Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.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.001208/0.001208, 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.001358/0.001358, allocations: 211.1 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.408/1.408, allocations: 230.6 MB / 256.8 MB, free: 7.789 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.001/3.001, allocations: 0.49 GB / 0.7958 GB, free: 35.44 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.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|C.C|C1.C|vol4.C.1.|C2.C|C3.C",fileNamePrefix="Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|C.C|C1.C|vol4.C.1.|C2.C|C3.C",fileNamePrefix="Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.025e-05/2.025e-05, allocations: 2.281 kB / 1.155 GB, free: 25.28 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource): time 0.3092/0.3092, allocations: 272 MB / 1.421 GB, free: 0.5234 MB / 1.107 GB
Notification: Performance of NFInst.instExpressions: time 0.03649/0.3457, allocations: 24.04 MB / 1.444 GB, free: 8.426 MB / 1.139 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004294/0.35, allocations: 174.5 kB / 1.444 GB, free: 8.254 MB / 1.139 GB
Notification: Performance of NFTyping.typeComponents: time 0.005092/0.3551, allocations: 1.74 MB / 1.446 GB, free: 6.504 MB / 1.139 GB
Notification: Performance of NFTyping.typeBindings: time 0.01606/0.3712, allocations: 6.232 MB / 1.452 GB, free: 256 kB / 1.139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007628/0.3788, allocations: 2.705 MB / 1.455 GB, free: 13.56 MB / 1.154 GB
Notification: Performance of NFFlatten.flatten: time 0.01478/0.3936, allocations: 10.11 MB / 1.465 GB, free: 3.422 MB / 1.154 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004633/0.3982, allocations: 2.881 MB / 1.467 GB, free: 480 kB / 1.154 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01319/0.4114, allocations: 5.427 MB / 1.473 GB, free: 11.07 MB / 1.17 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006123/0.4175, allocations: 3.031 MB / 1.476 GB, free: 8.039 MB / 1.17 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006818/0.4182, allocations: 324 kB / 1.476 GB, free: 7.723 MB / 1.17 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008307/0.4265, allocations: 3.561 MB / 1.479 GB, free: 4.152 MB / 1.17 GB
Notification: Performance of combineBinaries: time 0.00907/0.4356, allocations: 8.151 MB / 1.487 GB, free: 11.93 MB / 1.186 GB
Notification: Performance of replaceArrayConstructors: time 0.005408/0.441, allocations: 5.11 MB / 1.492 GB, free: 6.766 MB / 1.186 GB
Notification: Performance of NFVerifyModel.verify: time 0.001329/0.4423, allocations: 348 kB / 1.493 GB, free: 6.426 MB / 1.186 GB
Notification: Performance of FrontEnd: time 0.0006339/0.443, allocations: 119.4 kB / 1.493 GB, free: 6.309 MB / 1.186 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 693 (613)
 * Number of variables: 693 (527)
