Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001421/0.001421, allocations: 108.2 kB / 17.54 MB, free: 4.742 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001413/0.001413, allocations: 186.7 kB / 20.71 MB, free: 1.586 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.287/1.287, allocations: 225.6 MB / 249.3 MB, free: 3.152 MB / 190.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.333/2.333, allocations: 443.5 MB / 0.7304 GB, free: 13.96 MB / 0.5762 GB
"
[Timeout remaining time 177]
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS,fileNamePrefix="Buildings_10_Buildings_Experimental_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETS",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS,fileNamePrefix="Buildings_10_Buildings_Experimental_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETS",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.001786/0.001786, allocations: 63.89 kB / 1.059 GB, free: 0.9922 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2523/0.2541, allocations: 160.7 MB / 1.216 GB, free: 15.96 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS): time 3.118/3.372, allocations: 1.342 GB / 2.558 GB, free: 82.59 MB / 1.779 GB
Notification: Performance of NFInst.instExpressions: time 0.2738/3.646, allocations: 284.7 MB / 2.836 GB, free: 46.18 MB / 1.779 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04372/3.69, allocations: 1.289 MB / 2.837 GB, free: 46.18 MB / 1.779 GB
Notification: Performance of NFTyping.typeComponents: time 0.09184/3.782, allocations: 23.62 MB / 2.86 GB, free: 36.01 MB / 1.779 GB
Notification: Performance of NFTyping.typeBindings: time 0.07435/3.856, allocations: 36.13 MB / 2.896 GB, free: 15.96 MB / 1.779 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04987/3.906, allocations: 27.55 MB / 2.923 GB, free: 6.383 MB / 1.795 GB
Notification: Performance of NFFlatten.flatten: time 0.1569/4.063, allocations: 102.8 MB / 3.023 GB, free: 3.102 MB / 1.889 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04363/4.106, allocations: 21.74 MB / 3.044 GB, free: 13.6 MB / 1.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06005/4.166, allocations: 29.9 MB / 3.073 GB, free: 1.211 MB / 1.936 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.06001/4.226, allocations: 22.91 MB / 3.096 GB, free: 11.84 MB / 1.967 GB
Notification: Performance of NFPackage.collectConstants: time 0.01115/4.237, allocations: 4.121 MB / 3.1 GB, free: 7.715 MB / 1.967 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04029/4.278, allocations: 18.47 MB / 3.118 GB, free: 6.504 MB / 1.982 GB
Notification: Performance of NFScalarize.scalarize: time 0.01336/4.291, allocations: 9.536 MB / 3.127 GB, free: 13.07 MB / 1.998 GB
Notification: Performance of NFVerifyModel.verify: time 0.02978/4.321, allocations: 17.94 MB / 3.145 GB, free: 11.18 MB / 2.014 GB
Notification: Performance of NFConvertDAE.convert: time 0.09435/4.415, allocations: 68.49 MB / 3.212 GB, free: 8.16 MB / 2.076 GB
Notification: Performance of FrontEnd - DAE generated: time 5.721e-06/4.415, allocations: 0 / 3.212 GB, free: 8.16 MB / 2.076 GB
Notification: Performance of FrontEnd: time 1.262e-06/4.415, allocations: 0 / 3.212 GB, free: 8.16 MB / 2.076 GB
Notification: Performance of Transformations before backend: time 0.001222/4.416, allocations: 0 / 3.212 GB, free: 8.16 MB / 2.076 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3741
 * Number of variables: 3741
