Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.EXNI.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo): time 0.04666/0.04666, allocations: 9.519 MB / 28.61 MB, free: 464 kB / 18.57 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0007118/0.0007118, allocations: 88.45 kB / 34.65 MB, free: 1.012 MB / 24.77 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 0.8639/0.8639, allocations: 158.6 MB / 199.2 MB, free: 7.262 MB / 186.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001153/0.001153, allocations: 164.5 kB / 254.4 MB, free: 15.96 MB / 250.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo): time 0.1884/0.1884, allocations: 59.71 MB / 369.2 MB, free: 12.75 MB / 298.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:11:9-20:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/WorkInProgress.mo:130:9-144:24:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
Using package OpenIPSL with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Using package Modelica_Synchronous with version 0.93.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_Synchronous 0.93.0/package.mo)
Running command: "" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.ES.EXNI,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_EXNI",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(OpenIPSL.Tests.Controls.PSSE.ES.EXNI,fileNamePrefix="OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_EXNI",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.014e-06/2.014e-06, allocations: 0 / 0.5175 GB, free: 11.39 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.971e-05/2.172e-05, allocations: 5.797 kB / 0.5175 GB, free: 11.39 MB / 394.7 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Controls.PSSE.ES.EXNI): time 0.005727/0.005749, allocations: 7.306 MB / 0.5247 GB, free: 4.031 MB / 394.7 MB
Notification: Performance of NFInst.instExpressions: time 0.003922/0.009671, allocations: 2.475 MB / 0.5271 GB, free: 1.547 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006168/0.01029, allocations: 15.94 kB / 0.5271 GB, free: 1.531 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0005052/0.01079, allocations: 301.3 kB / 0.5274 GB, free: 1.234 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.001828/0.01262, allocations: 1.247 MB / 0.5286 GB, free: 15.99 MB / 410.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 2.0.0/NonElectrical/Logical/NegCurLogic.mo:14:3-14:60:writable] Warning: In relation eXNI.negCurLogic.RC_rfd == 0.0, == on Real operands is deprecated in non-function contexts.
Notification: Performance of NFTyping.typeClassSections: time 0.0009241/0.01354, allocations: 0.7361 MB / 0.5293 GB, free: 15.26 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.001775/0.01532, allocations: 2.357 MB / 0.5316 GB, free: 12.9 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003888/0.01571, allocations: 309.8 kB / 0.5319 GB, free: 12.57 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001073/0.01678, allocations: 1.243 MB / 0.5331 GB, free: 11.32 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007815/0.01756, allocations: 0.9035 MB / 0.534 GB, free: 10.41 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001927/0.01776, allocations: 184 kB / 0.5342 GB, free: 10.23 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003906/0.01815, allocations: 343.7 kB / 0.5345 GB, free: 9.898 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002445/0.01839, allocations: 474 kB / 0.535 GB, free: 9.434 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.000419/0.01881, allocations: 0.6269 MB / 0.5356 GB, free: 8.805 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001546/0.02036, allocations: 2.363 MB / 0.5379 GB, free: 6.434 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.683e-06/0.02036, allocations: 0 / 0.5379 GB, free: 6.434 MB / 410.7 MB
Notification: Performance of FrontEnd: time 9.52e-07/0.02036, allocations: 0 / 0.5379 GB, free: 6.434 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 2.282e-05/0.02038, allocations: 3.938 kB / 0.5379 GB, free: 6.43 MB / 410.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 254
 * Number of variables: 254
