Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables.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.0007729/0.0007729, allocations: 80.44 kB / 19.17 MB, free: 0.7461 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.0007783/0.0007783, allocations: 165.9 kB / 22.45 MB, free: 2.113 MB / 18.57 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.8812/0.8812, allocations: 177.1 MB / 202.8 MB, free: 5.742 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo): time 1.711/1.711, allocations: 377.9 MB / 0.6221 GB, free: 8.668 MB / 0.5886 GB
"
[Timeout remaining time 178]
Using package Buildings with version 12.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.2-maint.12.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Buildings.Examples.ChillerPlant.DataCenterRenewables,fileNamePrefix="Buildings_12_Buildings_Examples_ChillerPlant_DataCenterRenewables",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Examples.ChillerPlant.DataCenterRenewables,fileNamePrefix="Buildings_12_Buildings_Examples_ChillerPlant_DataCenterRenewables",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.963e-06/1.963e-06, allocations: 0 / 0.9809 GB, free: 2.648 MB / 0.9323 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.905e-05/2.101e-05, allocations: 2.281 kB / 0.9809 GB, free: 2.645 MB / 0.9323 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.ChillerPlant.DataCenterRenewables): time 0.7481/0.7481, allocations: 436.8 MB / 1.407 GB, free: 5.102 MB / 1.229 GB
Notification: Performance of NFInst.instExpressions: time 0.07685/0.825, allocations: 74.72 MB / 1.48 GB, free: 10.22 MB / 1.307 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01568/0.8407, allocations: 0.5309 MB / 1.481 GB, free: 9.684 MB / 1.307 GB
Notification: Performance of NFTyping.typeComponents: time 0.01505/0.8557, allocations: 7.194 MB / 1.488 GB, free: 2.465 MB / 1.307 GB
Notification: Performance of NFTyping.typeBindings: time 0.03151/0.8872, allocations: 16.69 MB / 1.504 GB, free: 1.711 MB / 1.323 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02172/0.9089, allocations: 12.5 MB / 1.516 GB, free: 5.281 MB / 1.339 GB
Notification: Performance of NFFlatten.flatten: time 1.078/1.987, allocations: 53.8 MB / 1.569 GB, free: 64.86 MB / 1.386 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03468/2.022, allocations: 23.33 MB / 1.592 GB, free: 63.96 MB / 1.386 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04908/2.071, allocations: 23.87 MB / 1.615 GB, free: 63.95 MB / 1.386 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02308/2.094, allocations: 11.45 MB / 1.626 GB, free: 63.94 MB / 1.386 GB
Notification: Performance of NFPackage.collectConstants: time 0.006332/2.1, allocations: 2.203 MB / 1.628 GB, free: 63.94 MB / 1.386 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02099/2.121, allocations: 9.205 MB / 1.637 GB, free: 63.94 MB / 1.386 GB
Notification: Performance of NFScalarize.scalarize: time 0.009115/2.13, allocations: 6.192 MB / 1.643 GB, free: 63.94 MB / 1.386 GB
Notification: Performance of NFVerifyModel.verify: time 0.0165/2.147, allocations: 7.151 MB / 1.65 GB, free: 63.94 MB / 1.386 GB
Notification: Performance of NFConvertDAE.convert: time 0.03659/2.183, allocations: 36.4 MB / 1.686 GB, free: 62.01 MB / 1.386 GB
Notification: Performance of FrontEnd - DAE generated: time 8.917e-06/2.183, allocations: 0 / 1.686 GB, free: 62.01 MB / 1.386 GB
Notification: Performance of FrontEnd: time 2.234e-06/2.183, allocations: 0.9062 kB / 1.686 GB, free: 62.01 MB / 1.386 GB
Notification: Performance of Transformations before backend: time 0.0008871/2.184, allocations: 0 / 1.686 GB, free: 62.01 MB / 1.386 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2819
 * Number of variables: 2819
