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.00121/0.00121, allocations: 80.44 kB / 19.17 MB, free: 0.7422 MB / 13.93 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.0008685/0.0008685, allocations: 169.9 kB / 22.45 MB, free: 2.109 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 0.8944/0.8944, allocations: 177.1 MB / 202.8 MB, free: 5.734 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 1.784/1.784, allocations: 389 MB / 0.633 GB, free: 12.7 MB / 0.6042 GB
"
[Timeout remaining time 178]
Using package Buildings with version 13.0.1 (/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: "" <> buildModelFMU(Buildings.Utilities.Plotters.Examples.SingleZoneVAV,fileNamePrefix="Buildings_latest_Buildings_Utilities_Plotters_Examples_SingleZoneVAV",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Utilities.Plotters.Examples.SingleZoneVAV,fileNamePrefix="Buildings_latest_Buildings_Utilities_Plotters_Examples_SingleZoneVAV",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.292e-06/1.292e-06, allocations: 0 / 0.9997 GB, free: 13.5 MB / 0.9636 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.075e-05/1.204e-05, allocations: 10.16 kB / 0.9997 GB, free: 13.48 MB / 0.9636 GB
Notification: Performance of NFInst.instantiate(Buildings.Utilities.Plotters.Examples.SingleZoneVAV): time 0.7225/0.7225, allocations: 450.1 MB / 1.439 GB, free: 9.32 MB / 1.276 GB
Notification: Performance of NFInst.instExpressions: time 0.1021/0.8246, allocations: 90.63 MB / 1.528 GB, free: 14.46 MB / 1.37 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01779/0.8424, allocations: 0.8176 MB / 1.529 GB, free: 13.64 MB / 1.37 GB
Notification: Performance of NFTyping.typeComponents: time 0.02337/0.8657, allocations: 12.35 MB / 1.541 GB, free: 1.23 MB / 1.37 GB
Notification: Performance of NFTyping.typeBindings: time 0.03564/0.9014, allocations: 18.05 MB / 1.558 GB, free: 15.1 MB / 1.401 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02419/0.9256, allocations: 15 MB / 1.573 GB, free: 148 kB / 1.401 GB
Notification: Performance of NFFlatten.flatten: time 0.6595/1.585, allocations: 82.1 MB / 1.653 GB, free: 37.77 MB / 1.401 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03756/1.623, allocations: 25.39 MB / 1.678 GB, free: 35.71 MB / 1.401 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.07309/1.696, allocations: 44.96 MB / 1.722 GB, free: 32.77 MB / 1.401 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04201/1.738, allocations: 26.28 MB / 1.747 GB, free: 26.08 MB / 1.401 GB
Notification: Performance of NFPackage.collectConstants: time 0.01514/1.753, allocations: 5.4 MB / 1.753 GB, free: 26.08 MB / 1.401 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02966/1.783, allocations: 15.16 MB / 1.767 GB, free: 23.85 MB / 1.401 GB
Notification: Performance of NFScalarize.scalarize: time 0.01886/1.801, allocations: 17.24 MB / 1.784 GB, free: 11.25 MB / 1.401 GB
Notification: Performance of NFVerifyModel.verify: time 0.0325/1.834, allocations: 17.12 MB / 1.801 GB, free: 11.03 MB / 1.417 GB
Notification: Performance of NFConvertDAE.convert: time 0.0952/1.929, allocations: 100.9 MB / 1.9 GB, free: 9.438 MB / 1.51 GB
Notification: Performance of FrontEnd - DAE generated: time 6.222e-06/1.929, allocations: 4 kB / 1.9 GB, free: 9.434 MB / 1.51 GB
Notification: Performance of FrontEnd: time 1.943e-06/1.929, allocations: 1.094 kB / 1.9 GB, free: 9.434 MB / 1.51 GB
Notification: Performance of Transformations before backend: time 0.002027/1.931, allocations: 0 / 1.9 GB, free: 9.434 MB / 1.51 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.1249/2.056, allocations: 58.49 MB / 1.957 GB, free: 15.16 MB / 1.573 GB
Notification: Performance of prepare preOptimizeDAE: time 4.732e-05/2.056, allocations: 12.03 kB / 1.957 GB, free: 15.14 MB / 1.573 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.006724/2.063, allocations: 2.188 MB / 1.959 GB, free: 12.95 MB / 1.573 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07897/2.142, allocations: 28.79 MB / 1.987 GB, free: 108 kB / 1.589 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.7549/2.897, allocations: 359 MB / 2.338 GB, free: 0.7332 GB / 1.823 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001841/2.898, allocations: 2.792 MB / 2.34 GB, free: 0.731 GB / 1.823 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007062/2.906, allocations: 1.911 MB / 2.342 GB, free: 0.7304 GB / 1.823 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06779/2.973, allocations: 39.68 MB / 2.381 GB, free: 0.7084 GB / 1.823 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004249/2.974, allocations: 39.62 kB / 2.381 GB, free: 0.7083 GB / 1.823 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005021/2.979, allocations: 0.6817 MB / 2.382 GB, free: 0.7077 GB / 1.823 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003491/2.979, allocations: 0.5982 MB / 2.382 GB, free: 0.7071 GB / 1.823 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07661/3.056, allocations: 46.49 MB / 2.428 GB, free: 0.6639 GB / 1.823 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.2336/3.289, allocations: 226.5 MB / 2.649 GB, free: 448.8 MB / 1.823 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03778/3.327, allocations: 25.57 MB / 2.674 GB, free: 423.5 MB / 1.823 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02828/3.355, allocations: 18.04 MB / 2.691 GB, free: 405.5 MB / 1.823 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.08721/3.443, allocations: 59.64 MB / 2.75 GB, free: 342.9 MB / 1.823 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03059/3.473, allocations: 20.22 MB / 2.769 GB, free: 322.2 MB / 1.823 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01444/3.488, allocations: 1.465 MB / 2.771 GB, free: 320.8 MB / 1.823 GB
Notification: Performance of pre-optimization done (n=1130): time 2.91e-05/3.488, allocations: 4 kB / 2.771 GB, free: 320.8 MB / 1.823 GB
Notification: Performance of matching and sorting (n=1136): time 0.1805/3.668, allocations: 94.69 MB / 2.863 GB, free: 225.8 MB / 1.823 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002127/3.668, allocations: 494.2 kB / 2.864 GB, free: 225.2 MB / 1.823 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.9141/4.583, allocations: 429.4 MB / 3.283 GB, free: 0.6385 GB / 1.823 GB
Notification: Performance of collectPreVariables (initialization): time 0.004402/4.587, allocations: 432.1 kB / 3.283 GB, free: 0.6381 GB / 1.823 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02109/4.608, allocations: 18.62 MB / 3.302 GB, free: 0.6236 GB / 1.823 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007523/4.616, allocations: 3.993 MB / 3.306 GB, free: 0.622 GB / 1.823 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.008739/4.624, allocations: 4.486 MB / 3.31 GB, free: 0.6183 GB / 1.823 GB
Notification: Performance of setup shared object (initialization): time 3.107e-05/4.624, allocations: 307.4 kB / 3.31 GB, free: 0.618 GB / 1.823 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0303/4.655, allocations: 22.39 MB / 3.332 GB, free: 0.6007 GB / 1.823 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0357/4.69, allocations: 30.31 MB / 3.362 GB, free: 0.5732 GB / 1.823 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.2806/4.971, allocations: 176.3 MB / 3.534 GB, free: 415.3 MB / 1.823 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001874/4.971, allocations: 48 kB / 3.534 GB, free: 415.3 MB / 1.823 GB
Notification: Performance of matching and sorting (n=2385) (initialization): time 0.08937/5.06, allocations: 55.23 MB / 3.588 GB, free: 361.9 MB / 1.823 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002477/5.061, allocations: 246.7 kB / 3.588 GB, free: 361.6 MB / 1.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.06595/5.127, allocations: 43.58 MB / 3.631 GB, free: 317.9 MB / 1.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008262/5.135, allocations: 4.953 MB / 3.635 GB, free: 312.9 MB / 1.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01977/5.155, allocations: 7.138 MB / 3.642 GB, free: 305.7 MB / 1.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02224/5.177, allocations: 39.15 MB / 3.681 GB, free: 265.2 MB / 1.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03121/5.208, allocations: 6.023 MB / 3.687 GB, free: 259.2 MB / 1.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004067/5.212, allocations: 0.9075 MB / 3.687 GB, free: 258.3 MB / 1.823 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.04853/5.261, allocations: 40.15 MB / 3.727 GB, free: 218.1 MB / 1.823 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03312/5.294, allocations: 30.28 MB / 3.756 GB, free: 184.9 MB / 1.823 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.8195/6.113, allocations: 175.8 MB / 3.928 GB, free: 0.7031 GB / 1.823 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001898/6.114, allocations: 46.94 kB / 3.928 GB, free: 0.7031 GB / 1.823 GB
Notification: Performance of matching and sorting (n=2385) (initialization_lambda0): time 0.1108/6.224, allocations: 55.85 MB / 3.983 GB, free: 0.6941 GB / 1.823 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003233/6.225, allocations: 241 kB / 3.983 GB, free: 0.694 GB / 1.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.07809/6.303, allocations: 44.23 MB / 4.026 GB, free: 0.6811 GB / 1.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008972/6.312, allocations: 4.746 MB / 4.031 GB, free: 0.6801 GB / 1.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02241/6.334, allocations: 7.133 MB / 4.038 GB, free: 0.6797 GB / 1.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03252/6.367, allocations: 50.08 MB / 4.086 GB, free: 0.6495 GB / 1.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0343/6.401, allocations: 6.07 MB / 4.092 GB, free: 0.6492 GB / 1.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004871/6.406, allocations: 0.8941 MB / 4.093 GB, free: 0.6491 GB / 1.823 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: 756
 * Number of states: 0 ()
 * Number of discrete variables: 194 (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,hvac.cooCoi.flowRegime_nominal,hvac.cooCoi.flowRegime,zon.roo.solRadExc.is_flo[11],zon.roo.solRadExc.is_flo[10],zon.roo.solRadExc.is_flo[9],zon.roo.solRadExc.is_flo[8],zon.roo.solRadExc.is_flo[7],zon.roo.solRadExc.is_flo[6],zon.roo.solRadExc.is_flo[5],zon.roo.solRadExc.is_flo[4],zon.roo.solRadExc.is_flo[3],zon.roo.solRadExc.is_flo[2],zon.roo.solRadExc.is_flo[1],$PRE.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.pre1.u,$PRE.con.conEco.hysTMix.y,$PRE.con.conEco.truFalHolTMix.entryTimeFalse,$PRE.con.conEco.truFalHolTMix.entryTimeTrue,$PRE.con.conEco.truFalHolTMix.not_y,$PRE.con.conEco.truFalHolTMix.not_u,$PRE.con.conEco.truFalHolTMix.y,$PRE.con.conEco.truFalHolTMix.u,$PRE.con.conEco.truFalHolCooPot.entryTimeFalse,$PRE.con.conEco.truFalHolCooPot.entryTimeTrue,$PRE.con.conEco.truFalHolCooPot.not_y,$PRE.con.conEco.truFalHolCooPot.not_u,$PRE.con.conEco.truFalHolCooPot.y,$PRE.con.conEco.truFalHolCooPot.u,$PRE.con.conEco.hysCooPot.y,$PRE.con.conEco.hysChiPla.y,$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,con.conEco.hysTMix.y,con.conEco.truFalHolTMix.entryTimeFalse,con.conEco.truFalHolTMix.entryTimeTrue,con.conEco.truFalHolTMix.not_y,con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.u,con.conEco.truFalHolCooPot.entryTimeFalse,con.conEco.truFalHolCooPot.entryTimeTrue,con.conEco.truFalHolCooPot.not_y,con.conEco.truFalHolCooPot.not_u,con.conEco.truFalHolCooPot.y,con.conEco.truFalHolCooPot.u,con.conEco.hysCooPot.y,con.conEco.not1.y,con.conEco.yCoiSta,con.conEco.hysChiPla.y,con.chiOn,weaDat.decAng.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 (2215):
 * Single equations (assignments): 2194
 * Array equations: 4
 * 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,43), (1,14)}
Notification: Performance of prepare postOptimizeDAE: time 0.004807/6.411, allocations: 1.598 MB / 4.095 GB, free: 0.6481 GB / 1.823 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01227/6.423, allocations: 3.783 MB / 4.098 GB, free: 0.6481 GB / 1.823 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.07041/6.493, allocations: 40.99 MB / 4.139 GB, free: 0.6196 GB / 1.823 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.251e-05/6.493, allocations: 108 kB / 4.139 GB, free: 0.6195 GB / 1.823 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.529e-05/6.493, allocations: 16 kB / 4.139 GB, free: 0.6195 GB / 1.823 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.05843/6.552, allocations: 34.5 MB / 4.172 GB, free: 0.5857 GB / 1.823 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.1419/6.694, allocations: 85.81 MB / 4.256 GB, free: 0.5005 GB / 1.823 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.786e-05/6.694, allocations: 8 kB / 4.256 GB, free: 0.5005 GB / 1.823 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0142/6.708, allocations: 4.955 MB / 4.261 GB, free: 0.4956 GB / 1.823 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005756/6.714, allocations: 3.247 MB / 4.264 GB, free: 0.4924 GB / 1.823 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002573/6.716, allocations: 427.6 kB / 4.265 GB, free: 0.492 GB / 1.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02265/6.739, allocations: 42.91 MB / 4.306 GB, free: 459.6 MB / 1.823 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.318e-06/6.739, allocations: 11.94 kB / 4.306 GB, free: 459.6 MB / 1.823 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.09122/6.83, allocations: 61.28 MB / 4.366 GB, free: 399.3 MB / 1.823 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02273/6.853, allocations: 12.22 MB / 4.378 GB, free: 387 MB / 1.823 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01106/6.864, allocations: 0.4977 MB / 4.379 GB, free: 386.5 MB / 1.823 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02486/6.889, allocations: 4.993 MB / 4.384 GB, free: 381.5 MB / 1.823 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002199/6.891, allocations: 0.8624 MB / 4.384 GB, free: 380.6 MB / 1.823 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001685/6.893, allocations: 474.8 kB / 4.385 GB, free: 380.2 MB / 1.823 GB
Notification: Performance of sorting global known variables: time 0.1824/7.075, allocations: 334.6 MB / 4.712 GB, free: 45.78 MB / 1.823 GB
Notification: Performance of sort global known variables: time 2.8e-07/7.075, allocations: 0 / 4.712 GB, free: 45.78 MB / 1.823 GB
Notification: Performance of remove unused functions: time 0.06366/7.139, allocations: 19.77 MB / 4.731 GB, free: 26.17 MB / 1.823 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.hysChiPla.y,con.conEco.hysTMix.y,con.conEco.truFalHolTMix.u,con.conEco.truFalHolTMix.not_u,con.conEco.truFalHolTMix.y,con.conEco.truFalHolTMix.not_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 (1073):
 * Single equations (assignments): 1004
 * 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,26,85.2%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,18,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,17), (1,16)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.6712/7.81, allocations: 64.89 MB / 4.794 GB, free: 0.711 GB / 1.823 GB
