Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables.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.0008061/0.0008061, allocations: 109.5 kB / 18.95 MB, free: 1.184 MB / 13.93 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.0008778/0.0008778, allocations: 220 kB / 22.25 MB, free: 3.574 MB / 13.93 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 0.9791/0.9791, allocations: 230.6 MB / 256 MB, free: 9.621 MB / 202.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 2.393/2.393, allocations: 0.5556 GB / 0.8607 GB, free: 30.79 MB / 0.6667 GB
"
[Timeout remaining time 177]
Using package Buildings with version 14.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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.Examples.ChillerPlant.DataCenter.Renewables,fileNamePrefix="Buildings_latest_Buildings_Examples_ChillerPlant_DataCenter_Renewables",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Examples.ChillerPlant.DataCenter.Renewables,fileNamePrefix="Buildings_latest_Buildings_Examples_ChillerPlant_DataCenter_Renewables",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.0015/0.0015, allocations: 71.56 kB / 1.253 GB, free: 22.55 MB / 0.9636 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3585/0.36, allocations: 193.3 MB / 1.442 GB, free: 10.85 MB / 1.12 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.ChillerPlant.DataCenter.Renewables): time 1.148/1.508, allocations: 439.9 MB / 1.871 GB, free: 18.19 MB / 1.385 GB
Notification: Performance of NFInst.instExpressions: time 0.08855/1.597, allocations: 78.89 MB / 1.948 GB, free: 13.54 MB / 1.432 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02252/1.619, allocations: 0.5562 MB / 1.949 GB, free: 13.28 MB / 1.432 GB
Notification: Performance of NFTyping.typeComponents: time 0.02033/1.639, allocations: 7.531 MB / 1.956 GB, free: 7.449 MB / 1.432 GB
Notification: Performance of NFTyping.typeBindings: time 0.04117/1.681, allocations: 16.47 MB / 1.972 GB, free: 9.902 MB / 1.448 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02851/1.709, allocations: 13.01 MB / 1.985 GB, free: 12.95 MB / 1.464 GB
Notification: Performance of NFFlatten.flatten: time 0.05601/1.765, allocations: 51.73 MB / 2.036 GB, free: 9.113 MB / 1.51 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04249/1.808, allocations: 23.7 MB / 2.059 GB, free: 1.234 MB / 1.526 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03616/1.844, allocations: 18.26 MB / 2.077 GB, free: 14.95 MB / 1.557 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02229/1.866, allocations: 12.85 MB / 2.089 GB, free: 2.066 MB / 1.557 GB
Notification: Performance of NFPackage.collectConstants: time 0.007312/1.873, allocations: 2.254 MB / 2.091 GB, free: 15.81 MB / 1.573 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02346/1.897, allocations: 9.78 MB / 2.101 GB, free: 6.016 MB / 1.573 GB
Notification: Performance of NFScalarize.scalarize: time 0.01066/1.907, allocations: 6.122 MB / 2.107 GB, free: 15.88 MB / 1.589 GB
Notification: Performance of NFVerifyModel.verify: time 0.01866/1.926, allocations: 8.659 MB / 2.115 GB, free: 7.18 MB / 1.589 GB
Notification: Performance of NFConvertDAE.convert: time 0.0529/1.979, allocations: 37.99 MB / 2.152 GB, free: 1.059 MB / 1.62 GB
Notification: Performance of FrontEnd - DAE generated: time 7.003e-06/1.979, allocations: 0 / 2.152 GB, free: 1.059 MB / 1.62 GB
Notification: Performance of FrontEnd: time 2.745e-06/1.979, allocations: 0 / 2.152 GB, free: 1.059 MB / 1.62 GB
Notification: Performance of Transformations before backend: time 0.001136/1.98, allocations: 0 / 2.152 GB, free: 1.059 MB / 1.62 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2820
 * Number of variables: 2820
