Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.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.0009916/0.0009916, allocations: 82.64 kB / 20.68 MB, free: 3.816 MB / 18.57 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.0009575/0.0009575, allocations: 181 kB / 24.09 MB, free: 416 kB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.9441/0.9441, allocations: 177.1 MB / 204.5 MB, free: 5.5 MB / 186.7 MB
"
[Timeout remaining time 179]
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 1.809/1.809, allocations: 377.9 MB / 0.624 GB, free: 8.387 MB / 0.5886 GB
"
[Timeout remaining time 178]
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.Examples.Cooling.ElectricChillersDirectETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|buiETS.[0-9,]+..bui.loa.y.[0-9,]+.|dis.mCon_flow.[0-9,]+.|pla.senMasFlo.m_flow|pla.senTCHWSup.T|buiETS.[0-9,]+..ets.senTBuiSup.T|buiETS.[0-9,]+..ets.senTBuiRet.T",fileNamePrefix="Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS")
translateModel(Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|buiETS.[0-9,]+..bui.loa.y.[0-9,]+.|dis.mCon_flow.[0-9,]+.|pla.senMasFlo.m_flow|pla.senTCHWSup.T|buiETS.[0-9,]+..ets.senTBuiSup.T|buiETS.[0-9,]+..ets.senTBuiRet.T",fileNamePrefix="Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.924e-06/1.924e-06, allocations: 0 / 0.812 GB, free: 1.496 MB / 0.7605 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.865e-05/2.057e-05, allocations: 2.312 kB / 0.812 GB, free: 1.492 MB / 0.7605 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS): time 0.7606/0.7607, allocations: 427.8 MB / 1.23 GB, free: 35.75 MB / 0.9948 GB
Notification: Performance of NFInst.instExpressions: time 0.1595/0.9202, allocations: 118.1 MB / 1.345 GB, free: 488 kB / 1.057 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04377/0.9639, allocations: 1.802 MB / 1.347 GB, free: 14.66 MB / 1.073 GB
Notification: Performance of NFTyping.typeComponents: time 0.02025/0.9842, allocations: 7.932 MB / 1.355 GB, free: 6.676 MB / 1.073 GB
Notification: Performance of NFTyping.typeBindings: time 0.05004/1.034, allocations: 25 MB / 1.379 GB, free: 13.55 MB / 1.104 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03632/1.071, allocations: 21.6 MB / 1.4 GB, free: 7.941 MB / 1.12 GB
Notification: Performance of NFFlatten.flatten: time 1.372/2.442, allocations: 288.4 MB / 1.682 GB, free: 66.67 MB / 1.214 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1035/2.546, allocations: 51.82 MB / 1.732 GB, free: 45.73 MB / 1.214 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.2015/2.747, allocations: 87.99 MB / 1.818 GB, free: 12.38 MB / 1.261 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.08355/2.831, allocations: 43.46 MB / 1.861 GB, free: 4.223 MB / 1.292 GB
Notification: Performance of NFPackage.collectConstants: time 0.02336/2.854, allocations: 7.547 MB / 1.868 GB, free: 12.67 MB / 1.307 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0507/2.905, allocations: 12.48 MB / 1.88 GB, free: 0.6562 MB / 1.307 GB
Notification: Performance of NFScalarize.scalarize: time 0.03054/2.935, allocations: 19.61 MB / 1.899 GB, free: 13.87 MB / 1.339 GB
Notification: Performance of NFVerifyModel.verify: time 0.06239/2.998, allocations: 23.76 MB / 1.923 GB, free: 6.871 MB / 1.354 GB
Notification: Performance of NFConvertDAE.convert: time 0.1096/3.107, allocations: 63.12 MB / 1.984 GB, free: 11.51 MB / 1.417 GB
Notification: Performance of FrontEnd - DAE generated: time 7.525e-06/3.107, allocations: 0 / 1.984 GB, free: 11.51 MB / 1.417 GB
Notification: Performance of FrontEnd: time 1.633e-06/3.107, allocations: 0 / 1.984 GB, free: 11.51 MB / 1.417 GB
Notification: Performance of Transformations before backend: time 0.003474/3.111, allocations: 0 / 1.984 GB, free: 11.51 MB / 1.417 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 7786
 * Number of variables: 7786