Notification: Performance of Generate backend data structure: time 0.03131/2.215, allocations: 19.94 MB / 1.705 GB, free: 53.8 MB / 1.386 GB
Notification: Performance of prepare preOptimizeDAE: time 4.507e-05/2.215, allocations: 10.5 kB / 1.705 GB, free: 53.8 MB / 1.386 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001597/2.217, allocations: 1.449 MB / 1.707 GB, free: 53.7 MB / 1.386 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01606/2.233, allocations: 5.01 MB / 1.712 GB, free: 52.65 MB / 1.386 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02407/2.257, allocations: 19.96 MB / 1.731 GB, free: 49.17 MB / 1.386 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006481/2.258, allocations: 1.003 MB / 1.732 GB, free: 48.99 MB / 1.386 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002107/2.26, allocations: 1.138 MB / 1.733 GB, free: 48.98 MB / 1.386 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02236/2.282, allocations: 17.71 MB / 1.751 GB, free: 42.37 MB / 1.386 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000254/2.283, allocations: 26.3 kB / 1.751 GB, free: 42.36 MB / 1.386 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001021/2.284, allocations: 466.1 kB / 1.751 GB, free: 42.36 MB / 1.386 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003216/2.284, allocations: 0.4931 MB / 1.752 GB, free: 42.3 MB / 1.386 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02026/2.304, allocations: 14.97 MB / 1.766 GB, free: 38.05 MB / 1.386 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.06536/2.37, allocations: 51.51 MB / 1.817 GB, free: 1.648 MB / 1.386 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01441/2.384, allocations: 10.41 MB / 1.827 GB, free: 7.711 MB / 1.401 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006573/2.391, allocations: 5.261 MB / 1.832 GB, free: 2.434 MB / 1.401 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.02524/2.416, allocations: 15.56 MB / 1.847 GB, free: 3.066 MB / 1.417 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.008044/2.424, allocations: 7.271 MB / 1.854 GB, free: 11.36 MB / 1.432 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004208/2.428, allocations: 0.9532 MB / 1.855 GB, free: 10.41 MB / 1.432 GB
Notification: Performance of pre-optimization done (n=751): time 2.203e-05/2.428, allocations: 0 / 1.855 GB, free: 10.41 MB / 1.432 GB
Notification: Performance of matching and sorting (n=854): time 0.137/2.565, allocations: 63.4 MB / 1.917 GB, free: 11 MB / 1.495 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000169/2.565, allocations: 396.5 kB / 1.917 GB, free: 10.54 MB / 1.495 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01758/2.583, allocations: 13.04 MB / 1.93 GB, free: 13.55 MB / 1.511 GB
Notification: Performance of collectPreVariables (initialization): time 0.00237/2.585, allocations: 249.7 kB / 1.93 GB, free: 13.3 MB / 1.511 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006266/2.591, allocations: 7.217 MB / 1.937 GB, free: 6.09 MB / 1.511 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004216/2.596, allocations: 2.94 MB / 1.94 GB, free: 3.195 MB / 1.511 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004092/2.6, allocations: 2.045 MB / 1.942 GB, free: 1.145 MB / 1.511 GB
Notification: Performance of setup shared object (initialization): time 6.708e-05/2.6, allocations: 313.1 kB / 1.943 GB, free: 0.8359 MB / 1.511 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01133/2.611, allocations: 7.023 MB / 1.949 GB, free: 9.801 MB / 1.526 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01363/2.625, allocations: 11.06 MB / 1.96 GB, free: 13.45 MB / 1.542 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02359/2.648, allocations: 15.83 MB / 1.976 GB, free: 13 MB / 1.557 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.491e-05/2.648, allocations: 19.98 kB / 1.976 GB, free: 12.98 MB / 1.557 GB
Notification: Performance of matching and sorting (n=1285) (initialization): time 0.03141/2.68, allocations: 18.47 MB / 1.994 GB, free: 10.76 MB / 1.573 GB
Notification: Performance of prepare postOptimizeDAE: time 4.449e-05/2.68, allocations: 32 kB / 1.994 GB, free: 10.73 MB / 1.573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.331e-05/2.68, allocations: 56 kB / 1.994 GB, free: 10.67 MB / 1.573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001796/2.682, allocations: 0.8368 MB / 1.995 GB, free: 9.812 MB / 1.573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00819/2.69, allocations: 2.836 MB / 1.997 GB, free: 7.113 MB / 1.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006269/2.696, allocations: 11.06 MB / 2.008 GB, free: 11.51 MB / 1.589 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01031/2.706, allocations: 1.273 MB / 2.009 GB, free: 10.24 MB / 1.589 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001017/2.707, allocations: 479.7 kB / 2.01 GB, free: 9.773 MB / 1.589 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0173/2.725, allocations: 11.17 MB / 2.021 GB, free: 14.59 MB / 1.604 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01292/2.738, allocations: 10.99 MB / 2.032 GB, free: 2.309 MB / 1.604 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02428/2.762, allocations: 15.71 MB / 2.047 GB, free: 1.984 MB / 1.62 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.693e-05/2.762, allocations: 20 kB / 2.047 GB, free: 1.965 MB / 1.62 GB
Notification: Performance of matching and sorting (n=1285) (initialization_lambda0): time 0.03772/2.8, allocations: 18.25 MB / 2.065 GB, free: 15.96 MB / 1.651 GB
Notification: Performance of prepare postOptimizeDAE: time 4.096e-05/2.8, allocations: 34.17 kB / 2.065 GB, free: 15.93 MB / 1.651 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.752e-05/2.8, allocations: 60.16 kB / 2.065 GB, free: 15.87 MB / 1.651 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001597/2.801, allocations: 0.7632 MB / 2.066 GB, free: 15.08 MB / 1.651 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008014/2.809, allocations: 2.803 MB / 2.068 GB, free: 12.41 MB / 1.651 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007576/2.817, allocations: 12.6 MB / 2.081 GB, free: 15.14 MB / 1.667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01173/2.829, allocations: 1.32 MB / 2.082 GB, free: 13.82 MB / 1.667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001409/2.83, allocations: 474.3 kB / 2.082 GB, free: 13.36 MB / 1.667 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 255
 * 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 (1238):
 * Single equations (assignments): 1219
 * Array equations: 8
 * Algorithm blocks: 0
 * Record equations: 0
 * 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.002506/2.833, allocations: 0.8481 MB / 2.083 GB, free: 12.62 MB / 1.667 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003164/2.836, allocations: 1.417 MB / 2.085 GB, free: 11.2 MB / 1.667 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02955/2.865, allocations: 17.38 MB / 2.102 GB, free: 9.852 MB / 1.682 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.858e-05/2.865, allocations: 108 kB / 2.102 GB, free: 9.746 MB / 1.682 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.485e-05/2.865, allocations: 0 / 2.102 GB, free: 9.746 MB / 1.682 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02288/2.888, allocations: 14.31 MB / 2.116 GB, free: 11.38 MB / 1.698 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.05443/2.943, allocations: 40.68 MB / 2.155 GB, free: 1.496 MB / 1.729 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.08e-05/2.943, allocations: 15.91 kB / 2.155 GB, free: 1.48 MB / 1.729 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.007047/2.95, allocations: 2.363 MB / 2.158 GB, free: 15.2 MB / 1.745 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001291/2.951, allocations: 0.6331 MB / 2.158 GB, free: 14.54 MB / 1.745 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007544/2.952, allocations: 271.8 kB / 2.159 GB, free: 14.28 MB / 1.745 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005725/2.958, allocations: 10.37 MB / 2.169 GB, free: 3.359 MB / 1.745 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.769e-06/2.958, allocations: 8.062 kB / 2.169 GB, free: 3.352 MB / 1.745 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04058/2.998, allocations: 25.3 MB / 2.193 GB, free: 9.922 MB / 1.776 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007261/3.005, allocations: 3.127 MB / 2.196 GB, free: 6.781 MB / 1.776 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002351/3.008, allocations: 211.9 kB / 2.197 GB, free: 6.574 MB / 1.776 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007107/3.015, allocations: 1.138 MB / 2.198 GB, free: 5.438 MB / 1.776 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009308/3.016, allocations: 0.6534 MB / 2.198 GB, free: 4.789 MB / 1.776 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006788/3.017, allocations: 359.7 kB / 2.199 GB, free: 4.438 MB / 1.776 GB
