Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.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.001812/0.001812, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001852/0.001852, allocations: 213.8 kB / 23.06 MB, free: 4.984 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.724/1.724, allocations: 207.7 MB / 233.9 MB, free: 9.762 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TAeZoSysPro master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TAeZoSysPro master/package.mo): time 0.07295/0.07295, allocations: 11.06 MB / 297.2 MB, free: 10.6 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/TAeZoSysPro_testsuite master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/TAeZoSysPro_testsuite master/package.mo): time 0.02205/0.02205, allocations: 4.312 MB / 356 MB, free: 15.63 MB / 302.1 MB
"
[Timeout remaining time 180]
Using package TAeZoSysPro_testsuite with version  (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TAeZoSysPro_testsuite master/package.mo)
Using package TAeZoSysPro with version  (/home/hudson/saved_omc/libraries/.openmodelica/libraries/TAeZoSysPro master/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 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(TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp")
translateModel(TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.123e-05/2.123e-05, allocations: 2.281 kB / 477.9 MB, free: 21.03 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp): time 0.3568/0.3568, allocations: 131.1 MB / 0.5948 GB, free: 15.93 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.005379/0.3622, allocations: 3.625 MB / 0.5983 GB, free: 12.3 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 6.052e-05/0.3623, allocations: 3.938 kB / 0.5983 GB, free: 12.29 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003607/0.3626, allocations: 35.88 kB / 0.5984 GB, free: 12.26 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 3.185e-05/0.3627, allocations: 11.86 kB / 0.5984 GB, free: 12.25 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002356/0.365, allocations: 0.6498 MB / 0.599 GB, free: 11.59 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0001231/0.3651, allocations: 31.86 kB / 0.599 GB, free: 11.56 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 4.674e-05/0.3652, allocations: 0 / 0.599 GB, free: 11.56 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 4.986e-05/0.3652, allocations: 19.91 kB / 0.5991 GB, free: 11.54 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 4.037e-05/0.3653, allocations: 15.94 kB / 0.5991 GB, free: 11.53 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 9.719e-06/0.3653, allocations: 0 / 0.5991 GB, free: 11.53 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001987/0.3673, allocations: 1.061 MB / 0.6001 GB, free: 10.46 MB / 398.1 MB
Notification: Performance of combineBinaries: time 8.057e-05/0.3673, allocations: 48.14 kB / 0.6002 GB, free: 10.42 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 3.535e-05/0.3674, allocations: 31.56 kB / 0.6002 GB, free: 10.39 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 1.515e-05/0.3674, allocations: 4 kB / 0.6002 GB, free: 10.38 MB / 398.1 MB
Notification: Performance of FrontEnd: time 8.316e-06/0.3674, allocations: 0 / 0.6002 GB, free: 10.38 MB / 398.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 6 (3)
 * Number of variables: 6 (5)
Notification: Performance of [SIM] Bindings: time 0.0006192/0.368, allocations: 352.3 kB / 0.6005 GB, free: 9.918 MB / 398.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0001477/0.3682, allocations: 62.86 kB / 0.6006 GB, free: 9.848 MB / 398.1 MB
Notification: Performance of [SIM] Early Inline: time 0.0001626/0.3683, allocations: 120.2 kB / 0.6007 GB, free: 9.703 MB / 398.1 MB
Notification: Performance of [SIM] Simplify 1: time 9.88e-05/0.3684, allocations: 68.53 kB / 0.6008 GB, free: 9.594 MB / 398.1 MB
Notification: Performance of [SIM] Alias: time 0.0004004/0.3688, allocations: 142 kB / 0.6009 GB, free: 9.398 MB / 398.1 MB
Notification: Performance of [SIM] Simplify 2: time 8.057e-05/0.3689, allocations: 72.64 kB / 0.601 GB, free: 9.281 MB / 398.1 MB
Notification: Performance of [SIM] Remove Stream: time 4.914e-05/0.369, allocations: 44.42 kB / 0.601 GB, free: 9.211 MB / 398.1 MB
Notification: Performance of [SIM] Detect States: time 0.0001261/0.3691, allocations: 84.89 kB / 0.6011 GB, free: 9.074 MB / 398.1 MB
Notification: Performance of [SIM] Events: time 1.741e-05/0.3691, allocations: 11.98 kB / 0.6011 GB, free: 9.062 MB / 398.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0001127/0.3692, allocations: 60.16 kB / 0.6012 GB, free: 8.988 MB / 398.1 MB
Notification: Performance of [SIM] Causalize: time 0.0002794/0.3695, allocations: 145.9 kB / 0.6013 GB, free: 8.832 MB / 398.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 5.613e-05/0.3696, allocations: 51.94 kB / 0.6014 GB, free: 8.781 MB / 398.1 MB
Notification: Performance of [INI] Simplify: time 0.0001709/0.3697, allocations: 113 kB / 0.6015 GB, free: 8.602 MB / 398.1 MB
Notification: Performance of [INI] Inline: time 0.0001005/0.3698, allocations: 99.89 kB / 0.6016 GB, free: 8.5 MB / 398.1 MB
Notification: Performance of [INI] Partitioning: time 2.243e-05/0.3698, allocations: 8.125 kB / 0.6016 GB, free: 8.484 MB / 398.1 MB
Notification: Performance of [INI] Cleanup: time 2.102e-05/0.3699, allocations: 12.28 kB / 0.6016 GB, free: 8.473 MB / 398.1 MB
Notification: Performance of [INI] Causalize: time 0.000253/0.3701, allocations: 156 kB / 0.6017 GB, free: 8.312 MB / 398.1 MB
Notification: Performance of [INI] Tearing: time 1.1e-05/0.3701, allocations: 4 kB / 0.6017 GB, free: 8.309 MB / 398.1 MB
Notification: Performance of [SIM] Initialization: time 3.3e-07/0.3701, allocations: 0 / 0.6017 GB, free: 8.309 MB / 398.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0001537/0.3703, allocations: 76.62 kB / 0.6018 GB, free: 8.223 MB / 398.1 MB
Notification: Performance of [SIM] Remove Dummies: time 4.048e-06/0.3703, allocations: 4 kB / 0.6018 GB, free: 8.219 MB / 398.1 MB
Notification: Performance of [SIM] Tearing: time 9.097e-06/0.3703, allocations: 12 kB / 0.6018 GB, free: 8.207 MB / 398.1 MB
Notification: Performance of [SIM] Categorize: time 9.788e-06/0.3703, allocations: 0 / 0.6018 GB, free: 8.207 MB / 398.1 MB
Notification: Performance of [SIM] Solve: time 0.0001711/0.3705, allocations: 83.92 kB / 0.6019 GB, free: 8.125 MB / 398.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0003216/0.3708, allocations: 383.6 kB / 0.6023 GB, free: 7.688 MB / 398.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: ............... 0
 * Number of algebraic event partitions: ......... 0
 * 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: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 0 (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: ........... 5 (scalar:4, array:1, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 5 (scalar:4, array:1, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 4.69e-05/0.3709, allocations: 27.81 kB / 0.6023 GB, free: 7.66 MB / 398.1 MB
Notification: Performance of SimCode: time 0.003389/0.3742, allocations: 1.368 MB / 0.6036 GB, free: 6.234 MB / 398.1 MB
Notification: Performance of Templates: time 0.01091/0.3851, allocations: 5.497 MB / 0.609 GB, free: 0.7383 MB / 398.1 MB
"
[Timeout remaining time 660]
make -j1 -f TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.makefile [Timeout 660]
(rm -f TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.pipe ; mkfifo TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.pipe ; head -c 1048576 < TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.pipe >> ../files/TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.sim & ./TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp  -abortSlowSimulation -alarm=480 -lv LOG_STATS > TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.Media.SimpleMoistAir.test_cp.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.613445260969456]
Failed to read output from testmodel.py, exit status != 0:
0.39301133999833837 0.410546383 0.039673898
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f1b9bb36fb0>