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.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001674/0.001674, allocations: 114.5 kB / 18.88 MB, free: 3.062 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001848/0.001848, allocations: 195.5 kB / 22.17 MB, free: 5.656 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.455/1.455, allocations: 225.6 MB / 250.9 MB, free: 13.29 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.742/2.742, allocations: 476.7 MB / 0.7645 GB, free: 10.12 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.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: Performance of FrontEnd - loaded program: time 0.002264/0.002264, allocations: 66.67 kB / 1.109 GB, free: 12.16 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3258/0.3281, allocations: 168.7 MB / 1.274 GB, free: 11.26 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer): time 0.9644/1.292, allocations: 320.9 MB / 1.587 GB, free: 21.62 MB / 1.264 GB
Notification: Performance of NFInst.instExpressions: time 0.04749/1.34, allocations: 48.34 MB / 1.635 GB, free: 21.17 MB / 1.264 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006554/1.347, allocations: 183.7 kB / 1.635 GB, free: 21.17 MB / 1.264 GB
Notification: Performance of NFTyping.typeComponents: time 0.009255/1.356, allocations: 4.024 MB / 1.639 GB, free: 21.09 MB / 1.264 GB
Notification: Performance of NFTyping.typeBindings: time 0.01659/1.372, allocations: 7.592 MB / 1.646 GB, free: 20.8 MB / 1.264 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01509/1.387, allocations: 7.983 MB / 1.654 GB, free: 20.49 MB / 1.264 GB
Notification: Performance of NFFlatten.flatten: time 0.02197/1.409, allocations: 23.01 MB / 1.676 GB, free: 18.99 MB / 1.264 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008613/1.418, allocations: 6.507 MB / 1.683 GB, free: 16.05 MB / 1.264 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01203/1.43, allocations: 7.232 MB / 1.69 GB, free: 13.32 MB / 1.264 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.009409/1.439, allocations: 6.619 MB / 1.696 GB, free: 10.52 MB / 1.264 GB
Notification: Performance of NFPackage.collectConstants: time 0.003371/1.443, allocations: 1.389 MB / 1.698 GB, free: 10.52 MB / 1.264 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01552/1.458, allocations: 8.802 MB / 1.706 GB, free: 8.32 MB / 1.264 GB
Notification: Performance of NFScalarize.scalarize: time 0.004556/1.463, allocations: 4.324 MB / 1.71 GB, free: 5.23 MB / 1.264 GB
Notification: Performance of NFVerifyModel.verify: time 0.009285/1.472, allocations: 6.721 MB / 1.717 GB, free: 268 kB / 1.264 GB
Notification: Performance of NFConvertDAE.convert: time 0.03386/1.506, allocations: 25.31 MB / 1.742 GB, free: 13.47 MB / 1.295 GB
Notification: Performance of FrontEnd - DAE generated: time 3.757e-06/1.506, allocations: 0 / 1.742 GB, free: 13.47 MB / 1.295 GB
Notification: Performance of FrontEnd: time 1.222e-06/1.506, allocations: 0 / 1.742 GB, free: 13.47 MB / 1.295 GB
Notification: Performance of Transformations before backend: time 0.0004676/1.507, allocations: 0 / 1.742 GB, free: 13.47 MB / 1.295 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.03461/1.541, allocations: 15.13 MB / 1.757 GB, free: 14.23 MB / 1.311 GB
Notification: Performance of prepare preOptimizeDAE: time 3.508e-05/1.541, allocations: 8.031 kB / 1.757 GB, free: 14.22 MB / 1.311 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03971/1.581, allocations: 5.012 MB / 1.761 GB, free: 9.207 MB / 1.311 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02323/1.604, allocations: 11.38 MB / 1.773 GB, free: 14.1 MB / 1.326 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000748/1.605, allocations: 0.6834 MB / 1.773 GB, free: 13.38 MB / 1.326 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001257/1.606, allocations: 0.5351 MB / 1.774 GB, free: 12.84 MB / 1.326 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02217/1.628, allocations: 10.83 MB / 1.784 GB, free: 1.852 MB / 1.326 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.283e-05/1.628, allocations: 5.969 kB / 1.784 GB, free: 1.848 MB / 1.326 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007484/1.629, allocations: 210.7 kB / 1.785 GB, free: 1.645 MB / 1.326 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001524/1.629, allocations: 185.4 kB / 1.785 GB, free: 1.461 MB / 1.326 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03015/1.659, allocations: 13 MB / 1.797 GB, free: 4.473 MB / 1.342 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.07999/1.739, allocations: 41.47 MB / 1.838 GB, free: 10.52 MB / 1.389 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02578/1.765, allocations: 9.043 MB / 1.847 GB, free: 1.43 MB / 1.389 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0156/1.781, allocations: 5.571 MB / 1.852 GB, free: 11.85 MB / 1.404 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001808/1.783, allocations: 1.314 MB / 1.853 GB, free: 10.31 MB / 1.404 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01965/1.802, allocations: 7.568 MB / 1.861 GB, free: 2.719 MB / 1.404 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007591/1.81, allocations: 0.649 MB / 1.861 GB, free: 2.074 MB / 1.404 GB
Notification: Performance of pre-optimization done (n=470): time 1.798e-05/1.81, allocations: 0 / 1.861 GB, free: 2.074 MB / 1.404 GB
Notification: Performance of matching and sorting (n=470): time 0.07971/1.89, allocations: 19.7 MB / 1.881 GB, free: 14.28 MB / 1.436 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002417/1.89, allocations: 314.9 kB / 1.881 GB, free: 13.91 MB / 1.436 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03113/1.921, allocations: 14.17 MB / 1.895 GB, free: 15.79 MB / 1.451 GB
Notification: Performance of collectPreVariables (initialization): time 0.001845/1.923, allocations: 189.7 kB / 1.895 GB, free: 15.6 MB / 1.451 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007468/1.93, allocations: 4.543 MB / 1.899 GB, free: 11.06 MB / 1.451 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003436/1.934, allocations: 1.568 MB / 1.901 GB, free: 9.52 MB / 1.451 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004969/1.939, allocations: 1.346 MB / 1.902 GB, free: 8.168 MB / 1.451 GB
Notification: Performance of setup shared object (initialization): time 0.0001598/1.939, allocations: 301.1 kB / 1.903 GB, free: 7.871 MB / 1.451 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01727/1.956, allocations: 6.916 MB / 1.909 GB, free: 0.9375 MB / 1.451 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01835/1.974, allocations: 7.86 MB / 1.917 GB, free: 8.684 MB / 1.467 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.49/2.464, allocations: 162.1 MB / 2.075 GB, free: 6.012 MB / 1.623 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.894e-05/2.465, allocations: 4 kB / 2.075 GB, free: 6.008 MB / 1.623 GB
Notification: Performance of matching and sorting (n=724) (initialization): time 0.06211/2.527, allocations: 17.27 MB / 2.092 GB, free: 4.742 MB / 1.639 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002115/2.527, allocations: 141.1 kB / 2.092 GB, free: 4.586 MB / 1.639 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.869e-05/2.527, allocations: 16 kB / 2.092 GB, free: 4.57 MB / 1.639 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007691/2.535, allocations: 1.77 MB / 2.094 GB, free: 2.773 MB / 1.639 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01003/2.545, allocations: 1.548 MB / 2.096 GB, free: 1.289 MB / 1.639 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02256/2.567, allocations: 16.94 MB / 2.112 GB, free: 15.34 MB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01338/2.581, allocations: 0.8156 MB / 2.113 GB, free: 14.52 MB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001971/2.583, allocations: 339.6 kB / 2.113 GB, free: 14.19 MB / 1.67 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.02978/2.612, allocations: 9.811 MB / 2.123 GB, free: 4.363 MB / 1.67 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02355/2.636, allocations: 7.726 MB / 2.13 GB, free: 12.23 MB / 1.686 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.131/3.767, allocations: 161.6 MB / 2.288 GB, free: 0.6786 GB / 1.748 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.571e-05/3.767, allocations: 4 kB / 2.288 GB, free: 0.6786 GB / 1.748 GB
Notification: Performance of matching and sorting (n=724) (initialization_lambda0): time 0.0532/3.82, allocations: 16.83 MB / 2.305 GB, free: 0.664 GB / 1.748 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001357/3.82, allocations: 137.1 kB / 2.305 GB, free: 0.6638 GB / 1.748 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.288e-05/3.82, allocations: 23.62 kB / 2.305 GB, free: 0.6638 GB / 1.748 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005227/3.825, allocations: 1.517 MB / 2.306 GB, free: 0.6624 GB / 1.748 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009316/3.835, allocations: 1.558 MB / 2.308 GB, free: 0.6609 GB / 1.748 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0126/3.847, allocations: 16.28 MB / 2.324 GB, free: 0.644 GB / 1.748 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01335/3.861, allocations: 0.8753 MB / 2.325 GB, free: 0.6432 GB / 1.748 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0016/3.862, allocations: 327.7 kB / 2.325 GB, free: 0.6429 GB / 1.748 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 (643):
 * Single equations (assignments): 626
 * Array equations: 2
 * Algorithm blocks: 3
 * Record equations: 1
 * 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.002209/3.865, allocations: 0.5806 MB / 2.325 GB, free: 0.6424 GB / 1.748 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003743/3.868, allocations: 1.024 MB / 2.326 GB, free: 0.6419 GB / 1.748 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05056/3.919, allocations: 14.29 MB / 2.34 GB, free: 0.6282 GB / 1.748 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.397e-05/3.919, allocations: 48 kB / 2.34 GB, free: 0.6281 GB / 1.748 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.435e-05/3.919, allocations: 0 / 2.34 GB, free: 0.6281 GB / 1.748 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04622/3.965, allocations: 12.38 MB / 2.353 GB, free: 0.616 GB / 1.748 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0782/4.043, allocations: 28.39 MB / 2.38 GB, free: 0.5884 GB / 1.748 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.078e-05/4.043, allocations: 0 / 2.38 GB, free: 0.5884 GB / 1.748 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008755/4.052, allocations: 1.236 MB / 2.381 GB, free: 0.5872 GB / 1.748 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002211/4.054, allocations: 0.651 MB / 2.382 GB, free: 0.5865 GB / 1.748 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001359/4.056, allocations: 191.8 kB / 2.382 GB, free: 0.5863 GB / 1.748 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005526/4.061, allocations: 6.19 MB / 2.388 GB, free: 0.58 GB / 1.748 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.923e-06/4.061, allocations: 3.938 kB / 2.388 GB, free: 0.58 GB / 1.748 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.06507/4.126, allocations: 21.18 MB / 2.409 GB, free: 0.5592 GB / 1.748 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01025/4.137, allocations: 2.867 MB / 2.412 GB, free: 0.5563 GB / 1.748 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005122/4.142, allocations: 223.9 kB / 2.412 GB, free: 0.5561 GB / 1.748 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01305/4.155, allocations: 0.7463 MB / 2.413 GB, free: 0.5554 GB / 1.748 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001543/4.156, allocations: 399.5 kB / 2.413 GB, free: 0.555 GB / 1.748 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001088/4.157, allocations: 255.8 kB / 2.413 GB, free: 0.5548 GB / 1.748 GB
