Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.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.001874/0.001874, allocations: 95.64 kB / 18.95 MB, free: 2.691 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.002678/0.002678, allocations: 213.6 kB / 22.24 MB, free: 5.238 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.503/1.503, allocations: 230.6 MB / 256 MB, free: 7.801 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.803/2.803, allocations: 476 MB / 0.7699 GB, free: 4.754 MB / 0.6231 GB
"
[Timeout remaining time 176]
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.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop,fileNamePrefix="Buildings_11_Buildings_Applications_DataCenters_ChillerCooled_Equipment_Validation_CoolingCoilHumidifyingHeating_ClosedLoop",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop,fileNamePrefix="Buildings_11_Buildings_Applications_DataCenters_ChillerCooled_Equipment_Validation_CoolingCoilHumidifyingHeating_ClosedLoop",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.002131/0.002131, allocations: 69.02 kB / 1.117 GB, free: 41.11 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4298/0.4319, allocations: 170 MB / 1.283 GB, free: 12.41 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop): time 1.458/1.89, allocations: 368.1 MB / 1.642 GB, free: 61.22 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 0.05972/1.949, allocations: 36.52 MB / 1.678 GB, free: 60.99 MB / 1.295 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01244/1.962, allocations: 252.6 kB / 1.678 GB, free: 60.99 MB / 1.295 GB
Notification: Performance of NFTyping.typeComponents: time 0.01348/1.975, allocations: 3.668 MB / 1.682 GB, free: 60.92 MB / 1.295 GB
Notification: Performance of NFTyping.typeBindings: time 0.03382/2.009, allocations: 10.39 MB / 1.692 GB, free: 60.52 MB / 1.295 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01599/2.025, allocations: 5.397 MB / 1.697 GB, free: 60.39 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.03674/2.062, allocations: 20.36 MB / 1.717 GB, free: 59.27 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.009491/2.071, allocations: 4.057 MB / 1.721 GB, free: 57.27 MB / 1.295 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02032/2.092, allocations: 6.867 MB / 1.728 GB, free: 55.12 MB / 1.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01112/2.103, allocations: 4.228 MB / 1.732 GB, free: 53.78 MB / 1.295 GB
Notification: Performance of NFPackage.collectConstants: time 0.003223/2.106, allocations: 0.7254 MB / 1.732 GB, free: 53.78 MB / 1.295 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02166/2.128, allocations: 7.381 MB / 1.74 GB, free: 52.56 MB / 1.295 GB
Notification: Performance of NFScalarize.scalarize: time 0.004356/2.132, allocations: 2.154 MB / 1.742 GB, free: 51.18 MB / 1.295 GB
Notification: Performance of NFVerifyModel.verify: time 0.008992/2.141, allocations: 2.934 MB / 1.745 GB, free: 49.44 MB / 1.295 GB
Notification: Performance of NFConvertDAE.convert: time 0.02793/2.169, allocations: 13.98 MB / 1.758 GB, free: 40.46 MB / 1.295 GB
Notification: Performance of FrontEnd - DAE generated: time 6.943e-06/2.169, allocations: 4 kB / 1.758 GB, free: 40.46 MB / 1.295 GB
Notification: Performance of FrontEnd: time 2.545e-06/2.169, allocations: 0 / 1.758 GB, free: 40.46 MB / 1.295 GB
Notification: Performance of Transformations before backend: time 0.0003987/2.169, allocations: 0 / 1.758 GB, free: 40.46 MB / 1.295 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 972
 * Number of variables: 972
