Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.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.00186/0.00186, 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.002007/0.002007, allocations: 161.1 kB / 24.97 MB, free: 8.715 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.699/1.699, allocations: 177.1 MB / 205.4 MB, free: 5.496 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.234/3.234, allocations: 389.5 MB / 0.6361 GB, free: 12.32 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.ETS.Combined.Subsystems.Validation.WatersideEconomizer,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer")
translateModel(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.47e-05/2.47e-05, allocations: 2.312 kB / 0.7759 GB, free: 5.344 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer): time 0.09008/0.0901, allocations: 64.43 MB / 0.8389 GB, free: 4.738 MB / 0.7917 GB
Notification: Performance of NFInst.instExpressions: time 0.09475/0.1849, allocations: 31.14 MB / 0.8693 GB, free: 5.695 MB / 0.823 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0154/0.2003, allocations: 0.5076 MB / 0.8698 GB, free: 5.184 MB / 0.823 GB
Notification: Performance of NFTyping.typeComponents: time 0.01328/0.2135, allocations: 3.218 MB / 0.8729 GB, free: 1.945 MB / 0.823 GB
Notification: Performance of NFTyping.typeBindings: time 0.02879/0.2423, allocations: 7.762 MB / 0.8805 GB, free: 10.14 MB / 0.8386 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02369/0.266, allocations: 8.368 MB / 0.8887 GB, free: 1.766 MB / 0.8386 GB
Notification: Performance of NFFlatten.flatten: time 0.07483/0.3408, allocations: 42.08 MB / 0.9298 GB, free: 7.59 MB / 0.8855 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02738/0.3682, allocations: 8.578 MB / 0.9381 GB, free: 14.89 MB / 0.9011 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04098/0.4092, allocations: 14.38 MB / 0.9522 GB, free: 0.5469 MB / 0.9011 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01887/0.4281, allocations: 7.378 MB / 0.9594 GB, free: 9.152 MB / 0.9167 GB
Notification: Performance of NFPackage.collectConstants: time 0.004571/0.4326, allocations: 0.918 MB / 0.9603 GB, free: 8.234 MB / 0.9167 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0182/0.4508, allocations: 5.624 MB / 0.9658 GB, free: 2.602 MB / 0.9167 GB
Notification: Performance of combineBinaries: time 0.03036/0.4812, allocations: 15.98 MB / 0.9814 GB, free: 2.523 MB / 0.9323 GB
Notification: Performance of replaceArrayConstructors: time 0.01475/0.4959, allocations: 9.352 MB / 0.9905 GB, free: 9.109 MB / 0.948 GB
Notification: Performance of NFVerifyModel.verify: time 0.004926/0.5009, allocations: 0.8008 MB / 0.9913 GB, free: 8.309 MB / 0.948 GB
Notification: Performance of FrontEnd: time 0.00271/0.5036, allocations: 370 kB / 0.9916 GB, free: 7.945 MB / 0.948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1353 (1299)
 * Number of variables: 1353 (1304)