Notification: Performance of Generate backend data structure: time 0.07479/4.491, allocations: 32.06 MB / 3.243 GB, free: 8.129 MB / 2.107 GB
Notification: Performance of prepare preOptimizeDAE: time 4.096e-05/4.491, allocations: 8.031 kB / 3.243 GB, free: 8.121 MB / 2.107 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.005711/4.497, allocations: 1.868 MB / 3.245 GB, free: 6.242 MB / 2.107 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04289/4.54, allocations: 7.689 MB / 3.252 GB, free: 14.54 MB / 2.123 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 1.076/5.615, allocations: 54.39 MB / 3.305 GB, free: 1.086 GB / 2.154 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001137/5.617, allocations: 1.248 MB / 3.307 GB, free: 1.086 GB / 2.154 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004723/5.621, allocations: 1.566 MB / 3.308 GB, free: 1.086 GB / 2.154 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05343/5.675, allocations: 20.65 MB / 3.328 GB, free: 1.078 GB / 2.154 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004453/5.675, allocations: 41.53 kB / 3.328 GB, free: 1.078 GB / 2.154 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003686/5.679, allocations: 0.621 MB / 3.329 GB, free: 1.077 GB / 2.154 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004868/5.679, allocations: 0.5232 MB / 3.329 GB, free: 1.077 GB / 2.154 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04646/5.726, allocations: 17.86 MB / 3.347 GB, free: 1.07 GB / 2.154 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.1365/5.862, allocations: 115.7 MB / 3.46 GB, free: 0.9852 GB / 2.154 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02374/5.886, allocations: 11.69 MB / 3.471 GB, free: 0.979 GB / 2.154 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01348/5.9, allocations: 6.359 MB / 3.477 GB, free: 0.9757 GB / 2.154 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.05004/5.95, allocations: 34.8 MB / 3.511 GB, free: 0.9468 GB / 2.154 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01576/5.965, allocations: 7.455 MB / 3.519 GB, free: 0.9425 GB / 2.154 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.009394/5.975, allocations: 2.385 MB / 3.521 GB, free: 0.9412 GB / 2.154 GB
Notification: Performance of pre-optimization done (n=783): time 2.634e-05/5.975, allocations: 0 / 3.521 GB, free: 0.9412 GB / 2.154 GB
Notification: Performance of matching and sorting (n=783): time 0.1401/6.115, allocations: 34.98 MB / 3.555 GB, free: 0.9206 GB / 2.154 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001963/6.115, allocations: 0.8001 MB / 3.556 GB, free: 0.9197 GB / 2.154 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03693/6.152, allocations: 23.58 MB / 3.579 GB, free: 0.8968 GB / 2.154 GB
Notification: Performance of collectPreVariables (initialization): time 0.002285/6.154, allocations: 325.7 kB / 3.579 GB, free: 0.8965 GB / 2.154 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01067/6.165, allocations: 11.65 MB / 3.591 GB, free: 0.8852 GB / 2.154 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003229/6.168, allocations: 2.724 MB / 3.593 GB, free: 0.8826 GB / 2.154 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006906/6.175, allocations: 3.725 MB / 3.597 GB, free: 0.8789 GB / 2.154 GB
Notification: Performance of setup shared object (initialization): time 3.401e-05/6.175, allocations: 305.1 kB / 3.597 GB, free: 0.8786 GB / 2.154 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01536/6.19, allocations: 8.9 MB / 3.606 GB, free: 0.87 GB / 2.154 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01853/6.209, allocations: 13.74 MB / 3.619 GB, free: 0.8548 GB / 2.154 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03123/6.24, allocations: 20.56 MB / 3.639 GB, free: 0.8331 GB / 2.154 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.992e-05/6.24, allocations: 36 kB / 3.639 GB, free: 0.833 GB / 2.154 GB
Notification: Performance of matching and sorting (n=2066) (initialization): time 0.06222/6.303, allocations: 27.35 MB / 3.666 GB, free: 0.8062 GB / 2.154 GB
Notification: Performance of prepare postOptimizeDAE: time 7.96e-05/6.303, allocations: 56 kB / 3.666 GB, free: 0.8062 GB / 2.154 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001261/6.303, allocations: 120 kB / 3.666 GB, free: 0.8061 GB / 2.154 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02038/6.323, allocations: 6.137 MB / 3.672 GB, free: 0.8002 GB / 2.154 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01222/6.335, allocations: 2.929 MB / 3.675 GB, free: 0.7973 GB / 2.154 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02668/6.362, allocations: 22.05 MB / 3.697 GB, free: 0.7749 GB / 2.154 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01788/6.38, allocations: 1.066 MB / 3.698 GB, free: 0.7739 GB / 2.154 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002757/6.383, allocations: 0.7456 MB / 3.699 GB, free: 0.7732 GB / 2.154 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02618/6.409, allocations: 14.97 MB / 3.713 GB, free: 0.7585 GB / 2.154 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01842/6.427, allocations: 13.37 MB / 3.726 GB, free: 0.7435 GB / 2.154 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03046/6.458, allocations: 19.87 MB / 3.746 GB, free: 0.7224 GB / 2.154 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.641e-05/6.458, allocations: 36 kB / 3.746 GB, free: 0.7224 GB / 2.154 GB
Notification: Performance of matching and sorting (n=2066) (initialization_lambda0): time 0.07012/6.528, allocations: 27.29 MB / 3.772 GB, free: 0.6956 GB / 2.154 GB
Notification: Performance of prepare postOptimizeDAE: time 7.489e-05/6.528, allocations: 64 kB / 3.772 GB, free: 0.6956 GB / 2.154 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001264/6.528, allocations: 120 kB / 3.772 GB, free: 0.6954 GB / 2.154 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01953/6.548, allocations: 5.846 MB / 3.778 GB, free: 0.6898 GB / 2.154 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01182/6.559, allocations: 2.925 MB / 3.781 GB, free: 0.687 GB / 2.154 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0243/6.584, allocations: 20.35 MB / 3.801 GB, free: 0.6663 GB / 2.154 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01801/6.602, allocations: 1.122 MB / 3.802 GB, free: 0.6652 GB / 2.154 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002717/6.605, allocations: 0.7183 MB / 3.803 GB, free: 0.6645 GB / 2.154 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 548
 * Number of states: 0 ()
 * Number of discrete variables: 225 ($PRE.bui.ets.swiFlo.con.truFalHol.onDel1.u,$PRE.bui.ets.swiFlo.con.truFalHol.onDel2.u,$PRE.bui.ets.swiFlo.con.truFalHol.toTrue.enableFire,$PRE.bui.ets.swiFlo.con.truFalHol.toFalse.enableFire,$PRE.bui.ets.swiFlo.con.truFalHol.toTrue1.enableFire,$PRE.bui.ets.swiFlo.con.truFalHol.toFalse1.enableFire,$PRE.bui.ets.enaHea.onDel1.u,$PRE.bui.ets.enaHea.onDel2.u,$PRE.bui.ets.enaHea.toTrue.enableFire,$PRE.bui.ets.enaHea.toFalse.enableFire,$PRE.bui.ets.enaHea.toTrue1.enableFire,$PRE.bui.ets.enaHea.toFalse1.enableFire,$PRE.bui.ets.enaSHW.onDel1.u,$PRE.bui.ets.enaSHW.onDel2.u,$PRE.bui.ets.enaSHW.toTrue.enableFire,$PRE.bui.ets.enaSHW.toFalse.enableFire,$PRE.bui.ets.enaSHW.toTrue1.enableFire,$PRE.bui.ets.enaSHW.toFalse1.enableFire,bui.ets.enaSHW.toFalse1.t_start,$PRE.bui.ets.enaSHW.toFalse1.t_start,bui.ets.enaSHW.toTrue1.t_start,$PRE.bui.ets.enaSHW.toTrue1.t_start,bui.ets.enaSHW.toFalse.t_start,$PRE.bui.ets.enaSHW.toFalse.t_start,bui.ets.enaSHW.toTrue.t_start,$PRE.bui.ets.enaSHW.toTrue.t_start,bui.ets.enaHea.toFalse1.t_start,$PRE.bui.ets.enaHea.toFalse1.t_start,bui.ets.enaHea.toTrue1.t_start,$PRE.bui.ets.enaHea.toTrue1.t_start,bui.ets.enaHea.toFalse.t_start,$PRE.bui.ets.enaHea.toFalse.t_start,bui.ets.enaHea.toTrue.t_start,$PRE.bui.ets.enaHea.toTrue.t_start,bui.ets.swiFlo.con.truFalHol.toFalse1.t_start,$PRE.bui.ets.swiFlo.con.truFalHol.toFalse1.t_start,bui.ets.swiFlo.con.truFalHol.toTrue1.t_start,$PRE.bui.ets.swiFlo.con.truFalHol.toTrue1.t_start,bui.ets.swiFlo.con.truFalHol.toFalse.t_start,$PRE.bui.ets.swiFlo.con.truFalHol.toFalse.t_start,bui.ets.swiFlo.con.truFalHol.toTrue.t_start,$PRE.bui.ets.swiFlo.con.truFalHol.toTrue.t_start,$PRE.bui.ets.enaSHW.onDel2.t_next,$whenCondition17,$PRE.bui.ets.enaSHW.onDel1.t_next,$whenCondition14,$PRE.bui.ets.enaHea.onDel2.t_next,$whenCondition11,$PRE.bui.ets.enaHea.onDel1.t_next,$whenCondition8,$PRE.bui.ets.swiFlo.con.truFalHol.onDel2.t_next,$whenCondition5,$PRE.bui.ets.swiFlo.con.truFalHol.onDel1.t_next,$whenCondition2,$PRE.bui.bui.loa.nextTimeEvent,$whenCondition1,bui.ets.enaSHW.onDel2.t_next,bui.ets.enaSHW.onDel1.t_next,bui.ets.enaHea.onDel2.t_next,bui.ets.enaHea.onDel1.t_next,bui.ets.swiFlo.con.truFalHol.onDel2.t_next,bui.ets.swiFlo.con.truFalHol.onDel1.t_next,bui.ets.enaSHW.toFalse1.localCondition,bui.ets.enaSHW.toFalse1.condition,bui.ets.enaSHW.and2.u2,bui.ets.enaSHW.notU.y,bui.enaSHW.y,bui.ets.enaSHW.stateGraphRoot.resume,bui.ets.enaSHW.stateGraphRoot.suspend,bui.ets.enaHea.stateGraphRoot.resume,bui.ets.enaHea.stateGraphRoot.suspend,bui.ets.swiFlo.con.truFalHol.stateGraphRoot.resume,bui.ets.swiFlo.con.truFalHol.stateGraphRoot.suspend,bui.bui.terUniCoo.con1.y,bui.bui.terUniHea.con1.y,bui.ets.enaSHW.toFalse.localCondition,bui.bui.terUniHea.hex.flowRegime_nominal,bui.bui.terUniHea.hex.flowRegime,bui.ets.hexChi.flowRegime_nominal,bui.ets.hexChi.flowRegime,bui.bui.terUniCoo.hexWetNtu.flowRegime_nominal,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyDry.cfg,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.cfg,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.cfg,bui.bui.terUniCoo.hexWetNtu.flowRegime,bui.bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,bui.bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,bui.ets.enaSHW.toFalse1.enableFire,bui.ets.enaSHW.toFalse.enableFire,bui.enaHeaCoo[2].y,bui.enaHeaCoo[1].y,bui.ets.enaSHW.toTrue1.enableFire,bui.ets.enaSHW.initialStep.oldActive,$PRE.bui.ets.enaSHW.initialStep.oldActive,bui.ets.enaSHW.initialStep.newActive,$PRE.bui.ets.enaSHW.initialStep.newActive,bui.ets.enaSHW.initialStep.outPort[2].available,bui.ets.enaSHW.initialStep.localActive,$PRE.bui.ets.enaSHW.initialStep.localActive,bui.ets.enaSHW.initialStep.active,bui.ets.enaSHW.outputTrue.active,bui.ets.enaSHW.outputTrue.oldActive,$PRE.bui.ets.enaSHW.outputTrue.oldActive,bui.ets.enaSHW.outputTrue.newActive,$PRE.bui.ets.enaSHW.outputTrue.newActive,bui.ets.enaSHW.outputTrue.inPort[2].occupied,bui.ets.enaSHW.outputTrue.localActive,$PRE.bui.ets.enaSHW.outputTrue.localActive,bui.ets.enaSHW.toTrue.enableFire,bui.ets.enaSHW.outputFalse.active,bui.ets.enaSHW.outputFalse.oldActive,$PRE.bui.ets.enaSHW.outputFalse.oldActive,bui.ets.enaSHW.outputFalse.newActive,$PRE.bui.ets.enaSHW.outputFalse.newActive,bui.ets.enaSHW.outputFalse.inPort[2].occupied,bui.ets.enaSHW.outputFalse.localActive,$PRE.bui.ets.enaSHW.outputFalse.localActive,bui.ets.enaSHW.stateGraphRoot.activeSteps,bui.ets.enaSHW.onDel2.y,bui.ets.enaSHW.onDel2.u,bui.ets.enaSHW.onDel1.y,bui.ets.enaSHW.onDel1.u,bui.ets.proHotWat.ena.y,bui.ets.proHotWat.staPum[2].greHys.y,$PRE.bui.ets.proHotWat.staPum[2].greHys.y,bui.ets.proHotWat.staPum[1].greHys.y,$PRE.bui.ets.proHotWat.staPum[1].greHys.y,bui.ets.proHeaWat.ena.y,bui.ets.proHeaWat.staPum[2].greHys.y,$PRE.bui.ets.proHeaWat.staPum[2].greHys.y,bui.ets.proHeaWat.staPum[1].greHys.y,$PRE.bui.ets.proHeaWat.staPum[1].greHys.y,bui.ets.enaHea.toFalse1.enableFire,bui.ets.enaHea.toTrue1.enableFire,bui.ets.enaHea.initialStep.oldActive,$PRE.bui.ets.enaHea.initialStep.oldActive,bui.ets.enaHea.initialStep.newActive,$PRE.bui.ets.enaHea.initialStep.newActive,bui.ets.enaHea.initialStep.outPort[2].available,bui.ets.enaHea.initialStep.localActive,$PRE.bui.ets.enaHea.initialStep.localActive,bui.ets.enaHea.initialStep.active,bui.ets.enaHea.toFalse.enableFire,bui.ets.enaHea.toFalse.localCondition,bui.ets.enaHea.outputTrue.active,bui.ets.enaHea.outputTrue.oldActive,$PRE.bui.ets.enaHea.outputTrue.oldActive,bui.ets.enaHea.outputTrue.newActive,$PRE.bui.ets.enaHea.outputTrue.newActive,bui.ets.enaHea.outputTrue.inPort[2].occupied,bui.ets.enaHea.outputTrue.localActive,$PRE.bui.ets.enaHea.outputTrue.localActive,bui.ets.enaHea.toTrue.enableFire,bui.ets.enaHea.toTrue.localCondition,bui.ets.enaHea.outputFalse.active,bui.ets.enaHea.outputFalse.oldActive,$PRE.bui.ets.enaHea.outputFalse.oldActive,bui.ets.enaHea.outputFalse.newActive,$PRE.bui.ets.enaHea.outputFalse.newActive,bui.ets.enaHea.outputFalse.inPort[2].occupied,bui.ets.enaHea.outputFalse.localActive,$PRE.bui.ets.enaHea.outputFalse.localActive,bui.ets.enaHea.stateGraphRoot.activeSteps,bui.ets.enaHea.onDel2.y,bui.ets.enaHea.onDel2.u,bui.ets.enaHea.onDel1.y,bui.ets.enaHea.onDel1.u,bui.ets.swiFlo.con.truFalHol.toFalse1.enableFire,bui.ets.swiFlo.con.truFalHol.toTrue1.enableFire,bui.ets.swiFlo.con.truFalHol.initialStep.oldActive,$PRE.bui.ets.swiFlo.con.truFalHol.initialStep.oldActive,bui.ets.swiFlo.con.truFalHol.initialStep.newActive,$PRE.bui.ets.swiFlo.con.truFalHol.initialStep.newActive,bui.ets.swiFlo.con.truFalHol.initialStep.outPort[2].available,bui.ets.swiFlo.con.truFalHol.initialStep.localActive,$PRE.bui.ets.swiFlo.con.truFalHol.initialStep.localActive,bui.ets.swiFlo.con.truFalHol.initialStep.active,bui.ets.swiFlo.con.truFalHol.toFalse.enableFire,bui.ets.swiFlo.con.truFalHol.toFalse.localCondition,bui.ets.swiFlo.con.truFalHol.outputTrue.active,bui.ets.swiFlo.con.truFalHol.outputTrue.oldActive,$PRE.bui.ets.swiFlo.con.truFalHol.outputTrue.oldActive,bui.ets.swiFlo.con.truFalHol.outputTrue.newActive,$PRE.bui.ets.swiFlo.con.truFalHol.outputTrue.newActive,bui.ets.swiFlo.con.truFalHol.outputTrue.inPort[2].occupied,bui.ets.swiFlo.con.truFalHol.outputTrue.localActive,$PRE.bui.ets.swiFlo.con.truFalHol.outputTrue.localActive,bui.ets.swiFlo.con.truFalHol.toTrue.enableFire,bui.ets.swiFlo.con.truFalHol.toTrue.localCondition,bui.ets.swiFlo.con.truFalHol.outputFalse.active,bui.ets.swiFlo.con.truFalHol.outputFalse.oldActive,$PRE.bui.ets.swiFlo.con.truFalHol.outputFalse.oldActive,bui.ets.swiFlo.con.truFalHol.outputFalse.newActive,$PRE.bui.ets.swiFlo.con.truFalHol.outputFalse.newActive,bui.ets.swiFlo.con.truFalHol.outputFalse.inPort[2].occupied,bui.ets.swiFlo.con.truFalHol.outputFalse.localActive,$PRE.bui.ets.swiFlo.con.truFalHol.outputFalse.localActive,bui.ets.swiFlo.con.truFalHol.stateGraphRoot.activeSteps,bui.ets.swiFlo.con.truFalHol.onDel2.y,bui.ets.swiFlo.con.truFalHol.onDel2.u,bui.ets.swiFlo.con.truFalHol.onDel1.y,bui.ets.swiFlo.con.truFalHol.onDel1.u,bui.ets.swiFlo.con.truFalHol.u,bui.bui.terUniCoo.greThr.greHys.y,$PRE.bui.bui.terUniCoo.greThr.greHys.y,bui.bui.terUniHea.greThr.greHys.y,$PRE.bui.bui.terUniHea.greThr.greHys.y,bui.bui.loa.nextTimeEventScaled,$PRE.bui.bui.loa.nextTimeEventScaled,bui.bui.loa.nextTimeEvent,$whenCondition4,$whenCondition3,$whenCondition7,$whenCondition6,$whenCondition10,$whenCondition9,$whenCondition13,$whenCondition12,$whenCondition16,$whenCondition15,$whenCondition19,$whenCondition18,$whenCondition20,$whenCondition21,$whenCondition22)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1617):
 * Single equations (assignments): 1587
 * Array equations: 10
 * Algorithm blocks: 0
 * Record equations: 8
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 3
 * Torn equation systems: 9
 * 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): 3 systems
   {1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(4,8,93.8%), (1,4,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(5,51), (1,34), (1,4), (1,2), (1,60), (5,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.003915/6.608, allocations: 1.249 MB / 3.804 GB, free: 0.6632 GB / 2.154 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005639/6.614, allocations: 2.259 MB / 3.806 GB, free: 0.661 GB / 2.154 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04851/6.663, allocations: 17.63 MB / 3.823 GB, free: 0.6439 GB / 2.154 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001184/6.663, allocations: 104 kB / 3.823 GB, free: 0.6438 GB / 2.154 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.26e-05/6.663, allocations: 12 kB / 3.823 GB, free: 0.6438 GB / 2.154 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0396/6.702, allocations: 13.96 MB / 3.837 GB, free: 0.63 GB / 2.154 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.08382/6.786, allocations: 42.14 MB / 3.878 GB, free: 0.5888 GB / 2.154 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.742e-05/6.786, allocations: 16.25 kB / 3.878 GB, free: 0.5888 GB / 2.154 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.006773/6.793, allocations: 1.307 MB / 3.88 GB, free: 0.5875 GB / 2.154 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01586/6.809, allocations: 4.765 MB / 3.884 GB, free: 0.5828 GB / 2.154 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001638/6.81, allocations: 259.8 kB / 3.884 GB, free: 0.5826 GB / 2.154 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02062/6.831, allocations: 18.69 MB / 3.903 GB, free: 0.5635 GB / 2.154 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.053e-06/6.831, allocations: 19.88 kB / 3.903 GB, free: 0.5634 GB / 2.154 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05751/6.889, allocations: 25.43 MB / 3.928 GB, free: 0.5383 GB / 2.154 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009493/6.898, allocations: 4.554 MB / 3.932 GB, free: 0.5338 GB / 2.154 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005175/6.903, allocations: 232.1 kB / 3.932 GB, free: 0.5336 GB / 2.154 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01372/6.917, allocations: 0.8247 MB / 3.933 GB, free: 0.5328 GB / 2.154 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001634/6.919, allocations: 0.6772 MB / 3.934 GB, free: 0.5322 GB / 2.154 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001268/6.92, allocations: 407.7 kB / 3.934 GB, free: 0.5318 GB / 2.154 GB
Notification: Performance of sorting global known variables: time 0.02693/6.947, allocations: 15.97 MB / 3.95 GB, free: 0.5163 GB / 2.154 GB
Notification: Performance of sort global known variables: time 2.41e-07/6.947, allocations: 0 / 3.95 GB, free: 0.5163 GB / 2.154 GB
Notification: Performance of remove unused functions: time 0.03294/6.98, allocations: 10.78 MB / 3.96 GB, free: 0.5057 GB / 2.154 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 50
 * Number of states: 22 (bui.bui.terUniHea.con.I.y,bui.bui.terUniHea.TLoaODE.TAir,bui.bui.disFloHea.heaCoo.vol.dynBal.U,bui.bui.disFloHea.senTSup.T,bui.bui.disFloCoo.heaCoo.vol.dynBal.U,bui.bui.disFloCoo.senTSup.T,bui.bui.terUniCoo.con.I.y,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.TWatOutEst,bui.bui.terUniCoo.TLoaODE.TAir,bui.ets.volMix_a.dynBal.U,bui.ets.volMix_b.dynBal.U,bui.ets.volHeaWatRet.dynBal.U,bui.ets.volChiWat.dynBal.U,bui.ets.conTChiWat.conPID.I.y,bui.ets.senTHeaWatSup.T,bui.ets.senTChiWatSup.T,bui.ets.proHeaWat.senTConLvg.T,bui.ets.proHeaWat.senTConEnt.T,bui.ets.proHotWat.senTConLvg.T,bui.ets.proHotWat.senTConEnt.T,bui.ets.senTHeaWatRet.T,bui.ets.senTChiWatRet.T)
 * Number of discrete variables: 140 (bui.enaHeaCoo[2].y,bui.ets.enaSHW.initialStep.localActive,bui.ets.enaSHW.outputTrue.active,bui.ets.enaSHW.outputTrue.localActive,bui.ets.enaSHW.onDel2.u,bui.ets.enaSHW.outputFalse.active,bui.ets.enaSHW.outputFalse.localActive,bui.ets.enaSHW.onDel1.u,bui.ets.enaHea.initialStep.localActive,bui.ets.enaHea.outputTrue.active,bui.ets.enaHea.outputTrue.localActive,bui.ets.enaHea.onDel2.u,bui.ets.enaHea.outputFalse.active,bui.ets.enaHea.outputFalse.localActive,bui.ets.enaHea.onDel1.u,bui.ets.swiFlo.con.truFalHol.initialStep.localActive,bui.ets.swiFlo.con.truFalHol.outputTrue.active,bui.ets.swiFlo.con.truFalHol.outputTrue.localActive,bui.ets.swiFlo.con.truFalHol.onDel2.u,bui.ets.swiFlo.con.truFalHol.outputFalse.active,bui.ets.swiFlo.con.truFalHol.outputFalse.localActive,bui.ets.swiFlo.con.truFalHol.onDel1.u,$cse96,$cse97,$cse100,$cse109,$cse110,$cse111,$cse112,$cse113,$cse125,$cse126,$cse127,$cse128,$cse129,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition1,bui.bui.loa.nextTimeEvent,bui.bui.loa.nextTimeEventScaled,bui.bui.terUniHea.greThr.greHys.y,bui.bui.terUniCoo.greThr.greHys.y,bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.truFalHol.onDel1.y,bui.ets.swiFlo.con.truFalHol.onDel1.t_next,bui.ets.swiFlo.con.truFalHol.onDel2.y,bui.ets.swiFlo.con.truFalHol.onDel2.t_next,bui.ets.swiFlo.con.truFalHol.stateGraphRoot.activeSteps,bui.ets.swiFlo.con.truFalHol.outputFalse.inPort[2].occupied,bui.ets.swiFlo.con.truFalHol.outputFalse.newActive,bui.ets.swiFlo.con.truFalHol.outputFalse.oldActive,bui.ets.swiFlo.con.truFalHol.toTrue.localCondition,bui.ets.swiFlo.con.truFalHol.toTrue.enableFire,bui.ets.swiFlo.con.truFalHol.outputTrue.inPort[2].occupied,bui.ets.swiFlo.con.truFalHol.outputTrue.newActive,bui.ets.swiFlo.con.truFalHol.outputTrue.oldActive,bui.ets.swiFlo.con.truFalHol.toFalse.localCondition,bui.ets.swiFlo.con.truFalHol.toFalse.enableFire,bui.ets.swiFlo.con.truFalHol.initialStep.active,bui.ets.swiFlo.con.truFalHol.initialStep.outPort[2].available,bui.ets.swiFlo.con.truFalHol.initialStep.newActive,bui.ets.swiFlo.con.truFalHol.initialStep.oldActive,bui.ets.swiFlo.con.truFalHol.toTrue1.enableFire,bui.ets.swiFlo.con.truFalHol.toFalse1.enableFire,bui.ets.enaHea.onDel1.y,bui.ets.enaHea.onDel1.t_next,bui.ets.enaHea.onDel2.y,bui.ets.enaHea.onDel2.t_next,bui.ets.enaHea.stateGraphRoot.activeSteps,bui.ets.enaHea.outputFalse.inPort[2].occupied,bui.ets.enaHea.outputFalse.newActive,bui.ets.enaHea.outputFalse.oldActive,bui.ets.enaHea.toTrue.localCondition,bui.ets.enaHea.toTrue.enableFire,bui.ets.enaHea.outputTrue.inPort[2].occupied,bui.ets.enaHea.outputTrue.newActive,bui.ets.enaHea.outputTrue.oldActive,bui.ets.enaHea.toFalse.localCondition,bui.ets.enaHea.toFalse.enableFire,bui.ets.enaHea.initialStep.active,bui.ets.enaHea.initialStep.outPort[2].available,bui.ets.enaHea.initialStep.newActive,bui.ets.enaHea.initialStep.oldActive,bui.ets.enaHea.toTrue1.enableFire,bui.ets.enaHea.toFalse1.enableFire,bui.ets.proHeaWat.staPum[1].greHys.y,bui.ets.proHeaWat.staPum[2].greHys.y,bui.ets.proHeaWat.ena.y,bui.ets.proHotWat.staPum[1].greHys.y,bui.ets.proHotWat.staPum[2].greHys.y,bui.ets.proHotWat.ena.y,bui.ets.enaSHW.onDel1.y,bui.ets.enaSHW.onDel1.t_next,bui.ets.enaSHW.onDel2.y,bui.ets.enaSHW.onDel2.t_next,bui.ets.enaSHW.stateGraphRoot.activeSteps,bui.ets.enaSHW.outputFalse.inPort[2].occupied,bui.ets.enaSHW.outputFalse.newActive,bui.ets.enaSHW.outputFalse.oldActive,bui.ets.enaSHW.toTrue.enableFire,bui.ets.enaSHW.outputTrue.inPort[2].occupied,bui.ets.enaSHW.outputTrue.newActive,bui.ets.enaSHW.outputTrue.oldActive,bui.ets.enaSHW.initialStep.active,bui.ets.enaSHW.initialStep.outPort[2].available,bui.ets.enaSHW.initialStep.newActive,bui.ets.enaSHW.initialStep.oldActive,bui.ets.enaSHW.toTrue1.enableFire,bui.enaHeaCoo[1].y,bui.ets.swiFlo.con.truFalHol.toTrue.t_start,bui.ets.swiFlo.con.truFalHol.toFalse.t_start,bui.ets.swiFlo.con.truFalHol.toTrue1.t_start,bui.ets.swiFlo.con.truFalHol.toFalse1.t_start,bui.ets.enaHea.toTrue.t_start,bui.ets.enaHea.toFalse.t_start,bui.ets.enaHea.toTrue1.t_start,bui.ets.enaHea.toFalse1.t_start,bui.ets.enaSHW.toTrue.t_start,bui.ets.enaSHW.toFalse.t_start,bui.ets.enaSHW.toTrue1.t_start,bui.ets.enaSHW.toFalse1.t_start)
 * Number of discrete states: 35 (bui.ets.enaSHW.toFalse1.t_start,bui.ets.enaSHW.toTrue1.t_start,bui.ets.enaSHW.toFalse.t_start,bui.ets.enaSHW.toTrue.t_start,bui.ets.enaHea.toFalse1.t_start,bui.ets.enaHea.toTrue1.t_start,bui.ets.enaHea.toFalse.t_start,bui.ets.enaHea.toTrue.t_start,bui.ets.swiFlo.con.truFalHol.toFalse1.t_start,bui.ets.swiFlo.con.truFalHol.toTrue1.t_start,bui.ets.swiFlo.con.truFalHol.toFalse.t_start,bui.ets.swiFlo.con.truFalHol.toTrue.t_start,bui.ets.enaSHW.onDel2.t_next,bui.ets.enaSHW.onDel1.t_next,bui.ets.enaHea.onDel2.t_next,bui.ets.enaHea.onDel1.t_next,bui.ets.swiFlo.con.truFalHol.onDel2.t_next,bui.ets.swiFlo.con.truFalHol.onDel1.t_next,bui.bui.loa.nextTimeEvent,bui.ets.swiFlo.con.truFalHol.outputFalse.newActive,bui.ets.swiFlo.con.truFalHol.outputTrue.newActive,bui.ets.swiFlo.con.truFalHol.initialStep.newActive,bui.ets.enaHea.outputFalse.newActive,bui.ets.enaHea.outputTrue.newActive,bui.ets.enaHea.initialStep.newActive,bui.ets.proHotWat.staPum[1].greHys.y,bui.ets.enaSHW.outputFalse.newActive,bui.ets.enaSHW.outputTrue.newActive,bui.ets.enaSHW.initialStep.newActive,bui.bui.loa.nextTimeEventScaled,bui.bui.terUniCoo.greThr.greHys.y,bui.bui.terUniHea.greThr.greHys.y,bui.ets.proHeaWat.staPum[1].greHys.y,bui.ets.proHeaWat.staPum[2].greHys.y,bui.ets.proHotWat.staPum[2].greHys.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (713):
 * Single equations (assignments): 635
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 32
 * When equations: 35
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 9
 * 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): 2 systems
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(4,8,100.0%), (1,4,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(1,4), (1,2), (1,56), (1,1), (5,57), (1,36)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.05758/7.037, allocations: 29.46 MB / 3.989 GB, free: 488.5 MB / 2.154 GB
Notification: Performance of simCode: created initialization part: time 0.05885/7.096, allocations: 29.67 MB / 4.018 GB, free: 458.8 MB / 2.154 GB
Notification: Performance of simCode: created event and clocks part: time 1.545e-05/7.096, allocations: 10.66 kB / 4.018 GB, free: 458.8 MB / 2.154 GB
Notification: Performance of simCode: created simulation system equations: time 0.01707/7.113, allocations: 8.176 MB / 4.026 GB, free: 450.5 MB / 2.154 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04425/7.158, allocations: 11.38 MB / 4.037 GB, free: 439.6 MB / 2.154 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3437/7.501, allocations: 186.1 MB / 4.219 GB, free: 247.8 MB / 2.154 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01491/7.516, allocations: 10.93 MB / 4.229 GB, free: 236.8 MB / 2.154 GB
Notification: Performance of simCode: alias equations: time 0.02362/7.54, allocations: 5.332 MB / 4.235 GB, free: 231.6 MB / 2.154 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01785/7.558, allocations: 11.44 MB / 4.246 GB, free: 220.2 MB / 2.154 GB
Notification: Performance of SimCode: time 1.232e-06/7.558, allocations: 0 / 4.246 GB, free: 220.2 MB / 2.154 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.261/8.819, allocations: 0.6684 GB / 4.914 GB, free: 0.711 GB / 2.154 GB
Notification: Performance of buildModelFMU: Generate platform static: time 87.74/96.56, allocations: 4 kB / 4.914 GB, free: 0.711 GB / 2.154 GB
"
[Timeout remaining time 203]
(rm -f Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe ; mkfifo Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe ; head -c 1048576 < Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe >> ../files/Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.sim & python3 -m fmpy simulate  --output-file Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS_res.csv --start-time 0 --stop-time 864000 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 345.6 Buildings_10_Buildings_Experimental_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETS.fmu > Buildings_10_Buildings.Experimental.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 102.29488769300224]