Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 9.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.844/4.844, allocations: 0.5623 GB / 0.5775 GB, free: 66.95 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002635/0.002635, allocations: 363.2 kB / 0.6446 GB, free: 21.38 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.13/4.13, allocations: 410.7 MB / 1.113 GB, free: 109.6 MB / 0.5573 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001838/0.001838, allocations: 184.7 kB / 1.226 GB, free: 9.508 MB / 0.573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0005082/0.0005084, allocations: 12 kB / 1.349 GB, free: 84.62 MB / 0.573 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.218/0.2185, allocations: 115.3 MB / 1.461 GB, free: 1.262 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.CoolingCoilHumidifyingHeating_ClosedLoop): time 2.118/2.337, allocations: 377.6 MB / 1.83 GB, free: 69.89 MB / 0.9167 GB
Notification: Performance of NFInst.instExpressions: time 0.08224/2.419, allocations: 40.82 MB / 1.87 GB, free: 69.51 MB / 0.9167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009792/2.429, allocations: 173.5 kB / 1.87 GB, free: 69.51 MB / 0.9167 GB
Notification: Performance of NFTyping.typeComponents: time 0.01289/2.442, allocations: 2.133 MB / 1.872 GB, free: 69.5 MB / 0.9167 GB
Notification: Performance of NFTyping.typeBindings: time 0.0389/2.481, allocations: 7.428 MB / 1.879 GB, free: 69.42 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02715/2.508, allocations: 5.186 MB / 1.885 GB, free: 69.31 MB / 0.9167 GB
Notification: Performance of NFFlatten.flatten: time 0.04394/2.552, allocations: 28.08 MB / 1.912 GB, free: 67.83 MB / 0.9167 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01946/2.572, allocations: 7.625 MB / 1.919 GB, free: 65.34 MB / 0.9167 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02361/2.595, allocations: 7.653 MB / 1.927 GB, free: 64.25 MB / 0.9167 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01762/2.613, allocations: 6.467 MB / 1.933 GB, free: 61.9 MB / 0.9167 GB
Notification: Performance of NFPackage.collectConstants: time 0.003316/2.616, allocations: 382.6 kB / 1.934 GB, free: 61.9 MB / 0.9167 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01891/2.635, allocations: 3.88 MB / 1.937 GB, free: 60.85 MB / 0.9167 GB
Notification: Performance of NFScalarize.scalarize: time 0.005755/2.641, allocations: 2.337 MB / 1.94 GB, free: 59.8 MB / 0.9167 GB
Notification: Performance of NFVerifyModel.verify: time 0.006355/2.648, allocations: 2.258 MB / 1.942 GB, free: 58.93 MB / 0.9167 GB
Notification: Performance of NFConvertDAE.convert: time 0.02834/2.676, allocations: 18.08 MB / 1.96 GB, free: 43.39 MB / 0.9167 GB
Notification: Performance of FrontEnd - DAE generated: time 7.885e-06/2.676, allocations: 4 kB / 1.96 GB, free: 43.39 MB / 0.9167 GB
Notification: Performance of FrontEnd: time 2.966e-06/2.676, allocations: 0 / 1.96 GB, free: 43.39 MB / 0.9167 GB
Notification: Performance of Transformations before backend: time 0.0005736/2.677, allocations: 0 / 1.96 GB, free: 43.39 MB / 0.9167 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1696
 * Number of variables: 1696
