Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.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.001609/0.001609, allocations: 77.55 kB / 19.76 MB, free: 2.027 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.002038/0.002038, allocations: 156.4 kB / 23.01 MB, free: 4.949 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.45/1.45, allocations: 177.2 MB / 203.4 MB, free: 8.961 MB / 190.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.708/2.708, allocations: 359.1 MB / 0.6044 GB, free: 14.84 MB / 0.5762 GB
"
[Timeout remaining time 177]
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.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|ecoCon.y|ecoCon.cooMod|dam1.y_actual|dam2.y|senTemSupAir.T|roo.TRooAir|weaBus.TDryBul|weaBus.TDewPoi|varSpeDX.QSen_flow|varSpeDX.QLat_flow|varSpeDX.P|varSpeDX.dxCoi.EIR",fileNamePrefix="Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer")
translateModel(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|ecoCon.y|ecoCon.cooMod|dam1.y_actual|dam2.y|senTemSupAir.T|roo.TRooAir|weaBus.TDryBul|weaBus.TDewPoi|varSpeDX.QSen_flow|varSpeDX.QLat_flow|varSpeDX.P|varSpeDX.dxCoi.EIR",fileNamePrefix="Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer") [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.002202/0.002202, allocations: 67.89 kB / 0.9515 GB, free: 12.76 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2885/0.2907, allocations: 169.9 MB / 1.117 GB, free: 2.523 MB / 1.061 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer): time 0.8199/1.111, allocations: 283 MB / 1.394 GB, free: 12.95 MB / 1.232 GB
Notification: Performance of NFInst.instExpressions: time 0.07013/1.181, allocations: 44.66 MB / 1.437 GB, free: 172 kB / 1.264 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007091/1.188, allocations: 246.1 kB / 1.438 GB, free: 15.92 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.01103/1.199, allocations: 3.853 MB / 1.441 GB, free: 12.05 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.02115/1.22, allocations: 7.66 MB / 1.449 GB, free: 4.367 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01999/1.24, allocations: 7.969 MB / 1.457 GB, free: 12.46 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.03404/1.274, allocations: 24.11 MB / 1.48 GB, free: 4.328 MB / 1.311 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01171/1.286, allocations: 6.945 MB / 1.487 GB, free: 13.26 MB / 1.326 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01498/1.301, allocations: 7.407 MB / 1.494 GB, free: 5.855 MB / 1.326 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01159/1.312, allocations: 6.239 MB / 1.5 GB, free: 15.61 MB / 1.342 GB
Notification: Performance of NFPackage.collectConstants: time 0.003709/1.316, allocations: 1.379 MB / 1.502 GB, free: 14.23 MB / 1.342 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01614/1.332, allocations: 7.134 MB / 1.509 GB, free: 7.078 MB / 1.342 GB
Notification: Performance of NFScalarize.scalarize: time 0.006194/1.338, allocations: 4.32 MB / 1.513 GB, free: 2.746 MB / 1.342 GB
Notification: Performance of NFVerifyModel.verify: time 0.01022/1.349, allocations: 5.231 MB / 1.518 GB, free: 13.49 MB / 1.357 GB
Notification: Performance of NFConvertDAE.convert: time 0.03511/1.384, allocations: 25.05 MB / 1.542 GB, free: 4.363 MB / 1.373 GB
Notification: Performance of FrontEnd - DAE generated: time 5.35e-06/1.384, allocations: 0 / 1.542 GB, free: 4.363 MB / 1.373 GB
Notification: Performance of FrontEnd: time 1.443e-06/1.384, allocations: 0 / 1.542 GB, free: 4.363 MB / 1.373 GB
Notification: Performance of Transformations before backend: time 0.0004591/1.384, allocations: 4 kB / 1.542 GB, free: 4.359 MB / 1.373 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1251
 * Number of variables: 1251
Notification: Performance of Generate backend data structure: time 0.03816/1.422, allocations: 15.06 MB / 1.557 GB, free: 5.082 MB / 1.389 GB
Notification: Performance of prepare preOptimizeDAE: time 4.236e-05/1.422, allocations: 8.031 kB / 1.557 GB, free: 5.074 MB / 1.389 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04798/1.47, allocations: 5.365 MB / 1.562 GB, free: 15.7 MB / 1.404 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02821/1.499, allocations: 11.45 MB / 1.574 GB, free: 4.129 MB / 1.404 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001115/1.5, allocations: 0.8258 MB / 1.574 GB, free: 3.23 MB / 1.404 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001716/1.501, allocations: 0.5312 MB / 1.575 GB, free: 2.699 MB / 1.404 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02665/1.528, allocations: 11.46 MB / 1.586 GB, free: 6.883 MB / 1.42 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001072/1.528, allocations: 7.938 kB / 1.586 GB, free: 6.875 MB / 1.42 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008081/1.529, allocations: 208 kB / 1.586 GB, free: 6.672 MB / 1.42 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001906/1.529, allocations: 197.4 kB / 1.587 GB, free: 6.477 MB / 1.42 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03594/1.565, allocations: 12.84 MB / 1.599 GB, free: 9.613 MB / 1.436 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.08056/1.646, allocations: 33.85 MB / 1.632 GB, free: 7.5 MB / 1.467 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02735/1.673, allocations: 8.795 MB / 1.641 GB, free: 14.7 MB / 1.482 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0163/1.689, allocations: 5.531 MB / 1.646 GB, free: 9.152 MB / 1.482 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001454/1.691, allocations: 247.2 kB / 1.646 GB, free: 8.91 MB / 1.482 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02037/1.711, allocations: 7.936 MB / 1.654 GB, free: 0.832 MB / 1.482 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006074/1.717, allocations: 0.6186 MB / 1.655 GB, free: 216 kB / 1.482 GB
Notification: Performance of pre-optimization done (n=470): time 1.61e-05/1.717, allocations: 0 / 1.655 GB, free: 216 kB / 1.482 GB
Notification: Performance of matching and sorting (n=470): time 0.08607/1.803, allocations: 19.26 MB / 1.674 GB, free: 12.91 MB / 1.514 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002491/1.804, allocations: 311 kB / 1.674 GB, free: 12.55 MB / 1.514 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03193/1.835, allocations: 13.95 MB / 1.687 GB, free: 14.65 MB / 1.529 GB
Notification: Performance of collectPreVariables (initialization): time 0.001839/1.837, allocations: 193.7 kB / 1.688 GB, free: 14.45 MB / 1.529 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007043/1.844, allocations: 4.585 MB / 1.692 GB, free: 9.852 MB / 1.529 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002662/1.847, allocations: 1.569 MB / 1.694 GB, free: 8.27 MB / 1.529 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004729/1.852, allocations: 1.232 MB / 1.695 GB, free: 7.027 MB / 1.529 GB
Notification: Performance of setup shared object (initialization): time 0.0001306/1.852, allocations: 309 kB / 1.695 GB, free: 6.723 MB / 1.529 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01753/1.869, allocations: 6.667 MB / 1.702 GB, free: 16 kB / 1.529 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02108/1.89, allocations: 9.045 MB / 1.71 GB, free: 6.184 MB / 1.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 1.515/3.406, allocations: 160.8 MB / 1.867 GB, free: 448.9 MB / 1.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.96e-05/3.406, allocations: 4 kB / 1.867 GB, free: 448.9 MB / 1.561 GB
Notification: Performance of matching and sorting (n=658) (initialization): time 0.05575/3.462, allocations: 16.6 MB / 1.884 GB, free: 432.8 MB / 1.561 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001363/3.462, allocations: 137.1 kB / 1.884 GB, free: 432.6 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.674e-05/3.462, allocations: 20 kB / 1.884 GB, free: 432.6 MB / 1.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007344/3.469, allocations: 1.766 MB / 1.886 GB, free: 430.8 MB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009686/3.479, allocations: 1.501 MB / 1.887 GB, free: 429.3 MB / 1.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01477/3.494, allocations: 15.9 MB / 1.903 GB, free: 412.7 MB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01294/3.507, allocations: 0.8164 MB / 1.903 GB, free: 411.9 MB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001547/3.508, allocations: 331.7 kB / 1.904 GB, free: 411.6 MB / 1.561 GB
Warning: Assuming fixed start value for the following 1 variables:
         varSpeDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01859/3.527, allocations: 9.64 MB / 1.913 GB, free: 401.9 MB / 1.561 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01486/3.542, allocations: 9.003 MB / 1.922 GB, free: 392.1 MB / 1.561 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.4423/3.984, allocations: 160.5 MB / 2.079 GB, free: 231.1 MB / 1.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.775e-05/3.984, allocations: 8 kB / 2.079 GB, free: 231.1 MB / 1.561 GB
Notification: Performance of matching and sorting (n=658) (initialization_lambda0): time 0.05525/4.039, allocations: 16.3 MB / 2.095 GB, free: 215.2 MB / 1.561 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001394/4.039, allocations: 137.1 kB / 2.095 GB, free: 215 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.751e-05/4.039, allocations: 16 kB / 2.095 GB, free: 215 MB / 1.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005635/4.045, allocations: 1.519 MB / 2.096 GB, free: 213.4 MB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009648/4.055, allocations: 1.513 MB / 2.098 GB, free: 211.9 MB / 1.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01243/4.067, allocations: 15.07 MB / 2.112 GB, free: 196.1 MB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01306/4.08, allocations: 0.8615 MB / 2.113 GB, free: 195.2 MB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001571/4.082, allocations: 323.7 kB / 2.113 GB, free: 194.9 MB / 1.561 GB
Warning: Assuming fixed start value for the following 1 variables:
         varSpeDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 76
 * Number of states: 0 ()
 * Number of discrete variables: 154 (varSpeDX.i_x,$PRE.cooModCon.con1.enableFire,$PRE.cooModCon.con2.enableFire,$PRE.cooModCon.con3.enableFire,$PRE.cooModCon.con4.enableFire,swiTim.y,$PRE.swiTim.y,cooModCon.stateGraphRoot.resume,cooModCon.stateGraphRoot.suspend,speCon.conInt.y,ecoCon.conInt.y,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,$PRE.cooModCon.swi.y,$PRE.cooModCon.con4.t_start,$PRE.cooModCon.con3.t_start,$PRE.cooModCon.con2.t_start,$PRE.cooModCon.fulMecCoo.oldActive,$PRE.cooModCon.fulMecCoo.newActive,$PRE.cooModCon.fulMecCoo.localActive,$PRE.cooModCon.freCoo.oldActive,$PRE.cooModCon.freCoo.newActive,$PRE.cooModCon.freCoo.localActive,$PRE.cooModCon.parMecCoo.oldActive,$PRE.cooModCon.parMecCoo.newActive,$PRE.cooModCon.parMecCoo.localActive,$PRE.cooModCon.con1.t_start,$PRE.varSpeDX.deaBan.y,$PRE.varSpeDX.watVapEva.off,$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[4],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[3],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[4],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[3],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[4],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[3],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[4],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[3],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],cooModCon.swi.expr[3],cooModCon.swi.expr[2],cooModCon.swi.expr[1],speCon.not1.y,ecoCon.ecoOff.y,cooModCon.swi.firstActiveIndex,cooModCon.swi.y,cooModCon.stateGraphRoot.activeSteps,cooModCon.con4.t_start,cooModCon.con4.fire,cooModCon.con4.enableFire,cooModCon.con4.localCondition,cooModCon.con3.t_start,cooModCon.con3.fire,cooModCon.con3.enableFire,cooModCon.con3.localCondition,cooModCon.con2.t_start,cooModCon.con2.fire,cooModCon.con2.enableFire,cooModCon.con2.localCondition,cooModCon.fulMecCoo.active,cooModCon.fulMecCoo.oldActive,cooModCon.fulMecCoo.newActive,cooModCon.fulMecCoo.localActive,cooModCon.freCoo.active,cooModCon.freCoo.oldActive,cooModCon.freCoo.newActive,cooModCon.freCoo.localActive,cooModCon.parMecCoo.active,cooModCon.parMecCoo.oldActive,cooModCon.parMecCoo.newActive,cooModCon.parMecCoo.outPort[2].available,cooModCon.parMecCoo.inPort[2].occupied,cooModCon.parMecCoo.localActive,cooModCon.con1.t_start,cooModCon.con1.fire,cooModCon.con1.enableFire,cooModCon.con1.localCondition,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,varSpeDX.deaBan.y,varSpeDX.watVapEva.off,varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[4],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[3],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[4],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[3],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.dryCoi.coiCap.stage,varSpeDX.dxCoi.wetCoi.shr.on,varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[4],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[3],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[4],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[3],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.wetCoi.coiCap.stage,sigCha.y,sigCha.u,$PRE.sigCha.u,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25,$whenCondition26,$whenCondition27,$whenCondition28,swiTim.local_set,swiTim.local_reset,fanSpe.I.trigger_internal,ecoCon.con.I.trigger_internal,EIT.local_reset,EHVAC.local_reset,FMCHou.trigger_internal,PMCTim.trigger_internal,FCTim.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (609):
 * Single equations (assignments): 593
 * Array equations: 2
 * Algorithm blocks: 3
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 9
 * 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): 2 systems
   {7, 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): 9 systems
   {(1,1), (1,2), (1,12), (1,2), (1,2), (1,2), (1,2), (1,2), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.002863/4.084, allocations: 0.5826 MB / 2.114 GB, free: 194.3 MB / 1.561 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004268/4.089, allocations: 1.01 MB / 2.115 GB, free: 193.3 MB / 1.561 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05176/4.141, allocations: 14.23 MB / 2.129 GB, free: 179.1 MB / 1.561 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.738e-05/4.141, allocations: 48 kB / 2.129 GB, free: 179 MB / 1.561 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.36e-05/4.141, allocations: 7.984 kB / 2.129 GB, free: 179 MB / 1.561 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0467/4.187, allocations: 12.33 MB / 2.141 GB, free: 166.6 MB / 1.561 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06987/4.257, allocations: 25.18 MB / 2.166 GB, free: 141.5 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.858e-05/4.257, allocations: 8 kB / 2.166 GB, free: 141.5 MB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008543/4.266, allocations: 1.232 MB / 2.167 GB, free: 140.3 MB / 1.561 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002151/4.268, allocations: 0.645 MB / 2.167 GB, free: 139.6 MB / 1.561 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00105/4.269, allocations: 187.8 kB / 2.168 GB, free: 139.4 MB / 1.561 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005373/4.274, allocations: 5.922 MB / 2.173 GB, free: 133.2 MB / 1.561 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.866e-06/4.274, allocations: 4 kB / 2.173 GB, free: 133.2 MB / 1.561 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.06603/4.34, allocations: 21.01 MB / 2.194 GB, free: 112.1 MB / 1.561 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00779/4.348, allocations: 2.803 MB / 2.197 GB, free: 109.3 MB / 1.561 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003683/4.352, allocations: 227.9 kB / 2.197 GB, free: 109.1 MB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01193/4.364, allocations: 0.7334 MB / 2.198 GB, free: 108.4 MB / 1.561 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001315/4.365, allocations: 415.2 kB / 2.198 GB, free: 108 MB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001131/4.366, allocations: 259.8 kB / 2.198 GB, free: 107.7 MB / 1.561 GB
Notification: Performance of sorting global known variables: time 0.01711/4.383, allocations: 9.731 MB / 2.208 GB, free: 98.02 MB / 1.561 GB
Notification: Performance of sort global known variables: time 2.11e-07/4.383, allocations: 0 / 2.208 GB, free: 98.02 MB / 1.561 GB
Notification: Performance of remove unused functions: time 0.01867/4.402, allocations: 4.296 MB / 2.212 GB, free: 93.99 MB / 1.561 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 23 (EIT.y,FCTim.y,PMCTim.y,FMCHou.y,EHVAC.y,roo.rooVol.dynBal.medium.Xi[1],roo.rooVol.dynBal.U,roo.rooVol.dynBal.m,varSpeDX.vol.dynBal.medium.Xi[1],varSpeDX.vol.dynBal.U,varSpeDX.vol.dynBal.m,varSpeDX.watVapEva.m,fan.filter.s[1],fan.filter.s[2],senTemSupAir.T,dam1.filter.s[1],dam1.filter.s[2],dam2.filter.s[1],dam2.filter.s[2],senTemMixAir.T,ecoCon.con.I.y,fanSpe.I.y,speCon.dxSpe.I.y)
 * Number of discrete variables: 92 (sigCha.y,cooModCon.con3.enableFire,cooModCon.con4.enableFire,cooModCon.con2.enableFire,cooModCon.con1.enableFire,speCon.not1.y,cooModCon.parMecCoo.active,cooModCon.freCoo.active,cooModCon.fulMecCoo.active,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,sigCha.u,swiTim.y,varSpeDX.dxCoi.wetCoi.coiCap.stage,varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[3],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[4],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[3],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[4],varSpeDX.dxCoi.wetCoi.shr.on,varSpeDX.dxCoi.dryCoi.coiCap.stage,varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[3],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[4],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[3],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[4],varSpeDX.watVapEva.off,varSpeDX.deaBan.y,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,cooModCon.con1.localCondition,cooModCon.con1.fire,cooModCon.con1.t_start,cooModCon.parMecCoo.localActive,cooModCon.parMecCoo.inPort[2].occupied,cooModCon.parMecCoo.outPort[2].available,cooModCon.parMecCoo.newActive,cooModCon.parMecCoo.oldActive,cooModCon.freCoo.localActive,cooModCon.freCoo.newActive,cooModCon.freCoo.oldActive,cooModCon.fulMecCoo.localActive,cooModCon.fulMecCoo.newActive,cooModCon.fulMecCoo.oldActive,cooModCon.con2.localCondition,cooModCon.con2.fire,cooModCon.con2.t_start,cooModCon.con3.localCondition,cooModCon.con3.fire,cooModCon.con3.t_start,cooModCon.con4.localCondition,cooModCon.con4.fire,cooModCon.con4.t_start,cooModCon.stateGraphRoot.activeSteps,cooModCon.swi.y,cooModCon.swi.firstActiveIndex,ecoCon.ecoOff.y)
 * Number of discrete states: 19 (cooModCon.fulMecCoo.newActive,cooModCon.freCoo.newActive,cooModCon.parMecCoo.newActive,cooModCon.swi.y,weaDat.conTimMin.tNext,weaDat.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.locTim.tNext,varSpeDX.deaBan.y,varSpeDX.dxCoi.wetCoi.coiCap.stage,varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[varSpeDX.dxCoi.wetCoi.coiCap.stage],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[varSpeDX.dxCoi.wetCoi.coiCap.stage],varSpeDX.dxCoi.dryCoi.coiCap.stage,varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[varSpeDX.dxCoi.dryCoi.coiCap.stage],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[varSpeDX.dxCoi.dryCoi.coiCap.stage],varSpeDX.watVapEva.off,sigCha.u,swiTim.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (480):
 * Single equations (assignments): 445
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 29
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 5
 * 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
   {7}
 * 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): 5 systems
   {(1,1), (1,3), (1,11), (1,1), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.004481/4.406, allocations: 1.327 MB / 2.213 GB, free: 92.99 MB / 1.561 GB
Notification: Performance of simCode: created initialization part: time 0.05079/4.457, allocations: 22.94 MB / 2.236 GB, free: 69.73 MB / 1.561 GB
Notification: Performance of simCode: created event and clocks part: time 8.977e-06/4.457, allocations: 1 kB / 2.236 GB, free: 69.73 MB / 1.561 GB
Notification: Performance of simCode: created simulation system equations: time 0.01574/4.473, allocations: 6.126 MB / 2.242 GB, free: 63.59 MB / 1.561 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01824/4.491, allocations: 3.706 MB / 2.245 GB, free: 60 MB / 1.561 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06/4.551, allocations: 24.48 MB / 2.269 GB, free: 35.53 MB / 1.561 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00523/4.556, allocations: 5.534 MB / 2.275 GB, free: 29.96 MB / 1.561 GB
Notification: Performance of simCode: alias equations: time 0.01256/4.569, allocations: 3.605 MB / 2.278 GB, free: 26.34 MB / 1.561 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003753/4.573, allocations: 0.8242 MB / 2.279 GB, free: 25.52 MB / 1.561 GB
Notification: Performance of SimCode: time 9.22e-07/4.573, allocations: 0 / 2.279 GB, free: 25.52 MB / 1.561 GB
Notification: Performance of Templates: time 0.8489/5.422, allocations: 221.4 MB / 2.495 GB, free: 446 MB / 1.592 GB
"
[Timeout remaining time 295]
make -j1 -f Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.makefile [Timeout 300]
(rm -f Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe ; mkfifo Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe ; head -c 1048576 < Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe >> ../files/Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.sim & ./Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer  -abortSlowSimulation -alarm=400 -s ida -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 20.072894359007478]
Failed to read output from testmodel.py, exit status != 0:
5.431922118063085 5.441832147 4.055606522
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f40cfecafe0>