Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.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.002482/0.002482, allocations: 80.88 kB / 21.56 MB, free: 2.934 MB / 18.57 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.003258/0.003258, allocations: 163.5 kB / 24.97 MB, free: 9.125 MB / 18.57 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.659/1.659, allocations: 177.1 MB / 205.4 MB, free: 5.473 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 3.235/3.235, allocations: 389.5 MB / 0.6361 GB, free: 12.3 MB / 0.6042 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.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.DHC.Plants.Cooling.Controls.Validation.ChillerStage,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage")
translateModel(Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.432e-05/2.432e-05, allocations: 2.312 kB / 0.7759 GB, free: 5.387 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage): time 0.006459/0.006484, allocations: 2.76 MB / 0.7786 GB, free: 2.645 MB / 0.7292 GB
Notification: Performance of NFInst.instExpressions: time 0.003895/0.01038, allocations: 1.663 MB / 0.7803 GB, free: 0.9844 MB / 0.7292 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004206/0.0108, allocations: 11.94 kB / 0.7803 GB, free: 0.9727 MB / 0.7292 GB
Notification: Performance of NFTyping.typeComponents: time 0.000792/0.01159, allocations: 186.8 kB / 0.7804 GB, free: 0.7891 MB / 0.7292 GB
Notification: Performance of NFTyping.typeBindings: time 0.0006549/0.01225, allocations: 206.5 kB / 0.7806 GB, free: 0.5898 MB / 0.7292 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001153/0.0134, allocations: 406.9 kB / 0.781 GB, free: 196 kB / 0.7292 GB
Notification: Performance of NFFlatten.flatten: time 0.001451/0.01485, allocations: 0.9378 MB / 0.7819 GB, free: 15.26 MB / 0.7448 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009347/0.01579, allocations: 495.7 kB / 0.7824 GB, free: 14.77 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.000889/0.01667, allocations: 0.5193 MB / 0.7829 GB, free: 14.25 MB / 0.7448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004709/0.01715, allocations: 256.2 kB / 0.7832 GB, free: 14 MB / 0.7448 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001366/0.01728, allocations: 76 kB / 0.7832 GB, free: 13.92 MB / 0.7448 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003694/0.01765, allocations: 135.9 kB / 0.7834 GB, free: 13.79 MB / 0.7448 GB
Notification: Performance of combineBinaries: time 0.001107/0.01876, allocations: 0.9563 MB / 0.7843 GB, free: 12.83 MB / 0.7448 GB
Notification: Performance of replaceArrayConstructors: time 0.0005157/0.01927, allocations: 0.5152 MB / 0.7848 GB, free: 12.31 MB / 0.7448 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001107/0.01938, allocations: 36.81 kB / 0.7848 GB, free: 12.27 MB / 0.7448 GB
Notification: Performance of FrontEnd: time 0.0002199/0.0196, allocations: 71.5 kB / 0.7849 GB, free: 12.2 MB / 0.7448 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 130 (128)
 * Number of variables: 130 (125)
