Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.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.0009819/0.0009819, allocations: 73.97 kB / 20.66 MB, free: 3.836 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.001085/0.001085, allocations: 173 kB / 24.06 MB, free: 444 kB / 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.022/1.022, allocations: 177.1 MB / 204.5 MB, free: 5.277 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 2.169/2.169, allocations: 429.5 MB / 0.6743 GB, free: 3.895 MB / 0.6355 GB
"
[Timeout remaining time 177]
Using package Buildings with version 14.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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.Utilities.Plotters.Examples.SingleZoneVAV,tolerance=1e-06,outputFormat="mat",numberOfIntervals=120,variableFilter="time|hvac.PFan",fileNamePrefix="Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV")
translateModel(Buildings.Utilities.Plotters.Examples.SingleZoneVAV,tolerance=1e-06,outputFormat="mat",numberOfIntervals=120,variableFilter="time|hvac.PFan",fileNamePrefix="Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.784e-06/1.784e-06, allocations: 0 / 0.8794 GB, free: 5.977 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.877e-05/2.055e-05, allocations: 3.406 kB / 0.8794 GB, free: 5.973 MB / 0.8386 GB
Notification: Performance of NFInst.instantiate(Buildings.Utilities.Plotters.Examples.SingleZoneVAV): time 0.6658/0.6658, allocations: 238.4 MB / 1.112 GB, free: 51.25 MB / 1.01 GB
Notification: Performance of NFInst.instExpressions: time 0.1011/0.7669, allocations: 65.71 MB / 1.176 GB, free: 37.05 MB / 1.01 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02772/0.7947, allocations: 0.8421 MB / 1.177 GB, free: 36.62 MB / 1.01 GB
Notification: Performance of NFTyping.typeComponents: time 0.02611/0.8208, allocations: 10.48 MB / 1.187 GB, free: 32.12 MB / 1.01 GB
Notification: Performance of NFTyping.typeBindings: time 0.0378/0.8586, allocations: 13.8 MB / 1.201 GB, free: 25.14 MB / 1.01 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02777/0.8863, allocations: 13.69 MB / 1.214 GB, free: 18.08 MB / 1.01 GB
Notification: Performance of NFFlatten.flatten: time 0.07809/0.9644, allocations: 81.23 MB / 1.294 GB, free: 9.727 MB / 1.057 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04963/1.014, allocations: 26.86 MB / 1.32 GB, free: 14.71 MB / 1.089 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1103/1.124, allocations: 51.36 MB / 1.37 GB, free: 14.39 MB / 1.135 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04042/1.165, allocations: 23.46 MB / 1.393 GB, free: 6.879 MB / 1.151 GB
Notification: Performance of NFPackage.collectConstants: time 0.01571/1.181, allocations: 5.273 MB / 1.398 GB, free: 1.605 MB / 1.151 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02809/1.209, allocations: 10.35 MB / 1.408 GB, free: 7.242 MB / 1.167 GB
Notification: Performance of NFScalarize.scalarize: time 0.02518/1.234, allocations: 16.93 MB / 1.425 GB, free: 6.273 MB / 1.182 GB
Notification: Performance of NFVerifyModel.verify: time 0.03867/1.272, allocations: 15.66 MB / 1.44 GB, free: 6.586 MB / 1.198 GB
Notification: Performance of NFConvertDAE.convert: time 0.07416/1.347, allocations: 46.45 MB / 1.485 GB, free: 8.004 MB / 1.245 GB
Notification: Performance of FrontEnd - DAE generated: time 7.244e-06/1.347, allocations: 0 / 1.485 GB, free: 8.004 MB / 1.245 GB
Notification: Performance of FrontEnd: time 1.623e-06/1.347, allocations: 4 kB / 1.485 GB, free: 8 MB / 1.245 GB
Notification: Performance of Transformations before backend: time 0.002304/1.349, allocations: 0 / 1.485 GB, free: 8 MB / 1.245 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4191
 * Number of variables: 4191
Notification: Performance of Generate backend data structure: time 0.1019/1.451, allocations: 50.45 MB / 1.535 GB, free: 5.098 MB / 1.292 GB
Notification: Performance of prepare preOptimizeDAE: time 4.238e-05/1.451, allocations: 15.98 kB / 1.535 GB, free: 5.082 MB / 1.292 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.5983/2.049, allocations: 14.16 MB / 1.548 GB, free: 249.8 MB / 1.292 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.07429/2.123, allocations: 45.97 MB / 1.593 GB, free: 245.3 MB / 1.292 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002197/2.126, allocations: 2.79 MB / 1.596 GB, free: 243.7 MB / 1.292 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005893/2.132, allocations: 1.948 MB / 1.598 GB, free: 243.7 MB / 1.292 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04075/2.172, allocations: 18.43 MB / 1.616 GB, free: 238.1 MB / 1.292 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005933/2.173, allocations: 38.5 kB / 1.616 GB, free: 238.1 MB / 1.292 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003673/2.177, allocations: 0.6815 MB / 1.617 GB, free: 238.1 MB / 1.292 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004909/2.177, allocations: 0.6071 MB / 1.617 GB, free: 238.1 MB / 1.292 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02445/2.202, allocations: 8.77 MB / 1.626 GB, free: 237.6 MB / 1.292 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.1628/2.364, allocations: 125.1 MB / 1.748 GB, free: 148.9 MB / 1.292 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01841/2.383, allocations: 10.03 MB / 1.758 GB, free: 141 MB / 1.292 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008866/2.392, allocations: 4.611 MB / 1.762 GB, free: 136.4 MB / 1.292 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.07382/2.465, allocations: 40.24 MB / 1.802 GB, free: 93.49 MB / 1.292 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01301/2.478, allocations: 7.518 MB / 1.809 GB, free: 85.91 MB / 1.292 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01456/2.493, allocations: 1.323 MB / 1.81 GB, free: 84.58 MB / 1.292 GB
Notification: Performance of pre-optimization done (n=1126): time 3.812e-05/2.493, allocations: 4 kB / 1.81 GB, free: 84.58 MB / 1.292 GB
Notification: Performance of matching and sorting (n=1132): time 0.09426/2.587, allocations: 27.3 MB / 1.837 GB, free: 57.18 MB / 1.292 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000208/2.588, allocations: 479.4 kB / 1.837 GB, free: 56.66 MB / 1.292 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.06438/2.652, allocations: 36.34 MB / 1.873 GB, free: 25.5 MB / 1.292 GB
Notification: Performance of collectPreVariables (initialization): time 0.004606/2.656, allocations: 438.2 kB / 1.873 GB, free: 25.07 MB / 1.292 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02337/2.68, allocations: 20.44 MB / 1.893 GB, free: 6.125 MB / 1.292 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005752/2.686, allocations: 4.208 MB / 1.897 GB, free: 2.176 MB / 1.292 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01776/2.703, allocations: 8.941 MB / 1.906 GB, free: 9.977 MB / 1.307 GB
Notification: Performance of setup shared object (initialization): time 0.0001332/2.704, allocations: 480.7 kB / 1.906 GB, free: 9.504 MB / 1.307 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01585/2.719, allocations: 7.916 MB / 1.914 GB, free: 1.562 MB / 1.307 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02301/2.742, allocations: 19.05 MB / 1.933 GB, free: 11.32 MB / 1.339 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 0.1017/2.844, allocations: 57.95 MB / 1.989 GB, free: 15.25 MB / 1.401 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002443/2.844, allocations: 48 kB / 1.989 GB, free: 15.2 MB / 1.401 GB
Notification: Performance of matching and sorting (n=3176) (initialization): time 0.07233/2.917, allocations: 33.39 MB / 2.022 GB, free: 14.89 MB / 1.432 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002553/2.917, allocations: 231.3 kB / 2.022 GB, free: 14.66 MB / 1.432 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.02919/2.946, allocations: 20.4 MB / 2.042 GB, free: 10.22 MB / 1.448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009642/2.956, allocations: 3.568 MB / 2.046 GB, free: 6.629 MB / 1.448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01321/2.969, allocations: 4.729 MB / 2.05 GB, free: 2.176 MB / 1.448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01914/2.988, allocations: 32.3 MB / 2.082 GB, free: 0.8633 MB / 1.479 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.5961/3.584, allocations: 1.534 MB / 2.083 GB, free: 376.4 MB / 1.479 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004994/3.589, allocations: 0.8086 MB / 2.084 GB, free: 376.4 MB / 1.479 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.0285/3.618, allocations: 8.263 MB / 2.092 GB, free: 376.2 MB / 1.479 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03135/3.649, allocations: 19.02 MB / 2.111 GB, free: 364.4 MB / 1.479 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 0.09802/3.747, allocations: 57.88 MB / 2.167 GB, free: 351.7 MB / 1.479 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0004391/3.747, allocations: 50.94 kB / 2.167 GB, free: 351.7 MB / 1.479 GB
Notification: Performance of matching and sorting (n=3176) (initialization_lambda0): time 0.07927/3.827, allocations: 33.55 MB / 2.2 GB, free: 344.1 MB / 1.479 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003098/3.827, allocations: 234.5 kB / 2.2 GB, free: 343.9 MB / 1.479 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.04306/3.87, allocations: 20.6 MB / 2.22 GB, free: 327.1 MB / 1.479 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01107/3.881, allocations: 3.569 MB / 2.224 GB, free: 324.6 MB / 1.479 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01658/3.898, allocations: 4.723 MB / 2.229 GB, free: 321 MB / 1.479 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02546/3.923, allocations: 36.95 MB / 2.265 GB, free: 292.4 MB / 1.479 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02919/3.952, allocations: 1.543 MB / 2.266 GB, free: 291.4 MB / 1.479 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006091/3.959, allocations: 0.8002 MB / 2.267 GB, free: 290.8 MB / 1.479 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: 792
 * Number of states: 0 ()
 * Number of discrete variables: 195 (plo.ploTOut.timeConverted,$PRE.plo.ploTOut.timeConverted,$PRE.TSetRooCoo.tab.nextTimeEvent,$whenCondition24,$PRE.TSetRooHea.tab.nextTimeEvent,$whenCondition23,$PRE.zon.intLoad.tab.nextTimeEvent,$whenCondition11,plo.ploTOut.sampleTrigger,plo.ploTOut.tActivateLast,$PRE.plo.ploTOut.tActivateLast,plo.ploTOut.active,$whenCondition27,plo.scaPFan.sampleTrigger,plo.scaPFan.tActivateLast,$PRE.plo.scaPFan.tActivateLast,plo.scaPFan.active,$whenCondition30,plo.scaPFan.activate_internal,plo.ploTOut.activate_internal,hvac.chi.tru.y,EPum.local_reset,ECoo.local_reset,EHea.local_reset,EFan.local_reset,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],hvac.cooCoi.flowRegime_nominal,$PRE.plo.scaTRoo.tActivateLast,$PRE.plo.scaEco.tActivateLast,$PRE.plo.plotConfiguration.tActivateLast,$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.hysTMix.y,$PRE.con.conEco.truFalHolTMix.entryTimeFalse,$PRE.con.conEco.truFalHolTMix.entryTimeTrue,$PRE.con.conEco.truFalHolTMix.not_y,$PRE.con.conEco.truFalHolTMix.y,$PRE.con.conEco.truFalHolCooPot.entryTimeFalse,$PRE.con.conEco.truFalHolCooPot.entryTimeTrue,$PRE.con.conEco.truFalHolCooPot.not_y,$PRE.con.conEco.truFalHolCooPot.y,$PRE.con.conEco.hysCooPot.y,$PRE.con.conEco.hysChiPla.y,$PRE.weaDat.decAng.k,$PRE.weaDat.decAng.tNext,$PRE.weaDat.eqnTim.k,$PRE.weaDat.eqnTim.tNext,$PRE.weaDat.conTim.k,$PRE.weaDat.conTim.tNext,$PRE.weaDat.conTimMin.k,$PRE.weaDat.conTimMin.tNext,$PRE.weaDat.locTim.k,$PRE.weaDat.locTim.tNext,$PRE.zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.k,$PRE.zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.k,$PRE.zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[4].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[3].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[2].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDifTil[1].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[4].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[3].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[2].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,$PRE.zon.roo.bouConExt.HDirTil[1].incAng.decAng.k,$PRE.zon.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,plo.scaTRoo.sampleTrigger,plo.scaTRoo.tActivateLast,plo.scaTRoo.active,plo.scaEco.sampleTrigger,plo.scaEco.tActivateLast,plo.scaEco.active,plo.plotConfiguration.tActivateLast,plo.plotConfiguration.active,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,$PRE.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,$PRE.con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.u,$PRE.con.conEco.truFalHolTMix.u,con.conEco.truFalHolCooPot.entryTimeFalse,con.conEco.truFalHolCooPot.entryTimeTrue,con.conEco.truFalHolCooPot.not_y,con.conEco.truFalHolCooPot.not_u,$PRE.con.conEco.truFalHolCooPot.not_u,con.conEco.truFalHolCooPot.y,con.conEco.truFalHolCooPot.u,$PRE.con.conEco.truFalHolCooPot.u,con.conEco.hysCooPot.y,con.conEco.not1.y,con.conEco.yCoiSta,con.conEco.hysChiPla.y,con.chiOn,weaDat.decAng.k,weaDat.decAng.tNext,weaDat.eqnTim.k,weaDat.eqnTim.tNext,weaDat.conTim.k,weaDat.conTim.tNext,weaDat.conTimMin.k,weaDat.conTimMin.tNext,weaDat.locTim.k,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.k,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.k,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[4].incAng.decAng.k,zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[3].incAng.decAng.k,zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[2].incAng.decAng.k,zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[1].incAng.decAng.k,zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[4].incAng.decAng.k,zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[3].incAng.decAng.k,zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[2].incAng.decAng.k,zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[1].incAng.decAng.k,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,$whenCondition26,$whenCondition28,$whenCondition29,$whenCondition31)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2314):
 * Single equations (assignments): 2254
 * Array equations: 43
 * Algorithm blocks: 2
 * Record equations: 1
 * 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,42), (1,14)}