Notification: Performance of [SIM] Bindings: time 0.02288/0.4658, allocations: 19.66 MB / 1.512 GB, free: 2.152 MB / 1.201 GB
Notification: Performance of [SIM] FunctionAlias: time 0.00382/0.4697, allocations: 2.641 MB / 1.515 GB, free: 15.41 MB / 1.217 GB
Notification: Performance of [SIM] Early Inline: time 0.01139/0.481, allocations: 9.419 MB / 1.524 GB, free: 5.895 MB / 1.217 GB
Notification: Performance of [SIM] Simplify 1: time 0.003362/0.4844, allocations: 1.521 MB / 1.525 GB, free: 4.219 MB / 1.217 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.02069/0.5051, allocations: 11.82 MB / 1.537 GB, free: 7.324 MB / 1.232 GB
Notification: Performance of [SIM] Simplify 2: time 0.00278/0.5079, allocations: 1.267 MB / 1.538 GB, free: 5.934 MB / 1.232 GB
Notification: Performance of [SIM] Remove Stream: time 0.00151/0.5094, allocations: 0.7974 MB / 1.539 GB, free: 5.066 MB / 1.232 GB
Notification: Performance of [SIM] Detect States: time 0.002954/0.5123, allocations: 1.837 MB / 1.541 GB, free: 3.141 MB / 1.232 GB
Notification: Performance of [SIM] Events: time 0.0008465/0.5132, allocations: 438.3 kB / 1.541 GB, free: 2.699 MB / 1.232 GB
Notification: Performance of [SIM] Partitioning: time 0.004494/0.5177, allocations: 2.841 MB / 1.544 GB, free: 15.75 MB / 1.248 GB
Notification: Performance of [SIM] Causalize: time 0.01408/0.5317, allocations: 8.295 MB / 1.552 GB, free: 7.266 MB / 1.248 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.007517/0.5393, allocations: 5.901 MB / 1.558 GB, free: 1.359 MB / 1.248 GB
Notification: Performance of [INI] Simplify: time 0.009643/0.5489, allocations: 4.121 MB / 1.562 GB, free: 12.97 MB / 1.264 GB
Notification: Performance of [INI] Inline: time 0.01587/0.5648, allocations: 10.81 MB / 1.572 GB, free: 2.125 MB / 1.264 GB
Notification: Performance of [INI] Partitioning: time 0.000717/0.5655, allocations: 169.4 kB / 1.572 GB, free: 1.926 MB / 1.264 GB
Notification: Performance of [INI] Cleanup: time 0.003688/0.5692, allocations: 2.082 MB / 1.574 GB, free: 15.81 MB / 1.279 GB
Notification: Performance of [INI] Causalize: time 0.03954/0.6087, allocations: 22.31 MB / 1.596 GB, free: 9.102 MB / 1.295 GB
Notification: Performance of [INI] Tearing: time 0.0004832/0.6092, allocations: 0.5664 MB / 1.597 GB, free: 8.535 MB / 1.295 GB
Notification: Performance of [SIM] Initialization: time 2.044e-06/0.6092, allocations: 0 / 1.597 GB, free: 8.535 MB / 1.295 GB
Notification: Performance of [SIM] Remove Dummies: time 7.149e-05/0.6093, allocations: 7.5 kB / 1.597 GB, free: 8.527 MB / 1.295 GB
Notification: Performance of [SIM] Tearing: time 0.0001498/0.6094, allocations: 227.9 kB / 1.597 GB, free: 8.305 MB / 1.295 GB
Notification: Performance of [SIM] Categorize: time 5.239e-05/0.6095, allocations: 12.94 kB / 1.597 GB, free: 8.293 MB / 1.295 GB
Notification: Performance of [SIM] Solve: time 0.01187/0.6214, allocations: 6.963 MB / 1.604 GB, free: 1.285 MB / 1.295 GB
Notification: Performance of [SIM] Jacobian: time 0.6336/1.255, allocations: 4.947 MB / 1.609 GB, free: 112.4 MB / 1.295 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 8
 * 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: ............................. 20 (20) {vol.U, vol.m, vol.Xi, vol.mC, vol1.U, vol1.m, vol1.Xi, vol1.mC, vol2.U, vol2.m, vol2.Xi, vol2.mC, vol3.U, vol3.m, vol3.Xi, vol3.mC, vol4.U, vol4.m, vol4.Xi, vol4.mC}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 7 (7) {$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: ........... 414 (scalar:387, array:27, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 33 (resizable: 33, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 7 (linear: 0, nonlinear:7)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 533 (scalar:472, array:61, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:5)
 * Number of for-loop strong components: ......... 33 (resizable: 33, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 7 (linear: 0, nonlinear:7)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 540 (scalar:479, array:61, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:5)
 * Number of for-loop strong components: ......... 33 (resizable: 33, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0003727/1.255, allocations: 245.7 kB / 1.609 GB, free: 112.4 MB / 1.295 GB
Notification: Performance of SimCode: time 0.04121/1.297, allocations: 23.19 MB / 1.632 GB, free: 108.5 MB / 1.295 GB
Notification: Performance of Templates: time 0.06814/1.365, allocations: 43.79 MB / 1.674 GB, free: 102.9 MB / 1.295 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; mkfifo Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe >> ../files/Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.sim & ./Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 10.75307041965425]
Failed to read output from testmodel.py, exit status != 0:
1.3717527478002012 1.381298263 0.935854779
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff3aa346f20>