Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.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.002787/0.002787, allocations: 80.52 kB / 19.95 MB, free: 4.602 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.00334/0.00334, allocations: 173.6 kB / 23.24 MB, free: 1.324 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.537/1.537, allocations: 177.1 MB / 203.5 MB, free: 5.719 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 3.195/3.195, allocations: 389.5 MB / 0.6343 GB, free: 12.61 MB / 0.6042 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone")
translateModel(Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.372e-06/1.372e-06, allocations: 0 / 1.001 GB, free: 13 MB / 0.9636 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.982e-05/3.119e-05, allocations: 6.281 kB / 1.001 GB, free: 13 MB / 0.9636 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone): time 1.28/1.28, allocations: 0.5373 GB / 1.538 GB, free: 4.414 MB / 1.37 GB
Notification: Performance of NFInst.instExpressions: time 1.073/2.353, allocations: 104 MB / 1.64 GB, free: 27.09 MB / 1.401 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04147/2.395, allocations: 0.9284 MB / 1.641 GB, free: 27.09 MB / 1.401 GB
Notification: Performance of NFTyping.typeComponents: time 0.04284/2.437, allocations: 13.53 MB / 1.654 GB, free: 26.8 MB / 1.401 GB
Notification: Performance of NFTyping.typeBindings: time 0.08087/2.518, allocations: 23.54 MB / 1.677 GB, free: 23.64 MB / 1.401 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05404/2.572, allocations: 18.45 MB / 1.695 GB, free: 22.77 MB / 1.401 GB
Notification: Performance of NFFlatten.flatten: time 0.1284/2.701, allocations: 75.73 MB / 1.769 GB, free: 0.6367 MB / 1.401 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.06199/2.763, allocations: 25.78 MB / 1.794 GB, free: 44 kB / 1.417 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1271/2.89, allocations: 38.47 MB / 1.832 GB, free: 9.668 MB / 1.448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.06263/2.952, allocations: 24.9 MB / 1.856 GB, free: 1.902 MB / 1.464 GB
Notification: Performance of NFPackage.collectConstants: time 0.02314/2.976, allocations: 4.496 MB / 1.861 GB, free: 13.4 MB / 1.479 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.06493/3.04, allocations: 17.42 MB / 1.878 GB, free: 13.41 MB / 1.495 GB
Notification: Performance of NFScalarize.scalarize: time 0.03595/3.076, allocations: 14.31 MB / 1.892 GB, free: 15.55 MB / 1.51 GB
Notification: Performance of NFVerifyModel.verify: time 0.05474/3.131, allocations: 13.34 MB / 1.905 GB, free: 2.609 MB / 1.51 GB
Notification: Performance of NFConvertDAE.convert: time 0.1707/3.302, allocations: 81.95 MB / 1.985 GB, free: 3.211 MB / 1.589 GB
Notification: Performance of FrontEnd - DAE generated: time 8.245e-06/3.302, allocations: 0 / 1.985 GB, free: 3.211 MB / 1.589 GB
Notification: Performance of FrontEnd: time 1.743e-06/3.302, allocations: 0 / 1.985 GB, free: 3.211 MB / 1.589 GB
Notification: Performance of Transformations before backend: time 0.002397/3.304, allocations: 0 / 1.985 GB, free: 3.211 MB / 1.589 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3738
 * Number of variables: 3738
