Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001989/0.001989, allocations: 110 kB / 18.93 MB, free: 2.945 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.002652/0.002652, allocations: 191.9 kB / 22.23 MB, free: 5.16 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.482/1.482, allocations: 225.6 MB / 251 MB, free: 13 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.1-maint.12.x/package.mo): time 3.124/3.124, allocations: 496 MB / 0.7835 GB, free: 33.68 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.1-maint.12.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer,tolerance=1e-06,outputFormat="mat",numberOfIntervals=140,variableFilter="time|con.TRoo|con.TSetRooHea|con.TSetRooCoo|EFan.y|EHea.y|ECoo.y|EHVAC.y|EPum.y",fileNamePrefix="Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer")
translateModel(Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer,tolerance=1e-06,outputFormat="mat",numberOfIntervals=140,variableFilter="time|con.TRoo|con.TSetRooHea|con.TSetRooCoo|EFan.y|EHea.y|ECoo.y|EHVAC.y|EPum.y",fileNamePrefix="Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002033/0.002033, allocations: 68.7 kB / 1.138 GB, free: 33.88 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4361/0.4382, allocations: 173.6 MB / 1.307 GB, free: 1.781 MB / 0.9981 GB
Notification: Performance of NFInst.instantiate(Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer): time 1.734/2.172, allocations: 0.499 GB / 1.806 GB, free: 8.781 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 0.1781/2.35, allocations: 97.7 MB / 1.902 GB, free: 0.707 MB / 1.373 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.03887/2.389, allocations: 0.8099 MB / 1.902 GB, free: 15.89 MB / 1.389 GB
Notification: Performance of NFTyping.typeComponents: time 0.03983/2.429, allocations: 12.75 MB / 1.915 GB, free: 3.074 MB / 1.389 GB
Notification: Performance of NFTyping.typeBindings: time 0.06173/2.49, allocations: 17.49 MB / 1.932 GB, free: 1.516 MB / 1.404 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04682/2.537, allocations: 14.72 MB / 1.946 GB, free: 2.84 MB / 1.42 GB
Notification: Performance of NFFlatten.flatten: time 0.117/2.654, allocations: 80.52 MB / 2.025 GB, free: 2.18 MB / 1.498 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.06036/2.715, allocations: 22.87 MB / 2.047 GB, free: 11.12 MB / 1.529 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.07535/2.79, allocations: 33.67 MB / 2.08 GB, free: 9.402 MB / 1.561 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.051/2.841, allocations: 25.14 MB / 2.105 GB, free: 192 kB / 1.576 GB
Notification: Performance of NFPackage.collectConstants: time 0.02065/2.862, allocations: 5.344 MB / 2.11 GB, free: 10.84 MB / 1.592 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04838/2.91, allocations: 17.64 MB / 2.127 GB, free: 9.18 MB / 1.607 GB
Notification: Performance of NFScalarize.scalarize: time 0.03157/2.942, allocations: 16.36 MB / 2.143 GB, free: 8.781 MB / 1.623 GB
Notification: Performance of NFVerifyModel.verify: time 0.06889/3.01, allocations: 24.36 MB / 2.167 GB, free: 332 kB / 1.639 GB
Notification: Performance of NFConvertDAE.convert: time 0.1559/3.166, allocations: 91.23 MB / 2.256 GB, free: 4.816 MB / 1.732 GB
Notification: Performance of FrontEnd - DAE generated: time 1.324e-05/3.166, allocations: 8 kB / 2.256 GB, free: 4.809 MB / 1.732 GB
Notification: Performance of FrontEnd: time 1.893e-06/3.166, allocations: 0 / 2.256 GB, free: 4.809 MB / 1.732 GB
Notification: Performance of Transformations before backend: time 0.002774/3.169, allocations: 0 / 2.256 GB, free: 4.809 MB / 1.732 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4133
 * Number of variables: 4133
Notification: Performance of Generate backend data structure: time 1.709/4.878, allocations: 51.18 MB / 2.306 GB, free: 0.6131 GB / 1.733 GB
Notification: Performance of prepare preOptimizeDAE: time 4.536e-05/4.878, allocations: 9.547 kB / 2.306 GB, free: 0.6131 GB / 1.733 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07083/4.949, allocations: 13.42 MB / 2.319 GB, free: 0.607 GB / 1.733 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1164/5.066, allocations: 61.68 MB / 2.379 GB, free: 0.5564 GB / 1.733 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002196/5.068, allocations: 2.118 MB / 2.381 GB, free: 0.5542 GB / 1.733 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00974/5.078, allocations: 1.863 MB / 2.383 GB, free: 0.5523 GB / 1.733 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0818/5.159, allocations: 29.4 MB / 2.412 GB, free: 0.5229 GB / 1.733 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0008339/5.16, allocations: 39.62 kB / 2.412 GB, free: 0.5228 GB / 1.733 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.007879/5.168, allocations: 0.6713 MB / 2.413 GB, free: 0.5222 GB / 1.733 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004782/5.169, allocations: 0.5878 MB / 2.413 GB, free: 0.5216 GB / 1.733 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07059/5.239, allocations: 30.29 MB / 2.443 GB, free: 0.492 GB / 1.733 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.2655/5.505, allocations: 154.9 MB / 2.594 GB, free: 345 MB / 1.733 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03839/5.543, allocations: 18.91 MB / 2.613 GB, free: 326.1 MB / 1.733 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02375/5.567, allocations: 11.51 MB / 2.624 GB, free: 314.6 MB / 1.733 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt evalFunc (simulation): time 0.1166/5.683, allocations: 52.59 MB / 2.675 GB, free: 261.9 MB / 1.733 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02757/5.711, allocations: 12.07 MB / 2.687 GB, free: 249.8 MB / 1.733 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.02008/5.731, allocations: 1.337 MB / 2.688 GB, free: 248.4 MB / 1.733 GB
Notification: Performance of pre-optimization done (n=1078): time 5.19e-05/5.731, allocations: 1.5 kB / 2.688 GB, free: 248.4 MB / 1.733 GB
Notification: Performance of matching and sorting (n=1084): time 0.1921/5.923, allocations: 65.77 MB / 2.753 GB, free: 182.4 MB / 1.733 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002955/5.923, allocations: 463.6 kB / 2.753 GB, free: 181.8 MB / 1.733 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1442/6.068, allocations: 64.51 MB / 2.816 GB, free: 117.5 MB / 1.733 GB
Notification: Performance of collectPreVariables (initialization): time 0.005977/6.074, allocations: 377.7 kB / 2.816 GB, free: 117.2 MB / 1.733 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03717/6.111, allocations: 16.85 MB / 2.833 GB, free: 100.3 MB / 1.733 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01082/6.122, allocations: 3.936 MB / 2.837 GB, free: 96.29 MB / 1.733 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02558/6.147, allocations: 7.176 MB / 2.844 GB, free: 89.09 MB / 1.733 GB
Notification: Performance of setup shared object (initialization): time 5.794e-05/6.147, allocations: 305.1 kB / 2.844 GB, free: 88.79 MB / 1.733 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04687/6.194, allocations: 38.67 MB / 2.882 GB, free: 50.09 MB / 1.733 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0537/6.248, allocations: 44.97 MB / 2.926 GB, free: 2.746 MB / 1.733 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: hvac.heaCoi.vol.dynBal.medium.p = hvac.heaCoi.vol.dynBal.p_start (weaDat.pAtmSel.p = hvac.heaCoi.vol.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: hvac.chi.vol1.dynBal.medium.p = hvac.chi.vol1.dynBal.p_start (weaDat.pAtmSel.p = hvac.chi.vol1.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zon.roo.air.vol.dynBal.medium.p = zon.roo.air.vol.dynBal.p_start (weaDat.pAtmSel.p = zon.roo.air.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 2.11/8.358, allocations: 364.3 MB / 3.281 GB, free: 297 MB / 1.733 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002294/8.358, allocations: 48 kB / 3.281 GB, free: 296.9 MB / 1.733 GB
Notification: Performance of matching and sorting (n=3180) (initialization): time 0.1588/8.517, allocations: 92.18 MB / 3.371 GB, free: 206.6 MB / 1.733 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003239/8.517, allocations: 221.6 kB / 3.372 GB, free: 206.4 MB / 1.733 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.09988/8.617, allocations: 65.03 MB / 3.435 GB, free: 141.2 MB / 1.733 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01472/8.632, allocations: 4.948 MB / 3.44 GB, free: 136.2 MB / 1.733 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02989/8.662, allocations: 5.011 MB / 3.445 GB, free: 131.2 MB / 1.733 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04236/8.704, allocations: 43.04 MB / 3.487 GB, free: 87.07 MB / 1.733 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0455/8.75, allocations: 3.316 MB / 3.49 GB, free: 83.77 MB / 1.733 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007312/8.757, allocations: 0.9019 MB / 3.491 GB, free: 82.87 MB / 1.733 GB
Warning: The initial conditions are over specified. The following 3 initial equations are redundant, so they are removed from the initialization system:
         hvac.heaCoi.vol.dynBal.medium.p = hvac.heaCoi.vol.dynBal.p_start
         hvac.chi.vol1.dynBal.medium.p = hvac.chi.vol1.dynBal.p_start
         zon.roo.air.vol.dynBal.medium.p = zon.roo.air.vol.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.07934/8.836, allocations: 55.29 MB / 3.545 GB, free: 27.55 MB / 1.733 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 1.175/10.01, allocations: 44.93 MB / 3.589 GB, free: 0.5686 GB / 1.748 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: hvac.heaCoi.vol.dynBal.medium.p = hvac.heaCoi.vol.dynBal.p_start (weaDat.pAtmSel.p = hvac.heaCoi.vol.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: hvac.chi.vol1.dynBal.medium.p = hvac.chi.vol1.dynBal.p_start (weaDat.pAtmSel.p = hvac.chi.vol1.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: zon.roo.air.vol.dynBal.medium.p = zon.roo.air.vol.dynBal.p_start (weaDat.pAtmSel.p = zon.roo.air.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.096/11.11, allocations: 363.8 MB / 3.944 GB, free: 296.4 MB / 1.748 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0004974/11.11, allocations: 48 kB / 3.944 GB, free: 296.4 MB / 1.748 GB
Notification: Performance of matching and sorting (n=3180) (initialization_lambda0): time 0.1496/11.26, allocations: 92.54 MB / 4.035 GB, free: 205.8 MB / 1.748 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003975/11.26, allocations: 225.6 kB / 4.035 GB, free: 205.5 MB / 1.748 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.1036/11.36, allocations: 65.66 MB / 4.099 GB, free: 139.7 MB / 1.748 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01409/11.38, allocations: 4.761 MB / 4.104 GB, free: 134.9 MB / 1.748 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02591/11.4, allocations: 4.996 MB / 4.108 GB, free: 129.9 MB / 1.748 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05224/11.45, allocations: 54.29 MB / 4.162 GB, free: 74.55 MB / 1.748 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04765/11.5, allocations: 3.342 MB / 4.165 GB, free: 71.22 MB / 1.748 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008128/11.51, allocations: 0.8938 MB / 4.166 GB, free: 70.33 MB / 1.748 GB
Warning: The initial conditions are over specified. The following 3 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         hvac.heaCoi.vol.dynBal.medium.p = hvac.heaCoi.vol.dynBal.p_start
         hvac.chi.vol1.dynBal.medium.p = hvac.chi.vol1.dynBal.p_start
         zon.roo.air.vol.dynBal.medium.p = zon.roo.air.vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 727
 * Number of states: 0 ()
 * Number of discrete variables: 137 ($PRE.TSetRooCoo.tab.nextTimeEvent,$whenCondition24,$PRE.TSetRooHea.tab.nextTimeEvent,$whenCondition23,$PRE.zon.intLoad.tab.nextTimeEvent,$whenCondition11,hvac.chi.tru.y,EPum.local_reset,ECoo.local_reset,EHea.local_reset,EFan.local_reset,hvac.cooCoi.flowRegime_nominal,hvac.cooCoi.flowRegime,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,zon.roo.solRadExc.is_flo[11],zon.roo.solRadExc.is_flo[10],zon.roo.solRadExc.is_flo[9],zon.roo.solRadExc.is_flo[8],zon.roo.solRadExc.is_flo[7],zon.roo.solRadExc.is_flo[6],zon.roo.solRadExc.is_flo[5],zon.roo.solRadExc.is_flo[4],zon.roo.solRadExc.is_flo[3],zon.roo.solRadExc.is_flo[2],zon.roo.solRadExc.is_flo[1],$PRE.occSch.tNext,$PRE.occSch.tNonOcc,$PRE.occSch.tOcc,$PRE.occSch.occupied,$PRE.con.heaOnTRoo.greHys.y,$PRE.con.chiOnTRoo.greHys.y,$PRE.con.conEco.pre1.u,$PRE.con.conEco.hysTMix.y,$PRE.con.conEco.truFalHolTMix.entryTimeFalse,$PRE.con.conEco.truFalHolTMix.entryTimeTrue,$PRE.con.conEco.truFalHolTMix.not_y,$PRE.con.conEco.truFalHolTMix.not_u,$PRE.con.conEco.truFalHolTMix.y,$PRE.con.conEco.truFalHolTMix.u,$PRE.con.conEco.truFalHolCooPot.entryTimeFalse,$PRE.con.conEco.truFalHolCooPot.entryTimeTrue,$PRE.con.conEco.truFalHolCooPot.not_y,$PRE.con.conEco.truFalHolCooPot.not_u,$PRE.con.conEco.truFalHolCooPot.y,$PRE.con.conEco.truFalHolCooPot.u,$PRE.con.conEco.hysCooPot.y,$PRE.con.conEco.hysChiPla.y,occSch.tNext,occSch.tNonOcc,occSch.tOcc,occSch.occupied,TSetRooCoo.tab.nextTimeEventScaled,$PRE.TSetRooCoo.tab.nextTimeEventScaled,TSetRooCoo.tab.nextTimeEvent,TSetRooHea.tab.nextTimeEventScaled,$PRE.TSetRooHea.tab.nextTimeEventScaled,TSetRooHea.tab.nextTimeEvent,con.heaOnTRoo.greHys.y,con.chiOnTRoo.greHys.y,con.orFan.uTemp[2],con.orFan.y,con.conEco.pre1.u,con.conEco.hysTMix.y,con.conEco.truFalHolTMix.entryTimeFalse,con.conEco.truFalHolTMix.entryTimeTrue,con.conEco.truFalHolTMix.not_y,con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.u,con.conEco.truFalHolCooPot.entryTimeFalse,con.conEco.truFalHolCooPot.entryTimeTrue,con.conEco.truFalHolCooPot.not_y,con.conEco.truFalHolCooPot.not_u,con.conEco.truFalHolCooPot.y,con.conEco.truFalHolCooPot.u,con.conEco.hysCooPot.y,con.conEco.not1.y,con.conEco.yCoiSta,con.conEco.hysChiPla.y,con.chiOn,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,zon.greThr.y,zon.intLoad.tab.nextTimeEventScaled,$PRE.zon.intLoad.tab.nextTimeEventScaled,zon.intLoad.tab.nextTimeEvent,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition25)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2253):
 * Single equations (assignments): 2192
 * Array equations: 43
 * Algorithm blocks: 1
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 14
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 11 systems
   {(18,37,16.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,16), (12,43), (1,14)}
Notification: Performance of prepare postOptimizeDAE: time 0.0138/11.52, allocations: 1.548 MB / 4.167 GB, free: 68.88 MB / 1.748 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01677/11.54, allocations: 3.369 MB / 4.17 GB, free: 67.41 MB / 1.748 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.08336/11.62, allocations: 28.54 MB / 4.198 GB, free: 38.82 MB / 1.748 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001708/11.62, allocations: 107.9 kB / 4.198 GB, free: 38.71 MB / 1.748 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.46e-05/11.62, allocations: 12 kB / 4.198 GB, free: 38.7 MB / 1.748 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.065/11.69, allocations: 23.04 MB / 4.221 GB, free: 15.51 MB / 1.748 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 1.26/12.95, allocations: 70.16 MB / 4.289 GB, free: 0.5584 GB / 1.748 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001242/12.95, allocations: 7.906 kB / 4.289 GB, free: 0.5584 GB / 1.748 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01697/12.97, allocations: 2.743 MB / 4.292 GB, free: 0.5583 GB / 1.748 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01052/12.98, allocations: 3.251 MB / 4.295 GB, free: 0.5574 GB / 1.748 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.005082/12.98, allocations: 403.1 kB / 4.296 GB, free: 0.5573 GB / 1.748 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04259/13.02, allocations: 45.61 MB / 4.34 GB, free: 0.5272 GB / 1.748 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.138e-06/13.02, allocations: 15.5 kB / 4.34 GB, free: 0.5272 GB / 1.748 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1051/13.13, allocations: 41.65 MB / 4.381 GB, free: 0.5057 GB / 1.748 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.03373/13.16, allocations: 9.571 MB / 4.39 GB, free: 0.4982 GB / 1.748 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.02091/13.18, allocations: 359.9 kB / 4.391 GB, free: 0.4979 GB / 1.748 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.03725/13.22, allocations: 2.27 MB / 4.393 GB, free: 0.4957 GB / 1.748 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.005639/13.23, allocations: 0.8185 MB / 4.394 GB, free: 0.4949 GB / 1.748 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.004994/13.23, allocations: 441.5 kB / 4.394 GB, free: 0.4945 GB / 1.748 GB
Notification: Performance of sorting global known variables: time 0.1222/13.35, allocations: 44.55 MB / 4.438 GB, free: 462 MB / 1.748 GB
Notification: Performance of sort global known variables: time 5.01e-07/13.35, allocations: 0 / 4.438 GB, free: 462 MB / 1.748 GB
Notification: Performance of remove unused functions: time 0.1161/13.47, allocations: 19.29 MB / 4.456 GB, free: 442.9 MB / 1.748 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 30
 * Number of states: 70 (hvac.heaCoi.vol.dynBal.medium.Xi[1],hvac.heaCoi.vol.dynBal.U,hvac.heaCoi.vol.dynBal.mC[1],hvac.chi.vol1.dynBal.medium.Xi[1],hvac.chi.vol1.dynBal.U,hvac.chi.vol1.dynBal.mC[1],hvac.chi.vol2.dynBal.U,zon.soi.T[1],zon.soi.T[2],zon.soi.T[3],zon.soi.T[4],zon.soi.T[5],zon.soi.T[6],zon.soi.T[7],zon.soi.T[8],zon.soi.T[9],zon.soi.T[10],zon.soi.T[11],zon.soi.T[12],zon.soi.T[13],zon.soi.T[14],zon.soi.T[15],zon.soi.T[16],zon.soi.T[17],zon.soi.T[18],zon.roo.conExt[1].opa.lay[1].T[1],zon.roo.conExt[1].opa.lay[1].T[2],zon.roo.conExt[1].opa.lay[2].T[1],zon.roo.conExt[1].opa.lay[2].T[2],zon.roo.conExt[1].opa.lay[2].T[3],zon.roo.conExt[1].opa.lay[2].T[4],zon.roo.conExt[1].opa.lay[3].T[1],zon.roo.conExt[1].opa.lay[3].T[2],zon.roo.conExt[2].opa.lay[1].T[1],zon.roo.conExt[2].opa.lay[1].T[2],zon.roo.conExt[2].opa.lay[2].T[1],zon.roo.conExt[2].opa.lay[2].T[2],zon.roo.conExt[2].opa.lay[3].T[1],zon.roo.conExt[2].opa.lay[3].T[2],zon.roo.conExt[3].opa.lay[1].T[1],zon.roo.conExt[3].opa.lay[1].T[2],zon.roo.conExt[3].opa.lay[2].T[1],zon.roo.conExt[3].opa.lay[2].T[2],zon.roo.conExt[3].opa.lay[3].T[1],zon.roo.conExt[3].opa.lay[3].T[2],zon.roo.conExt[4].opa.lay[1].T[1],zon.roo.conExt[4].opa.lay[1].T[2],zon.roo.conExt[4].opa.lay[2].T[1],zon.roo.conExt[4].opa.lay[2].T[2],zon.roo.conExt[4].opa.lay[3].T[1],zon.roo.conExt[4].opa.lay[3].T[2],zon.roo.conExtWin[1].opa.lay[1].T[1],zon.roo.conExtWin[1].opa.lay[1].T[2],zon.roo.conExtWin[1].opa.lay[2].T[1],zon.roo.conExtWin[1].opa.lay[2].T[2],zon.roo.conExtWin[1].opa.lay[3].T[1],zon.roo.conExtWin[1].opa.lay[3].T[2],zon.roo.conExtWin[1].win.capGla.TUns,zon.roo.conExtWin[1].win.capFra.T,zon.roo.conBou[1].opa.lay[2].T[1],zon.roo.conBou[1].opa.lay[2].T[2],zon.roo.conBou[1].opa.lay[2].T[3],zon.roo.conBou[1].opa.lay[2].T[4],zon.roo.air.vol.dynBal.medium.Xi[1],zon.roo.air.vol.dynBal.U,zon.roo.air.vol.dynBal.mC[1],EFan.y,EHea.y,ECoo.y,EPum.y)
 * Number of discrete variables: 74 ($whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,zon.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,zon.intLoad.tab.nextTimeEvent,zon.intLoad.tab.nextTimeEventScaled,zon.greThr.y,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,con.chiOn,con.conEco.hysChiPla.y,con.conEco.yCoiSta,con.conEco.not1.y,con.conEco.hysCooPot.y,con.conEco.truFalHolCooPot.u,con.conEco.truFalHolCooPot.y,con.conEco.truFalHolCooPot.not_u,con.conEco.truFalHolCooPot.not_y,con.conEco.truFalHolCooPot.entryTimeTrue,con.conEco.truFalHolCooPot.entryTimeFalse,con.conEco.truFalHolTMix.u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.not_y,con.conEco.truFalHolTMix.entryTimeTrue,con.conEco.truFalHolTMix.entryTimeFalse,con.conEco.hysTMix.y,con.conEco.pre1.u,con.orFan.y,con.orFan.uTemp[2],con.chiOnTRoo.greHys.y,con.heaOnTRoo.greHys.y,TSetRooHea.tab.nextTimeEvent,TSetRooHea.tab.nextTimeEventScaled,TSetRooCoo.tab.nextTimeEvent,TSetRooCoo.tab.nextTimeEventScaled,occSch.occupied,occSch.tOcc,occSch.tNonOcc,occSch.tNext)
 * Number of discrete states: 40 (occSch.tNext,TSetRooCoo.tab.nextTimeEvent,TSetRooHea.tab.nextTimeEvent,con.conEco.truFalHolTMix.entryTimeFalse,con.conEco.truFalHolTMix.entryTimeTrue,con.conEco.truFalHolCooPot.entryTimeFalse,con.conEco.truFalHolCooPot.entryTimeTrue,zon.intLoad.tab.nextTimeEvent,zon.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,weaDat.locTim.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext,con.conEco.pre1.u,TSetRooCoo.tab.nextTimeEventScaled,con.chiOnTRoo.greHys.y,TSetRooHea.tab.nextTimeEventScaled,con.heaOnTRoo.greHys.y,con.conEco.hysCooPot.y,con.conEco.truFalHolCooPot.u,con.conEco.truFalHolCooPot.not_u,con.conEco.truFalHolCooPot.y,con.conEco.truFalHolCooPot.not_y,con.conEco.hysChiPla.y,con.conEco.hysTMix.y,con.conEco.truFalHolTMix.u,con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.not_y,zon.intLoad.tab.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1019):
 * Single equations (assignments): 971
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 4
 * When equations: 28
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 15
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 13 systems
   {(9,26,85.2%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,18,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,17), (1,16)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01466/13.49, allocations: 2.876 MB / 4.459 GB, free: 441 MB / 1.748 GB
Notification: Performance of simCode: created initialization part: time 0.1514/13.64, allocations: 99.14 MB / 4.556 GB, free: 342 MB / 1.748 GB
Notification: Performance of simCode: created event and clocks part: time 2.556e-05/13.64, allocations: 9.812 kB / 4.556 GB, free: 342 MB / 1.748 GB
Notification: Performance of simCode: created simulation system equations: time 0.03198/13.67, allocations: 14.07 MB / 4.57 GB, free: 327.8 MB / 1.748 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.106/13.77, allocations: 12.9 MB / 4.582 GB, free: 315.2 MB / 1.748 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2025/13.98, allocations: 93 MB / 4.673 GB, free: 222.5 MB / 1.748 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.06701/14.04, allocations: 24.91 MB / 4.697 GB, free: 197.5 MB / 1.748 GB
Notification: Performance of simCode: alias equations: time 0.06833/14.11, allocations: 17.01 MB / 4.714 GB, free: 180.5 MB / 1.748 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02036/14.13, allocations: 2.003 MB / 4.716 GB, free: 178.5 MB / 1.748 GB
Notification: Performance of SimCode: time 1.633e-06/14.13, allocations: 4 kB / 4.716 GB, free: 178.5 MB / 1.748 GB
Notification: Performance of Templates: time 3.214/17.35, allocations: 0.6484 GB / 5.364 GB, free: 144.5 MB / 1.748 GB
"
[Timeout remaining time 283]
make -j1 -f Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.pipe ; mkfifo Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.pipe ; head -c 1048576 < Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.pipe >> ../files/Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.sim & ./Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Air_Systems_SingleZone_VAV_Examples_ChillerDXHeatingEconomizer.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.ChillerDXHeatingEconomizer.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 45.63240101467818]