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.0007943/0.0007943, allocations: 72.5 kB / 19.93 MB, free: 4.633 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.0008459/0.0008459, allocations: 177.9 kB / 23.21 MB, free: 1.348 MB / 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.8991/0.8991, allocations: 177.1 MB / 203.5 MB, free: 5.742 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 1.775/1.775, allocations: 389 MB / 0.6338 GB, free: 12.66 MB / 0.6042 GB
"
[Timeout remaining time 178]
Using package Buildings with version 13.0.1 (/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.964e-06/1.964e-06, allocations: 3.938 kB / 1.001 GB, free: 12.96 MB / 0.9636 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.648e-05/2.844e-05, allocations: 6.219 kB / 1.001 GB, free: 12.95 MB / 0.9636 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer): time 0.7213/0.7213, allocations: 274.6 MB / 1.269 GB, free: 10.29 MB / 1.104 GB
Notification: Performance of NFInst.instExpressions: time 0.08102/0.8023, allocations: 69.13 MB / 1.337 GB, free: 5.008 MB / 1.167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01892/0.8212, allocations: 0.5114 MB / 1.337 GB, free: 4.492 MB / 1.167 GB
Notification: Performance of NFTyping.typeComponents: time 0.01468/0.8359, allocations: 4.923 MB / 1.342 GB, free: 15.54 MB / 1.182 GB
Notification: Performance of NFTyping.typeBindings: time 0.0297/0.8656, allocations: 11.02 MB / 1.353 GB, free: 4.473 MB / 1.182 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01986/0.8855, allocations: 10 MB / 1.362 GB, free: 10.52 MB / 1.198 GB
Notification: Performance of NFFlatten.flatten: time 0.0398/0.9253, allocations: 37.37 MB / 1.399 GB, free: 5.07 MB / 1.229 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01114/0.9364, allocations: 6.616 MB / 1.405 GB, free: 14.34 MB / 1.245 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02557/0.962, allocations: 13.63 MB / 1.419 GB, free: 0.6914 MB / 1.245 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.009551/0.9715, allocations: 5.481 MB / 1.424 GB, free: 11.2 MB / 1.26 GB
Notification: Performance of NFPackage.collectConstants: time 0.001726/0.9733, allocations: 0.9805 MB / 1.425 GB, free: 10.21 MB / 1.26 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009704/0.983, allocations: 5.045 MB / 1.43 GB, free: 5.16 MB / 1.26 GB
Notification: Performance of NFScalarize.scalarize: time 0.002038/0.985, allocations: 2.916 MB / 1.433 GB, free: 2.234 MB / 1.26 GB
Notification: Performance of NFVerifyModel.verify: time 0.0046/0.9896, allocations: 3.57 MB / 1.436 GB, free: 14.66 MB / 1.276 GB
Notification: Performance of NFConvertDAE.convert: time 0.02038/1.01, allocations: 17.54 MB / 1.453 GB, free: 13.07 MB / 1.292 GB
Notification: Performance of FrontEnd - DAE generated: time 8.205e-06/1.01, allocations: 0 / 1.453 GB, free: 13.07 MB / 1.292 GB
Notification: Performance of FrontEnd: time 2.134e-06/1.01, allocations: 3.938 kB / 1.453 GB, free: 13.06 MB / 1.292 GB
Notification: Performance of Transformations before backend: time 0.0002486/1.01, allocations: 3.984 kB / 1.453 GB, free: 13.06 MB / 1.292 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.01747/1.028, allocations: 10.88 MB / 1.464 GB, free: 2.02 MB / 1.292 GB
Notification: Performance of prepare preOptimizeDAE: time 5.659e-05/1.028, allocations: 15.98 kB / 1.464 GB, free: 2.004 MB / 1.292 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005872/1.034, allocations: 2.023 MB / 1.466 GB, free: 15.97 MB / 1.307 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01482/1.048, allocations: 10.84 MB / 1.477 GB, free: 5.004 MB / 1.307 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002784/1.049, allocations: 450.5 kB / 1.477 GB, free: 4.562 MB / 1.307 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006854/1.049, allocations: 0.5742 MB / 1.478 GB, free: 3.988 MB / 1.307 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00948/1.059, allocations: 7.062 MB / 1.485 GB, free: 12.61 MB / 1.323 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.089e-05/1.059, allocations: 15.88 kB / 1.485 GB, free: 12.59 MB / 1.323 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003914/1.059, allocations: 224 kB / 1.485 GB, free: 12.37 MB / 1.323 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.766e-05/1.059, allocations: 132 kB / 1.485 GB, free: 12.24 MB / 1.323 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008431/1.068, allocations: 5.699 MB / 1.49 GB, free: 6.52 MB / 1.323 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.03053/1.098, allocations: 22.34 MB / 1.512 GB, free: 15.78 MB / 1.354 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005989/1.104, allocations: 4.012 MB / 1.516 GB, free: 11.73 MB / 1.354 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002732/1.107, allocations: 2.09 MB / 1.518 GB, free: 9.609 MB / 1.354 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01195/1.119, allocations: 7.307 MB / 1.525 GB, free: 2.266 MB / 1.354 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003858/1.123, allocations: 3.273 MB / 1.529 GB, free: 14.82 MB / 1.37 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002154/1.125, allocations: 0.5249 MB / 1.529 GB, free: 14.29 MB / 1.37 GB
Notification: Performance of pre-optimization done (n=394): time 7.434e-06/1.125, allocations: 0 / 1.529 GB, free: 14.29 MB / 1.37 GB
Notification: Performance of matching and sorting (n=394): time 0.01461/1.14, allocations: 8.301 MB / 1.537 GB, free: 5.914 MB / 1.37 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.00014/1.14, allocations: 272.6 kB / 1.537 GB, free: 5.598 MB / 1.37 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008444/1.148, allocations: 6.778 MB / 1.544 GB, free: 14.83 MB / 1.385 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003107/1.149, allocations: 153.7 kB / 1.544 GB, free: 14.68 MB / 1.385 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002547/1.151, allocations: 3.955 MB / 1.548 GB, free: 10.7 MB / 1.385 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00101/1.152, allocations: 1.301 MB / 1.549 GB, free: 9.387 MB / 1.385 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001205/1.153, allocations: 1.099 MB / 1.55 GB, free: 8.277 MB / 1.385 GB
Notification: Performance of setup shared object (initialization): time 7.143e-05/1.153, allocations: 301.1 kB / 1.551 GB, free: 7.98 MB / 1.385 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003016/1.156, allocations: 2.249 MB / 1.553 GB, free: 5.703 MB / 1.385 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004098/1.161, allocations: 4.353 MB / 1.557 GB, free: 0.6055 MB / 1.385 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006606/1.167, allocations: 5.469 MB / 1.562 GB, free: 10.65 MB / 1.401 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.863e-05/1.167, allocations: 8 kB / 1.562 GB, free: 10.64 MB / 1.401 GB
Notification: Performance of matching and sorting (n=657) (initialization): time 0.01075/1.178, allocations: 7.212 MB / 1.57 GB, free: 3.375 MB / 1.401 GB
Notification: Performance of prepare postOptimizeDAE: time 7.351e-05/1.178, allocations: 87.38 kB / 1.57 GB, free: 3.277 MB / 1.401 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.563e-05/1.178, allocations: 36.78 kB / 1.57 GB, free: 3.242 MB / 1.401 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002046/1.18, allocations: 0.8641 MB / 1.571 GB, free: 2.367 MB / 1.401 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002392/1.182, allocations: 1.092 MB / 1.572 GB, free: 1.273 MB / 1.401 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.5539/1.736, allocations: 3.705 MB / 1.575 GB, free: 462 MB / 1.401 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006405/1.743, allocations: 374.2 kB / 1.576 GB, free: 462 MB / 1.401 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004874/1.743, allocations: 288.9 kB / 1.576 GB, free: 462 MB / 1.401 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.006643/1.75, allocations: 3.704 MB / 1.579 GB, free: 461.8 MB / 1.401 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003452/1.753, allocations: 4.312 MB / 1.584 GB, free: 458.9 MB / 1.401 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005819/1.759, allocations: 5.375 MB / 1.589 GB, free: 455.8 MB / 1.401 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.892e-05/1.759, allocations: 10.31 kB / 1.589 GB, free: 455.8 MB / 1.401 GB
Notification: Performance of matching and sorting (n=657) (initialization_lambda0): time 0.01079/1.77, allocations: 6.98 MB / 1.596 GB, free: 453.4 MB / 1.401 GB
Notification: Performance of prepare postOptimizeDAE: time 5.479e-05/1.77, allocations: 86.44 kB / 1.596 GB, free: 453.4 MB / 1.401 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.436e-05/1.77, allocations: 37.53 kB / 1.596 GB, free: 453.4 MB / 1.401 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001733/1.772, allocations: 0.7905 MB / 1.597 GB, free: 453.2 MB / 1.401 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002213/1.774, allocations: 1.09 MB / 1.598 GB, free: 453.1 MB / 1.401 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002914/1.777, allocations: 5.241 MB / 1.603 GB, free: 448.7 MB / 1.401 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003741/1.781, allocations: 391.6 kB / 1.603 GB, free: 448.6 MB / 1.401 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005061/1.781, allocations: 275.9 kB / 1.603 GB, free: 448.6 MB / 1.401 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 148
 * 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 (600):
 * Single equations (assignments): 590
 * 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.001387/1.783, allocations: 0.6176 MB / 1.604 GB, free: 448.1 MB / 1.401 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001199/1.784, allocations: 0.8012 MB / 1.605 GB, free: 448.1 MB / 1.401 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01063/1.794, allocations: 7.202 MB / 1.612 GB, free: 445.5 MB / 1.401 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.296e-05/1.794, allocations: 61.73 kB / 1.612 GB, free: 445.5 MB / 1.401 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.823e-06/1.794, allocations: 2.312 kB / 1.612 GB, free: 445.5 MB / 1.401 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007236/1.802, allocations: 5.329 MB / 1.617 GB, free: 443.4 MB / 1.401 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01718/1.819, allocations: 11.91 MB / 1.629 GB, free: 438.4 MB / 1.401 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.306e-05/1.819, allocations: 7.969 kB / 1.629 GB, free: 438.4 MB / 1.401 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001906/1.821, allocations: 0.7191 MB / 1.629 GB, free: 438.4 MB / 1.401 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001267/1.822, allocations: 0.5847 MB / 1.63 GB, free: 438.2 MB / 1.401 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002524/1.822, allocations: 144.2 kB / 1.63 GB, free: 438.2 MB / 1.401 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001908/1.824, allocations: 3.563 MB / 1.634 GB, free: 435.1 MB / 1.401 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.002e-06/1.824, allocations: 7.344 kB / 1.634 GB, free: 435.1 MB / 1.401 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01417/1.838, allocations: 9.483 MB / 1.643 GB, free: 431.2 MB / 1.401 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003329/1.842, allocations: 1.388 MB / 1.644 GB, free: 430.3 MB / 1.401 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006403/1.842, allocations: 110.1 kB / 1.644 GB, free: 430.2 MB / 1.401 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002071/1.844, allocations: 321.6 kB / 1.645 GB, free: 430.2 MB / 1.401 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005983/1.845, allocations: 371.8 kB / 1.645 GB, free: 430.1 MB / 1.401 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003329/1.845, allocations: 203.2 kB / 1.645 GB, free: 430.1 MB / 1.401 GB
