Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.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.001829/0.001829, allocations: 110.4 kB / 18.94 MB, free: 2.949 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.001851/0.001851, allocations: 220.3 kB / 22.26 MB, free: 5.125 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.549/1.549, allocations: 230.6 MB / 256 MB, free: 7.984 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.874/2.874, allocations: 476.7 MB / 0.7706 GB, free: 4.328 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.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.ETS.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_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly")
translateModel(Buildings.DHC.ETS.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_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002183/0.002183, allocations: 65.59 kB / 1.118 GB, free: 40.26 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4519/0.4541, allocations: 170 MB / 1.284 GB, free: 11.19 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Validation.ChillerOnly): time 3.979/4.433, allocations: 1.531 GB / 2.815 GB, free: 0.5156 MB / 1.732 GB
Notification: Performance of NFInst.instExpressions: time 1.878/6.311, allocations: 279.5 MB / 3.088 GB, free: 34.36 MB / 1.889 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.07459/6.385, allocations: 1.783 MB / 3.09 GB, free: 34.36 MB / 1.889 GB
Notification: Performance of NFTyping.typeComponents: time 0.04653/6.432, allocations: 14.92 MB / 3.105 GB, free: 34.13 MB / 1.889 GB
Notification: Performance of NFTyping.typeBindings: time 0.09209/6.524, allocations: 33.16 MB / 3.137 GB, free: 32.97 MB / 1.889 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06313/6.587, allocations: 27.24 MB / 3.164 GB, free: 32.14 MB / 1.889 GB
Notification: Performance of NFFlatten.flatten: time 0.1972/6.784, allocations: 125.6 MB / 3.286 GB, free: 14.78 MB / 1.889 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.07375/6.858, allocations: 27.7 MB / 3.313 GB, free: 8.969 MB / 1.904 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1014/6.959, allocations: 35.22 MB / 3.348 GB, free: 7.555 MB / 1.936 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.05918/7.019, allocations: 25.06 MB / 3.372 GB, free: 192 kB / 1.951 GB
Notification: Performance of NFPackage.collectConstants: time 0.01855/7.037, allocations: 4.555 MB / 3.377 GB, free: 11.63 MB / 1.967 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0563/7.093, allocations: 14.61 MB / 3.391 GB, free: 13.59 MB / 1.982 GB
Notification: Performance of NFScalarize.scalarize: time 0.0251/7.119, allocations: 10.6 MB / 3.401 GB, free: 3.129 MB / 1.982 GB
Notification: Performance of NFVerifyModel.verify: time 0.05874/7.177, allocations: 20.54 MB / 3.421 GB, free: 14.66 MB / 2.014 GB
Notification: Performance of NFConvertDAE.convert: time 0.1556/7.333, allocations: 69.56 MB / 3.489 GB, free: 10.65 MB / 2.076 GB
Notification: Performance of FrontEnd - DAE generated: time 7.855e-06/7.333, allocations: 4 kB / 3.489 GB, free: 10.64 MB / 2.076 GB
Notification: Performance of FrontEnd: time 2.334e-06/7.333, allocations: 0 / 3.489 GB, free: 10.64 MB / 2.076 GB
Notification: Performance of Transformations before backend: time 0.00236/7.335, allocations: 0 / 3.489 GB, free: 10.64 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: 4618
 * Number of variables: 4618
