Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_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.001753/0.001753, allocations: 110.1 kB / 16.46 MB, free: 6.504 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.002032/0.002032, allocations: 196.5 kB / 19.41 MB, free: 3.668 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.501/1.501, allocations: 225.6 MB / 247.8 MB, free: 13.96 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.505/2.505, allocations: 443.5 MB / 0.7287 GB, free: 13.18 MB / 0.5919 GB
"
[Timeout remaining time 177]
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.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: "" <> buildModelFMU(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,fileNamePrefix="Buildings_10_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,fileNamePrefix="Buildings_10_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.001983/0.001983, allocations: 71.88 kB / 1.056 GB, free: 5.812 MB / 0.8575 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7197/0.7217, allocations: 160.7 MB / 1.213 GB, free: 3.895 MB / 0.92 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer): time 0.3905/1.112, allocations: 319.7 MB / 1.525 GB, free: 7.363 MB / 1.232 GB
Notification: Performance of NFInst.instExpressions: time 0.06941/1.182, allocations: 48.04 MB / 1.572 GB, free: 7.18 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007426/1.189, allocations: 179.1 kB / 1.572 GB, free: 7.004 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.01135/1.2, allocations: 4.029 MB / 1.576 GB, free: 2.949 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.02009/1.22, allocations: 7.586 MB / 1.584 GB, free: 11.33 MB / 1.295 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01967/1.24, allocations: 7.904 MB / 1.591 GB, free: 3.473 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.7881/2.028, allocations: 22.91 MB / 1.614 GB, free: 34.1 MB / 1.311 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01526/2.043, allocations: 6.829 MB / 1.62 GB, free: 33.61 MB / 1.311 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01514/2.059, allocations: 7.232 MB / 1.627 GB, free: 33.61 MB / 1.311 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01056/2.069, allocations: 6.605 MB / 1.634 GB, free: 33.3 MB / 1.311 GB
Notification: Performance of NFPackage.collectConstants: time 0.004519/2.074, allocations: 1.388 MB / 1.635 GB, free: 33.3 MB / 1.311 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01738/2.091, allocations: 8.805 MB / 1.644 GB, free: 33.3 MB / 1.311 GB
Notification: Performance of NFScalarize.scalarize: time 0.00646/2.097, allocations: 4.312 MB / 1.648 GB, free: 32.82 MB / 1.311 GB
Notification: Performance of NFVerifyModel.verify: time 0.01159/2.109, allocations: 6.746 MB / 1.655 GB, free: 31.07 MB / 1.311 GB
Notification: Performance of NFConvertDAE.convert: time 0.03253/2.142, allocations: 25.35 MB / 1.679 GB, free: 28.62 MB / 1.311 GB
Notification: Performance of FrontEnd - DAE generated: time 4.669e-06/2.142, allocations: 0.9062 kB / 1.679 GB, free: 28.62 MB / 1.311 GB
Notification: Performance of FrontEnd: time 1.413e-06/2.142, allocations: 0 / 1.679 GB, free: 28.62 MB / 1.311 GB
Notification: Performance of Transformations before backend: time 0.0005522/2.142, allocations: 3.625 kB / 1.679 GB, free: 28.62 MB / 1.311 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.04195/2.184, allocations: 14.25 MB / 1.693 GB, free: 22.41 MB / 1.311 GB
Notification: Performance of prepare preOptimizeDAE: time 4.005e-05/2.184, allocations: 9.906 kB / 1.693 GB, free: 22.41 MB / 1.311 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001865/2.186, allocations: 0.661 MB / 1.694 GB, free: 22.34 MB / 1.311 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04126/2.227, allocations: 5.02 MB / 1.699 GB, free: 21.66 MB / 1.311 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02918/2.256, allocations: 14.06 MB / 1.713 GB, free: 19.16 MB / 1.311 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008489/2.257, allocations: 0.6858 MB / 1.713 GB, free: 18.91 MB / 1.311 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001825/2.259, allocations: 0.539 MB / 1.714 GB, free: 18.9 MB / 1.311 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02475/2.284, allocations: 10.83 MB / 1.724 GB, free: 16.23 MB / 1.311 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001211/2.284, allocations: 5.719 kB / 1.724 GB, free: 16.23 MB / 1.311 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001166/2.285, allocations: 217.5 kB / 1.725 GB, free: 16.23 MB / 1.311 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000136/2.285, allocations: 187.8 kB / 1.725 GB, free: 16.21 MB / 1.311 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03026/2.316, allocations: 12.99 MB / 1.737 GB, free: 13.83 MB / 1.311 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.08182/2.397, allocations: 41.48 MB / 1.778 GB, free: 2.637 MB / 1.326 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.027/2.424, allocations: 9.046 MB / 1.787 GB, free: 9.582 MB / 1.342 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01542/2.44, allocations: 5.571 MB / 1.792 GB, free: 4.004 MB / 1.342 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002002/2.442, allocations: 1.321 MB / 1.793 GB, free: 2.457 MB / 1.342 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02013/2.462, allocations: 7.555 MB / 1.801 GB, free: 10.88 MB / 1.357 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006818/2.469, allocations: 0.6503 MB / 1.801 GB, free: 10.23 MB / 1.357 GB
Notification: Performance of pre-optimization done (n=470): time 1.486e-05/2.469, allocations: 3.938 kB / 1.802 GB, free: 10.23 MB / 1.357 GB
Notification: Performance of matching and sorting (n=470): time 0.08394/2.553, allocations: 19.71 MB / 1.821 GB, free: 6.453 MB / 1.373 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002681/2.553, allocations: 311 kB / 1.821 GB, free: 6.094 MB / 1.373 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03602/2.589, allocations: 14.19 MB / 1.835 GB, free: 7.957 MB / 1.389 GB
Notification: Performance of collectPreVariables (initialization): time 0.001949/2.591, allocations: 193.7 kB / 1.835 GB, free: 7.762 MB / 1.389 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006858/2.598, allocations: 4.554 MB / 1.84 GB, free: 3.211 MB / 1.389 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002765/2.601, allocations: 1.579 MB / 1.841 GB, free: 1.66 MB / 1.389 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003303/2.604, allocations: 1.316 MB / 1.842 GB, free: 340 kB / 1.389 GB
Notification: Performance of setup shared object (initialization): time 0.0001249/2.604, allocations: 309.1 kB / 1.843 GB, free: 28 kB / 1.389 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01675/2.621, allocations: 6.892 MB / 1.849 GB, free: 9.117 MB / 1.404 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01858/2.639, allocations: 7.839 MB / 1.857 GB, free: 0.875 MB / 1.404 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.5068/3.146, allocations: 162.1 MB / 2.015 GB, free: 14.29 MB / 1.576 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.81e-05/3.146, allocations: 4 kB / 2.015 GB, free: 14.29 MB / 1.576 GB
Notification: Performance of matching and sorting (n=716) (initialization): time 0.06764/3.214, allocations: 17.23 MB / 2.032 GB, free: 13.09 MB / 1.592 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002124/3.214, allocations: 137.1 kB / 2.032 GB, free: 12.94 MB / 1.592 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.096e-05/3.214, allocations: 16 kB / 2.032 GB, free: 12.93 MB / 1.592 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008421/3.222, allocations: 1.769 MB / 2.034 GB, free: 11.14 MB / 1.592 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01097/3.233, allocations: 1.532 MB / 2.036 GB, free: 9.668 MB / 1.592 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02241/3.256, allocations: 16.96 MB / 2.052 GB, free: 7.707 MB / 1.607 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01434/3.27, allocations: 0.8041 MB / 2.053 GB, free: 6.898 MB / 1.607 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001994/3.272, allocations: 331.7 kB / 2.053 GB, free: 6.574 MB / 1.607 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.02467/3.297, allocations: 9.789 MB / 2.063 GB, free: 12.77 MB / 1.623 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01983/3.317, allocations: 7.727 MB / 2.07 GB, free: 4.633 MB / 1.623 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.5039/3.821, allocations: 161.6 MB / 2.228 GB, free: 2.543 MB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.399e-05/3.821, allocations: 4 kB / 2.228 GB, free: 2.539 MB / 1.779 GB
Notification: Performance of matching and sorting (n=716) (initialization_lambda0): time 0.06512/3.886, allocations: 16.78 MB / 2.244 GB, free: 1.758 MB / 1.795 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002075/3.886, allocations: 137.1 kB / 2.245 GB, free: 1.605 MB / 1.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.795e-05/3.886, allocations: 16 kB / 2.245 GB, free: 1.59 MB / 1.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006411/3.892, allocations: 1.518 MB / 2.246 GB, free: 48 kB / 1.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.6032/4.496, allocations: 1.545 MB / 2.248 GB, free: 0.8059 GB / 1.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01477/4.51, allocations: 16.27 MB / 2.263 GB, free: 0.794 GB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01464/4.525, allocations: 0.8822 MB / 2.264 GB, free: 0.794 GB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001956/4.527, allocations: 327.1 kB / 2.265 GB, free: 0.794 GB / 1.795 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: 152 (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,$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 (635):
 * Single equations (assignments): 618
 * 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.002166/4.529, allocations: 0.5742 MB / 2.265 GB, free: 0.7937 GB / 1.795 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003743/4.533, allocations: 1.024 MB / 2.266 GB, free: 0.7937 GB / 1.795 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05175/4.585, allocations: 14.29 MB / 2.28 GB, free: 0.7916 GB / 1.795 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.64e-05/4.585, allocations: 52.5 kB / 2.28 GB, free: 0.7916 GB / 1.795 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.169e-05/4.585, allocations: 1.562 kB / 2.28 GB, free: 0.7916 GB / 1.795 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04575/4.63, allocations: 12.38 MB / 2.292 GB, free: 0.7877 GB / 1.795 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1051/4.736, allocations: 28.39 MB / 2.32 GB, free: 0.7767 GB / 1.795 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.386e-05/4.736, allocations: 3.281 kB / 2.32 GB, free: 0.7767 GB / 1.795 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01167/4.747, allocations: 1.235 MB / 2.321 GB, free: 0.7766 GB / 1.795 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003037/4.75, allocations: 0.6584 MB / 2.322 GB, free: 0.7764 GB / 1.795 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001585/4.752, allocations: 190.8 kB / 2.322 GB, free: 0.7763 GB / 1.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007469/4.759, allocations: 6.194 MB / 2.328 GB, free: 0.771 GB / 1.795 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.275e-06/4.759, allocations: 0 / 2.328 GB, free: 0.771 GB / 1.795 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.07535/4.835, allocations: 21.19 MB / 2.349 GB, free: 0.7531 GB / 1.795 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009787/4.845, allocations: 2.875 MB / 2.352 GB, free: 0.7503 GB / 1.795 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005508/4.85, allocations: 219.9 kB / 2.352 GB, free: 0.7501 GB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01259/4.863, allocations: 0.7346 MB / 2.353 GB, free: 0.7494 GB / 1.795 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001555/4.864, allocations: 407.4 kB / 2.353 GB, free: 0.749 GB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001588/4.866, allocations: 251.8 kB / 2.353 GB, free: 0.7488 GB / 1.795 GB
Notification: Performance of sorting global known variables: time 0.02034/4.886, allocations: 9.9 MB / 2.363 GB, free: 0.7392 GB / 1.795 GB
Notification: Performance of sort global known variables: time 4.71e-07/4.886, allocations: 0 / 2.363 GB, free: 0.7392 GB / 1.795 GB
Notification: Performance of remove unused functions: time 0.0195/4.906, allocations: 4.363 MB / 2.367 GB, free: 0.7351 GB / 1.795 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.05189/4.958, allocations: 21.75 MB / 2.388 GB, free: 0.7143 GB / 1.795 GB
Notification: Performance of simCode: created initialization part: time 0.05285/5.01, allocations: 23.38 MB / 2.411 GB, free: 0.6912 GB / 1.795 GB
Notification: Performance of simCode: created event and clocks part: time 9.237e-06/5.01, allocations: 8.938 kB / 2.411 GB, free: 0.6912 GB / 1.795 GB
Notification: Performance of simCode: created simulation system equations: time 0.0155/5.026, allocations: 6.178 MB / 2.417 GB, free: 0.6851 GB / 1.795 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02118/5.047, allocations: 3.675 MB / 2.421 GB, free: 0.6816 GB / 1.795 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2947/5.342, allocations: 137.7 MB / 2.555 GB, free: 0.5462 GB / 1.795 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005927/5.348, allocations: 5.986 MB / 2.561 GB, free: 0.5404 GB / 1.795 GB
Notification: Performance of simCode: alias equations: time 0.01675/5.364, allocations: 3.633 MB / 2.565 GB, free: 0.5368 GB / 1.795 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01109/5.376, allocations: 4.678 MB / 2.569 GB, free: 0.5322 GB / 1.795 GB
Notification: Performance of SimCode: time 1.734e-06/5.376, allocations: 0 / 2.569 GB, free: 0.5322 GB / 1.795 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4066/5.782, allocations: 310 MB / 2.872 GB, free: 236.6 MB / 1.795 GB
Notification: Performance of buildModelFMU: Generate platform static: time 43.03/48.82, allocations: 15.81 kB / 2.872 GB, free: 236.5 MB / 1.795 GB
"
[Timeout remaining time 251]
(rm -f Buildings_10_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe ; mkfifo Buildings_10_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe ; head -c 1048576 < Buildings_10_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe >> ../files/Buildings_10_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_10_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer_res.mat --tempDir=temp_Buildings_10_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer_fmu --startTime=1.188e+07 --stopTime=1.26e+07 --stepSize=288 --timeout=400 --tolerance=1e-06 Buildings_10_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer.fmu > Buildings_10_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 55.54155291104689]
Failed to read output from testmodel.py, exit status != 0:
49.218068953603506 49.230966535 47.086294505
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fb7801de020>