Notification: Performance of prepare postOptimizeDAE: time 0.01014/3.969, allocations: 1.71 MB / 2.269 GB, free: 290.1 MB / 1.479 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01534/3.984, allocations: 3.699 MB / 2.272 GB, free: 288.4 MB / 1.479 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04668/4.031, allocations: 13.67 MB / 2.286 GB, free: 280.3 MB / 1.479 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.349e-05/4.031, allocations: 115.8 kB / 2.286 GB, free: 280.1 MB / 1.479 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.408e-05/4.031, allocations: 12 kB / 2.286 GB, free: 280.1 MB / 1.479 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02488/4.056, allocations: 8.638 MB / 2.294 GB, free: 273.7 MB / 1.479 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 0.09931/4.155, allocations: 45 MB / 2.338 GB, free: 251.2 MB / 1.479 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.312e-05/4.155, allocations: 8 kB / 2.338 GB, free: 251.2 MB / 1.479 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01075/4.166, allocations: 2.636 MB / 2.341 GB, free: 249.2 MB / 1.479 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007312/4.173, allocations: 2.055 MB / 2.343 GB, free: 247.8 MB / 1.479 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003381/4.176, allocations: 428.6 kB / 2.343 GB, free: 247.7 MB / 1.479 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01792/4.194, allocations: 34.67 MB / 2.377 GB, free: 215.6 MB / 1.479 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.472e-06/4.194, allocations: 14.61 kB / 2.377 GB, free: 215.6 MB / 1.479 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04824/4.243, allocations: 17.42 MB / 2.394 GB, free: 198.3 MB / 1.479 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02156/4.264, allocations: 8.163 MB / 2.402 GB, free: 190.1 MB / 1.479 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01254/4.277, allocations: 379.2 kB / 2.402 GB, free: 189.7 MB / 1.479 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01968/4.296, allocations: 1.073 MB / 2.403 GB, free: 188.7 MB / 1.479 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003311/4.3, allocations: 0.818 MB / 2.404 GB, free: 187.9 MB / 1.479 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002175/4.302, allocations: 395.6 kB / 2.405 GB, free: 187.5 MB / 1.479 GB
Notification: Performance of sorting global known variables: time 0.04021/4.342, allocations: 19.77 MB / 2.424 GB, free: 169.4 MB / 1.479 GB
Notification: Performance of sort global known variables: time 3.4e-07/4.342, allocations: 4 kB / 2.424 GB, free: 169.4 MB / 1.479 GB
Notification: Performance of remove unused functions: time 0.06463/4.407, allocations: 19.28 MB / 2.443 GB, free: 150.3 MB / 1.479 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: 110 (plo.scaTRoo.sampleTrigger,plo.scaEco.sampleTrigger,plo.plotConfiguration.active,con.chiOn,plo.ploTOut.sampleTrigger,plo.scaPFan.sampleTrigger,$whenCondition31,$whenCondition30,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$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[1].incAng.decAng.k,zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[2].incAng.decAng.k,zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[3].incAng.decAng.k,zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[4].incAng.decAng.k,zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[1].incAng.decAng.k,zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[2].incAng.decAng.k,zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[3].incAng.decAng.k,zon.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[4].incAng.decAng.k,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.k,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.k,zon.intLoad.tab.nextTimeEvent,zon.intLoad.tab.nextTimeEventScaled,zon.greThr.y,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k,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,plo.plotConfiguration.tActivateLast,plo.ploTOut.active,plo.ploTOut.tActivateLast,plo.ploTOut.timeConverted,plo.scaEco.active,plo.scaEco.tActivateLast,plo.scaPFan.active,plo.scaPFan.tActivateLast,plo.scaTRoo.active,plo.scaTRoo.tActivateLast)
 * Number of discrete states: 55 (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.HDifTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,zon.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.locTim.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,weaDat.decAng.k,weaDat.eqnTim.k,weaDat.conTim.k,con.conEco.hysCooPot.y,con.conEco.truFalHolCooPot.u,con.conEco.truFalHolCooPot.not_u,con.conEco.truFalHolCooPot.y,con.conEco.truFalHolCooPot.not_y,con.conEco.hysTMix.y,con.conEco.truFalHolTMix.u,con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.not_y,con.conEco.hysChiPla.y,weaDat.conTimMin.k,weaDat.locTim.k,zon.intLoad.tab.nextTimeEventScaled,zon.roo.bouConExtWin.HDifTil[1].incAng.decAng.k,zon.roo.bouConExtWin.HDirTil[1].incAng.decAng.k,zon.roo.bouConExt.HDifTil[4].incAng.decAng.k,zon.roo.bouConExt.HDifTil[3].incAng.decAng.k,zon.roo.bouConExt.HDifTil[2].incAng.decAng.k,zon.roo.bouConExt.HDifTil[1].incAng.decAng.k,zon.roo.bouConExt.HDirTil[4].incAng.decAng.k,zon.roo.bouConExt.HDirTil[3].incAng.decAng.k,zon.roo.bouConExt.HDirTil[2].incAng.decAng.k,zon.roo.bouConExt.HDirTil[1].incAng.decAng.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1070):
 * Single equations (assignments): 1001
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 4
 * When equations: 49
 * 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,25,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.007688/4.414, allocations: 2.537 MB / 2.445 GB, free: 148.6 MB / 1.479 GB