Notification: Performance of [SIM] Bindings: time 0.003941/0.02355, allocations: 2.625 MB / 0.7875 GB, free: 9.449 MB / 0.7448 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0009811/0.02453, allocations: 0.5786 MB / 0.788 GB, free: 8.855 MB / 0.7448 GB
Notification: Performance of [SIM] Early Inline: time 0.003848/0.02837, allocations: 2.868 MB / 0.7908 GB, free: 5.918 MB / 0.7448 GB
Notification: Performance of [SIM] Simplify 1: time 0.0005044/0.02888, allocations: 249.8 kB / 0.7911 GB, free: 5.633 MB / 0.7448 GB
Notification: Performance of [SIM] Alias: time 0.004917/0.0338, allocations: 2.649 MB / 0.7937 GB, free: 2.785 MB / 0.7448 GB
Notification: Performance of [SIM] Simplify 2: time 0.0005377/0.03433, allocations: 260 kB / 0.7939 GB, free: 2.477 MB / 0.7448 GB
Notification: Performance of [SIM] Remove Stream: time 0.0002938/0.03463, allocations: 197.4 kB / 0.7941 GB, free: 2.258 MB / 0.7448 GB
Notification: Performance of [SIM] Detect States: time 0.001031/0.03566, allocations: 0.6798 MB / 0.7948 GB, free: 1.52 MB / 0.7448 GB
Notification: Performance of [SIM] Events: time 0.0004192/0.03608, allocations: 247 kB / 0.795 GB, free: 1.277 MB / 0.7448 GB
Notification: Performance of [SIM] Partitioning: time 0.001204/0.03728, allocations: 0.7403 MB / 0.7957 GB, free: 0.4922 MB / 0.7448 GB
Notification: Performance of [SIM] Causalize: time 0.001951/0.03923, allocations: 1.091 MB / 0.7968 GB, free: 15.44 MB / 0.7605 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001902/0.04114, allocations: 1.503 MB / 0.7983 GB, free: 13.93 MB / 0.7605 GB
Notification: Performance of [INI] Simplify: time 0.004846/0.04598, allocations: 1.184 MB / 0.7994 GB, free: 12.7 MB / 0.7605 GB
Notification: Performance of [INI] Inline: time 0.003444/0.04943, allocations: 2.72 MB / 0.8021 GB, free: 9.969 MB / 0.7605 GB
Notification: Performance of [INI] Partitioning: time 0.0001697/0.0496, allocations: 67.95 kB / 0.8021 GB, free: 9.883 MB / 0.7605 GB
Notification: Performance of [INI] Cleanup: time 0.0004946/0.05009, allocations: 403.6 kB / 0.8025 GB, free: 9.488 MB / 0.7605 GB
Notification: Performance of [INI] Causalize: time 0.00564/0.05573, allocations: 3.156 MB / 0.8056 GB, free: 6.23 MB / 0.7605 GB
Notification: Performance of [INI] Tearing: time 6.547e-05/0.05579, allocations: 68 kB / 0.8057 GB, free: 6.164 MB / 0.7605 GB
Notification: Performance of [SIM] Initialization: time 1.232e-06/0.0558, allocations: 0 / 0.8057 GB, free: 6.164 MB / 0.7605 GB
Notification: Performance of [SIM] Remove Dummies: time 1.68e-05/0.05581, allocations: 4.594 kB / 0.8057 GB, free: 6.16 MB / 0.7605 GB
Notification: Performance of [SIM] Tearing: time 2.949e-05/0.05584, allocations: 36 kB / 0.8057 GB, free: 6.125 MB / 0.7605 GB
Notification: Performance of [SIM] Categorize: time 1.6e-05/0.05586, allocations: 0 / 0.8057 GB, free: 6.125 MB / 0.7605 GB
Notification: Performance of [SIM] Solve: time 0.001497/0.05736, allocations: 0.7728 MB / 0.8065 GB, free: 5.34 MB / 0.7605 GB
Notification: Performance of [SIM] Jacobian: time 1.827e-05/0.05737, allocations: 7.938 kB / 0.8065 GB, free: 5.332 MB / 0.7605 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 1.172e-06/0.05737, allocations: 3.938 kB / 0.8065 GB, free: 5.328 MB / 0.7605 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * 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: ............................. 0 (0) {}
 * Number of discrete states: .................... 6 (6) {on.combiTimeTable.nextTimeEvent, on.combiTimeTable.nextTimeEventScaled, chiStaCon.oneToOff.t_start, chiStaCon.twoToOne.t_start, chiStaCon.oneToTwo.t_start, chiStaCon.offToOne.t_start}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 65 (60) {chiStaCon.stateGraphRoot.activeSteps, chiStaCon.on, chiStaCon.y, chiStaCon.off.active, chiStaCon.off.localActive, chiStaCon.off.inPort.occupied, chiStaCon.off.inPort.set, chiStaCon.off.outPort.available, chiStaCon.off.outPort.reset, chiStaCon.off.newActive, chiStaCon.oneOn.localActive, chiStaCon.oneOn.inPort.occupied, chiStaCon.oneOn.inPort.set, chiStaCon.oneOn.outPort.available, chiStaCon.oneOn.outPort.reset, chiStaCon.oneOn.newActive, chiStaCon.twoOn.localActive, chiStaCon.twoOn.inPort.occupied, chiStaCon.twoOn.inPort.set, chiStaCon.twoOn.outPort.available, chiStaCon.twoOn.outPort.reset, chiStaCon.twoOn.newActive, chiStaCon.offToOne.enableFire, chiStaCon.offToOne.fire, chiStaCon.offToOne.inPort.available, chiStaCon.offToOne.outPort.occupied, chiStaCon.oneToTwo.localCondition, chiStaCon.oneToTwo.enableFire, chiStaCon.oneToTwo.fire, chiStaCon.oneToTwo.inPort.available, chiStaCon.oneToTwo.outPort.occupied, chiStaCon.twoToOne.localCondition, chiStaCon.twoToOne.enableFire, chiStaCon.twoToOne.fire, chiStaCon.twoToOne.inPort.available, chiStaCon.twoToOne.outPort.occupied, chiStaCon.oneToOff.enableFire, chiStaCon.oneToOff.fire, chiStaCon.oneToOff.inPort.available, chiStaCon.oneToOff.outPort.occupied, chiStaCon.thrOneToTwo.y, chiStaCon.Or.y, $FUN_1, $FUN_2, $FUN_3, $FUN_4, $FUN_5, $FUN_6, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 71 (scalar:71, array:0, record:0)
 * Number of multi strong components: ............ 4 (algorithm:0, when:4, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 0, generic: 0, entwined:2)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 120 (scalar:107, array:13, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 6 (resizable: 4, generic: 0, entwined:2)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001267/0.0575, allocations: 81.05 kB / 0.8066 GB, free: 5.266 MB / 0.7605 GB
Notification: Performance of SimCode: time 0.006867/0.06437, allocations: 1.926 MB / 0.8084 GB, free: 3.523 MB / 0.7605 GB
Notification: Performance of Templates: time 0.01664/0.08101, allocations: 7.245 MB / 0.8155 GB, free: 12.36 MB / 0.7761 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.pipe ; mkfifo Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.pipe ; head -c 1048576 < Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.pipe >> ../files/Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.sim & ./Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.DHC.Plants.Cooling.Controls.Validation.ChillerStage.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 8.620958624407649]