Notification: Performance of Generate backend data structure: time 0.2079/3.512, allocations: 55.36 MB / 2.039 GB, free: 11.89 MB / 1.651 GB
Notification: Performance of prepare preOptimizeDAE: time 5.561e-05/3.512, allocations: 12.03 kB / 2.039 GB, free: 11.88 MB / 1.651 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.097/3.609, allocations: 19.75 MB / 2.058 GB, free: 8.102 MB / 1.667 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1425/3.752, allocations: 54.9 MB / 2.112 GB, free: 1.996 MB / 1.714 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.003387/3.755, allocations: 2.429 MB / 2.114 GB, free: 15.31 MB / 1.729 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01238/3.767, allocations: 1.692 MB / 2.116 GB, free: 13.62 MB / 1.729 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1157/3.883, allocations: 35.94 MB / 2.151 GB, free: 8.832 MB / 1.76 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0008274/3.884, allocations: 26.06 kB / 2.151 GB, free: 8.82 MB / 1.76 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.009662/3.894, allocations: 0.5997 MB / 2.151 GB, free: 8.227 MB / 1.76 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008333/3.894, allocations: 0.5349 MB / 2.152 GB, free: 7.691 MB / 1.76 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1163/4.011, allocations: 39.62 MB / 2.191 GB, free: 148 kB / 1.792 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 1.642/5.652, allocations: 122.1 MB / 2.31 GB, free: 0.7583 GB / 1.839 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.06647/5.719, allocations: 24.68 MB / 2.334 GB, free: 0.7515 GB / 1.839 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03725/5.756, allocations: 15.58 MB / 2.349 GB, free: 0.7476 GB / 1.839 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.1608/5.917, allocations: 51.52 MB / 2.399 GB, free: 0.726 GB / 1.839 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03668/5.954, allocations: 17.52 MB / 2.416 GB, free: 0.7163 GB / 1.839 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0203/5.974, allocations: 1.429 MB / 2.418 GB, free: 0.7158 GB / 1.839 GB
Notification: Performance of pre-optimization done (n=1043): time 9.091e-05/5.974, allocations: 0 / 2.418 GB, free: 0.7158 GB / 1.839 GB
Notification: Performance of matching and sorting (n=1049): time 0.3908/6.365, allocations: 122 MB / 2.537 GB, free: 0.5985 GB / 1.839 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0005747/6.365, allocations: 0.894 MB / 2.538 GB, free: 0.5975 GB / 1.839 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1442/6.51, allocations: 59.33 MB / 2.596 GB, free: 0.5397 GB / 1.839 GB
Notification: Performance of collectPreVariables (initialization): time 0.007868/6.517, allocations: 413.6 kB / 2.596 GB, free: 0.5393 GB / 1.839 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0301/6.547, allocations: 13.47 MB / 2.609 GB, free: 0.5262 GB / 1.839 GB
Notification: Performance of collectInitialBindings (initialization): time 0.008294/6.556, allocations: 3.684 MB / 2.613 GB, free: 0.5227 GB / 1.839 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.03196/6.588, allocations: 7.165 MB / 2.62 GB, free: 0.5157 GB / 1.839 GB
Notification: Performance of setup shared object (initialization): time 6.282e-05/6.588, allocations: 305.1 kB / 2.62 GB, free: 0.5154 GB / 1.839 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.06303/6.651, allocations: 47.94 MB / 2.667 GB, free: 479.9 MB / 1.839 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0692/6.72, allocations: 56.29 MB / 2.722 GB, free: 421.4 MB / 1.839 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.
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: cooCoi[1].heaCooHum_u.vol.dynBal.medium.p = cooCoi[1].heaCooHum_u.vol.dynBal.p_start (fan[1].vol.dynBal.p_start = cooCoi[1].heaCooHum_u.vol.dynBal.p_start)
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 0.4689/7.189, allocations: 240 MB / 2.956 GB, free: 181.3 MB / 1.839 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002106/7.189, allocations: 28 kB / 2.956 GB, free: 181.3 MB / 1.839 GB
Notification: Performance of matching and sorting (n=2770) (initialization): time 0.1713/7.36, allocations: 106.8 MB / 3.061 GB, free: 74.35 MB / 1.839 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0005032/7.361, allocations: 201.7 kB / 3.061 GB, free: 74.14 MB / 1.839 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.9562/8.317, allocations: 81.57 MB / 3.141 GB, free: 0.7654 GB / 1.839 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01443/8.332, allocations: 5.99 MB / 3.147 GB, free: 0.7653 GB / 1.839 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02993/8.362, allocations: 5.854 MB / 3.152 GB, free: 0.7653 GB / 1.839 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02394/8.385, allocations: 21.06 MB / 3.173 GB, free: 0.7547 GB / 1.839 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04395/8.429, allocations: 4.406 MB / 3.177 GB, free: 0.7547 GB / 1.839 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.009386/8.439, allocations: 0.7409 MB / 3.178 GB, free: 0.7547 GB / 1.839 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization system:
         cooCoi[1].UAFroRated.TAirIn = 293.15
         cooCoi[1].UAFroRated.TWatIn = 293.15
         cooCoi[1].heaCooHum_u.vol.dynBal.medium.p = cooCoi[1].heaCooHum_u.vol.dynBal.p_start
         fanRet[1].vol.dynBal.medium.p = fanRet[1].vol.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1239/8.563, allocations: 65.32 MB / 3.242 GB, free: 0.7345 GB / 1.839 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.07574/8.638, allocations: 56.01 MB / 3.296 GB, free: 0.7112 GB / 1.839 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.
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: cooCoi[1].heaCooHum_u.vol.dynBal.medium.p = cooCoi[1].heaCooHum_u.vol.dynBal.p_start (fan[1].vol.dynBal.p_start = cooCoi[1].heaCooHum_u.vol.dynBal.p_start)
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 0.4996/9.138, allocations: 238.3 MB / 3.529 GB, free: 495.6 MB / 1.839 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0002255/9.138, allocations: 28 kB / 3.529 GB, free: 495.6 MB / 1.839 GB
Notification: Performance of matching and sorting (n=2770) (initialization_lambda0): time 0.1788/9.317, allocations: 108.5 MB / 3.635 GB, free: 388.5 MB / 1.839 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003575/9.317, allocations: 205.5 kB / 3.635 GB, free: 388.3 MB / 1.839 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.1391/9.457, allocations: 83.1 MB / 3.716 GB, free: 305.1 MB / 1.839 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01438/9.471, allocations: 5.785 MB / 3.722 GB, free: 299.2 MB / 1.839 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02981/9.501, allocations: 5.791 MB / 3.728 GB, free: 293.4 MB / 1.839 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04687/9.548, allocations: 45 MB / 3.772 GB, free: 247.7 MB / 1.839 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04133/9.589, allocations: 4.512 MB / 3.776 GB, free: 243.2 MB / 1.839 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008913/9.598, allocations: 0.7198 MB / 3.777 GB, free: 242.5 MB / 1.839 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         cooCoi[1].UAFroRated.TAirIn = 293.15
         cooCoi[1].UAFroRated.TWatIn = 293.15
         cooCoi[1].heaCooHum_u.vol.dynBal.medium.p = cooCoi[1].heaCooHum_u.vol.dynBal.p_start
         fanRet[1].vol.dynBal.medium.p = fanRet[1].vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 417
 * Number of states: 0 ()
 * Number of discrete variables: 231 (cooCoi[1].UAFroRated.isFulWet,cooCoi[1].UAFroRated.isFulDry,$PRE.modeSelector[1].start.enableFire,$PRE.modeSelector[1].t2.enableFire,$PRE.modeSelector[1].t1.enableFire,$PRE.modeSelector[1].t6.enableFire,$PRE.modeSelector[1].t5.enableFire,$PRE.modeSelector[1].t3.enableFire,$PRE.modeSelector[1].t4.enableFire,$PRE.modeSelector[1].t7.enableFire,$PRE.modeSelector[1].t9.enableFire,$PRE.modeSelector[1].t8.enableFire,modeSelector[1].t8.t_start,$PRE.modeSelector[1].t8.t_start,modeSelector[1].t9.t_start,$PRE.modeSelector[1].t9.t_start,modeSelector[1].t7.t_start,$PRE.modeSelector[1].t7.t_start,modeSelector[1].t4.t_start,$PRE.modeSelector[1].t4.t_start,modeSelector[1].t3.t_start,$PRE.modeSelector[1].t3.t_start,modeSelector[1].t5.t_start,$PRE.modeSelector[1].t5.t_start,modeSelector[1].start.t_start,$PRE.modeSelector[1].start.t_start,$PRE.TSetCoo1.nextTimeEvent,$whenCondition13,$PRE.TSetHea.nextTimeEvent,$whenCondition12,$PRE.buiZon.theZon[1,1].intLoad.nextTimeEvent,$whenCondition3,modeSelector[1].stateGraphRoot.resume,modeSelector[1].stateGraphRoot.suspend,modeSelector[1].start.condition,conEco[1].conV_flow.con1.y,vavTer[1,1].con.conCoo.con1.y,vavTer[1,1].con.conHea.con1.y,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,cooCoi[1].flowRegime_nominal,hex[1].flowRegime_nominal,buiZon.theZon[1,1].roo.solRadExc.is_flo[10],buiZon.theZon[1,1].roo.solRadExc.is_flo[9],buiZon.theZon[1,1].roo.solRadExc.is_flo[8],buiZon.theZon[1,1].roo.solRadExc.is_flo[7],buiZon.theZon[1,1].roo.solRadExc.is_flo[6],buiZon.theZon[1,1].roo.solRadExc.is_flo[5],buiZon.theZon[1,1].roo.solRadExc.is_flo[4],buiZon.theZon[1,1].roo.solRadExc.is_flo[3],buiZon.theZon[1,1].roo.solRadExc.is_flo[2],buiZon.theZon[1,1].roo.solRadExc.is_flo[1],vavTer[1,1].terHea.flowRegime_nominal,vavTer[1,1].vav.idx_sorted[13],vavTer[1,1].vav.idx_sorted[12],vavTer[1,1].vav.idx_sorted[11],vavTer[1,1].vav.idx_sorted[10],vavTer[1,1].vav.idx_sorted[9],vavTer[1,1].vav.idx_sorted[8],vavTer[1,1].vav.idx_sorted[7],vavTer[1,1].vav.idx_sorted[6],vavTer[1,1].vav.idx_sorted[5],vavTer[1,1].vav.idx_sorted[4],vavTer[1,1].vav.idx_sorted[3],vavTer[1,1].vav.idx_sorted[2],vavTer[1,1].vav.idx_sorted[1],$PRE.vavTer[1,1].con.hysWitHol.y,$PRE.buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.k,$PRE.buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.k,$PRE.modeSelector[1].initialStepWithSignal.localActive,$PRE.modeSelector[1].initialStepWithSignal.newActive,$PRE.modeSelector[1].initialStepWithSignal.oldActive,$PRE.modeSelector[1].unOccOff.localActive,$PRE.modeSelector[1].unOccOff.newActive,$PRE.modeSelector[1].unOccOff.oldActive,$PRE.modeSelector[1].unOccNigSetBac.localActive,$PRE.modeSelector[1].unOccNigSetBac.newActive,$PRE.modeSelector[1].unOccNigSetBac.oldActive,$PRE.modeSelector[1].t2.t_start,$PRE.modeSelector[1].t1.t_start,$PRE.modeSelector[1].morWarUp.localActive,$PRE.modeSelector[1].morWarUp.newActive,$PRE.modeSelector[1].morWarUp.oldActive,$PRE.modeSelector[1].t6.t_start,$PRE.modeSelector[1].occ.localActive,$PRE.modeSelector[1].occ.newActive,$PRE.modeSelector[1].occ.oldActive,$PRE.modeSelector[1].morPreCoo.localActive,$PRE.modeSelector[1].morPreCoo.newActive,$PRE.modeSelector[1].morPreCoo.oldActive,$PRE.conEco[1].hysLoc.y,$PRE.weaDat.locTim.tNext,$PRE.weaDat.locTim.k,$PRE.weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.k,$PRE.weaDat.conTim.tNext,$PRE.weaDat.conTim.k,$PRE.weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.k,$PRE.weaDat.decAng.tNext,$PRE.weaDat.decAng.k,$PRE.occSch.occupied,$PRE.occSch.tOcc,$PRE.occSch.tNonOcc,$PRE.occSch.tNext,vavTer[1,1].con.hysWitHol.y,vavTer[1,1].con.greThr.y,buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.k,buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.k,buiZon.theZon[1,1].intLoad.nextTimeEvent,buiZon.theZon[1,1].intLoad.nextTimeEventScaled,$PRE.buiZon.theZon[1,1].intLoad.nextTimeEventScaled,modeSelector[1].initialStepWithSignal.localActive,modeSelector[1].initialStepWithSignal.newActive,modeSelector[1].initialStepWithSignal.oldActive,modeSelector[1].initialStepWithSignal.active,modeSelector[1].start.enableFire,modeSelector[1].unOccOff.localActive,modeSelector[1].unOccOff.outPort[2].available,modeSelector[1].unOccOff.outPort[3].available,modeSelector[1].unOccOff.outPort[4].available,modeSelector[1].unOccOff.newActive,modeSelector[1].unOccOff.oldActive,modeSelector[1].unOccOff.active,modeSelector[1].unOccOff.y,modeSelector[1].unOccNigSetBac.localActive,modeSelector[1].unOccNigSetBac.outPort[2].available,modeSelector[1].unOccNigSetBac.newActive,modeSelector[1].unOccNigSetBac.oldActive,modeSelector[1].unOccNigSetBac.active,modeSelector[1].unOccNigSetBac.y,modeSelector[1].t2.localCondition,modeSelector[1].t2.enableFire,modeSelector[1].t2.fire,modeSelector[1].t2.t_start,modeSelector[1].t1.localCondition,modeSelector[1].t1.enableFire,modeSelector[1].t1.fire,modeSelector[1].t1.outPort.occupied,modeSelector[1].t1.t_start,modeSelector[1].stateGraphRoot.activeSteps,modeSelector[1].morWarUp.localActive,modeSelector[1].morWarUp.newActive,modeSelector[1].morWarUp.oldActive,modeSelector[1].morWarUp.active,modeSelector[1].morWarUp.y,modeSelector[1].t6.enableFire,modeSelector[1].t6.fire,modeSelector[1].t6.t_start,modeSelector[1].t5.localCondition,modeSelector[1].t5.enableFire,modeSelector[1].t5.outPort.occupied,modeSelector[1].occ.localActive,modeSelector[1].occ.newActive,modeSelector[1].occ.oldActive,modeSelector[1].occ.active,modeSelector[1].occ.y,modeSelector[1].t3.localCondition,modeSelector[1].t3.enableFire,modeSelector[1].t4.localCondition,modeSelector[1].t4.enableFire,modeSelector[1].t4.outPort.occupied,modeSelector[1].morPreCoo.localActive,modeSelector[1].morPreCoo.newActive,modeSelector[1].morPreCoo.oldActive,modeSelector[1].morPreCoo.active,modeSelector[1].morPreCoo.y,modeSelector[1].t7.localCondition,modeSelector[1].t7.enableFire,modeSelector[1].t7.outPort.occupied,modeSelector[1].preCooSta.greater.y,modeSelector[1].preCooSta.greater2.y,modeSelector[1].preCooSta.greater1.y,modeSelector[1].t9.localCondition,modeSelector[1].t9.enableFire,modeSelector[1].not1.y,modeSelector[1].t8.enableFire,modeSelector[1].t8.outPort.occupied,modeSelector[1].yFan,modeSelector[1].yEco,modeSelector[1].or2.y,modeSelector[1].modIni.y,conEco[1].hysLoc.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,TSetHea.nextTimeEvent,TSetHea.nextTimeEventScaled,$PRE.TSetHea.nextTimeEventScaled,TSetCoo1.nextTimeEvent,TSetCoo1.nextTimeEventScaled,$PRE.TSetCoo1.nextTimeEventScaled,occSch.occupied,occSch.tOcc,occSch.tNonOcc,occSch.tNext,fan_dP_On_Off[1].extractor.index,$PRE.fan_dP_On_Off[1].extractor.index,fan_dP_On_Off[1].extractor.k[1],fan_dP_On_Off[1].extractor.k[2],fan_dP_On_Off[1].extractor.k[3],fan_dP_On_Off[1].extractor.k[4],fan_dP_On_Off[1].extractor.k[5],fan_dP_On_Off[1].extractor.k[6],$whenCondition1,$whenCondition2,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition14,$whenCondition15,$whenCondition16,conTSup[1].con.cheYMinMax.y,buiZon.theZon[1,1].intECoo.local_reset,buiZon.theZon[1,1].intEHea.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1920):
 * Single equations (assignments): 1862
 * Array equations: 44
 * Algorithm blocks: 1
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 10
 * 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): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,3,100.0%), (1,4,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(1,1), (1,3), (14,55), (1,2), (2,11), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.01651/9.614, allocations: 1.465 MB / 3.778 GB, free: 241 MB / 1.839 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01477/9.629, allocations: 2.546 MB / 3.781 GB, free: 239.9 MB / 1.839 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.09693/9.726, allocations: 34.85 MB / 3.815 GB, free: 205 MB / 1.839 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001708/9.726, allocations: 108 kB / 3.815 GB, free: 204.9 MB / 1.839 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.173e-05/9.726, allocations: 4 kB / 3.815 GB, free: 204.9 MB / 1.839 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.07123/9.798, allocations: 29.21 MB / 3.843 GB, free: 175.5 MB / 1.839 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1705/9.968, allocations: 65.44 MB / 3.907 GB, free: 109.8 MB / 1.839 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001992/9.968, allocations: 4 kB / 3.907 GB, free: 109.8 MB / 1.839 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.02335/9.992, allocations: 3.698 MB / 3.911 GB, free: 106.1 MB / 1.839 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01536/10.01, allocations: 4.875 MB / 3.916 GB, free: 101.2 MB / 1.839 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006352/10.01, allocations: 355.7 kB / 3.916 GB, free: 100.9 MB / 1.839 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01863/10.03, allocations: 19.98 MB / 3.935 GB, free: 80.18 MB / 1.839 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.05e-06/10.03, allocations: 11.94 kB / 3.935 GB, free: 80.17 MB / 1.839 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1168/10.15, allocations: 51.98 MB / 3.986 GB, free: 28.49 MB / 1.839 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02654/10.18, allocations: 8.783 MB / 3.995 GB, free: 19.67 MB / 1.839 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01372/10.19, allocations: 316.9 kB / 3.995 GB, free: 19.36 MB / 1.839 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02768/10.22, allocations: 3.108 MB / 3.998 GB, free: 16.25 MB / 1.839 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.004534/10.22, allocations: 0.8932 MB / 3.999 GB, free: 15.36 MB / 1.839 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00408/10.23, allocations: 411.7 kB / 3.999 GB, free: 14.95 MB / 1.839 GB
Notification: Performance of sorting global known variables: time 0.8881/11.11, allocations: 41 MB / 4.039 GB, free: 0.7502 GB / 1.839 GB
Notification: Performance of sort global known variables: time 2.61e-07/11.11, allocations: 1.219 kB / 4.039 GB, free: 0.7502 GB / 1.839 GB
Notification: Performance of remove unused functions: time 0.08258/11.2, allocations: 13.19 MB / 4.052 GB, free: 0.7495 GB / 1.839 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 21
 * Number of states: 46 (conTSup[1].con.I.y,conFanRet[1].con.I.y,conEco[1].conV_flow.I.y,TSup[1].T,TCoiHeaOut[1].T,valCoo[1].actPos.y,valHea[1].actPos.y,fanRet[1].motSpe.y,fanRet[1].vol.dynBal.U,fanRet[1].vol.dynBal.medium.Xi[1],TRet[1].T,TMix[1].T,eco[1].actPos.y,cooCoi[1].dryWetCalcs.fullyWet.TWatOutEst,cooCoi[1].heaCooHum_u.vol.dynBal.U,cooCoi[1].heaCooHum_u.vol.dynBal.medium.Xi[1],cooCoi[1].heaCoo.vol.dynBal.U,fan[1].motSpe.y,fan[1].vol.dynBal.m,fan[1].vol.dynBal.U,fan[1].vol.dynBal.medium.Xi[1],buiZon.theZon[1,1].intECoo.y,buiZon.theZon[1,1].intEHea.y,buiZon.theZon[1,1].roo.air.vol.dynBal.m,buiZon.theZon[1,1].roo.air.vol.dynBal.U,buiZon.theZon[1,1].roo.air.vol.dynBal.medium.Xi[1],buiZon.theZon[1,1].roo.conBou[2].opa.lay[1].T[2],buiZon.theZon[1,1].roo.conBou[2].opa.lay[1].T[1],buiZon.theZon[1,1].roo.conBou[1].opa.lay[1].T[2],buiZon.theZon[1,1].roo.conBou[1].opa.lay[1].T[1],buiZon.theZon[1,1].roo.conPar[1].opa.lay[1].T[2],buiZon.theZon[1,1].roo.conPar[1].opa.lay[1].T[1],buiZon.theZon[1,1].roo.conExtWin[1].win.capFra.T,buiZon.theZon[1,1].roo.conExtWin[1].win.capGla.TUns,buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[3].T[2],buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[3].T[1],buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[2].T[3],buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[2].T[2],buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[2].T[1],buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[1].T[2],buiZon.theZon[1,1].roo.conExtWin[1].opa.lay[1].T[1],vavTer[1,1].valHea.actPos.y,vavTer[1,1].TSup.T,vavTer[1,1].con.conCoo.I.y,vavTer[1,1].con.conHea.I.y,vavTer[1,1].vav.actPos.y)
 * Number of discrete variables: 127 (modeSelector[1].t6.enableFire,modeSelector[1].t2.enableFire,modeSelector[1].t1.enableFire,modeSelector[1].yFan,modeSelector[1].morPreCoo.active,modeSelector[1].occ.active,modeSelector[1].morWarUp.active,modeSelector[1].unOccNigSetBac.active,modeSelector[1].unOccOff.active,modeSelector[1].initialStepWithSignal.active,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,fan_dP_On_Off[1].extractor.k[6],fan_dP_On_Off[1].extractor.k[5],fan_dP_On_Off[1].extractor.k[4],fan_dP_On_Off[1].extractor.k[3],fan_dP_On_Off[1].extractor.k[2],fan_dP_On_Off[1].extractor.k[1],fan_dP_On_Off[1].extractor.index,occSch.tNext,occSch.tNonOcc,occSch.tOcc,occSch.occupied,TSetCoo1.nextTimeEventScaled,TSetCoo1.nextTimeEvent,TSetHea.nextTimeEventScaled,TSetHea.nextTimeEvent,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,conEco[1].hysLoc.y,modeSelector[1].modIni.y,modeSelector[1].or2.y,modeSelector[1].yEco,modeSelector[1].t8.outPort.occupied,modeSelector[1].t8.enableFire,modeSelector[1].not1.y,modeSelector[1].t9.enableFire,modeSelector[1].t9.localCondition,modeSelector[1].preCooSta.greater1.y,modeSelector[1].preCooSta.greater2.y,modeSelector[1].preCooSta.greater.y,modeSelector[1].t7.outPort.occupied,modeSelector[1].t7.enableFire,modeSelector[1].t7.localCondition,modeSelector[1].morPreCoo.y,modeSelector[1].morPreCoo.oldActive,modeSelector[1].morPreCoo.newActive,modeSelector[1].morPreCoo.localActive,modeSelector[1].t4.outPort.occupied,modeSelector[1].t4.enableFire,modeSelector[1].t4.localCondition,modeSelector[1].t3.enableFire,modeSelector[1].t3.localCondition,modeSelector[1].occ.y,modeSelector[1].occ.oldActive,modeSelector[1].occ.newActive,modeSelector[1].occ.localActive,modeSelector[1].t5.outPort.occupied,modeSelector[1].t5.enableFire,modeSelector[1].t5.localCondition,modeSelector[1].t6.t_start,modeSelector[1].t6.fire,modeSelector[1].morWarUp.y,modeSelector[1].morWarUp.oldActive,modeSelector[1].morWarUp.newActive,modeSelector[1].morWarUp.localActive,modeSelector[1].stateGraphRoot.activeSteps,modeSelector[1].t1.t_start,modeSelector[1].t1.outPort.occupied,modeSelector[1].t1.fire,modeSelector[1].t1.localCondition,modeSelector[1].t2.t_start,modeSelector[1].t2.fire,modeSelector[1].t2.localCondition,modeSelector[1].unOccNigSetBac.y,modeSelector[1].unOccNigSetBac.oldActive,modeSelector[1].unOccNigSetBac.newActive,modeSelector[1].unOccNigSetBac.outPort[2].available,modeSelector[1].unOccNigSetBac.localActive,modeSelector[1].unOccOff.y,modeSelector[1].unOccOff.oldActive,modeSelector[1].unOccOff.newActive,modeSelector[1].unOccOff.outPort[4].available,modeSelector[1].unOccOff.outPort[3].available,modeSelector[1].unOccOff.outPort[2].available,modeSelector[1].unOccOff.localActive,modeSelector[1].start.enableFire,modeSelector[1].initialStepWithSignal.oldActive,modeSelector[1].initialStepWithSignal.newActive,modeSelector[1].initialStepWithSignal.localActive,buiZon.theZon[1,1].intLoad.nextTimeEventScaled,buiZon.theZon[1,1].intLoad.nextTimeEvent,buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.k,buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.k,buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,vavTer[1,1].con.greThr.y,vavTer[1,1].con.hysWitHol.y,modeSelector[1].start.t_start,modeSelector[1].t5.t_start,modeSelector[1].t3.t_start,modeSelector[1].t4.t_start,modeSelector[1].t7.t_start,modeSelector[1].t9.t_start,modeSelector[1].t8.t_start)
 * Number of discrete states: 37 (modeSelector[1].t8.t_start,modeSelector[1].t9.t_start,modeSelector[1].t7.t_start,modeSelector[1].t4.t_start,modeSelector[1].t3.t_start,modeSelector[1].t5.t_start,modeSelector[1].start.t_start,occSch.tNext,TSetCoo1.nextTimeEvent,TSetHea.nextTimeEvent,buiZon.theZon[1,1].intLoad.nextTimeEvent,modeSelector[1].initialStepWithSignal.newActive,modeSelector[1].unOccOff.newActive,modeSelector[1].unOccNigSetBac.newActive,modeSelector[1].morWarUp.newActive,modeSelector[1].occ.newActive,modeSelector[1].morPreCoo.newActive,fan_dP_On_Off[1].extractor.index,buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.locTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext,TSetCoo1.nextTimeEventScaled,TSetHea.nextTimeEventScaled,vavTer[1,1].con.hysWitHol.y,weaDat.decAng.k,weaDat.eqnTim.k,weaDat.conTim.k,conEco[1].hysLoc.y,weaDat.conTimMin.k,weaDat.locTim.k,buiZon.theZon[1,1].intLoad.nextTimeEventScaled,buiZon.theZon[1,1].roo.bouConExtWin.HDifTil[1].incAng.decAng.k,buiZon.theZon[1,1].roo.bouConExtWin.HDirTil[1].incAng.decAng.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1017):
 * Single equations (assignments): 957
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 6
 * When equations: 43
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 10
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 5 systems
   {(1,2,100.0%), (1,3,100.0%), (1,1,100.0%), (1,1,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 5 systems
   {(1,2), (1,1), (2,12), (12,37), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01637/11.21, allocations: 3.282 MB / 4.055 GB, free: 0.7491 GB / 1.839 GB
Notification: Performance of simCode: created initialization part: time 0.2101/11.42, allocations: 119.3 MB / 4.172 GB, free: 0.7064 GB / 1.839 GB
Notification: Performance of simCode: created event and clocks part: time 3.34e-05/11.42, allocations: 5.969 kB / 4.172 GB, free: 0.7064 GB / 1.839 GB
Notification: Performance of simCode: created simulation system equations: time 0.04128/11.46, allocations: 17.46 MB / 4.189 GB, free: 0.6929 GB / 1.839 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0809/11.54, allocations: 10.76 MB / 4.2 GB, free: 0.6852 GB / 1.839 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2226/11.77, allocations: 93.48 MB / 4.291 GB, free: 0.5993 GB / 1.839 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0717/11.84, allocations: 25.57 MB / 4.316 GB, free: 0.5746 GB / 1.839 GB
Notification: Performance of simCode: alias equations: time 0.06662/11.91, allocations: 19.47 MB / 4.335 GB, free: 0.556 GB / 1.839 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01896/11.92, allocations: 1.691 MB / 4.337 GB, free: 0.5543 GB / 1.839 GB
Notification: Performance of SimCode: time 2.124e-06/11.92, allocations: 0 / 4.337 GB, free: 0.5543 GB / 1.839 GB
Notification: Performance of Templates: time 1.556/13.48, allocations: 0.6056 GB / 4.942 GB, free: 0.6918 GB / 1.839 GB
"
[Timeout remaining time 287]
make -j1 -f Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.pipe ; mkfifo Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.pipe ; head -c 1048576 < Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.pipe >> ../files/Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.sim & ./Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Examples.ScalableBenchmarks.BuildingVAV.Examples.OneFloor_OneZone.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 44.39294685982168]