Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.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.001702/0.001702, allocations: 114.2 kB / 18.94 MB, free: 2.953 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.001684/0.001684, allocations: 190.6 kB / 22.23 MB, free: 5.137 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.548/1.548, allocations: 225.6 MB / 251 MB, free: 13.04 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.1-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.1-master/package.mo): time 3.171/3.171, allocations: 0.4893 GB / 0.7884 GB, free: 33.14 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.1-master/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: translateModel(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|bui.ets.proHeaWat.heaPum.QCon_flow_nominal|bui.ets.proHeaWat.heaPum.QCon_flow|bui.bui.QReqHea_flow|bui.bui.QReqCoo_flow|bui.bui.QHea_flow|bui.bui.QCoo_flow|bui.PHea|bui.PPum|bui.ets.proHeaWat.senTDisSup.T|bui.ets.proHeaWat.senTEvaRet.T|bui.ets.QReqHotWat_flow|bui.ets.THotWatSupSet|bui.ets.theMixVal.TMixSet|bui.ets.proHotWat.THotSouSet.y|bui.ets.theMixVal.senTHot.T|bui.ets.proHotWat.heaPumTan.conCha.TTanTopSet|bui.ets.proHotWat.heaPumTan.conCha.TTanTop|bui.ets.proHotWat.heaPumTan.conCha.TTanBot|bui.ets.proHotWat.PHea|bui.ets.proHotWat.PPum|bui.ets.proHotWat.senTDisSup.T|bui.ets.proHotWat.senTEvaRet.T",fileNamePrefix="Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank")
translateModel(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|bui.ets.proHeaWat.heaPum.QCon_flow_nominal|bui.ets.proHeaWat.heaPum.QCon_flow|bui.bui.QReqHea_flow|bui.bui.QReqCoo_flow|bui.bui.QHea_flow|bui.bui.QCoo_flow|bui.PHea|bui.PPum|bui.ets.proHeaWat.senTDisSup.T|bui.ets.proHeaWat.senTEvaRet.T|bui.ets.QReqHotWat_flow|bui.ets.THotWatSupSet|bui.ets.theMixVal.TMixSet|bui.ets.proHotWat.THotSouSet.y|bui.ets.theMixVal.senTHot.T|bui.ets.proHotWat.heaPumTan.conCha.TTanTopSet|bui.ets.proHotWat.heaPumTan.conCha.TTanTop|bui.ets.proHotWat.heaPumTan.conCha.TTanBot|bui.ets.proHotWat.PHea|bui.ets.proHotWat.PPum|bui.ets.proHotWat.senTDisSup.T|bui.ets.proHotWat.senTEvaRet.T",fileNamePrefix="Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.001957/0.001957, allocations: 65.67 kB / 1.145 GB, free: 30.73 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3762/0.3781, allocations: 174.9 MB / 1.316 GB, free: 9.699 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank): time 3.737/4.115, allocations: 1.713 GB / 3.029 GB, free: 1.57 MB / 2.045 GB
Notification: Performance of NFInst.instExpressions: time 1.864/5.979, allocations: 357.3 MB / 3.378 GB, free: 46.38 MB / 2.076 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.09473/6.074, allocations: 2.229 MB / 3.38 GB, free: 46.38 MB / 2.076 GB
Notification: Performance of NFTyping.typeComponents: time 0.154/6.228, allocations: 31.91 MB / 3.411 GB, free: 37.2 MB / 2.076 GB
Notification: Performance of NFTyping.typeBindings: time 0.1507/6.379, allocations: 49.5 MB / 3.46 GB, free: 17.18 MB / 2.076 GB
Notification: Performance of NFTyping.typeClassSections: time 0.09952/6.478, allocations: 38.98 MB / 3.498 GB, free: 5.945 MB / 2.092 GB
Notification: Performance of NFFlatten.flatten: time 0.2592/6.737, allocations: 156.8 MB / 3.651 GB, free: 13.72 MB / 2.232 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.08089/6.818, allocations: 31.66 MB / 3.682 GB, free: 14.44 MB / 2.264 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1246/6.943, allocations: 44.52 MB / 3.725 GB, free: 4.09 MB / 2.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.06198/7.005, allocations: 27.96 MB / 3.752 GB, free: 9.863 MB / 2.326 GB
Notification: Performance of NFPackage.collectConstants: time 0.02086/7.026, allocations: 6.156 MB / 3.758 GB, free: 3.707 MB / 2.326 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07113/7.097, allocations: 23.34 MB / 3.781 GB, free: 13.79 MB / 2.357 GB
Notification: Performance of NFScalarize.scalarize: time 0.02892/7.126, allocations: 13.56 MB / 3.794 GB, free: 420 kB / 2.357 GB
Notification: Performance of NFVerifyModel.verify: time 0.06193/7.188, allocations: 25.54 MB / 3.819 GB, free: 6.945 MB / 2.389 GB
Notification: Performance of NFConvertDAE.convert: time 0.1815/7.369, allocations: 92.24 MB / 3.909 GB, free: 12.64 MB / 2.482 GB
Notification: Performance of FrontEnd - DAE generated: time 8.396e-06/7.369, allocations: 0 / 3.909 GB, free: 12.64 MB / 2.482 GB
Notification: Performance of FrontEnd: time 2.214e-06/7.369, allocations: 0 / 3.909 GB, free: 12.64 MB / 2.482 GB
Notification: Performance of Transformations before backend: time 0.002699/7.372, allocations: 3.938 kB / 3.909 GB, free: 12.64 MB / 2.482 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 5055
 * Number of variables: 5055
Notification: Performance of Generate backend data structure: time 0.161/7.533, allocations: 56.2 MB / 3.964 GB, free: 4.652 MB / 2.529 GB
Notification: Performance of prepare preOptimizeDAE: time 5.188e-05/7.533, allocations: 16.02 kB / 3.964 GB, free: 4.637 MB / 2.529 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05839/7.591, allocations: 9.424 MB / 3.974 GB, free: 11.19 MB / 2.545 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 1.574/9.165, allocations: 66.43 MB / 4.038 GB, free: 1.384 GB / 2.561 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002158/9.167, allocations: 1.668 MB / 4.04 GB, free: 1.383 GB / 2.561 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008133/9.176, allocations: 2.088 MB / 4.042 GB, free: 1.382 GB / 2.561 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.08241/9.258, allocations: 30.13 MB / 4.072 GB, free: 1.368 GB / 2.561 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0009174/9.259, allocations: 53.97 kB / 4.072 GB, free: 1.368 GB / 2.561 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.007188/9.266, allocations: 0.8327 MB / 4.072 GB, free: 1.368 GB / 2.561 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006493/9.267, allocations: 0.7145 MB / 4.073 GB, free: 1.368 GB / 2.561 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07066/9.337, allocations: 26.12 MB / 4.099 GB, free: 1.355 GB / 2.561 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.2423/9.58, allocations: 169 MB / 4.264 GB, free: 1.211 GB / 2.561 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03381/9.613, allocations: 16.19 MB / 4.279 GB, free: 1.196 GB / 2.561 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02181/9.635, allocations: 9.74 MB / 4.289 GB, free: 1.187 GB / 2.561 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.08489/9.72, allocations: 41.8 MB / 4.33 GB, free: 1.146 GB / 2.561 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0263/9.746, allocations: 11.38 MB / 4.341 GB, free: 1.135 GB / 2.561 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01946/9.766, allocations: 2.724 MB / 4.344 GB, free: 1.132 GB / 2.561 GB
Notification: Performance of pre-optimization done (n=1030): time 5.038e-05/9.766, allocations: 0 / 4.344 GB, free: 1.132 GB / 2.561 GB
Notification: Performance of matching and sorting (n=1030): time 0.1657/9.932, allocations: 42.02 MB / 4.385 GB, free: 1.092 GB / 2.561 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001592/9.932, allocations: 0.5398 MB / 4.385 GB, free: 1.092 GB / 2.561 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.07036/10, allocations: 32.86 MB / 4.417 GB, free: 1.06 GB / 2.561 GB
Notification: Performance of collectPreVariables (initialization): time 0.00403/10.01, allocations: 333.7 kB / 4.418 GB, free: 1.059 GB / 2.561 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01783/10.02, allocations: 16.3 MB / 4.433 GB, free: 1.044 GB / 2.561 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005786/10.03, allocations: 3.74 MB / 4.437 GB, free: 1.04 GB / 2.561 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01243/10.04, allocations: 4.761 MB / 4.442 GB, free: 1.035 GB / 2.561 GB
Notification: Performance of setup shared object (initialization): time 4.132e-05/10.04, allocations: 301.1 kB / 4.442 GB, free: 1.035 GB / 2.561 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02508/10.07, allocations: 13.93 MB / 4.456 GB, free: 1.021 GB / 2.561 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02952/10.1, allocations: 19.95 MB / 4.475 GB, free: 0.9998 GB / 2.561 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05084/10.15, allocations: 31.58 MB / 4.506 GB, free: 0.9674 GB / 2.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000151/10.15, allocations: 40 kB / 4.506 GB, free: 0.9673 GB / 2.561 GB
Notification: Performance of matching and sorting (n=2627) (initialization): time 0.1033/10.25, allocations: 40.94 MB / 4.546 GB, free: 0.9273 GB / 2.561 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000179/10.25, allocations: 72.03 kB / 4.546 GB, free: 0.9272 GB / 2.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002224/10.25, allocations: 144 kB / 4.546 GB, free: 0.927 GB / 2.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02151/10.27, allocations: 6.691 MB / 4.553 GB, free: 0.9206 GB / 2.561 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02057/10.29, allocations: 4.06 MB / 4.557 GB, free: 0.9166 GB / 2.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0376/10.33, allocations: 32.47 MB / 4.588 GB, free: 0.8838 GB / 2.561 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03145/10.36, allocations: 1.387 MB / 4.59 GB, free: 0.8824 GB / 2.561 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005428/10.37, allocations: 1.023 MB / 4.591 GB, free: 0.8814 GB / 2.561 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04282/10.41, allocations: 22.12 MB / 4.612 GB, free: 0.8598 GB / 2.561 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02869/10.44, allocations: 18.63 MB / 4.631 GB, free: 0.8392 GB / 2.561 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04663/10.49, allocations: 29.01 MB / 4.659 GB, free: 0.8089 GB / 2.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001511/10.49, allocations: 44 kB / 4.659 GB, free: 0.8088 GB / 2.561 GB
Notification: Performance of matching and sorting (n=2627) (initialization_lambda0): time 0.0959/10.58, allocations: 38.04 MB / 4.696 GB, free: 0.7716 GB / 2.561 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001491/10.58, allocations: 64 kB / 4.696 GB, free: 0.7715 GB / 2.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001819/10.58, allocations: 144 kB / 4.696 GB, free: 0.7714 GB / 2.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02008/10.6, allocations: 6.346 MB / 4.702 GB, free: 0.7653 GB / 2.561 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01832/10.62, allocations: 4.021 MB / 4.706 GB, free: 0.7613 GB / 2.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04468/10.67, allocations: 38.72 MB / 4.744 GB, free: 0.7223 GB / 2.561 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0284/10.69, allocations: 1.451 MB / 4.746 GB, free: 0.7209 GB / 2.561 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004505/10.7, allocations: 0.9567 MB / 4.747 GB, free: 0.7199 GB / 2.561 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 644
 * Number of states: 0 ()
 * Number of discrete variables: 95 ($whenCondition14,$PRE.bui.bui.loa.nextTimeEvent,$whenCondition1,bui.enaSHW.y,bui.ets.theMixVal.conPID.con1.y,bui.bui.terUniCoo.con1.y,bui.bui.terUniHea.con1.y,bui.ets.enaSHW.not_u,$PRE.bui.ets.enaSHW.not_u,$whenCondition10,bui.ets.proHotWat.heaPumTan.conVal.ram.local_reset,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.u,$PRE.bui.ets.enaSHW.u,bui.bui.loa.nextTimeEvent,bui.bui.loa.nextTimeEventScaled,$PRE.bui.bui.loa.nextTimeEventScaled,bui.bui.terUniHea.greThr.greHys.y,$PRE.bui.bui.terUniHea.greThr.greHys.y,bui.bui.terUniCoo.greThr.greHys.y,$PRE.bui.bui.terUniCoo.greThr.greHys.y,bui.ets.swiFlo.con.posDom.greHys.y,$PRE.bui.ets.swiFlo.con.posDom.greHys.y,bui.ets.swiFlo.con.truFalHol.u,$PRE.bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.truFalHol.y,$PRE.bui.ets.swiFlo.con.truFalHol.y,bui.ets.swiFlo.con.truFalHol.not_u,$PRE.bui.ets.swiFlo.con.truFalHol.not_u,bui.ets.swiFlo.con.truFalHol.not_y,$PRE.bui.ets.swiFlo.con.truFalHol.not_y,bui.ets.swiFlo.con.truFalHol.entryTimeTrue,$PRE.bui.ets.swiFlo.con.truFalHol.entryTimeTrue,bui.ets.swiFlo.con.truFalHol.entryTimeFalse,$PRE.bui.ets.swiFlo.con.truFalHol.entryTimeFalse,bui.ets.swiFlo.con.movAve.mode,$PRE.bui.ets.swiFlo.con.movAve.mode,bui.ets.enaHea.u,$PRE.bui.ets.enaHea.u,bui.ets.enaHea.y,$PRE.bui.ets.enaHea.y,bui.ets.enaHea.not_u,$PRE.bui.ets.enaHea.not_u,bui.ets.enaHea.not_y,$PRE.bui.ets.enaHea.not_y,bui.ets.enaHea.entryTimeTrue,$PRE.bui.ets.enaHea.entryTimeTrue,bui.ets.enaHea.entryTimeFalse,$PRE.bui.ets.enaHea.entryTimeFalse,bui.ets.enaSHW.y,$PRE.bui.ets.enaSHW.y,bui.ets.enaSHW.not_y,$PRE.bui.ets.enaSHW.not_y,bui.ets.enaSHW.entryTimeTrue,$PRE.bui.ets.enaSHW.entryTimeTrue,bui.ets.enaSHW.entryTimeFalse,$PRE.bui.ets.enaSHW.entryTimeFalse,bui.ets.proHotWat.heaPumTan.conPum.hysMasFlo.y,$PRE.bui.ets.proHotWat.heaPumTan.conPum.hysMasFlo.y,bui.ets.proHotWat.heaPumTan.conCha.lat.y,bui.ets.proHotWat.heaPumTan.conCha.cha.y,$PRE.bui.ets.proHotWat.heaPumTan.conCha.cha.y,bui.ets.proHotWat.heaPumTan.conCha.cha1.y,$PRE.bui.ets.proHotWat.heaPumTan.conCha.cha1.y,bui.ets.proHotWat.heaPumTan.conVal.cha.y,$PRE.bui.ets.proHotWat.heaPumTan.conVal.cha.y,bui.ets.proHotWat.and2.y,bui.enaHeaCoo[2].y,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2067):
 * Single equations (assignments): 2023
 * Array equations: 12
 * Algorithm blocks: 0
 * Record equations: 10
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 7
 * Torn equation systems: 15
 * 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): 7 systems
   {1, 1, 1, 1, 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): 5 systems
   {(1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (4,8,87.5%), (1,10,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 10 systems
   {(1,4), (1,34), (1,4), (1,2), (1,60), (5,2), (1,4), (6,32), (3,16), (2,12)}
Notification: Performance of prepare postOptimizeDAE: time 0.007603/10.71, allocations: 1.322 MB / 4.748 GB, free: 0.7186 GB / 2.561 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.009868/10.72, allocations: 3.05 MB / 4.751 GB, free: 0.7156 GB / 2.561 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.06967/10.79, allocations: 24.74 MB / 4.775 GB, free: 0.6916 GB / 2.561 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000213/10.79, allocations: 136 kB / 4.775 GB, free: 0.6915 GB / 2.561 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.698e-05/10.79, allocations: 4 kB / 4.775 GB, free: 0.6915 GB / 2.561 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.05293/10.84, allocations: 19.4 MB / 4.794 GB, free: 0.6724 GB / 2.561 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.1346/10.97, allocations: 59.85 MB / 4.853 GB, free: 0.6139 GB / 2.561 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.000112/10.97, allocations: 8 kB / 4.853 GB, free: 0.6139 GB / 2.561 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01197/10.99, allocations: 2.2 MB / 4.855 GB, free: 0.6118 GB / 2.561 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01496/11, allocations: 4.698 MB / 4.859 GB, free: 0.6071 GB / 2.561 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002784/11, allocations: 359.7 kB / 4.86 GB, free: 0.6068 GB / 2.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03345/11.04, allocations: 30.57 MB / 4.889 GB, free: 0.5757 GB / 2.561 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.077e-06/11.04, allocations: 11.94 kB / 4.889 GB, free: 0.5756 GB / 2.561 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.09517/11.13, allocations: 36.34 MB / 4.925 GB, free: 0.5398 GB / 2.561 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01718/11.15, allocations: 6.33 MB / 4.931 GB, free: 0.5336 GB / 2.561 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01036/11.16, allocations: 296 kB / 4.931 GB, free: 0.5333 GB / 2.561 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02095/11.18, allocations: 1.058 MB / 4.932 GB, free: 0.5322 GB / 2.561 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002747/11.18, allocations: 0.8428 MB / 4.933 GB, free: 0.5314 GB / 2.561 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002771/11.19, allocations: 0.5543 MB / 4.934 GB, free: 0.5309 GB / 2.561 GB
Notification: Performance of sorting global known variables: time 0.04248/11.23, allocations: 22.53 MB / 4.956 GB, free: 0.5091 GB / 2.561 GB
Notification: Performance of sort global known variables: time 3.1e-07/11.23, allocations: 3.938 kB / 4.956 GB, free: 0.5091 GB / 2.561 GB
Notification: Performance of remove unused functions: time 0.0536/11.28, allocations: 15.16 MB / 4.971 GB, free: 0.4942 GB / 2.561 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 40
 * Number of states: 44 (bui.ets.theMixVal.eneMetAct.EInt,bui.ets.theMixVal.eneMetReq.EInt,bui.ets.theMixVal.jun.vol.dynBal.U,bui.ets.theMixVal.conPID.I.y,bui.ets.proHotWat.heaPumTan.conVal.ram.y,bui.ets.proHotWat.heaPumTan.senTemRet.T,bui.ets.proHotWat.heaPumTan.conPum.conPI.I.y,bui.ets.proHotWat.heaPumTan.senTemHot.T,bui.ets.proHotWat.heaPumTan.tan.vol[5].dynBal.U,bui.ets.proHotWat.heaPumTan.tan.vol[4].dynBal.U,bui.ets.proHotWat.heaPumTan.tan.vol[3].dynBal.U,bui.ets.proHotWat.heaPumTan.tan.vol[2].dynBal.U,bui.ets.proHotWat.heaPumTan.tan.vol[1].dynBal.U,bui.ets.proHotWat.conPI.I.y,bui.ets.proHotWat.valHeaPumEva.actPos.y,bui.ets.proHotWat.pumEva.motSpe.y,bui.ets.proHotWat.pumCon.motSpe.y,bui.ets.proHotWat.pumCon.vol.dynBal.U,bui.ets.proHotWat.heaPum.eva.vol.dynBal.U,bui.ets.proHotWat.heaPum.con.outCon.T,bui.ets.senTChiWatRet.T,bui.ets.senTHeaWatRet.T,bui.ets.proHeaWat.conPI.I.y,bui.ets.proHeaWat.valHeaPumEva.actPos.y,bui.ets.proHeaWat.pumCon.vol.dynBal.U,bui.ets.proHeaWat.heaPum.eva.vol.dynBal.U,bui.ets.proHeaWat.heaPum.con.outCon.T,bui.ets.swiFlo.con.movAve.mu,bui.ets.senTChiWatSup.T,bui.ets.senTHeaWatSup.T,bui.ets.conTChiWat.conPID.I.y,bui.ets.volChiWat.dynBal.U,bui.ets.volHeaWatRet.dynBal.U,bui.ets.volMix_b.dynBal.U,bui.ets.volMix_a.dynBal.U,bui.bui.terUniCoo.TLoaODE.TAir,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.TWatOutEst,bui.bui.terUniCoo.con.I.y,bui.bui.disFloCoo.senTSup.T,bui.bui.disFloCoo.heaCoo.vol.dynBal.U,bui.bui.disFloHea.senTSup.T,bui.bui.disFloHea.heaCoo.vol.dynBal.U,bui.bui.terUniHea.TLoaODE.TAir,bui.bui.terUniHea.con.I.y)
 * Number of discrete variables: 49 (bui.ets.proHotWat.and2.y,bui.enaHeaCoo[2].y,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,bui.ets.proHotWat.heaPumTan.conVal.cha.y,bui.ets.proHotWat.heaPumTan.conCha.cha1.y,bui.ets.proHotWat.heaPumTan.conCha.cha.y,bui.ets.proHotWat.heaPumTan.conCha.lat.y,bui.ets.proHotWat.heaPumTan.conPum.hysMasFlo.y,bui.ets.enaSHW.entryTimeFalse,bui.ets.enaSHW.entryTimeTrue,bui.ets.enaSHW.not_y,bui.ets.enaSHW.y,bui.ets.enaHea.entryTimeFalse,bui.ets.enaHea.entryTimeTrue,bui.ets.enaHea.not_y,bui.ets.enaHea.not_u,bui.ets.enaHea.y,bui.ets.enaHea.u,bui.ets.swiFlo.con.movAve.mode,bui.ets.swiFlo.con.truFalHol.entryTimeFalse,bui.ets.swiFlo.con.truFalHol.entryTimeTrue,bui.ets.swiFlo.con.truFalHol.not_y,bui.ets.swiFlo.con.truFalHol.not_u,bui.ets.swiFlo.con.truFalHol.y,bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.posDom.greHys.y,bui.bui.terUniCoo.greThr.greHys.y,bui.bui.terUniHea.greThr.greHys.y,bui.bui.loa.nextTimeEventScaled,bui.bui.loa.nextTimeEvent)
 * Number of discrete states: 25 (bui.ets.enaSHW.entryTimeFalse,bui.ets.enaSHW.entryTimeTrue,bui.ets.enaHea.entryTimeFalse,bui.ets.enaHea.entryTimeTrue,bui.ets.swiFlo.con.truFalHol.entryTimeFalse,bui.ets.swiFlo.con.truFalHol.entryTimeTrue,bui.bui.loa.nextTimeEvent,bui.ets.proHotWat.heaPumTan.conVal.cha.y,bui.ets.enaSHW.y,bui.ets.enaSHW.not_y,bui.ets.swiFlo.con.posDom.greHys.y,bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.truFalHol.not_u,bui.ets.swiFlo.con.truFalHol.y,bui.ets.swiFlo.con.truFalHol.not_y,bui.bui.loa.nextTimeEventScaled,bui.bui.terUniCoo.greThr.greHys.y,bui.ets.enaHea.u,bui.ets.enaHea.not_u,bui.ets.enaHea.y,bui.ets.enaHea.not_y,bui.bui.terUniHea.greThr.greHys.y,bui.ets.proHotWat.heaPumTan.conPum.hysMasFlo.y,bui.ets.proHotWat.heaPumTan.conCha.cha.y,bui.ets.proHotWat.heaPumTan.conCha.cha1.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (970):
 * Single equations (assignments): 888
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 48
 * When equations: 13
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 15
 * 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): 6 systems
   {1, 1, 1, 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): 5 systems
   {(1,10,100.0%), (1,3,100.0%), (1,3,100.0%), (4,8,93.8%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 10 systems
   {(2,23), (1,4), (2,12), (1,4), (6,34), (1,4), (1,2), (1,56), (1,1), (1,36)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01068/11.29, allocations: 5.056 MB / 4.976 GB, free: 0.4898 GB / 2.561 GB
Notification: Performance of simCode: created initialization part: time 0.09046/11.38, allocations: 44.15 MB / 5.019 GB, free: 457.2 MB / 2.561 GB
Notification: Performance of simCode: created event and clocks part: time 1.924e-05/11.38, allocations: 11.38 kB / 5.019 GB, free: 457.2 MB / 2.561 GB
Notification: Performance of simCode: created simulation system equations: time 0.02417/11.41, allocations: 11.56 MB / 5.03 GB, free: 445.6 MB / 2.561 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.07055/11.48, allocations: 16.41 MB / 5.046 GB, free: 429.9 MB / 2.561 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1277/11.61, allocations: 64.65 MB / 5.109 GB, free: 365 MB / 2.561 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.03165/11.64, allocations: 15.39 MB / 5.124 GB, free: 349.5 MB / 2.561 GB
Notification: Performance of simCode: alias equations: time 0.03809/11.68, allocations: 7.558 MB / 5.132 GB, free: 342.2 MB / 2.561 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009734/11.69, allocations: 2.092 MB / 5.134 GB, free: 340.1 MB / 2.561 GB
Notification: Performance of SimCode: time 1.543e-06/11.69, allocations: 0 / 5.134 GB, free: 340.1 MB / 2.561 GB
Notification: Performance of Templates: time 2.315/14, allocations: 0.6908 GB / 5.824 GB, free: 1.073 GB / 2.561 GB
"
[Timeout remaining time 286]
make -j1 -f Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe ; mkfifo Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe >> ../files/Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.sim & ./Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe 2>&1) [Timeout 800]
diffSimulationResults("Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETSDHWTank.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.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: 48.18194605410099]