Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.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.001215/0.001215, allocations: 104.3 kB / 19.72 MB, free: 2.145 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.001306/0.001306, allocations: 209.3 kB / 23.01 MB, free: 4.961 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.366/1.366, allocations: 230.6 MB / 256.8 MB, free: 7.801 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 2.935/2.935, allocations: 0.49 GB / 0.7958 GB, free: 35.5 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.Storage.Examples.Stratified,tolerance=1e-08,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|dH.y|tanSim.m_flow|tanSim.vol.1..T|tanSim.vol.2..T|tanSim.vol.3..T|tanSim.vol.4..T|tanSim.vol.5..T|tanSim.vol.6..T|tanSim.vol.7..T|tanSim.vol.8..T|tanSim.vol.9..T|tanSim.vol.10..T|tanEnh.vol.1..T|tanEnh.vol.2..T|tanEnh.vol.3..T|tanEnh.vol.4..T|tanEnh.vol.5..T|tanEnh.vol.6..T|tanEnh.vol.7..T|tanEnh.vol.8..T|tanEnh.vol.9..T|tanEnh.vol.10..T",fileNamePrefix="Buildings_12_Buildings.Fluid.Storage.Examples.Stratified")
translateModel(Buildings.Fluid.Storage.Examples.Stratified,tolerance=1e-08,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|dH.y|tanSim.m_flow|tanSim.vol.1..T|tanSim.vol.2..T|tanSim.vol.3..T|tanSim.vol.4..T|tanSim.vol.5..T|tanSim.vol.6..T|tanSim.vol.7..T|tanSim.vol.8..T|tanSim.vol.9..T|tanSim.vol.10..T|tanEnh.vol.1..T|tanEnh.vol.2..T|tanEnh.vol.3..T|tanEnh.vol.4..T|tanEnh.vol.5..T|tanEnh.vol.6..T|tanEnh.vol.7..T|tanEnh.vol.8..T|tanEnh.vol.9..T|tanEnh.vol.10..T",fileNamePrefix="Buildings_12_Buildings.Fluid.Storage.Examples.Stratified") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.575e-05/2.575e-05, allocations: 7.344 kB / 1.155 GB, free: 25.19 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Examples.Stratified): time 0.05068/0.05071, allocations: 51.87 MB / 1.206 GB, free: 6.391 MB / 0.92 GB
Notification: Performance of NFInst.instExpressions: time 0.02681/0.07751, allocations: 16.35 MB / 1.222 GB, free: 11.25 MB / 0.9356 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004666/0.08218, allocations: 102.8 kB / 1.222 GB, free: 11.2 MB / 0.9356 GB
Notification: Performance of NFTyping.typeComponents: time 0.003949/0.08613, allocations: 0.9538 MB / 1.223 GB, free: 10.66 MB / 0.9356 GB
Notification: Performance of NFTyping.typeBindings: time 0.009526/0.09565, allocations: 2.611 MB / 1.225 GB, free: 9.133 MB / 0.9356 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006355/0.102, allocations: 1.866 MB / 1.227 GB, free: 8.125 MB / 0.9356 GB
Notification: Performance of NFFlatten.flatten: time 0.01808/0.1201, allocations: 13.31 MB / 1.24 GB, free: 2.445 MB / 0.9356 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01084/0.1309, allocations: 6.947 MB / 1.247 GB, free: 13.75 MB / 0.9512 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01034/0.1413, allocations: 4.315 MB / 1.251 GB, free: 11.38 MB / 0.9512 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007628/0.1489, allocations: 3.497 MB / 1.254 GB, free: 9.32 MB / 0.9512 GB
Notification: Performance of NFPackage.collectConstants: time 0.001453/0.1503, allocations: 0.6089 MB / 1.255 GB, free: 9.32 MB / 0.9512 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005579/0.1559, allocations: 1.635 MB / 1.257 GB, free: 8.754 MB / 0.9512 GB
Notification: Performance of combineBinaries: time 0.009439/0.1654, allocations: 7.104 MB / 1.264 GB, free: 1.934 MB / 0.9512 GB
Notification: Performance of replaceArrayConstructors: time 0.004276/0.1696, allocations: 3.497 MB / 1.267 GB, free: 14.4 MB / 0.9669 GB
Notification: Performance of NFVerifyModel.verify: time 0.001746/0.1714, allocations: 320 kB / 1.267 GB, free: 14.09 MB / 0.9669 GB
Notification: Performance of FrontEnd: time 0.0006051/0.172, allocations: 71.67 kB / 1.267 GB, free: 14.02 MB / 0.9669 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2145 (1014)
 * Number of variables: 2145 (365)
Notification: Performance of [SIM] Bindings: time 0.02434/0.1963, allocations: 20.41 MB / 1.287 GB, free: 9.23 MB / 0.9825 GB
Notification: Performance of [SIM] FunctionAlias: time 0.005298/0.2016, allocations: 3.892 MB / 1.291 GB, free: 5.395 MB / 0.9825 GB
Notification: Performance of [SIM] Early Inline: time 0.02096/0.2226, allocations: 17.53 MB / 1.308 GB, free: 3.738 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 1: time 0.005304/0.2279, allocations: 2.568 MB / 1.311 GB, free: 1.012 MB / 0.9981 GB
Notification: Performance of [SIM] Alias: time 0.01752/0.2454, allocations: 12.57 MB / 1.323 GB, free: 3.82 MB / 1.014 GB
Notification: Performance of [SIM] Simplify 2: time 0.003792/0.2492, allocations: 2.338 MB / 1.325 GB, free: 1.363 MB / 1.014 GB
Notification: Performance of [SIM] Remove Stream: time 0.002288/0.2515, allocations: 1.594 MB / 1.327 GB, free: 15.7 MB / 1.029 GB
Notification: Performance of [SIM] Detect States: time 0.004192/0.2557, allocations: 3.297 MB / 1.33 GB, free: 12.3 MB / 1.029 GB
Notification: Performance of [SIM] Events: time 0.001738/0.2574, allocations: 0.7899 MB / 1.331 GB, free: 11.5 MB / 1.029 GB
Notification: Performance of [SIM] Partitioning: time 0.009936/0.2674, allocations: 6.413 MB / 1.337 GB, free: 4.949 MB / 1.029 GB
Notification: Performance of [SIM] Causalize: time 0.06898/0.3363, allocations: 41.42 MB / 1.378 GB, free: 11.25 MB / 1.076 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.01693/0.3533, allocations: 13.86 MB / 1.391 GB, free: 13.38 MB / 1.092 GB
Notification: Performance of [INI] Simplify: time 0.01133/0.3646, allocations: 5.849 MB / 1.397 GB, free: 7.262 MB / 1.092 GB
Notification: Performance of [INI] Inline: time 0.03162/0.3962, allocations: 24.5 MB / 1.421 GB, free: 14.7 MB / 1.123 GB
Notification: Performance of [INI] Partitioning: time 0.001168/0.3974, allocations: 251.6 kB / 1.421 GB, free: 14.41 MB / 1.123 GB
Notification: Performance of [INI] Cleanup: time 0.009031/0.4064, allocations: 4.693 MB / 1.426 GB, free: 9.68 MB / 1.123 GB
Notification: Performance of [INI] Causalize: time 0.1/0.5064, allocations: 58.11 MB / 1.482 GB, free: 15.32 MB / 1.186 GB
Notification: Performance of [INI] Tearing: time 0.002512/0.5089, allocations: 2.226 MB / 1.484 GB, free: 13.09 MB / 1.186 GB
Notification: Performance of [SIM] Initialization: time 1.693e-06/0.5089, allocations: 0 / 1.484 GB, free: 13.09 MB / 1.186 GB
Notification: Performance of [SIM] Remove Dummies: time 5.874e-05/0.509, allocations: 6.984 kB / 1.484 GB, free: 13.09 MB / 1.186 GB
Notification: Performance of [SIM] Tearing: time 0.00114/0.5101, allocations: 1.074 MB / 1.486 GB, free: 12.01 MB / 1.186 GB
Notification: Performance of [SIM] Categorize: time 4.23e-05/0.5102, allocations: 16 kB / 1.486 GB, free: 12 MB / 1.186 GB
Notification: Performance of [SIM] Solve: time 0.01949/0.5297, allocations: 7.686 MB / 1.493 GB, free: 4.34 MB / 1.186 GB
Notification: Performance of [SIM] Jacobian: time 0.03084/0.5605, allocations: 20.43 MB / 1.513 GB, free: 15.61 MB / 1.217 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: ......... 0
 * 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: ............................. 21 (3) {tanSim.vol.dynBal.U, tanEnh.vol.dynBal.U, dH.y}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 58 (34) {TWat.a, TWat.b, TWat.last, TWat.nextEvent, TWat.nextEventScaled, P.a, P.b, P.last, P.nextEvent, P.nextEventScaled, $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_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: ........... 744 (scalar:744, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 116 (resizable: 116, 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: ........... 789 (scalar:787, array:2, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 152 (resizable: 152, 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: ........... 789 (scalar:787, array:2, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 152 (resizable: 152, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: Performance of backend: time 0.000698/0.5612, allocations: 389.5 kB / 1.513 GB, free: 15.23 MB / 1.217 GB
Notification: Performance of SimCode: time 0.08959/0.6508, allocations: 66.26 MB / 1.578 GB, free: 12.77 MB / 1.279 GB
Notification: Performance of Templates: time 0.714/1.365, allocations: 85.34 MB / 1.661 GB, free: 266.5 MB / 1.295 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.pipe ; mkfifo Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.pipe >> ../files/Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.sim & ./Buildings_12_Buildings.Fluid.Storage.Examples.Stratified  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Storage.Examples.Stratified.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 11.79155508428812]
Failed to read output from testmodel.py, exit status != 0:
1.372842571232468 1.382480991 1.208122577
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f4790ac6f20>