Notification: Performance of Generate backend data structure: time 0.006688/0.02707, allocations: 3.794 MB / 0.5416 GB, free: 2.59 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.696e-05/0.02711, allocations: 12.03 kB / 0.5416 GB, free: 2.578 MB / 410.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.000148/0.02725, allocations: 164.2 kB / 0.5418 GB, free: 2.41 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002157/0.02941, allocations: 0.7599 MB / 0.5425 GB, free: 1.648 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001172/0.03058, allocations: 1.03 MB / 0.5435 GB, free: 0.5781 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005916/0.03117, allocations: 0.6311 MB / 0.5441 GB, free: 15.83 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001476/0.03132, allocations: 112 kB / 0.5442 GB, free: 15.72 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00171/0.03303, allocations: 1.468 MB / 0.5457 GB, free: 14.23 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.549e-05/0.03305, allocations: 0 / 0.5457 GB, free: 14.23 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.403e-05/0.03313, allocations: 47.88 kB / 0.5457 GB, free: 14.18 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.326e-05/0.03314, allocations: 24 kB / 0.5457 GB, free: 14.16 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001765/0.03491, allocations: 1.351 MB / 0.5471 GB, free: 12.81 MB / 426.7 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.004659/0.03957, allocations: 3.748 MB / 0.5507 GB, free: 8.98 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004292/0.04386, allocations: 2.445 MB / 0.5531 GB, free: 6.508 MB / 426.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001079/0.04494, allocations: 0.838 MB / 0.5539 GB, free: 5.664 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 9.576e-05/0.04504, allocations: 16.98 kB / 0.5539 GB, free: 5.648 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.986e-05/0.04507, allocations: 51.5 kB / 0.554 GB, free: 5.586 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=128): time 2.485e-06/0.04507, allocations: 4 kB / 0.554 GB, free: 5.582 MB / 426.7 MB
Notification: Performance of matching and sorting (n=128): time 0.01952/0.06459, allocations: 9.612 MB / 0.5634 GB, free: 11.95 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.851e-05/0.06466, allocations: 153.4 kB / 0.5635 GB, free: 11.77 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001208/0.06586, allocations: 1.368 MB / 0.5649 GB, free: 10.39 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 8.992e-05/0.06595, allocations: 57.7 kB / 0.5649 GB, free: 10.33 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005486/0.0665, allocations: 0.6049 MB / 0.5655 GB, free: 9.723 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003058/0.06681, allocations: 491.8 kB / 0.566 GB, free: 9.238 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003886/0.0672, allocations: 339.5 kB / 0.5663 GB, free: 8.902 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 7.268e-05/0.06727, allocations: 305.1 kB / 0.5666 GB, free: 8.602 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001296/0.06857, allocations: 0.9847 MB / 0.5676 GB, free: 7.613 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001425/0.06999, allocations: 1.223 MB / 0.5688 GB, free: 6.336 MB / 442.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002577/0.07257, allocations: 2.101 MB / 0.5708 GB, free: 4.188 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.989e-06/0.07257, allocations: 0 / 0.5708 GB, free: 4.188 MB / 442.7 MB
Notification: Performance of matching and sorting (n=242) (initialization): time 0.005408/0.07798, allocations: 3.739 MB / 0.5745 GB, free: 444 kB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.804e-05/0.078, allocations: 8 kB / 0.5745 GB, free: 436 kB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.869e-06/0.07801, allocations: 4 kB / 0.5745 GB, free: 432 kB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00515/0.08316, allocations: 3.013 MB / 0.5774 GB, free: 13.41 MB / 458.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006189/0.08378, allocations: 275.6 kB / 0.5777 GB, free: 13.14 MB / 458.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004284/0.08806, allocations: 3.064 MB / 0.5807 GB, free: 10.04 MB / 458.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009038/0.08896, allocations: 246.7 kB / 0.5809 GB, free: 9.801 MB / 458.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.694e-05/0.08906, allocations: 67.98 kB / 0.581 GB, free: 9.734 MB / 458.7 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001584/0.09065, allocations: 1.183 MB / 0.5821 GB, free: 8.547 MB / 458.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001434/0.09208, allocations: 1.204 MB / 0.5833 GB, free: 7.289 MB / 458.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002536/0.09462, allocations: 2.081 MB / 0.5853 GB, free: 5.164 MB / 458.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.739e-06/0.09462, allocations: 3.938 kB / 0.5853 GB, free: 5.16 MB / 458.7 MB
Notification: Performance of matching and sorting (n=242) (initialization_lambda0): time 0.005728/0.1003, allocations: 3.704 MB / 0.5889 GB, free: 1.445 MB / 458.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.411e-05/0.1004, allocations: 8 kB / 0.589 GB, free: 1.438 MB / 458.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.706e-06/0.1004, allocations: 11.94 kB / 0.589 GB, free: 1.426 MB / 458.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005543/0.1059, allocations: 3.005 MB / 0.5919 GB, free: 14.41 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006458/0.1066, allocations: 279.6 kB / 0.5922 GB, free: 14.14 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004408/0.111, allocations: 3.02 MB / 0.5951 GB, free: 11.09 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009584/0.1119, allocations: 219 kB / 0.5953 GB, free: 10.88 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.687e-05/0.112, allocations: 63.98 kB / 0.5954 GB, free: 10.82 MB / 474.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * 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 (163):
 * Single equations (assignments): 162
 * Array equations: 0
 * Algorithm blocks: 0
 * 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
   {(34,46)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003209/0.1123, allocations: 271.8 kB / 0.5956 GB, free: 10.54 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002191/0.1126, allocations: 170.9 kB / 0.5958 GB, free: 10.38 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008701/0.1213, allocations: 4.855 MB / 0.6005 GB, free: 5.496 MB / 474.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.099e-05/0.1213, allocations: 16 kB / 0.6006 GB, free: 5.48 MB / 474.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.763e-06/0.1213, allocations: 3.938 kB / 0.6006 GB, free: 5.477 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.077e-06/0.1213, allocations: 7.922 kB / 0.6006 GB, free: 5.469 MB / 474.7 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 postOpt removeSimpleEquations (simulation): time 0.01015/0.1314, allocations: 6.359 MB / 0.6068 GB, free: 15.04 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.38e-06/0.1314, allocations: 4 kB / 0.6068 GB, free: 15.04 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000394/0.1318, allocations: 147.8 kB / 0.6069 GB, free: 14.89 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003907/0.1357, allocations: 2.219 MB / 0.6091 GB, free: 12.67 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.182e-05/0.1358, allocations: 27.98 kB / 0.6091 GB, free: 12.64 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01565/0.1515, allocations: 11.38 MB / 0.6202 GB, free: 1.02 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.703e-06/0.1515, allocations: 0 / 0.6202 GB, free: 1.02 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.217/0.3684, allocations: 6.088 MB / 0.6262 GB, free: 102.8 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004582/0.3689, allocations: 202.3 kB / 0.6264 GB, free: 102.8 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001445/0.369, allocations: 30.3 kB / 0.6264 GB, free: 102.8 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007509/0.3698, allocations: 116.3 kB / 0.6265 GB, free: 102.8 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005968/0.3704, allocations: 270.6 kB / 0.6268 GB, free: 102.8 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.464e-05/0.3705, allocations: 42.58 kB / 0.6268 GB, free: 102.8 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.0008449/0.3713, allocations: 0.9064 MB / 0.6277 GB, free: 102.5 MB / 490.7 MB
Notification: Performance of sort global known variables: time 2.3e-07/0.3713, allocations: 0 / 0.6277 GB, free: 102.5 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.001319/0.3726, allocations: 0.87 MB / 0.6286 GB, free: 102.4 MB / 490.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 13 (gENCLS.delta,gENCLS.eq,gENROE.w,gENROE.delta,gENROE.Epd,gENROE.Epq,gENROE.PSIkd,gENROE.PSIkq,eXNI.derivativeLag.x,eXNI.simpleLag1.state,eXNI.TransducerDelay.state,eXNI.VR.state,gENCLS.omega)
 * 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 (81):
 * Single equations (assignments): 79
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,4), (26,23)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01041/0.383, allocations: 6.678 MB / 0.6351 GB, free: 100.2 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.007843/0.3909, allocations: 4.653 MB / 0.6396 GB, free: 99.02 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 4.228e-06/0.3909, allocations: 4.25 kB / 0.6396 GB, free: 99.02 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.003029/0.3939, allocations: 1.975 MB / 0.6416 GB, free: 98.28 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008129/0.3947, allocations: 149 kB / 0.6417 GB, free: 98.19 MB / 490.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02538/0.4201, allocations: 20.58 MB / 0.6618 GB, free: 79.13 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003299/0.4204, allocations: 0.6413 MB / 0.6624 GB, free: 78.45 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.000392/0.4208, allocations: 158.1 kB / 0.6626 GB, free: 78.29 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004384/0.4213, allocations: 0.6058 MB / 0.6632 GB, free: 77.69 MB / 490.7 MB
Notification: Performance of SimCode: time 1.172e-06/0.4213, allocations: 0 / 0.6632 GB, free: 77.69 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.05089/0.4721, allocations: 53.2 MB / 0.7151 GB, free: 24.6 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 8.832/9.304, allocations: 15.62 kB / 0.7151 GB, free: 24.59 MB / 490.7 MB
"
[Timeout remaining time 651]
(rm -f OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.EXNI.pipe ; mkfifo OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.EXNI.pipe ; head -c 1048576 < OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.EXNI.pipe >> ../files/OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.EXNI.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_EXNI_fmu --startTime=0 --stopTime=10 --stepSize=0.004 --timeout=50 --tolerance=1e-06 OpenIPSL_2_0_0_OpenIPSL_Tests_Controls_PSSE_ES_EXNI.fmu > OpenIPSL_2.0.0_OpenIPSL.Tests.Controls.PSSE.ES.EXNI.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 11.748192558065057]
Failed to read output from testmodel.py, exit status != 0:
9.412627344951034 9.418935813 9.397070237
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7eda693c1220>