Notification: Performance of sorting global known variables: time 0.4794/3.496, allocations: 8.895 MB / 2.207 GB, free: 0.7797 GB / 1.776 GB
Notification: Performance of sort global known variables: time 2.21e-07/3.496, allocations: 0 / 2.207 GB, free: 0.7797 GB / 1.776 GB
Notification: Performance of remove unused functions: time 0.01881/3.515, allocations: 6.489 MB / 2.214 GB, free: 0.7797 GB / 1.776 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 (899):
 * Single equations (assignments): 847
 * 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.0423/3.557, allocations: 28.19 MB / 2.241 GB, free: 0.773 GB / 1.776 GB
Notification: Performance of simCode: created initialization part: time 0.04043/3.598, allocations: 25.33 MB / 2.266 GB, free: 0.7644 GB / 1.776 GB
Notification: Performance of simCode: created event and clocks part: time 2.055e-05/3.598, allocations: 8.594 kB / 2.266 GB, free: 0.7644 GB / 1.776 GB
Notification: Performance of simCode: created simulation system equations: time 0.01792/3.615, allocations: 8.311 MB / 2.274 GB, free: 0.7615 GB / 1.776 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02757/3.643, allocations: 7.609 MB / 2.282 GB, free: 0.7598 GB / 1.776 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2095/3.853, allocations: 125.9 MB / 2.405 GB, free: 0.6798 GB / 1.776 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006662/3.859, allocations: 8.298 MB / 2.413 GB, free: 0.6738 GB / 1.776 GB
Notification: Performance of simCode: alias equations: time 0.01541/3.875, allocations: 5.302 MB / 2.418 GB, free: 0.6699 GB / 1.776 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.007926/3.883, allocations: 7.403 MB / 2.425 GB, free: 0.6632 GB / 1.776 GB
Notification: Performance of SimCode: time 1.393e-06/3.883, allocations: 0 / 2.425 GB, free: 0.6632 GB / 1.776 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.358/4.241, allocations: 443.4 MB / 2.858 GB, free: 241.3 MB / 1.776 GB
Notification: Performance of buildModelFMU: Generate platform static: time 32.2/36.44, allocations: 7.688 kB / 2.858 GB, free: 241.3 MB / 1.776 GB
"
[Timeout remaining time 263]
(rm -f Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe ; mkfifo Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe ; head -c 1048576 < Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe >> ../files/Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables.sim & python3 -m fmpy simulate  --output-file Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv --start-time 0 --stop-time 604800 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 241.92 Buildings_12_Buildings_Examples_ChillerPlant_DataCenterRenewables.fmu > Buildings_12_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 40.91452554240823]
Failed to read output from testmodel.py, exit status != 0:
36.799720065668225 36.808952412000004 34.623401188
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x74e4bdcc8650>