Notification: Performance of sorting global known variables: time 0.006564/1.852, allocations: 4.46 MB / 1.65 GB, free: 428.5 MB / 1.401 GB
Notification: Performance of sort global known variables: time 2.01e-07/1.852, allocations: 0 / 1.65 GB, free: 428.5 MB / 1.401 GB
Notification: Performance of remove unused functions: time 0.009068/1.861, allocations: 4.046 MB / 1.654 GB, free: 427.9 MB / 1.401 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 (418):
 * Single equations (assignments): 357
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 38
 * 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
   {(3,16), (2,17), (1,7), (1,7)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002772/1.864, allocations: 1.707 MB / 1.655 GB, free: 427.6 MB / 1.401 GB
Notification: Performance of simCode: created initialization part: time 0.01527/1.879, allocations: 9.054 MB / 1.664 GB, free: 424.3 MB / 1.401 GB
Notification: Performance of simCode: created event and clocks part: time 9.017e-06/1.879, allocations: 6.125 kB / 1.664 GB, free: 424.3 MB / 1.401 GB
Notification: Performance of simCode: created simulation system equations: time 0.004151/1.883, allocations: 2.897 MB / 1.667 GB, free: 423.3 MB / 1.401 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01021/1.893, allocations: 3.827 MB / 1.671 GB, free: 422.1 MB / 1.401 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01906/1.912, allocations: 15.42 MB / 1.686 GB, free: 414.6 MB / 1.401 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003717/1.916, allocations: 3.667 MB / 1.689 GB, free: 413.4 MB / 1.401 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002006/1.918, allocations: 0.7197 MB / 1.69 GB, free: 412.8 MB / 1.401 GB
Notification: Performance of SimCode: time 1.613e-06/1.918, allocations: 0 / 1.69 GB, free: 412.8 MB / 1.401 GB
Notification: Performance of Templates: time 0.2124/2.131, allocations: 348.2 MB / 2.03 GB, free: 71.48 MB / 1.401 GB
"
[Timeout remaining time 298]
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=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.pipe 2>&1) [Timeout 800]
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","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.WatersideEconomizer.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: 30.152065399102867]