Notification: Performance of Generate backend data structure: time 0.05051/2.031, allocations: 20.84 MB / 2.173 GB, free: 11.99 MB / 1.651 GB
Notification: Performance of prepare preOptimizeDAE: time 5.881e-05/2.031, allocations: 12.03 kB / 2.173 GB, free: 11.98 MB / 1.651 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.005186/2.036, allocations: 1.444 MB / 2.174 GB, free: 10.53 MB / 1.651 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0273/2.063, allocations: 6.591 MB / 2.181 GB, free: 3.918 MB / 1.651 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03673/2.1, allocations: 20.14 MB / 2.2 GB, free: 15.66 MB / 1.682 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00115/2.101, allocations: 1.038 MB / 2.201 GB, free: 14.59 MB / 1.682 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005023/2.106, allocations: 1.18 MB / 2.202 GB, free: 13.41 MB / 1.682 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04128/2.147, allocations: 18.62 MB / 2.221 GB, free: 9.938 MB / 1.698 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003557/2.148, allocations: 19.88 kB / 2.221 GB, free: 9.918 MB / 1.698 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0035/2.151, allocations: 468 kB / 2.221 GB, free: 9.461 MB / 1.698 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004107/2.152, allocations: 0.4891 MB / 2.222 GB, free: 8.969 MB / 1.698 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03738/2.189, allocations: 16.69 MB / 2.238 GB, free: 8.254 MB / 1.714 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.1053/2.294, allocations: 55.92 MB / 2.292 GB, free: 14.7 MB / 1.776 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02062/2.315, allocations: 11.23 MB / 2.303 GB, free: 3.586 MB / 1.776 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01206/2.327, allocations: 6.093 MB / 2.309 GB, free: 13.46 MB / 1.792 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.04159/2.369, allocations: 17.95 MB / 2.327 GB, free: 10.86 MB / 1.807 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01384/2.382, allocations: 8.124 MB / 2.335 GB, free: 2.285 MB / 1.807 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006278/2.389, allocations: 1.045 MB / 2.336 GB, free: 1.234 MB / 1.807 GB
Notification: Performance of pre-optimization done (n=750): time 2.537e-05/2.389, allocations: 0 / 2.336 GB, free: 1.234 MB / 1.807 GB
Notification: Performance of matching and sorting (n=853): time 0.1973/2.586, allocations: 75.09 MB / 2.409 GB, free: 5.898 MB / 1.885 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001884/2.586, allocations: 401.3 kB / 2.41 GB, free: 5.438 MB / 1.885 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02527/2.612, allocations: 14.58 MB / 2.424 GB, free: 6.941 MB / 1.901 GB
Notification: Performance of collectPreVariables (initialization): time 0.002297/2.614, allocations: 265.7 kB / 2.424 GB, free: 6.676 MB / 1.901 GB
Notification: Performance of collectInitialEqns (initialization): time 0.009585/2.623, allocations: 7.268 MB / 2.431 GB, free: 15.37 MB / 1.917 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004478/2.628, allocations: 2.983 MB / 2.434 GB, free: 12.36 MB / 1.917 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.005786/2.634, allocations: 2.616 MB / 2.437 GB, free: 9.734 MB / 1.917 GB
Notification: Performance of setup shared object (initialization): time 7.387e-05/2.634, allocations: 301.1 kB / 2.437 GB, free: 9.438 MB / 1.917 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01695/2.651, allocations: 8.661 MB / 2.445 GB, free: 0.7578 MB / 1.917 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 1.443/4.093, allocations: 13.47 MB / 2.458 GB, free: 0.7238 GB / 1.917 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03543/4.129, allocations: 19.34 MB / 2.477 GB, free: 0.7151 GB / 1.917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001992/4.129, allocations: 27.25 kB / 2.477 GB, free: 0.7151 GB / 1.917 GB
Notification: Performance of matching and sorting (n=1593) (initialization): time 0.04928/4.178, allocations: 22.41 MB / 2.499 GB, free: 0.7082 GB / 1.917 GB
Notification: Performance of prepare postOptimizeDAE: time 7.8e-05/4.178, allocations: 39.97 kB / 2.499 GB, free: 0.7082 GB / 1.917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001177/4.178, allocations: 87.48 kB / 2.499 GB, free: 0.7082 GB / 1.917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002257/4.181, allocations: 0.8864 MB / 2.5 GB, free: 0.708 GB / 1.917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01154/4.192, allocations: 3.512 MB / 2.504 GB, free: 0.7077 GB / 1.917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005128/4.197, allocations: 11.12 MB / 2.515 GB, free: 0.698 GB / 1.917 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01495/4.212, allocations: 1.641 MB / 2.516 GB, free: 0.6979 GB / 1.917 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003294/4.216, allocations: 0.5533 MB / 2.517 GB, free: 0.6978 GB / 1.917 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02413/4.24, allocations: 13 MB / 2.529 GB, free: 0.6929 GB / 1.917 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0181/4.258, allocations: 13.41 MB / 2.542 GB, free: 0.6804 GB / 1.917 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02981/4.288, allocations: 19.21 MB / 2.561 GB, free: 0.6623 GB / 1.917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.688e-05/4.288, allocations: 24 kB / 2.561 GB, free: 0.6623 GB / 1.917 GB
Notification: Performance of matching and sorting (n=1593) (initialization_lambda0): time 0.04049/4.328, allocations: 22.19 MB / 2.583 GB, free: 0.6424 GB / 1.917 GB
Notification: Performance of prepare postOptimizeDAE: time 5.488e-05/4.328, allocations: 40 kB / 2.583 GB, free: 0.6424 GB / 1.917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.683e-05/4.328, allocations: 88.72 kB / 2.583 GB, free: 0.6423 GB / 1.917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001583/4.33, allocations: 0.8006 MB / 2.584 GB, free: 0.6415 GB / 1.917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01115/4.341, allocations: 3.479 MB / 2.587 GB, free: 0.6381 GB / 1.917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006674/4.348, allocations: 12.67 MB / 2.6 GB, free: 0.625 GB / 1.917 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01393/4.362, allocations: 1.684 MB / 2.601 GB, free: 0.6234 GB / 1.917 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002715/4.364, allocations: 0.5505 MB / 2.602 GB, free: 0.6229 GB / 1.917 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 374
 * Number of states: 0 ()
 * Number of discrete variables: 138 ($PRE.dataCenterContinuousTimeControl.wseCon.T1.enableFire,$PRE.dataCenterContinuousTimeControl.wseCon.T2.enableFire,$PRE.con.multiSwitch1.u[1],$PRE.con.multiSwitch1.u[2],$PRE.con.t1.enableFire,$PRE.con.t2.enableFire,$PRE.con.t3.enableFire,$PRE.con.t4.enableFire,con.t4.t_start,$PRE.con.t4.t_start,con.t3.t_start,$PRE.con.t3.t_start,con.stateGraphRoot.resume,con.stateGraphRoot.suspend,dataCenterContinuousTimeControl.wseCon.stateGraphRoot.resume,dataCenterContinuousTimeControl.wseCon.stateGraphRoot.suspend,dataCenterContinuousTimeControl.chi.tru.y,con.t4.enableFire,con.t4.localCondition,con.t3.enableFire,con.t3.localCondition,con.discharge.active,con.discharge.oldActive,$PRE.con.discharge.oldActive,con.discharge.newActive,$PRE.con.discharge.newActive,con.discharge.localActive,$PRE.con.discharge.localActive,con.charge.active,con.charge.oldActive,$PRE.con.charge.oldActive,con.charge.newActive,$PRE.con.charge.newActive,con.charge.localActive,$PRE.con.charge.localActive,con.t2.t_start,$PRE.con.t2.t_start,con.t2.fire,con.t2.enableFire,con.t2.localCondition,con.t1.t_start,$PRE.con.t1.t_start,con.t1.fire,con.t1.enableFire,con.t1.localCondition,con.alternative.split[2].available,con.stateGraphRoot.activeSteps,con.off.oldActive,$PRE.con.off.oldActive,con.off.newActive,$PRE.con.off.newActive,con.off.outPort[1].reset,con.off.inPort[1].set,con.off.localActive,$PRE.con.off.localActive,con.off.active,con.multiSwitch1.firstActiveIndex,con.multiSwitch1.u[2],con.multiSwitch1.u[1],con.greaterThreshold.y,con.not1.y,con.lessThreshold.y,bat.cha.overCharged,$PRE.bat.cha.overCharged,bat.cha.underCharged,$PRE.bat.cha.underCharged,pv.HDirTil.incAng.decAng.k,$PRE.pv.HDirTil.incAng.decAng.k,pv.HDirTil.incAng.decAng.tNext,$PRE.pv.HDirTil.incAng.decAng.tNext,pv.HDifTil.incAng.decAng.k,$PRE.pv.HDifTil.incAng.decAng.k,pv.HDifTil.incAng.decAng.tNext,$PRE.pv.HDifTil.incAng.decAng.tNext,dataCenterContinuousTimeControl.or1.y,dataCenterContinuousTimeControl.or1.u1,dataCenterContinuousTimeControl.weaData.decAng.k,$PRE.dataCenterContinuousTimeControl.weaData.decAng.k,dataCenterContinuousTimeControl.weaData.decAng.tNext,$PRE.dataCenterContinuousTimeControl.weaData.decAng.tNext,dataCenterContinuousTimeControl.weaData.eqnTim.k,$PRE.dataCenterContinuousTimeControl.weaData.eqnTim.k,dataCenterContinuousTimeControl.weaData.eqnTim.tNext,$PRE.dataCenterContinuousTimeControl.weaData.eqnTim.tNext,dataCenterContinuousTimeControl.weaData.conTim.k,$PRE.dataCenterContinuousTimeControl.weaData.conTim.k,dataCenterContinuousTimeControl.weaData.conTim.tNext,$PRE.dataCenterContinuousTimeControl.weaData.conTim.tNext,dataCenterContinuousTimeControl.weaData.conTimMin.k,$PRE.dataCenterContinuousTimeControl.weaData.conTimMin.k,dataCenterContinuousTimeControl.weaData.conTimMin.tNext,$PRE.dataCenterContinuousTimeControl.weaData.conTimMin.tNext,dataCenterContinuousTimeControl.weaData.locTim.k,$PRE.dataCenterContinuousTimeControl.weaData.locTim.k,dataCenterContinuousTimeControl.weaData.locTim.tNext,$PRE.dataCenterContinuousTimeControl.weaData.locTim.tNext,dataCenterContinuousTimeControl.chiSwi.hysteresis.y,$PRE.dataCenterContinuousTimeControl.chiSwi.hysteresis.y,dataCenterContinuousTimeControl.wseCon.stateGraphRoot.activeSteps,dataCenterContinuousTimeControl.wseCon.T2.t_start,$PRE.dataCenterContinuousTimeControl.wseCon.T2.t_start,dataCenterContinuousTimeControl.wseCon.T2.fire,dataCenterContinuousTimeControl.wseCon.T2.enableFire,dataCenterContinuousTimeControl.wseCon.T2.localCondition,dataCenterContinuousTimeControl.wseCon.on.oldActive,$PRE.dataCenterContinuousTimeControl.wseCon.on.oldActive,dataCenterContinuousTimeControl.wseCon.on.newActive,$PRE.dataCenterContinuousTimeControl.wseCon.on.newActive,dataCenterContinuousTimeControl.wseCon.on.localActive,$PRE.dataCenterContinuousTimeControl.wseCon.on.localActive,dataCenterContinuousTimeControl.wseCon.on.active,dataCenterContinuousTimeControl.wseCon.T1.t_start,$PRE.dataCenterContinuousTimeControl.wseCon.T1.t_start,dataCenterContinuousTimeControl.wseCon.T1.fire,dataCenterContinuousTimeControl.wseCon.T1.enableFire,dataCenterContinuousTimeControl.wseCon.T1.localCondition,dataCenterContinuousTimeControl.wseCon.off.active,dataCenterContinuousTimeControl.wseCon.off.oldActive,$PRE.dataCenterContinuousTimeControl.wseCon.off.oldActive,dataCenterContinuousTimeControl.wseCon.off.newActive,$PRE.dataCenterContinuousTimeControl.wseCon.off.newActive,dataCenterContinuousTimeControl.wseCon.off.localActive,$PRE.dataCenterContinuousTimeControl.wseCon.off.localActive,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,dataCenterContinuousTimeControl.triAndRes.conPID.I.trigger_internal,dataCenterContinuousTimeControl.EIT.local_reset,dataCenterContinuousTimeControl.EHVAC.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1454):
 * Single equations (assignments): 1433
 * Array equations: 7
 * Algorithm blocks: 0
 * Record equations: 3
 * 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
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(1,7,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(3,9), (1,2), (2,9), (1,1), (1,1), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.003919/4.368, allocations: 0.9626 MB / 2.603 GB, free: 0.622 GB / 1.917 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00472/4.373, allocations: 1.458 MB / 2.604 GB, free: 0.6213 GB / 1.917 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04166/4.415, allocations: 18.88 MB / 2.623 GB, free: 0.603 GB / 1.917 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.997e-05/4.415, allocations: 95.98 kB / 2.623 GB, free: 0.6029 GB / 1.917 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.996e-05/4.415, allocations: 4 kB / 2.623 GB, free: 0.6029 GB / 1.917 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02945/4.444, allocations: 15.77 MB / 2.638 GB, free: 0.5874 GB / 1.917 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06572/4.51, allocations: 43.57 MB / 2.681 GB, free: 0.5433 GB / 1.917 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.182e-05/4.51, allocations: 4 kB / 2.681 GB, free: 0.5433 GB / 1.917 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008759/4.519, allocations: 2.673 MB / 2.683 GB, free: 0.5407 GB / 1.917 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001384/4.52, allocations: 0.6415 MB / 2.684 GB, free: 0.54 GB / 1.917 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001778/4.522, allocations: 271.8 kB / 2.684 GB, free: 0.5398 GB / 1.917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004183/4.526, allocations: 10.38 MB / 2.694 GB, free: 0.5291 GB / 1.917 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.085e-06/4.526, allocations: 12.06 kB / 2.694 GB, free: 0.5291 GB / 1.917 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04633/4.572, allocations: 27.76 MB / 2.721 GB, free: 0.5021 GB / 1.917 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008251/4.581, allocations: 3.3 MB / 2.725 GB, free: 0.4989 GB / 1.917 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003675/4.584, allocations: 213.8 kB / 2.725 GB, free: 0.4987 GB / 1.917 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01066/4.595, allocations: 1.449 MB / 2.726 GB, free: 0.4972 GB / 1.917 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001831/4.597, allocations: 0.6541 MB / 2.727 GB, free: 0.4966 GB / 1.917 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00115/4.598, allocations: 355.7 kB / 2.727 GB, free: 0.4963 GB / 1.917 GB
Notification: Performance of sorting global known variables: time 0.01603/4.614, allocations: 9.838 MB / 2.737 GB, free: 498.4 MB / 1.917 GB
Notification: Performance of sort global known variables: time 3.8e-07/4.614, allocations: 4 kB / 2.737 GB, free: 498.4 MB / 1.917 GB
Notification: Performance of remove unused functions: time 0.02534/4.639, allocations: 7.025 MB / 2.744 GB, free: 491.6 MB / 1.917 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 24
 * Number of states: 37 (dataCenterContinuousTimeControl.cooCoi.ele[1].vol1.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[1].vol2.dynBal.medium.Xi[1],dataCenterContinuousTimeControl.cooCoi.ele[1].vol2.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[1].mas.T,dataCenterContinuousTimeControl.cooCoi.ele[2].vol1.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[2].vol2.dynBal.medium.Xi[1],dataCenterContinuousTimeControl.cooCoi.ele[2].vol2.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[2].mas.T,dataCenterContinuousTimeControl.cooCoi.ele[3].vol1.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[3].vol2.dynBal.medium.Xi[1],dataCenterContinuousTimeControl.cooCoi.ele[3].vol2.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[3].mas.T,dataCenterContinuousTimeControl.cooCoi.ele[4].vol1.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[4].vol2.dynBal.medium.Xi[1],dataCenterContinuousTimeControl.cooCoi.ele[4].vol2.dynBal.U,dataCenterContinuousTimeControl.cooCoi.ele[4].vol2.dynBal.m,dataCenterContinuousTimeControl.cooCoi.ele[4].mas.T,dataCenterContinuousTimeControl.roo.rooVol.dynBal.medium.Xi[1],dataCenterContinuousTimeControl.roo.rooVol.dynBal.U,dataCenterContinuousTimeControl.roo.rooVol.dynBal.m,dataCenterContinuousTimeControl.pumCHW.vol.dynBal.U,dataCenterContinuousTimeControl.expVesCHW.m,dataCenterContinuousTimeControl.expVesCHW.H,dataCenterContinuousTimeControl.cooTow.vol.dynBal.U,dataCenterContinuousTimeControl.pumCW.vol.dynBal.U,dataCenterContinuousTimeControl.expVesChi.m,dataCenterContinuousTimeControl.expVesChi.H,dataCenterContinuousTimeControl.chi.vol1.dynBal.U,dataCenterContinuousTimeControl.chi.vol2.dynBal.U,dataCenterContinuousTimeControl.TAirSup.T,dataCenterContinuousTimeControl.TCHWEntChi.T,dataCenterContinuousTimeControl.TCWLeaTow.T,dataCenterContinuousTimeControl.TCHWLeaCoi.T,dataCenterContinuousTimeControl.EHVAC.y,dataCenterContinuousTimeControl.EIT.y,dataCenterContinuousTimeControl.triAndRes.conPID.I.y,bat.cha.SOC)
 * Number of discrete variables: 84 (dataCenterContinuousTimeControl.wseCon.T1.enableFire,con.t2.enableFire,con.t1.enableFire,dataCenterContinuousTimeControl.wseCon.T2.enableFire,con.discharge.active,con.discharge.localActive,con.charge.active,con.charge.localActive,con.off.localActive,dataCenterContinuousTimeControl.wseCon.on.localActive,dataCenterContinuousTimeControl.wseCon.off.active,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,dataCenterContinuousTimeControl.wseCon.off.localActive,dataCenterContinuousTimeControl.wseCon.off.newActive,dataCenterContinuousTimeControl.wseCon.off.oldActive,dataCenterContinuousTimeControl.wseCon.T1.localCondition,dataCenterContinuousTimeControl.wseCon.T1.fire,dataCenterContinuousTimeControl.wseCon.T1.t_start,dataCenterContinuousTimeControl.wseCon.on.active,dataCenterContinuousTimeControl.wseCon.on.newActive,dataCenterContinuousTimeControl.wseCon.on.oldActive,dataCenterContinuousTimeControl.wseCon.T2.localCondition,dataCenterContinuousTimeControl.wseCon.T2.fire,dataCenterContinuousTimeControl.wseCon.T2.t_start,dataCenterContinuousTimeControl.wseCon.stateGraphRoot.activeSteps,dataCenterContinuousTimeControl.chiSwi.hysteresis.y,dataCenterContinuousTimeControl.weaData.locTim.tNext,dataCenterContinuousTimeControl.weaData.locTim.k,dataCenterContinuousTimeControl.weaData.conTimMin.tNext,dataCenterContinuousTimeControl.weaData.conTimMin.k,dataCenterContinuousTimeControl.weaData.conTim.tNext,dataCenterContinuousTimeControl.weaData.conTim.k,dataCenterContinuousTimeControl.weaData.eqnTim.tNext,dataCenterContinuousTimeControl.weaData.eqnTim.k,dataCenterContinuousTimeControl.weaData.decAng.tNext,dataCenterContinuousTimeControl.weaData.decAng.k,dataCenterContinuousTimeControl.or1.u1,dataCenterContinuousTimeControl.or1.y,pv.HDifTil.incAng.decAng.tNext,pv.HDifTil.incAng.decAng.k,pv.HDirTil.incAng.decAng.tNext,pv.HDirTil.incAng.decAng.k,bat.cha.underCharged,bat.cha.overCharged,con.lessThreshold.y,con.not1.y,con.greaterThreshold.y,con.multiSwitch1.u[1],con.multiSwitch1.u[2],con.multiSwitch1.firstActiveIndex,con.off.active,con.off.inPort[1].set,con.off.outPort[1].reset,con.off.newActive,con.off.oldActive,con.stateGraphRoot.activeSteps,con.alternative.split[2].available,con.t1.localCondition,con.t1.fire,con.t1.t_start,con.t2.localCondition,con.t2.fire,con.t2.t_start,con.charge.newActive,con.charge.oldActive,con.discharge.newActive,con.discharge.oldActive,con.t3.localCondition,con.t3.enableFire,con.t4.localCondition,con.t4.enableFire,con.t3.t_start,con.t4.t_start)
 * Number of discrete states: 24 (con.t4.t_start,con.t3.t_start,pv.HDirTil.incAng.decAng.tNext,pv.HDifTil.incAng.decAng.tNext,dataCenterContinuousTimeControl.weaData.decAng.tNext,dataCenterContinuousTimeControl.weaData.eqnTim.tNext,dataCenterContinuousTimeControl.weaData.conTim.tNext,dataCenterContinuousTimeControl.weaData.conTimMin.tNext,dataCenterContinuousTimeControl.weaData.locTim.tNext,dataCenterContinuousTimeControl.wseCon.off.newActive,dataCenterContinuousTimeControl.wseCon.on.newActive,dataCenterContinuousTimeControl.chiSwi.hysteresis.y,bat.cha.underCharged,bat.cha.overCharged,con.off.newActive,con.charge.newActive,con.discharge.newActive,pv.HDirTil.incAng.decAng.k,pv.HDifTil.incAng.decAng.k,dataCenterContinuousTimeControl.weaData.decAng.k,dataCenterContinuousTimeControl.weaData.eqnTim.k,dataCenterContinuousTimeControl.weaData.conTim.k,dataCenterContinuousTimeControl.weaData.conTimMin.k,dataCenterContinuousTimeControl.weaData.locTim.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (896):
 * Single equations (assignments): 844
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 17
 * When equations: 25
 * If-equations: 0
 * Equation systems (not torn): 1
 * 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): 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): 3 systems
   {(1,1,100.0%), (1,1,100.0%), (1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 6 systems
   {(1,2), (1,2), (1,3), (3,13), (1,2), (2,9)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.04897/4.688, allocations: 30.84 MB / 2.774 GB, free: 461.3 MB / 1.917 GB
Notification: Performance of simCode: created initialization part: time 0.05315/4.741, allocations: 30.08 MB / 2.803 GB, free: 431.1 MB / 1.917 GB
Notification: Performance of simCode: created event and clocks part: time 1.912e-05/4.742, allocations: 6.656 kB / 2.803 GB, free: 431.1 MB / 1.917 GB
Notification: Performance of simCode: created simulation system equations: time 0.01593/4.757, allocations: 9.138 MB / 2.812 GB, free: 421.9 MB / 1.917 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02397/4.781, allocations: 7.549 MB / 2.82 GB, free: 415.1 MB / 1.917 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2396/5.021, allocations: 141.3 MB / 2.958 GB, free: 270.8 MB / 1.917 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01004/5.031, allocations: 8.594 MB / 2.966 GB, free: 262.1 MB / 1.917 GB
Notification: Performance of simCode: alias equations: time 0.02034/5.051, allocations: 5.753 MB / 2.972 GB, free: 256.4 MB / 1.917 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01293/5.064, allocations: 7.661 MB / 2.979 GB, free: 248.8 MB / 1.917 GB
Notification: Performance of SimCode: time 2.344e-06/5.064, allocations: 0 / 2.979 GB, free: 248.8 MB / 1.917 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.604/6.669, allocations: 459.3 MB / 3.428 GB, free: 0.5548 GB / 1.917 GB
Notification: Performance of buildModelFMU: Generate platform static: time 30.18/36.85, allocations: 8 kB / 3.428 GB, free: 0.5548 GB / 1.917 GB
"
[Timeout remaining time 263]
(rm -f Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables.pipe ; mkfifo Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables.pipe >> ../files/Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables.sim & python3 -m fmpy simulate  --output-file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables_res.csv --start-time 0 --stop-time 604800 --timeout 800 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 241.92 Buildings_latest_Buildings_Examples_ChillerPlant_DataCenter_Renewables.fmu > Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.Renewables.pipe 2>&1) [Timeout 840.0]
[Calling os._exit(0), Time elapsed: 42.52482555247843]