Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.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.00111/0.00111, 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.001158/0.001158, allocations: 217.6 kB / 23.01 MB, free: 4.973 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.255/1.255, allocations: 230.6 MB / 256.8 MB, free: 7.824 MB / 206.1 MB
"
[Timeout remaining time 179]
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.727/2.727, allocations: 0.49 GB / 0.7958 GB, free: 35.48 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.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|chi.refCyc.sigBus.TConInMea|chi.refCyc.sigBus.TConOutMea|chi.refCyc.sigBus.TEvaInMea|chi.refCyc.sigBus.TEvaOutMea|chi.QEva_flow|chi.QCon_flow|chi.P|chi.dp1|chi.dp2|chi.refCyc.refCycChiCoo.EER_nominal|chi.EER",fileNamePrefix="Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness")
translateModel(Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|chi.refCyc.sigBus.TConInMea|chi.refCyc.sigBus.TConOutMea|chi.refCyc.sigBus.TEvaInMea|chi.refCyc.sigBus.TEvaOutMea|chi.QEva_flow|chi.QCon_flow|chi.P|chi.dp1|chi.dp2|chi.refCyc.refCycChiCoo.EER_nominal|chi.EER",fileNamePrefix="Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.533e-05/1.533e-05, allocations: 2.281 kB / 1.155 GB, free: 25.16 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness): time 0.06998/0.07, allocations: 75.76 MB / 1.229 GB, free: 6.383 MB / 0.9356 GB
Notification: Performance of NFInst.instExpressions: time 0.02656/0.09656, allocations: 17.1 MB / 1.246 GB, free: 10.49 MB / 0.9512 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004094/0.1007, allocations: 132 kB / 1.246 GB, free: 10.43 MB / 0.9512 GB
Notification: Performance of NFTyping.typeComponents: time 0.00323/0.1039, allocations: 1.117 MB / 1.247 GB, free: 9.793 MB / 0.9512 GB
Notification: Performance of NFTyping.typeBindings: time 0.007992/0.1119, allocations: 2.931 MB / 1.25 GB, free: 8.039 MB / 0.9512 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004809/0.1167, allocations: 1.905 MB / 1.252 GB, free: 6.691 MB / 0.9512 GB
Notification: Performance of NFFlatten.flatten: time 0.008254/0.1249, allocations: 6.663 MB / 1.258 GB, free: 2.633 MB / 0.9512 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003867/0.1288, allocations: 2.253 MB / 1.26 GB, free: 0.9414 MB / 0.9512 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005738/0.1345, allocations: 2.824 MB / 1.263 GB, free: 15.16 MB / 0.9669 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002996/0.1375, allocations: 1.737 MB / 1.265 GB, free: 14.04 MB / 0.9669 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005107/0.1381, allocations: 299.1 kB / 1.265 GB, free: 14.04 MB / 0.9669 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003964/0.142, allocations: 1.809 MB / 1.267 GB, free: 13.21 MB / 0.9669 GB
Notification: Performance of combineBinaries: time 0.004431/0.1464, allocations: 5.418 MB / 1.272 GB, free: 9.016 MB / 0.9669 GB
Notification: Performance of replaceArrayConstructors: time 0.002432/0.1489, allocations: 3.436 MB / 1.276 GB, free: 5.543 MB / 0.9669 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004011/0.1493, allocations: 220 kB / 1.276 GB, free: 5.328 MB / 0.9669 GB
Notification: Performance of FrontEnd: time 0.0004961/0.1498, allocations: 99.36 kB / 1.276 GB, free: 5.23 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: 439 (427)
 * Number of variables: 439 (422)
