Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.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.002134/0.002134, allocations: 95.66 kB / 21.25 MB, free: 428 kB / 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.002479/0.002479, allocations: 211.2 kB / 24.55 MB, free: 3.746 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.472/1.472, allocations: 230.6 MB / 258.3 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.225/0.225, allocations: 44.94 MB / 359.7 MB, free: 6.035 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.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 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(ModelicaTest.Media.TestOnly.IdealGasN2Mix,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|medium.T|medium.p",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix")
translateModel(ModelicaTest.Media.TestOnly.IdealGasN2Mix,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|medium.T|medium.p",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.512e-05/2.512e-05, allocations: 6.219 kB / 0.4943 GB, free: 10.07 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestOnly.IdealGasN2Mix): time 0.4236/0.4237, allocations: 131.5 MB / 0.6227 GB, free: 1.418 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.002248/0.4259, allocations: 1.428 MB / 0.6241 GB, free: 0 / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001061/0.426, allocations: 4.047 kB / 0.6241 GB, free: 15.99 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003711/0.4264, allocations: 43.7 kB / 0.6242 GB, free: 15.95 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001312/0.4277, allocations: 418 kB / 0.6246 GB, free: 15.54 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0005763/0.4283, allocations: 176.5 kB / 0.6247 GB, free: 15.38 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0003208/0.4286, allocations: 203.2 kB / 0.6249 GB, free: 15.18 MB / 462.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 6.113e-05/0.4286, allocations: 4.531 kB / 0.6249 GB, free: 15.17 MB / 462.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.000247/0.4289, allocations: 101.6 kB / 0.625 GB, free: 15.07 MB / 462.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001343/0.429, allocations: 47.83 kB / 0.6251 GB, free: 15.03 MB / 462.1 MB
Notification: Performance of NFPackage.collectConstants: time 2.701e-05/0.4291, allocations: 8 kB / 0.6251 GB, free: 15.02 MB / 462.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001016/0.4301, allocations: 0.5143 MB / 0.6256 GB, free: 14.5 MB / 462.1 MB
Notification: Performance of combineBinaries: time 0.0002276/0.4303, allocations: 194.3 kB / 0.6258 GB, free: 14.31 MB / 462.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0001066/0.4304, allocations: 118.6 kB / 0.6259 GB, free: 14.19 MB / 462.1 MB
Notification: Performance of NFVerifyModel.verify: time 3.817e-05/0.4304, allocations: 12 kB / 0.6259 GB, free: 14.18 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.672e-05/0.4305, allocations: 0 / 0.6259 GB, free: 14.18 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: 21 (21)
 * Number of variables: 21 (21)
Notification: Performance of [SIM] Bindings: time 0.001023/0.4315, allocations: 0.6829 MB / 0.6266 GB, free: 13.37 MB / 462.1 MB
Notification: Performance of [SIM] FunctionAlias: time 9.79e-05/0.4316, allocations: 63.98 kB / 0.6266 GB, free: 13.3 MB / 462.1 MB
Notification: Performance of [SIM] Early Inline: time 0.002231/0.4338, allocations: 1.689 MB / 0.6283 GB, free: 11.6 MB / 462.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0008572/0.4347, allocations: 0.5747 MB / 0.6288 GB, free: 11.05 MB / 462.1 MB
Notification: Performance of [SIM] Alias: time 0.001419/0.4361, allocations: 0.7635 MB / 0.6296 GB, free: 10.23 MB / 462.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0007366/0.4368, allocations: 0.5457 MB / 0.6301 GB, free: 9.672 MB / 462.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0002049/0.437, allocations: 132.3 kB / 0.6302 GB, free: 9.516 MB / 462.1 MB
Notification: Performance of [SIM] Detect States: time 0.0005521/0.4376, allocations: 356.3 kB / 0.6306 GB, free: 9.113 MB / 462.1 MB
Notification: Performance of [SIM] Events: time 0.0002463/0.4378, allocations: 123.7 kB / 0.6307 GB, free: 8.992 MB / 462.1 MB
Notification: Performance of [SIM] Partitioning: time 0.000635/0.4385, allocations: 0.4939 MB / 0.6312 GB, free: 8.492 MB / 462.1 MB
Notification: Performance of [SIM] Causalize: time 0.0009095/0.4394, allocations: 0.5047 MB / 0.6317 GB, free: 7.984 MB / 462.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001147/0.4405, allocations: 0.9912 MB / 0.6326 GB, free: 6.992 MB / 462.1 MB
Notification: Performance of [INI] Simplify: time 0.001187/0.4417, allocations: 0.6979 MB / 0.6333 GB, free: 6.266 MB / 462.1 MB
Notification: Performance of [INI] Inline: time 0.002038/0.4437, allocations: 1.701 MB / 0.635 GB, free: 4.559 MB / 462.1 MB
Notification: Performance of [INI] Partitioning: time 3.798e-05/0.4438, allocations: 16.12 kB / 0.635 GB, free: 4.535 MB / 462.1 MB
Notification: Performance of [INI] Cleanup: time 0.0005183/0.4443, allocations: 263.6 kB / 0.6353 GB, free: 4.277 MB / 462.1 MB
Notification: Performance of [INI] Causalize: time 0.001113/0.4454, allocations: 0.5728 MB / 0.6358 GB, free: 3.699 MB / 462.1 MB
Notification: Performance of [INI] Tearing: time 3.149e-05/0.4454, allocations: 16 kB / 0.6358 GB, free: 3.684 MB / 462.1 MB
Notification: Performance of [SIM] Initialization: time 1.202e-06/0.4454, allocations: 0 / 0.6358 GB, free: 3.684 MB / 462.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.001297/0.4467, allocations: 0.8928 MB / 0.6367 GB, free: 2.867 MB / 462.1 MB
Notification: Performance of [SIM] Remove Dummies: time 9.388e-06/0.4468, allocations: 0 / 0.6367 GB, free: 2.867 MB / 462.1 MB
Notification: Performance of [SIM] Tearing: time 9.215e-05/0.4468, allocations: 36 kB / 0.6367 GB, free: 2.832 MB / 462.1 MB
Notification: Performance of [SIM] Categorize: time 1.361e-05/0.4469, allocations: 4 kB / 0.6367 GB, free: 2.828 MB / 462.1 MB
Notification: Performance of [SIM] Solve: time 0.005226/0.4521, allocations: 4.145 MB / 0.6408 GB, free: 14.8 MB / 478.1 MB
Notification: Performance of [SIM] Jacobian: time 0.00204/0.4541, allocations: 1.468 MB / 0.6422 GB, free: 13.26 MB / 478.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * 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: ............................. 2 (2) {m, U}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 5 (5) {$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: ........... 22 (scalar:20, array:2, 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: ........... 26 (scalar:24, array:2, 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: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 5.446e-05/0.4542, allocations: 13.5 kB / 0.6422 GB, free: 13.25 MB / 478.1 MB
Notification: Performance of SimCode: time 0.004092/0.4583, allocations: 1.969 MB / 0.6442 GB, free: 11.27 MB / 478.1 MB
Notification: Performance of Templates: time 0.01733/0.4756, allocations: 9.622 MB / 0.6536 GB, free: 1.609 MB / 478.1 MB
"
[Timeout remaining time 660]
make -j1 -f ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.makefile [Timeout 660]
(rm -f ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.pipe ; mkfifo ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.pipe ; head -c 1048576 < ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.pipe >> ../files/ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.sim & ./ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.0.0_ModelicaTest.Media.TestOnly.IdealGasN2Mix.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.461122989014257]
Failed to read output from testmodel.py, exit status != 0:
['time', 'medium.T', 'medium.p']
0.4847570229903795 0.499115672 0.06560508500000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f8ef911efb0>