Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.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.001441/0.001441, allocations: 73.88 kB / 20.65 MB, free: 3.84 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.001457/0.001457, allocations: 169 kB / 24.05 MB, free: 452 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.9934/0.9934, allocations: 177.2 MB / 204.5 MB, free: 5.469 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 2.082/2.082, allocations: 429.5 MB / 0.6743 GB, free: 3.922 MB / 0.6355 GB
"
[Timeout remaining time 177]
Using package Buildings with version 14.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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.Subsystems.Validation.WatersideEconomizer,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|senT1InlPum.T|senT2InlPum.T|hexPum.conWSE.calTemLvg.T2WatLvg|senT2OutPum.T|hexPum.m1_flow|hexPum.m1_flow_nominal|hexPum.m2_flow_nominal|hexPum.hex.m2_flow|hexPum.conWSE.y1|hexPum.conWSE.yVal2|senT1InlVal.T|senT2InlVal.T|hexVal.conWSE.calTemLvg.T2WatLvg|senT2OutVal.T|hexVal.m1_flow|hexVal.m1_flow_nominal|hexVal.m2_flow_nominal|hexVal.hex.m2_flow|hexVal.conWSE.y1|hexVal.conWSE.yVal2",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer")
translateModel(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|senT1InlPum.T|senT2InlPum.T|hexPum.conWSE.calTemLvg.T2WatLvg|senT2OutPum.T|hexPum.m1_flow|hexPum.m1_flow_nominal|hexPum.m2_flow_nominal|hexPum.hex.m2_flow|hexPum.conWSE.y1|hexPum.conWSE.yVal2|senT1InlVal.T|senT2InlVal.T|hexVal.conWSE.calTemLvg.T2WatLvg|senT2OutVal.T|hexVal.m1_flow|hexVal.m1_flow_nominal|hexVal.m2_flow_nominal|hexVal.hex.m2_flow|hexVal.conWSE.y1|hexVal.conWSE.yVal2",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.633e-06/1.633e-06, allocations: 0 / 0.8794 GB, free: 6.035 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.39e-05/2.553e-05, allocations: 2.312 kB / 0.8794 GB, free: 6.031 MB / 0.8386 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer): time 0.05337/0.0534, allocations: 64.83 MB / 0.9427 GB, free: 5 MB / 0.9011 GB
Notification: Performance of NFInst.instExpressions: time 0.06083/0.1142, allocations: 31.8 MB / 0.9738 GB, free: 5.145 MB / 0.9323 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01513/0.1294, allocations: 0.5347 MB / 0.9743 GB, free: 4.605 MB / 0.9323 GB
Notification: Performance of NFTyping.typeComponents: time 0.01053/0.1399, allocations: 3.218 MB / 0.9774 GB, free: 1.367 MB / 0.9323 GB
Notification: Performance of NFTyping.typeBindings: time 0.02032/0.1602, allocations: 7.87 MB / 0.9851 GB, free: 9.453 MB / 0.948 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01753/0.1777, allocations: 9.194 MB / 0.9941 GB, free: 256 kB / 0.948 GB
Notification: Performance of NFFlatten.flatten: time 0.04707/0.2248, allocations: 37.27 MB / 1.031 GB, free: 10.89 MB / 0.9948 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01549/0.2403, allocations: 7.065 MB / 1.037 GB, free: 3.711 MB / 0.9948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0295/0.2698, allocations: 11.85 MB / 1.049 GB, free: 7.891 MB / 1.01 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01172/0.2815, allocations: 5.485 MB / 1.054 GB, free: 2.395 MB / 1.01 GB
Notification: Performance of NFPackage.collectConstants: time 0.004124/0.2856, allocations: 0.9648 MB / 1.055 GB, free: 1.43 MB / 1.01 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.4966/0.7822, allocations: 3.064 MB / 1.058 GB, free: 98.6 MB / 1.01 GB
Notification: Performance of NFScalarize.scalarize: time 0.004804/0.787, allocations: 2.92 MB / 1.061 GB, free: 98.6 MB / 1.01 GB
Notification: Performance of NFVerifyModel.verify: time 0.01004/0.7971, allocations: 3.574 MB / 1.065 GB, free: 98.6 MB / 1.01 GB
Notification: Performance of NFConvertDAE.convert: time 0.01957/0.8167, allocations: 9.479 MB / 1.074 GB, free: 97.95 MB / 1.01 GB
Notification: Performance of FrontEnd - DAE generated: time 1.051e-05/0.8167, allocations: 0 / 1.074 GB, free: 97.95 MB / 1.01 GB
Notification: Performance of FrontEnd: time 1.773e-06/0.8167, allocations: 0 / 1.074 GB, free: 97.95 MB / 1.01 GB
Notification: Performance of Transformations before backend: time 0.0007375/0.8174, allocations: 0 / 1.074 GB, free: 97.95 MB / 1.01 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1353
 * Number of variables: 1353
Notification: Performance of Generate backend data structure: time 0.02273/0.8401, allocations: 11.1 MB / 1.085 GB, free: 92.85 MB / 1.01 GB
Notification: Performance of prepare preOptimizeDAE: time 4.287e-05/0.8402, allocations: 8.719 kB / 1.085 GB, free: 92.85 MB / 1.01 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006762/0.8469, allocations: 2.26 MB / 1.087 GB, free: 92.23 MB / 1.01 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01626/0.8632, allocations: 9.606 MB / 1.096 GB, free: 90.52 MB / 1.01 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005096/0.8637, allocations: 459.1 kB / 1.097 GB, free: 90.5 MB / 1.01 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00147/0.8652, allocations: 0.6068 MB / 1.097 GB, free: 90.5 MB / 1.01 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008548/0.8737, allocations: 4.853 MB / 1.102 GB, free: 89.02 MB / 1.01 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001317/0.8739, allocations: 6.125 kB / 1.102 GB, free: 89.02 MB / 1.01 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004877/0.8743, allocations: 224.4 kB / 1.102 GB, free: 89.02 MB / 1.01 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001415/0.8745, allocations: 132.1 kB / 1.102 GB, free: 89.02 MB / 1.01 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00481/0.8793, allocations: 2.194 MB / 1.105 GB, free: 88.82 MB / 1.01 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.03895/0.9182, allocations: 24.18 MB / 1.128 GB, free: 79.64 MB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004707/0.923, allocations: 2.45 MB / 1.131 GB, free: 79.29 MB / 1.01 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001894/0.9249, allocations: 1.004 MB / 1.132 GB, free: 79.14 MB / 1.01 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01522/0.9401, allocations: 6.617 MB / 1.138 GB, free: 77.87 MB / 1.01 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0026/0.9427, allocations: 2.098 MB / 1.14 GB, free: 77.04 MB / 1.01 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003554/0.9462, allocations: 0.5752 MB / 1.141 GB, free: 76.85 MB / 1.01 GB
Notification: Performance of pre-optimization done (n=388): time 2.246e-05/0.9462, allocations: 0 / 1.141 GB, free: 76.85 MB / 1.01 GB
Notification: Performance of matching and sorting (n=388): time 0.01113/0.9574, allocations: 5.022 MB / 1.146 GB, free: 75.95 MB / 1.01 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.764e-05/0.9575, allocations: 272.2 kB / 1.146 GB, free: 75.69 MB / 1.01 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007331/0.9648, allocations: 6.129 MB / 1.152 GB, free: 74.95 MB / 1.01 GB
Notification: Performance of collectPreVariables (initialization): time 0.001234/0.966, allocations: 163.8 kB / 1.152 GB, free: 74.92 MB / 1.01 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003303/0.9693, allocations: 4.331 MB / 1.156 GB, free: 72.76 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001773/0.9711, allocations: 1.305 MB / 1.157 GB, free: 71.79 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001512/0.9726, allocations: 1.221 MB / 1.159 GB, free: 71.39 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 4.838e-05/0.9727, allocations: 482.8 kB / 1.159 GB, free: 70.92 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001633/0.9743, allocations: 0.9417 MB / 1.16 GB, free: 70.69 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002585/0.9769, allocations: 3.89 MB / 1.164 GB, free: 66.9 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004216/0.9811, allocations: 4.14 MB / 1.168 GB, free: 63.72 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.489e-05/0.9811, allocations: 12.69 kB / 1.168 GB, free: 63.72 MB / 1.01 GB
Notification: Performance of matching and sorting (n=705) (initialization): time 0.008516/0.9896, allocations: 5.034 MB / 1.173 GB, free: 62.22 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 6.755e-05/0.9897, allocations: 92.42 kB / 1.173 GB, free: 62.15 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.063e-05/0.9898, allocations: 49.33 kB / 1.173 GB, free: 62.15 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002183/0.9919, allocations: 0.7889 MB / 1.174 GB, free: 62.04 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002531/0.9945, allocations: 1.126 MB / 1.175 GB, free: 61.99 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001983/0.9965, allocations: 4.596 MB / 1.179 GB, free: 57.8 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005079/1.002, allocations: 304.7 kB / 1.18 GB, free: 57.69 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000616/1.002, allocations: 268.1 kB / 1.18 GB, free: 57.64 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003663/1.006, allocations: 1.131 MB / 1.181 GB, free: 57.24 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002665/1.008, allocations: 3.877 MB / 1.185 GB, free: 53.45 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004189/1.013, allocations: 4.105 MB / 1.189 GB, free: 50.28 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.603e-05/1.013, allocations: 12.12 kB / 1.189 GB, free: 50.28 MB / 1.01 GB
Notification: Performance of matching and sorting (n=705) (initialization_lambda0): time 0.008782/1.021, allocations: 4.916 MB / 1.194 GB, free: 48.79 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 7.036e-05/1.022, allocations: 95.41 kB / 1.194 GB, free: 48.72 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.235e-05/1.022, allocations: 50.59 kB / 1.194 GB, free: 48.72 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001931/1.024, allocations: 0.6505 MB / 1.194 GB, free: 48.62 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002487/1.026, allocations: 1.125 MB / 1.195 GB, free: 48.57 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003088/1.029, allocations: 6.333 MB / 1.202 GB, free: 42.85 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005368/1.035, allocations: 311.5 kB / 1.202 GB, free: 42.75 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005864/1.035, allocations: 258.2 kB / 1.202 GB, free: 42.7 MB / 1.01 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 202
 * Number of states: 0 ()
 * Number of discrete variables: 121 ($PRE.hexPum.conWSE.ena.enableFire,$PRE.hexPum.conWSE.dis.enableFire,$PRE.hexPum.conWSE.isValIsoEvaClo.lesHys.y,$PRE.hexVal.conWSE.ena.enableFire,$PRE.hexVal.conWSE.dis.enableFire,$PRE.hexVal.conWSE.isValIsoEvaClo.lesHys.y,hexVal.conWSE.dis.t_start,$PRE.hexVal.conWSE.dis.t_start,hexVal.conWSE.ena.t_start,$PRE.hexVal.conWSE.ena.t_start,hexPum.conWSE.dis.t_start,$PRE.hexPum.conWSE.dis.t_start,hexPum.conWSE.ena.t_start,$PRE.hexPum.conWSE.ena.t_start,hexVal.conWSE.stateGraphRoot.resume,hexVal.conWSE.stateGraphRoot.suspend,hexPum.conWSE.stateGraphRoot.resume,hexPum.conWSE.stateGraphRoot.suspend,hexVal.hex.flowRegime_nominal,hexPum.hex.flowRegime_nominal,hexPum.conWSE.isValIsoEvaClo.lesHys.y,hexVal.conWSE.isValIsoEvaClo.lesHys.y,TSerWat.nextEventScaled,TSerWat.nextEvent,$PRE.TSerWat.nextEvent,TSerWat.last,TSerWat.b,TSerWat.a,TChiWatRet.nextEventScaled,TChiWatRet.nextEvent,$PRE.TChiWatRet.nextEvent,TChiWatRet.last,TChiWatRet.b,TChiWatRet.a,hexVal.uCoo,hexVal.conWSE.and1.y,hexVal.conWSE.tim1.entryTime,$PRE.hexVal.conWSE.tim1.entryTime,hexVal.conWSE.tim1.passed,$PRE.hexVal.conWSE.tim1.passed,hexVal.conWSE.tim.entryTime,$PRE.hexVal.conWSE.tim.entryTime,hexVal.conWSE.tim.passed,$PRE.hexVal.conWSE.tim.passed,hexVal.conWSE.or1.uTemp[2],hexVal.conWSE.or1.y,hexVal.conWSE.mulAnd.uTemp[3],hexVal.conWSE.mulAnd.uTemp[2],hexVal.conWSE.stateGraphRoot.activeSteps,hexVal.conWSE.delTemDis1.lesHys.y,$PRE.hexVal.conWSE.delTemDis1.lesHys.y,hexVal.conWSE.delTemDis.lesHys.y,$PRE.hexVal.conWSE.delTemDis.lesHys.y,hexVal.conWSE.dis.enableFire,hexVal.conWSE.dis.localCondition,hexVal.conWSE.actSta.active,hexVal.conWSE.actSta.oldActive,$PRE.hexVal.conWSE.actSta.oldActive,hexVal.conWSE.actSta.newActive,$PRE.hexVal.conWSE.actSta.newActive,hexVal.conWSE.actSta.localActive,$PRE.hexVal.conWSE.actSta.localActive,hexVal.conWSE.ena.enableFire,hexVal.conWSE.ena.localCondition,hexVal.conWSE.iniSta.active,hexVal.conWSE.iniSta.oldActive,$PRE.hexVal.conWSE.iniSta.oldActive,hexVal.conWSE.iniSta.newActive,$PRE.hexVal.conWSE.iniSta.newActive,hexVal.conWSE.iniSta.localActive,$PRE.hexVal.conWSE.iniSta.localActive,hexPum.conWSE.and1.y,hexPum.conWSE.tim1.entryTime,$PRE.hexPum.conWSE.tim1.entryTime,hexPum.conWSE.tim1.passed,$PRE.hexPum.conWSE.tim1.passed,hexPum.conWSE.tim.entryTime,$PRE.hexPum.conWSE.tim.entryTime,hexPum.conWSE.tim.passed,$PRE.hexPum.conWSE.tim.passed,hexPum.conWSE.or1.uTemp[2],hexPum.conWSE.or1.y,hexPum.conWSE.mulAnd.uTemp[3],hexPum.conWSE.mulAnd.uTemp[2],hexPum.conWSE.stateGraphRoot.activeSteps,hexPum.conWSE.delTemDis1.lesHys.y,$PRE.hexPum.conWSE.delTemDis1.lesHys.y,hexPum.conWSE.delTemDis.lesHys.y,$PRE.hexPum.conWSE.delTemDis.lesHys.y,hexPum.conWSE.dis.enableFire,hexPum.conWSE.dis.localCondition,hexPum.conWSE.actSta.active,hexPum.conWSE.actSta.oldActive,$PRE.hexPum.conWSE.actSta.oldActive,hexPum.conWSE.actSta.newActive,$PRE.hexPum.conWSE.actSta.newActive,hexPum.conWSE.actSta.localActive,$PRE.hexPum.conWSE.actSta.localActive,hexPum.conWSE.ena.enableFire,hexPum.conWSE.ena.localCondition,hexPum.conWSE.iniSta.active,hexPum.conWSE.iniSta.oldActive,$PRE.hexPum.conWSE.iniSta.oldActive,hexPum.conWSE.iniSta.newActive,$PRE.hexPum.conWSE.iniSta.newActive,hexPum.conWSE.iniSta.localActive,$PRE.hexPum.conWSE.iniSta.localActive,$whenCondition14,$whenCondition13,$whenCondition3,$whenCondition2,$whenCondition1,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition12,$whenCondition11,$whenCondition10)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (648):
 * Single equations (assignments): 638
 * Array equations: 3
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 4
 * 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): 1 system
   {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): 4 systems
   {(2,13), (1,7), (2,13), (1,7)}