Notification: Performance of [SIM] Bindings: time 0.01123/0.161, allocations: 12.33 MB / 1.288 GB, free: 8.582 MB / 0.9825 GB
Notification: Performance of [SIM] FunctionAlias: time 0.001245/0.1622, allocations: 1.262 MB / 1.289 GB, free: 7.293 MB / 0.9825 GB
Notification: Performance of [SIM] Early Inline: time 0.005946/0.1682, allocations: 6.296 MB / 1.295 GB, free: 0.9375 MB / 0.9825 GB
Notification: Performance of [SIM] Simplify 1: time 0.001565/0.1698, allocations: 0.92 MB / 1.296 GB, free: 15.92 MB / 0.9981 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.01512/0.1849, allocations: 10.7 MB / 1.307 GB, free: 4.367 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 2: time 0.000882/0.1858, allocations: 0.557 MB / 1.307 GB, free: 3.734 MB / 0.9981 GB
Notification: Performance of [SIM] Remove Stream: time 0.0004106/0.1862, allocations: 360.1 kB / 1.308 GB, free: 3.348 MB / 0.9981 GB
Notification: Performance of [SIM] Detect States: time 0.0008646/0.187, allocations: 0.8025 MB / 1.308 GB, free: 2.488 MB / 0.9981 GB
Notification: Performance of [SIM] Events: time 0.0003828/0.1874, allocations: 266.7 kB / 1.309 GB, free: 2.219 MB / 0.9981 GB
Notification: Performance of [SIM] Partitioning: time 0.001244/0.1887, allocations: 1.13 MB / 1.31 GB, free: 1.031 MB / 0.9981 GB
Notification: Performance of [SIM] Causalize: time 0.006023/0.1947, allocations: 4.679 MB / 1.314 GB, free: 12.16 MB / 1.014 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002277/0.197, allocations: 2.487 MB / 1.317 GB, free: 9.676 MB / 1.014 GB
Notification: Performance of [INI] Simplify: time 0.004499/0.2015, allocations: 3.09 MB / 1.32 GB, free: 6.379 MB / 1.014 GB
Notification: Performance of [INI] Inline: time 0.004702/0.2062, allocations: 5.069 MB / 1.325 GB, free: 1.289 MB / 1.014 GB
Notification: Performance of [INI] Partitioning: time 0.0002184/0.2064, allocations: 114.3 kB / 1.325 GB, free: 1.148 MB / 1.014 GB
Notification: Performance of [INI] Cleanup: time 0.0009451/0.2073, allocations: 1.098 MB / 1.326 GB, free: 36 kB / 1.014 GB
Notification: Performance of [INI] Causalize: time 0.01442/0.2217, allocations: 10.97 MB / 1.337 GB, free: 4.758 MB / 1.029 GB
Notification: Performance of [INI] Tearing: time 0.001632/0.2234, allocations: 1.397 MB / 1.338 GB, free: 3.305 MB / 1.029 GB
Notification: Performance of [SIM] Initialization: time 2.935e-06/0.2234, allocations: 3.984 kB / 1.338 GB, free: 3.301 MB / 1.029 GB
Notification: Performance of [SIM] Remove Dummies: time 1.796e-05/0.2234, allocations: 5.25 kB / 1.338 GB, free: 3.297 MB / 1.029 GB
Notification: Performance of [SIM] Tearing: time 0.0004833/0.2239, allocations: 394.8 kB / 1.338 GB, free: 2.91 MB / 1.029 GB
Notification: Performance of [SIM] Categorize: time 1.859e-05/0.2239, allocations: 4 kB / 1.338 GB, free: 2.906 MB / 1.029 GB
Notification: Performance of [SIM] Solve: time 0.003587/0.2275, allocations: 2.398 MB / 1.341 GB, free: 0.5078 MB / 1.029 GB
Notification: Performance of [SIM] Jacobian: time 0.001302/0.2288, allocations: 1.024 MB / 1.342 GB, free: 15.44 MB / 1.045 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 2
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 3
 * 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: ............................. 2 (2) {chi.con.vol.U, chi.eva.vol.U}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 18 (18) {chi.eff.hys.y, chi.hys.y, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_5, $TEV_4, $TEV_3, $TEV_2, $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: ........... 136 (scalar:136, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 2, 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: ........... 314 (scalar:304, array:10, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 2, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 314 (scalar:304, array:10, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 2, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0001297/0.2289, allocations: 132.2 kB / 1.342 GB, free: 15.31 MB / 1.045 GB
Notification: Performance of SimCode: time 0.01447/0.2434, allocations: 11.64 MB / 1.353 GB, free: 3.5 MB / 1.045 GB
Notification: Performance of Templates: time 0.03744/0.2808, allocations: 24.45 MB / 1.377 GB, free: 11.13 MB / 1.076 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe ; mkfifo Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe >> ../files/Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.sim & ./Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Chillers.ModularReversible.Validation.ConstantCarnotEffectiveness.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 8.044235590379685]
Failed to read output from testmodel.py, exit status != 0:
0.28781846771016717 0.300362734 0.147914134
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3a62676f20>