Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII.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: "" <> buildModelFMU(OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Examples_PSATSystems_ThreeArea_FifthOrder_AVRII",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Examples_PSATSystems_ThreeArea_FifthOrder_AVRII",fmuType="me",version="2.0",platforms={"static"}) 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.84 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.485/1.485, allocations: 223.3 MB / 239.4 MB, free: 5.527 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.001281/0.001281, allocations: 180.5 kB / 290.6 MB, free: 2.199 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.5516/0.5516, allocations: 91.94 MB / 433.7 MB, free: 10.34 MB / 302.1 MB Notification: Performance of FrontEnd - loaded program: time 0.0004485/0.000449, allocations: 12 kB / 0.5049 GB, free: 7.207 MB / 382.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.4021/0.4025, allocations: 72.46 MB / 0.5756 GB, free: 36.88 MB / 430.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII): time 0.009851/0.4124, allocations: 13.94 MB / 0.5893 GB, free: 26.88 MB / 430.1 MB Notification: Performance of NFInst.instExpressions: time 0.007185/0.4197, allocations: 3.625 MB / 0.5928 GB, free: 24.29 MB / 430.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002768/0.4225, allocations: 31.38 kB / 0.5928 GB, free: 24.29 MB / 430.1 MB Notification: Performance of NFTyping.typeComponents: time 0.001882/0.4244, allocations: 437.1 kB / 0.5932 GB, free: 24.11 MB / 430.1 MB Notification: Performance of NFTyping.typeBindings: time 0.004734/0.4291, allocations: 1.228 MB / 0.5944 GB, free: 23.29 MB / 430.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.003427/0.4326, allocations: 1.42 MB / 0.5958 GB, free: 22.51 MB / 430.1 MB Notification: Performance of NFFlatten.flatten: time 0.0051/0.4377, allocations: 3.564 MB / 0.5993 GB, free: 20.77 MB / 430.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001644/0.4393, allocations: 0.7952 MB / 0.6001 GB, free: 20.34 MB / 430.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.002407/0.4417, allocations: 1.346 MB / 0.6014 GB, free: 19.71 MB / 430.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002852/0.4446, allocations: 1.808 MB / 0.6032 GB, free: 18.88 MB / 430.1 MB Notification: Performance of NFPackage.collectConstants: time 0.001015/0.4456, allocations: 147.2 kB / 0.6033 GB, free: 18.88 MB / 430.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.001672/0.4473, allocations: 280.4 kB / 0.6036 GB, free: 18.83 MB / 430.1 MB Notification: Performance of NFScalarize.scalarize: time 0.001149/0.4485, allocations: 0.6165 MB / 0.6042 GB, free: 18.46 MB / 430.1 MB Notification: Performance of NFVerifyModel.verify: time 0.002703/0.4512, allocations: 1.502 MB / 0.6056 GB, free: 17.47 MB / 430.1 MB Notification: Performance of NFConvertDAE.convert: time 0.00411/0.4553, allocations: 3.757 MB / 0.6093 GB, free: 16.04 MB / 430.1 MB Notification: Performance of FrontEnd - DAE generated: time 4.458e-06/0.4553, allocations: 0 / 0.6093 GB, free: 16.04 MB / 430.1 MB Notification: Performance of FrontEnd: time 2.204e-06/0.4553, allocations: 1.062 kB / 0.6093 GB, free: 16.04 MB / 430.1 MB Notification: Performance of Transformations before backend: time 7.948e-05/0.4554, allocations: 0 / 0.6093 GB, free: 16.04 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: 524 * Number of variables: 524 Notification: Performance of Generate backend data structure: time 0.02299/0.4784, allocations: 6.19 MB / 0.6154 GB, free: 13.76 MB / 430.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.938e-05/0.4785, allocations: 8.906 kB / 0.6154 GB, free: 13.76 MB / 430.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0009438/0.4794, allocations: 304 kB / 0.6156 GB, free: 13.57 MB / 430.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0173/0.4967, allocations: 2.3 MB / 0.6179 GB, free: 13.14 MB / 430.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.006587/0.5034, allocations: 1.902 MB / 0.6198 GB, free: 11.97 MB / 430.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001178/0.5046, allocations: 0.755 MB / 0.6205 GB, free: 11.31 MB / 430.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.001227/0.5058, allocations: 215 kB / 0.6207 GB, free: 11.24 MB / 430.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01414/0.52, allocations: 3.246 MB / 0.6239 GB, free: 10.06 MB / 430.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 0.0001005/0.5201, allocations: 0 / 0.6239 GB, free: 10.06 MB / 430.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00076/0.5209, allocations: 90.52 kB / 0.624 GB, free: 9.988 MB / 430.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.433e-05/0.521, allocations: 48.88 kB / 0.624 GB, free: 9.988 MB / 430.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01123/0.5323, allocations: 2.999 MB / 0.6269 GB, free: 8.773 MB / 430.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.02842/0.5607, allocations: 10.19 MB / 0.6369 GB, free: 14.24 MB / 446.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.01974/0.5805, allocations: 4.883 MB / 0.6416 GB, free: 9.219 MB / 446.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.00782/0.5884, allocations: 2.18 MB / 0.6438 GB, free: 7.035 MB / 446.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0006198/0.589, allocations: 49.81 kB / 0.6438 GB, free: 6.992 MB / 446.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00909/0.5982, allocations: 2.435 MB / 0.6462 GB, free: 4.535 MB / 446.1 MB Notification: Performance of pre-optimization done (n=249): time 1.012e-05/0.5982, allocations: 4 kB / 0.6462 GB, free: 4.531 MB / 446.1 MB Notification: Performance of matching and sorting (n=249): time 0.1668/0.7651, allocations: 33.64 MB / 0.6791 GB, free: 2.773 MB / 478.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.000245/0.7654, allocations: 188.1 kB / 0.6792 GB, free: 2.551 MB / 478.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007887/0.7733, allocations: 2.317 MB / 0.6815 GB, free: 220 kB / 478.1 MB Notification: Performance of collectPreVariables (initialization): time 0.00146/0.7748, allocations: 73.7 kB / 0.6816 GB, free: 140 kB / 478.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.001611/0.7765, allocations: 1.172 MB / 0.6827 GB, free: 14.95 MB / 494.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.002359/0.7789, allocations: 0.8781 MB / 0.6836 GB, free: 14.06 MB / 494.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.00158/0.7805, allocations: 292.6 kB / 0.6838 GB, free: 13.77 MB / 494.1 MB Notification: Performance of setup shared object (initialization): time 0.0001613/0.7807, allocations: 305.1 kB / 0.6841 GB, free: 13.47 MB / 494.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.006623/0.7873, allocations: 2.169 MB / 0.6863 GB, free: 11.3 MB / 494.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.007098/0.7944, allocations: 2.541 MB / 0.6887 GB, free: 8.664 MB / 494.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.06588/0.8604, allocations: 15.68 MB / 0.7041 GB, free: 8.75 MB / 0.4981 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.986e-05/0.8605, allocations: 3.938 kB / 0.7041 GB, free: 8.746 MB / 0.4981 GB Notification: Performance of matching and sorting (n=421) (initialization): time 0.05216/0.9126, allocations: 15.36 MB / 0.7191 GB, free: 9.312 MB / 0.5137 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001167/0.9128, allocations: 114.8 kB / 0.7192 GB, free: 9.176 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.053e-05/0.9128, allocations: 8 kB / 0.7192 GB, free: 9.168 MB / 0.5137 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.02122/0.9341, allocations: 6.234 MB / 0.7253 GB, free: 2.93 MB / 0.5137 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00367/0.9378, allocations: 0.589 MB / 0.7258 GB, free: 2.34 MB / 0.5137 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08027/1.018, allocations: 24.5 MB / 0.7498 GB, free: 9.684 MB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006788/1.025, allocations: 0.5947 MB / 0.7503 GB, free: 9.086 MB / 0.545 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001165/1.026, allocations: 120 kB / 0.7505 GB, free: 8.969 MB / 0.545 GB Warning: Assuming fixed start value for the following 7 variables: order3_2.delta:VARIABLE(flow=false start = order3_2.delta0 unit = "rad" fixed = true ) "Rotor angle" type: Real order3_2.w:VARIABLE(flow=false start = 1.0 fixed = true ) "Rotor speed [pu]" type: Real order3_2.e1q:VARIABLE(start = order3_2.e1q0 unit = "1" fixed = true ) "q-axis transient voltage" type: Real order2.delta:VARIABLE(flow=false start = order2.delta0 unit = "rad" fixed = true ) "Rotor angle" type: Real order2.w:VARIABLE(flow=false start = 1.0 fixed = true ) "Rotor speed [pu]" type: Real Syn2.delta:VARIABLE(flow=false start = Syn2.delta0 unit = "rad" fixed = true ) "Rotor angle" type: Real Syn2.w:VARIABLE(flow=false start = 1.0 fixed = true ) "Rotor speed [pu]" type: Real Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 29 * Number of states: 0 () * Number of discrete variables: 4 ($whenCondition2,$whenCondition1,$whenCondition4,$whenCondition3) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (334): * Single equations (assignments): 329 * Array equations: 0 * Algorithm blocks: 4 * 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 {(63,25,8.1%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.003275/1.029, allocations: 0.5407 MB / 0.751 GB, free: 8.41 MB / 0.545 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001885/1.031, allocations: 300.2 kB / 0.7513 GB, free: 8.113 MB / 0.545 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04898/1.08, allocations: 14.77 MB / 0.7657 GB, free: 9.246 MB / 0.5606 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.489e-05/1.08, allocations: 24 kB / 0.7657 GB, free: 9.223 MB / 0.5606 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.377e-05/1.081, allocations: 24 kB / 0.7657 GB, free: 9.199 MB / 0.5606 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.422e-05/1.081, allocations: 11.95 kB / 0.7658 GB, free: 9.188 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.3025/1.383, allocations: 18.4 MB / 0.7837 GB, free: 158.1 MB / 0.5606 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.326e-05/1.383, allocations: 1.25 kB / 0.7837 GB, free: 158.1 MB / 0.5606 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001744/1.385, allocations: 247 kB / 0.784 GB, free: 158 MB / 0.5606 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.02171/1.407, allocations: 6.289 MB / 0.7901 GB, free: 157.9 MB / 0.5606 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0008604/1.408, allocations: 55.53 kB / 0.7902 GB, free: 157.9 MB / 0.5606 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.06791/1.476, allocations: 25.52 MB / 0.8151 GB, free: 148.7 MB / 0.5606 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.988e-06/1.476, allocations: 0 / 0.8151 GB, free: 148.7 MB / 0.5606 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05278/1.528, allocations: 17.36 MB / 0.832 GB, free: 139.8 MB / 0.5606 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001277/1.53, allocations: 417.9 kB / 0.8324 GB, free: 139.4 MB / 0.5606 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001547/1.531, allocations: 44 kB / 0.8325 GB, free: 139.4 MB / 0.5606 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004814/1.536, allocations: 410.1 kB / 0.8329 GB, free: 139.1 MB / 0.5606 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003348/1.539, allocations: 0.5667 MB / 0.8334 GB, free: 138.8 MB / 0.5606 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0008631/1.54, allocations: 63.75 kB / 0.8335 GB, free: 138.7 MB / 0.5606 GB Notification: Performance of sorting global known variables: time 0.003826/1.544, allocations: 1.544 MB / 0.835 GB, free: 137.4 MB / 0.5606 GB Notification: Performance of sort global known variables: time 3.21e-07/1.544, allocations: 0 / 0.835 GB, free: 137.4 MB / 0.5606 GB Notification: Performance of remove unused functions: time 0.00785/1.552, allocations: 1.176 MB / 0.8361 GB, free: 136.2 MB / 0.5606 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 18 (order3_2.delta,order3_2.w,order3_2.e1q,order2.delta,order2.w,Syn2.delta,Syn2.w,Syn2.e1q,Syn2.e2q,Syn2.e2d,Exc1.ExcitationSystem.x_scaled[1],Exc1.derivativeBlock.x,Exc1.firstOrder2.y,Exc1.simpleLagLim.state,Exc2.ExcitationSystem.x_scaled[1],Exc2.derivativeBlock.x,Exc2.firstOrder2.y,Exc2.simpleLagLim.state) * Number of discrete variables: 4 ($whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (158): * Single equations (assignments): 153 * Array equations: 0 * Algorithm blocks: 2 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 3 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(67,21,7.5%)} * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(1,6), (1,6)} Notification: Performance of Backend phase and start with SimCode phase: time 0.05769/1.61, allocations: 17.98 MB / 0.8537 GB, free: 119.1 MB / 0.5606 GB Notification: Performance of simCode: created initialization part: time 0.02271/1.633, allocations: 7.548 MB / 0.8611 GB, free: 111.5 MB / 0.5606 GB Notification: Performance of simCode: created event and clocks part: time 1.072e-05/1.633, allocations: 0 / 0.8611 GB, free: 111.5 MB / 0.5606 GB Notification: Performance of simCode: created simulation system equations: time 0.0159/1.649, allocations: 5.115 MB / 0.8661 GB, free: 106.3 MB / 0.5606 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004725/1.653, allocations: 273.2 kB / 0.8663 GB, free: 106 MB / 0.5606 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1379/1.791, allocations: 53.43 MB / 0.9185 GB, free: 50.76 MB / 0.5606 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00139/1.793, allocations: 1.811 MB / 0.9203 GB, free: 48.92 MB / 0.5606 GB Notification: Performance of simCode: alias equations: time 0.001722/1.794, allocations: 266.6 kB / 0.9205 GB, free: 48.66 MB / 0.5606 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00195/1.796, allocations: 1.23 MB / 0.9217 GB, free: 47.43 MB / 0.5606 GB Notification: Performance of SimCode: time 2.044e-06/1.796, allocations: 0 / 0.9217 GB, free: 47.43 MB / 0.5606 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4018/2.198, allocations: 80.23 MB / 1 GB, free: 184.1 MB / 0.5919 GB Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.000147/2.198, allocations: 239.8 kB / 1 GB, free: 183.8 MB / 0.5919 GB Notification: Performance of buildModelFMU: Generate platform static: time 5.124/7.322, allocations: 1.75 kB / 1 GB, free: 183.8 MB / 0.5919 GB (rm -f OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --tempDir=temp_OpenIPSL_dev_OpenIPSL_Examples_PSATSystems_ThreeArea_FifthOrder_AVRII_fmu --startTime=0 --stopTime=20 --timeout=50 --tolerance=1e-06 OpenIPSL_dev_OpenIPSL_Examples_PSATSystems_ThreeArea_FifthOrder_AVRII.fmu > OpenIPSL_dev_OpenIPSL.Examples.PSATSystems.ThreeArea.FifthOrder_AVRII.pipe 2>&1)