Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo", uses=false) Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo) Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: translateModel(IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY") translateModel(IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.000864/0.0008642, allocations: 93.11 kB / 16.02 MB, free: 84 kB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001163/0.001163, allocations: 178 kB / 16.92 MB, free: 6.688 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.485/1.485, allocations: 223.3 MB / 241 MB, free: 5.383 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7038/0.7038, allocations: 115.5 MB / 407.6 MB, free: 2.734 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.0003189/0.0003189, allocations: 9.406 kB / 495.9 MB, free: 6.316 MB / 350.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1587/0.1591, allocations: 77.54 MB / 0.56 GB, free: 8.984 MB / 430.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY): time 0.02066/0.1797, allocations: 17.53 MB / 0.5771 GB, free: 7.391 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.01358/0.1934, allocations: 6.782 MB / 0.5837 GB, free: 0.5898 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.00197/0.1954, allocations: 43.88 kB / 0.5838 GB, free: 0.5469 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.00171/0.1971, allocations: 393.2 kB / 0.5842 GB, free: 164 kB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.2774/0.4745, allocations: 1.373 MB / 0.5855 GB, free: 13.37 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.002597/0.4771, allocations: 0.999 MB / 0.5865 GB, free: 13.34 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.01161/0.4887, allocations: 8.793 MB / 0.5951 GB, free: 13.34 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.01355/0.5023, allocations: 8.895 MB / 0.6037 GB, free: 11.81 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.003978/0.5063, allocations: 1.717 MB / 0.6054 GB, free: 11.33 MB / 446.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.004751/0.5111, allocations: 2.738 MB / 0.6081 GB, free: 10.59 MB / 446.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0008856/0.512, allocations: 250.5 kB / 0.6083 GB, free: 10.59 MB / 446.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.002915/0.5149, allocations: 1.167 MB / 0.6095 GB, free: 10.34 MB / 446.1 MB Notification: Performance of NFScalarize.scalarize: time 0.002139/0.5171, allocations: 1.952 MB / 0.6114 GB, free: 9.371 MB / 446.1 MB Notification: Performance of NFVerifyModel.verify: time 0.002034/0.5191, allocations: 1.864 MB / 0.6132 GB, free: 8.098 MB / 446.1 MB Notification: Performance of NFConvertDAE.convert: time 0.007597/0.5267, allocations: 7.732 MB / 0.6207 GB, free: 2.73 MB / 446.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.61e-06/0.5268, allocations: 3.938 kB / 0.6208 GB, free: 2.727 MB / 446.1 MB Notification: Performance of FrontEnd: time 2.404e-06/0.5268, allocations: 0 / 0.6208 GB, free: 2.727 MB / 446.1 MB Notification: Performance of Transformations before backend: time 0.0001763/0.527, allocations: 0 / 0.6208 GB, free: 2.727 MB / 446.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1034 * Number of variables: 1034 Notification: Performance of Generate backend data structure: time 0.007298/0.5343, allocations: 3.189 MB / 0.6239 GB, free: 388 kB / 446.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.545e-05/0.5343, allocations: 16.03 kB / 0.6239 GB, free: 372 kB / 446.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01389/0.5482, allocations: 2.426 MB / 0.6263 GB, free: 13.93 MB / 462.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.005728/0.554, allocations: 2.22 MB / 0.6284 GB, free: 11.68 MB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002689/0.5543, allocations: 287 kB / 0.6287 GB, free: 11.41 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.001446/0.5558, allocations: 361.7 kB / 0.629 GB, free: 11.07 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01628/0.572, allocations: 7.4 MB / 0.6363 GB, free: 3.578 MB / 462.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 7.697e-05/0.5722, allocations: 0 / 0.6363 GB, free: 3.578 MB / 462.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004924/0.5727, allocations: 157.9 kB / 0.6364 GB, free: 3.434 MB / 462.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004791/0.5731, allocations: 334.4 kB / 0.6367 GB, free: 3.105 MB / 462.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01755/0.5907, allocations: 7.197 MB / 0.6438 GB, free: 11.9 MB / 478.1 MB Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts. Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.0454/0.6361, allocations: 28.34 MB / 0.6714 GB, free: 13.33 MB / 0.4981 GB Notification: Performance of preOpt comSubExp (simulation): time 0.008275/0.6445, allocations: 4.175 MB / 0.6755 GB, free: 8.934 MB / 0.4981 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.005822/0.6503, allocations: 2.326 MB / 0.6778 GB, free: 6.598 MB / 0.4981 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0003083/0.6506, allocations: 137.7 kB / 0.6779 GB, free: 6.457 MB / 0.4981 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.885e-05/0.6507, allocations: 60.5 kB / 0.678 GB, free: 6.387 MB / 0.4981 GB Notification: Performance of pre-optimization done (n=198): time 3.607e-06/0.6507, allocations: 0 / 0.678 GB, free: 6.387 MB / 0.4981 GB Notification: Performance of matching and sorting (n=257): time 0.1089/0.7596, allocations: 30.48 MB / 0.7077 GB, free: 7.859 MB / 0.5294 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001338/0.7598, allocations: 243.5 kB / 0.708 GB, free: 7.574 MB / 0.5294 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002505/0.7623, allocations: 1.485 MB / 0.7094 GB, free: 6.082 MB / 0.5294 GB Notification: Performance of collectPreVariables (initialization): time 0.0004692/0.7628, allocations: 65.7 kB / 0.7095 GB, free: 6.012 MB / 0.5294 GB Notification: Performance of collectInitialEqns (initialization): time 0.001037/0.7638, allocations: 1.567 MB / 0.711 GB, free: 4.434 MB / 0.5294 GB Notification: Performance of collectInitialBindings (initialization): time 0.001056/0.7649, allocations: 0.8705 MB / 0.7119 GB, free: 3.57 MB / 0.5294 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005714/0.7655, allocations: 248.2 kB / 0.7121 GB, free: 3.32 MB / 0.5294 GB Notification: Performance of setup shared object (initialization): time 9.378e-05/0.7656, allocations: 301.1 kB / 0.7124 GB, free: 3.023 MB / 0.5294 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.006151/0.7717, allocations: 2.563 MB / 0.7149 GB, free: 464 kB / 0.5294 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.006724/0.7785, allocations: 3.451 MB / 0.7183 GB, free: 12.62 MB / 0.545 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01343/0.7919, allocations: 6.145 MB / 0.7243 GB, free: 6.074 MB / 0.545 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.756e-05/0.792, allocations: 11.94 kB / 0.7243 GB, free: 6.062 MB / 0.545 GB Notification: Performance of matching and sorting (n=398) (initialization): time 0.03006/0.8221, allocations: 10.31 MB / 0.7343 GB, free: 11.68 MB / 0.5606 GB Notification: Performance of prepare postOptimizeDAE: time 0.0006807/0.8228, allocations: 0.8741 MB / 0.7352 GB, free: 10.43 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.775e-05/0.8229, allocations: 31.94 kB / 0.7352 GB, free: 10.4 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.02301/0.8459, allocations: 5.755 MB / 0.7408 GB, free: 4.637 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00474/0.8507, allocations: 0.9983 MB / 0.7418 GB, free: 3.637 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04196/0.8927, allocations: 21.6 MB / 0.7629 GB, free: 13.8 MB / 0.5919 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004982/0.8977, allocations: 0.5692 MB / 0.7635 GB, free: 13.23 MB / 0.5919 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000663/0.8984, allocations: 151.9 kB / 0.7636 GB, free: 13.08 MB / 0.5919 GB Notification: Performance of prepare postOptimizeDAE: time 1.154e-05/0.8984, allocations: 4 kB / 0.7636 GB, free: 13.08 MB / 0.5919 GB Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0243/0.9227, allocations: 8.482 MB / 0.7719 GB, free: 4.543 MB / 0.5919 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.956e-05/0.9228, allocations: 28.06 kB / 0.7719 GB, free: 4.516 MB / 0.5919 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01443/0.9373, allocations: 3.54 MB / 0.7754 GB, free: 0.9648 MB / 0.5919 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00576/0.9431, allocations: 1.139 MB / 0.7765 GB, free: 15.82 MB / 0.6075 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02238/0.9655, allocations: 11.8 MB / 0.788 GB, free: 3.898 MB / 0.6075 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004513/0.97, allocations: 0.542 MB / 0.7885 GB, free: 3.355 MB / 0.6075 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006192/0.9707, allocations: 147.9 kB / 0.7887 GB, free: 3.211 MB / 0.6075 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 121 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (304): * Single equations (assignments): 302 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(6,42,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(6,42)} Notification: Performance of prepare postOptimizeDAE: time 0.003455/0.9741, allocations: 1.62 MB / 0.7903 GB, free: 1.578 MB / 0.6075 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007464/0.9749, allocations: 193.7 kB / 0.7905 GB, free: 1.387 MB / 0.6075 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02795/1.003, allocations: 9.838 MB / 0.8001 GB, free: 7.496 MB / 0.6231 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.598e-05/1.003, allocations: 28 kB / 0.8001 GB, free: 7.469 MB / 0.6231 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.868e-05/1.003, allocations: 19.88 kB / 0.8001 GB, free: 7.449 MB / 0.6231 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.963e-05/1.003, allocations: 15.95 kB / 0.8001 GB, free: 7.434 MB / 0.6231 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03753/1.041, allocations: 15.22 MB / 0.815 GB, free: 8.043 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.988e-05/1.041, allocations: 8 kB / 0.815 GB, free: 8.035 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003737/1.044, allocations: 0.7334 MB / 0.8157 GB, free: 7.301 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.02193/1.066, allocations: 5.412 MB / 0.821 GB, free: 1.875 MB / 0.6387 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009553/1.067, allocations: 71.95 kB / 0.8211 GB, free: 1.805 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.371/1.438, allocations: 20.46 MB / 0.841 GB, free: 205.2 MB / 0.6387 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.366e-05/1.438, allocations: 15.56 kB / 0.8411 GB, free: 205.2 MB / 0.6387 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0256/1.464, allocations: 9.384 MB / 0.8502 GB, free: 202.4 MB / 0.6387 GB Notification: Performance of postOpt removeConstants (simulation): time 0.002116/1.466, allocations: 0.6946 MB / 0.8509 GB, free: 202.1 MB / 0.6387 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000617/1.467, allocations: 62.03 kB / 0.851 GB, free: 202.1 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004268/1.471, allocations: 0.5097 MB / 0.8515 GB, free: 202.1 MB / 0.6387 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009967/1.472, allocations: 216.9 kB / 0.8517 GB, free: 202 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002343/1.472, allocations: 94.22 kB / 0.8518 GB, free: 202 MB / 0.6387 GB Notification: Performance of sorting global known variables: time 0.001687/1.474, allocations: 1.05 MB / 0.8528 GB, free: 201.6 MB / 0.6387 GB Notification: Performance of sort global known variables: time 2.41e-07/1.474, allocations: 3.375 kB / 0.8528 GB, free: 201.6 MB / 0.6387 GB Notification: Performance of remove unused functions: time 0.006364/1.48, allocations: 1.773 MB / 0.8545 GB, free: 201.5 MB / 0.6387 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 40 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (162): * Single equations (assignments): 160 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(6,42,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(6,42)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0004509/1.481, allocations: 175.6 kB / 0.8547 GB, free: 201.3 MB / 0.6387 GB Notification: Performance of simCode: created initialization part: time 0.02669/1.508, allocations: 11.37 MB / 0.8658 GB, free: 197.9 MB / 0.6387 GB Notification: Performance of simCode: created event and clocks part: time 1.343e-05/1.508, allocations: 0 / 0.8658 GB, free: 197.9 MB / 0.6387 GB Notification: Performance of simCode: created simulation system equations: time 0.01042/1.518, allocations: 4.146 MB / 0.8698 GB, free: 196 MB / 0.6387 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004018/1.522, allocations: 271.6 kB / 0.8701 GB, free: 195.8 MB / 0.6387 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02369/1.546, allocations: 11.53 MB / 0.8814 GB, free: 185.1 MB / 0.6387 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002437/1.548, allocations: 2.856 MB / 0.8841 GB, free: 182.2 MB / 0.6387 GB Notification: Performance of simCode: alias equations: time 0.004873/1.553, allocations: 1.677 MB / 0.8858 GB, free: 180.5 MB / 0.6387 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006054/1.554, allocations: 171.3 kB / 0.8859 GB, free: 180.4 MB / 0.6387 GB Notification: Performance of SimCode: time 1.002e-06/1.554, allocations: 0 / 0.8859 GB, free: 180.4 MB / 0.6387 GB Notification: Performance of Templates: time 0.08599/1.64, allocations: 67.11 MB / 0.9515 GB, free: 113.5 MB / 0.6387 GB make -j1 -f IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.makefile (rm -f IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.pipe ; mkfifo IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.pipe >> ../files/IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.sim & ./IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.DY.pipe 2>&1)