Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.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.001361/0.001361, allocations: 111.3 kB / 17.61 MB, free: 4.684 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.001357/0.001357, allocations: 185.9 kB / 20.78 MB, free: 1.52 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.441/1.441, allocations: 225.6 MB / 249.4 MB, free: 3.141 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.847/2.847, allocations: 496.2 MB / 0.7819 GB, free: 12.27 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/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.Examples.VAVReheat.Validation.TraceSubstance,tolerance=1e-06,outputFormat="mat",numberOfIntervals=192,variableFilter="time|hvac.VOut1.V_flow|hvac.senSupFlo.V_flow|flo.cor.air.vol.C.1.|flo.sou.air.vol.C.1.|flo.eas.air.vol.C.1.|flo.nor.air.vol.C.1.|flo.wes.air.vol.C.1.",fileNamePrefix="Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance")
translateModel(Buildings.Examples.VAVReheat.Validation.TraceSubstance,tolerance=1e-06,outputFormat="mat",numberOfIntervals=192,variableFilter="time|hvac.VOut1.V_flow|hvac.senSupFlo.V_flow|flo.cor.air.vol.C.1.|flo.sou.air.vol.C.1.|flo.eas.air.vol.C.1.|flo.nor.air.vol.C.1.|flo.wes.air.vol.C.1.",fileNamePrefix="Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002821/0.002821, allocations: 75.88 kB / 1.136 GB, free: 12.42 MB / 0.92 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.215/1.218, allocations: 173.6 MB / 1.305 GB, free: 33.39 MB / 1.061 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.VAVReheat.Validation.TraceSubstance): time 6.252/7.47, allocations: 2.139 GB / 3.444 GB, free: 119.4 MB / 2.217 GB
Notification: Performance of NFInst.instExpressions: time 0.4401/7.91, allocations: 239.2 MB / 3.678 GB, free: 116.9 MB / 2.217 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.1181/8.028, allocations: 2.202 MB / 3.68 GB, free: 116.9 MB / 2.217 GB
Notification: Performance of NFTyping.typeComponents: time 0.1088/8.137, allocations: 31.21 MB / 3.71 GB, free: 116.3 MB / 2.217 GB
Notification: Performance of NFTyping.typeBindings: time 0.1763/8.313, allocations: 53.46 MB / 3.763 GB, free: 109.3 MB / 2.217 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1036/8.417, allocations: 36.95 MB / 3.799 GB, free: 89.59 MB / 2.217 GB
Notification: Performance of NFFlatten.flatten: time 0.3153/8.732, allocations: 238.9 MB / 4.032 GB, free: 4 kB / 2.264 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.2293/8.961, allocations: 73.83 MB / 4.104 GB, free: 7.516 MB / 2.342 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.222/9.183, allocations: 92.63 MB / 4.195 GB, free: 13.99 MB / 2.436 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.17/9.353, allocations: 80.85 MB / 4.274 GB, free: 15.89 MB / 2.514 GB
Notification: Performance of NFPackage.collectConstants: time 0.06206/9.415, allocations: 16.77 MB / 4.29 GB, free: 15.12 MB / 2.529 GB
Notification: Performance of NFFlatten.collectFunctions: time 3.32/12.74, allocations: 40.23 MB / 4.329 GB, free: 224.2 MB / 2.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.1076/12.84, allocations: 50.55 MB / 4.379 GB, free: 224.2 MB / 2.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.209/13.05, allocations: 71.66 MB / 4.449 GB, free: 215.9 MB / 2.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.4162/13.47, allocations: 255.1 MB / 4.698 GB, free: 166.3 MB / 2.545 GB
Notification: Performance of FrontEnd - DAE generated: time 6.272e-06/13.47, allocations: 6.219 kB / 4.698 GB, free: 166.3 MB / 2.545 GB
Notification: Performance of FrontEnd: time 1.192e-06/13.47, allocations: 0 / 4.698 GB, free: 166.3 MB / 2.545 GB
Notification: Performance of Transformations before backend: time 0.007975/13.48, allocations: 0 / 4.698 GB, free: 166.3 MB / 2.545 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 11851
 * Number of variables: 11851
Notification: Performance of Generate backend data structure: time 0.6027/14.08, allocations: 150.7 MB / 4.845 GB, free: 89.74 MB / 2.545 GB
Notification: Performance of prepare preOptimizeDAE: time 5.004e-05/14.08, allocations: 19.45 kB / 4.845 GB, free: 89.73 MB / 2.545 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1813/14.26, allocations: 30.32 MB / 4.875 GB, free: 75.21 MB / 2.545 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.3857/14.65, allocations: 161.9 MB / 5.033 GB, free: 8.09 MB / 2.623 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.009028/14.66, allocations: 6.835 MB / 5.039 GB, free: 0.6719 MB / 2.623 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.04934/14.7, allocations: 5.529 MB / 5.045 GB, free: 11.16 MB / 2.639 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2999/15, allocations: 82.58 MB / 5.125 GB, free: 7.277 MB / 2.717 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0025/15.01, allocations: 88.28 kB / 5.125 GB, free: 7.234 MB / 2.717 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.03014/15.04, allocations: 1.891 MB / 5.127 GB, free: 5.363 MB / 2.717 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002282/15.04, allocations: 1.734 MB / 5.129 GB, free: 3.629 MB / 2.717 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.2788/15.32, allocations: 84.71 MB / 5.212 GB, free: 15.23 MB / 2.811 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 2.105/17.42, allocations: 437.5 MB / 5.639 GB, free: 1.171 GB / 2.858 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.1397/17.56, allocations: 59.38 MB / 5.697 GB, free: 1.146 GB / 2.858 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.07706/17.64, allocations: 34.28 MB / 5.731 GB, free: 1.134 GB / 2.858 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.4968/18.14, allocations: 161.1 MB / 5.888 GB, free: 1.011 GB / 2.858 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.09324/18.23, allocations: 35.46 MB / 5.922 GB, free: 0.9762 GB / 2.858 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0886/18.32, allocations: 9.779 MB / 5.932 GB, free: 0.9688 GB / 2.858 GB
Notification: Performance of pre-optimization done (n=3056): time 0.0001648/18.32, allocations: 0 / 5.932 GB, free: 0.9688 GB / 2.858 GB
Notification: Performance of matching and sorting (n=3068): time 1.142/19.46, allocations: 319.7 MB / 6.244 GB, free: 0.6559 GB / 2.858 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001081/19.46, allocations: 1.916 MB / 6.246 GB, free: 0.6538 GB / 2.858 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.484/19.95, allocations: 192.7 MB / 6.434 GB, free: 477.5 MB / 2.858 GB
Notification: Performance of collectPreVariables (initialization): time 0.02691/19.97, allocations: 1.066 MB / 6.435 GB, free: 476.4 MB / 2.858 GB
Notification: Performance of collectInitialEqns (initialization): time 0.1152/20.09, allocations: 50.91 MB / 6.485 GB, free: 425.7 MB / 2.858 GB
Notification: Performance of collectInitialBindings (initialization): time 0.02787/20.12, allocations: 11.19 MB / 6.496 GB, free: 414.7 MB / 2.858 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1132/20.23, allocations: 23.69 MB / 6.519 GB, free: 391 MB / 2.858 GB
Notification: Performance of setup shared object (initialization): time 5.602e-05/20.23, allocations: 301.1 kB / 6.519 GB, free: 390.7 MB / 2.858 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1767/20.41, allocations: 145.3 MB / 6.661 GB, free: 245.3 MB / 2.858 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.188/20.59, allocations: 163.2 MB / 6.821 GB, free: 76.5 MB / 2.858 GB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 3.246/23.84, allocations: 0.7401 GB / 7.561 GB, free: 0.9121 GB / 2.858 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0005102/23.84, allocations: 96 kB / 7.561 GB, free: 0.912 GB / 2.858 GB
Notification: Performance of matching and sorting (n=9763) (initialization): time 0.531/24.37, allocations: 338.3 MB / 7.891 GB, free: 0.5872 GB / 2.858 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009734/24.37, allocations: 0.7313 MB / 7.892 GB, free: 0.5865 GB / 2.858 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.414/24.79, allocations: 251.5 MB / 8.138 GB, free: 348.9 MB / 2.858 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06674/24.85, allocations: 20.58 MB / 8.158 GB, free: 328.2 MB / 2.858 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0819/24.93, allocations: 14.04 MB / 8.171 GB, free: 314.2 MB / 2.858 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.09891/25.03, allocations: 99.68 MB / 8.269 GB, free: 211.3 MB / 2.858 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1348/25.17, allocations: 7.945 MB / 8.277 GB, free: 203.4 MB / 2.858 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03002/25.2, allocations: 2.479 MB / 8.279 GB, free: 201 MB / 2.858 GB
Warning: The initial conditions are over specified. The following 5 initial equations are redundant, so they are removed from the initialization system:
         hvac.cooCoi.heaCooHum_u.vol.dynBal.medium.p = hvac.cooCoi.heaCooHum_u.vol.dynBal.p_start
         flo.sou.air.vol.dynBal.medium.p = flo.sou.air.vol.dynBal.p_start
         flo.eas.air.vol.dynBal.medium.p = flo.eas.air.vol.dynBal.p_start
         flo.nor.air.vol.dynBal.medium.p = flo.nor.air.vol.dynBal.p_start
         flo.wes.air.vol.dynBal.medium.p = flo.wes.air.vol.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 1.616/26.81, allocations: 191.5 MB / 8.466 GB, free: 1.234 GB / 2.858 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.2326/27.05, allocations: 162.1 MB / 8.624 GB, free: 1.194 GB / 2.858 GB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.942/28.99, allocations: 0.7348 GB / 9.359 GB, free: 0.6056 GB / 2.858 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0007093/28.99, allocations: 96 kB / 9.359 GB, free: 0.6055 GB / 2.858 GB
Notification: Performance of matching and sorting (n=9763) (initialization_lambda0): time 0.5239/29.51, allocations: 339.8 MB / 9.691 GB, free: 286.1 MB / 2.858 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009729/29.51, allocations: 0.729 MB / 9.692 GB, free: 285.3 MB / 2.858 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.821/31.34, allocations: 252.7 MB / 9.939 GB, free: 1.194 GB / 2.858 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06976/31.4, allocations: 20.14 MB / 9.958 GB, free: 1.193 GB / 2.858 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.08448/31.49, allocations: 13.73 MB / 9.972 GB, free: 1.193 GB / 2.858 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1935/31.68, allocations: 161.7 MB / 10.13 GB, free: 1.128 GB / 2.858 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1233/31.81, allocations: 8.171 MB / 10.14 GB, free: 1.127 GB / 2.858 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03008/31.84, allocations: 2.437 MB / 10.14 GB, free: 1.126 GB / 2.858 GB
Warning: The initial conditions are over specified. The following 5 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         hvac.cooCoi.heaCooHum_u.vol.dynBal.medium.p = hvac.cooCoi.heaCooHum_u.vol.dynBal.p_start
         flo.sou.air.vol.dynBal.medium.p = flo.sou.air.vol.dynBal.p_start
         flo.eas.air.vol.dynBal.medium.p = flo.eas.air.vol.dynBal.p_start
         flo.nor.air.vol.dynBal.medium.p = flo.nor.air.vol.dynBal.p_start
         flo.wes.air.vol.dynBal.medium.p = flo.wes.air.vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1541
 * Number of states: 0 ()
 * Number of discrete variables: 341 ($PRE.hvac.modeSelector.start.enableFire,$PRE.hvac.modeSelector.t2.enableFire,$PRE.hvac.modeSelector.t1.enableFire,$PRE.hvac.modeSelector.t6.enableFire,$PRE.hvac.modeSelector.t5.enableFire,$PRE.hvac.modeSelector.t3.enableFire,$PRE.hvac.modeSelector.t4.enableFire,$PRE.hvac.modeSelector.t7.enableFire,$PRE.hvac.modeSelector.t9.enableFire,$PRE.hvac.modeSelector.t8.enableFire,$PRE.hvac.sysHysHea.truDel.u,$PRE.hvac.sysHysCoo.truDel.u,$PRE.hvac.freSta.locOut.u,hvac.modeSelector.t8.t_start,$PRE.hvac.modeSelector.t8.t_start,hvac.modeSelector.t9.t_start,$PRE.hvac.modeSelector.t9.t_start,hvac.modeSelector.t7.t_start,$PRE.hvac.modeSelector.t7.t_start,hvac.modeSelector.t4.t_start,$PRE.hvac.modeSelector.t4.t_start,hvac.modeSelector.t3.t_start,$PRE.hvac.modeSelector.t3.t_start,hvac.modeSelector.t5.t_start,$PRE.hvac.modeSelector.t5.t_start,hvac.modeSelector.start.t_start,$PRE.hvac.modeSelector.start.t_start,$PRE.flo.intGaiFra.nextTimeEvent,$whenCondition28,$PRE.hvac.freSta.locOut.t_next,$whenCondition17,$PRE.hvac.sysHysCoo.truDel.t_next,$whenCondition14,$PRE.hvac.sysHysHea.truDel.t_next,$whenCondition8,hvac.freSta.locOut.t_next,hvac.sysHysCoo.truDel.t_next,hvac.sysHysHea.truDel.t_next,hvac.modeSelector.stateGraphRoot.resume,hvac.modeSelector.stateGraphRoot.suspend,hvac.modeSelector.start.condition,hvac.conVAV[5].conDam.con1.y,hvac.conVAV[5].conCoo.con1.y,hvac.conVAV[5].conHea.con1.y,hvac.conVAV[4].conDam.con1.y,hvac.conVAV[4].conCoo.con1.y,hvac.conVAV[4].conHea.con1.y,hvac.conVAV[3].conDam.con1.y,hvac.conVAV[3].conCoo.con1.y,hvac.conVAV[3].conHea.con1.y,hvac.conVAV[2].conDam.con1.y,hvac.conVAV[2].conCoo.con1.y,hvac.conVAV[2].conHea.con1.y,hvac.conVAV[1].conDam.con1.y,hvac.conVAV[1].conCoo.con1.y,hvac.conVAV[1].conHea.con1.y,hvac.conEco.yOATFre.con1.y,hvac.conEco.conV_flow.con1.y,hvac.heaCoi.flowRegime_nominal,hvac.heaCoi.flowRegime,hvac.VAVBox[1].terHea.flowRegime_nominal,hvac.VAVBox[1].terHea.flowRegime,hvac.VAVBox[2].terHea.flowRegime_nominal,hvac.VAVBox[2].terHea.flowRegime,hvac.VAVBox[3].terHea.flowRegime_nominal,hvac.VAVBox[3].terHea.flowRegime,hvac.VAVBox[4].terHea.flowRegime_nominal,hvac.VAVBox[4].terHea.flowRegime,hvac.VAVBox[5].terHea.flowRegime_nominal,hvac.VAVBox[5].terHea.flowRegime,hvac.cooCoi.flowRegime_nominal,hvac.cooCoi.dryWetCalcs.fullyDry.cfg,hvac.cooCoi.dryWetCalcs.fullyWet.cfg,hvac.cooCoi.dryWetCalcs.cfg,hvac.cooCoi.flowRegime,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,flo.wes.solRadExc.is_flo[11],flo.wes.solRadExc.is_flo[10],flo.wes.solRadExc.is_flo[9],flo.wes.solRadExc.is_flo[8],flo.wes.solRadExc.is_flo[7],flo.wes.solRadExc.is_flo[6],flo.wes.solRadExc.is_flo[5],flo.wes.solRadExc.is_flo[4],flo.wes.solRadExc.is_flo[3],flo.wes.solRadExc.is_flo[2],flo.wes.solRadExc.is_flo[1],flo.nor.solRadExc.is_flo[12],flo.nor.solRadExc.is_flo[11],flo.nor.solRadExc.is_flo[10],flo.nor.solRadExc.is_flo[9],flo.nor.solRadExc.is_flo[8],flo.nor.solRadExc.is_flo[7],flo.nor.solRadExc.is_flo[6],flo.nor.solRadExc.is_flo[5],flo.nor.solRadExc.is_flo[4],flo.nor.solRadExc.is_flo[3],flo.nor.solRadExc.is_flo[2],flo.nor.solRadExc.is_flo[1],flo.eas.solRadExc.is_flo[11],flo.eas.solRadExc.is_flo[10],flo.eas.solRadExc.is_flo[9],flo.eas.solRadExc.is_flo[8],flo.eas.solRadExc.is_flo[7],flo.eas.solRadExc.is_flo[6],flo.eas.solRadExc.is_flo[5],flo.eas.solRadExc.is_flo[4],flo.eas.solRadExc.is_flo[3],flo.eas.solRadExc.is_flo[2],flo.eas.solRadExc.is_flo[1],flo.sou.solRadExc.is_flo[12],flo.sou.solRadExc.is_flo[11],flo.sou.solRadExc.is_flo[10],flo.sou.solRadExc.is_flo[9],flo.sou.solRadExc.is_flo[8],flo.sou.solRadExc.is_flo[7],flo.sou.solRadExc.is_flo[6],flo.sou.solRadExc.is_flo[5],flo.sou.solRadExc.is_flo[4],flo.sou.solRadExc.is_flo[3],flo.sou.solRadExc.is_flo[2],flo.sou.solRadExc.is_flo[1],hvac.cooCoi.UAFroRated.isFulWet,hvac.cooCoi.UAFroRated.isFulDry,$PRE.hvac.freSta.greThr.greHys.y,$PRE.hvac.sysHysCoo.truFalHol1.entryTimeFalse,$PRE.hvac.sysHysCoo.truFalHol1.entryTimeTrue,$PRE.hvac.sysHysCoo.truFalHol1.not_y,$PRE.hvac.sysHysCoo.truFalHol1.not_u,$PRE.hvac.sysHysCoo.truFalHol1.y,$PRE.hvac.sysHysCoo.truFalHol1.u,$PRE.hvac.sysHysCoo.greThr.greHys.y,$PRE.hvac.sysHysHea.truFalHol1.entryTimeFalse,$PRE.hvac.sysHysHea.truFalHol1.entryTimeTrue,$PRE.hvac.sysHysHea.truFalHol1.not_y,$PRE.hvac.sysHysHea.truFalHol1.not_u,$PRE.hvac.sysHysHea.truFalHol1.y,$PRE.hvac.sysHysHea.truFalHol1.u,$PRE.hvac.sysHysHea.greThr.greHys.y,$PRE.hvac.conVAV[5].hysWitHol.y,$PRE.hvac.conVAV[4].hysWitHol.y,$PRE.hvac.conVAV[3].hysWitHol.y,$PRE.hvac.conVAV[2].hysWitHol.y,$PRE.hvac.conVAV[1].hysWitHol.y,$PRE.hvac.conEco.hysLoc.y,$PRE.hvac.modeSelector.morPreCoo.oldActive,$PRE.hvac.modeSelector.morPreCoo.newActive,$PRE.hvac.modeSelector.morPreCoo.localActive,$PRE.hvac.modeSelector.occ.oldActive,$PRE.hvac.modeSelector.occ.newActive,$PRE.hvac.modeSelector.occ.localActive,$PRE.hvac.modeSelector.t6.t_start,$PRE.hvac.modeSelector.morWarUp.oldActive,$PRE.hvac.modeSelector.morWarUp.newActive,$PRE.hvac.modeSelector.morWarUp.localActive,$PRE.hvac.modeSelector.t1.t_start,$PRE.hvac.modeSelector.t2.t_start,$PRE.hvac.modeSelector.unOccNigSetBac.oldActive,$PRE.hvac.modeSelector.unOccNigSetBac.newActive,$PRE.hvac.modeSelector.unOccNigSetBac.localActive,$PRE.hvac.modeSelector.unOccOff.oldActive,$PRE.hvac.modeSelector.unOccOff.newActive,$PRE.hvac.modeSelector.unOccOff.localActive,$PRE.hvac.modeSelector.initialStepWithSignal.oldActive,$PRE.hvac.modeSelector.initialStepWithSignal.newActive,$PRE.hvac.modeSelector.initialStepWithSignal.localActive,$PRE.hvac.occSch.tNext,$PRE.hvac.occSch.tNonOcc,$PRE.hvac.occSch.tOcc,$PRE.hvac.occSch.occupied,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,flo.intGaiFra.nextTimeEventScaled,$PRE.flo.intGaiFra.nextTimeEventScaled,flo.intGaiFra.nextTimeEvent,flo.wes.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.flo.wes.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.wes.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.flo.wes.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.nor.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.flo.nor.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.nor.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.flo.nor.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.eas.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.flo.eas.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.eas.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.flo.eas.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.sou.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.flo.sou.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.sou.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.flo.sou.bouConExtWin.HDirTil[1].incAng.decAng.tNext,hvac.freSta.greThr.greHys.y,hvac.freSta.locOut.y,hvac.freSta.locOut.u,hvac.sysHysCoo.truDel.y,hvac.sysHysCoo.truDel.u,hvac.sysHysCoo.truFalHol1.entryTimeFalse,hvac.sysHysCoo.truFalHol1.entryTimeTrue,hvac.sysHysCoo.truFalHol1.not_y,hvac.sysHysCoo.truFalHol1.not_u,hvac.sysHysCoo.truFalHol1.y,hvac.sysHysCoo.truFalHol1.u,hvac.sysHysCoo.greThr.greHys.y,hvac.sysHysHea.truDel.y,hvac.sysHysHea.truDel.u,hvac.sysHysHea.sysOn,hvac.sysHysHea.truFalHol1.entryTimeFalse,hvac.sysHysHea.truFalHol1.entryTimeTrue,hvac.sysHysHea.truFalHol1.not_y,hvac.sysHysHea.truFalHol1.not_u,hvac.sysHysHea.truFalHol1.y,hvac.sysHysHea.truFalHol1.u,hvac.sysHysHea.greThr.greHys.y,hvac.or2.y,hvac.conVAV[5].greThr.y,hvac.conVAV[5].hysWitHol.y,hvac.conVAV[4].greThr.y,hvac.conVAV[4].hysWitHol.y,hvac.conVAV[3].greThr.y,hvac.conVAV[3].hysWitHol.y,hvac.conVAV[2].greThr.y,hvac.conVAV[2].hysWitHol.y,hvac.conVAV[1].greThr.y,hvac.conVAV[1].hysWitHol.y,hvac.conEco.hysLoc.y,hvac.modeSelector.or2.y,hvac.modeSelector.yEco,hvac.modeSelector.sum.u[6],hvac.modeSelector.sum.u[5],hvac.modeSelector.sum.u[4],hvac.modeSelector.sum.u[3],hvac.modeSelector.sum.u[2],hvac.modeSelector.sum.u[1],hvac.modeSelector.t8.enableFire,hvac.modeSelector.not1.y,hvac.modeSelector.t9.enableFire,hvac.modeSelector.t9.localCondition,hvac.modeSelector.preCooSta.and3.u[3],hvac.modeSelector.preCooSta.and3.u[2],hvac.modeSelector.preCooSta.and3.u[1],hvac.modeSelector.t7.enableFire,hvac.modeSelector.t7.localCondition,hvac.modeSelector.morPreCoo.active,hvac.modeSelector.morPreCoo.oldActive,hvac.modeSelector.morPreCoo.newActive,hvac.modeSelector.morPreCoo.localActive,hvac.modeSelector.t4.enableFire,hvac.modeSelector.t4.localCondition,hvac.modeSelector.t3.enableFire,hvac.modeSelector.t3.localCondition,hvac.modeSelector.occ.active,hvac.modeSelector.occ.oldActive,hvac.modeSelector.occ.newActive,hvac.modeSelector.occ.inPort[3].occupied,hvac.modeSelector.occ.inPort[2].occupied,hvac.modeSelector.occ.localActive,hvac.modeSelector.t5.enableFire,hvac.modeSelector.t5.localCondition,hvac.modeSelector.t6.t_start,hvac.modeSelector.t6.fire,hvac.modeSelector.t6.enableFire,hvac.modeSelector.morWarUp.active,hvac.modeSelector.morWarUp.oldActive,hvac.modeSelector.morWarUp.newActive,hvac.modeSelector.morWarUp.inPort[2].occupied,hvac.modeSelector.morWarUp.localActive,hvac.modeSelector.stateGraphRoot.activeSteps,hvac.modeSelector.t1.t_start,hvac.modeSelector.t1.fire,hvac.modeSelector.t1.enableFire,hvac.modeSelector.t1.localCondition,hvac.modeSelector.t2.t_start,hvac.modeSelector.t2.fire,hvac.modeSelector.t2.enableFire,hvac.modeSelector.t2.localCondition,hvac.modeSelector.unOccNigSetBac.active,hvac.modeSelector.unOccNigSetBac.oldActive,hvac.modeSelector.unOccNigSetBac.newActive,hvac.modeSelector.unOccNigSetBac.outPort[2].available,hvac.modeSelector.unOccNigSetBac.localActive,hvac.modeSelector.unOccOff.active,hvac.modeSelector.unOccOff.oldActive,hvac.modeSelector.unOccOff.newActive,hvac.modeSelector.unOccOff.outPort[4].available,hvac.modeSelector.unOccOff.outPort[3].available,hvac.modeSelector.unOccOff.outPort[2].available,hvac.modeSelector.unOccOff.inPort[3].occupied,hvac.modeSelector.unOccOff.inPort[2].occupied,hvac.modeSelector.unOccOff.localActive,hvac.modeSelector.start.enableFire,hvac.modeSelector.initialStepWithSignal.active,hvac.modeSelector.initialStepWithSignal.oldActive,hvac.modeSelector.initialStepWithSignal.newActive,hvac.modeSelector.initialStepWithSignal.localActive,hvac.occSch.tNext,hvac.occSch.tNonOcc,hvac.occSch.tOcc,hvac.occSch.occupied,hvac.controlBus.controlMode,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition6,$whenCondition7,$whenCondition5,$whenCondition10,$whenCondition9,$whenCondition12,$whenCondition13,$whenCondition11,$whenCondition16,$whenCondition15,$whenCondition19,$whenCondition18,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25,$whenCondition26,$whenCondition27,$whenCondition29,$whenCondition30,$whenCondition31,$whenCondition32,$whenCondition33,$whenCondition34,$whenCondition35,hvac.conTSup.con.cheYMinMax.y,hvac.pSetDuc.limPID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (6410):
 * Single equations (assignments): 6199
 * Array equations: 161
 * Algorithm blocks: 4
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 9
 * Torn equation systems: 33
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 9 systems
   {1, 1, 1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 23 systems
   {(1,3,100.0%), (10,30,52.0%), (1,4,100.0%), (3,7,100.0%), (3,7,88.9%), (3,7,88.9%), (1,17,100.0%), (3,7,88.9%), (3,7,88.9%), (1,3,100.0%), (1,1,100.0%), (1,1,100.0%), (7,9,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,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 10 systems
   {(1,2), (5,2), (6,11), (3,4), (1,4), (1,4), (13,46), (13,46), (13,46), (13,46)}
Notification: Performance of prepare postOptimizeDAE: time 0.04811/31.88, allocations: 4.055 MB / 10.14 GB, free: 1.124 GB / 2.858 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.05228/31.94, allocations: 9.528 MB / 10.15 GB, free: 1.124 GB / 2.858 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.3013/32.24, allocations: 86.54 MB / 10.24 GB, free: 1.094 GB / 2.858 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0004606/32.24, allocations: 298.8 kB / 10.24 GB, free: 1.094 GB / 2.858 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0005209/32.24, allocations: 66.44 kB / 10.24 GB, free: 1.094 GB / 2.858 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.2051/32.44, allocations: 70.75 MB / 10.31 GB, free: 1.07 GB / 2.858 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.6121/33.06, allocations: 193.4 MB / 10.5 GB, free: 0.916 GB / 2.858 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0003678/33.06, allocations: 8 kB / 10.5 GB, free: 0.916 GB / 2.858 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.04237/33.1, allocations: 6.942 MB / 10.5 GB, free: 0.9093 GB / 2.858 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.04791/33.15, allocations: 14.45 MB / 10.52 GB, free: 0.8953 GB / 2.858 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.01661/33.16, allocations: 0.978 MB / 10.52 GB, free: 0.8943 GB / 2.858 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.1338/33.3, allocations: 138.2 MB / 10.65 GB, free: 0.7563 GB / 2.858 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.723e-06/33.3, allocations: 11.94 kB / 10.65 GB, free: 0.7563 GB / 2.858 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.3078/33.61, allocations: 124.5 MB / 10.77 GB, free: 0.6398 GB / 2.858 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.1016/33.71, allocations: 24.15 MB / 10.8 GB, free: 0.6164 GB / 2.858 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.06063/33.77, allocations: 0.8456 MB / 10.8 GB, free: 0.6156 GB / 2.858 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.09887/33.87, allocations: 4.388 MB / 10.8 GB, free: 0.6113 GB / 2.858 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.01937/33.89, allocations: 2.155 MB / 10.81 GB, free: 0.6092 GB / 2.858 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.01694/33.9, allocations: 1.091 MB / 10.81 GB, free: 0.6081 GB / 2.858 GB
Notification: Performance of sorting global known variables: time 0.3669/34.27, allocations: 131.9 MB / 10.93 GB, free: 491.4 MB / 2.858 GB
Notification: Performance of sort global known variables: time 2.1e-07/34.27, allocations: 3.938 kB / 10.93 GB, free: 491.4 MB / 2.858 GB
Notification: Performance of remove unused functions: time 0.2975/34.57, allocations: 40.8 MB / 10.97 GB, free: 450.9 MB / 2.858 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 34
 * Number of states: 169 (hvac.cooCoi.heaCoo.vol.dynBal.U,hvac.cooCoi.heaCooHum_u.vol.dynBal.medium.Xi[1],hvac.cooCoi.heaCooHum_u.vol.dynBal.U,hvac.cooCoi.heaCooHum_u.vol.dynBal.mC[1],hvac.cooCoi.dryWetCalcs.fullyWet.TWatOutEst,hvac.fanSup.vol.dynBal.medium.Xi[1],hvac.fanSup.vol.dynBal.U,hvac.fanSup.vol.dynBal.m,hvac.fanSup.vol.dynBal.mC[1],hvac.fanSup.motSpe.y,hvac.TSup.T,hvac.TRet.T,hvac.TMix.T,hvac.res.EFan,hvac.res.EPum,hvac.res.EHea,hvac.res.ECooSen,hvac.res.ECooLat,hvac.damRet.actPos.y,hvac.damOut.actPos.y,hvac.valCooCoi.actPos.y,hvac.pumCooCoi.vol.dynBal.U,hvac.pumCooCoi.motSpe.y,hvac.pumHeaCoi.vol.dynBal.U,hvac.pumHeaCoi.motSpe.y,hvac.valHeaCoi.actPos.y,hvac.VAVBox[1].vav.actPos.y,hvac.VAVBox[1].senTem.T,hvac.VAVBox[2].vav.actPos.y,hvac.VAVBox[2].senTem.T,hvac.VAVBox[3].vav.actPos.y,hvac.VAVBox[3].senTem.T,hvac.VAVBox[4].vav.actPos.y,hvac.VAVBox[4].senTem.T,hvac.VAVBox[5].vav.actPos.y,hvac.VAVBox[5].senTem.T,hvac.splRetOut.vol.dynBal.medium.Xi[1],hvac.splRetOut.vol.dynBal.U,hvac.splRetOut.vol.dynBal.m,hvac.splRetOut.vol.dynBal.mC[1],hvac.conFanSup.con.I.y,hvac.conEco.conV_flow.I.y,hvac.conEco.yOATFre.I.y,hvac.pSetDuc.limPID.I.y,hvac.conVAV[1].conHea.I.y,hvac.conVAV[1].conCoo.I.y,hvac.conVAV[1].conDam.I.y,hvac.conVAV[2].conHea.I.y,hvac.conVAV[2].conCoo.I.y,hvac.conVAV[2].conDam.I.y,hvac.conVAV[3].conHea.I.y,hvac.conVAV[3].conCoo.I.y,hvac.conVAV[3].conDam.I.y,hvac.conVAV[4].conHea.I.y,hvac.conVAV[4].conCoo.I.y,hvac.conVAV[4].conDam.I.y,hvac.conVAV[5].conHea.I.y,hvac.conVAV[5].conCoo.I.y,hvac.conVAV[5].conDam.I.y,hvac.conTSup.con.I.y,hvac.damExh.actPos.y,flo.sou.conExtWin[1].opa.lay[1].T[1],flo.sou.conExtWin[1].opa.lay[1].T[2],flo.sou.conExtWin[1].opa.lay[2].T[1],flo.sou.conExtWin[1].opa.lay[2].T[2],flo.sou.conExtWin[1].opa.lay[2].T[3],flo.sou.conExtWin[1].opa.lay[3].T[1],flo.sou.conExtWin[1].opa.lay[3].T[2],flo.sou.conExtWin[1].win.capGla.TUns,flo.sou.conExtWin[1].win.capFra.T,flo.sou.conPar[1].opa.lay[1].T[1],flo.sou.conPar[1].opa.lay[1].T[2],flo.sou.conPar[2].opa.lay[1].T[1],flo.sou.conPar[2].opa.lay[1].T[2],flo.sou.conPar[2].opa.lay[1].T[3],flo.sou.conPar[2].opa.lay[1].T[4],flo.sou.conPar[2].opa.lay[1].T[5],flo.sou.conPar[2].opa.lay[1].T[6],flo.sou.conBou[1].opa.lay[1].T[1],flo.sou.conBou[1].opa.lay[1].T[2],flo.sou.conBou[2].opa.lay[1].T[1],flo.sou.conBou[2].opa.lay[1].T[2],flo.sou.conBou[3].opa.lay[1].T[1],flo.sou.conBou[3].opa.lay[1].T[2],flo.sou.air.vol.dynBal.medium.Xi[1],flo.sou.air.vol.dynBal.U,flo.sou.air.vol.dynBal.mC[1],flo.eas.conExtWin[1].opa.lay[1].T[1],flo.eas.conExtWin[1].opa.lay[1].T[2],flo.eas.conExtWin[1].opa.lay[2].T[1],flo.eas.conExtWin[1].opa.lay[2].T[2],flo.eas.conExtWin[1].opa.lay[2].T[3],flo.eas.conExtWin[1].opa.lay[3].T[1],flo.eas.conExtWin[1].opa.lay[3].T[2],flo.eas.conExtWin[1].win.capGla.TUns,flo.eas.conExtWin[1].win.capFra.T,flo.eas.conPar[1].opa.lay[1].T[1],flo.eas.conPar[1].opa.lay[1].T[2],flo.eas.conPar[2].opa.lay[1].T[1],flo.eas.conPar[2].opa.lay[1].T[2],flo.eas.conPar[2].opa.lay[1].T[3],flo.eas.conPar[2].opa.lay[1].T[4],flo.eas.conPar[2].opa.lay[1].T[5],flo.eas.conPar[2].opa.lay[1].T[6],flo.eas.conBou[1].opa.lay[1].T[1],flo.eas.conBou[1].opa.lay[1].T[2],flo.eas.air.vol.dynBal.medium.Xi[1],flo.eas.air.vol.dynBal.U,flo.eas.air.vol.dynBal.mC[1],flo.nor.conExtWin[1].opa.lay[1].T[1],flo.nor.conExtWin[1].opa.lay[1].T[2],flo.nor.conExtWin[1].opa.lay[2].T[1],flo.nor.conExtWin[1].opa.lay[2].T[2],flo.nor.conExtWin[1].opa.lay[2].T[3],flo.nor.conExtWin[1].opa.lay[3].T[1],flo.nor.conExtWin[1].opa.lay[3].T[2],flo.nor.conExtWin[1].win.capGla.TUns,flo.nor.conExtWin[1].win.capFra.T,flo.nor.conPar[1].opa.lay[1].T[1],flo.nor.conPar[1].opa.lay[1].T[2],flo.nor.conPar[2].opa.lay[1].T[1],flo.nor.conPar[2].opa.lay[1].T[2],flo.nor.conPar[2].opa.lay[1].T[3],flo.nor.conPar[2].opa.lay[1].T[4],flo.nor.conPar[2].opa.lay[1].T[5],flo.nor.conPar[2].opa.lay[1].T[6],flo.nor.conBou[1].opa.lay[1].T[1],flo.nor.conBou[1].opa.lay[1].T[2],flo.nor.conBou[2].opa.lay[1].T[1],flo.nor.conBou[2].opa.lay[1].T[2],flo.nor.conBou[3].opa.lay[1].T[1],flo.nor.conBou[3].opa.lay[1].T[2],flo.nor.air.vol.dynBal.medium.Xi[1],flo.nor.air.vol.dynBal.U,flo.nor.air.vol.dynBal.mC[1],flo.wes.conExtWin[1].opa.lay[1].T[1],flo.wes.conExtWin[1].opa.lay[1].T[2],flo.wes.conExtWin[1].opa.lay[2].T[1],flo.wes.conExtWin[1].opa.lay[2].T[2],flo.wes.conExtWin[1].opa.lay[2].T[3],flo.wes.conExtWin[1].opa.lay[3].T[1],flo.wes.conExtWin[1].opa.lay[3].T[2],flo.wes.conExtWin[1].win.capGla.TUns,flo.wes.conExtWin[1].win.capFra.T,flo.wes.conPar[1].opa.lay[1].T[1],flo.wes.conPar[1].opa.lay[1].T[2],flo.wes.conPar[2].opa.lay[1].T[1],flo.wes.conPar[2].opa.lay[1].T[2],flo.wes.conPar[2].opa.lay[1].T[3],flo.wes.conPar[2].opa.lay[1].T[4],flo.wes.conPar[2].opa.lay[1].T[5],flo.wes.conPar[2].opa.lay[1].T[6],flo.wes.conBou[1].opa.lay[1].T[1],flo.wes.conBou[1].opa.lay[1].T[2],flo.wes.air.vol.dynBal.medium.Xi[1],flo.wes.air.vol.dynBal.U,flo.wes.air.vol.dynBal.mC[1],flo.cor.conPar[1].opa.lay[1].T[1],flo.cor.conPar[1].opa.lay[1].T[2],flo.cor.conPar[2].opa.lay[1].T[1],flo.cor.conPar[2].opa.lay[1].T[2],flo.cor.conPar[2].opa.lay[1].T[3],flo.cor.conPar[2].opa.lay[1].T[4],flo.cor.conPar[2].opa.lay[1].T[5],flo.cor.conPar[2].opa.lay[1].T[6],flo.cor.air.vol.dynBal.medium.Xi[1],flo.cor.air.vol.dynBal.U,flo.cor.air.vol.dynBal.m,flo.cor.air.vol.dynBal.mC[1])
 * Number of discrete variables: 179 (hvac.modeSelector.t6.enableFire,hvac.or2.y,hvac.sysHysHea.truDel.u,hvac.sysHysCoo.truDel.u,hvac.modeSelector.t2.enableFire,hvac.modeSelector.t1.enableFire,hvac.freSta.locOut.u,hvac.sysHysHea.sysOn,hvac.modeSelector.morPreCoo.active,hvac.modeSelector.occ.active,hvac.modeSelector.morWarUp.active,hvac.modeSelector.unOccNigSetBac.active,hvac.modeSelector.unOccOff.active,hvac.modeSelector.initialStepWithSignal.active,$cse294,$cse295,$cse296,$cse297,$cse298,$cse299,$cse300,$cse301,$cse302,$cse303,$cse305,$whenCondition35,$whenCondition34,$whenCondition33,$whenCondition32,$whenCondition31,$whenCondition30,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition11,$whenCondition13,$whenCondition12,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition5,$whenCondition7,$whenCondition6,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,hvac.controlBus.controlMode,hvac.occSch.occupied,hvac.occSch.tOcc,hvac.occSch.tNonOcc,hvac.occSch.tNext,hvac.modeSelector.initialStepWithSignal.localActive,hvac.modeSelector.initialStepWithSignal.newActive,hvac.modeSelector.initialStepWithSignal.oldActive,hvac.modeSelector.start.enableFire,hvac.modeSelector.unOccOff.localActive,hvac.modeSelector.unOccOff.inPort[2].occupied,hvac.modeSelector.unOccOff.inPort[3].occupied,hvac.modeSelector.unOccOff.outPort[2].available,hvac.modeSelector.unOccOff.outPort[3].available,hvac.modeSelector.unOccOff.outPort[4].available,hvac.modeSelector.unOccOff.newActive,hvac.modeSelector.unOccOff.oldActive,hvac.modeSelector.unOccNigSetBac.localActive,hvac.modeSelector.unOccNigSetBac.outPort[2].available,hvac.modeSelector.unOccNigSetBac.newActive,hvac.modeSelector.unOccNigSetBac.oldActive,hvac.modeSelector.t2.localCondition,hvac.modeSelector.t2.fire,hvac.modeSelector.t2.t_start,hvac.modeSelector.t1.localCondition,hvac.modeSelector.t1.fire,hvac.modeSelector.t1.t_start,hvac.modeSelector.stateGraphRoot.activeSteps,hvac.modeSelector.morWarUp.localActive,hvac.modeSelector.morWarUp.inPort[2].occupied,hvac.modeSelector.morWarUp.newActive,hvac.modeSelector.morWarUp.oldActive,hvac.modeSelector.t6.fire,hvac.modeSelector.t6.t_start,hvac.modeSelector.t5.localCondition,hvac.modeSelector.t5.enableFire,hvac.modeSelector.occ.localActive,hvac.modeSelector.occ.inPort[2].occupied,hvac.modeSelector.occ.inPort[3].occupied,hvac.modeSelector.occ.newActive,hvac.modeSelector.occ.oldActive,hvac.modeSelector.t3.localCondition,hvac.modeSelector.t3.enableFire,hvac.modeSelector.t4.localCondition,hvac.modeSelector.t4.enableFire,hvac.modeSelector.morPreCoo.localActive,hvac.modeSelector.morPreCoo.newActive,hvac.modeSelector.morPreCoo.oldActive,hvac.modeSelector.t7.localCondition,hvac.modeSelector.t7.enableFire,hvac.modeSelector.preCooSta.and3.u[1],hvac.modeSelector.preCooSta.and3.u[2],hvac.modeSelector.preCooSta.and3.u[3],hvac.modeSelector.t9.localCondition,hvac.modeSelector.t9.enableFire,hvac.modeSelector.not1.y,hvac.modeSelector.t8.enableFire,hvac.modeSelector.sum.u[1],hvac.modeSelector.sum.u[2],hvac.modeSelector.sum.u[3],hvac.modeSelector.sum.u[4],hvac.modeSelector.sum.u[5],hvac.modeSelector.sum.u[6],hvac.modeSelector.yEco,hvac.modeSelector.or2.y,hvac.conEco.hysLoc.y,hvac.conVAV[1].hysWitHol.y,hvac.conVAV[1].greThr.y,hvac.conVAV[2].hysWitHol.y,hvac.conVAV[2].greThr.y,hvac.conVAV[3].hysWitHol.y,hvac.conVAV[3].greThr.y,hvac.conVAV[4].hysWitHol.y,hvac.conVAV[4].greThr.y,hvac.conVAV[5].hysWitHol.y,hvac.conVAV[5].greThr.y,hvac.sysHysHea.greThr.greHys.y,hvac.sysHysHea.truFalHol1.u,hvac.sysHysHea.truFalHol1.y,hvac.sysHysHea.truFalHol1.not_u,hvac.sysHysHea.truFalHol1.not_y,hvac.sysHysHea.truFalHol1.entryTimeTrue,hvac.sysHysHea.truFalHol1.entryTimeFalse,hvac.sysHysHea.truDel.y,hvac.sysHysHea.truDel.t_next,hvac.sysHysCoo.greThr.greHys.y,hvac.sysHysCoo.truFalHol1.u,hvac.sysHysCoo.truFalHol1.y,hvac.sysHysCoo.truFalHol1.not_u,hvac.sysHysCoo.truFalHol1.not_y,hvac.sysHysCoo.truFalHol1.entryTimeTrue,hvac.sysHysCoo.truFalHol1.entryTimeFalse,hvac.sysHysCoo.truDel.y,hvac.sysHysCoo.truDel.t_next,hvac.freSta.locOut.y,hvac.freSta.locOut.t_next,hvac.freSta.greThr.greHys.y,flo.sou.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.sou.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.eas.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.eas.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.nor.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.nor.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.wes.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.wes.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.intGaiFra.nextTimeEvent,flo.intGaiFra.nextTimeEventScaled,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,hvac.modeSelector.start.t_start,hvac.modeSelector.t5.t_start,hvac.modeSelector.t3.t_start,hvac.modeSelector.t4.t_start,hvac.modeSelector.t7.t_start,hvac.modeSelector.t9.t_start,hvac.modeSelector.t8.t_start)
 * Number of discrete states: 53 (hvac.modeSelector.t8.t_start,hvac.modeSelector.t9.t_start,hvac.modeSelector.t7.t_start,hvac.modeSelector.t4.t_start,hvac.modeSelector.t3.t_start,hvac.modeSelector.t5.t_start,hvac.modeSelector.start.t_start,flo.intGaiFra.nextTimeEvent,hvac.freSta.locOut.t_next,hvac.sysHysCoo.truDel.t_next,hvac.sysHysCoo.truFalHol1.entryTimeFalse,hvac.sysHysCoo.truFalHol1.entryTimeTrue,hvac.sysHysHea.truDel.t_next,hvac.sysHysHea.truFalHol1.entryTimeFalse,hvac.sysHysHea.truFalHol1.entryTimeTrue,hvac.occSch.tNext,hvac.modeSelector.initialStepWithSignal.newActive,hvac.modeSelector.unOccOff.newActive,hvac.modeSelector.unOccNigSetBac.newActive,hvac.modeSelector.morWarUp.newActive,hvac.modeSelector.occ.newActive,hvac.modeSelector.morPreCoo.newActive,hvac.freSta.greThr.greHys.y,flo.sou.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.sou.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.eas.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.eas.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.nor.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.nor.bouConExtWin.HDifTil[1].incAng.decAng.tNext,flo.wes.bouConExtWin.HDirTil[1].incAng.decAng.tNext,flo.wes.bouConExtWin.HDifTil[1].incAng.decAng.tNext,weaDat.locTim.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext,hvac.conVAV[1].hysWitHol.y,hvac.conVAV[2].hysWitHol.y,hvac.conVAV[3].hysWitHol.y,hvac.conVAV[4].hysWitHol.y,hvac.conVAV[5].hysWitHol.y,hvac.conEco.hysLoc.y,flo.intGaiFra.nextTimeEventScaled,hvac.sysHysCoo.greThr.greHys.y,hvac.sysHysHea.greThr.greHys.y,hvac.sysHysCoo.truFalHol1.u,hvac.sysHysCoo.truFalHol1.not_u,hvac.sysHysCoo.truFalHol1.y,hvac.sysHysCoo.truFalHol1.not_y,hvac.sysHysHea.truFalHol1.u,hvac.sysHysHea.truFalHol1.not_u,hvac.sysHysHea.truFalHol1.y,hvac.sysHysHea.truFalHol1.not_y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (2829):
 * Single equations (assignments): 2726
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 10
 * When equations: 44
 * If-equations: 0
 * Equation systems (not torn): 8
 * Torn equation systems: 37
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 8 systems
   {1, 1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 31 systems
   {(1,3,100.0%), (1,3,100.0%), (3,7,88.9%), (3,7,100.0%), (3,7,100.0%), (1,13,100.0%), (1,3,100.0%), (11,29,46.3%), (3,7,88.9%), (3,7,88.9%), (11,28,86.8%), (11,28,86.8%), (11,28,86.8%), (11,28,86.8%), (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%), (7,9,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(1,2), (1,1), (3,4), (6,12), (1,5), (1,5)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02444/34.59, allocations: 4.71 MB / 10.98 GB, free: 447.1 MB / 2.858 GB
Notification: Performance of simCode: created initialization part: time 0.5388/35.13, allocations: 351.8 MB / 11.32 GB, free: 94.63 MB / 2.858 GB
Notification: Performance of simCode: created event and clocks part: time 2.96e-05/35.13, allocations: 16.19 kB / 11.32 GB, free: 94.62 MB / 2.858 GB
Notification: Performance of simCode: created simulation system equations: time 0.09952/35.23, allocations: 41.98 MB / 11.36 GB, free: 52.21 MB / 2.858 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.279/35.51, allocations: 35.15 MB / 11.4 GB, free: 17.88 MB / 2.858 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 3.365/38.87, allocations: 277.7 MB / 11.67 GB, free: 1.133 GB / 2.858 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.3027/39.18, allocations: 75.84 MB / 11.74 GB, free: 1.123 GB / 2.858 GB
Notification: Performance of simCode: alias equations: time 0.2259/39.4, allocations: 39.18 MB / 11.78 GB, free: 1.119 GB / 2.858 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.06766/39.47, allocations: 5.509 MB / 11.79 GB, free: 1.119 GB / 2.858 GB
Notification: Performance of SimCode: time 2.375e-06/39.47, allocations: 0 / 11.79 GB, free: 1.119 GB / 2.858 GB
Notification: Performance of Templates: time 5.346/44.82, allocations: 1.877 GB / 13.66 GB, free: 0.6588 GB / 2.858 GB
"
[Timeout remaining time 255]
make -j1 -f Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.pipe ; mkfifo Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.pipe >> ../files/Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.sim & ./Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Examples_VAVReheat_Validation_TraceSubstance.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Examples.VAVReheat.Validation.TraceSubstance.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: 240.5464183902368]