Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.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.002258/0.002258, allocations: 109.5 kB / 21.99 MB, free: 4.551 MB / 14.72 MB
"
[Timeout remaining time 180]
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.002167/0.002167, allocations: 214 kB / 25.3 MB, free: 2.902 MB / 14.72 MB
"
[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 1.786/1.786, allocations: 207.7 MB / 236.2 MB, free: 9.773 MB / 190.1 MB
"
[Timeout remaining time 178]
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 Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 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(Modelica.Media.Examples.WaterIF97,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|V|medium.h|medium.p",fileNamePrefix="Modelica_3.2.3_Modelica.Media.Examples.WaterIF97")
translateModel(Modelica.Media.Examples.WaterIF97,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|V|medium.h|medium.p",fileNamePrefix="Modelica_3.2.3_Modelica.Media.Examples.WaterIF97") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.473e-05/3.473e-05, allocations: 2.281 kB / 348.5 MB, free: 9.391 MB / 286.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Media.Examples.WaterIF97): time 0.02112/0.02116, allocations: 11.82 MB / 360.3 MB, free: 13.51 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01673/0.03788, allocations: 10.13 MB / 370.5 MB, free: 3.348 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001882/0.03807, allocations: 4 kB / 370.5 MB, free: 3.344 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0004176/0.03849, allocations: 63.59 kB / 370.5 MB, free: 3.281 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0005117/0.039, allocations: 83.36 kB / 370.6 MB, free: 3.199 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02028/0.05927, allocations: 5.022 MB / 375.6 MB, free: 14.16 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0006563/0.05993, allocations: 314.9 kB / 375.9 MB, free: 13.85 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.000124/0.06005, allocations: 12.17 kB / 375.9 MB, free: 13.84 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001031/0.06109, allocations: 231 kB / 376.2 MB, free: 13.61 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002792/0.06137, allocations: 71.69 kB / 376.2 MB, free: 13.54 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 5.602e-05/0.06142, allocations: 8 kB / 376.3 MB, free: 13.54 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01445/0.07587, allocations: 6.173 MB / 382.4 MB, free: 7.355 MB / 318.1 MB
Notification: Performance of combineBinaries: time 0.0004925/0.07636, allocations: 265.4 kB / 382.7 MB, free: 7.094 MB / 318.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0002263/0.07659, allocations: 161.9 kB / 382.8 MB, free: 6.934 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001009/0.07669, allocations: 20 kB / 382.9 MB, free: 6.914 MB / 318.1 MB
Notification: Performance of FrontEnd: time 5.771e-05/0.07674, allocations: 0 / 382.9 MB, free: 6.914 MB / 318.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 34 (26)
 * Number of variables: 34 (34)
Notification: Performance of [SIM] Bindings: time 0.002179/0.07892, allocations: 0.9941 MB / 383.9 MB, free: 5.793 MB / 318.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0002144/0.07914, allocations: 95.89 kB / 383.9 MB, free: 5.688 MB / 318.1 MB
Notification: Performance of [SIM] Early Inline: time 0.002927/0.08206, allocations: 1.626 MB / 385.6 MB, free: 4.035 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0004387/0.0825, allocations: 177.8 kB / 385.7 MB, free: 3.812 MB / 318.1 MB
Notification: Performance of [SIM] Alias: time 0.001835/0.08434, allocations: 0.7167 MB / 386.5 MB, free: 3.008 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0003205/0.08466, allocations: 202.5 kB / 386.7 MB, free: 2.766 MB / 318.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0002141/0.08487, allocations: 120.2 kB / 386.8 MB, free: 2.621 MB / 318.1 MB
Notification: Performance of [SIM] Detect States: time 0.0006351/0.08551, allocations: 311.1 kB / 387.1 MB, free: 2.262 MB / 318.1 MB
Notification: Performance of [SIM] Events: time 0.0005635/0.08607, allocations: 264.6 kB / 387.3 MB, free: 2 MB / 318.1 MB
Notification: Performance of [SIM] Partitioning: time 0.000731/0.0868, allocations: 492.1 kB / 387.8 MB, free: 1.473 MB / 318.1 MB
Notification: Performance of [SIM] Causalize: time 0.276/0.3628, allocations: 3.077 MB / 390.9 MB, free: 23.26 MB / 318.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002527/0.3653, allocations: 2.052 MB / 393 MB, free: 23.26 MB / 318.1 MB
Notification: Performance of [INI] Simplify: time 0.001112/0.3664, allocations: 0.6711 MB / 393.6 MB, free: 23.1 MB / 318.1 MB
Notification: Performance of [INI] Inline: time 0.003198/0.3696, allocations: 2.782 MB / 396.4 MB, free: 23.09 MB / 318.1 MB
Notification: Performance of [INI] Partitioning: time 4.573e-05/0.3696, allocations: 26.48 kB / 396.4 MB, free: 23.07 MB / 318.1 MB
Notification: Performance of [INI] Cleanup: time 0.0004511/0.3701, allocations: 418.5 kB / 396.8 MB, free: 23.07 MB / 318.1 MB
Notification: Performance of [INI] Causalize: time 0.002288/0.3724, allocations: 1.443 MB / 398.3 MB, free: 23 MB / 318.1 MB
Notification: Performance of [INI] Tearing: time 0.0001366/0.3725, allocations: 71.31 kB / 398.4 MB, free: 22.99 MB / 318.1 MB
Notification: Performance of [SIM] Initialization: time 4.81e-07/0.3725, allocations: 0 / 398.4 MB, free: 22.99 MB / 318.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.001222/0.3737, allocations: 0.9015 MB / 399.3 MB, free: 22.59 MB / 318.1 MB
Notification: Performance of [SIM] Remove Dummies: time 9.207e-06/0.3738, allocations: 1.422 kB / 399.3 MB, free: 22.59 MB / 318.1 MB
Notification: Performance of [SIM] Tearing: time 0.0002916/0.374, allocations: 213 kB / 399.5 MB, free: 22.55 MB / 318.1 MB
Notification: Performance of [SIM] Categorize: time 1.883e-05/0.3741, allocations: 6.969 kB / 399.5 MB, free: 22.55 MB / 318.1 MB
Notification: Performance of [SIM] Solve: time 0.005921/0.38, allocations: 4.29 MB / 403.8 MB, free: 22.04 MB / 318.1 MB
Notification: Performance of [SIM] Jacobian: time 0.01976/0.3997, allocations: 22.67 MB / 426.4 MB, free: 3.055 MB / 318.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 2
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 3
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 3 (3) {m, U, medium.h}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 9 (9) {medium.state.phase, medium.phase, state2.phase, state.phase, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_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: ........... 44 (scalar:44, array:0, 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: ... 2 (linear: 2, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 52 (scalar:52, array:0, 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: Performance of backend: time 0.0002148/0.4, allocations: 34.12 kB / 426.5 MB, free: 3.023 MB / 318.1 MB
Notification: Performance of SimCode: time 0.03818/0.4381, allocations: 13.84 MB / 440.3 MB, free: 10.62 MB / 334.1 MB
Notification: Performance of Templates: time 0.1012/0.5393, allocations: 59.85 MB / 0.4884 GB, free: 14.7 MB / 398.1 MB
"
[Timeout remaining time 659]
make -j1 -f Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.makefile [Timeout 660]
(rm -f Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.pipe ; mkfifo Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.pipe ; head -c 1048576 < Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.pipe >> ../files/Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.sim & ./Modelica_3.2.3_Modelica.Media.Examples.WaterIF97  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_3.2.3_Modelica.Media.Examples.WaterIF97.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 7.099230193009134]
Failed to read output from testmodel.py, exit status != 0:
['time', 'V', 'medium.h', 'medium.p']
0.5499454690143466 0.5653418610000001 0.485159229
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f1f3a286fb0>