Notification: Performance of sorting global known variables: time 0.01955/4.177, allocations: 9.884 MB / 2.423 GB, free: 0.5452 GB / 1.748 GB
Notification: Performance of sort global known variables: time 4.31e-07/4.177, allocations: 4 kB / 2.423 GB, free: 0.5452 GB / 1.748 GB
Notification: Performance of remove unused functions: time 0.02355/4.201, allocations: 4.375 MB / 2.427 GB, free: 0.5411 GB / 1.748 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: 98 (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,$cse43,$cse44,$cse45,$cse46,$cse47,$cse48,$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 (486):
 * Single equations (assignments): 451
 * 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.005817/4.206, allocations: 1.459 MB / 2.429 GB, free: 0.5401 GB / 1.748 GB
Notification: Performance of simCode: created initialization part: time 0.05458/4.261, allocations: 23.45 MB / 2.452 GB, free: 0.5169 GB / 1.748 GB
Notification: Performance of simCode: created event and clocks part: time 1.355e-05/4.261, allocations: 6.812 kB / 2.452 GB, free: 0.5169 GB / 1.748 GB
Notification: Performance of simCode: created simulation system equations: time 0.01689/4.278, allocations: 6.172 MB / 2.458 GB, free: 0.5108 GB / 1.748 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02419/4.302, allocations: 3.661 MB / 2.461 GB, free: 0.5073 GB / 1.748 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06513/4.367, allocations: 24.56 MB / 2.485 GB, free: 495 MB / 1.748 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01091/4.378, allocations: 5.98 MB / 2.491 GB, free: 488.9 MB / 1.748 GB
Notification: Performance of simCode: alias equations: time 0.01703/4.395, allocations: 3.625 MB / 2.495 GB, free: 485.3 MB / 1.748 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005474/4.401, allocations: 0.8154 MB / 2.495 GB, free: 484.5 MB / 1.748 GB
Notification: Performance of SimCode: time 9.72e-07/4.401, allocations: 0 / 2.495 GB, free: 484.5 MB / 1.748 GB
Notification: Performance of Templates: time 0.3405/4.741, allocations: 218.9 MB / 2.709 GB, free: 267.1 MB / 1.748 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 cvode -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 21.075325927697122]
Failed to read output from testmodel.py, exit status != 0:
4.866960848215967 4.760304678 3.251864136
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3de6c82050>