Notification: Performance of Generate backend data structure: time 0.0384/2.715, allocations: 9.505 MB / 1.969 GB, free: 34.69 MB / 0.9167 GB
Notification: Performance of prepare preOptimizeDAE: time 5.209e-05/2.715, allocations: 8.031 kB / 1.969 GB, free: 34.68 MB / 0.9167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02164/2.737, allocations: 2.358 MB / 1.971 GB, free: 32.42 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02721/2.764, allocations: 9.825 MB / 1.981 GB, free: 26.47 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007095/2.765, allocations: 0.5231 MB / 1.981 GB, free: 26.17 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003165/2.768, allocations: 0.6748 MB / 1.982 GB, free: 25.71 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03407/2.802, allocations: 9.815 MB / 1.991 GB, free: 19.11 MB / 0.9167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004095/2.802, allocations: 11.84 kB / 1.991 GB, free: 19.1 MB / 0.9167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002612/2.805, allocations: 272.8 kB / 1.992 GB, free: 19.04 MB / 0.9167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004326/2.806, allocations: 325.9 kB / 1.992 GB, free: 18.74 MB / 0.9167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03226/2.838, allocations: 9.12 MB / 2.001 GB, free: 12.92 MB / 0.9167 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.09393/2.932, allocations: 40.75 MB / 2.041 GB, free: 13.59 MB / 0.948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01652/2.948, allocations: 6.04 MB / 2.047 GB, free: 9.645 MB / 0.948 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01086/2.959, allocations: 3.655 MB / 2.05 GB, free: 7.34 MB / 0.948 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003843/2.963, allocations: 1.966 MB / 2.052 GB, free: 5.035 MB / 0.948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01056/2.974, allocations: 3.187 MB / 2.055 GB, free: 2.918 MB / 0.948 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004809/2.979, allocations: 377.3 kB / 2.056 GB, free: 2.613 MB / 0.948 GB
Notification: Performance of pre-optimization done (n=456): time 2.208e-05/2.979, allocations: 0 / 2.056 GB, free: 2.613 MB / 0.948 GB
Notification: Performance of matching and sorting (n=464): time 0.07596/3.055, allocations: 17.45 MB / 2.073 GB, free: 2.328 MB / 0.9636 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001119/3.055, allocations: 132.7 kB / 2.073 GB, free: 2.18 MB / 0.9636 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01749/3.072, allocations: 6.851 MB / 2.079 GB, free: 11.36 MB / 0.9792 GB
Notification: Performance of collectPreVariables (initialization): time 0.001351/3.074, allocations: 133.7 kB / 2.08 GB, free: 11.22 MB / 0.9792 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006164/3.08, allocations: 3.734 MB / 2.083 GB, free: 7.477 MB / 0.9792 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003072/3.083, allocations: 1.6 MB / 2.085 GB, free: 5.891 MB / 0.9792 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006036/3.084, allocations: 101.9 kB / 2.085 GB, free: 5.793 MB / 0.9792 GB
Notification: Performance of setup shared object (initialization): time 0.0004848/3.084, allocations: 0.5052 MB / 2.085 GB, free: 5.281 MB / 0.9792 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009264/3.093, allocations: 2.817 MB / 2.088 GB, free: 2.457 MB / 0.9792 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01116/3.105, allocations: 4.136 MB / 2.092 GB, free: 13.84 MB / 0.9948 GB
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.ele[1].vol2.dynBal.medium.p = ahu.cooCoi.ele[1].vol2.dynBal.p_start (ahu.fan.vol.dynBal.p_start = ahu.cooCoi.ele[1].vol2.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.9207/4.025, allocations: 72.14 MB / 2.163 GB, free: 5.863 MB / 1.057 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.692e-05/4.025, allocations: 4 kB / 2.163 GB, free: 5.859 MB / 1.057 GB
Notification: Performance of matching and sorting (n=664) (initialization): time 0.02938/4.055, allocations: 8.044 MB / 2.17 GB, free: 13.7 MB / 1.073 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000729/4.056, allocations: 0.8122 MB / 2.171 GB, free: 12.54 MB / 1.073 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.152e-05/4.056, allocations: 24 kB / 2.171 GB, free: 12.52 MB / 1.073 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001927/4.058, allocations: 363.1 kB / 2.172 GB, free: 12.15 MB / 1.073 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01099/4.069, allocations: 1.147 MB / 2.173 GB, free: 11 MB / 1.073 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008465/4.077, allocations: 5.992 MB / 2.179 GB, free: 4.68 MB / 1.073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01294/4.09, allocations: 0.7731 MB / 2.179 GB, free: 3.906 MB / 1.073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001506/4.092, allocations: 221.6 kB / 2.18 GB, free: 3.691 MB / 1.073 GB
Notification: Performance of prepare postOptimizeDAE: time 1.346e-05/4.092, allocations: 4 kB / 2.18 GB, free: 3.688 MB / 1.073 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0259/4.118, allocations: 7.388 MB / 2.187 GB, free: 12.19 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.854e-05/4.118, allocations: 24 kB / 2.187 GB, free: 12.17 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001534/4.119, allocations: 363.6 kB / 2.187 GB, free: 11.8 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01057/4.13, allocations: 1.131 MB / 2.188 GB, free: 10.67 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0145/4.144, allocations: 8.418 MB / 2.196 GB, free: 1.648 MB / 1.089 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01242/4.157, allocations: 0.76 MB / 2.197 GB, free: 0.8945 MB / 1.089 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001488/4.158, allocations: 219.9 kB / 2.197 GB, free: 0.6797 MB / 1.089 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem:
         ahu.cooCoi.ele[1].vol2.dynBal.medium.p = ahu.cooCoi.ele[1].vol2.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 106
 * Number of states: 0 ()
 * Number of discrete variables: 32 ($PRE.ahu.heaCon.offToOn.enableFire,$PRE.ahu.heaCon.onToOff.enableFire,ahu.heaCon.stateGraphRoot.resume,ahu.heaCon.stateGraphRoot.suspend,$whenCondition2,$whenCondition1,$PRE.ahu.heaCon.off.localActive,ahu.heaCon.off.localActive,$PRE.ahu.heaCon.off.newActive,ahu.heaCon.off.newActive,$PRE.ahu.heaCon.off.oldActive,ahu.heaCon.off.oldActive,ahu.heaCon.off.active,$PRE.ahu.heaCon.on.localActive,ahu.heaCon.on.localActive,$PRE.ahu.heaCon.on.newActive,ahu.heaCon.on.newActive,$PRE.ahu.heaCon.on.oldActive,ahu.heaCon.on.oldActive,ahu.heaCon.on.active,ahu.heaCon.offToOn.condition,ahu.heaCon.offToOn.enableFire,ahu.heaCon.offToOn.fire,$PRE.ahu.heaCon.offToOn.t_start,ahu.heaCon.offToOn.t_start,ahu.heaCon.onToOff.condition,ahu.heaCon.onToOff.enableFire,ahu.heaCon.onToOff.fire,$PRE.ahu.heaCon.onToOff.t_start,ahu.heaCon.onToOff.t_start,ahu.heaCon.stateGraphRoot.activeSteps,PID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (634):
 * Single equations (assignments): 622
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(1,100.0%) 12,(1,100.0%) 2}
 * Non-linear torn systems: 2 {1 3,1 4}
Notification: Performance of prepare postOptimizeDAE: time 0.01004/4.169, allocations: 3.216 MB / 2.201 GB, free: 13.46 MB / 1.104 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002585/4.171, allocations: 0.7101 MB / 2.201 GB, free: 12.74 MB / 1.104 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02718/4.198, allocations: 7.263 MB / 2.208 GB, free: 5.445 MB / 1.104 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.35/5.548, allocations: 6.023 MB / 2.214 GB, free: 469.3 MB / 1.104 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.616e-05/5.548, allocations: 1.609 kB / 2.214 GB, free: 469.3 MB / 1.104 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009186/5.558, allocations: 1.619 MB / 2.216 GB, free: 469.2 MB / 1.104 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004023/5.562, allocations: 103.7 kB / 2.216 GB, free: 469.2 MB / 1.104 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01515/5.577, allocations: 0.582 MB / 2.217 GB, free: 469.2 MB / 1.104 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002247/5.579, allocations: 305.9 kB / 2.217 GB, free: 469.2 MB / 1.104 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.04588/5.625, allocations: 7.146 MB / 2.224 GB, free: 468.5 MB / 1.104 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.04878/5.674, allocations: 10.77 MB / 2.234 GB, free: 464.3 MB / 1.104 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01309/5.687, allocations: 3.053 MB / 2.237 GB, free: 463 MB / 1.104 GB
Notification: Performance of sorting global known variables: time 0.02038/5.708, allocations: 4.771 MB / 2.242 GB, free: 461.3 MB / 1.104 GB
Notification: Performance of Backend: time 2.224e-06/5.708, allocations: 0 / 2.242 GB, free: 461.3 MB / 1.104 GB
Notification: Performance of simCode: created initialization part: time 0.05424/5.762, allocations: 10.5 MB / 2.252 GB, free: 457.4 MB / 1.104 GB
Notification: Performance of SimCode: time 0.0899/5.852, allocations: 22.88 MB / 2.275 GB, free: 446.3 MB / 1.104 GB
Notification: Performance of Templates: time 0.4218/6.274, allocations: 191.4 MB / 2.461 GB, free: 268.6 MB / 1.104 GB