Notification: Performance of simCode: created initialization part: time 0.06661/4.481, allocations: 38.28 MB / 2.483 GB, free: 111.5 MB / 1.479 GB
Notification: Performance of simCode: created event and clocks part: time 1.644e-05/4.481, allocations: 5.812 kB / 2.483 GB, free: 111.5 MB / 1.479 GB
Notification: Performance of simCode: created simulation system equations: time 0.01433/4.495, allocations: 8.4 MB / 2.491 GB, free: 103.2 MB / 1.479 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05236/4.548, allocations: 12.77 MB / 2.503 GB, free: 90.78 MB / 1.479 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1329/4.681, allocations: 68.03 MB / 2.57 GB, free: 22.5 MB / 1.479 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.03206/4.713, allocations: 10.46 MB / 2.58 GB, free: 12 MB / 1.479 GB
Notification: Performance of simCode: alias equations: time 0.03224/4.745, allocations: 5.57 MB / 2.585 GB, free: 6.426 MB / 1.479 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.03021/4.775, allocations: 9.207 MB / 2.594 GB, free: 13.21 MB / 1.495 GB
Notification: Performance of SimCode: time 1.753e-06/4.775, allocations: 0 / 2.594 GB, free: 13.21 MB / 1.495 GB
Notification: Performance of Templates: time 2.836/7.611, allocations: 0.7271 GB / 3.321 GB, free: 407.1 MB / 1.573 GB
"
[Timeout remaining time 292]
make -j1 -f Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.pipe ; mkfifo Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.pipe ; head -c 1048576 < Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.pipe >> ../files/Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.sim & ./Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.pipe 2>&1) [Timeout 240]
diffSimulationResults("Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Utilities_Plotters_Examples_SingleZoneVAV.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 27.205761302262545]