Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.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.002383/0.002383, allocations: 85.48 kB / 19.44 MB, free: 344 kB / 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.002871/0.002871, allocations: 173.6 kB / 22.76 MB, free: 1.66 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.611/1.611, allocations: 177.1 MB / 203.1 MB, free: 5.621 MB / 186.7 MB
"
[Timeout remaining time 178]
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 3.357/3.357, allocations: 429.5 MB / 0.6729 GB, free: 4.012 MB / 0.6355 GB
"
[Timeout remaining time 176]
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.Examples.HydronicHeating.TwoRoomsWithStorage,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|roo1.air.vol.T|roo2.air.vol.T|weaBus.TDryBul|tan.vol.1..T|tan.vol.2..T|tan.vol.3..T|tan.vol.4..T|tan.vol.5..T|temSup.T|temRet.T|boi.T|val1.y|val2.y",fileNamePrefix="Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage")
translateModel(Buildings.Examples.HydronicHeating.TwoRoomsWithStorage,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|roo1.air.vol.T|roo2.air.vol.T|weaBus.TDryBul|tan.vol.1..T|tan.vol.2..T|tan.vol.3..T|tan.vol.4..T|tan.vol.5..T|temSup.T|temRet.T|boi.T|val1.y|val2.y",fileNamePrefix="Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.343e-06/1.343e-06, allocations: 0 / 0.8775 GB, free: 6.637 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.592e-05/2.726e-05, allocations: 2.312 kB / 0.8775 GB, free: 6.633 MB / 0.8386 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.HydronicHeating.TwoRoomsWithStorage): time 2.22/2.22, allocations: 0.8158 GB / 1.693 GB, free: 36.32 MB / 1.307 GB
Notification: Performance of NFInst.instExpressions: time 0.2503/2.47, allocations: 159.1 MB / 1.849 GB, free: 128 kB / 1.307 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.06615/2.537, allocations: 1.694 MB / 1.85 GB, free: 128 kB / 1.307 GB
Notification: Performance of NFTyping.typeComponents: time 0.05658/2.593, allocations: 17.76 MB / 1.868 GB, free: 5.547 MB / 1.323 GB
Notification: Performance of NFTyping.typeBindings: time 0.09861/2.692, allocations: 30.82 MB / 1.898 GB, free: 0.7695 MB / 1.339 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06281/2.755, allocations: 22.23 MB / 1.919 GB, free: 1.398 MB / 1.354 GB
Notification: Performance of NFFlatten.flatten: time 0.2341/2.989, allocations: 150.1 MB / 2.066 GB, free: 3.691 MB / 1.495 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1187/3.107, allocations: 47.09 MB / 2.112 GB, free: 5.949 MB / 1.542 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.928/5.035, allocations: 71.58 MB / 2.182 GB, free: 84.1 MB / 1.557 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1109/5.146, allocations: 44.18 MB / 2.225 GB, free: 84.08 MB / 1.557 GB
Notification: Performance of NFPackage.collectConstants: time 0.04043/5.187, allocations: 7.858 MB / 2.233 GB, free: 84.08 MB / 1.557 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0745/5.261, allocations: 18.53 MB / 2.251 GB, free: 84.08 MB / 1.557 GB
Notification: Performance of NFScalarize.scalarize: time 0.06748/5.329, allocations: 31.64 MB / 2.282 GB, free: 84.08 MB / 1.557 GB
Notification: Performance of NFVerifyModel.verify: time 0.09782/5.426, allocations: 25.63 MB / 2.307 GB, free: 84.08 MB / 1.557 GB
Notification: Performance of NFConvertDAE.convert: time 0.2021/5.628, allocations: 127.9 MB / 2.432 GB, free: 52.7 MB / 1.557 GB
Notification: Performance of FrontEnd - DAE generated: time 7.885e-06/5.628, allocations: 0 / 2.432 GB, free: 52.7 MB / 1.557 GB
Notification: Performance of FrontEnd: time 1.944e-06/5.628, allocations: 0 / 2.432 GB, free: 52.7 MB / 1.557 GB
Notification: Performance of Transformations before backend: time 0.005028/5.634, allocations: 7.906 kB / 2.432 GB, free: 52.7 MB / 1.557 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 6652
 * Number of variables: 6652