Notification: Performance of simCode: created initialization part: time 0.1195/7.929, allocations: 73.01 MB / 4.866 GB, free: 0.6888 GB / 1.823 GB
Notification: Performance of simCode: created event and clocks part: time 2e-05/7.93, allocations: 9.688 kB / 4.866 GB, free: 0.6888 GB / 1.823 GB
Notification: Performance of simCode: created simulation system equations: time 0.03356/7.963, allocations: 20.68 MB / 4.886 GB, free: 0.6821 GB / 1.823 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05296/8.016, allocations: 13.6 MB / 4.899 GB, free: 0.6779 GB / 1.823 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 5.717/13.73, allocations: 1.925 GB / 6.824 GB, free: 379 MB / 1.823 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.03194/13.77, allocations: 25.09 MB / 6.848 GB, free: 360.3 MB / 1.823 GB
Notification: Performance of simCode: alias equations: time 0.04131/13.81, allocations: 19.21 MB / 6.867 GB, free: 345.5 MB / 1.823 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.03078/13.84, allocations: 18.79 MB / 6.886 GB, free: 326.7 MB / 1.823 GB
Notification: Performance of SimCode: time 9.32e-07/13.84, allocations: 1.562 kB / 6.886 GB, free: 326.7 MB / 1.823 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 2.249/16.09, allocations: 1.291 GB / 8.177 GB, free: 0.6102 GB / 1.823 GB
Notification: Performance of buildModelFMU: Generate platform static: time 107.9/124, allocations: 3.984 kB / 8.177 GB, free: 0.6102 GB / 1.823 GB
"
[Timeout remaining time 175]
(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 & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV_res.mat --tempDir=temp_Buildings_latest_Buildings_Utilities_Plotters_Examples_SingleZoneVAV_fmu --startTime=1.5552e+07 --stopTime=1.5984e+07 --stepSize=3600 --timeout=800 --tolerance=1e-06 Buildings_latest_Buildings_Utilities_Plotters_Examples_SingleZoneVAV.fmu > Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.pipe 2>&1) [Timeout 840.0]
diffSimulationResults("Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Utilities_Plotters_Examples_SingleZoneVAV.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Utilities.Plotters.Examples.SingleZoneVAV.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: 134.82745688967407]