Notification: Performance of Generate backend data structure: time 0.1592/7.494, allocations: 46.11 MB / 3.534 GB, free: 12.65 MB / 2.123 GB
Notification: Performance of prepare preOptimizeDAE: time 5.823e-05/7.495, allocations: 8.031 kB / 3.534 GB, free: 12.64 MB / 2.123 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03463/7.529, allocations: 5.584 MB / 3.54 GB, free: 7.035 MB / 2.123 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1123/7.641, allocations: 42.58 MB / 3.581 GB, free: 13.02 MB / 2.17 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0024/7.644, allocations: 1.561 MB / 3.583 GB, free: 11.43 MB / 2.17 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008769/7.653, allocations: 1.873 MB / 3.585 GB, free: 9.566 MB / 2.17 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.09106/7.744, allocations: 26.08 MB / 3.61 GB, free: 14.76 MB / 2.201 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001051/7.745, allocations: 43.64 kB / 3.61 GB, free: 14.71 MB / 2.201 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00757/7.752, allocations: 0.7499 MB / 3.611 GB, free: 13.97 MB / 2.201 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005925/7.753, allocations: 499.9 kB / 3.611 GB, free: 13.48 MB / 2.201 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06633/7.819, allocations: 21.11 MB / 3.632 GB, free: 8.359 MB / 2.217 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.2691/8.088, allocations: 132.9 MB / 3.762 GB, free: 12.53 MB / 2.357 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02857/8.117, allocations: 9.964 MB / 3.771 GB, free: 2.559 MB / 2.357 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02066/8.138, allocations: 6.149 MB / 3.777 GB, free: 12.38 MB / 2.373 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.08468/8.222, allocations: 27.3 MB / 3.804 GB, free: 1.223 MB / 2.389 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0207/8.243, allocations: 7.178 MB / 3.811 GB, free: 9.977 MB / 2.404 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01752/8.26, allocations: 1.671 MB / 3.813 GB, free: 8.305 MB / 2.404 GB
Notification: Performance of pre-optimization done (n=778): time 4.082e-05/8.26, allocations: 4 kB / 3.813 GB, free: 8.301 MB / 2.404 GB
Notification: Performance of matching and sorting (n=778): time 0.07047/8.331, allocations: 17.66 MB / 3.83 GB, free: 6.586 MB / 2.42 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000384/8.331, allocations: 391.4 kB / 3.83 GB, free: 6.137 MB / 2.42 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 1.176/9.507, allocations: 29.83 MB / 3.86 GB, free: 1.304 GB / 2.42 GB
Notification: Performance of collectPreVariables (initialization): time 0.003929/9.511, allocations: 290.1 kB / 3.86 GB, free: 1.304 GB / 2.42 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02207/9.533, allocations: 14.29 MB / 3.874 GB, free: 1.296 GB / 2.42 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005752/9.539, allocations: 2.761 MB / 3.876 GB, free: 1.295 GB / 2.42 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01361/9.552, allocations: 3.444 MB / 3.88 GB, free: 1.293 GB / 2.42 GB
Notification: Performance of setup shared object (initialization): time 5.494e-05/9.552, allocations: 305.4 kB / 3.88 GB, free: 1.293 GB / 2.42 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01645/9.569, allocations: 8.521 MB / 3.888 GB, free: 1.29 GB / 2.42 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02266/9.592, allocations: 13.63 MB / 3.902 GB, free: 1.28 GB / 2.42 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03889/9.63, allocations: 21.05 MB / 3.922 GB, free: 1.268 GB / 2.42 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002274/9.631, allocations: 39.44 kB / 3.922 GB, free: 1.268 GB / 2.42 GB
Notification: Performance of matching and sorting (n=1971) (initialization): time 0.06784/9.698, allocations: 24.8 MB / 3.947 GB, free: 1.258 GB / 2.42 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000258/9.699, allocations: 62.12 kB / 3.947 GB, free: 1.258 GB / 2.42 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0004119/9.699, allocations: 137.2 kB / 3.947 GB, free: 1.258 GB / 2.42 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003064/9.702, allocations: 0.8733 MB / 3.948 GB, free: 1.257 GB / 2.42 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01696/9.719, allocations: 3.117 MB / 3.951 GB, free: 1.257 GB / 2.42 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01175/9.731, allocations: 14 MB / 3.964 GB, free: 1.245 GB / 2.42 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02672/9.758, allocations: 0.8691 MB / 3.965 GB, free: 1.245 GB / 2.42 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004805/9.762, allocations: 0.7727 MB / 3.966 GB, free: 1.245 GB / 2.42 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03821/9.801, allocations: 16.3 MB / 3.982 GB, free: 1.238 GB / 2.42 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02152/9.822, allocations: 12.87 MB / 3.994 GB, free: 1.225 GB / 2.42 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0372/9.859, allocations: 19.54 MB / 4.013 GB, free: 1.204 GB / 2.42 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0002301/9.86, allocations: 36.16 kB / 4.013 GB, free: 1.204 GB / 2.42 GB
Notification: Performance of matching and sorting (n=1971) (initialization_lambda0): time 0.06229/9.922, allocations: 23.17 MB / 4.036 GB, free: 1.182 GB / 2.42 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002284/9.922, allocations: 69.39 kB / 4.036 GB, free: 1.182 GB / 2.42 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002924/9.922, allocations: 136 kB / 4.036 GB, free: 1.182 GB / 2.42 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002363/9.925, allocations: 0.8007 MB / 4.037 GB, free: 1.181 GB / 2.42 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01454/9.939, allocations: 3.08 MB / 4.04 GB, free: 1.178 GB / 2.42 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01053/9.95, allocations: 13.45 MB / 4.053 GB, free: 1.164 GB / 2.42 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02538/9.975, allocations: 0.9162 MB / 4.054 GB, free: 1.163 GB / 2.42 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00364/9.979, allocations: 0.7186 MB / 4.055 GB, free: 1.162 GB / 2.42 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 608
 * 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 (1724):
 * Single equations (assignments): 1699
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 7
 * 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): 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.007186/9.986, allocations: 1.212 MB / 4.056 GB, free: 1.161 GB / 2.42 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0106/9.997, allocations: 2.6 MB / 4.059 GB, free: 1.159 GB / 2.42 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04411/10.04, allocations: 14.57 MB / 4.073 GB, free: 1.145 GB / 2.42 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001496/10.04, allocations: 91.98 kB / 4.073 GB, free: 1.145 GB / 2.42 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.334e-05/10.04, allocations: 10.19 kB / 4.073 GB, free: 1.145 GB / 2.42 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02603/10.07, allocations: 10.61 MB / 4.083 GB, free: 1.134 GB / 2.42 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.09671/10.16, allocations: 38 MB / 4.12 GB, free: 1.097 GB / 2.42 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.599e-05/10.16, allocations: 0 / 4.12 GB, free: 1.097 GB / 2.42 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008746/10.17, allocations: 1.608 MB / 4.122 GB, free: 1.096 GB / 2.42 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001641/10.17, allocations: 0.5508 MB / 4.122 GB, free: 1.095 GB / 2.42 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002035/10.18, allocations: 255.8 kB / 4.123 GB, free: 1.095 GB / 2.42 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007785/10.18, allocations: 13.24 MB / 4.136 GB, free: 1.081 GB / 2.42 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.45e-06/10.18, allocations: 11.92 kB / 4.136 GB, free: 1.081 GB / 2.42 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04602/10.23, allocations: 20.96 MB / 4.156 GB, free: 1.061 GB / 2.42 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01776/10.25, allocations: 4.615 MB / 4.161 GB, free: 1.056 GB / 2.42 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00993/10.26, allocations: 204 kB / 4.161 GB, free: 1.056 GB / 2.42 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01792/10.28, allocations: 0.6195 MB / 4.161 GB, free: 1.055 GB / 2.42 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002419/10.28, allocations: 0.6609 MB / 4.162 GB, free: 1.055 GB / 2.42 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002474/10.28, allocations: 427.7 kB / 4.162 GB, free: 1.054 GB / 2.42 GB
