Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.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/Modelica 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/OpenIPSL 3.1.0-master/package.mo", uses=false) Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/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 Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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(OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI") translateModel(OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001135/0.001135, allocations: 91.77 kB / 15.36 MB, free: 0.7383 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.447/1.447, allocations: 223.3 MB / 239.4 MB, free: 5.523 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001383/0.001383, allocations: 172.5 kB / 290.6 MB, free: 2.207 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.5495/0.5495, allocations: 91.93 MB / 433.6 MB, free: 10.31 MB / 302.1 MB Notification: Performance of FrontEnd - loaded program: time 0.000424/0.0004239, allocations: 19.98 kB / 0.5048 GB, free: 7.297 MB / 382.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.425/0.4255, allocations: 72.45 MB / 0.5755 GB, free: 36.63 MB / 430.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI): time 0.01484/0.4404, allocations: 22.29 MB / 0.5973 GB, free: 20.36 MB / 430.1 MB Notification: Performance of NFInst.instExpressions: time 0.01228/0.4527, allocations: 5.146 MB / 0.6023 GB, free: 16.63 MB / 430.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.005754/0.4585, allocations: 51.88 kB / 0.6024 GB, free: 16.63 MB / 430.1 MB Notification: Performance of NFTyping.typeComponents: time 0.003129/0.4617, allocations: 0.6743 MB / 0.603 GB, free: 16.36 MB / 430.1 MB Notification: Performance of NFTyping.typeBindings: time 0.008582/0.4703, allocations: 1.717 MB / 0.6047 GB, free: 15.16 MB / 430.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.00665/0.4769, allocations: 1.928 MB / 0.6066 GB, free: 14.05 MB / 430.1 MB Notification: Performance of NFFlatten.flatten: time 0.0142/0.4912, allocations: 5.394 MB / 0.6118 GB, free: 11.33 MB / 430.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.003725/0.4949, allocations: 1.126 MB / 0.6129 GB, free: 10.75 MB / 430.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.004682/0.4996, allocations: 2.039 MB / 0.6149 GB, free: 9.773 MB / 430.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.005276/0.5049, allocations: 2.677 MB / 0.6175 GB, free: 8.496 MB / 430.1 MB Notification: Performance of NFPackage.collectConstants: time 0.002204/0.5071, allocations: 233.2 kB / 0.6178 GB, free: 8.496 MB / 430.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.003576/0.5107, allocations: 373.4 kB / 0.6181 GB, free: 8.453 MB / 430.1 MB Notification: Performance of NFScalarize.scalarize: time 0.002411/0.5131, allocations: 0.9336 MB / 0.619 GB, free: 7.875 MB / 430.1 MB Notification: Performance of NFVerifyModel.verify: time 0.007137/0.5203, allocations: 2.385 MB / 0.6214 GB, free: 6.316 MB / 430.1 MB Notification: Performance of NFConvertDAE.convert: time 0.01442/0.5347, allocations: 5.82 MB / 0.6271 GB, free: 4.047 MB / 430.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.631e-06/0.5348, allocations: 0 / 0.6271 GB, free: 4.047 MB / 430.1 MB Notification: Performance of FrontEnd: time 2.374e-06/0.5348, allocations: 0 / 0.6271 GB, free: 4.047 MB / 430.1 MB Notification: Performance of Transformations before backend: time 0.000365/0.5352, allocations: 1.375 kB / 0.6271 GB, free: 4.047 MB / 430.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 889 * Number of variables: 889 Notification: Performance of Generate backend data structure: time 0.03413/0.5693, allocations: 8.381 MB / 0.6352 GB, free: 148 kB / 430.1 MB Notification: Performance of prepare preOptimizeDAE: time 5.121e-05/0.5694, allocations: 9.469 kB / 0.6352 GB, free: 148 kB / 430.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02834/0.5977, allocations: 4.051 MB / 0.6392 GB, free: 12.39 MB / 446.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.008655/0.6064, allocations: 2.651 MB / 0.6418 GB, free: 9.656 MB / 446.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001359/0.6078, allocations: 0.9673 MB / 0.6427 GB, free: 8.559 MB / 446.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002041/0.6099, allocations: 351.9 kB / 0.6431 GB, free: 8.215 MB / 446.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01793/0.6278, allocations: 4.989 MB / 0.6479 GB, free: 3.188 MB / 446.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.000189/0.6281, allocations: 3.938 kB / 0.6479 GB, free: 3.184 MB / 446.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001617/0.6297, allocations: 140 kB / 0.6481 GB, free: 3.047 MB / 446.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.161e-05/0.6298, allocations: 84 kB / 0.6482 GB, free: 2.965 MB / 446.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01393/0.6438, allocations: 4.525 MB / 0.6526 GB, free: 14.43 MB / 462.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.05126/0.6951, allocations: 18.84 MB / 0.671 GB, free: 10.4 MB / 478.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.01529/0.7104, allocations: 5.719 MB / 0.6766 GB, free: 4.605 MB / 478.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.007584/0.7181, allocations: 3.058 MB / 0.6796 GB, free: 1.539 MB / 478.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0008445/0.7189, allocations: 66.91 kB / 0.6796 GB, free: 1.473 MB / 478.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.645e-05/0.7191, allocations: 77.47 kB / 0.6797 GB, free: 1.387 MB / 478.1 MB Notification: Performance of pre-optimization done (n=379): time 8.065e-06/0.7191, allocations: 0 / 0.6797 GB, free: 1.387 MB / 478.1 MB Notification: Performance of matching and sorting (n=379): time 0.3206/1.04, allocations: 80.43 MB / 0.7582 GB, free: 0.7852 MB / 0.545 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001558/1.04, allocations: 167.5 kB / 0.7584 GB, free: 0.5898 MB / 0.545 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007491/1.047, allocations: 3.21 MB / 0.7615 GB, free: 13.36 MB / 0.5606 GB Notification: Performance of collectPreVariables (initialization): time 0.001497/1.049, allocations: 93.7 kB / 0.7616 GB, free: 13.26 MB / 0.5606 GB Notification: Performance of collectInitialEqns (initialization): time 0.002022/1.051, allocations: 1.959 MB / 0.7635 GB, free: 11.29 MB / 0.5606 GB Notification: Performance of collectInitialBindings (initialization): time 0.002975/1.054, allocations: 1.301 MB / 0.7648 GB, free: 9.969 MB / 0.5606 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001612/1.056, allocations: 334.5 kB / 0.7651 GB, free: 9.633 MB / 0.5606 GB Notification: Performance of setup shared object (initialization): time 0.0001123/1.056, allocations: 305.1 kB / 0.7654 GB, free: 9.332 MB / 0.5606 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.007609/1.063, allocations: 2.835 MB / 0.7682 GB, free: 6.488 MB / 0.5606 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.008243/1.072, allocations: 3.47 MB / 0.7716 GB, free: 2.789 MB / 0.5606 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.4288/1.5, allocations: 20.62 MB / 0.7917 GB, free: 157 MB / 0.5606 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.049e-05/1.501, allocations: 3.625 kB / 0.7917 GB, free: 157 MB / 0.5606 GB Notification: Performance of matching and sorting (n=524) (initialization): time 0.1092/1.61, allocations: 20.7 MB / 0.8119 GB, free: 153.1 MB / 0.5606 GB Notification: Performance of prepare postOptimizeDAE: time 0.0005767/1.61, allocations: 0.5904 MB / 0.8125 GB, free: 152.3 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.341e-05/1.61, allocations: 15.84 kB / 0.8125 GB, free: 152.3 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.04532/1.656, allocations: 8.559 MB / 0.8209 GB, free: 149.1 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005687/1.662, allocations: 0.6487 MB / 0.8215 GB, free: 148.6 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.09676/1.758, allocations: 35.28 MB / 0.856 GB, free: 114.6 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007268/1.766, allocations: 0.7495 MB / 0.8567 GB, free: 113.9 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001213/1.767, allocations: 148 kB / 0.8568 GB, free: 113.8 MB / 0.5606 GB Notification: Performance of prepare postOptimizeDAE: time 1.536e-05/1.767, allocations: 4 kB / 0.8568 GB, free: 113.8 MB / 0.5606 GB Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.05942/1.826, allocations: 20.26 MB / 0.8766 GB, free: 93.5 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.204e-05/1.827, allocations: 12 kB / 0.8766 GB, free: 93.48 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.02592/1.852, allocations: 8.557 MB / 0.885 GB, free: 84.91 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003506/1.856, allocations: 0.6397 MB / 0.8856 GB, free: 84.27 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.09276/1.949, allocations: 35.29 MB / 0.9201 GB, free: 48.87 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007141/1.956, allocations: 0.7047 MB / 0.9208 GB, free: 48.2 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001249/1.957, allocations: 148 kB / 0.9209 GB, free: 48.05 MB / 0.5606 GB Warning: Assuming fixed start value for the following 4 variables: order3_1.w:VARIABLE(flow=false start = 1.0 fixed = true ) "Rotor speed [pu]" type: Real order3.w:VARIABLE(flow=false start = 1.0 fixed = true ) "Rotor speed [pu]" type: Real order3.delta:VARIABLE(flow=false start = order3.delta0 unit = "rad" fixed = true ) "Rotor angle" type: Real order3.e1q:VARIABLE(start = order3.e1q0 unit = "1" fixed = true ) "q-axis transient voltage" type: Real Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 65 * 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 (388): * Single equations (assignments): 385 * Array equations: 0 * Algorithm blocks: 2 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(92,45)} Notification: Performance of prepare postOptimizeDAE: time 0.00367/1.961, allocations: 0.7527 MB / 0.9216 GB, free: 47.28 MB / 0.5606 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002105/1.963, allocations: 450.4 kB / 0.9221 GB, free: 46.84 MB / 0.5606 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05992/2.023, allocations: 20.51 MB / 0.9421 GB, free: 26.26 MB / 0.5606 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.623e-05/2.023, allocations: 36 kB / 0.9421 GB, free: 26.22 MB / 0.5606 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.129e-05/2.023, allocations: 32 kB / 0.9422 GB, free: 26.19 MB / 0.5606 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001279/2.023, allocations: 19.92 kB / 0.9422 GB, free: 26.17 MB / 0.5606 GB 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 postOpt removeSimpleEquations (simulation): time 0.07176/2.095, allocations: 25.81 MB / 0.9674 GB, free: 284 kB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.192e-05/2.095, allocations: 0 / 0.9674 GB, free: 284 kB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002793/2.098, allocations: 399.5 kB / 0.9678 GB, free: 15.89 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.02968/2.128, allocations: 8.616 MB / 0.9762 GB, free: 7.262 MB / 0.5762 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001359/2.129, allocations: 71.98 kB / 0.9763 GB, free: 7.191 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.4429/2.572, allocations: 30.61 MB / 1.006 GB, free: 176 MB / 0.5919 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.517e-06/2.572, allocations: 0 / 1.006 GB, free: 176 MB / 0.5919 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.07904/2.651, allocations: 24.14 MB / 1.03 GB, free: 172.9 MB / 0.5919 GB Notification: Performance of postOpt removeConstants (simulation): time 0.002967/2.654, allocations: 0.5588 MB / 1.03 GB, free: 172.5 MB / 0.5919 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00154/2.656, allocations: 67.5 kB / 1.03 GB, free: 172.4 MB / 0.5919 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004872/2.661, allocations: 0.4974 MB / 1.031 GB, free: 172.4 MB / 0.5919 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002928/2.663, allocations: 0.755 MB / 1.032 GB, free: 172.3 MB / 0.5919 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002768/2.664, allocations: 95.83 kB / 1.032 GB, free: 172.3 MB / 0.5919 GB Notification: Performance of sorting global known variables: time 0.003125/2.667, allocations: 2.109 MB / 1.034 GB, free: 171.5 MB / 0.5919 GB Notification: Performance of sort global known variables: time 2.41e-07/2.667, allocations: 0 / 1.034 GB, free: 171.5 MB / 0.5919 GB Notification: Performance of remove unused functions: time 0.009498/2.676, allocations: 2.961 MB / 1.037 GB, free: 171 MB / 0.5919 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 2 * Number of states: 10 (order3.delta,order3.w,order3.e1q,order3_1.delta,order3_1.w,order3_1.e1q,aVRTypeI.firstOrder.y,aVRTypeI.firstOrder2.y,aVRTypeI.transferFunction.x_scaled[1],aVRTypeI.transferFunction.x_scaled[2]) * 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 (249): * Single equations (assignments): 247 * Array equations: 0 * Algorithm blocks: 1 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(100,36,5.5%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.0006075/2.677, allocations: 198.4 kB / 1.037 GB, free: 170.9 MB / 0.5919 GB Notification: Performance of simCode: created initialization part: time 0.04789/2.725, allocations: 17.6 MB / 1.054 GB, free: 161 MB / 0.5919 GB Notification: Performance of simCode: created event and clocks part: time 1.531e-05/2.725, allocations: 0 / 1.054 GB, free: 161 MB / 0.5919 GB Notification: Performance of simCode: created simulation system equations: time 0.02183/2.747, allocations: 6.923 MB / 1.061 GB, free: 155.1 MB / 0.5919 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01079/2.758, allocations: 384.9 kB / 1.061 GB, free: 154.7 MB / 0.5919 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02433/2.782, allocations: 9.827 MB / 1.071 GB, free: 145.5 MB / 0.5919 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003337/2.786, allocations: 2.497 MB / 1.073 GB, free: 143.6 MB / 0.5919 GB Notification: Performance of simCode: alias equations: time 0.003747/2.789, allocations: 444.3 kB / 1.074 GB, free: 143.3 MB / 0.5919 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00146/2.791, allocations: 234.2 kB / 1.074 GB, free: 143.1 MB / 0.5919 GB Notification: Performance of SimCode: time 1.372e-06/2.791, allocations: 0 / 1.074 GB, free: 143.1 MB / 0.5919 GB Notification: Performance of Templates: time 0.1642/2.955, allocations: 112.1 MB / 1.183 GB, free: 33.79 MB / 0.5919 GB make -j1 -f OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.makefile (rm -f OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.sim & ./OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.TwoArea.ThirdOrder_AVRI.pipe 2>&1)