Notification: Performance of Generate backend data structure: time 1.248/4.359, allocations: 114.4 MB / 2.096 GB, free: 292.8 MB / 1.448 GB
Notification: Performance of prepare preOptimizeDAE: time 5.179e-05/4.359, allocations: 11.38 kB / 2.096 GB, free: 292.8 MB / 1.448 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05501/4.414, allocations: 16.44 MB / 2.112 GB, free: 289.2 MB / 1.448 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1106/4.525, allocations: 86.05 MB / 2.196 GB, free: 281.6 MB / 1.448 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002905/4.528, allocations: 2.823 MB / 2.199 GB, free: 281.1 MB / 1.448 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.009771/4.538, allocations: 3.263 MB / 2.202 GB, free: 281.1 MB / 1.448 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06604/4.604, allocations: 33.13 MB / 2.234 GB, free: 259.4 MB / 1.448 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001007/4.605, allocations: 89.81 kB / 2.234 GB, free: 259.4 MB / 1.448 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.007154/4.612, allocations: 1.268 MB / 2.236 GB, free: 258.1 MB / 1.448 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006735/4.613, allocations: 1.145 MB / 2.237 GB, free: 257 MB / 1.448 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04161/4.654, allocations: 12.37 MB / 2.249 GB, free: 244.9 MB / 1.448 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.237/4.891, allocations: 185.5 MB / 2.43 GB, free: 67.94 MB / 1.448 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02321/4.914, allocations: 13.93 MB / 2.444 GB, free: 54.36 MB / 1.448 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.009587/4.924, allocations: 4.849 MB / 2.448 GB, free: 49.57 MB / 1.448 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.09163/5.016, allocations: 43.91 MB / 2.491 GB, free: 7.09 MB / 1.448 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01473/5.03, allocations: 12.15 MB / 2.503 GB, free: 10.33 MB / 1.464 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01974/5.05, allocations: 3.28 MB / 2.506 GB, free: 7.414 MB / 1.464 GB
Notification: Performance of pre-optimization done (n=1714): time 5.447e-05/5.05, allocations: 0 / 2.506 GB, free: 7.414 MB / 1.464 GB
Notification: Performance of matching and sorting (n=1714): time 0.1082/5.158, allocations: 35.98 MB / 2.541 GB, free: 3.504 MB / 1.495 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003368/5.159, allocations: 0.8689 MB / 2.542 GB, free: 2.469 MB / 1.495 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.6937/5.852, allocations: 43.85 MB / 2.585 GB, free: 322 MB / 1.526 GB
Notification: Performance of collectPreVariables (initialization): time 0.005374/5.858, allocations: 0.4905 MB / 2.586 GB, free: 322 MB / 1.526 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03264/5.89, allocations: 30.34 MB / 2.615 GB, free: 321.4 MB / 1.526 GB
Notification: Performance of collectInitialBindings (initialization): time 0.009387/5.9, allocations: 6.517 MB / 2.622 GB, free: 319.7 MB / 1.526 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01307/5.913, allocations: 6.426 MB / 2.628 GB, free: 319.3 MB / 1.526 GB
Notification: Performance of setup shared object (initialization): time 4.788e-05/5.913, allocations: 481.7 kB / 2.628 GB, free: 318.8 MB / 1.526 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01176/5.925, allocations: 4.218 MB / 2.632 GB, free: 318.6 MB / 1.526 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01782/5.942, allocations: 22.03 MB / 2.654 GB, free: 297.6 MB / 1.526 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02449/5.967, allocations: 18.79 MB / 2.672 GB, free: 286.3 MB / 1.526 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000257/5.967, allocations: 59.12 kB / 2.672 GB, free: 286.3 MB / 1.526 GB
Notification: Performance of matching and sorting (n=3110) (initialization): time 0.05958/6.027, allocations: 24.87 MB / 2.697 GB, free: 283 MB / 1.526 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001363/6.027, allocations: 94.56 kB / 2.697 GB, free: 283 MB / 1.526 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003763/6.027, allocations: 221.8 kB / 2.697 GB, free: 283 MB / 1.526 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.4313/6.459, allocations: 107.2 MB / 2.802 GB, free: 259.5 MB / 1.526 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01616/6.475, allocations: 5.481 MB / 2.807 GB, free: 254.5 MB / 1.526 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01415/6.489, allocations: 27.93 MB / 2.834 GB, free: 226.7 MB / 1.526 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02822/6.517, allocations: 1.476 MB / 2.836 GB, free: 225.7 MB / 1.526 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006155/6.523, allocations: 1.284 MB / 2.837 GB, free: 224.6 MB / 1.526 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02228/6.546, allocations: 4.596 MB / 2.841 GB, free: 220.9 MB / 1.526 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01334/6.559, allocations: 21.91 MB / 2.863 GB, free: 194.5 MB / 1.526 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01791/6.577, allocations: 18.59 MB / 2.881 GB, free: 175.3 MB / 1.526 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001448/6.577, allocations: 60 kB / 2.881 GB, free: 175.2 MB / 1.526 GB
Notification: Performance of matching and sorting (n=3110) (initialization_lambda0): time 0.05184/6.629, allocations: 24.72 MB / 2.905 GB, free: 154.1 MB / 1.526 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001104/6.629, allocations: 93 kB / 2.905 GB, free: 154 MB / 1.526 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002615/6.629, allocations: 227.9 kB / 2.905 GB, free: 153.8 MB / 1.526 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.4813/7.11, allocations: 106.7 MB / 3.01 GB, free: 47.57 MB / 1.526 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01671/7.127, allocations: 5.433 MB / 3.015 GB, free: 42.66 MB / 1.526 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.018/7.145, allocations: 29.3 MB / 3.044 GB, free: 14.75 MB / 1.526 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03069/7.176, allocations: 1.527 MB / 3.045 GB, free: 13.64 MB / 1.526 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006836/7.183, allocations: 1.185 MB / 3.046 GB, free: 12.65 MB / 1.526 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 932
 * Number of states: 0 ()
 * Number of discrete variables: 147 ($PRE.pla.chiStaCon.offToOne.enableFire,$PRE.pla.chiStaCon.oneToTwo.enableFire,$PRE.pla.chiStaCon.twoToOne.enableFire,$PRE.pla.chiStaCon.oneToOff.enableFire,$PRE.buiETS[1].bui.loa.nextTimeEvent,$whenCondition6,$PRE.buiETS[2].bui.loa.nextTimeEvent,$whenCondition5,$PRE.buiETS[3].bui.loa.nextTimeEvent,$whenCondition4,pla.chiStaCon.stateGraphRoot.resume,pla.chiStaCon.stateGraphRoot.suspend,buiETS[3].ets.con.con1.y,buiETS[2].ets.con.con1.y,buiETS[1].ets.con.con1.y,pla.cooTowWitByp.cooTowSpeCon.con1.y,pla.mulChiSys.chi[2].tru.y,pla.mulChiSys.chi[1].tru.y,buiETS[3].bui.terUniCoo.hexWetNtu.flowRegime_nominal,buiETS[3].bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,buiETS[3].bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,buiETS[2].bui.terUniCoo.hexWetNtu.flowRegime_nominal,buiETS[2].bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,buiETS[2].bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,buiETS[1].bui.terUniCoo.hexWetNtu.flowRegime_nominal,buiETS[1].bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,buiETS[1].bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,pla.cooTowWitByp.hys.y,$PRE.pla.cooTowWitByp.hys.y,pla.pumCHW.hys[1].y,$PRE.pla.pumCHW.hys[1].y,pla.pumCHW.hys[2].y,$PRE.pla.pumCHW.hys[2].y,pla.pumCW.hys[1].y,$PRE.pla.pumCW.hys[1].y,pla.pumCW.hys[2].y,$PRE.pla.pumCW.hys[2].y,pla.chiStaCon.stateGraphRoot.activeSteps,pla.chiStaCon.y[1],pla.chiStaCon.off.active,pla.chiStaCon.off.localActive,$PRE.pla.chiStaCon.off.localActive,pla.chiStaCon.off.newActive,$PRE.pla.chiStaCon.off.newActive,pla.chiStaCon.off.oldActive,$PRE.pla.chiStaCon.off.oldActive,pla.chiStaCon.oneOn.localActive,$PRE.pla.chiStaCon.oneOn.localActive,pla.chiStaCon.oneOn.inPort[2].occupied,pla.chiStaCon.oneOn.outPort[2].available,pla.chiStaCon.oneOn.newActive,$PRE.pla.chiStaCon.oneOn.newActive,pla.chiStaCon.oneOn.oldActive,$PRE.pla.chiStaCon.oneOn.oldActive,pla.chiStaCon.oneOn.active,pla.chiStaCon.twoOn.localActive,$PRE.pla.chiStaCon.twoOn.localActive,pla.chiStaCon.twoOn.newActive,$PRE.pla.chiStaCon.twoOn.newActive,pla.chiStaCon.twoOn.oldActive,$PRE.pla.chiStaCon.twoOn.oldActive,pla.chiStaCon.twoOn.active,pla.chiStaCon.offToOne.enableFire,pla.chiStaCon.offToOne.fire,pla.chiStaCon.offToOne.t_start,$PRE.pla.chiStaCon.offToOne.t_start,pla.chiStaCon.oneToTwo.enableFire,pla.chiStaCon.oneToTwo.fire,pla.chiStaCon.oneToTwo.t_start,$PRE.pla.chiStaCon.oneToTwo.t_start,pla.chiStaCon.twoToOne.localCondition,pla.chiStaCon.twoToOne.enableFire,pla.chiStaCon.twoToOne.fire,pla.chiStaCon.twoToOne.t_start,$PRE.pla.chiStaCon.twoToOne.t_start,pla.chiStaCon.oneToOff.enableFire,pla.chiStaCon.oneToOff.fire,pla.chiStaCon.oneToOff.t_start,$PRE.pla.chiStaCon.oneToOff.t_start,pla.chiStaCon.thrOneToTwo.y,$PRE.pla.chiStaCon.thrOneToTwo.y,pla.chiBypCon.booToInt[1].y,pla.chiBypCon.booToInt[2].y,pla.chiBypCon.intGreThr.y,pla.chiBypCon.numChiOn.y,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,weaDat.locTim.k,$PRE.weaDat.locTim.k,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.conTimMin.k,$PRE.weaDat.conTimMin.k,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTim.k,$PRE.weaDat.conTim.k,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.eqnTim.k,$PRE.weaDat.eqnTim.k,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.decAng.k,$PRE.weaDat.decAng.k,buiETS[1].bui.loa.nextTimeEvent,buiETS[1].bui.loa.nextTimeEventScaled,$PRE.buiETS[1].bui.loa.nextTimeEventScaled,buiETS[1].bui.terUniCoo.greThr.greHys.y,$PRE.buiETS[1].bui.terUniCoo.greThr.greHys.y,buiETS[2].bui.loa.nextTimeEvent,buiETS[2].bui.loa.nextTimeEventScaled,$PRE.buiETS[2].bui.loa.nextTimeEventScaled,buiETS[2].bui.terUniCoo.greThr.greHys.y,$PRE.buiETS[2].bui.terUniCoo.greThr.greHys.y,buiETS[3].bui.loa.nextTimeEvent,buiETS[3].bui.loa.nextTimeEventScaled,$PRE.buiETS[3].bui.loa.nextTimeEventScaled,buiETS[3].bui.terUniCoo.greThr.greHys.y,$PRE.buiETS[3].bui.terUniCoo.greThr.greHys.y,offCoo.y,tim.passed,$PRE.tim.passed,tim.entryTime,$PRE.tim.entryTime,$whenCondition3,$whenCondition2,$whenCondition1,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,buiETS[3].ets.int.local_reset,buiETS[2].ets.int.local_reset,buiETS[1].ets.int.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2769):
 * Single equations (assignments): 2716
 * Array equations: 15
 * Algorithm blocks: 0
 * Record equations: 14
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 8
 * Torn equation systems: 16
 * 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): 8 systems
   {1, 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 16 systems
   {(7,50), (1,6), (1,6), (4,11), (1,1), (1,1), (1,2), (1,2), (2,59), (5,2), (1,2), (2,59), (5,2), (1,2), (2,59), (5,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.008076/7.191, allocations: 1.889 MB / 3.048 GB, free: 11.88 MB / 1.526 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01471/7.205, allocations: 5.156 MB / 3.053 GB, free: 6.902 MB / 1.526 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04776/7.253, allocations: 23.21 MB / 3.076 GB, free: 4.254 MB / 1.542 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001469/7.253, allocations: 222.9 kB / 3.076 GB, free: 4.047 MB / 1.542 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.624e-05/7.253, allocations: 0 / 3.076 GB, free: 4.047 MB / 1.542 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02888/7.282, allocations: 12.81 MB / 3.088 GB, free: 8.578 MB / 1.558 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.779/8.061, allocations: 64.64 MB / 3.152 GB, free: 357.1 MB / 1.589 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001295/8.061, allocations: 33.91 kB / 3.152 GB, free: 357.1 MB / 1.589 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0103/8.072, allocations: 3.264 MB / 3.155 GB, free: 357.1 MB / 1.589 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.2611/8.333, allocations: 65.24 MB / 3.218 GB, free: 354.1 MB / 1.589 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.004714/8.337, allocations: 0.6248 MB / 3.219 GB, free: 354.1 MB / 1.589 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01165/8.349, allocations: 22.73 MB / 3.241 GB, free: 334.7 MB / 1.589 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.975e-06/8.349, allocations: 18.12 kB / 3.241 GB, free: 334.7 MB / 1.589 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0647/8.414, allocations: 25.05 MB / 3.266 GB, free: 331.3 MB / 1.589 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0272/8.441, allocations: 9.055 MB / 3.275 GB, free: 331.3 MB / 1.589 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01286/8.454, allocations: 467.4 kB / 3.275 GB, free: 331.3 MB / 1.589 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02716/8.481, allocations: 1.103 MB / 3.276 GB, free: 331.2 MB / 1.589 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.004526/8.486, allocations: 1.378 MB / 3.277 GB, free: 331.2 MB / 1.589 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002828/8.488, allocations: 0.8023 MB / 3.278 GB, free: 331.2 MB / 1.589 GB
Notification: Performance of sorting global known variables: time 0.04508/8.533, allocations: 23.24 MB / 3.301 GB, free: 329.6 MB / 1.589 GB
Notification: Performance of sort global known variables: time 3.01e-07/8.533, allocations: 0 / 3.301 GB, free: 329.6 MB / 1.589 GB
Notification: Performance of remove unused functions: time 0.07145/8.605, allocations: 22.2 MB / 3.323 GB, free: 322 MB / 1.589 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 50
 * Number of states: 94 (buiETS[3].ets.senTBuiSup.T,buiETS[3].ets.con.I.y,buiETS[3].ets.int.y,buiETS[3].ets.senTBuiRet.T,buiETS[3].ets.conVal.actPos.y,buiETS[3].ets.spl.vol.dynBal.U,buiETS[3].ets.senTDisRet.T,buiETS[3].ets.jun.vol.dynBal.U,buiETS[3].ets.senTDisSup.T,buiETS[3].bui.terUniCoo.TLoaODE.TAir,buiETS[3].bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.TWatOutEst,buiETS[3].bui.terUniCoo.con.I.y,buiETS[3].bui.disFloCoo.senTSup.T,buiETS[3].bui.disFloCoo.heaCoo.vol.dynBal.U,buiETS[2].ets.senTBuiSup.T,buiETS[2].ets.con.I.y,buiETS[2].ets.int.y,buiETS[2].ets.senTBuiRet.T,buiETS[2].ets.conVal.actPos.y,buiETS[2].ets.spl.vol.dynBal.U,buiETS[2].ets.senTDisRet.T,buiETS[2].ets.jun.vol.dynBal.U,buiETS[2].ets.senTDisSup.T,buiETS[2].bui.terUniCoo.TLoaODE.TAir,buiETS[2].bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.TWatOutEst,buiETS[2].bui.terUniCoo.con.I.y,buiETS[2].bui.disFloCoo.senTSup.T,buiETS[2].bui.disFloCoo.heaCoo.vol.dynBal.U,buiETS[1].ets.senTBuiSup.T,buiETS[1].ets.con.I.y,buiETS[1].ets.int.y,buiETS[1].ets.senTBuiRet.T,buiETS[1].ets.conVal.actPos.y,buiETS[1].ets.spl.vol.dynBal.U,buiETS[1].ets.senTDisRet.T,buiETS[1].ets.jun.vol.dynBal.U,buiETS[1].ets.senTDisSup.T,buiETS[1].bui.terUniCoo.TLoaODE.TAir,buiETS[1].bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.TWatOutEst,buiETS[1].bui.terUniCoo.con.I.y,buiETS[1].bui.disFloCoo.senTSup.T,buiETS[1].bui.disFloCoo.heaCoo.vol.dynBal.U,dis.pipEnd.vol_a.dynBal.U,dis.pipEnd.vol_b.dynBal.U,dis.pipEnd.timDel.x,dis.pipEnd.del.x,dis.con[3].junConRet.vol.dynBal.U,dis.con[3].junConSup.vol.dynBal.U,dis.con[3].pipDisRet.vol_a.dynBal.U,dis.con[3].pipDisRet.vol_b.dynBal.U,dis.con[3].pipDisRet.timDel.x,dis.con[3].pipDisRet.del.x,dis.con[3].pipDisSup.vol_a.dynBal.U,dis.con[3].pipDisSup.vol_b.dynBal.U,dis.con[3].pipDisSup.timDel.x,dis.con[3].pipDisSup.del.x,dis.con[2].junConRet.vol.dynBal.U,dis.con[2].junConSup.vol.dynBal.U,dis.con[2].pipDisRet.vol_a.dynBal.U,dis.con[2].pipDisRet.vol_b.dynBal.U,dis.con[2].pipDisRet.timDel.x,dis.con[2].pipDisRet.del.x,dis.con[2].pipDisSup.vol_a.dynBal.U,dis.con[2].pipDisSup.vol_b.dynBal.U,dis.con[2].pipDisSup.timDel.x,dis.con[2].pipDisSup.del.x,dis.con[1].junConRet.vol.dynBal.U,dis.con[1].junConSup.vol.dynBal.U,dis.con[1].pipDisRet.vol_a.dynBal.U,dis.con[1].pipDisRet.vol_b.dynBal.U,dis.con[1].pipDisRet.timDel.x,dis.con[1].pipDisRet.del.x,dis.con[1].pipDisSup.vol_a.dynBal.U,dis.con[1].pipDisSup.vol_b.dynBal.U,dis.con[1].pipDisSup.timDel.x,dis.con[1].pipDisSup.del.x,pla.chiBypCon.bypValCon.I.y,pla.senTCHWRet.T,pla.senTCHWSup.T,pla.valByp.actPos.y,pla.pumCW.pum[2].vol.dynBal.U,pla.pumCW.pum[1].vol.dynBal.U,pla.pumCHW.pum[2].vol.dynBal.U,pla.pumCHW.pum[1].vol.dynBal.U,pla.cooTowWitByp.cooTowSpeCon.I.y,pla.cooTowWitByp.bypValCon.I.y,pla.cooTowWitByp.senTCWSup.T,pla.cooTowWitByp.cooTowSys.senTem.T,pla.cooTowWitByp.cooTowSys.cooTow[2].vol.dynBal.U,pla.cooTowWitByp.cooTowSys.cooTow[1].vol.dynBal.U,pla.mulChiSys.chi[2].vol2.dynBal.U,pla.mulChiSys.chi[2].vol1.dynBal.U,pla.mulChiSys.chi[1].vol2.dynBal.U,pla.mulChiSys.chi[1].vol1.dynBal.U)
 * Number of discrete variables: 81 (pla.chiStaCon.twoToOne.enableFire,pla.chiStaCon.oneToOff.enableFire,pla.chiStaCon.oneToTwo.enableFire,pla.chiStaCon.off.active,pla.chiStaCon.offToOne.enableFire,pla.chiStaCon.oneOn.active,pla.chiStaCon.y[1],pla.chiBypCon.intGreThr.y,pla.chiStaCon.twoOn.active,offCoo.y,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition1,$whenCondition2,$whenCondition3,tim.entryTime,tim.passed,buiETS[3].bui.terUniCoo.greThr.greHys.y,buiETS[3].bui.loa.nextTimeEventScaled,buiETS[3].bui.loa.nextTimeEvent,buiETS[2].bui.terUniCoo.greThr.greHys.y,buiETS[2].bui.loa.nextTimeEventScaled,buiETS[2].bui.loa.nextTimeEvent,buiETS[1].bui.terUniCoo.greThr.greHys.y,buiETS[1].bui.loa.nextTimeEventScaled,buiETS[1].bui.loa.nextTimeEvent,weaDat.decAng.k,weaDat.decAng.tNext,weaDat.eqnTim.k,weaDat.eqnTim.tNext,weaDat.conTim.k,weaDat.conTim.tNext,weaDat.conTimMin.k,weaDat.conTimMin.tNext,weaDat.locTim.k,weaDat.locTim.tNext,pla.chiBypCon.numChiOn.y,pla.chiBypCon.booToInt[2].y,pla.chiBypCon.booToInt[1].y,pla.chiStaCon.thrOneToTwo.y,pla.chiStaCon.oneToOff.t_start,pla.chiStaCon.oneToOff.fire,pla.chiStaCon.twoToOne.t_start,pla.chiStaCon.twoToOne.fire,pla.chiStaCon.twoToOne.localCondition,pla.chiStaCon.oneToTwo.t_start,pla.chiStaCon.oneToTwo.fire,pla.chiStaCon.offToOne.t_start,pla.chiStaCon.offToOne.fire,pla.chiStaCon.twoOn.oldActive,pla.chiStaCon.twoOn.newActive,pla.chiStaCon.twoOn.localActive,pla.chiStaCon.oneOn.oldActive,pla.chiStaCon.oneOn.newActive,pla.chiStaCon.oneOn.outPort[2].available,pla.chiStaCon.oneOn.inPort[2].occupied,pla.chiStaCon.oneOn.localActive,pla.chiStaCon.off.oldActive,pla.chiStaCon.off.newActive,pla.chiStaCon.off.localActive,pla.chiStaCon.stateGraphRoot.activeSteps,pla.pumCW.hys[2].y,pla.pumCW.hys[1].y,pla.pumCHW.hys[2].y,pla.pumCHW.hys[1].y,pla.cooTowWitByp.hys.y)
 * Number of discrete states: 29 (buiETS[1].bui.loa.nextTimeEvent,buiETS[2].bui.loa.nextTimeEvent,buiETS[3].bui.loa.nextTimeEvent,buiETS[3].bui.loa.nextTimeEventScaled,buiETS[3].bui.terUniCoo.greThr.greHys.y,buiETS[2].bui.loa.nextTimeEventScaled,buiETS[2].bui.terUniCoo.greThr.greHys.y,buiETS[1].bui.loa.nextTimeEventScaled,tim.entryTime,buiETS[1].bui.terUniCoo.greThr.greHys.y,weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k,pla.chiStaCon.twoOn.newActive,pla.chiStaCon.oneOn.newActive,pla.chiStaCon.off.newActive,pla.pumCW.hys[2].y,pla.pumCW.hys[1].y,pla.pumCHW.hys[2].y,pla.pumCHW.hys[1].y,pla.cooTowWitByp.hys.y,pla.chiStaCon.thrOneToTwo.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1697):
 * Single equations (assignments): 1549
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 104
 * When equations: 25
 * If-equations: 0
 * Equation systems (not torn): 5
 * Torn equation systems: 14
 * 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): 5 systems
   {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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 14 systems
   {(1,2), (7,49), (3,54), (1,1), (1,2), (3,54), (1,1), (1,2), (3,54), (1,1), (1,6), (1,6), (1,3), (4,11)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.008769/8.614, allocations: 2.642 MB / 3.325 GB, free: 320.6 MB / 1.589 GB
Notification: Performance of simCode: created initialization part: time 0.06356/8.677, allocations: 26.99 MB / 3.352 GB, free: 301 MB / 1.589 GB
Notification: Performance of simCode: created event and clocks part: time 2.561e-05/8.677, allocations: 18.06 kB / 3.352 GB, free: 301 MB / 1.589 GB
Notification: Performance of simCode: created simulation system equations: time 0.01608/8.693, allocations: 8.071 MB / 3.359 GB, free: 294.9 MB / 1.589 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.1243/8.818, allocations: 27.9 MB / 3.387 GB, free: 275.8 MB / 1.589 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.138/8.956, allocations: 91.11 MB / 3.476 GB, free: 193.6 MB / 1.589 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02114/8.977, allocations: 16.15 MB / 3.491 GB, free: 181.6 MB / 1.589 GB
Notification: Performance of simCode: alias equations: time 0.04006/9.017, allocations: 9.426 MB / 3.501 GB, free: 172.2 MB / 1.589 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.05995/9.077, allocations: 18.2 MB / 3.518 GB, free: 154.6 MB / 1.589 GB
Notification: Performance of SimCode: time 1.683e-06/9.077, allocations: 0 / 3.518 GB, free: 154.6 MB / 1.589 GB
Notification: Performance of Templates: time 2.773/11.85, allocations: 1.122 GB / 4.64 GB, free: 218.3 MB / 1.667 GB
"
[Timeout remaining time 288]
make -j1 -f Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.pipe ; mkfifo Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.pipe ; head -c 1048576 < Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.pipe >> ../files/Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.sim & ./Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.DHC.Examples.Cooling.ElectricChillersDirectETS.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 276.6913735852577]