Notification: Performance of sorting global known variables: time 0.04639/10.33, allocations: 20.6 MB / 4.183 GB, free: 1.034 GB / 2.42 GB
Notification: Performance of sort global known variables: time 2.1e-07/10.33, allocations: 3.172 kB / 4.183 GB, free: 1.034 GB / 2.42 GB
Notification: Performance of remove unused functions: time 0.05174/10.38, allocations: 12.77 MB / 4.195 GB, free: 1.022 GB / 2.42 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: 109 (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,$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 (818):
 * Single equations (assignments): 744
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 31
 * When equations: 30
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 7
 * 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): 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.009778/10.39, allocations: 3.818 MB / 4.199 GB, free: 1.019 GB / 2.42 GB
Notification: Performance of simCode: created initialization part: time 0.05607/10.44, allocations: 27.48 MB / 4.226 GB, free: 0.992 GB / 2.42 GB
Notification: Performance of simCode: created event and clocks part: time 1.813e-05/10.44, allocations: 11.28 kB / 4.226 GB, free: 0.992 GB / 2.42 GB
Notification: Performance of simCode: created simulation system equations: time 0.01398/10.46, allocations: 6.215 MB / 4.232 GB, free: 0.9859 GB / 2.42 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.06689/10.53, allocations: 14.18 MB / 4.246 GB, free: 0.9726 GB / 2.42 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1148/10.64, allocations: 55.2 MB / 4.299 GB, free: 0.9186 GB / 2.42 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02879/10.67, allocations: 15.55 MB / 4.315 GB, free: 0.9034 GB / 2.42 GB
Notification: Performance of simCode: alias equations: time 0.03212/10.7, allocations: 7.336 MB / 4.322 GB, free: 0.8962 GB / 2.42 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.008562/10.71, allocations: 1.823 MB / 4.324 GB, free: 0.8944 GB / 2.42 GB
Notification: Performance of SimCode: time 1.323e-06/10.71, allocations: 0 / 4.324 GB, free: 0.8944 GB / 2.42 GB
Notification: Performance of Templates: time 0.7086/11.42, allocations: 0.5107 GB / 4.834 GB, free: 396.2 MB / 2.42 GB
"
[Timeout remaining time 288]
make -j1 -f Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.makefile [Timeout 300]
(rm -f Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.pipe ; mkfifo Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.pipe ; head -c 1048576 < Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.pipe >> ../files/Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.sim & ./Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_11_Buildings.DHC.ETS.Combined.Validation.ChillerOnly_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_DHC_ETS_Combined_Validation_ChillerOnly.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.DHC.ETS.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: 48.817114965990186]