Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.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.001948/0.001948, allocations: 96.42 kB / 20.52 MB, free: 1.152 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.002698/0.002698, allocations: 218.7 kB / 23.82 MB, free: 4.344 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.715/1.715, allocations: 207.7 MB / 234.7 MB, free: 9.762 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo): time 0.2602/0.2602, allocations: 44.26 MB / 331.2 MB, free: 9.363 MB / 270.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+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 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.TestAllProperties.DryAirNasa,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|eps_h_is|eta|lambda|Pr|p|T|d|h|u|s|g|f|cp|cp2|cv|cv2|h_is|a|beta|beta2|kappa|kappa2|ddpT|ddTp|dddX.1.|MM|h2|d2|err_T|err_d|err_u|s_is|err_h_is|eps",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa")
translateModel(ModelicaTest.Media.TestAllProperties.DryAirNasa,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|eps_h_is|eta|lambda|Pr|p|T|d|h|u|s|g|f|cp|cp2|cv|cv2|h_is|a|beta|beta2|kappa|kappa2|ddpT|ddTp|dddX.1.|MM|h2|d2|err_T|err_d|err_u|s_is|err_h_is|eps",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.384e-05/2.384e-05, allocations: 3.828 kB / 468.9 MB, free: 3.828 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestAllProperties.DryAirNasa): time 0.4693/0.4694, allocations: 130.2 MB / 0.585 GB, free: 5.273 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00788/0.4772, allocations: 6.342 MB / 0.5912 GB, free: 4.227 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001552/0.4774, allocations: 6.125 kB / 0.5912 GB, free: 4.223 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002963/0.4777, allocations: 49.28 kB / 0.5912 GB, free: 4.203 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003799/0.4815, allocations: 1.468 MB / 0.5927 GB, free: 3.66 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0003305/0.4818, allocations: 137.2 kB / 0.5928 GB, free: 3.625 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0005292/0.4823, allocations: 449.9 kB / 0.5932 GB, free: 3.484 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 6.57e-05/0.4824, allocations: 10.98 kB / 0.5932 GB, free: 3.477 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002565/0.4827, allocations: 187.3 kB / 0.5934 GB, free: 3.41 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002704/0.4829, allocations: 172.9 kB / 0.5936 GB, free: 3.34 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 3.51e-05/0.483, allocations: 8.094 kB / 0.5936 GB, free: 3.34 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002087/0.4851, allocations: 1.118 MB / 0.5947 GB, free: 3.023 MB / 414.1 MB
Notification: Performance of combineBinaries: time 0.0003127/0.4854, allocations: 444.5 kB / 0.5951 GB, free: 2.781 MB / 414.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0001385/0.4855, allocations: 282.2 kB / 0.5954 GB, free: 2.605 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 3.642e-05/0.4855, allocations: 23.88 kB / 0.5954 GB, free: 2.605 MB / 414.1 MB
Notification: Performance of FrontEnd: time 1.937e-05/0.4856, allocations: 2.844 kB / 0.5954 GB, free: 2.605 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 56 (54)
 * Number of variables: 56 (56)
Notification: Performance of [SIM] Bindings: time 0.001239/0.4868, allocations: 1.377 MB / 0.5967 GB, free: 1.73 MB / 414.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0001692/0.487, allocations: 165.5 kB / 0.5969 GB, free: 1.633 MB / 414.1 MB
Notification: Performance of [SIM] Early Inline: time 0.003609/0.4906, allocations: 4.099 MB / 0.6009 GB, free: 15.66 MB / 430.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001821/0.4924, allocations: 1.452 MB / 0.6023 GB, free: 14.69 MB / 430.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.002321/0.4947, allocations: 1.822 MB / 0.6041 GB, free: 13.24 MB / 430.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001653/0.4964, allocations: 1.415 MB / 0.6055 GB, free: 12.22 MB / 430.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.000297/0.4967, allocations: 261.7 kB / 0.6057 GB, free: 12 MB / 430.1 MB
Notification: Performance of [SIM] Detect States: time 0.0006614/0.4973, allocations: 0.659 MB / 0.6064 GB, free: 11.45 MB / 430.1 MB
Notification: Performance of [SIM] Events: time 0.0003653/0.4977, allocations: 310.9 kB / 0.6067 GB, free: 11.25 MB / 430.1 MB
Notification: Performance of [SIM] Partitioning: time 0.001174/0.4989, allocations: 1.24 MB / 0.6079 GB, free: 10.52 MB / 430.1 MB
Notification: Performance of [SIM] Causalize: time 0.001513/0.5004, allocations: 1.23 MB / 0.6091 GB, free: 10.04 MB / 430.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001914/0.5023, allocations: 2.181 MB / 0.6112 GB, free: 8.656 MB / 430.1 MB
Notification: Performance of [INI] Simplify: time 0.002075/0.5044, allocations: 1.664 MB / 0.6128 GB, free: 7.434 MB / 430.1 MB
Notification: Performance of [INI] Inline: time 0.003498/0.5079, allocations: 3.752 MB / 0.6165 GB, free: 4.98 MB / 430.1 MB
Notification: Performance of [INI] Partitioning: time 4.706e-05/0.5079, allocations: 24.12 kB / 0.6165 GB, free: 4.965 MB / 430.1 MB
Notification: Performance of [INI] Cleanup: time 0.0006114/0.5085, allocations: 0.579 MB / 0.6171 GB, free: 4.539 MB / 430.1 MB
Notification: Performance of [INI] Causalize: time 0.001522/0.5101, allocations: 1.242 MB / 0.6183 GB, free: 4.094 MB / 430.1 MB
Notification: Performance of [INI] Tearing: time 2.796e-05/0.5101, allocations: 32.38 kB / 0.6183 GB, free: 4.07 MB / 430.1 MB
Notification: Performance of [SIM] Initialization: time 6.32e-07/0.5101, allocations: 0 / 0.6183 GB, free: 4.07 MB / 430.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.002768/0.5129, allocations: 2.441 MB / 0.6207 GB, free: 2.145 MB / 430.1 MB
Notification: Performance of [SIM] Remove Dummies: time 9.157e-06/0.5129, allocations: 2.688 kB / 0.6207 GB, free: 2.145 MB / 430.1 MB
Notification: Performance of [SIM] Tearing: time 4.181e-05/0.5129, allocations: 57.31 kB / 0.6208 GB, free: 2.102 MB / 430.1 MB
Notification: Performance of [SIM] Categorize: time 2.02e-05/0.5129, allocations: 10.88 kB / 0.6208 GB, free: 2.094 MB / 430.1 MB
Notification: Performance of [SIM] Solve: time 0.01309/0.526, allocations: 10.81 MB / 0.6313 GB, free: 8.367 MB / 446.1 MB
Notification: Performance of [SIM] Jacobian: time 0.001524/0.5275, allocations: 1.387 MB / 0.6327 GB, free: 6.77 MB / 446.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 3
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 2
 * 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: ................. 9 (9) {$SEV_8, $SEV_7, $SEV_6, $SEV_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: ........... 55 (scalar:54, array:1, 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: 0, nonlinear:1)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 55 (scalar:54, array:1, 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: 0, nonlinear:1)
Notification: Performance of backend: time 9.24e-05/0.5276, allocations: 53.84 kB / 0.6328 GB, free: 6.719 MB / 446.1 MB
Notification: Performance of SimCode: time 0.008894/0.5365, allocations: 3.749 MB / 0.6364 GB, free: 2.902 MB / 446.1 MB
Notification: Performance of Templates: time 0.03529/0.5718, allocations: 21.84 MB / 0.6577 GB, free: 12.89 MB / 478.1 MB
"
[Timeout remaining time 659]
make -j1 -f ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.makefile [Timeout 660]
(rm -f ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.pipe >> ../files/ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.sim & ./ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_3.2.3_ModelicaTest.Media.TestAllProperties.DryAirNasa.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 7.157324797008187]
Failed to read output from testmodel.py, exit status != 0:
['time', 'eps_h_is', 'eta', 'lambda', 'Pr', 'p', 'T', 'd', 'h', 'u', 's', 'g', 'f', 'cp', 'cp2', 'cv', 'cv2', 'h_is', 'a', 'beta', 'beta2', 'kappa', 'kappa2', 'ddpT', 'ddTp', 'dddX[1]', 'MM', 'h2', 'd2', 'err_T', 'err_d', 'err_u', 's_is', 'err_h_is', 'eps']
0.5810401759808883 0.595521546 0.106946651
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fdcacecefb0>