Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.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.001474/0.001474, allocations: 100.4 kB / 19.72 MB, free: 2.121 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.001623/0.001623, allocations: 211.6 kB / 23.01 MB, free: 4.93 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.38/1.38, allocations: 230.6 MB / 256.8 MB, free: 7.793 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 3.062/3.062, allocations: 0.49 GB / 0.7958 GB, free: 35.57 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|senTem1a.T|senTem1b.T|senTem2a.T|senTem2b.T|senTem3a.T|senTem3b.T|senTem4a.T|senTem4b.T|mix1.T|hea1.m_flow|hea2.m_flow|hea3.m_flow|hea4.m_flow|senTem5b.T|senTem5a.T|senTem6b.T|senTem7a.T|senTem7b.T|senTem8a.T|senTem8b.T|mix2.T|hea5.m_flow|hea6.m_flow|hea7.m_flow|hea8.m_flow|che1.y|che2.y|che9.y|che10.y|che3.y|che4.y|che5.y|che6.y|che7.y|che8.y",fileNamePrefix="Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u")
translateModel(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|senTem1a.T|senTem1b.T|senTem2a.T|senTem2b.T|senTem3a.T|senTem3b.T|senTem4a.T|senTem4b.T|mix1.T|hea1.m_flow|hea2.m_flow|hea3.m_flow|hea4.m_flow|senTem5b.T|senTem5a.T|senTem6b.T|senTem7a.T|senTem7b.T|senTem8a.T|senTem8b.T|mix2.T|hea5.m_flow|hea6.m_flow|hea7.m_flow|hea8.m_flow|che1.y|che2.y|che9.y|che10.y|che3.y|che4.y|che5.y|che6.y|che7.y|che8.y",fileNamePrefix="Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.505e-05/2.505e-05, allocations: 2.281 kB / 1.155 GB, free: 25.23 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u): time 0.3128/0.3128, allocations: 276.4 MB / 1.425 GB, free: 12.15 MB / 1.123 GB
Notification: Performance of NFInst.instExpressions: time 0.07688/0.3897, allocations: 46.52 MB / 1.47 GB, free: 13.51 MB / 1.17 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01202/0.4017, allocations: 420.4 kB / 1.471 GB, free: 13.1 MB / 1.17 GB
Notification: Performance of NFTyping.typeComponents: time 0.01115/0.4129, allocations: 3.381 MB / 1.474 GB, free: 9.695 MB / 1.17 GB
Notification: Performance of NFTyping.typeBindings: time 0.02788/0.4408, allocations: 9.664 MB / 1.484 GB, free: 15.99 MB / 1.186 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01822/0.459, allocations: 6.783 MB / 1.49 GB, free: 9.242 MB / 1.186 GB
Notification: Performance of NFFlatten.flatten: time 0.03384/0.4928, allocations: 22.56 MB / 1.512 GB, free: 2.625 MB / 1.201 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01287/0.5057, allocations: 5.804 MB / 1.518 GB, free: 12.71 MB / 1.217 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02586/0.5315, allocations: 9.75 MB / 1.527 GB, free: 2.957 MB / 1.217 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01107/0.5426, allocations: 5.343 MB / 1.533 GB, free: 13.59 MB / 1.232 GB
Notification: Performance of NFPackage.collectConstants: time 0.002314/0.5449, allocations: 0.5508 MB / 1.533 GB, free: 13.04 MB / 1.232 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0124/0.5573, allocations: 3.934 MB / 1.537 GB, free: 9.102 MB / 1.232 GB
Notification: Performance of combineBinaries: time 0.01973/0.5771, allocations: 14.72 MB / 1.551 GB, free: 10.24 MB / 1.248 GB
Notification: Performance of replaceArrayConstructors: time 0.0102/0.5873, allocations: 9.405 MB / 1.561 GB, free: 0.7188 MB / 1.248 GB
Notification: Performance of NFVerifyModel.verify: time 0.003076/0.5903, allocations: 0.6797 MB / 1.561 GB, free: 40 kB / 1.248 GB
Notification: Performance of FrontEnd: time 0.001597/0.5919, allocations: 251 kB / 1.561 GB, free: 15.79 MB / 1.264 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1035 (983)
 * Number of variables: 1035 (947)
