Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.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.001604/0.001604, allocations: 80.3 kB / 19.18 MB, free: 2.516 MB / 14.72 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.001956/0.001956, allocations: 161.4 kB / 22.45 MB, free: 5.375 MB / 14.72 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.459/1.459, allocations: 177.2 MB / 202.8 MB, free: 9.172 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo): time 2.948/2.948, allocations: 377.8 MB / 0.6221 GB, free: 12.62 MB / 0.5919 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.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_12_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_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.703e-06/1.703e-06, allocations: 0 / 0.9814 GB, free: 10.99 MB / 0.8887 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 3.244e-05/3.414e-05, allocations: 6.219 kB / 0.9814 GB, free: 10.98 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank): time 4.751/4.751, allocations: 1.531 GB / 2.512 GB, free: 83.04 MB / 1.732 GB
Notification: Performance of NFInst.instExpressions: time 0.555/5.306, allocations: 334 MB / 2.838 GB, free: 136 kB / 1.826 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.09045/5.397, allocations: 2.259 MB / 2.84 GB, free: 13.85 MB / 1.842 GB
Notification: Performance of NFTyping.typeComponents: time 0.1729/5.57, allocations: 31.43 MB / 2.871 GB, free: 1.223 MB / 1.857 GB
Notification: Performance of NFTyping.typeBindings: time 0.1687/5.738, allocations: 50.71 MB / 2.921 GB, free: 14.31 MB / 1.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1137/5.852, allocations: 39.64 MB / 2.959 GB, free: 6.688 MB / 1.951 GB
Notification: Performance of NFFlatten.flatten: time 2.773/8.626, allocations: 177.8 MB / 3.133 GB, free: 107.4 MB / 2.076 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.07897/8.704, allocations: 31.44 MB / 3.164 GB, free: 105.6 MB / 2.076 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1641/8.869, allocations: 61.64 MB / 3.224 GB, free: 105.6 MB / 2.076 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.05711/8.926, allocations: 23.75 MB / 3.247 GB, free: 104.4 MB / 2.076 GB
Notification: Performance of NFPackage.collectConstants: time 0.01881/8.945, allocations: 5.859 MB / 3.253 GB, free: 104.4 MB / 2.076 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.05887/9.003, allocations: 18.83 MB / 3.271 GB, free: 103.4 MB / 2.076 GB
Notification: Performance of NFScalarize.scalarize: time 0.02255/9.026, allocations: 13.59 MB / 3.284 GB, free: 101.5 MB / 2.076 GB
Notification: Performance of NFVerifyModel.verify: time 0.05205/9.078, allocations: 16.13 MB / 3.3 GB, free: 99.73 MB / 2.076 GB
Notification: Performance of NFConvertDAE.convert: time 0.1366/9.215, allocations: 91.79 MB / 3.39 GB, free: 84 MB / 2.076 GB
Notification: Performance of FrontEnd - DAE generated: time 8.716e-06/9.215, allocations: 0 / 3.39 GB, free: 84 MB / 2.076 GB
Notification: Performance of FrontEnd: time 1.934e-06/9.215, allocations: 0 / 3.39 GB, free: 84 MB / 2.076 GB
Notification: Performance of Transformations before backend: time 0.002625/9.217, allocations: 3.938 kB / 3.39 GB, free: 84 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: 5059
 * Number of variables: 5059
