Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.conf.json
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.001953/0.001953, allocations: 78.81 kB / 19.77 MB, free: 2.043 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.474/1.474, allocations: 177.2 MB / 200.1 MB, free: 8.523 MB / 190.1 MB
"
[Timeout remaining time 178]
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.001612/0.001612, allocations: 156.6 kB / 256.6 MB, free: 4.426 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0/package.mo): time 0.5976/0.5976, allocations: 80.29 MB / 393.3 MB, free: 29.75 MB / 334.1 MB
"
[Timeout remaining time 179]
Using package OpenIPSL with version 3.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.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 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+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)
Running command: translateModel(OpenIPSL.Data.PowerPlant.Examples.Anderson,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson")
translateModel(OpenIPSL.Data.PowerPlant.Examples.Anderson,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.371e-05/1.371e-05, allocations: 2.281 kB / 0.5557 GB, free: 14.31 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(OpenIPSL.Data.PowerPlant.Examples.Anderson): time 0.009947/0.009961, allocations: 10.75 MB / 0.5662 GB, free: 7.062 MB / 430.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01118/0.02115, allocations: 9.764 MB / 0.5758 GB, free: 15.42 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001681/0.02283, allocations: 38.53 kB / 0.5758 GB, free: 15.41 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002863/0.02569, allocations: 1.105 MB / 0.5769 GB, free: 14.6 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003775/0.02946, allocations: 1.499 MB / 0.5783 GB, free: 13.35 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003295/0.03276, allocations: 1.508 MB / 0.5798 GB, free: 12.16 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005923/0.03868, allocations: 5.116 MB / 0.5848 GB, free: 8.68 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009841/0.03967, allocations: 428.7 kB / 0.5852 GB, free: 8.23 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003434/0.0431, allocations: 2.544 MB / 0.5877 GB, free: 5.68 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001886/0.04499, allocations: 1.563 MB / 0.5892 GB, free: 4.109 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0004792/0.04547, allocations: 356 kB / 0.5896 GB, free: 3.762 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001993/0.04746, allocations: 0.8942 MB / 0.5904 GB, free: 2.867 MB / 446.1 MB
Notification: Performance of combineBinaries: time 0.006147/0.05361, allocations: 6.874 MB / 0.5972 GB, free: 11.93 MB / 462.1 MB
Notification: Performance of replaceArrayConstructors: time 0.003424/0.05703, allocations: 3.999 MB / 0.6011 GB, free: 7.879 MB / 462.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004124/0.05744, allocations: 168 kB / 0.6012 GB, free: 7.715 MB / 462.1 MB
Notification: Performance of FrontEnd: time 0.0004231/0.05787, allocations: 91.48 kB / 0.6013 GB, free: 7.625 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 355 (341)
 * Number of variables: 355 (355)
Notification: Performance of [SIM] Bindings: time 0.01693/0.0748, allocations: 16.99 MB / 0.6179 GB, free: 6.203 MB / 478.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.003368/0.07817, allocations: 2.459 MB / 0.6203 GB, free: 3.695 MB / 478.1 MB
Notification: Performance of [SIM] Early Inline: time 0.01345/0.09162, allocations: 12.15 MB / 0.6322 GB, free: 7.414 MB / 494.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.002642/0.09426, allocations: 1.417 MB / 0.6335 GB, free: 5.887 MB / 494.1 MB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.01345/0.1077, allocations: 9.507 MB / 0.6428 GB, free: 11.47 MB / 0.4981 GB
Notification: Performance of [SIM] Simplify 2: time 0.002051/0.1098, allocations: 1.217 MB / 0.644 GB, free: 10.14 MB / 0.4981 GB
Notification: Performance of [SIM] Remove Stream: time 0.0008751/0.1106, allocations: 0.7054 MB / 0.6447 GB, free: 9.371 MB / 0.4981 GB
Notification: Performance of [SIM] Detect States: time 0.003284/0.1139, allocations: 2.791 MB / 0.6474 GB, free: 6.441 MB / 0.4981 GB
Notification: Performance of [SIM] Events: time 0.00116/0.1151, allocations: 0.7891 MB / 0.6482 GB, free: 5.625 MB / 0.4981 GB
Notification: Performance of [SIM] Partitioning: time 0.003515/0.1186, allocations: 2.871 MB / 0.651 GB, free: 2.684 MB / 0.4981 GB
Notification: Performance of [SIM] Causalize: time 0.008199/0.1268, allocations: 5.252 MB / 0.6561 GB, free: 13.3 MB / 0.5137 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.007068/0.1339, allocations: 6.698 MB / 0.6627 GB, free: 6.598 MB / 0.5137 GB
Notification: Performance of [INI] Simplify: time 0.01071/0.1446, allocations: 6.379 MB / 0.6689 GB, free: 15.94 MB / 0.5294 GB
Notification: Performance of [INI] Inline: time 0.01584/0.1604, allocations: 14.59 MB / 0.6832 GB, free: 1.301 MB / 0.5294 GB
Notification: Performance of [INI] Partitioning: time 0.0005902/0.161, allocations: 209 kB / 0.6834 GB, free: 1.051 MB / 0.5294 GB
Notification: Performance of [INI] Cleanup: time 0.004715/0.1657, allocations: 4.498 MB / 0.6878 GB, free: 12.52 MB / 0.545 GB
Notification: Performance of [INI] Causalize: time 0.04454/0.2103, allocations: 27.56 MB / 0.7147 GB, free: 452 kB / 0.5606 GB
Notification: Performance of [INI] Tearing: time 0.006983/0.2172, allocations: 5.033 MB / 0.7196 GB, free: 11.3 MB / 0.5762 GB
Notification: Performance of [SIM] Initialization: time 1.633e-06/0.2172, allocations: 0 / 0.7196 GB, free: 11.3 MB / 0.5762 GB
Notification: Performance of [SIM] Remove Dummies: time 2.413e-05/0.2173, allocations: 2 kB / 0.7196 GB, free: 11.3 MB / 0.5762 GB
Notification: Performance of [SIM] Tearing: time 0.002523/0.2198, allocations: 1.771 MB / 0.7213 GB, free: 9.484 MB / 0.5762 GB
Notification: Performance of [SIM] Categorize: time 3.13e-05/0.2198, allocations: 12 kB / 0.7213 GB, free: 9.473 MB / 0.5762 GB
Notification: Performance of [SIM] Solve: time 0.01205/0.2319, allocations: 7.335 MB / 0.7285 GB, free: 2.113 MB / 0.5762 GB
Notification: Performance of [SIM] Jacobian: time 0.2386/0.4705, allocations: 12.41 MB / 0.7406 GB, free: 116 MB / 0.5762 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 1
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 2
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 25 (25) {gENCLS.delta, gENCLS.omega, gENCLS.eq, generator1.gENROE.w, generator1.gENROE.ANGLE, generator1.eSDC1A.imDerivativeLag.x, generator1.eSDC1A.imLeadLag.TF.x_scaled, generator1.eSDC1A.simpleLagLim.state, generator1.gENROE.EFD, generator1.eSDC1A.TransducerDelay.state, generator1.iEE2ST.imDerivativeLag.x, generator1.iEE2ST.imSimpleLag.state, generator1.iEE2ST.imSimpleLag1.state, generator1.iEE2ST.imLeadLag.TF.x_scaled, generator1.iEE2ST.imLeadLag1.TF.x_scaled, generator1.iEE2ST.imLeadLag2.TF.x_scaled, generator1.iEESGO.imSimpleLag.state, generator1.iEESGO.imLeadLag.TF.x_scaled, generator1.iEESGO.imSimpleLag1.state, generator1.iEESGO.imSimpleLag2.state, generator1.iEESGO.imSimpleLag3.state, generator1.gENROE.Epd, generator1.gENROE.Epq, generator1.gENROE.PSIkd, generator1.gENROE.PSIkq}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 39 (39) {$SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_19, $TEV_18, $TEV_17, $TEV_16, $TEV_15, $TEV_14, $TEV_13, $TEV_12, $TEV_11, $TEV_10, $TEV_9, $TEV_8, $TEV_7, $TEV_6, $TEV_5, $TEV_4, $TEV_3, $TEV_2, $TEV_1, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 177 (scalar:160, array:17, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 547 (scalar:525, array:22, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:1)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 547 (scalar:525, array:22, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:1)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0002322/0.4707, allocations: 227.8 kB / 0.7408 GB, free: 115.8 MB / 0.5762 GB
Notification: Performance of SimCode: time 0.01625/0.487, allocations: 17.04 MB / 0.7575 GB, free: 112.1 MB / 0.5762 GB
Notification: Performance of Templates: time 0.05865/0.5456, allocations: 42.79 MB / 0.7992 GB, free: 84.39 MB / 0.5762 GB
"
[Timeout remaining time 659]
make -j1 -f OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.makefile [Timeout 660]
(rm -f OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.pipe ; mkfifo OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.pipe ; head -c 1048576 < OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.pipe >> ../files/OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.sim & ./OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson  -abortSlowSimulation -alarm=480 -lv LOG_STATS > OpenIPSL_OpenIPSL.Data.PowerPlant.Examples.Anderson.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 12.325725220143795]
Failed to read output from testmodel.py, exit status != 0:
0.5522841550409794 0.562295446 0.502155204
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3200a6afb0>