Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer.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.001278/0.001278, allocations: 107.7 kB / 16.46 MB, free: 6.512 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.001391/0.001391, allocations: 208.3 kB / 19.43 MB, free: 3.648 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.523/1.523, allocations: 230.6 MB / 252.8 MB, free: 8.945 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.81/2.81, allocations: 476.7 MB / 0.7672 GB, free: 5.199 MB / 0.6231 GB " [Timeout remaining time 177] Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: "" <> buildModelFMU(Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer,fileNamePrefix="Buildings_11_Buildings_Applications_DataCenters_ChillerCooled_Examples_IntegratedPrimaryLoadSideEconomizer",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer,fileNamePrefix="Buildings_11_Buildings_Applications_DataCenters_ChillerCooled_Examples_IntegratedPrimaryLoadSideEconomizer",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.002674/0.002674, allocations: 67.89 kB / 1.112 GB, free: 1.418 MB / 0.9044 GB Notification: Performance of FrontEnd - Absyn->SCode: time 1.001/1.004, allocations: 169.9 MB / 1.278 GB, free: 13.34 MB / 0.9825 GB Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer): time 2.986/3.99, allocations: 1.099 GB / 2.377 GB, free: 131.2 MB / 1.686 GB Notification: Performance of NFInst.instExpressions: time 0.1649/4.155, allocations: 123.5 MB / 2.498 GB, free: 129.4 MB / 1.686 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.04604/4.201, allocations: 0.9301 MB / 2.499 GB, free: 129.4 MB / 1.686 GB Notification: Performance of NFTyping.typeComponents: time 0.03018/4.231, allocations: 9.361 MB / 2.508 GB, free: 129.2 MB / 1.686 GB Notification: Performance of NFTyping.typeBindings: time 0.07086/4.302, allocations: 23.7 MB / 2.531 GB, free: 125.4 MB / 1.686 GB Notification: Performance of NFTyping.typeClassSections: time 0.03857/4.341, allocations: 15.16 MB / 2.546 GB, free: 116.9 MB / 1.686 GB Notification: Performance of NFFlatten.flatten: time 0.1064/4.447, allocations: 82 MB / 2.626 GB, free: 61.54 MB / 1.686 GB Notification: Performance of NFFlatten.resolveConnections: time 0.03672/4.484, allocations: 20.23 MB / 2.646 GB, free: 41.57 MB / 1.686 GB Notification: Performance of NFEvalConstants.evaluate: time 0.05067/4.534, allocations: 22.71 MB / 2.668 GB, free: 20.02 MB / 1.686 GB Notification: Performance of NFSimplifyModel.simplify: time 0.02889/4.563, allocations: 18.2 MB / 2.686 GB, free: 2.98 MB / 1.686 GB Notification: Performance of NFPackage.collectConstants: time 0.01089/4.574, allocations: 2.859 MB / 2.688 GB, free: 124 kB / 1.686 GB Notification: Performance of NFFlatten.collectFunctions: time 0.04862/4.623, allocations: 15.38 MB / 2.703 GB, free: 1.859 MB / 1.701 GB Notification: Performance of NFScalarize.scalarize: time 0.01618/4.639, allocations: 8.702 MB / 2.712 GB, free: 9.316 MB / 1.717 GB Notification: Performance of NFVerifyModel.verify: time 0.03319/4.672, allocations: 15.16 MB / 2.727 GB, free: 10.25 MB / 1.732 GB Notification: Performance of NFConvertDAE.convert: time 0.09589/4.768, allocations: 50.02 MB / 2.776 GB, free: 9.754 MB / 1.779 GB Notification: Performance of FrontEnd - DAE generated: time 6.062e-06/4.768, allocations: 4 kB / 2.776 GB, free: 9.75 MB / 1.779 GB Notification: Performance of FrontEnd: time 2.003e-06/4.768, allocations: 0 / 2.776 GB, free: 9.75 MB / 1.779 GB Notification: Performance of Transformations before backend: time 0.001484/4.769, allocations: 0 / 2.776 GB, free: 9.75 MB / 1.779 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 3460 * Number of variables: 3460 Notification: Performance of Generate backend data structure: time 0.09125/4.861, allocations: 30.95 MB / 2.806 GB, free: 10.86 MB / 1.811 GB Notification: Performance of prepare preOptimizeDAE: time 4.846e-05/4.861, allocations: 12.03 kB / 2.806 GB, free: 10.84 MB / 1.811 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.007547/4.868, allocations: 1.767 MB / 2.808 GB, free: 9.066 MB / 1.811 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06039/4.929, allocations: 8.424 MB / 2.816 GB, free: 0.625 MB / 1.811 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.09514/5.024, allocations: 43.58 MB / 2.858 GB, free: 5.957 MB / 1.857 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001912/5.026, allocations: 1.319 MB / 2.86 GB, free: 4.621 MB / 1.857 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.006294/5.032, allocations: 1.461 MB / 2.861 GB, free: 3.168 MB / 1.857 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0707/5.103, allocations: 22.82 MB / 2.883 GB, free: 11.93 MB / 1.889 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0007016/5.103, allocations: 27.77 kB / 2.883 GB, free: 11.91 MB / 1.889 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005816/5.109, allocations: 0.5555 MB / 2.884 GB, free: 11.36 MB / 1.889 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006019/5.11, allocations: 0.5252 MB / 2.884 GB, free: 10.83 MB / 1.889 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07269/5.183, allocations: 24.42 MB / 2.908 GB, free: 2.391 MB / 1.904 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 1.265/6.448, allocations: 95.28 MB / 3.001 GB, free: 301.3 MB / 1.951 GB Notification: Performance of preOpt comSubExp (simulation): time 0.03582/6.484, allocations: 15.37 MB / 3.016 GB, free: 300.6 MB / 1.951 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.02403/6.508, allocations: 9.232 MB / 3.025 GB, free: 300.5 MB / 1.951 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 evalFunc (simulation): time 0.07688/6.584, allocations: 33.67 MB / 3.058 GB, free: 293.8 MB / 1.951 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02551/6.61, allocations: 10.57 MB / 3.069 GB, free: 293.5 MB / 1.951 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.01388/6.624, allocations: 1.76 MB / 3.07 GB, free: 293.5 MB / 1.951 GB Notification: Performance of pre-optimization done (n=1072): time 6.148e-05/6.624, allocations: 0 / 3.07 GB, free: 293.5 MB / 1.951 GB Notification: Performance of matching and sorting (n=1083): time 0.1589/6.783, allocations: 52.16 MB / 3.121 GB, free: 288.4 MB / 1.951 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001638/6.783, allocations: 323 kB / 3.122 GB, free: 288.2 MB / 1.951 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.04311/6.826, allocations: 23.65 MB / 3.145 GB, free: 286.9 MB / 1.951 GB Notification: Performance of collectPreVariables (initialization): time 0.003616/6.83, allocations: 349.6 kB / 3.145 GB, free: 286.9 MB / 1.951 GB Notification: Performance of collectInitialEqns (initialization): time 0.01213/6.842, allocations: 10.63 MB / 3.155 GB, free: 284.9 MB / 1.951 GB Notification: Performance of collectInitialBindings (initialization): time 0.005721/6.848, allocations: 3.672 MB / 3.159 GB, free: 282.6 MB / 1.951 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.01352/6.861, allocations: 3.636 MB / 3.162 GB, free: 281.8 MB / 1.951 GB Notification: Performance of setup shared object (initialization): time 4.344e-05/6.861, allocations: 304.9 kB / 3.163 GB, free: 281.5 MB / 1.951 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.02296/6.884, allocations: 11.23 MB / 3.174 GB, free: 276.5 MB / 1.951 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.02802/6.912, allocations: 15.07 MB / 3.188 GB, free: 266.5 MB / 1.951 GB Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet. Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: ahu.cooCoi.heaCooHum_u.vol.dynBal.medium.p = ahu.cooCoi.heaCooHum_u.vol.dynBal.p_start (ahu.fan.vol.dynBal.p_start = ahu.cooCoi.heaCooHum_u.vol.dynBal.p_start) Notification: Performance of analyzeInitialSystem (initialization): time 0.6326/7.545, allocations: 135.4 MB / 3.321 GB, free: 131.6 MB / 1.951 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001201/7.545, allocations: 24 kB / 3.321 GB, free: 131.6 MB / 1.951 GB Notification: Performance of matching and sorting (n=2067) (initialization): time 0.07254/7.617, allocations: 30.26 MB / 3.35 GB, free: 101.7 MB / 1.951 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001272/7.618, allocations: 40.22 kB / 3.35 GB, free: 101.7 MB / 1.951 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001482/7.618, allocations: 76.09 kB / 3.35 GB, free: 101.6 MB / 1.951 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01296/7.631, allocations: 3.49 MB / 3.354 GB, free: 98.13 MB / 1.951 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02/7.651, allocations: 3.601 MB / 3.357 GB, free: 94.72 MB / 1.951 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01725/7.668, allocations: 19.52 MB / 3.376 GB, free: 74.32 MB / 1.951 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02316/7.691, allocations: 1.496 MB / 3.378 GB, free: 72.82 MB / 1.951 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004054/7.695, allocations: 0.7807 MB / 3.379 GB, free: 72.04 MB / 1.951 GB Warning: The initial conditions are over specified. The following 3 initial equations are redundant, so they are removed from the initialization system: ahu.cooCoi.UAFroRated.TAirIn = 293.15 ahu.cooCoi.UAFroRated.TWatIn = 293.15 ahu.cooCoi.heaCooHum_u.vol.dynBal.medium.p = ahu.cooCoi.heaCooHum_u.vol.dynBal.p_start. Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03615/7.731, allocations: 17.2 MB / 3.395 GB, free: 54.84 MB / 1.951 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02576/7.757, allocations: 14.39 MB / 3.409 GB, free: 39.16 MB / 1.951 GB Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet. Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: ahu.cooCoi.heaCooHum_u.vol.dynBal.medium.p = ahu.cooCoi.heaCooHum_u.vol.dynBal.p_start (ahu.fan.vol.dynBal.p_start = ahu.cooCoi.heaCooHum_u.vol.dynBal.p_start) Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.6839/8.441, allocations: 132.7 MB / 3.539 GB, free: 2.148 MB / 2.045 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001217/8.441, allocations: 24 kB / 3.539 GB, free: 2.125 MB / 2.045 GB Notification: Performance of matching and sorting (n=2067) (initialization_lambda0): time 0.08824/8.529, allocations: 28.59 MB / 3.567 GB, free: 5.887 MB / 2.076 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001442/8.529, allocations: 40 kB / 3.567 GB, free: 5.848 MB / 2.076 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001864/8.53, allocations: 72 kB / 3.567 GB, free: 5.777 MB / 2.076 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01244/8.542, allocations: 3.193 MB / 3.57 GB, free: 2.566 MB / 2.076 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02078/8.563, allocations: 3.605 MB / 3.574 GB, free: 15.15 MB / 2.092 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02558/8.588, allocations: 19.5 MB / 3.593 GB, free: 10.63 MB / 2.107 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02615/8.615, allocations: 1.578 MB / 3.594 GB, free: 9.055 MB / 2.107 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004878/8.619, allocations: 0.7342 MB / 3.595 GB, free: 8.32 MB / 2.107 GB Warning: The initial conditions are over specified. The following 3 initial equations are redundant, so they are removed from the initialization_lambda0 system: ahu.cooCoi.UAFroRated.TAirIn = 293.15 ahu.cooCoi.UAFroRated.TWatIn = 293.15 ahu.cooCoi.heaCooHum_u.vol.dynBal.medium.p = ahu.cooCoi.heaCooHum_u.vol.dynBal.p_start. Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 342 * Number of states: 0 () * Number of discrete variables: 315 (ahu.cooCoi.UAFroRated.isFulWet,ahu.cooCoi.UAFroRated.isFulDry,$PRE.ahu.heaCon.offToOn.enableFire,$PRE.ahu.heaCon.onToOff.enableFire,$PRE.chiStaCon.con1.enableFire,$PRE.chiStaCon.con2.enableFire,$PRE.chiStaCon.con3.enableFire,$PRE.chiStaCon.con4.enableFire,$PRE.CWPumCon.con1.enableFire,$PRE.CWPumCon.con2.enableFire,$PRE.CWPumCon.con3.enableFire,$PRE.CWPumCon.con4.enableFire,$PRE.varSpeCon.con1.enableFire,$PRE.varSpeCon.con2.enableFire,$PRE.varSpeCon.con3.enableFire,$PRE.varSpeCon.con4.enableFire,$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,varSpeCon.stateGraphRoot.resume,varSpeCon.stateGraphRoot.suspend,CWPumCon.stateGraphRoot.resume,CWPumCon.stateGraphRoot.suspend,chiStaCon.stateGraphRoot.resume,chiStaCon.stateGraphRoot.suspend,ahu.heaCon.stateGraphRoot.resume,ahu.heaCon.stateGraphRoot.suspend,chiWSE.chiPar.chi[2].tru.y,chiWSE.chiPar.chi[1].tru.y,swiTim.local_set,swiTim.local_reset,ahu.cooCoi.flowRegime_nominal,ahu.cooCoi.dryWetCalcs.fullyDry.cfg,ahu.cooCoi.dryWetCalcs.fullyWet.cfg,ahu.cooCoi.dryWetCalcs.cfg,ahu.cooCoi.flowRegime,$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.varSpeCon.con4.t_start,$PRE.varSpeCon.con3.t_start,$PRE.varSpeCon.con2.t_start,$PRE.varSpeCon.twoOn.oldActive,$PRE.varSpeCon.twoOn.newActive,$PRE.varSpeCon.twoOn.localActive,$PRE.varSpeCon.off.oldActive,$PRE.varSpeCon.off.newActive,$PRE.varSpeCon.off.localActive,$PRE.varSpeCon.oneOn.oldActive,$PRE.varSpeCon.oneOn.newActive,$PRE.varSpeCon.oneOn.localActive,$PRE.varSpeCon.con1.t_start,$PRE.CWPumCon.con4.t_start,$PRE.CWPumCon.con3.t_start,$PRE.CWPumCon.con2.t_start,$PRE.CWPumCon.twoOn.oldActive,$PRE.CWPumCon.twoOn.newActive,$PRE.CWPumCon.twoOn.localActive,$PRE.CWPumCon.off.oldActive,$PRE.CWPumCon.off.newActive,$PRE.CWPumCon.off.localActive,$PRE.CWPumCon.oneOn.oldActive,$PRE.CWPumCon.oneOn.newActive,$PRE.CWPumCon.oneOn.localActive,$PRE.CWPumCon.con1.t_start,$PRE.chiStaCon.con4.t_start,$PRE.chiStaCon.con3.t_start,$PRE.chiStaCon.con2.t_start,$PRE.chiStaCon.twoOn.oldActive,$PRE.chiStaCon.twoOn.newActive,$PRE.chiStaCon.twoOn.localActive,$PRE.chiStaCon.off.oldActive,$PRE.chiStaCon.off.newActive,$PRE.chiStaCon.off.localActive,$PRE.chiStaCon.oneOn.oldActive,$PRE.chiStaCon.oneOn.newActive,$PRE.chiStaCon.oneOn.localActive,$PRE.chiStaCon.con1.t_start,$PRE.ahu.heaCon.onToOff.t_start,$PRE.ahu.heaCon.offToOn.t_start,$PRE.ahu.heaCon.on.oldActive,$PRE.ahu.heaCon.on.newActive,$PRE.ahu.heaCon.on.localActive,$PRE.ahu.heaCon.off.oldActive,$PRE.ahu.heaCon.off.newActive,$PRE.ahu.heaCon.off.localActive,$PRE.chiWSE.pum.hys[2].y,$PRE.chiWSE.pum.hys[1].y,cooModCon.swi.expr[3],cooModCon.swi.expr[2],cooModCon.swi.expr[1],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,chiOnSta.y,chiOnSta.u[2],chiOnSta.u[1],swi[2].u2,varSpeCon.addInt.y,varSpeCon.booToInt1.y,varSpeCon.booToInt.y,varSpeCon.stateGraphRoot.activeSteps,varSpeCon.con4.t_start,varSpeCon.con4.fire,varSpeCon.con4.enableFire,varSpeCon.con4.localCondition,varSpeCon.con3.t_start,varSpeCon.con3.fire,varSpeCon.con3.enableFire,varSpeCon.con3.localCondition,varSpeCon.con2.t_start,varSpeCon.con2.fire,varSpeCon.con2.enableFire,varSpeCon.con2.localCondition,varSpeCon.twoOn.active,varSpeCon.twoOn.oldActive,varSpeCon.twoOn.newActive,varSpeCon.twoOn.localActive,varSpeCon.off.oldActive,varSpeCon.off.newActive,varSpeCon.off.localActive,varSpeCon.off.active,varSpeCon.oneOn.active,varSpeCon.oneOn.oldActive,varSpeCon.oneOn.newActive,varSpeCon.oneOn.outPort[2].available,varSpeCon.oneOn.inPort[2].occupied,varSpeCon.oneOn.localActive,varSpeCon.con1.t_start,varSpeCon.con1.fire,varSpeCon.con1.enableFire,varSpeCon.con1.localCondition,cooTowSpeCon.fmcMod.y,cooTowSpeCon.pmcMod.y,chiNumOn.y,CWPumCon.addInt.y,CWPumCon.booToInt1.y,CWPumCon.booToInt.y,CWPumCon.stateGraphRoot.activeSteps,CWPumCon.con4.t_start,CWPumCon.con4.fire,CWPumCon.con4.enableFire,CWPumCon.con4.localCondition,CWPumCon.con3.t_start,CWPumCon.con3.fire,CWPumCon.con3.enableFire,CWPumCon.con3.localCondition,CWPumCon.con2.t_start,CWPumCon.con2.fire,CWPumCon.con2.enableFire,CWPumCon.con2.localCondition,CWPumCon.twoOn.active,CWPumCon.twoOn.oldActive,CWPumCon.twoOn.newActive,CWPumCon.twoOn.localActive,CWPumCon.off.oldActive,CWPumCon.off.newActive,CWPumCon.off.localActive,CWPumCon.off.active,CWPumCon.oneOn.active,CWPumCon.oneOn.oldActive,CWPumCon.oneOn.newActive,CWPumCon.oneOn.outPort[2].available,CWPumCon.oneOn.inPort[2].occupied,CWPumCon.oneOn.localActive,CWPumCon.con1.t_start,CWPumCon.con1.fire,CWPumCon.con1.enableFire,CWPumCon.con1.localCondition,chiStaCon.addInt.y,chiStaCon.booToInt1.y,chiStaCon.booToInt.y,chiStaCon.stateGraphRoot.activeSteps,chiStaCon.con4.t_start,chiStaCon.con4.fire,chiStaCon.con4.enableFire,chiStaCon.con4.localCondition,chiStaCon.con3.t_start,chiStaCon.con3.fire,chiStaCon.con3.enableFire,chiStaCon.con3.localCondition,chiStaCon.con2.t_start,chiStaCon.con2.fire,chiStaCon.con2.enableFire,chiStaCon.con2.localCondition,chiStaCon.twoOn.active,chiStaCon.twoOn.oldActive,chiStaCon.twoOn.newActive,chiStaCon.twoOn.localActive,chiStaCon.off.oldActive,chiStaCon.off.newActive,chiStaCon.off.localActive,chiStaCon.off.active,chiStaCon.oneOn.active,chiStaCon.oneOn.oldActive,chiStaCon.oneOn.newActive,chiStaCon.oneOn.outPort[2].available,chiStaCon.oneOn.inPort[2].occupied,chiStaCon.oneOn.localActive,chiStaCon.con1.t_start,chiStaCon.con1.fire,chiStaCon.con1.enableFire,chiStaCon.con1.localCondition,ahu.heaCon.stateGraphRoot.activeSteps,ahu.heaCon.onToOff.t_start,ahu.heaCon.onToOff.fire,ahu.heaCon.onToOff.enableFire,ahu.heaCon.onToOff.localCondition,ahu.heaCon.offToOn.t_start,ahu.heaCon.offToOn.fire,ahu.heaCon.offToOn.enableFire,ahu.heaCon.offToOn.localCondition,ahu.heaCon.on.active,ahu.heaCon.on.oldActive,ahu.heaCon.on.newActive,ahu.heaCon.on.localActive,ahu.heaCon.off.active,ahu.heaCon.off.oldActive,ahu.heaCon.off.newActive,ahu.heaCon.off.localActive,weaData.decAng.tNext,$PRE.weaData.decAng.tNext,weaData.eqnTim.tNext,$PRE.weaData.eqnTim.tNext,weaData.conTim.tNext,$PRE.weaData.conTim.tNext,weaData.conTimMin.tNext,$PRE.weaData.conTimMin.tNext,weaData.locTim.tNext,$PRE.weaData.locTim.tNext,chiWSE.pum.hys[2].y,chiWSE.pum.hys[1].y,chiWSE.on[3],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,ahuFanSpeCon.I.trigger_internal,ahuValSig.I.trigger_internal,pumSpe.I.trigger_internal,cooTowSpeCon.conPID.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 (1731): * Single equations (assignments): 1694 * Array equations: 15 * Algorithm blocks: 0 * Record equations: 5 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 7 * Torn equation systems: 10 * 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): 7 systems {1, 1, 1, 1, 1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(1,5,100.0%), (1,2,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 8 systems {(1,1), (1,3), (1,2), (8,48), (8,37), (3,5), (1,8), (1,2)} Notification: Performance of prepare postOptimizeDAE: time 0.007545/8.627, allocations: 1.174 MB / 3.596 GB, free: 7.324 MB / 2.107 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008692/8.636, allocations: 2.169 MB / 3.598 GB, free: 5.141 MB / 2.107 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.07027/8.706, allocations: 21.97 MB / 3.62 GB, free: 15.23 MB / 2.139 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002043/8.706, allocations: 131.5 kB / 3.62 GB, free: 15.11 MB / 2.139 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.887e-05/8.706, allocations: 0 / 3.62 GB, free: 15.11 MB / 2.139 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0558/8.762, allocations: 17.3 MB / 3.637 GB, free: 13.73 MB / 2.154 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1199/8.882, allocations: 43.11 MB / 3.679 GB, free: 2.836 MB / 2.186 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.539e-05/8.882, allocations: 8.109 kB / 3.679 GB, free: 2.828 MB / 2.186 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.016/8.898, allocations: 2.462 MB / 3.681 GB, free: 472 kB / 2.186 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.006355/8.904, allocations: 1.56 MB / 3.683 GB, free: 14.88 MB / 2.201 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002855/8.907, allocations: 327.7 kB / 3.683 GB, free: 14.56 MB / 2.201 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01634/8.924, allocations: 14.3 MB / 3.697 GB, free: 15.54 MB / 2.217 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.645e-06/8.924, allocations: 0 / 3.697 GB, free: 15.54 MB / 2.217 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.09116/9.015, allocations: 31.38 MB / 3.728 GB, free: 28 kB / 2.232 GB Notification: Performance of postOpt removeConstants (simulation): time 0.01547/9.03, allocations: 4.41 MB / 3.732 GB, free: 11.58 MB / 2.248 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.008847/9.039, allocations: 232 kB / 3.732 GB, free: 11.36 MB / 2.248 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02069/9.06, allocations: 1.231 MB / 3.733 GB, free: 10.13 MB / 2.248 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.004091/9.064, allocations: 0.8977 MB / 3.734 GB, free: 9.23 MB / 2.248 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003603/9.067, allocations: 463.7 kB / 3.735 GB, free: 8.777 MB / 2.248 GB Notification: Performance of sorting global known variables: time 0.8572/9.925, allocations: 16.17 MB / 3.751 GB, free: 1.138 GB / 2.248 GB Notification: Performance of sort global known variables: time 4.61e-07/9.925, allocations: 0.5312 kB / 3.751 GB, free: 1.138 GB / 2.248 GB Notification: Performance of remove unused functions: time 0.04705/9.972, allocations: 9.16 MB / 3.759 GB, free: 1.138 GB / 2.248 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 5 * Number of states: 40 (FCTim.y,PMCTim.y,FMCHou.y,EHVAC.y,EIT.y,chiWSE.chiPar.chi[1].vol1.dynBal.U,chiWSE.chiPar.chi[1].vol2.dynBal.U,chiWSE.chiPar.chi[2].vol1.dynBal.U,chiWSE.chiPar.chi[2].vol2.dynBal.U,chiWSE.senTem.T,chiWSE.pum.pum[1].vol.dynBal.U,chiWSE.pum.pum[2].vol.dynBal.U,cooTow[1].vol.dynBal.U,cooTow[2].vol.dynBal.U,TCHWSup.T,TCWSup.T,TCWRet.T,pumCW[1].vol.dynBal.U,pumCW[2].vol.dynBal.U,ahu.cooCoi.heaCoo.vol.dynBal.U,ahu.cooCoi.heaCooHum_u.vol.dynBal.medium.Xi[1],ahu.cooCoi.heaCooHum_u.vol.dynBal.U,ahu.cooCoi.dryWetCalcs.fullyWet.TWatOutEst,ahu.fan.vol.dynBal.medium.Xi[1],ahu.fan.vol.dynBal.U,ahu.fan.vol.dynBal.m,ahu.fan.filter.s[1],ahu.fan.filter.s[2],ahu.hum.outCon.T,ahu.hum.outCon.Xi,ahu.eleHea.hea.outCon.T,TCHWRet.T,TAirSup.T,roo.rooVol.dynBal.medium.Xi[1],roo.rooVol.dynBal.U,roo.rooVol.dynBal.m,cooTowSpeCon.conPID.I.y,pumSpe.I.y,ahuValSig.I.y,ahuFanSpeCon.I.y) * Number of discrete variables: 194 (cooModCon.con3.enableFire,chiStaCon.con3.enableFire,chiStaCon.con4.enableFire,CWPumCon.con3.enableFire,CWPumCon.con4.enableFire,varSpeCon.con3.enableFire,varSpeCon.con4.enableFire,cooModCon.con4.enableFire,chiStaCon.con2.enableFire,cooModCon.con2.enableFire,cooModCon.con1.enableFire,varSpeCon.con2.enableFire,varSpeCon.con1.enableFire,CWPumCon.con2.enableFire,CWPumCon.con1.enableFire,chiStaCon.con1.enableFire,ahu.heaCon.offToOn.enableFire,ahu.heaCon.onToOff.enableFire,sigCha.y,cooModCon.fulMecCoo.active,cooModCon.freCoo.active,cooModCon.parMecCoo.active,varSpeCon.twoOn.active,varSpeCon.off.localActive,varSpeCon.oneOn.active,CWPumCon.twoOn.active,CWPumCon.off.localActive,CWPumCon.oneOn.active,chiStaCon.twoOn.active,chiStaCon.off.localActive,chiStaCon.oneOn.active,ahu.heaCon.on.active,ahu.heaCon.off.active,$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,chiWSE.on[3],chiWSE.pum.hys[1].y,chiWSE.pum.hys[2].y,weaData.locTim.tNext,weaData.conTimMin.tNext,weaData.conTim.tNext,weaData.eqnTim.tNext,weaData.decAng.tNext,ahu.heaCon.off.localActive,ahu.heaCon.off.newActive,ahu.heaCon.off.oldActive,ahu.heaCon.on.localActive,ahu.heaCon.on.newActive,ahu.heaCon.on.oldActive,ahu.heaCon.offToOn.localCondition,ahu.heaCon.offToOn.fire,ahu.heaCon.offToOn.t_start,ahu.heaCon.onToOff.localCondition,ahu.heaCon.onToOff.fire,ahu.heaCon.onToOff.t_start,ahu.heaCon.stateGraphRoot.activeSteps,chiStaCon.con1.localCondition,chiStaCon.con1.fire,chiStaCon.con1.t_start,chiStaCon.oneOn.localActive,chiStaCon.oneOn.inPort[2].occupied,chiStaCon.oneOn.outPort[2].available,chiStaCon.oneOn.newActive,chiStaCon.oneOn.oldActive,chiStaCon.off.active,chiStaCon.off.newActive,chiStaCon.off.oldActive,chiStaCon.twoOn.localActive,chiStaCon.twoOn.newActive,chiStaCon.twoOn.oldActive,chiStaCon.con2.localCondition,chiStaCon.con2.fire,chiStaCon.con2.t_start,chiStaCon.con3.localCondition,chiStaCon.con3.fire,chiStaCon.con3.t_start,chiStaCon.con4.localCondition,chiStaCon.con4.fire,chiStaCon.con4.t_start,chiStaCon.stateGraphRoot.activeSteps,chiStaCon.booToInt.y,chiStaCon.booToInt1.y,chiStaCon.addInt.y,CWPumCon.con1.localCondition,CWPumCon.con1.fire,CWPumCon.con1.t_start,CWPumCon.oneOn.localActive,CWPumCon.oneOn.inPort[2].occupied,CWPumCon.oneOn.outPort[2].available,CWPumCon.oneOn.newActive,CWPumCon.oneOn.oldActive,CWPumCon.off.active,CWPumCon.off.newActive,CWPumCon.off.oldActive,CWPumCon.twoOn.localActive,CWPumCon.twoOn.newActive,CWPumCon.twoOn.oldActive,CWPumCon.con2.localCondition,CWPumCon.con2.fire,CWPumCon.con2.t_start,CWPumCon.con3.localCondition,CWPumCon.con3.fire,CWPumCon.con3.t_start,CWPumCon.con4.localCondition,CWPumCon.con4.fire,CWPumCon.con4.t_start,CWPumCon.stateGraphRoot.activeSteps,CWPumCon.booToInt.y,CWPumCon.booToInt1.y,CWPumCon.addInt.y,chiNumOn.y,cooTowSpeCon.pmcMod.y,cooTowSpeCon.fmcMod.y,varSpeCon.con1.localCondition,varSpeCon.con1.fire,varSpeCon.con1.t_start,varSpeCon.oneOn.localActive,varSpeCon.oneOn.inPort[2].occupied,varSpeCon.oneOn.outPort[2].available,varSpeCon.oneOn.newActive,varSpeCon.oneOn.oldActive,varSpeCon.off.active,varSpeCon.off.newActive,varSpeCon.off.oldActive,varSpeCon.twoOn.localActive,varSpeCon.twoOn.newActive,varSpeCon.twoOn.oldActive,varSpeCon.con2.localCondition,varSpeCon.con2.fire,varSpeCon.con2.t_start,varSpeCon.con3.localCondition,varSpeCon.con3.fire,varSpeCon.con3.t_start,varSpeCon.con4.localCondition,varSpeCon.con4.fire,varSpeCon.con4.t_start,varSpeCon.stateGraphRoot.activeSteps,varSpeCon.booToInt.y,varSpeCon.booToInt1.y,varSpeCon.addInt.y,swi[2].u2,chiOnSta.u[1],chiOnSta.u[2],chiOnSta.y,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) * Number of discrete states: 24 (weaData.locTim.tNext,weaData.conTim.tNext,weaData.eqnTim.tNext,weaData.decAng.tNext,weaData.conTimMin.tNext,ahu.heaCon.off.newActive,ahu.heaCon.on.newActive,chiStaCon.oneOn.newActive,chiStaCon.off.newActive,chiStaCon.twoOn.newActive,CWPumCon.oneOn.newActive,CWPumCon.off.newActive,CWPumCon.twoOn.newActive,varSpeCon.oneOn.newActive,varSpeCon.off.newActive,varSpeCon.twoOn.newActive,cooModCon.parMecCoo.newActive,cooModCon.freCoo.newActive,cooModCon.fulMecCoo.newActive,cooModCon.swi.y,sigCha.u,chiWSE.pum.hys[1].y,chiWSE.pum.hys[2].y,swiTim.y) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (1108): * Single equations (assignments): 1026 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 31 * When equations: 38 * If-equations: 0 * Equation systems (not torn): 3 * Torn equation systems: 10 * 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): 3 systems {1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(1,5,100.0%), (1,2,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 8 systems {(1,1), (1,2), (1,1), (4,28), (1,3), (1,8), (3,5), (8,39)} Notification: Performance of Backend phase and start with SimCode phase: time 0.08777/10.06, allocations: 34.77 MB / 3.793 GB, free: 1.127 GB / 2.248 GB Notification: Performance of simCode: created initialization part: time 0.08629/10.15, allocations: 36.59 MB / 3.829 GB, free: 1.115 GB / 2.248 GB Notification: Performance of simCode: created event and clocks part: time 1.765e-05/10.15, allocations: 5.812 kB / 3.829 GB, free: 1.115 GB / 2.248 GB Notification: Performance of simCode: created simulation system equations: time 0.02247/10.17, allocations: 9.769 MB / 3.839 GB, free: 1.112 GB / 2.248 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05804/10.23, allocations: 11.6 MB / 3.85 GB, free: 1.109 GB / 2.248 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4212/10.65, allocations: 210.7 MB / 4.056 GB, free: 0.9059 GB / 2.248 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0266/10.67, allocations: 13.03 MB / 4.069 GB, free: 0.8931 GB / 2.248 GB Notification: Performance of simCode: alias equations: time 0.05883/10.73, allocations: 7.857 MB / 4.076 GB, free: 0.8855 GB / 2.248 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.03168/10.76, allocations: 11.21 MB / 4.087 GB, free: 0.8746 GB / 2.248 GB Notification: Performance of SimCode: time 1.042e-06/10.76, allocations: 0 / 4.087 GB, free: 0.8746 GB / 2.248 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.8686/11.63, allocations: 0.6537 GB / 4.741 GB, free: 228.4 MB / 2.248 GB Notification: Performance of buildModelFMU: Generate platform static: time 180.7/192.3, allocations: 3.75 kB / 4.741 GB, free: 228.4 MB / 2.248 GB " [Timeout remaining time 107] (rm -f Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer.pipe ; mkfifo Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer.pipe ; head -c 1048576 < Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer.pipe >> ../files/Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer.sim & python3 -m fmpy simulate --output-file Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer_res.csv --start-time 0 --stop-time 86400 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 34.56 Buildings_11_Buildings_Applications_DataCenters_ChillerCooled_Examples_IntegratedPrimaryLoadSideEconomizer.fmu > Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Examples.IntegratedPrimaryLoadSideEconomizer.pipe 2>&1) [Timeout 420.0] [Calling os._exit(0), Time elapsed: 199.43189393612556] Failed to read output from testmodel.py, exit status != 0: 192.92563309404068 192.934678382 188.164097255 Calling exit ...