Notification: Performance of Generate backend data structure: time 0.3585/5.992, allocations: 106.6 MB / 2.536 GB, free: 188 kB / 1.604 GB
Notification: Performance of prepare preOptimizeDAE: time 5.485e-05/5.992, allocations: 12.03 kB / 2.536 GB, free: 176 kB / 1.604 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1745/6.167, allocations: 26.82 MB / 2.562 GB, free: 5.293 MB / 1.636 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.228/6.395, allocations: 70.69 MB / 2.631 GB, free: 0.4922 MB / 1.698 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.006785/6.401, allocations: 5.303 MB / 2.636 GB, free: 10.52 MB / 1.714 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01967/6.421, allocations: 3.236 MB / 2.639 GB, free: 7.293 MB / 1.714 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.148/6.569, allocations: 47.2 MB / 2.685 GB, free: 6.098 MB / 1.761 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001245/6.57, allocations: 70.69 kB / 2.685 GB, free: 6.059 MB / 1.761 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0126/6.583, allocations: 1.063 MB / 2.686 GB, free: 5.004 MB / 1.761 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001275/6.584, allocations: 0.9661 MB / 2.687 GB, free: 4.039 MB / 1.761 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1379/6.722, allocations: 40.9 MB / 2.727 GB, free: 11.36 MB / 1.807 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.825/8.547, allocations: 321.9 MB / 3.042 GB, free: 0.7058 GB / 1.87 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.06554/8.613, allocations: 26.87 MB / 3.068 GB, free: 0.6866 GB / 1.87 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0454/8.658, allocations: 17.27 MB / 3.085 GB, free: 0.6724 GB / 1.87 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.2586/8.917, allocations: 68.42 MB / 3.152 GB, free: 0.613 GB / 1.87 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.05342/8.97, allocations: 21 MB / 3.172 GB, free: 0.5919 GB / 1.87 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0451/9.015, allocations: 2.953 MB / 3.175 GB, free: 0.5902 GB / 1.87 GB
Notification: Performance of pre-optimization done (n=1742): time 0.0001331/9.016, allocations: 4 kB / 3.175 GB, free: 0.5902 GB / 1.87 GB
Notification: Performance of matching and sorting (n=1753): time 0.5192/9.535, allocations: 130.7 MB / 3.303 GB, free: 474 MB / 1.87 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001427/9.536, allocations: 1.062 MB / 3.304 GB, free: 472.8 MB / 1.87 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2609/9.797, allocations: 97.44 MB / 3.399 GB, free: 375.8 MB / 1.87 GB
Notification: Performance of collectPreVariables (initialization): time 0.01312/9.81, allocations: 0.6696 MB / 3.399 GB, free: 375.1 MB / 1.87 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0665/9.877, allocations: 38.55 MB / 3.437 GB, free: 336.7 MB / 1.87 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01464/9.891, allocations: 7.187 MB / 3.444 GB, free: 329.6 MB / 1.87 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.07312/9.965, allocations: 26.41 MB / 3.47 GB, free: 303.2 MB / 1.87 GB
Notification: Performance of setup shared object (initialization): time 7.927e-05/9.965, allocations: 476.8 kB / 3.47 GB, free: 302.8 MB / 1.87 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.07299/10.04, allocations: 36.61 MB / 3.506 GB, free: 266.1 MB / 1.87 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.09866/10.14, allocations: 61.8 MB / 3.566 GB, free: 197.5 MB / 1.87 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: roo1.air.vol.dynBal.medium.p = roo1.air.vol.dynBal.p_start (roo2.air.vol.dynBal.p_start = roo1.air.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 2.398/12.53, allocations: 333.1 MB / 3.892 GB, free: 0.6741 GB / 1.87 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0008293/12.53, allocations: 78.66 kB / 3.892 GB, free: 0.6741 GB / 1.87 GB
Notification: Performance of matching and sorting (n=7129) (initialization): time 0.3239/12.86, allocations: 121.1 MB / 4.01 GB, free: 0.6284 GB / 1.87 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001057/12.86, allocations: 0.5953 MB / 4.011 GB, free: 0.628 GB / 1.87 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.2241/13.08, allocations: 85.13 MB / 4.094 GB, free: 0.5645 GB / 1.87 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06091/13.14, allocations: 14.07 MB / 4.108 GB, free: 0.5555 GB / 1.87 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04979/13.19, allocations: 8.632 MB / 4.116 GB, free: 0.549 GB / 1.87 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05793/13.25, allocations: 55.93 MB / 4.171 GB, free: 0.5001 GB / 1.87 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.07928/13.33, allocations: 4.554 MB / 4.175 GB, free: 0.4962 GB / 1.87 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01673/13.35, allocations: 1.712 MB / 4.177 GB, free: 0.4948 GB / 1.87 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         roo1.air.vol.dynBal.medium.p = roo1.air.vol.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1284/13.48, allocations: 52.12 MB / 4.228 GB, free: 457.5 MB / 1.87 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.1204/13.6, allocations: 61.46 MB / 4.288 GB, free: 389.2 MB / 1.87 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: roo1.air.vol.dynBal.medium.p = roo1.air.vol.dynBal.p_start (roo2.air.vol.dynBal.p_start = roo1.air.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.758/15.36, allocations: 330 MB / 4.61 GB, free: 0.6812 GB / 1.87 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0006781/15.36, allocations: 77.72 kB / 4.61 GB, free: 0.6812 GB / 1.87 GB
Notification: Performance of matching and sorting (n=7129) (initialization_lambda0): time 0.3295/15.69, allocations: 122.8 MB / 4.73 GB, free: 0.668 GB / 1.87 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0008102/15.69, allocations: 0.5967 MB / 4.73 GB, free: 0.6678 GB / 1.87 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.2072/15.89, allocations: 87.13 MB / 4.816 GB, free: 0.6403 GB / 1.87 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06392/15.96, allocations: 15.07 MB / 4.83 GB, free: 0.6311 GB / 1.87 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04878/16.01, allocations: 8.591 MB / 4.839 GB, free: 0.6246 GB / 1.87 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1167/16.12, allocations: 92.02 MB / 4.929 GB, free: 0.5595 GB / 1.87 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.07139/16.19, allocations: 4.641 MB / 4.933 GB, free: 0.5571 GB / 1.87 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01567/16.21, allocations: 1.676 MB / 4.935 GB, free: 0.5558 GB / 1.87 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         roo1.air.vol.dynBal.medium.p = roo1.air.vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1256
 * Number of states: 0 ()
 * Number of discrete variables: 192 ($PRE.T1.enableFire,$PRE.T3.enableFire,$PRE.T2.enableFire,$PRE.T4.enableFire,T2.t_start,$PRE.T2.t_start,T1.t_start,$PRE.T1.t_start,stateGraphRoot.resume,stateGraphRoot.suspend,T4.condition,T3.condition,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,roo2.solRadExc.is_flo[13],roo2.solRadExc.is_flo[12],roo2.solRadExc.is_flo[11],roo2.solRadExc.is_flo[10],roo2.solRadExc.is_flo[9],roo2.solRadExc.is_flo[8],roo2.solRadExc.is_flo[7],roo2.solRadExc.is_flo[6],roo2.solRadExc.is_flo[5],roo2.solRadExc.is_flo[4],roo2.solRadExc.is_flo[3],roo2.solRadExc.is_flo[2],roo2.solRadExc.is_flo[1],roo1.solRadExc.is_flo[13],roo1.solRadExc.is_flo[12],roo1.solRadExc.is_flo[11],roo1.solRadExc.is_flo[10],roo1.solRadExc.is_flo[9],roo1.solRadExc.is_flo[8],roo1.solRadExc.is_flo[7],roo1.solRadExc.is_flo[6],roo1.solRadExc.is_flo[5],roo1.solRadExc.is_flo[4],roo1.solRadExc.is_flo[3],roo1.solRadExc.is_flo[2],roo1.solRadExc.is_flo[1],$PRE.T4.t_start,$PRE.pumOn2.oldActive,$PRE.pumOn2.newActive,$PRE.pumOn2.localActive,$PRE.boiOn.oldActive,$PRE.boiOn.newActive,$PRE.boiOn.localActive,$PRE.T3.t_start,$PRE.pumOn.oldActive,$PRE.pumOn.newActive,$PRE.pumOn.localActive,$PRE.off.oldActive,$PRE.off.newActive,$PRE.off.localActive,$PRE.cooCon.yHex,$PRE.cooCon.yF,$PRE.onOff.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.hysPum.y,$PRE.occSch.tNext,$PRE.occSch.tNonOcc,$PRE.occSch.tOcc,$PRE.occSch.occupied,$PRE.occSch2.tNext,$PRE.occSch2.tNonOcc,$PRE.occSch2.tOcc,$PRE.occSch2.occupied,$PRE.occSch1.tNext,$PRE.occSch1.tNonOcc,$PRE.occSch1.tOcc,$PRE.occSch1.occupied,$PRE.roo2.bouConExtWin.HDifTil[2].incAng.decAng.k,$PRE.roo2.bouConExtWin.HDifTil[2].incAng.decAng.tNext,$PRE.roo2.bouConExtWin.HDifTil[1].incAng.decAng.k,$PRE.roo2.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.roo2.bouConExtWin.HDirTil[2].incAng.decAng.k,$PRE.roo2.bouConExtWin.HDirTil[2].incAng.decAng.tNext,$PRE.roo2.bouConExtWin.HDirTil[1].incAng.decAng.k,$PRE.roo2.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.roo1.bouConExtWin.HDifTil[2].incAng.decAng.k,$PRE.roo1.bouConExtWin.HDifTil[2].incAng.decAng.tNext,$PRE.roo1.bouConExtWin.HDifTil[1].incAng.decAng.k,$PRE.roo1.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.roo1.bouConExtWin.HDirTil[2].incAng.decAng.k,$PRE.roo1.bouConExtWin.HDirTil[2].incAng.decAng.tNext,$PRE.roo1.bouConExtWin.HDirTil[1].incAng.decAng.k,$PRE.roo1.bouConExtWin.HDirTil[1].incAng.decAng.tNext,aveTOut.mode,$PRE.aveTOut.mode,stateGraphRoot.activeSteps,T4.t_start,T4.fire,T4.enableFire,pumOn2.active,pumOn2.oldActive,pumOn2.newActive,pumOn2.localActive,T2.enableFire,T2.localCondition,boiOn.active,boiOn.oldActive,boiOn.newActive,boiOn.localActive,T3.t_start,T3.fire,T3.enableFire,pumOn.active,pumOn.oldActive,pumOn.newActive,pumOn.localActive,T1.enableFire,T1.localCondition,off.oldActive,off.newActive,off.localActive,off.active,lesThrTOut.y,cooCon.yHex,cooCon.yF,onOff.y,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,hysPum.y,occSch.tNext,occSch.tNonOcc,occSch.tOcc,occSch.occupied,occSch2.tNext,occSch2.tNonOcc,occSch2.tOcc,occSch2.occupied,occSch1.tNext,occSch1.tNonOcc,occSch1.tOcc,occSch1.occupied,lesThr.y,booToReaPum.u,roo2.bouConExtWin.HDifTil[2].incAng.decAng.k,roo2.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo2.bouConExtWin.HDifTil[1].incAng.decAng.k,roo2.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo2.bouConExtWin.HDirTil[2].incAng.decAng.k,roo2.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo2.bouConExtWin.HDirTil[1].incAng.decAng.k,roo2.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo1.bouConExtWin.HDifTil[2].incAng.decAng.k,roo1.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo1.bouConExtWin.HDifTil[1].incAng.decAng.k,roo1.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo1.bouConExtWin.HDirTil[2].incAng.decAng.k,roo1.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo1.bouConExtWin.HDirTil[1].incAng.decAng.k,roo1.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$whenCondition21,$whenCondition20,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition22)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (3942):
 * Single equations (assignments): 3747
 * Array equations: 160
 * Algorithm blocks: 5
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 27
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 16 systems
   {(1,4,100.0%), (6,12,66.7%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (5,13,52.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,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 11 systems
   {(18,99), (18,99), (2,12), (3,8), (3,8), (1,2), (1,2), (1,2), (1,4), (1,4), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.02682/16.24, allocations: 2.82 MB / 4.937 GB, free: 0.5542 GB / 1.87 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.04524/16.28, allocations: 6.19 MB / 4.943 GB, free: 0.5515 GB / 1.87 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1616/16.44, allocations: 42.34 MB / 4.985 GB, free: 0.5212 GB / 1.87 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002783/16.44, allocations: 176 kB / 4.985 GB, free: 0.5211 GB / 1.87 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0003129/16.44, allocations: 44 kB / 4.985 GB, free: 0.521 GB / 1.87 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1141/16.56, allocations: 34.11 MB / 5.018 GB, free: 499.1 MB / 1.87 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.3251/16.88, allocations: 108.5 MB / 5.124 GB, free: 389.5 MB / 1.87 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001882/16.88, allocations: 8 kB / 5.124 GB, free: 389.5 MB / 1.87 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.02418/16.91, allocations: 4.087 MB / 5.128 GB, free: 385.4 MB / 1.87 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03857/16.95, allocations: 8.904 MB / 5.137 GB, free: 376.4 MB / 1.87 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006533/16.95, allocations: 0.5503 MB / 5.138 GB, free: 375.8 MB / 1.87 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.087/17.04, allocations: 96.52 MB / 5.232 GB, free: 275.3 MB / 1.87 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.264e-06/17.04, allocations: 0 / 5.232 GB, free: 275.3 MB / 1.87 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1845/17.22, allocations: 62.09 MB / 5.292 GB, free: 212.8 MB / 1.87 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.04862/17.27, allocations: 12.06 MB / 5.304 GB, free: 200.7 MB / 1.87 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.02339/17.3, allocations: 449.2 kB / 5.305 GB, free: 200.3 MB / 1.87 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.04646/17.34, allocations: 2.628 MB / 5.307 GB, free: 197.6 MB / 1.87 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.008195/17.35, allocations: 1.276 MB / 5.309 GB, free: 196.4 MB / 1.87 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00684/17.36, allocations: 0.6973 MB / 5.309 GB, free: 195.7 MB / 1.87 GB
Notification: Performance of sorting global known variables: time 0.1902/17.55, allocations: 71.1 MB / 5.379 GB, free: 124.9 MB / 1.87 GB
Notification: Performance of sort global known variables: time 2.1e-07/17.55, allocations: 0 / 5.379 GB, free: 124.9 MB / 1.87 GB
Notification: Performance of remove unused functions: time 0.1508/17.7, allocations: 25.75 MB / 5.404 GB, free: 99.42 MB / 1.87 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 77 (pumRad.motSpe.y,roo1.conExtWin[1].opa.lay[1].T[1],roo1.conExtWin[1].opa.lay[1].T[2],roo1.conExtWin[1].opa.lay[2].T[1],roo1.conExtWin[1].opa.lay[2].T[2],roo1.conExtWin[1].opa.lay[2].T[3],roo1.conExtWin[1].win.capGla.TUns,roo1.conExtWin[1].win.capFra.T,roo1.conExtWin[2].opa.lay[1].T[1],roo1.conExtWin[2].opa.lay[1].T[2],roo1.conExtWin[2].opa.lay[2].T[1],roo1.conExtWin[2].opa.lay[2].T[2],roo1.conExtWin[2].opa.lay[2].T[3],roo1.conExtWin[2].win.capGla.TUns,roo1.conExtWin[2].win.capFra.T,roo1.conPar[1].opa.lay[1].T[1],roo1.conPar[1].opa.lay[1].T[2],roo1.conPar[1].opa.lay[1].T[3],roo1.conPar[1].opa.lay[2].T[1],roo1.conPar[1].opa.lay[2].T[2],roo1.conPar[1].opa.lay[3].T[1],roo1.conPar[1].opa.lay[3].T[2],roo1.conPar[2].opa.lay[1].T[1],roo1.conPar[2].opa.lay[1].T[2],roo1.air.vol.dynBal.medium.Xi[1],roo1.air.vol.dynBal.U,roo2.conExtWin[1].opa.lay[1].T[1],roo2.conExtWin[1].opa.lay[1].T[2],roo2.conExtWin[1].opa.lay[2].T[1],roo2.conExtWin[1].opa.lay[2].T[2],roo2.conExtWin[1].opa.lay[2].T[3],roo2.conExtWin[1].win.capGla.TUns,roo2.conExtWin[1].win.capFra.T,roo2.conExtWin[2].opa.lay[1].T[1],roo2.conExtWin[2].opa.lay[1].T[2],roo2.conExtWin[2].opa.lay[2].T[1],roo2.conExtWin[2].opa.lay[2].T[2],roo2.conExtWin[2].opa.lay[2].T[3],roo2.conExtWin[2].win.capGla.TUns,roo2.conExtWin[2].win.capFra.T,roo2.conPar[1].opa.lay[1].T[1],roo2.conPar[1].opa.lay[1].T[2],roo2.conPar[1].opa.lay[1].T[3],roo2.conPar[1].opa.lay[2].T[1],roo2.conPar[1].opa.lay[2].T[2],roo2.conPar[1].opa.lay[3].T[1],roo2.conPar[1].opa.lay[3].T[2],roo2.conPar[2].opa.lay[1].T[1],roo2.conPar[2].opa.lay[1].T[2],roo2.air.vol.dynBal.medium.Xi[1],roo2.air.vol.dynBal.U,roo2.air.vol.dynBal.m,boi.heaCapDry.T,conPum.I.y,rad1.vol[1].dynBal.U,rad1.vol[2].dynBal.U,rad1.vol[3].dynBal.U,rad1.vol[4].dynBal.U,rad1.vol[5].dynBal.U,rad2.vol[1].dynBal.U,rad2.vol[2].dynBal.U,rad2.vol[3].dynBal.U,rad2.vol[4].dynBal.U,rad2.vol[5].dynBal.U,conVal.I.y,tan.vol[1].dynBal.U,tan.vol[2].dynBal.U,tan.vol[3].dynBal.U,tan.vol[4].dynBal.U,tan.vol[5].dynBal.U,temSup.T,temRet.T,parWal.lay[1].T[1],parWal.lay[1].T[2],lea1.mExc,lea2.mExc,aveTOut.mu)
 * Number of discrete variables: 97 (T4.enableFire,pumOn2.active,boiOn.active,T3.enableFire,pumOn.active,off.localActive,$whenCondition22,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,$whenCondition20,$whenCondition21,roo1.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo1.bouConExtWin.HDirTil[1].incAng.decAng.k,roo1.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo1.bouConExtWin.HDirTil[2].incAng.decAng.k,roo1.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo1.bouConExtWin.HDifTil[1].incAng.decAng.k,roo1.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo1.bouConExtWin.HDifTil[2].incAng.decAng.k,roo2.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo2.bouConExtWin.HDirTil[1].incAng.decAng.k,roo2.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo2.bouConExtWin.HDirTil[2].incAng.decAng.k,roo2.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo2.bouConExtWin.HDifTil[1].incAng.decAng.k,roo2.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo2.bouConExtWin.HDifTil[2].incAng.decAng.k,booToReaPum.u,lesThr.y,occSch1.occupied,occSch1.tOcc,occSch1.tNonOcc,occSch1.tNext,occSch2.occupied,occSch2.tOcc,occSch2.tNonOcc,occSch2.tNext,occSch.occupied,occSch.tOcc,occSch.tNonOcc,occSch.tNext,hysPum.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,onOff.y,cooCon.yF,cooCon.yHex,lesThrTOut.y,off.active,off.newActive,off.oldActive,T1.localCondition,T1.enableFire,pumOn.localActive,pumOn.newActive,pumOn.oldActive,T3.fire,T3.t_start,boiOn.localActive,boiOn.newActive,boiOn.oldActive,T2.localCondition,T2.enableFire,pumOn2.localActive,pumOn2.newActive,pumOn2.oldActive,T4.fire,T4.t_start,stateGraphRoot.activeSteps,aveTOut.mode,T1.t_start,T2.t_start)
 * Number of discrete states: 41 (T2.t_start,T1.t_start,occSch.tNext,occSch2.tNext,occSch1.tNext,roo2.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo2.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo2.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo2.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo1.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo1.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo1.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo1.bouConExtWin.HDirTil[1].incAng.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.locTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext,off.newActive,pumOn.newActive,boiOn.newActive,pumOn2.newActive,onOff.y,weaDat.decAng.k,weaDat.eqnTim.k,weaDat.conTim.k,cooCon.yHex,cooCon.yF,$whenCondition21,$whenCondition20,weaDat.conTimMin.k,weaDat.locTim.k,hysPum.y,roo2.bouConExtWin.HDifTil[2].incAng.decAng.k,roo2.bouConExtWin.HDifTil[1].incAng.decAng.k,roo2.bouConExtWin.HDirTil[2].incAng.decAng.k,roo2.bouConExtWin.HDirTil[1].incAng.decAng.k,roo1.bouConExtWin.HDifTil[2].incAng.decAng.k,roo1.bouConExtWin.HDifTil[1].incAng.decAng.k,roo1.bouConExtWin.HDirTil[2].incAng.decAng.k,roo1.bouConExtWin.HDirTil[1].incAng.decAng.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1570):
 * Single equations (assignments): 1479
 * Array equations: 0
 * Algorithm blocks: 5
 * Record equations: 9
 * When equations: 38
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 39
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 32 systems
   {(5,13,52.0%), (1,1,100.0%), (1,1,100.0%), (1,4,100.0%), (1,1,100.0%), (1,1,100.0%), (1,4,100.0%), (6,12,77.8%), (14,46,77.6%), (14,46,77.6%), (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,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,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 7 systems
   {(1,3), (1,4), (1,2), (1,2), (2,13), (1,3), (1,5)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01698/17.72, allocations: 3.31 MB / 5.407 GB, free: 96.79 MB / 1.87 GB
Notification: Performance of simCode: created initialization part: time 0.9866/18.7, allocations: 130.1 MB / 5.534 GB, free: 0.6927 GB / 1.87 GB
Notification: Performance of simCode: created event and clocks part: time 1.842e-05/18.7, allocations: 7.812 kB / 5.534 GB, free: 0.6927 GB / 1.87 GB
Notification: Performance of simCode: created simulation system equations: time 0.06464/18.77, allocations: 26.22 MB / 5.56 GB, free: 0.6862 GB / 1.87 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.1571/18.92, allocations: 20.45 MB / 5.58 GB, free: 0.6839 GB / 1.87 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.372/19.3, allocations: 146.5 MB / 5.723 GB, free: 0.6428 GB / 1.87 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.1022/19.4, allocations: 38.66 MB / 5.761 GB, free: 0.6349 GB / 1.87 GB
Notification: Performance of simCode: alias equations: time 0.0928/19.49, allocations: 20.09 MB / 5.78 GB, free: 0.6189 GB / 1.87 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02926/19.52, allocations: 3.488 MB / 5.784 GB, free: 0.6155 GB / 1.87 GB
Notification: Performance of SimCode: time 2.044e-06/19.52, allocations: 0 / 5.784 GB, free: 0.6155 GB / 1.87 GB
Notification: Performance of Templates: time 2.445/21.97, allocations: 1.131 GB / 6.915 GB, free: 229.1 MB / 1.87 GB
"
[Timeout remaining time 278]
make -j1 -f Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.pipe ; mkfifo Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.pipe >> ../files/Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.sim & ./Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.pipe 2>&1) [Timeout 240]
diffSimulationResults("Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Examples_HydronicHeating_TwoRoomsWithStorage.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Examples.HydronicHeating.TwoRoomsWithStorage.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: 73.80874038592447]