Notification: Performance of [SIM] Bindings: time 0.04014/0.6321, allocations: 31.56 MB / 1.592 GB, free: 15.63 MB / 1.295 GB
Notification: Performance of [SIM] FunctionAlias: time 0.004603/0.6367, allocations: 2.966 MB / 1.595 GB, free: 12.65 MB / 1.295 GB
Notification: Performance of [SIM] Early Inline: time 0.7836/1.42, allocations: 14.19 MB / 1.609 GB, free: 138.6 MB / 1.295 GB
Notification: Performance of [SIM] Simplify 1: time 0.008739/1.429, allocations: 2.339 MB / 1.611 GB, free: 138 MB / 1.295 GB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.06606/1.495, allocations: 27.9 MB / 1.639 GB, free: 133.4 MB / 1.295 GB
Notification: Performance of [SIM] Simplify 2: time 0.007646/1.503, allocations: 1.684 MB / 1.64 GB, free: 133 MB / 1.295 GB
Notification: Performance of [SIM] Remove Stream: time 0.004191/1.507, allocations: 0.9532 MB / 1.641 GB, free: 132.8 MB / 1.295 GB
Notification: Performance of [SIM] Detect States: time 0.008042/1.515, allocations: 2.155 MB / 1.643 GB, free: 132.5 MB / 1.295 GB
Notification: Performance of [SIM] Events: time 0.003881/1.519, allocations: 0.9891 MB / 1.644 GB, free: 132.3 MB / 1.295 GB
Notification: Performance of [SIM] Partitioning: time 0.01182/1.531, allocations: 3.175 MB / 1.647 GB, free: 132 MB / 1.295 GB
Notification: Performance of [SIM] Causalize: time 0.03735/1.568, allocations: 13.55 MB / 1.661 GB, free: 130.7 MB / 1.295 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.014/1.582, allocations: 7.389 MB / 1.668 GB, free: 130.6 MB / 1.295 GB
Notification: Performance of [INI] Simplify: time 0.02247/1.605, allocations: 7.107 MB / 1.675 GB, free: 129.2 MB / 1.295 GB
Notification: Performance of [INI] Inline: time 0.02686/1.631, allocations: 13.75 MB / 1.688 GB, free: 129 MB / 1.295 GB
Notification: Performance of [INI] Partitioning: time 0.001525/1.633, allocations: 221.8 kB / 1.688 GB, free: 128.9 MB / 1.295 GB
Notification: Performance of [INI] Cleanup: time 0.006864/1.64, allocations: 2.708 MB / 1.691 GB, free: 128.8 MB / 1.295 GB
Notification: Performance of [INI] Causalize: time 0.06047/1.7, allocations: 25.38 MB / 1.716 GB, free: 126.6 MB / 1.295 GB
Notification: Performance of [INI] Tearing: time 0.002009/1.702, allocations: 1.728 MB / 1.717 GB, free: 126.2 MB / 1.295 GB
Notification: Performance of [SIM] Initialization: time 3.797e-06/1.702, allocations: 4 kB / 1.717 GB, free: 126.2 MB / 1.295 GB
Notification: Performance of [SIM] Remove Dummies: time 6.895e-05/1.702, allocations: 5.188 kB / 1.717 GB, free: 126.2 MB / 1.295 GB
Notification: Performance of [SIM] Tearing: time 0.0007831/1.703, allocations: 0.6624 MB / 1.718 GB, free: 126 MB / 1.295 GB
Notification: Performance of [SIM] Categorize: time 7.957e-05/1.703, allocations: 18.17 kB / 1.718 GB, free: 126 MB / 1.295 GB
Notification: Performance of [SIM] Solve: time 0.01652/1.72, allocations: 8.025 MB / 1.726 GB, free: 124.3 MB / 1.295 GB
Notification: Performance of [SIM] Jacobian: time 0.009334/1.729, allocations: 6.237 MB / 1.732 GB, free: 122.9 MB / 1.295 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 10
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 10 (10) {hea1.vol.U, hea2.vol.U, hea3.vol.U, hea4.vol.U, mix1.U, hea5.vol.U, hea6.vol.U, hea7.vol.U, hea8.vol.U, mix2.U}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 51 (51) {$SEV_48, $SEV_47, $SEV_46, $SEV_45, $SEV_44, $SEV_43, $SEV_42, $SEV_41, $SEV_40, $SEV_39, $SEV_38, $SEV_37, $SEV_36, $SEV_35, $SEV_34, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_1, $TEV_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: ........... 307 (scalar:307, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 14 (resizable: 14, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 593 (scalar:573, array:20, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 14 (resizable: 14, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 593 (scalar:573, array:20, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 14 (resizable: 14, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: Performance of backend: time 0.0004224/1.729, allocations: 234.4 kB / 1.732 GB, free: 122.6 MB / 1.295 GB
Notification: Performance of SimCode: time 0.06011/1.79, allocations: 32.45 MB / 1.764 GB, free: 112.7 MB / 1.295 GB
Notification: Performance of Templates: time 0.103/1.893, allocations: 82.49 MB / 1.845 GB, free: 34.72 MB / 1.295 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; mkfifo Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe >> ../files/Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.sim & ./Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 13.21755750104785]
Failed to read output from testmodel.py, exit status != 0:
1.9010956627316773 1.909927071 1.315498616
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f44b1e3af20>