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.001533/0.001533, allocations: 113.5 kB / 19.73 MB, free: 2.242 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.001839/0.001839, allocations: 212.8 kB / 23.04 MB, free: 5.078 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.484/1.484, allocations: 230.6 MB / 256.8 MB, free: 7.988 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.126/3.126, allocations: 0.49 GB / 0.7959 GB, free: 33.41 MB / 0.6231 GB
"
[Timeout remaining time 177]
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="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer,fileNamePrefix="Buildings_12_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer",fmuType="cs",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.001937/0.001937, allocations: 66.25 kB / 1.155 GB, free: 25.7 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2998/0.3017, allocations: 176.1 MB / 1.327 GB, free: 1.973 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer): time 1.09/1.392, allocations: 324 MB / 1.643 GB, free: 21 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 0.06517/1.457, allocations: 48.36 MB / 1.69 GB, free: 20.46 MB / 1.295 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009753/1.466, allocations: 250.2 kB / 1.691 GB, free: 20.46 MB / 1.295 GB
Notification: Performance of NFTyping.typeComponents: time 0.01138/1.478, allocations: 4.107 MB / 1.695 GB, free: 20.35 MB / 1.295 GB
Notification: Performance of NFTyping.typeBindings: time 0.02328/1.501, allocations: 7.65 MB / 1.702 GB, free: 20.04 MB / 1.295 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01971/1.521, allocations: 8.102 MB / 1.71 GB, free: 19.7 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.02961/1.55, allocations: 23.16 MB / 1.733 GB, free: 16.42 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01346/1.564, allocations: 6.472 MB / 1.739 GB, free: 13.4 MB / 1.295 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01924/1.583, allocations: 7.546 MB / 1.746 GB, free: 10.44 MB / 1.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0117/1.595, allocations: 6.517 MB / 1.753 GB, free: 6.652 MB / 1.295 GB
Notification: Performance of NFPackage.collectConstants: time 0.005796/1.601, allocations: 1.382 MB / 1.754 GB, free: 6.652 MB / 1.295 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02269/1.623, allocations: 9.019 MB / 1.763 GB, free: 3.438 MB / 1.295 GB
Notification: Performance of NFScalarize.scalarize: time 0.006367/1.63, allocations: 4.302 MB / 1.767 GB, free: 364 kB / 1.295 GB
Notification: Performance of NFVerifyModel.verify: time 0.01628/1.646, allocations: 6.704 MB / 1.774 GB, free: 11.39 MB / 1.311 GB
Notification: Performance of NFConvertDAE.convert: time 0.04653/1.693, allocations: 25.3 MB / 1.798 GB, free: 5.395 MB / 1.326 GB
Notification: Performance of FrontEnd - DAE generated: time 6.752e-06/1.693, allocations: 0 / 1.798 GB, free: 5.395 MB / 1.326 GB
Notification: Performance of FrontEnd: time 1.783e-06/1.693, allocations: 0 / 1.798 GB, free: 5.395 MB / 1.326 GB
Notification: Performance of Transformations before backend: time 0.0006837/1.693, allocations: 3.938 kB / 1.798 GB, free: 5.391 MB / 1.326 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.05198/1.745, allocations: 15.05 MB / 1.813 GB, free: 6.215 MB / 1.342 GB
Notification: Performance of prepare preOptimizeDAE: time 5.904e-05/1.745, allocations: 8.031 kB / 1.813 GB, free: 6.207 MB / 1.342 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 0.000187/1.745, allocations: 127.8 kB / 1.813 GB, free: 6.082 MB / 1.342 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003146/1.749, allocations: 0.6581 MB / 1.814 GB, free: 5.414 MB / 1.342 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04805/1.797, allocations: 5.338 MB / 1.819 GB, free: 76 kB / 1.342 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03571/1.832, allocations: 13.91 MB / 1.833 GB, free: 2.512 MB / 1.357 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001319/1.834, allocations: 0.8286 MB / 1.833 GB, free: 1.617 MB / 1.357 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002271/1.836, allocations: 0.5304 MB / 1.834 GB, free: 1.09 MB / 1.357 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03081/1.867, allocations: 10.82 MB / 1.844 GB, free: 6.109 MB / 1.373 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001595/1.867, allocations: 0 / 1.844 GB, free: 6.109 MB / 1.373 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0018/1.869, allocations: 210.8 kB / 1.845 GB, free: 5.906 MB / 1.373 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001988/1.869, allocations: 185.2 kB / 1.845 GB, free: 5.727 MB / 1.373 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03827/1.907, allocations: 12.95 MB / 1.857 GB, free: 8.785 MB / 1.389 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.08825/1.995, allocations: 41.51 MB / 1.898 GB, free: 14.66 MB / 1.436 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0278/2.023, allocations: 8.895 MB / 1.907 GB, free: 5.75 MB / 1.436 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0164/2.04, allocations: 5.575 MB / 1.912 GB, free: 168 kB / 1.436 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001454/2.041, allocations: 282.1 kB / 1.912 GB, free: 15.92 MB / 1.451 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02002/2.061, allocations: 7.557 MB / 1.92 GB, free: 8.34 MB / 1.451 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.005872/2.067, allocations: 0.6414 MB / 1.92 GB, free: 7.703 MB / 1.451 GB
Notification: Performance of pre-optimization done (n=464): time 1.385e-05/2.067, allocations: 4 kB / 1.92 GB, free: 7.699 MB / 1.451 GB
Notification: Performance of matching and sorting (n=464): time 0.08889/2.156, allocations: 19.35 MB / 1.939 GB, free: 4.348 MB / 1.467 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002347/2.156, allocations: 313.6 kB / 1.94 GB, free: 3.988 MB / 1.467 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03164/2.188, allocations: 14.13 MB / 1.953 GB, free: 5.902 MB / 1.482 GB
Notification: Performance of collectPreVariables (initialization): time 0.002221/2.19, allocations: 189.7 kB / 1.954 GB, free: 5.711 MB / 1.482 GB
Notification: Performance of collectInitialEqns (initialization): time 0.008222/2.198, allocations: 4.526 MB / 1.958 GB, free: 1.191 MB / 1.482 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002796/2.201, allocations: 1.553 MB / 1.959 GB, free: 15.66 MB / 1.498 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.005192/2.206, allocations: 1.3 MB / 1.961 GB, free: 14.36 MB / 1.498 GB
Notification: Performance of setup shared object (initialization): time 0.0001254/2.206, allocations: 305.1 kB / 1.961 GB, free: 14.05 MB / 1.498 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01824/2.225, allocations: 6.891 MB / 1.968 GB, free: 7.148 MB / 1.498 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0196/2.244, allocations: 7.841 MB / 1.975 GB, free: 14.89 MB / 1.514 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.5166/2.761, allocations: 162 MB / 2.134 GB, free: 12.32 MB / 1.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.409e-05/2.761, allocations: 8 kB / 2.134 GB, free: 12.32 MB / 1.67 GB
Notification: Performance of matching and sorting (n=707) (initialization): time 0.06791/2.829, allocations: 17.24 MB / 2.151 GB, free: 11.08 MB / 1.686 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002445/2.829, allocations: 141 kB / 2.151 GB, free: 10.92 MB / 1.686 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.752e-05/2.829, allocations: 20 kB / 2.151 GB, free: 10.9 MB / 1.686 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008372/2.837, allocations: 1.758 MB / 2.152 GB, free: 9.117 MB / 1.686 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01065/2.848, allocations: 1.503 MB / 2.154 GB, free: 7.68 MB / 1.686 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02165/2.87, allocations: 16.24 MB / 2.17 GB, free: 6.609 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01394/2.884, allocations: 0.8157 MB / 2.171 GB, free: 5.793 MB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001818/2.885, allocations: 331.7 kB / 2.171 GB, free: 5.469 MB / 1.701 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/2.91, allocations: 9.764 MB / 2.18 GB, free: 11.69 MB / 1.717 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01883/2.929, allocations: 7.724 MB / 2.188 GB, free: 3.555 MB / 1.717 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.359/4.288, allocations: 161.5 MB / 2.346 GB, free: 463.8 MB / 1.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.09e-05/4.288, allocations: 6.375 kB / 2.346 GB, free: 463.8 MB / 1.795 GB
Notification: Performance of matching and sorting (n=707) (initialization_lambda0): time 0.05952/4.347, allocations: 16.8 MB / 2.362 GB, free: 460.7 MB / 1.795 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001591/4.347, allocations: 142.4 kB / 2.362 GB, free: 460.6 MB / 1.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.326e-05/4.347, allocations: 16.28 kB / 2.362 GB, free: 460.6 MB / 1.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005623/4.353, allocations: 1.516 MB / 2.364 GB, free: 460.1 MB / 1.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009451/4.363, allocations: 1.518 MB / 2.365 GB, free: 459.7 MB / 1.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0133/4.376, allocations: 15.45 MB / 2.38 GB, free: 447.7 MB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0133/4.389, allocations: 0.886 MB / 2.381 GB, free: 447.3 MB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001681/4.391, allocations: 321.1 kB / 2.381 GB, free: 447.3 MB / 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 (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.002955/4.394, allocations: 0.579 MB / 2.382 GB, free: 447 MB / 1.795 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003925/4.398, allocations: 1.018 MB / 2.383 GB, free: 447 MB / 1.795 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05589/4.454, allocations: 14.27 MB / 2.397 GB, free: 438.2 MB / 1.795 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.063e-05/4.454, allocations: 51.94 kB / 2.397 GB, free: 438.1 MB / 1.795 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.964e-05/4.454, allocations: 0 / 2.397 GB, free: 438.1 MB / 1.795 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04928/4.503, allocations: 12.4 MB / 2.409 GB, free: 429.2 MB / 1.795 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.08081/4.584, allocations: 28.33 MB / 2.437 GB, free: 408.2 MB / 1.795 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.444e-05/4.584, allocations: 0 / 2.437 GB, free: 408.2 MB / 1.795 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00868/4.593, allocations: 1.233 MB / 2.438 GB, free: 407 MB / 1.795 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002371/4.595, allocations: 0.654 MB / 2.439 GB, free: 406.4 MB / 1.795 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001461/4.596, allocations: 192.5 kB / 2.439 GB, free: 406.2 MB / 1.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005686/4.602, allocations: 5.971 MB / 2.445 GB, free: 399.9 MB / 1.795 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.236e-06/4.602, allocations: 0 / 2.445 GB, free: 399.9 MB / 1.795 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0677/4.67, allocations: 21.17 MB / 2.465 GB, free: 378.7 MB / 1.795 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008901/4.679, allocations: 2.814 MB / 2.468 GB, free: 375.9 MB / 1.795 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004723/4.683, allocations: 230.4 kB / 2.468 GB, free: 375.7 MB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01316/4.697, allocations: 0.7443 MB / 2.469 GB, free: 375 MB / 1.795 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001753/4.698, allocations: 415.2 kB / 2.469 GB, free: 374.6 MB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00153/4.7, allocations: 255.7 kB / 2.47 GB, free: 374.3 MB / 1.795 GB
Notification: Performance of sorting global known variables: time 0.02038/4.72, allocations: 9.848 MB / 2.479 GB, free: 364.5 MB / 1.795 GB
Notification: Performance of sort global known variables: time 2.01e-07/4.72, allocations: 0 / 2.479 GB, free: 364.5 MB / 1.795 GB
Notification: Performance of remove unused functions: time 0.02058/4.741, allocations: 4.331 MB / 2.483 GB, free: 360.4 MB / 1.795 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.05658/4.797, allocations: 21.83 MB / 2.505 GB, free: 338.9 MB / 1.795 GB
Notification: Performance of simCode: created initialization part: time 0.05624/4.854, allocations: 23.38 MB / 2.528 GB, free: 315.5 MB / 1.795 GB
Notification: Performance of simCode: created event and clocks part: time 1.137e-05/4.854, allocations: 6.938 kB / 2.528 GB, free: 315.4 MB / 1.795 GB
Notification: Performance of simCode: created simulation system equations: time 0.0155/4.869, allocations: 6.161 MB / 2.534 GB, free: 309.3 MB / 1.795 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02038/4.889, allocations: 3.67 MB / 2.537 GB, free: 305.8 MB / 1.795 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3223/5.212, allocations: 137.4 MB / 2.671 GB, free: 168 MB / 1.795 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.007832/5.22, allocations: 5.941 MB / 2.677 GB, free: 162 MB / 1.795 GB
Notification: Performance of simCode: alias equations: time 0.01567/5.235, allocations: 3.632 MB / 2.681 GB, free: 158.4 MB / 1.795 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009733/5.245, allocations: 4.666 MB / 2.685 GB, free: 153.7 MB / 1.795 GB
Notification: Performance of SimCode: time 1.093e-06/5.245, allocations: 0 / 2.685 GB, free: 153.7 MB / 1.795 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.133/6.378, allocations: 312.7 MB / 2.991 GB, free: 0.8202 GB / 1.92 GB
Notification: Performance of buildModelFMU: Generate platform static: time 56.96/63.33, allocations: 8.469 kB / 2.991 GB, free: 0.8202 GB / 1.92 GB
"
[Timeout remaining time 236]
(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 & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_12_Buildings.Applications.DataCenters.DXCooled.Examples.DXCooledAirsideEconomizer_res.mat --tempDir=temp_Buildings_12_Buildings_Applications_DataCenters_DXCooled_Examples_DXCooledAirsideEconomizer_fmu --startTime=1.188e+07 --stopTime=1.26e+07 --stepSize=288 --timeout=400 --tolerance=1e-06 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: 71.0234839770128]
Failed to read output from testmodel.py, exit status != 0:
63.806555998977274 63.826805737 62.130097516
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f8c58d933a0>