Notification: Performance of Generate backend data structure: time 0.02625/2.196, allocations: 7.805 MB / 1.766 GB, free: 35.03 MB / 1.295 GB
Notification: Performance of prepare preOptimizeDAE: time 6.158e-05/2.196, allocations: 15.25 kB / 1.766 GB, free: 35.03 MB / 1.295 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001396/2.197, allocations: 0.5044 MB / 1.766 GB, free: 34.64 MB / 1.295 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02102/2.218, allocations: 3.06 MB / 1.769 GB, free: 33.31 MB / 1.295 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01981/2.238, allocations: 8.801 MB / 1.778 GB, free: 26.36 MB / 1.295 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000308/2.238, allocations: 310.1 kB / 1.778 GB, free: 26.05 MB / 1.295 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001744/2.24, allocations: 414.3 kB / 1.779 GB, free: 25.66 MB / 1.295 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01391/2.254, allocations: 6.079 MB / 1.785 GB, free: 19.43 MB / 1.295 GB
Notification: Performance of preOpt findStateOrder (simulation): time 9.624e-05/2.254, allocations: 0 / 1.785 GB, free: 19.43 MB / 1.295 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004969/2.254, allocations: 156.1 kB / 1.785 GB, free: 19.28 MB / 1.295 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001461/2.255, allocations: 174.7 kB / 1.785 GB, free: 19.11 MB / 1.295 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01627/2.271, allocations: 6.14 MB / 1.791 GB, free: 12.98 MB / 1.295 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.04279/2.314, allocations: 17.9 MB / 1.808 GB, free: 11.39 MB / 1.311 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01169/2.325, allocations: 3.794 MB / 1.812 GB, free: 7.59 MB / 1.311 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007366/2.333, allocations: 2.475 MB / 1.814 GB, free: 5.117 MB / 1.311 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt evalFunc (simulation): time 0.02253/2.355, allocations: 7.228 MB / 1.822 GB, free: 13.95 MB / 1.326 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007616/2.363, allocations: 3.069 MB / 1.825 GB, free: 10.75 MB / 1.326 GB
Notification: Performance of pre-optimization done (n=310): time 6.853e-06/2.363, allocations: 4 kB / 1.825 GB, free: 10.75 MB / 1.326 GB
Notification: Performance of matching and sorting (n=315): time 0.04256/2.405, allocations: 13.02 MB / 1.837 GB, free: 13.63 MB / 1.342 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000107/2.406, allocations: 111.6 kB / 1.837 GB, free: 13.5 MB / 1.342 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008826/2.414, allocations: 4.518 MB / 1.842 GB, free: 8.996 MB / 1.342 GB
Notification: Performance of collectPreVariables (initialization): time 0.00111/2.415, allocations: 105.7 kB / 1.842 GB, free: 8.887 MB / 1.342 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002923/2.418, allocations: 2.294 MB / 1.844 GB, free: 6.598 MB / 1.342 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002288/2.421, allocations: 1.116 MB / 1.845 GB, free: 5.496 MB / 1.342 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002091/2.423, allocations: 0.923 MB / 1.846 GB, free: 4.562 MB / 1.342 GB
Notification: Performance of setup shared object (initialization): time 0.0001742/2.423, allocations: 305.1 kB / 1.846 GB, free: 4.262 MB / 1.342 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007184/2.43, allocations: 2.673 MB / 1.849 GB, free: 1.566 MB / 1.342 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008891/2.439, allocations: 4.286 MB / 1.853 GB, free: 12.79 MB / 1.357 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.4791/2.918, allocations: 79.45 MB / 1.931 GB, free: 13.47 MB / 1.436 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.831e-05/2.918, allocations: 4 kB / 1.931 GB, free: 13.47 MB / 1.436 GB
Notification: Performance of matching and sorting (n=546) (initialization): time 0.02133/2.94, allocations: 7.271 MB / 1.938 GB, free: 6.266 MB / 1.436 GB
Notification: Performance of prepare postOptimizeDAE: time 4.69e-05/2.94, allocations: 15.98 kB / 1.938 GB, free: 6.25 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.906e-05/2.94, allocations: 16 kB / 1.938 GB, free: 6.234 MB / 1.436 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001759/2.941, allocations: 489 kB / 1.938 GB, free: 5.742 MB / 1.436 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007317/2.949, allocations: 1.167 MB / 1.94 GB, free: 4.625 MB / 1.436 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009775/2.958, allocations: 9.192 MB / 1.949 GB, free: 10.9 MB / 1.451 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007793/2.966, allocations: 417.2 kB / 1.949 GB, free: 10.49 MB / 1.451 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001286/2.968, allocations: 207.9 kB / 1.949 GB, free: 10.29 MB / 1.451 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.0106/2.978, allocations: 3.7 MB / 1.953 GB, free: 6.578 MB / 1.451 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00869/2.987, allocations: 4.178 MB / 1.957 GB, free: 1.906 MB / 1.451 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.4699/3.457, allocations: 78.91 MB / 2.034 GB, free: 3.051 MB / 1.529 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.732e-05/3.457, allocations: 4 kB / 2.034 GB, free: 3.047 MB / 1.529 GB
Notification: Performance of matching and sorting (n=546) (initialization_lambda0): time 0.02173/3.478, allocations: 7.033 MB / 2.041 GB, free: 12.08 MB / 1.545 GB
Notification: Performance of prepare postOptimizeDAE: time 3.865e-05/3.479, allocations: 15.94 kB / 2.041 GB, free: 12.07 MB / 1.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.116e-05/3.479, allocations: 19.94 kB / 2.041 GB, free: 12.05 MB / 1.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001642/3.48, allocations: 477.1 kB / 2.041 GB, free: 11.56 MB / 1.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007119/3.487, allocations: 1.143 MB / 2.042 GB, free: 10.47 MB / 1.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01367/3.501, allocations: 11.78 MB / 2.054 GB, free: 13.95 MB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00823/3.509, allocations: 428.2 kB / 2.054 GB, free: 13.54 MB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001153/3.51, allocations: 195.8 kB / 2.054 GB, free: 13.34 MB / 1.561 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: 72
 * Number of states: 0 ()
 * Number of discrete variables: 39 (ahu.cooCoi.UAFroRated.isFulWet,ahu.cooCoi.UAFroRated.isFulDry,$PRE.ahu.heaCon.offToOn.enableFire,$PRE.ahu.heaCon.onToOff.enableFire,ahu.heaCon.stateGraphRoot.resume,ahu.heaCon.stateGraphRoot.suspend,ahu.cooCoi.flowRegime_nominal,ahu.cooCoi.dryWetCalcs.fullyDry.cfg,ahu.cooCoi.dryWetCalcs.fullyWet.cfg,ahu.cooCoi.dryWetCalcs.cfg,ahu.cooCoi.flowRegime,$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,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,$whenCondition1,$whenCondition2,PID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (488):
 * Single equations (assignments): 475
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 7
 * 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
   {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,6,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 5 systems
   {(1,1), (1,3), (1,2), (1,3), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.001413/3.512, allocations: 447.9 kB / 2.055 GB, free: 12.95 MB / 1.561 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001818/3.514, allocations: 0.5239 MB / 2.055 GB, free: 12.43 MB / 1.561 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0175/3.531, allocations: 5.803 MB / 2.061 GB, free: 6.598 MB / 1.561 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.707e-05/3.531, allocations: 35.94 kB / 2.061 GB, free: 6.562 MB / 1.561 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.224e-05/3.531, allocations: 4 kB / 2.061 GB, free: 6.559 MB / 1.561 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01476/3.546, allocations: 4.762 MB / 2.066 GB, free: 1.75 MB / 1.561 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02949/3.575, allocations: 10.99 MB / 2.076 GB, free: 6.738 MB / 1.576 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.107e-05/3.575, allocations: 8 kB / 2.076 GB, free: 6.73 MB / 1.576 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004782/3.58, allocations: 0.7719 MB / 2.077 GB, free: 5.988 MB / 1.576 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001294/3.581, allocations: 358.8 kB / 2.078 GB, free: 5.625 MB / 1.576 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003476/3.582, allocations: 99.91 kB / 2.078 GB, free: 5.527 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007569/3.589, allocations: 7.238 MB / 2.085 GB, free: 13.88 MB / 1.592 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.598e-06/3.589, allocations: 4 kB / 2.085 GB, free: 13.88 MB / 1.592 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02483/3.614, allocations: 8.452 MB / 2.093 GB, free: 5.301 MB / 1.592 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003876/3.618, allocations: 1.09 MB / 2.094 GB, free: 4.203 MB / 1.592 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001317/3.619, allocations: 60 kB / 2.094 GB, free: 4.145 MB / 1.592 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004959/3.624, allocations: 324.4 kB / 2.094 GB, free: 3.828 MB / 1.592 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005693/3.625, allocations: 237.1 kB / 2.095 GB, free: 3.598 MB / 1.592 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003798/3.625, allocations: 127.9 kB / 2.095 GB, free: 3.473 MB / 1.592 GB
Notification: Performance of sorting global known variables: time 0.006599/3.632, allocations: 2.994 MB / 2.098 GB, free: 0.4961 MB / 1.592 GB
Notification: Performance of sort global known variables: time 3.9e-07/3.632, allocations: 0 / 2.098 GB, free: 0.4961 MB / 1.592 GB
Notification: Performance of remove unused functions: time 0.01291/3.645, allocations: 2.643 MB / 2.1 GB, free: 13.86 MB / 1.607 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 14
 * Number of states: 17 (masFra.X,temSenWat1.T,temSenAir2.T,temSenWat2.T,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,PID.I.y)
 * Number of discrete variables: 19 (ahu.heaCon.offToOn.enableFire,ahu.heaCon.onToOff.enableFire,ahu.heaCon.on.active,ahu.heaCon.off.active,$whenCondition2,$whenCondition1,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)
 * Number of discrete states: 2 (ahu.heaCon.off.newActive,ahu.heaCon.on.newActive)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (313):
 * Single equations (assignments): 296
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 4
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 6
 * 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
   {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,6,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(1,5), (1,2), (1,1), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02656/3.671, allocations: 9.962 MB / 2.11 GB, free: 3.867 MB / 1.607 GB
Notification: Performance of simCode: created initialization part: time 0.02992/3.701, allocations: 9.928 MB / 2.12 GB, free: 9.988 MB / 1.623 GB
Notification: Performance of simCode: created event and clocks part: time 1.544e-05/3.701, allocations: 5.375 kB / 2.12 GB, free: 9.984 MB / 1.623 GB
Notification: Performance of simCode: created simulation system equations: time 0.008287/3.71, allocations: 2.88 MB / 2.123 GB, free: 7.129 MB / 1.623 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01429/3.724, allocations: 2.594 MB / 2.125 GB, free: 4.605 MB / 1.623 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1125/3.836, allocations: 44.14 MB / 2.168 GB, free: 7.809 MB / 1.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003408/3.84, allocations: 2.485 MB / 2.171 GB, free: 5.281 MB / 1.67 GB
Notification: Performance of simCode: alias equations: time 0.008704/3.849, allocations: 1.582 MB / 2.172 GB, free: 3.727 MB / 1.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005376/3.854, allocations: 2.401 MB / 2.174 GB, free: 1.324 MB / 1.67 GB
Notification: Performance of SimCode: time 1.513e-06/3.854, allocations: 0 / 2.174 GB, free: 1.324 MB / 1.67 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.079/4.932, allocations: 164.5 MB / 2.335 GB, free: 0.6877 GB / 1.748 GB
Notification: Performance of buildModelFMU: Generate platform static: time 23.6/28.54, allocations: 3.375 kB / 2.335 GB, free: 0.6877 GB / 1.748 GB
"
[Timeout remaining time 271]
(rm -f Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.pipe ; mkfifo Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.pipe ; head -c 1048576 < Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.pipe >> ../files/Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.sim & python3 -m fmpy simulate  --output-file Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop_res.csv --start-time 0 --stop-time 2400 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.96 Buildings_11_Buildings_Applications_DataCenters_ChillerCooled_Equipment_Validation_CoolingCoilHumidifyingHeating_ClosedLoop.fmu > Buildings_11_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 35.804940616711974]
Failed to read output from testmodel.py, exit status != 0:
29.474779463373125 28.798510503 26.6259907
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe54fbf2fb0>