Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_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.001594/0.001594, allocations: 99.75 kB / 18.95 MB, free: 2.832 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.001937/0.001937, allocations: 218.2 kB / 22.25 MB, free: 5.102 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.454/1.454, allocations: 230.6 MB / 256 MB, free: 7.789 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 3.22/3.22, allocations: 0.49 GB / 0.7951 GB, free: 35.54 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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: "" <> buildModelFMU(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,fileNamePrefix="Buildings_12_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,fileNamePrefix="Buildings_12_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer",fmuType="me",version="2.0",platforms={"static"}) [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.002064/0.002064, allocations: 70.2 kB / 1.154 GB, free: 25.42 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.39/0.3921, allocations: 176.1 MB / 1.326 GB, free: 1.523 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer): time 0.3609/0.753, allocations: 283 MB / 1.602 GB, free: 5.5 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 0.9348/1.688, allocations: 44.55 MB / 1.646 GB, free: 18.82 MB / 1.295 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00911/1.697, allocations: 246.4 kB / 1.646 GB, free: 18.82 MB / 1.295 GB
Notification: Performance of NFTyping.typeComponents: time 0.01208/1.709, allocations: 3.863 MB / 1.65 GB, free: 18.73 MB / 1.295 GB
Notification: Performance of NFTyping.typeBindings: time 0.02584/1.735, allocations: 7.624 MB / 1.657 GB, free: 18.52 MB / 1.295 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02408/1.759, allocations: 7.967 MB / 1.665 GB, free: 18.31 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.02829/1.787, allocations: 23.16 MB / 1.688 GB, free: 18.21 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01471/1.802, allocations: 6.998 MB / 1.694 GB, free: 17.63 MB / 1.295 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01819/1.82, allocations: 7.578 MB / 1.702 GB, free: 17.07 MB / 1.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01269/1.833, allocations: 6.53 MB / 1.708 GB, free: 14.28 MB / 1.295 GB
Notification: Performance of NFPackage.collectConstants: time 0.005314/1.838, allocations: 1.37 MB / 1.71 GB, free: 14.28 MB / 1.295 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02048/1.859, allocations: 7.471 MB / 1.717 GB, free: 13.07 MB / 1.295 GB
Notification: Performance of NFScalarize.scalarize: time 0.007603/1.866, allocations: 4.284 MB / 1.721 GB, free: 10.88 MB / 1.295 GB
Notification: Performance of NFVerifyModel.verify: time 0.01338/1.88, allocations: 5.211 MB / 1.726 GB, free: 7.879 MB / 1.295 GB
Notification: Performance of NFConvertDAE.convert: time 0.04336/1.923, allocations: 25.13 MB / 1.751 GB, free: 8.258 MB / 1.311 GB
Notification: Performance of FrontEnd - DAE generated: time 7.284e-06/1.923, allocations: 0 / 1.751 GB, free: 8.258 MB / 1.311 GB
Notification: Performance of FrontEnd: time 2.435e-06/1.923, allocations: 0 / 1.751 GB, free: 8.258 MB / 1.311 GB
Notification: Performance of Transformations before backend: time 0.0007166/1.924, allocations: 2.719 kB / 1.751 GB, free: 8.258 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: 1242
 * Number of variables: 1242
Notification: Performance of Generate backend data structure: time 0.04488/1.969, allocations: 15.01 MB / 1.765 GB, free: 13.78 MB / 1.326 GB
Notification: Performance of prepare preOptimizeDAE: time 5.523e-05/1.969, allocations: 10.62 kB / 1.765 GB, free: 13.78 MB / 1.326 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00211/1.971, allocations: 0.6586 MB / 1.766 GB, free: 13.28 MB / 1.326 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04308/2.014, allocations: 5.333 MB / 1.771 GB, free: 10.83 MB / 1.326 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03378/2.048, allocations: 13.86 MB / 1.785 GB, free: 2.062 MB / 1.326 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001309/2.049, allocations: 0.8273 MB / 1.786 GB, free: 1.168 MB / 1.326 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002253/2.051, allocations: 0.5398 MB / 1.786 GB, free: 0.6328 MB / 1.326 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02944/2.081, allocations: 11.51 MB / 1.797 GB, free: 4.793 MB / 1.342 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001474/2.081, allocations: 6.625 kB / 1.797 GB, free: 4.789 MB / 1.342 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001938/2.083, allocations: 210.4 kB / 1.797 GB, free: 4.586 MB / 1.342 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002077/2.083, allocations: 177.4 kB / 1.798 GB, free: 4.41 MB / 1.342 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03667/2.12, allocations: 12.88 MB / 1.81 GB, free: 7.539 MB / 1.357 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.08846/2.208, allocations: 34.7 MB / 1.844 GB, free: 5.129 MB / 1.389 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02599/2.234, allocations: 8.886 MB / 1.853 GB, free: 12.26 MB / 1.404 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01498/2.249, allocations: 5.57 MB / 1.858 GB, free: 6.684 MB / 1.404 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001295/2.25, allocations: 241 kB / 1.858 GB, free: 6.449 MB / 1.404 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01949/2.27, allocations: 8.001 MB / 1.866 GB, free: 14.31 MB / 1.42 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007066/2.277, allocations: 0.6512 MB / 1.867 GB, free: 13.67 MB / 1.42 GB
Notification: Performance of pre-optimization done (n=464): time 2.731e-05/2.277, allocations: 0 / 1.867 GB, free: 13.67 MB / 1.42 GB
Notification: Performance of matching and sorting (n=464): time 0.075/2.352, allocations: 19.37 MB / 1.886 GB, free: 10.3 MB / 1.436 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.00024/2.352, allocations: 306.1 kB / 1.886 GB, free: 9.945 MB / 1.436 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03052/2.383, allocations: 14.15 MB / 1.9 GB, free: 11.84 MB / 1.451 GB
Notification: Performance of collectPreVariables (initialization): time 0.002069/2.385, allocations: 185.7 kB / 1.9 GB, free: 11.65 MB / 1.451 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006837/2.391, allocations: 4.525 MB / 1.905 GB, free: 7.133 MB / 1.451 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003081/2.395, allocations: 1.551 MB / 1.906 GB, free: 5.609 MB / 1.451 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003301/2.398, allocations: 1.3 MB / 1.907 GB, free: 4.297 MB / 1.451 GB
Notification: Performance of setup shared object (initialization): time 0.0001278/2.398, allocations: 301.1 kB / 1.908 GB, free: 4 MB / 1.451 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01628/2.414, allocations: 7.024 MB / 1.914 GB, free: 12.95 MB / 1.467 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0195/2.434, allocations: 9.418 MB / 1.924 GB, free: 2.75 MB / 1.467 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.4806/2.914, allocations: 162 MB / 2.082 GB, free: 200 kB / 1.623 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.438e-05/2.914, allocations: 8 kB / 2.082 GB, free: 192 kB / 1.623 GB
Notification: Performance of matching and sorting (n=707) (initialization): time 0.06181/2.976, allocations: 17.38 MB / 2.099 GB, free: 14.79 MB / 1.654 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002112/2.976, allocations: 137.1 kB / 2.099 GB, free: 14.64 MB / 1.654 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.416e-05/2.977, allocations: 20 kB / 2.099 GB, free: 14.62 MB / 1.654 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007747/2.984, allocations: 1.77 MB / 2.101 GB, free: 12.83 MB / 1.654 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01036/2.995, allocations: 1.501 MB / 2.102 GB, free: 11.39 MB / 1.654 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02141/3.016, allocations: 16.05 MB / 2.118 GB, free: 10.5 MB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0131/3.029, allocations: 0.8126 MB / 2.119 GB, free: 9.691 MB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001775/3.031, allocations: 331.7 kB / 2.119 GB, free: 9.367 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.02431/3.055, allocations: 9.892 MB / 2.129 GB, free: 15.45 MB / 1.686 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02034/3.076, allocations: 9.299 MB / 2.138 GB, free: 5.371 MB / 1.686 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.188/4.263, allocations: 161.5 MB / 2.295 GB, free: 0.7498 GB / 1.826 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.039e-05/4.263, allocations: 7.219 kB / 2.295 GB, free: 0.7498 GB / 1.826 GB
Notification: Performance of matching and sorting (n=707) (initialization_lambda0): time 0.06136/4.325, allocations: 16.93 MB / 2.312 GB, free: 0.746 GB / 1.826 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001845/4.325, allocations: 146 kB / 2.312 GB, free: 0.7459 GB / 1.826 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.297e-05/4.325, allocations: 18.72 kB / 2.312 GB, free: 0.7459 GB / 1.826 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005641/4.33, allocations: 1.508 MB / 2.314 GB, free: 0.7456 GB / 1.826 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009328/4.34, allocations: 1.52 MB / 2.315 GB, free: 0.7455 GB / 1.826 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01354/4.353, allocations: 15.23 MB / 2.33 GB, free: 0.7327 GB / 1.826 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01412/4.367, allocations: 0.8813 MB / 2.331 GB, free: 0.7326 GB / 1.826 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001786/4.369, allocations: 318.7 kB / 2.331 GB, free: 0.7325 GB / 1.826 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 (626):
 * Single equations (assignments): 609
 * 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.002291/4.371, allocations: 0.5866 MB / 2.332 GB, free: 0.7321 GB / 1.826 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003843/4.375, allocations: 1.013 MB / 2.333 GB, free: 0.7321 GB / 1.826 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05134/4.427, allocations: 14.27 MB / 2.347 GB, free: 0.7277 GB / 1.826 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.476e-05/4.427, allocations: 48.25 kB / 2.347 GB, free: 0.7277 GB / 1.826 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.649e-05/4.427, allocations: 3.938 kB / 2.347 GB, free: 0.7277 GB / 1.826 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0462/4.473, allocations: 12.4 MB / 2.359 GB, free: 0.7236 GB / 1.826 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0713/4.544, allocations: 25.84 MB / 2.384 GB, free: 0.7002 GB / 1.826 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.891e-05/4.544, allocations: 0 / 2.384 GB, free: 0.7002 GB / 1.826 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008083/4.552, allocations: 1.238 MB / 2.385 GB, free: 0.699 GB / 1.826 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002027/4.554, allocations: 0.6551 MB / 2.386 GB, free: 0.6984 GB / 1.826 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001053/4.555, allocations: 191.6 kB / 2.386 GB, free: 0.6982 GB / 1.826 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005088/4.56, allocations: 5.938 MB / 2.392 GB, free: 0.6921 GB / 1.826 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.833e-06/4.56, allocations: 0 / 2.392 GB, free: 0.6921 GB / 1.826 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.06128/4.622, allocations: 21.17 MB / 2.413 GB, free: 0.6716 GB / 1.826 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01024/4.632, allocations: 2.838 MB / 2.415 GB, free: 0.6689 GB / 1.826 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004814/4.637, allocations: 219.8 kB / 2.416 GB, free: 0.6687 GB / 1.826 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01237/4.649, allocations: 0.744 MB / 2.416 GB, free: 0.668 GB / 1.826 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001507/4.651, allocations: 423.1 kB / 2.417 GB, free: 0.6676 GB / 1.826 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001122/4.652, allocations: 247.8 kB / 2.417 GB, free: 0.6673 GB / 1.826 GB
Notification: Performance of sorting global known variables: time 0.01804/4.67, allocations: 9.851 MB / 2.426 GB, free: 0.6578 GB / 1.826 GB
Notification: Performance of sort global known variables: time 1.8e-07/4.67, allocations: 0 / 2.426 GB, free: 0.6578 GB / 1.826 GB
Notification: Performance of remove unused functions: time 0.01896/4.689, allocations: 4.321 MB / 2.431 GB, free: 0.6538 GB / 1.826 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 20 (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.motSpe.y,senTemSupAir.T,dam1.actPos.y,dam2.actPos.y,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 (474):
 * Single equations (assignments): 439
 * 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,3), (1,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.05128/4.74, allocations: 21.86 MB / 2.452 GB, free: 0.6329 GB / 1.826 GB
Notification: Performance of simCode: created initialization part: time 0.05002/4.79, allocations: 23.59 MB / 2.475 GB, free: 0.6095 GB / 1.826 GB
Notification: Performance of simCode: created event and clocks part: time 1.134e-05/4.79, allocations: 5 kB / 2.475 GB, free: 0.6095 GB / 1.826 GB
Notification: Performance of simCode: created simulation system equations: time 0.01462/4.805, allocations: 6.157 MB / 2.481 GB, free: 0.6035 GB / 1.826 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01932/4.824, allocations: 3.671 MB / 2.485 GB, free: 0.6 GB / 1.826 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3071/5.131, allocations: 137.9 MB / 2.619 GB, free: 475.5 MB / 1.826 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00841/5.14, allocations: 5.494 MB / 2.625 GB, free: 469.9 MB / 1.826 GB
Notification: Performance of simCode: alias equations: time 0.01343/5.153, allocations: 3.57 MB / 2.628 GB, free: 466.4 MB / 1.826 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01011/5.163, allocations: 4.67 MB / 2.633 GB, free: 461.7 MB / 1.826 GB
Notification: Performance of SimCode: time 1.022e-06/5.163, allocations: 0 / 2.633 GB, free: 461.7 MB / 1.826 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4098/5.573, allocations: 324.5 MB / 2.95 GB, free: 139 MB / 1.826 GB
Notification: Performance of buildModelFMU: Generate platform static: time 38.13/43.7, allocations: 4.062 kB / 2.95 GB, free: 139 MB / 1.826 GB
"
[Timeout remaining time 256]
(rm -f Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe ; mkfifo Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe ; head -c 1048576 < Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe >> ../files/Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.sim & python3 -m fmpy simulate  --output-file Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer_res.csv --start-time 1.188e+07 --stop-time 1.26e+07 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 288 Buildings_12_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer.fmu > Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 50.91257258399855]
Failed to read output from testmodel.py, exit status != 0:
44.11687530900235 44.125952752 42.200535845
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f8163632f20>