Notification: Performance of prepare postOptimizeDAE: time 0.001642/1.037, allocations: 0.7428 MB / 1.203 GB, free: 42.16 MB / 1.01 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002433/1.039, allocations: 0.9432 MB / 1.204 GB, free: 41.66 MB / 1.01 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006605/1.046, allocations: 4.394 MB / 1.208 GB, free: 40.36 MB / 1.01 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.414e-05/1.046, allocations: 54.61 kB / 1.208 GB, free: 40.35 MB / 1.01 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.987e-06/1.046, allocations: 3.281 kB / 1.208 GB, free: 40.35 MB / 1.01 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003208/1.049, allocations: 2.698 MB / 1.211 GB, free: 39.6 MB / 1.01 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01365/1.063, allocations: 8.088 MB / 1.219 GB, free: 36.81 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.088e-05/1.063, allocations: 4.031 kB / 1.219 GB, free: 36.81 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001567/1.064, allocations: 0.6409 MB / 1.219 GB, free: 36.78 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00112/1.065, allocations: 0.5044 MB / 1.22 GB, free: 36.42 MB / 1.01 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002779/1.066, allocations: 133.4 kB / 1.22 GB, free: 36.31 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001404/1.067, allocations: 4.486 MB / 1.224 GB, free: 31.79 MB / 1.01 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.987e-06/1.067, allocations: 7.844 kB / 1.224 GB, free: 31.78 MB / 1.01 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007027/1.074, allocations: 5.035 MB / 1.229 GB, free: 27.18 MB / 1.01 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003065/1.077, allocations: 1.358 MB / 1.231 GB, free: 25.98 MB / 1.01 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001214/1.078, allocations: 108 kB / 1.231 GB, free: 25.87 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002158/1.081, allocations: 216.8 kB / 1.231 GB, free: 25.66 MB / 1.01 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000407/1.081, allocations: 334.1 kB / 1.231 GB, free: 25.34 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002801/1.081, allocations: 167.9 kB / 1.231 GB, free: 25.17 MB / 1.01 GB
Notification: Performance of sorting global known variables: time 0.00315/1.084, allocations: 3.088 MB / 1.234 GB, free: 22.46 MB / 1.01 GB
Notification: Performance of sort global known variables: time 6e-08/1.084, allocations: 0 / 1.234 GB, free: 22.46 MB / 1.01 GB
Notification: Performance of remove unused functions: time 0.008844/1.093, allocations: 3.796 MB / 1.238 GB, free: 18.66 MB / 1.01 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 13
 * Number of states: 18 (pum2Pum.vol.dynBal.U,pum2Pum.motSpe.y,hexPum.senT2WatEnt.T,hexPum.senT2WatLvg.T,hexPum.senT1WatEnt.T,senT1OutPum.T,senT1InlPum.T,senT2OutPum.T,senT2InlPum.T,hexVal.senT2WatEnt.T,hexVal.senT2WatLvg.T,hexVal.senT1WatEnt.T,senT1InlVal.T,senT1OutVal.T,senT2OutVal.T,senT2InlVal.T,pum2Val.vol.dynBal.U,pum2Val.motSpe.y)
 * Number of discrete variables: 77 (hexVal.conWSE.actSta.localActive,hexVal.conWSE.actSta.active,hexVal.conWSE.iniSta.localActive,hexVal.conWSE.iniSta.active,hexPum.conWSE.actSta.localActive,hexPum.conWSE.actSta.active,hexPum.conWSE.iniSta.localActive,hexPum.conWSE.iniSta.active,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition13,$whenCondition14,hexPum.conWSE.iniSta.newActive,hexPum.conWSE.iniSta.oldActive,hexPum.conWSE.ena.localCondition,hexPum.conWSE.ena.enableFire,hexPum.conWSE.actSta.newActive,hexPum.conWSE.actSta.oldActive,hexPum.conWSE.dis.localCondition,hexPum.conWSE.dis.enableFire,hexPum.conWSE.delTemDis.lesHys.y,hexPum.conWSE.delTemDis1.lesHys.y,hexPum.conWSE.stateGraphRoot.activeSteps,hexPum.conWSE.mulAnd.uTemp[2],hexPum.conWSE.mulAnd.uTemp[3],hexPum.conWSE.or1.y,hexPum.conWSE.or1.uTemp[2],hexPum.conWSE.tim.passed,hexPum.conWSE.tim.entryTime,hexPum.conWSE.tim1.passed,hexPum.conWSE.tim1.entryTime,hexPum.conWSE.and1.y,hexVal.conWSE.iniSta.newActive,hexVal.conWSE.iniSta.oldActive,hexVal.conWSE.ena.localCondition,hexVal.conWSE.ena.enableFire,hexVal.conWSE.actSta.newActive,hexVal.conWSE.actSta.oldActive,hexVal.conWSE.dis.localCondition,hexVal.conWSE.dis.enableFire,hexVal.conWSE.delTemDis.lesHys.y,hexVal.conWSE.delTemDis1.lesHys.y,hexVal.conWSE.stateGraphRoot.activeSteps,hexVal.conWSE.mulAnd.uTemp[2],hexVal.conWSE.mulAnd.uTemp[3],hexVal.conWSE.or1.y,hexVal.conWSE.or1.uTemp[2],hexVal.conWSE.tim.passed,hexVal.conWSE.tim.entryTime,hexVal.conWSE.tim1.passed,hexVal.conWSE.tim1.entryTime,hexVal.conWSE.and1.y,hexVal.uCoo,TChiWatRet.a,TChiWatRet.b,TChiWatRet.last,TChiWatRet.nextEvent,TChiWatRet.nextEventScaled,TSerWat.a,TSerWat.b,TSerWat.last,TSerWat.nextEvent,TSerWat.nextEventScaled,hexPum.conWSE.ena.t_start,hexPum.conWSE.dis.t_start,hexVal.conWSE.ena.t_start,hexVal.conWSE.dis.t_start)
 * Number of discrete states: 28 (hexVal.conWSE.dis.t_start,hexVal.conWSE.ena.t_start,hexPum.conWSE.dis.t_start,hexPum.conWSE.ena.t_start,hexPum.conWSE.iniSta.newActive,hexPum.conWSE.tim1.entryTime,hexPum.conWSE.actSta.newActive,hexPum.conWSE.tim.entryTime,hexPum.conWSE.delTemDis.lesHys.y,hexVal.conWSE.iniSta.newActive,hexVal.conWSE.tim1.entryTime,hexVal.conWSE.actSta.newActive,hexVal.conWSE.tim.entryTime,hexVal.conWSE.delTemDis.lesHys.y,TChiWatRet.nextEvent,TChiWatRet.last,TChiWatRet.nextEventScaled,TChiWatRet.b,TChiWatRet.a,$whenCondition14,TSerWat.nextEvent,TSerWat.last,TSerWat.nextEventScaled,TSerWat.b,TSerWat.a,$whenCondition13,hexPum.conWSE.delTemDis1.lesHys.y,hexVal.conWSE.delTemDis1.lesHys.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (396):
 * Single equations (assignments): 351
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 22
 * When equations: 16
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 4
 * 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): 1 system
   {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): 4 systems
   {(2,17), (3,16), (1,7), (1,7)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001617/1.095, allocations: 0.7966 MB / 1.239 GB, free: 17.93 MB / 1.01 GB
Notification: Performance of simCode: created initialization part: time 0.008648/1.103, allocations: 5.998 MB / 1.245 GB, free: 12.24 MB / 1.01 GB
Notification: Performance of simCode: created event and clocks part: time 7.264e-06/1.103, allocations: 0 / 1.245 GB, free: 12.24 MB / 1.01 GB
Notification: Performance of simCode: created simulation system equations: time 0.002193/1.106, allocations: 1.691 MB / 1.246 GB, free: 10.63 MB / 1.01 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01104/1.117, allocations: 4.01 MB / 1.25 GB, free: 6.719 MB / 1.01 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01932/1.136, allocations: 13.23 MB / 1.263 GB, free: 9.391 MB / 1.026 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001758/1.138, allocations: 1.464 MB / 1.265 GB, free: 7.902 MB / 1.026 GB
Notification: Performance of simCode: alias equations: time 0.006797/1.145, allocations: 1.759 MB / 1.266 GB, free: 6.211 MB / 1.026 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.007079/1.152, allocations: 3.213 MB / 1.269 GB, free: 3 MB / 1.026 GB
Notification: Performance of SimCode: time 1.954e-06/1.152, allocations: 0 / 1.269 GB, free: 3 MB / 1.026 GB
Notification: Performance of Templates: time 0.2004/1.352, allocations: 169.7 MB / 1.435 GB, free: 12.45 MB / 1.198 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe ; mkfifo Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe >> ../files/Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.sim & ./Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe 2>&1) [Timeout 240]
diffSimulationResults("Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_DHC_ETS_Combined_Subsystems_Validation_WatersideEconomizer.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 10.748916045762599]