Notification: Performance of [SIM] Bindings: time 0.09417/0.5977, allocations: 46.57 MB / 1.037 GB, free: 8.559 MB / 0.9948 GB
Notification: Performance of [SIM] FunctionAlias: time 0.01943/0.6172, allocations: 8.01 MB / 1.045 GB, free: 0.7188 MB / 0.9948 GB
Notification: Performance of [SIM] Early Inline: time 0.6149/1.232, allocations: 41.46 MB / 1.085 GB, free: 144.3 MB / 1.01 GB
Notification: Performance of [SIM] Simplify 1: time 0.01548/1.248, allocations: 3.926 MB / 1.089 GB, free: 143.2 MB / 1.01 GB
Warning: NBAlias.selectStartByConfidence: Alias set with conflicting unfixed start values of equal confidence detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.0708/1.318, allocations: 39.36 MB / 1.128 GB, free: 131.8 MB / 1.01 GB
Notification: Performance of [SIM] Simplify 2: time 0.009358/1.328, allocations: 2.767 MB / 1.13 GB, free: 130.7 MB / 1.01 GB
Notification: Performance of [SIM] Remove Stream: time 0.00391/1.332, allocations: 1.956 MB / 1.132 GB, free: 129.6 MB / 1.01 GB
Notification: Performance of [SIM] Detect States: time 0.009556/1.341, allocations: 5.873 MB / 1.138 GB, free: 126.2 MB / 1.01 GB
Notification: Performance of [SIM] Events: time 0.005331/1.346, allocations: 2.113 MB / 1.14 GB, free: 125.2 MB / 1.01 GB
Notification: Performance of [SIM] Partitioning: time 0.02537/1.372, allocations: 7.377 MB / 1.147 GB, free: 121.3 MB / 1.01 GB
Notification: Performance of [SIM] Causalize: time 0.04702/1.419, allocations: 16.11 MB / 1.163 GB, free: 115.7 MB / 1.01 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.03207/1.451, allocations: 16.29 MB / 1.179 GB, free: 103.1 MB / 1.01 GB
Notification: Performance of [INI] Simplify: time 0.04761/1.499, allocations: 21.3 MB / 1.2 GB, free: 87.1 MB / 1.01 GB
Notification: Performance of [INI] Inline: time 0.05119/1.55, allocations: 33.91 MB / 1.233 GB, free: 54.24 MB / 1.01 GB
Notification: Performance of [INI] Partitioning: time 0.003146/1.553, allocations: 435 kB / 1.233 GB, free: 53.72 MB / 1.01 GB
Notification: Performance of [INI] Cleanup: time 0.01372/1.567, allocations: 8.007 MB / 1.241 GB, free: 45.93 MB / 1.01 GB
Notification: Performance of [INI] Causalize: time 0.1348/1.701, allocations: 54.43 MB / 1.294 GB, free: 8.754 MB / 1.026 GB
Notification: Performance of [INI] Tearing: time 0.0133/1.715, allocations: 6.837 MB / 1.301 GB, free: 2.34 MB / 1.026 GB
Notification: Performance of [SIM] Initialization: time 4.639e-06/1.715, allocations: 4 kB / 1.301 GB, free: 2.336 MB / 1.026 GB
Notification: Performance of [SIM] Remove Dummies: time 0.0001639/1.715, allocations: 12.47 kB / 1.301 GB, free: 2.324 MB / 1.026 GB
Notification: Performance of [SIM] Tearing: time 0.006197/1.721, allocations: 3.104 MB / 1.304 GB, free: 15.41 MB / 1.042 GB
Notification: Performance of [SIM] Categorize: time 8.986e-05/1.721, allocations: 31.48 kB / 1.304 GB, free: 15.38 MB / 1.042 GB
Notification: Performance of [SIM] Solve: time 0.03454/1.756, allocations: 13.21 MB / 1.317 GB, free: 2.562 MB / 1.042 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:800:5-800:70:writable] Warning: Variable t of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:801:5-801:57:writable] Warning: Variable h00 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:802:5-802:57:writable] Warning: Variable h10 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:803:5-803:57:writable] Warning: Variable h01 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:804:5-804:57:writable] Warning: Variable h11 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:805:5-805:23:writable] Warning: Variable aux3 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:806:5-806:25:writable] Warning: Variable aux2 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:800:5-800:70:writable] Warning: Variable $fDER_t of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:801:5-801:57:writable] Warning: Variable $fDER_h00 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:802:5-802:57:writable] Warning: Variable $fDER_h10 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:803:5-803:57:writable] Warning: Variable $fDER_h01 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:804:5-804:57:writable] Warning: Variable $fDER_h11 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:805:5-805:23:writable] Warning: Variable $fDER_aux3 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Fluid/Utilities.mo:806:5-806:25:writable] Warning: Variable $fDER_aux2 of the generated function $fDER0.Modelica.Fluid.Utilities.cubicHermite will be initialized to 0.0 because it could not be proven that it is always assigned before it is used.
Notification: Performance of [SIM] Jacobian: time 0.02741/1.783, allocations: 10.85 MB / 1.328 GB, free: 7.625 MB / 1.057 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 6.246e-05/1.783, allocations: 4 kB / 1.328 GB, free: 7.621 MB / 1.057 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 11
 * 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: ............................. 18 (18) {pum2Pum.vol.U, pum2Pum.dpMachine, hexPum.senT2WatEnt.T, hexPum.senT2WatLvg.T, hexPum.senT1WatEnt.T, senT1OutPum.T, senT1InlPum.T, senT2OutPum.T, senT2InlPum.T, hexVal.senT2WatEnt.T, hexVal.senT2WatLvg.T, hexVal.senT1WatEnt.T, senT1InlVal.T, senT1OutVal.T, senT2OutVal.T, senT2InlVal.T, pum2Val.vol.U, pum2Val.dpMachine}
 * Number of discrete states: .................... 8 (8) {hexVal.conWSE.tim1.passed, hexVal.conWSE.tim1.entryTime, hexVal.conWSE.tim.passed, hexVal.conWSE.tim.entryTime, hexPum.conWSE.tim1.passed, hexPum.conWSE.tim1.entryTime, hexPum.conWSE.tim.passed, hexPum.conWSE.tim.entryTime}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 134 (114) {hexPum.conWSE.iniSta.localActive, hexPum.conWSE.iniSta.inPort.occupied, hexPum.conWSE.iniSta.inPort.set, hexPum.conWSE.iniSta.outPort.available, hexPum.conWSE.iniSta.outPort.reset, hexPum.conWSE.iniSta.newActive, hexPum.conWSE.ena.localCondition, hexPum.conWSE.ena.enableFire, hexPum.conWSE.ena.fire, hexPum.conWSE.ena.inPort.available, hexPum.conWSE.ena.outPort.occupied, hexPum.conWSE.actSta.localActive, hexPum.conWSE.actSta.inPort.occupied, hexPum.conWSE.actSta.inPort.set, hexPum.conWSE.actSta.outPort.available, hexPum.conWSE.actSta.outPort.reset, hexPum.conWSE.actSta.newActive, hexPum.conWSE.dis.localCondition, hexPum.conWSE.dis.enableFire, hexPum.conWSE.dis.fire, hexPum.conWSE.dis.inPort.available, hexPum.conWSE.dis.outPort.occupied, hexPum.conWSE.delTemDis.y, hexPum.conWSE.delTemDis.lesHys.y, hexPum.conWSE.delTemDis1.y, hexPum.conWSE.delTemDis1.lesHys.y, hexPum.conWSE.stateGraphRoot.activeSteps, hexPum.conWSE.mulAnd.u, hexPum.conWSE.mulAnd.uTemp, hexPum.conWSE.or1.u, hexPum.conWSE.or1.y, hexPum.conWSE.or1.uTemp, hexPum.conWSE.isValIsoEvaClo.lesHys.y, hexPum.conWSE.not1.y, hexPum.conWSE.and1.y, hexVal.conWSE.iniSta.localActive, hexVal.conWSE.iniSta.inPort.occupied, hexVal.conWSE.iniSta.inPort.set, hexVal.conWSE.iniSta.outPort.available, hexVal.conWSE.iniSta.outPort.reset, hexVal.conWSE.iniSta.newActive, hexVal.conWSE.ena.localCondition, hexVal.conWSE.ena.enableFire, hexVal.conWSE.ena.fire, hexVal.conWSE.ena.inPort.available, hexVal.conWSE.ena.outPort.occupied, hexVal.conWSE.actSta.localActive, hexVal.conWSE.actSta.inPort.occupied, hexVal.conWSE.actSta.inPort.set, hexVal.conWSE.actSta.outPort.available, hexVal.conWSE.actSta.outPort.reset, hexVal.conWSE.actSta.newActive, hexVal.conWSE.dis.localCondition, hexVal.conWSE.dis.enableFire, hexVal.conWSE.dis.fire, hexVal.conWSE.dis.inPort.available, hexVal.conWSE.dis.outPort.occupied, hexVal.conWSE.delTemDis.y, hexVal.conWSE.delTemDis.lesHys.y, hexVal.conWSE.delTemDis1.y, hexVal.conWSE.delTemDis1.lesHys.y, hexVal.conWSE.stateGraphRoot.activeSteps, hexVal.conWSE.mulAnd.u, hexVal.conWSE.mulAnd.uTemp, hexVal.conWSE.or1.u, hexVal.conWSE.or1.y, hexVal.conWSE.or1.uTemp, hexVal.conWSE.isValIsoEvaClo.lesHys.y, hexVal.conWSE.not1.y, hexVal.conWSE.and1.y, hexVal.uCoo, TChiWatRet.a, TChiWatRet.b, TChiWatRet.last, TChiWatRet.nextEvent, TChiWatRet.nextEventScaled, TSerWat.a, TSerWat.b, TSerWat.last, TSerWat.nextEvent, TSerWat.nextEventScaled, $FUN_7, $FUN_8, $FUN_9, $FUN_10, $FUN_78, $FUN_79, $FUN_80, $FUN_81, $WC_7, $WC_6, $WC_5, $WC_4, $WC_3, $WC_2, $WC_1, $WC_0, $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_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: ........... 599 (scalar:599, array:0, record:0)
 * Number of multi strong components: ............ 10 (algorithm:2, when:8, if:0, tuple:0)
 * Number of for-loop strong components: ......... 10 (resizable: 10, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 5 (linear: 2, nonlinear:3)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 949 (scalar:901, array:48, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:39)
 * Number of for-loop strong components: ......... 15 (resizable: 15, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 5 (linear: 2, nonlinear:3)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 957 (scalar:909, array:48, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:39)
 * Number of for-loop strong components: ......... 15 (resizable: 15, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 2, nonlinear:2)
Notification: Performance of backend: time 0.001039/1.784, allocations: 431.9 kB / 1.328 GB, free: 7.191 MB / 1.057 GB
Notification: Performance of SimCode: time 0.0859/1.87, allocations: 28.77 MB / 1.356 GB, free: 11.14 MB / 1.089 GB
Notification: Performance of Templates: time 0.2037/2.074, allocations: 98.72 MB / 1.452 GB, free: 9.434 MB / 1.182 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe ; mkfifo Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe ; head -c 1048576 < Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe >> ../files/Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.sim & ./Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 14.753971231169999]