Notification: Performance of Generate backend data structure: time 0.156/9.373, allocations: 55.68 MB / 3.444 GB, free: 57.99 MB / 2.076 GB
Notification: Performance of prepare preOptimizeDAE: time 3.978e-05/9.373, allocations: 7.75 kB / 3.444 GB, free: 57.99 MB / 2.076 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05892/9.432, allocations: 9.552 MB / 3.454 GB, free: 53.87 MB / 2.076 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1326/9.565, allocations: 70.83 MB / 3.523 GB, free: 10.19 MB / 2.076 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002034/9.567, allocations: 1.691 MB / 3.524 GB, free: 8.484 MB / 2.076 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01014/9.577, allocations: 2.072 MB / 3.526 GB, free: 6.418 MB / 2.076 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1092/9.686, allocations: 32.32 MB / 3.558 GB, free: 4.621 MB / 2.108 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001181/9.687, allocations: 58.75 kB / 3.558 GB, free: 4.59 MB / 2.108 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.009569/9.697, allocations: 0.835 MB / 3.559 GB, free: 3.762 MB / 2.108 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008832/9.698, allocations: 0.7136 MB / 3.559 GB, free: 3.047 MB / 2.108 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.08636/9.784, allocations: 25.4 MB / 3.584 GB, free: 9.863 MB / 2.139 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.2934/10.08, allocations: 119.4 MB / 3.701 GB, free: 3.113 MB / 2.248 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04673/10.12, allocations: 15.39 MB / 3.716 GB, free: 3.816 MB / 2.264 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0298/10.15, allocations: 9.363 MB / 3.725 GB, free: 10.43 MB / 2.279 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.1037/10.26, allocations: 32.47 MB / 3.757 GB, free: 10.3 MB / 2.311 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03539/10.29, allocations: 13.05 MB / 3.769 GB, free: 12.59 MB / 2.326 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01798/10.31, allocations: 2.435 MB / 3.772 GB, free: 10.17 MB / 2.326 GB
Notification: Performance of pre-optimization done (n=1030): time 4.078e-05/10.31, allocations: 0 / 3.772 GB, free: 10.17 MB / 2.326 GB
Notification: Performance of matching and sorting (n=1030): time 0.2/10.51, allocations: 40.81 MB / 3.812 GB, free: 1.426 MB / 2.358 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004153/10.51, allocations: 0.5416 MB / 3.812 GB, free: 0.7812 MB / 2.358 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.08164/10.59, allocations: 30.05 MB / 3.842 GB, free: 2.934 MB / 2.389 GB
Notification: Performance of collectPreVariables (initialization): time 0.005157/10.6, allocations: 328.2 kB / 3.842 GB, free: 2.609 MB / 2.389 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03216/10.63, allocations: 16.97 MB / 3.858 GB, free: 1.648 MB / 2.404 GB
Notification: Performance of collectInitialBindings (initialization): time 0.008337/10.64, allocations: 3.649 MB / 3.862 GB, free: 14.05 MB / 2.42 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01729/10.66, allocations: 3.523 MB / 3.865 GB, free: 10.52 MB / 2.42 GB
Notification: Performance of setup shared object (initialization): time 0.0001456/10.66, allocations: 301.1 kB / 3.866 GB, free: 10.22 MB / 2.42 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02907/10.69, allocations: 9.674 MB / 3.875 GB, free: 0.5352 MB / 2.42 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03929/10.72, allocations: 19.77 MB / 3.895 GB, free: 9.352 MB / 2.451 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.06355/10.79, allocations: 23.79 MB / 3.918 GB, free: 116 kB / 2.467 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001843/10.79, allocations: 40 kB / 3.918 GB, free: 76 kB / 2.467 GB
Notification: Performance of matching and sorting (n=1961) (initialization): time 0.1197/10.91, allocations: 31.52 MB / 3.949 GB, free: 1.344 MB / 2.498 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002333/10.91, allocations: 68.03 kB / 3.949 GB, free: 1.277 MB / 2.498 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003087/10.91, allocations: 140 kB / 3.949 GB, free: 1.141 MB / 2.498 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02802/10.94, allocations: 6.711 MB / 3.955 GB, free: 10.41 MB / 2.514 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02255/10.96, allocations: 3.636 MB / 3.959 GB, free: 6.984 MB / 2.514 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05447/11.01, allocations: 32.08 MB / 3.99 GB, free: 5.992 MB / 2.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02979/11.04, allocations: 1.342 MB / 3.992 GB, free: 4.656 MB / 2.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005649/11.05, allocations: 1.031 MB / 3.993 GB, free: 3.625 MB / 2.545 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.6354/11.68, allocations: 18.64 MB / 4.011 GB, free: 1.464 GB / 2.545 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03273/11.72, allocations: 19.24 MB / 4.03 GB, free: 1.453 GB / 2.545 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.05449/11.77, allocations: 22.79 MB / 4.052 GB, free: 1.447 GB / 2.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0003796/11.77, allocations: 40.31 kB / 4.052 GB, free: 1.447 GB / 2.545 GB
Notification: Performance of matching and sorting (n=1961) (initialization_lambda0): time 0.09864/11.87, allocations: 30.36 MB / 4.081 GB, free: 1.437 GB / 2.545 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001799/11.87, allocations: 64.47 kB / 4.082 GB, free: 1.437 GB / 2.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003271/11.87, allocations: 143.2 kB / 4.082 GB, free: 1.437 GB / 2.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0221/11.89, allocations: 6.352 MB / 4.088 GB, free: 1.435 GB / 2.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01867/11.91, allocations: 3.56 MB / 4.091 GB, free: 1.435 GB / 2.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05071/11.96, allocations: 38.19 MB / 4.129 GB, free: 1.409 GB / 2.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0304/11.99, allocations: 1.385 MB / 4.13 GB, free: 1.409 GB / 2.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005452/12, allocations: 0.9129 MB / 4.131 GB, free: 1.408 GB / 2.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 642
 * Number of states: 0 ()
 * Number of discrete variables: 89 ($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.ets.hexChi.flowRegime_nominal,bui.bui.terUniCoo.hexWetNtu.flowRegime_nominal,bui.bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,bui.bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,bui.bui.terUniHea.hex.flowRegime_nominal,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 (1721):
 * Single equations (assignments): 1687
 * Array equations: 12
 * Algorithm blocks: 0
 * Record equations: 0
 * 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,93.8%), (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.009685/12.01, allocations: 1.225 MB / 4.132 GB, free: 1.408 GB / 2.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.011/12.02, allocations: 2.969 MB / 4.135 GB, free: 1.408 GB / 2.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.08589/12.11, allocations: 24.5 MB / 4.159 GB, free: 1.399 GB / 2.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002106/12.11, allocations: 135.6 kB / 4.159 GB, free: 1.399 GB / 2.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.788e-05/12.11, allocations: 11.81 kB / 4.159 GB, free: 1.399 GB / 2.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.06462/12.17, allocations: 18.92 MB / 4.178 GB, free: 1.392 GB / 2.545 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.1517/12.32, allocations: 51.3 MB / 4.228 GB, free: 1.352 GB / 2.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001398/12.32, allocations: 9.469 kB / 4.228 GB, free: 1.352 GB / 2.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01407/12.34, allocations: 2.235 MB / 4.23 GB, free: 1.35 GB / 2.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01621/12.35, allocations: 4.696 MB / 4.234 GB, free: 1.346 GB / 2.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003529/12.36, allocations: 375 kB / 4.235 GB, free: 1.346 GB / 2.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03769/12.39, allocations: 30.32 MB / 4.264 GB, free: 1.317 GB / 2.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.766e-06/12.39, allocations: 15.94 kB / 4.264 GB, free: 1.317 GB / 2.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1028/12.5, allocations: 34.44 MB / 4.298 GB, free: 1.288 GB / 2.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02093/12.52, allocations: 5.985 MB / 4.304 GB, free: 1.282 GB / 2.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01107/12.53, allocations: 299.3 kB / 4.304 GB, free: 1.282 GB / 2.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02216/12.55, allocations: 1.072 MB / 4.305 GB, free: 1.281 GB / 2.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003244/12.55, allocations: 0.8587 MB / 4.306 GB, free: 1.281 GB / 2.545 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003537/12.56, allocations: 0.595 MB / 4.307 GB, free: 1.28 GB / 2.545 GB
Notification: Performance of sorting global known variables: time 0.05267/12.61, allocations: 20.79 MB / 4.327 GB, free: 1.263 GB / 2.545 GB
Notification: Performance of sort global known variables: time 3.51e-07/12.61, allocations: 0 / 4.327 GB, free: 1.263 GB / 2.545 GB
Notification: Performance of remove unused functions: time 0.06122/12.67, allocations: 14.68 MB / 4.341 GB, free: 1.25 GB / 2.545 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 (973):
 * Single equations (assignments): 891
 * 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.01266/12.68, allocations: 5.024 MB / 4.346 GB, free: 1.247 GB / 2.545 GB
Notification: Performance of simCode: created initialization part: time 0.09152/12.78, allocations: 35.16 MB / 4.38 GB, free: 1.214 GB / 2.545 GB
Notification: Performance of simCode: created event and clocks part: time 2.604e-05/12.78, allocations: 13.38 kB / 4.381 GB, free: 1.214 GB / 2.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.02876/12.8, allocations: 11.25 MB / 4.391 GB, free: 1.203 GB / 2.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.07736/12.88, allocations: 16.46 MB / 4.408 GB, free: 1.188 GB / 2.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1596/13.04, allocations: 63.33 MB / 4.469 GB, free: 1.126 GB / 2.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.05257/13.09, allocations: 15.56 MB / 4.485 GB, free: 1.111 GB / 2.545 GB
Notification: Performance of simCode: alias equations: time 0.06522/13.16, allocations: 7.342 MB / 4.492 GB, free: 1.104 GB / 2.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01089/13.17, allocations: 2.222 MB / 4.494 GB, free: 1.101 GB / 2.545 GB
Notification: Performance of SimCode: time 1.633e-06/13.17, allocations: 0 / 4.494 GB, free: 1.101 GB / 2.545 GB
Notification: Performance of Templates: time 1.05/14.22, allocations: 0.6605 GB / 5.154 GB, free: 453.8 MB / 2.545 GB
"
[Timeout remaining time 286]
make -j1 -f Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe ; mkfifo Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe ; head -c 1048576 < Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe >> ../files/Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.sim & ./Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETSDHWTank_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETSDHWTank.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_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: 47.2065351344645]