Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.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.001327/0.001327, 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.002326/0.002326, allocations: 211.9 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.622/1.622, allocations: 207.7 MB / 233.9 MB, free: 9.766 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.06907/0.06907, allocations: 11.08 MB / 297.3 MB, free: 10.48 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.02158/0.02158, allocations: 4.309 MB / 356 MB, free: 15.52 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.HeatTransfer.Components.test_Ventilation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation")
translateModel(TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.443e-05/2.443e-05, allocations: 2.281 kB / 477.9 MB, free: 21.03 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation): time 0.002578/0.002602, allocations: 1.763 MB / 479.7 MB, free: 19.24 MB / 318.1 MB
Notification: Performance of NFInst.instExpressions: time 0.3756/0.3782, allocations: 116.6 MB / 0.5823 GB, free: 12.82 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001184/0.3783, allocations: 4 kB / 0.5823 GB, free: 12.82 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001641/0.3785, allocations: 23.8 kB / 0.5823 GB, free: 12.8 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 8.92e-05/0.3785, allocations: 37.98 kB / 0.5824 GB, free: 12.76 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0008857/0.3794, allocations: 255 kB / 0.5826 GB, free: 12.51 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0003079/0.3797, allocations: 183.3 kB / 0.5828 GB, free: 12.33 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001636/0.3799, allocations: 38.28 kB / 0.5828 GB, free: 12.29 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001716/0.3801, allocations: 67.72 kB / 0.5829 GB, free: 12.23 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 9.831e-05/0.3802, allocations: 55.75 kB / 0.5829 GB, free: 12.17 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 2.343e-05/0.3802, allocations: 12 kB / 0.583 GB, free: 12.16 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0004567/0.3806, allocations: 227.5 kB / 0.5832 GB, free: 11.94 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.0002721/0.3809, allocations: 234.3 kB / 0.5834 GB, free: 11.71 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0001024/0.381, allocations: 142.2 kB / 0.5835 GB, free: 11.57 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 2.455e-05/0.381, allocations: 12 kB / 0.5835 GB, free: 11.55 MB / 382.1 MB
Notification: Performance of FrontEnd: time 2.813e-05/0.3811, allocations: 7.938 kB / 0.5835 GB, free: 11.55 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 30 (30)
 * Number of variables: 30 (30)
Notification: Performance of [SIM] Bindings: time 0.0008495/0.3819, allocations: 0.6743 MB / 0.5842 GB, free: 10.75 MB / 382.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0001169/0.382, allocations: 87.95 kB / 0.5843 GB, free: 10.66 MB / 382.1 MB
Notification: Performance of [SIM] Early Inline: time 0.0004839/0.3825, allocations: 384.1 kB / 0.5847 GB, free: 10.25 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0001756/0.3827, allocations: 109.9 kB / 0.5848 GB, free: 10.1 MB / 382.1 MB
Notification: Performance of [SIM] Alias: time 0.001192/0.3839, allocations: 0.6399 MB / 0.5854 GB, free: 9.328 MB / 382.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0001208/0.384, allocations: 81.62 kB / 0.5855 GB, free: 9.203 MB / 382.1 MB
Notification: Performance of [SIM] Remove Stream: time 6.066e-05/0.3841, allocations: 56.34 kB / 0.5855 GB, free: 9.121 MB / 382.1 MB
Notification: Performance of [SIM] Detect States: time 0.0002108/0.3843, allocations: 120.8 kB / 0.5856 GB, free: 8.949 MB / 382.1 MB
Notification: Performance of [SIM] Events: time 2.399e-05/0.3843, allocations: 8 kB / 0.5856 GB, free: 8.941 MB / 382.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0001724/0.3845, allocations: 112.4 kB / 0.5857 GB, free: 8.801 MB / 382.1 MB
Notification: Performance of [SIM] Causalize: time 0.0002978/0.3848, allocations: 188.1 kB / 0.5859 GB, free: 8.59 MB / 382.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0001132/0.3849, allocations: 119.8 kB / 0.586 GB, free: 8.473 MB / 382.1 MB
Notification: Performance of [INI] Simplify: time 0.0003538/0.3852, allocations: 239 kB / 0.5863 GB, free: 8.172 MB / 382.1 MB
Notification: Performance of [INI] Inline: time 0.0003169/0.3856, allocations: 280.9 kB / 0.5865 GB, free: 7.895 MB / 382.1 MB
Notification: Performance of [INI] Partitioning: time 3.451e-05/0.3856, allocations: 20.12 kB / 0.5866 GB, free: 7.867 MB / 382.1 MB
Notification: Performance of [INI] Cleanup: time 4.127e-05/0.3856, allocations: 39.95 kB / 0.5866 GB, free: 7.828 MB / 382.1 MB
Notification: Performance of [INI] Causalize: time 0.0004666/0.3861, allocations: 316.5 kB / 0.5869 GB, free: 7.512 MB / 382.1 MB
Notification: Performance of [INI] Tearing: time 0.0001131/0.3862, allocations: 35.98 kB / 0.5869 GB, free: 7.477 MB / 382.1 MB
Notification: Performance of [SIM] Initialization: time 3.61e-07/0.3862, allocations: 0 / 0.5869 GB, free: 7.477 MB / 382.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0001578/0.3864, allocations: 108.3 kB / 0.587 GB, free: 7.34 MB / 382.1 MB
Notification: Performance of [SIM] Remove Dummies: time 4.93e-06/0.3864, allocations: 0 / 0.587 GB, free: 7.34 MB / 382.1 MB
Notification: Performance of [SIM] Tearing: time 3.28e-05/0.3864, allocations: 28 kB / 0.5871 GB, free: 7.312 MB / 382.1 MB
Notification: Performance of [SIM] Categorize: time 1.098e-05/0.3864, allocations: 0 / 0.5871 GB, free: 7.312 MB / 382.1 MB
Notification: Performance of [SIM] Solve: time 0.0003548/0.3868, allocations: 228.9 kB / 0.5873 GB, free: 7.094 MB / 382.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0009078/0.3877, allocations: 0.9547 MB / 0.5882 GB, free: 5.973 MB / 382.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 2
 * 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: ............................. 2 (2) {ventilation1.E, ventilation2.E}
 * 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: ........... 9 (scalar:9, 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: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 23 (scalar:23, 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 5.82e-05/0.3877, allocations: 28 kB / 0.5882 GB, free: 5.953 MB / 382.1 MB
Notification: Performance of SimCode: time 0.001758/0.3895, allocations: 0.8069 MB / 0.589 GB, free: 5.098 MB / 382.1 MB
Notification: Performance of Templates: time 0.005937/0.3954, allocations: 1.979 MB / 0.591 GB, free: 3.129 MB / 382.1 MB
"
[Timeout remaining time 660]
make -j1 -f TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.makefile [Timeout 660]
(rm -f TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.pipe ; mkfifo TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.pipe ; head -c 1048576 < TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.pipe >> ../files/TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.sim & ./TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation  -abortSlowSimulation -alarm=480 -lv LOG_STATS > TAeZoSysPro_testsuite_TAeZoSysPro_testsuite.HeatTransfer.Components.test_Ventilation.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.306507598026656]
Failed to read output from testmodel.py, exit status != 0:
0.40304345602635294 0.42105013 0.036586549
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f5e5f9dafb0>