Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.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.001374/0.001374, allocations: 108.8 kB / 18.93 MB, free: 2.945 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.001457/0.001457, allocations: 191.3 kB / 22.23 MB, free: 5.156 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.403/1.403, allocations: 225.6 MB / 251 MB, free: 13.02 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.2-maint.10.0.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.2-maint.10.0.x/package.mo): time 2.611/2.611, allocations: 443.4 MB / 0.7321 GB, free: 12.3 MB / 0.5919 GB
"
[Timeout remaining time 177]
Using package Buildings with version 10.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.2-maint.10.0.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly,tolerance=1e-06,outputFormat="mat",numberOfIntervals=12531,variableFilter="time|ets.tanHeaWat.TTop|ets.tanHeaWat.TBot|senTHeaWatSup.T|senTHeaWatRet.T|ets.conSup.THeaWatSupPreSet|ets.conSup.THeaWatSupSet|ets.tanChiWat.TTop|ets.tanChiWat.TBot|senTChiWatSup.T|senTChiWatRet.T|ets.conSup.TChiWatSupPreSet|ets.conSup.TChiWatSupSet|ets.conSup.yHea|ets.conSup.yCoo|ets.conSup.yAmb.1.|ets.chi.pumCon.m_flow|ets.chi.pumEva.m_flow|ets.hex.pum1.m_flow|ets.hex.pum2.m_flow|ets.hex.m1_flow_nominal|ets.hex.m2_flow_nominal|ets.valIsoEva.y_actual|ets.valIsoCon.y_actual|senTDisWatSup.T|senTDisWatRet.T|ets.hex.senT2WatEnt.T|ets.hex.senT2WatLvg.T|ets.chi.senTConEnt.T|ets.chi.senTConLvg.T|ets.chi.senTEvaEnt.T|ets.chi.senTEvaLvg.T|ets.chi.chi.COP|ets.datChi.COP_nominal|ets.chi.chi.PLR2|ets.QChiWat_flow_nominal|ets.QHeaWat_flow_nominal",fileNamePrefix="Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly")
translateModel(Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly,tolerance=1e-06,outputFormat="mat",numberOfIntervals=12531,variableFilter="time|ets.tanHeaWat.TTop|ets.tanHeaWat.TBot|senTHeaWatSup.T|senTHeaWatRet.T|ets.conSup.THeaWatSupPreSet|ets.conSup.THeaWatSupSet|ets.tanChiWat.TTop|ets.tanChiWat.TBot|senTChiWatSup.T|senTChiWatRet.T|ets.conSup.TChiWatSupPreSet|ets.conSup.TChiWatSupSet|ets.conSup.yHea|ets.conSup.yCoo|ets.conSup.yAmb.1.|ets.chi.pumCon.m_flow|ets.chi.pumEva.m_flow|ets.hex.pum1.m_flow|ets.hex.pum2.m_flow|ets.hex.m1_flow_nominal|ets.hex.m2_flow_nominal|ets.valIsoEva.y_actual|ets.valIsoCon.y_actual|senTDisWatSup.T|senTDisWatRet.T|ets.hex.senT2WatEnt.T|ets.hex.senT2WatLvg.T|ets.chi.senTConEnt.T|ets.chi.senTConLvg.T|ets.chi.senTEvaEnt.T|ets.chi.senTEvaLvg.T|ets.chi.chi.COP|ets.datChi.COP_nominal|ets.chi.chi.PLR2|ets.QChiWat_flow_nominal|ets.QHeaWat_flow_nominal",fileNamePrefix="Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002438/0.002438, allocations: 63.89 kB / 1.062 GB, free: 2.965 MB / 0.8575 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7496/0.7521, allocations: 160.8 MB / 1.219 GB, free: 3.695 MB / 0.92 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly): time 2.972/3.724, allocations: 1.53 GB / 2.749 GB, free: 9.262 MB / 1.654 GB
Notification: Performance of NFInst.instExpressions: time 1.423/5.147, allocations: 280.2 MB / 3.022 GB, free: 31.71 MB / 1.826 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05248/5.199, allocations: 1.799 MB / 3.024 GB, free: 31.71 MB / 1.826 GB
Notification: Performance of NFTyping.typeComponents: time 0.04206/5.241, allocations: 15.18 MB / 3.039 GB, free: 31.67 MB / 1.826 GB
Notification: Performance of NFTyping.typeBindings: time 0.08194/5.323, allocations: 33.6 MB / 3.072 GB, free: 30.51 MB / 1.826 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05507/5.378, allocations: 26.57 MB / 3.098 GB, free: 29.57 MB / 1.826 GB
Notification: Performance of NFFlatten.flatten: time 0.1359/5.514, allocations: 108.4 MB / 3.203 GB, free: 28.19 MB / 1.826 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.05422/5.569, allocations: 27.41 MB / 3.23 GB, free: 10.04 MB / 1.826 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.08195/5.651, allocations: 35.07 MB / 3.264 GB, free: 400 kB / 1.842 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.05245/5.703, allocations: 25.21 MB / 3.289 GB, free: 8.922 MB / 1.873 GB
Notification: Performance of NFPackage.collectConstants: time 0.01674/5.72, allocations: 4.441 MB / 3.293 GB, free: 4.48 MB / 1.873 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04699/5.767, allocations: 13.8 MB / 3.307 GB, free: 7.254 MB / 1.889 GB
Notification: Performance of NFScalarize.scalarize: time 0.0253/5.792, allocations: 10.95 MB / 3.318 GB, free: 12.45 MB / 1.904 GB
Notification: Performance of NFVerifyModel.verify: time 0.04888/5.841, allocations: 20.95 MB / 3.338 GB, free: 7.551 MB / 1.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.1182/5.959, allocations: 72.51 MB / 3.409 GB, free: 0.5391 MB / 1.982 GB
Notification: Performance of FrontEnd - DAE generated: time 5.821e-06/5.959, allocations: 0 / 3.409 GB, free: 0.5391 MB / 1.982 GB
Notification: Performance of FrontEnd: time 1.613e-06/5.959, allocations: 0 / 3.409 GB, free: 0.5391 MB / 1.982 GB
Notification: Performance of Transformations before backend: time 0.001673/5.961, allocations: 0 / 3.409 GB, free: 0.5391 MB / 1.982 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4618
 * Number of variables: 4618
Notification: Performance of Generate backend data structure: time 0.1197/6.081, allocations: 47.41 MB / 3.455 GB, free: 1.211 MB / 2.029 GB
Notification: Performance of prepare preOptimizeDAE: time 4.747e-05/6.081, allocations: 12.03 kB / 3.455 GB, free: 1.199 MB / 2.029 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02649/6.107, allocations: 5.307 MB / 3.46 GB, free: 11.87 MB / 2.045 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.09835/6.205, allocations: 44.49 MB / 3.504 GB, free: 15.95 MB / 2.092 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00214/6.208, allocations: 1.5 MB / 3.505 GB, free: 14.44 MB / 2.092 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006776/6.214, allocations: 1.863 MB / 3.507 GB, free: 12.58 MB / 2.092 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06662/6.281, allocations: 24.8 MB / 3.531 GB, free: 3.035 MB / 2.107 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006318/6.282, allocations: 39.64 kB / 3.531 GB, free: 2.996 MB / 2.107 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004776/6.286, allocations: 0.7547 MB / 3.532 GB, free: 2.242 MB / 2.107 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006375/6.287, allocations: 0.4918 MB / 3.533 GB, free: 1.754 MB / 2.107 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05345/6.34, allocations: 20.16 MB / 3.552 GB, free: 13.57 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.2311/6.571, allocations: 131.7 MB / 3.681 GB, free: 2.969 MB / 2.264 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02297/6.594, allocations: 9.037 MB / 3.69 GB, free: 9.832 MB / 2.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01413/6.609, allocations: 5.593 MB / 3.695 GB, free: 4.203 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.06759/6.676, allocations: 30.31 MB / 3.725 GB, free: 4.719 MB / 2.311 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01478/6.691, allocations: 5.769 MB / 3.73 GB, free: 14.87 MB / 2.326 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01254/6.703, allocations: 1.666 MB / 3.732 GB, free: 13.21 MB / 2.326 GB
Notification: Performance of pre-optimization done (n=754): time 3.054e-05/6.704, allocations: 0 / 3.732 GB, free: 13.21 MB / 2.326 GB
Notification: Performance of matching and sorting (n=754): time 0.04885/6.752, allocations: 16.5 MB / 3.748 GB, free: 12.5 MB / 2.342 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002682/6.753, allocations: 384.5 kB / 3.748 GB, free: 12.06 MB / 2.342 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.7414/7.494, allocations: 31.71 MB / 3.779 GB, free: 1.274 GB / 2.342 GB
Notification: Performance of collectPreVariables (initialization): time 0.002064/7.496, allocations: 284.4 kB / 3.78 GB, free: 1.273 GB / 2.342 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01635/7.512, allocations: 15.02 MB / 3.794 GB, free: 1.265 GB / 2.342 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003699/7.516, allocations: 2.693 MB / 3.797 GB, free: 1.264 GB / 2.342 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.008238/7.524, allocations: 3.329 MB / 3.8 GB, free: 1.263 GB / 2.342 GB
Notification: Performance of setup shared object (initialization): time 6.443e-05/7.525, allocations: 302.2 kB / 3.801 GB, free: 1.263 GB / 2.342 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01273/7.537, allocations: 6.443 MB / 3.807 GB, free: 1.26 GB / 2.342 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01738/7.555, allocations: 11.71 MB / 3.818 GB, free: 1.251 GB / 2.342 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0243/7.579, allocations: 17.08 MB / 3.835 GB, free: 1.24 GB / 2.342 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001643/7.579, allocations: 39.59 kB / 3.835 GB, free: 1.24 GB / 2.342 GB
Notification: Performance of matching and sorting (n=1953) (initialization): time 0.04817/7.627, allocations: 20.8 MB / 3.855 GB, free: 1.232 GB / 2.342 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002196/7.627, allocations: 64.38 kB / 3.855 GB, free: 1.232 GB / 2.342 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003337/7.628, allocations: 145 kB / 3.856 GB, free: 1.232 GB / 2.342 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003077/7.631, allocations: 0.8862 MB / 3.856 GB, free: 1.232 GB / 2.342 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01232/7.643, allocations: 2.939 MB / 3.859 GB, free: 1.231 GB / 2.342 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007394/7.651, allocations: 10.17 MB / 3.869 GB, free: 1.223 GB / 2.342 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02101/7.672, allocations: 0.9147 MB / 3.87 GB, free: 1.222 GB / 2.342 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00319/7.675, allocations: 0.6684 MB / 3.871 GB, free: 1.222 GB / 2.342 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03048/7.705, allocations: 15.19 MB / 3.886 GB, free: 1.215 GB / 2.342 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01664/7.722, allocations: 11.63 MB / 3.897 GB, free: 1.207 GB / 2.342 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02477/7.747, allocations: 16.98 MB / 3.914 GB, free: 1.195 GB / 2.342 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001655/7.747, allocations: 40 kB / 3.914 GB, free: 1.195 GB / 2.342 GB
Notification: Performance of matching and sorting (n=1953) (initialization_lambda0): time 0.04338/7.79, allocations: 20.59 MB / 3.934 GB, free: 1.176 GB / 2.342 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001037/7.79, allocations: 68 kB / 3.934 GB, free: 1.175 GB / 2.342 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001782/7.791, allocations: 140 kB / 3.934 GB, free: 1.175 GB / 2.342 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001972/7.792, allocations: 0.8118 MB / 3.935 GB, free: 1.175 GB / 2.342 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01131/7.804, allocations: 2.92 MB / 3.938 GB, free: 1.172 GB / 2.342 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009301/7.813, allocations: 14.18 MB / 3.951 GB, free: 1.157 GB / 2.342 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02026/7.833, allocations: 0.9839 MB / 3.952 GB, free: 1.156 GB / 2.342 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002667/7.836, allocations: 0.66 MB / 3.953 GB, free: 1.155 GB / 2.342 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 638
 * Number of states: 0 ()
 * Number of discrete variables: 180 ($PRE.ets.conSup.uHeaHol.onDel1.u,$PRE.ets.conSup.uHeaHol.onDel2.u,$PRE.ets.conSup.uHeaHol.toTrue.enableFire,$PRE.ets.conSup.uHeaHol.toFalse.enableFire,$PRE.ets.conSup.uHeaHol.toTrue1.enableFire,$PRE.ets.conSup.uHeaHol.toFalse1.enableFire,$PRE.ets.conSup.uCooHol.onDel1.u,$PRE.ets.conSup.uCooHol.onDel2.u,$PRE.ets.conSup.uCooHol.toTrue.enableFire,$PRE.ets.conSup.uCooHol.toFalse.enableFire,$PRE.ets.conSup.uCooHol.toTrue1.enableFire,$PRE.ets.conSup.uCooHol.toFalse1.enableFire,ets.conSup.uCooHol.toFalse1.t_start,$PRE.ets.conSup.uCooHol.toFalse1.t_start,ets.conSup.uCooHol.toTrue1.t_start,$PRE.ets.conSup.uCooHol.toTrue1.t_start,ets.conSup.uCooHol.toFalse.t_start,$PRE.ets.conSup.uCooHol.toFalse.t_start,ets.conSup.uCooHol.toTrue.t_start,$PRE.ets.conSup.uCooHol.toTrue.t_start,ets.conSup.uHeaHol.toFalse1.t_start,$PRE.ets.conSup.uHeaHol.toFalse1.t_start,ets.conSup.uHeaHol.toTrue1.t_start,$PRE.ets.conSup.uHeaHol.toTrue1.t_start,ets.conSup.uHeaHol.toFalse.t_start,$PRE.ets.conSup.uHeaHol.toFalse.t_start,ets.conSup.uHeaHol.toTrue.t_start,$PRE.ets.conSup.uHeaHol.toTrue.t_start,ets.conSup.conCol.zeroOrderHold.firstTrigger,$PRE.ets.conSup.conCol.zeroOrderHold.firstTrigger,ets.conSup.conHot.zeroOrderHold.firstTrigger,$PRE.ets.conSup.conHot.zeroOrderHold.firstTrigger,$PRE.loa.nextTimeEvent,$whenCondition16,$PRE.TDisWatSup.nextTimeEvent,$whenCondition15,$PRE.ets.conSup.uCooHol.onDel2.t_next,$whenCondition10,$PRE.ets.conSup.uCooHol.onDel1.t_next,$whenCondition7,$PRE.ets.conSup.uHeaHol.onDel2.t_next,$whenCondition4,$PRE.ets.conSup.uHeaHol.onDel1.t_next,$whenCondition1,ets.conSup.conHot.zeroOrderHold.sampleTrigger,$whenCondition13,ets.conSup.conCol.zeroOrderHold.sampleTrigger,$whenCondition14,ets.conSup.uCooHol.onDel2.t_next,ets.conSup.uCooHol.onDel1.t_next,ets.conSup.uHeaHol.onDel2.t_next,ets.conSup.uHeaHol.onDel1.t_next,ets.conSup.uCooHol.stateGraphRoot.resume,ets.conSup.uCooHol.stateGraphRoot.suspend,ets.conSup.uHeaHol.stateGraphRoot.resume,ets.conSup.uHeaHol.stateGraphRoot.suspend,ets.chi.chi.tru.y,EChi.local_reset,ets.chi.con.conValCon.conPID.cheYMinMax.y,ets.chi.con.conValEva.conPID.cheYMinMax.y,ets.conSup.conCol.conTChiWatSup.conPID.cheYMinMax.y,ets.conSup.conHot.conHeaRej.conPID.cheYMinMax.y,ets.conSup.conHot.conColRej.conPID.cheYMinMax.y,ets.hex.hex.flowRegime_nominal,ets.hex.hex.flowRegime,ets.conSup.uHeaHol.onDel1.u,ets.conSup.uHeaHol.onDel1.y,ets.conSup.uHeaHol.onDel2.u,ets.conSup.uHeaHol.onDel2.y,ets.conSup.uHeaHol.stateGraphRoot.activeSteps,ets.conSup.uHeaHol.outputFalse.localActive,$PRE.ets.conSup.uHeaHol.outputFalse.localActive,ets.conSup.uHeaHol.outputFalse.inPort[2].occupied,ets.conSup.uHeaHol.outputFalse.newActive,$PRE.ets.conSup.uHeaHol.outputFalse.newActive,ets.conSup.uHeaHol.outputFalse.oldActive,$PRE.ets.conSup.uHeaHol.outputFalse.oldActive,ets.conSup.uHeaHol.outputFalse.active,ets.conSup.uHeaHol.toTrue.localCondition,ets.conSup.uHeaHol.toTrue.enableFire,ets.conSup.uHeaHol.outputTrue.localActive,$PRE.ets.conSup.uHeaHol.outputTrue.localActive,ets.conSup.uHeaHol.outputTrue.inPort[2].occupied,ets.conSup.uHeaHol.outputTrue.newActive,$PRE.ets.conSup.uHeaHol.outputTrue.newActive,ets.conSup.uHeaHol.outputTrue.oldActive,$PRE.ets.conSup.uHeaHol.outputTrue.oldActive,ets.conSup.uHeaHol.outputTrue.active,ets.conSup.uHeaHol.toFalse.localCondition,ets.conSup.uHeaHol.toFalse.enableFire,ets.conSup.uHeaHol.initialStep.active,ets.conSup.uHeaHol.initialStep.localActive,$PRE.ets.conSup.uHeaHol.initialStep.localActive,ets.conSup.uHeaHol.initialStep.outPort[2].available,ets.conSup.uHeaHol.initialStep.newActive,$PRE.ets.conSup.uHeaHol.initialStep.newActive,ets.conSup.uHeaHol.initialStep.oldActive,$PRE.ets.conSup.uHeaHol.initialStep.oldActive,ets.conSup.uHeaHol.toTrue1.enableFire,ets.conSup.uHeaHol.toFalse1.enableFire,ets.conSup.uCooHol.onDel1.u,ets.conSup.uCooHol.onDel1.y,ets.conSup.uCooHol.onDel2.u,ets.conSup.uCooHol.onDel2.y,ets.conSup.uCooHol.stateGraphRoot.activeSteps,ets.conSup.uCooHol.outputFalse.localActive,$PRE.ets.conSup.uCooHol.outputFalse.localActive,ets.conSup.uCooHol.outputFalse.inPort[2].occupied,ets.conSup.uCooHol.outputFalse.newActive,$PRE.ets.conSup.uCooHol.outputFalse.newActive,ets.conSup.uCooHol.outputFalse.oldActive,$PRE.ets.conSup.uCooHol.outputFalse.oldActive,ets.conSup.uCooHol.outputFalse.active,ets.conSup.uCooHol.toTrue.localCondition,ets.conSup.uCooHol.toTrue.enableFire,ets.conSup.uCooHol.outputTrue.localActive,$PRE.ets.conSup.uCooHol.outputTrue.localActive,ets.conSup.uCooHol.outputTrue.inPort[2].occupied,ets.conSup.uCooHol.outputTrue.newActive,$PRE.ets.conSup.uCooHol.outputTrue.newActive,ets.conSup.uCooHol.outputTrue.oldActive,$PRE.ets.conSup.uCooHol.outputTrue.oldActive,ets.conSup.uCooHol.outputTrue.active,ets.conSup.uCooHol.toFalse.localCondition,ets.conSup.uCooHol.toFalse.enableFire,ets.conSup.uCooHol.initialStep.active,ets.conSup.uCooHol.initialStep.localActive,$PRE.ets.conSup.uCooHol.initialStep.localActive,ets.conSup.uCooHol.initialStep.outPort[2].available,ets.conSup.uCooHol.initialStep.newActive,$PRE.ets.conSup.uCooHol.initialStep.newActive,ets.conSup.uCooHol.initialStep.oldActive,$PRE.ets.conSup.uCooHol.initialStep.oldActive,ets.conSup.uCooHol.toTrue1.enableFire,ets.conSup.uCooHol.toFalse1.enableFire,ets.conSup.conHot.greThr.y,ets.conSup.conHot.isValIsoConClo.lesHys.y,$PRE.ets.conSup.conHot.isValIsoConClo.lesHys.y,ets.conSup.conHot.isValIsoEvaClo.lesHys.y,$PRE.ets.conSup.conHot.isValIsoEvaClo.lesHys.y,ets.conSup.conHot.mulAnd.y,ets.conSup.conHot.mulAnd.uTemp[2],ets.conSup.conHot.zeroOrderHold.ySample,$PRE.ets.conSup.conHot.zeroOrderHold.ySample,ets.conSup.conHot.isBelLoc.lesHys.y,$PRE.ets.conSup.conHot.isBelLoc.lesHys.y,ets.conSup.conCol.greThr.y,ets.conSup.conCol.zeroOrderHold.ySample,$PRE.ets.conSup.conCol.zeroOrderHold.ySample,ets.hex.con.greThr.greHys.y,$PRE.ets.hex.con.greThr.greHys.y,ets.hex.con.and2.y,ets.hex.con.heaRej.greHys.y,$PRE.ets.hex.con.heaRej.greHys.y,ets.hex.con.cooRej.greHys.y,$PRE.ets.hex.con.cooRej.greHys.y,ets.hex.con.or1.y,ets.chi.con.yChi,uHea.greHys.y,$PRE.uHea.greHys.y,uCoo.greHys.y,$PRE.uCoo.greHys.y,TDisWatSup.nextTimeEvent,TDisWatSup.nextTimeEventScaled,$PRE.TDisWatSup.nextTimeEventScaled,loa.nextTimeEvent,loa.nextTimeEventScaled,$PRE.loa.nextTimeEventScaled,$whenCondition3,$whenCondition2,$whenCondition6,$whenCondition5,$whenCondition9,$whenCondition8,$whenCondition12,$whenCondition11,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1718):
 * Single equations (assignments): 1699
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,1,100.0%), (1,1,100.0%), (1,9,100.0%), (1,9,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,4), (1,4), (2,8)}
Notification: Performance of prepare postOptimizeDAE: time 0.004153/7.84, allocations: 1.211 MB / 3.954 GB, free: 1.154 GB / 2.342 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007975/7.848, allocations: 2.736 MB / 3.957 GB, free: 1.152 GB / 2.342 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02959/7.878, allocations: 13.35 MB / 3.97 GB, free: 1.139 GB / 2.342 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.633e-05/7.878, allocations: 87.98 kB / 3.97 GB, free: 1.139 GB / 2.342 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.928e-05/7.878, allocations: 8 kB / 3.97 GB, free: 1.139 GB / 2.342 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01827/7.896, allocations: 9.428 MB / 3.979 GB, free: 1.129 GB / 2.342 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.082/7.978, allocations: 37 MB / 4.015 GB, free: 1.093 GB / 2.342 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.019e-05/7.978, allocations: 0 / 4.015 GB, free: 1.093 GB / 2.342 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.007556/7.986, allocations: 1.466 MB / 4.017 GB, free: 1.092 GB / 2.342 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001474/7.987, allocations: 0.5397 MB / 4.017 GB, free: 1.091 GB / 2.342 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001525/7.989, allocations: 235.8 kB / 4.017 GB, free: 1.091 GB / 2.342 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005738/7.994, allocations: 9.659 MB / 4.027 GB, free: 1.081 GB / 2.342 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.308e-06/7.994, allocations: 4 kB / 4.027 GB, free: 1.081 GB / 2.342 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04065/8.035, allocations: 19.07 MB / 4.046 GB, free: 1.062 GB / 2.342 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01622/8.051, allocations: 4.847 MB / 4.05 GB, free: 1.058 GB / 2.342 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.009416/8.061, allocations: 200 kB / 4.05 GB, free: 1.058 GB / 2.342 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01769/8.078, allocations: 0.6281 MB / 4.051 GB, free: 1.057 GB / 2.342 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002024/8.08, allocations: 0.614 MB / 4.052 GB, free: 1.056 GB / 2.342 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001597/8.082, allocations: 383.6 kB / 4.052 GB, free: 1.056 GB / 2.342 GB
Notification: Performance of sorting global known variables: time 0.04373/8.126, allocations: 22.01 MB / 4.074 GB, free: 1.035 GB / 2.342 GB
Notification: Performance of sort global known variables: time 2.8e-07/8.126, allocations: 0 / 4.074 GB, free: 1.035 GB / 2.342 GB
Notification: Performance of remove unused functions: time 0.04648/8.172, allocations: 12.87 MB / 4.086 GB, free: 1.022 GB / 2.342 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 13
 * Number of states: 43 (senTDisWatRet.T,EChi.y,senTDisWatSup.T,volChiWat.dynBal.U,volHeaWat.dynBal.U,senTChiWatRet.T,senTHeaWatRet.T,ets.chi.valCon.vol.dynBal.U,ets.chi.valEva.vol.dynBal.U,ets.chi.senTEvaLvg.T,ets.chi.senTEvaEnt.T,ets.chi.senTConEnt.T,ets.chi.senTConLvg.T,ets.chi.con.conValCon.conPID.I.y,ets.chi.con.conValEva.conPID.I.y,ets.chi.chi.vol2.dynBal.U,ets.chi.chi.vol1.dynBal.U,ets.colAmbWat.con[1].junConRet.vol.dynBal.U,ets.colAmbWat.con[1].junConSup.vol.dynBal.U,ets.colHeaWat.con[2].junConRet.vol.dynBal.U,ets.colHeaWat.con[2].junConSup.vol.dynBal.U,ets.colHeaWat.con[1].junConRet.vol.dynBal.U,ets.colHeaWat.con[1].junConSup.vol.dynBal.U,ets.colChiWat.con[2].junConRet.vol.dynBal.U,ets.colChiWat.con[2].junConSup.vol.dynBal.U,ets.colChiWat.con[1].junConRet.vol.dynBal.U,ets.colChiWat.con[1].junConSup.vol.dynBal.U,ets.tanHeaWat.tan.vol[3].dynBal.U,ets.tanHeaWat.tan.vol[2].dynBal.U,ets.tanHeaWat.tan.vol[1].dynBal.U,ets.tanChiWat.tan.vol[3].dynBal.U,ets.tanChiWat.tan.vol[2].dynBal.U,ets.tanChiWat.tan.vol[1].dynBal.U,ets.hex.val2.vol.dynBal.U,ets.hex.senT2WatLvg.T,ets.hex.senT2WatEnt.T,ets.conSup.resTSup.ramLimHea.y,ets.conSup.conCol.ramLimHea.y,ets.conSup.conCol.conTChiWatSup.conPID.I.y,ets.conSup.conHot.conHeaRej.conPID.I.y,ets.conSup.conHot.conColRej.conPID.I.y,senTChiWatSup.T,senTHeaWatSup.T)
 * Number of discrete variables: 119 (ets.chi.con.yChi,ets.conSup.conHot.mulAnd.y,ets.conSup.conCol.zeroOrderHold.sampleTrigger,ets.conSup.conHot.zeroOrderHold.sampleTrigger,ets.conSup.uCooHol.initialStep.localActive,ets.conSup.uCooHol.outputTrue.active,ets.conSup.uCooHol.outputTrue.localActive,ets.conSup.uCooHol.onDel2.u,ets.conSup.uCooHol.outputFalse.active,ets.conSup.uCooHol.outputFalse.localActive,ets.conSup.uCooHol.onDel1.u,ets.conSup.uHeaHol.initialStep.localActive,ets.conSup.uHeaHol.outputTrue.active,ets.conSup.uHeaHol.outputTrue.localActive,ets.conSup.uHeaHol.onDel2.u,ets.conSup.uHeaHol.outputFalse.active,ets.conSup.uHeaHol.outputFalse.localActive,ets.conSup.uHeaHol.onDel1.u,$cse73,$cse74,$cse75,$cse76,$cse77,$cse78,$cse79,$cse80,$cse81,$cse82,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition1,$whenCondition2,$whenCondition3,loa.nextTimeEventScaled,loa.nextTimeEvent,TDisWatSup.nextTimeEventScaled,TDisWatSup.nextTimeEvent,uCoo.greHys.y,uHea.greHys.y,ets.hex.con.or1.y,ets.hex.con.cooRej.greHys.y,ets.hex.con.heaRej.greHys.y,ets.hex.con.and2.y,ets.hex.con.greThr.greHys.y,ets.conSup.conCol.zeroOrderHold.ySample,ets.conSup.conCol.zeroOrderHold.firstTrigger,ets.conSup.conCol.greThr.y,ets.conSup.conHot.isBelLoc.lesHys.y,ets.conSup.conHot.zeroOrderHold.ySample,ets.conSup.conHot.zeroOrderHold.firstTrigger,ets.conSup.conHot.mulAnd.uTemp[2],ets.conSup.conHot.isValIsoEvaClo.lesHys.y,ets.conSup.conHot.isValIsoConClo.lesHys.y,ets.conSup.conHot.greThr.y,ets.conSup.uCooHol.toFalse1.enableFire,ets.conSup.uCooHol.toTrue1.enableFire,ets.conSup.uCooHol.initialStep.oldActive,ets.conSup.uCooHol.initialStep.newActive,ets.conSup.uCooHol.initialStep.outPort[2].available,ets.conSup.uCooHol.initialStep.active,ets.conSup.uCooHol.toFalse.enableFire,ets.conSup.uCooHol.toFalse.localCondition,ets.conSup.uCooHol.outputTrue.oldActive,ets.conSup.uCooHol.outputTrue.newActive,ets.conSup.uCooHol.outputTrue.inPort[2].occupied,ets.conSup.uCooHol.toTrue.enableFire,ets.conSup.uCooHol.toTrue.localCondition,ets.conSup.uCooHol.outputFalse.oldActive,ets.conSup.uCooHol.outputFalse.newActive,ets.conSup.uCooHol.outputFalse.inPort[2].occupied,ets.conSup.uCooHol.stateGraphRoot.activeSteps,ets.conSup.uCooHol.onDel2.t_next,ets.conSup.uCooHol.onDel2.y,ets.conSup.uCooHol.onDel1.t_next,ets.conSup.uCooHol.onDel1.y,ets.conSup.uHeaHol.toFalse1.enableFire,ets.conSup.uHeaHol.toTrue1.enableFire,ets.conSup.uHeaHol.initialStep.oldActive,ets.conSup.uHeaHol.initialStep.newActive,ets.conSup.uHeaHol.initialStep.outPort[2].available,ets.conSup.uHeaHol.initialStep.active,ets.conSup.uHeaHol.toFalse.enableFire,ets.conSup.uHeaHol.toFalse.localCondition,ets.conSup.uHeaHol.outputTrue.oldActive,ets.conSup.uHeaHol.outputTrue.newActive,ets.conSup.uHeaHol.outputTrue.inPort[2].occupied,ets.conSup.uHeaHol.toTrue.enableFire,ets.conSup.uHeaHol.toTrue.localCondition,ets.conSup.uHeaHol.outputFalse.oldActive,ets.conSup.uHeaHol.outputFalse.newActive,ets.conSup.uHeaHol.outputFalse.inPort[2].occupied,ets.conSup.uHeaHol.stateGraphRoot.activeSteps,ets.conSup.uHeaHol.onDel2.t_next,ets.conSup.uHeaHol.onDel2.y,ets.conSup.uHeaHol.onDel1.t_next,ets.conSup.uHeaHol.onDel1.y,ets.conSup.uHeaHol.toTrue.t_start,ets.conSup.uHeaHol.toFalse.t_start,ets.conSup.uHeaHol.toTrue1.t_start,ets.conSup.uHeaHol.toFalse1.t_start,ets.conSup.uCooHol.toTrue.t_start,ets.conSup.uCooHol.toFalse.t_start,ets.conSup.uCooHol.toTrue1.t_start,ets.conSup.uCooHol.toFalse1.t_start)
 * Number of discrete states: 32 (ets.conSup.uCooHol.toFalse1.t_start,ets.conSup.uCooHol.toTrue1.t_start,ets.conSup.uCooHol.toFalse.t_start,ets.conSup.uCooHol.toTrue.t_start,ets.conSup.uHeaHol.toFalse1.t_start,ets.conSup.uHeaHol.toTrue1.t_start,ets.conSup.uHeaHol.toFalse.t_start,ets.conSup.uHeaHol.toTrue.t_start,loa.nextTimeEvent,TDisWatSup.nextTimeEvent,ets.conSup.uCooHol.onDel2.t_next,ets.conSup.uCooHol.onDel1.t_next,ets.conSup.uHeaHol.onDel2.t_next,ets.conSup.uHeaHol.onDel1.t_next,ets.conSup.uHeaHol.outputFalse.newActive,ets.conSup.uHeaHol.outputTrue.newActive,ets.conSup.uHeaHol.initialStep.newActive,ets.conSup.uCooHol.outputFalse.newActive,ets.conSup.uCooHol.outputTrue.newActive,ets.conSup.uCooHol.initialStep.newActive,ets.conSup.conHot.zeroOrderHold.ySample,ets.conSup.conHot.isValIsoConClo.lesHys.y,ets.conSup.conCol.zeroOrderHold.ySample,ets.conSup.conHot.isValIsoEvaClo.lesHys.y,ets.hex.con.heaRej.greHys.y,ets.hex.con.cooRej.greHys.y,ets.conSup.conHot.isBelLoc.lesHys.y,ets.hex.con.greThr.greHys.y,loa.nextTimeEventScaled,uCoo.greHys.y,uHea.greHys.y,TDisWatSup.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (798):
 * Single equations (assignments): 730
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 31
 * When equations: 30
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,1,100.0%), (1,1,100.0%), (1,9,100.0%), (1,9,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,4), (1,4), (2,8)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00825/8.18, allocations: 3.937 MB / 4.09 GB, free: 1.019 GB / 2.342 GB
Notification: Performance of simCode: created initialization part: time 0.04161/8.222, allocations: 23.42 MB / 4.113 GB, free: 0.9958 GB / 2.342 GB
Notification: Performance of simCode: created event and clocks part: time 1.417e-05/8.222, allocations: 7.281 kB / 4.113 GB, free: 0.9958 GB / 2.342 GB
Notification: Performance of simCode: created simulation system equations: time 0.01107/8.233, allocations: 5.564 MB / 4.118 GB, free: 0.9903 GB / 2.342 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.06525/8.298, allocations: 15.27 MB / 4.133 GB, free: 0.9759 GB / 2.342 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1024/8.401, allocations: 56.39 MB / 4.188 GB, free: 0.9207 GB / 2.342 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02997/8.431, allocations: 16.07 MB / 4.204 GB, free: 0.905 GB / 2.342 GB
Notification: Performance of simCode: alias equations: time 0.03365/8.464, allocations: 7.522 MB / 4.211 GB, free: 0.8978 GB / 2.342 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.008424/8.473, allocations: 1.909 MB / 4.213 GB, free: 0.8959 GB / 2.342 GB
Notification: Performance of SimCode: time 1.062e-06/8.473, allocations: 0 / 4.213 GB, free: 0.8959 GB / 2.342 GB
Notification: Performance of Templates: time 0.7035/9.176, allocations: 0.5299 GB / 4.743 GB, free: 377.7 MB / 2.342 GB
"
[Timeout remaining time 291]
make -j1 -f Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.makefile [Timeout 300]
(rm -f Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.pipe ; mkfifo Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.pipe ; head -c 1048576 < Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.pipe >> ../files/Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.sim & ./Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_10.0.x/Buildings_Experimental_DHC_EnergyTransferStations_Combined_Validation_ChillerOnly.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_10_Buildings.Experimental.DHC.EnergyTransferStations.Combined.Validation.ChillerOnly.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: 43.940036587417126]