Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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.001326/0.001326, allocations: 110.4 kB / 18.94 MB, free: 2.949 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.001505/0.001505, allocations: 220.3 kB / 22.26 MB, free: 5.125 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.478/1.478, allocations: 230.6 MB / 256 MB, free: 7.988 MB / 206.1 MB
"
[Timeout remaining time 178]
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 3.449/3.449, allocations: 0.505 GB / 0.8101 GB, free: 22.05 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.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.DataCenterRenewables,fileNamePrefix="Buildings_latest_Buildings_Examples_ChillerPlant_DataCenterRenewables",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Examples.ChillerPlant.DataCenterRenewables,fileNamePrefix="Buildings_latest_Buildings_Examples_ChillerPlant_DataCenterRenewables",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.002056/0.002056, allocations: 73.36 kB / 1.177 GB, free: 16.99 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3696/0.3717, allocations: 180.2 MB / 1.353 GB, free: 8.496 MB / 1.045 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/Electrical/Interfaces/PartialPV.mo:8:3-10:67:writable] Warning: Parameter pv.panel.V_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=110) as default value.
Notification: Performance of NFInst.instantiate(Buildings.Examples.ChillerPlant.DataCenterRenewables): time 1.381/1.753, allocations: 496.5 MB / 1.838 GB, free: 14.54 MB / 1.342 GB
Notification: Performance of NFInst.instExpressions: time 0.1378/1.891, allocations: 80.35 MB / 1.916 GB, free: 16 kB / 1.404 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01728/1.908, allocations: 0.5271 MB / 1.917 GB, free: 15.48 MB / 1.42 GB
Notification: Performance of NFTyping.typeComponents: time 0.02349/1.932, allocations: 7.466 MB / 1.924 GB, free: 7.984 MB / 1.42 GB
Notification: Performance of NFTyping.typeBindings: time 0.04955/1.981, allocations: 16.33 MB / 1.94 GB, free: 7.602 MB / 1.436 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03053/2.012, allocations: 12.3 MB / 1.952 GB, free: 11.36 MB / 1.451 GB
Notification: Performance of NFFlatten.flatten: time 0.08062/2.092, allocations: 50.72 MB / 2.001 GB, free: 8.531 MB / 1.498 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.049/2.141, allocations: 23.29 MB / 2.024 GB, free: 1.062 MB / 1.514 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0432/2.184, allocations: 16.77 MB / 2.041 GB, free: 284 kB / 1.529 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03235/2.217, allocations: 12.82 MB / 2.053 GB, free: 3.426 MB / 1.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.00824/2.225, allocations: 2.23 MB / 2.055 GB, free: 1.195 MB / 1.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0305/2.256, allocations: 11.54 MB / 2.067 GB, free: 5.637 MB / 1.561 GB
Notification: Performance of NFScalarize.scalarize: time 0.01258/2.268, allocations: 6.021 MB / 2.072 GB, free: 15.6 MB / 1.576 GB
Notification: Performance of NFVerifyModel.verify: time 0.02336/2.292, allocations: 10.79 MB / 2.083 GB, free: 4.77 MB / 1.576 GB
Notification: Performance of NFConvertDAE.convert: time 0.07043/2.362, allocations: 36.24 MB / 2.118 GB, free: 420 kB / 1.607 GB
Notification: Performance of FrontEnd - DAE generated: time 7.153e-06/2.362, allocations: 4 kB / 2.118 GB, free: 416 kB / 1.607 GB
Notification: Performance of FrontEnd: time 1.714e-06/2.362, allocations: 0 / 2.118 GB, free: 416 kB / 1.607 GB
Notification: Performance of Transformations before backend: time 0.001154/2.363, allocations: 0 / 2.118 GB, free: 416 kB / 1.607 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2812
 * Number of variables: 2812
Notification: Performance of Generate backend data structure: time 0.06447/2.428, allocations: 20.15 MB / 2.138 GB, free: 12.04 MB / 1.639 GB
Notification: Performance of prepare preOptimizeDAE: time 5.087e-05/2.428, allocations: 8.031 kB / 2.138 GB, free: 12.03 MB / 1.639 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.00678/2.434, allocations: 1.44 MB / 2.139 GB, free: 10.58 MB / 1.639 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04769/2.482, allocations: 6.506 MB / 2.146 GB, free: 4.055 MB / 1.639 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04837/2.53, allocations: 19.26 MB / 2.165 GB, free: 0.6562 MB / 1.654 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001288/2.532, allocations: 1.002 MB / 2.166 GB, free: 15.63 MB / 1.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004506/2.536, allocations: 1.121 MB / 2.167 GB, free: 14.51 MB / 1.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05422/2.59, allocations: 16.73 MB / 2.183 GB, free: 13.38 MB / 1.686 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005082/2.591, allocations: 31.75 kB / 2.183 GB, free: 13.35 MB / 1.686 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004644/2.596, allocations: 464 kB / 2.183 GB, free: 12.9 MB / 1.686 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006797/2.596, allocations: 0.4968 MB / 2.184 GB, free: 12.4 MB / 1.686 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05657/2.653, allocations: 16.76 MB / 2.2 GB, free: 11.61 MB / 1.701 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.1508/2.804, allocations: 72.73 MB / 2.271 GB, free: 14.16 MB / 1.779 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03268/2.836, allocations: 11.26 MB / 2.282 GB, free: 3.012 MB / 1.779 GB
Notification: Performance of preOpt resolveLoops (simulation): time 1.349/4.186, allocations: 6.078 MB / 2.288 GB, free: 0.6673 GB / 1.779 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.04721/4.233, allocations: 20.42 MB / 2.308 GB, free: 0.6581 GB / 1.779 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02003/4.253, allocations: 6.581 MB / 2.315 GB, free: 0.656 GB / 1.779 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.008349/4.261, allocations: 0.9807 MB / 2.316 GB, free: 0.6558 GB / 1.779 GB
Notification: Performance of pre-optimization done (n=739): time 7.148e-05/4.261, allocations: 0 / 2.316 GB, free: 0.6558 GB / 1.779 GB
Notification: Performance of matching and sorting (n=837): time 0.321/4.582, allocations: 74.44 MB / 2.388 GB, free: 0.6237 GB / 1.779 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001691/4.583, allocations: 388.8 kB / 2.389 GB, free: 0.6233 GB / 1.779 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02931/4.612, allocations: 13.34 MB / 2.402 GB, free: 0.6104 GB / 1.779 GB
Notification: Performance of collectPreVariables (initialization): time 0.002379/4.614, allocations: 237.7 kB / 2.402 GB, free: 0.6101 GB / 1.779 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006852/4.621, allocations: 7.041 MB / 2.409 GB, free: 0.6038 GB / 1.779 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004421/4.626, allocations: 2.926 MB / 2.412 GB, free: 0.6014 GB / 1.779 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.007995/4.634, allocations: 2.38 MB / 2.414 GB, free: 0.599 GB / 1.779 GB
Notification: Performance of setup shared object (initialization): time 5.777e-05/4.634, allocations: 309.1 kB / 2.414 GB, free: 0.5988 GB / 1.779 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02255/4.656, allocations: 8.475 MB / 2.423 GB, free: 0.5905 GB / 1.779 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02523/4.681, allocations: 11.16 MB / 2.433 GB, free: 0.5786 GB / 1.779 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04571/4.727, allocations: 18.3 MB / 2.451 GB, free: 0.56 GB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001079/4.727, allocations: 16 kB / 2.451 GB, free: 0.56 GB / 1.779 GB
Notification: Performance of matching and sorting (n=1459) (initialization): time 0.05742/4.785, allocations: 21.42 MB / 2.472 GB, free: 0.539 GB / 1.779 GB
Notification: Performance of prepare postOptimizeDAE: time 6.947e-05/4.785, allocations: 28 kB / 2.472 GB, free: 0.539 GB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.892e-05/4.785, allocations: 60.78 kB / 2.472 GB, free: 0.5389 GB / 1.779 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00324/4.788, allocations: 0.8503 MB / 2.473 GB, free: 0.5381 GB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01827/4.806, allocations: 3.284 MB / 2.476 GB, free: 0.5348 GB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007807/4.814, allocations: 11.12 MB / 2.487 GB, free: 0.5234 GB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0196/4.834, allocations: 1.614 MB / 2.489 GB, free: 0.5218 GB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002452/4.836, allocations: 0.4958 MB / 2.489 GB, free: 0.5213 GB / 1.779 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0293/4.865, allocations: 12.61 MB / 2.502 GB, free: 0.509 GB / 1.779 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02386/4.889, allocations: 11.09 MB / 2.512 GB, free: 0.4972 GB / 1.779 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04289/4.932, allocations: 18.17 MB / 2.53 GB, free: 490.2 MB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.586e-05/4.932, allocations: 16 kB / 2.53 GB, free: 490.2 MB / 1.779 GB
Notification: Performance of matching and sorting (n=1459) (initialization_lambda0): time 0.054/4.986, allocations: 21.2 MB / 2.551 GB, free: 468.9 MB / 1.779 GB
Notification: Performance of prepare postOptimizeDAE: time 4.621e-05/4.986, allocations: 31.98 kB / 2.551 GB, free: 468.9 MB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.446e-05/4.986, allocations: 56 kB / 2.551 GB, free: 468.8 MB / 1.779 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002645/4.989, allocations: 0.7892 MB / 2.552 GB, free: 468 MB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01722/5.006, allocations: 3.245 MB / 2.555 GB, free: 464.8 MB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008648/5.015, allocations: 12.72 MB / 2.567 GB, free: 451.3 MB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02043/5.035, allocations: 1.653 MB / 2.569 GB, free: 449.6 MB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002534/5.038, allocations: 499.7 kB / 2.569 GB, free: 449.1 MB / 1.779 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 258
 * Number of states: 0 ()
 * Number of discrete variables: 124 ($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.tNext,$PRE.pv.HDirTil.incAng.decAng.tNext,pv.HDifTil.incAng.decAng.tNext,$PRE.pv.HDifTil.incAng.decAng.tNext,dataCenterContinuousTimeControl.or1.y,dataCenterContinuousTimeControl.or1.u1,dataCenterContinuousTimeControl.weaData.decAng.tNext,$PRE.dataCenterContinuousTimeControl.weaData.decAng.tNext,dataCenterContinuousTimeControl.weaData.eqnTim.tNext,$PRE.dataCenterContinuousTimeControl.weaData.eqnTim.tNext,dataCenterContinuousTimeControl.weaData.conTim.tNext,$PRE.dataCenterContinuousTimeControl.weaData.conTim.tNext,dataCenterContinuousTimeControl.weaData.conTimMin.tNext,$PRE.dataCenterContinuousTimeControl.weaData.conTimMin.tNext,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 (1316):
 * Single equations (assignments): 1294
 * Array equations: 8
 * 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.003464/5.041, allocations: 0.8589 MB / 2.57 GB, free: 448.3 MB / 1.779 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003911/5.045, allocations: 1.401 MB / 2.572 GB, free: 446.9 MB / 1.779 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05438/5.1, allocations: 18.82 MB / 2.59 GB, free: 428.1 MB / 1.779 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.955e-05/5.1, allocations: 95.98 kB / 2.59 GB, free: 428 MB / 1.779 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.861e-05/5.1, allocations: 4 kB / 2.59 GB, free: 428 MB / 1.779 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04503/5.145, allocations: 15.75 MB / 2.606 GB, free: 412.2 MB / 1.779 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0844/5.229, allocations: 45.91 MB / 2.65 GB, free: 364.6 MB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.296e-05/5.229, allocations: 4 kB / 2.65 GB, free: 364.6 MB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01525/5.244, allocations: 2.669 MB / 2.653 GB, free: 361.9 MB / 1.779 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002188/5.247, allocations: 0.6415 MB / 2.654 GB, free: 361.2 MB / 1.779 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001846/5.248, allocations: 275.8 kB / 2.654 GB, free: 361 MB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006313/5.255, allocations: 10.42 MB / 2.664 GB, free: 350 MB / 1.779 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.238e-06/5.255, allocations: 4 kB / 2.664 GB, free: 349.9 MB / 1.779 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0735/5.328, allocations: 27.61 MB / 2.691 GB, free: 322.2 MB / 1.779 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009958/5.338, allocations: 3.206 MB / 2.694 GB, free: 319 MB / 1.779 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004892/5.343, allocations: 198.5 kB / 2.694 GB, free: 318.8 MB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02087/5.364, allocations: 1.445 MB / 2.696 GB, free: 317.4 MB / 1.779 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002496/5.366, allocations: 0.6463 MB / 2.696 GB, free: 316.7 MB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001828/5.368, allocations: 363.7 kB / 2.697 GB, free: 316.4 MB / 1.779 GB
Notification: Performance of sorting global known variables: time 0.01677/5.385, allocations: 9.07 MB / 2.706 GB, free: 307.3 MB / 1.779 GB
Notification: Performance of sort global known variables: time 3.21e-07/5.385, allocations: 0 / 2.706 GB, free: 307.3 MB / 1.779 GB
Notification: Performance of remove unused functions: time 0.02654/5.412, allocations: 6.784 MB / 2.712 GB, free: 300.7 MB / 1.779 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 19
 * 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: 77 (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.conTimMin.tNext,dataCenterContinuousTimeControl.weaData.conTim.tNext,dataCenterContinuousTimeControl.weaData.eqnTim.tNext,dataCenterContinuousTimeControl.weaData.decAng.tNext,dataCenterContinuousTimeControl.or1.u1,dataCenterContinuousTimeControl.or1.y,pv.HDifTil.incAng.decAng.tNext,pv.HDirTil.incAng.decAng.tNext,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: 17 (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)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (882):
 * Single equations (assignments): 837
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 17
 * When equations: 18
 * 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.08134/5.493, allocations: 30.52 MB / 2.742 GB, free: 270.6 MB / 1.779 GB
Notification: Performance of simCode: created initialization part: time 0.07634/5.569, allocations: 29.23 MB / 2.771 GB, free: 241.3 MB / 1.779 GB
Notification: Performance of simCode: created event and clocks part: time 1.605e-05/5.569, allocations: 10.66 kB / 2.771 GB, free: 241.3 MB / 1.779 GB
Notification: Performance of simCode: created simulation system equations: time 0.02459/5.594, allocations: 9.023 MB / 2.779 GB, free: 232.2 MB / 1.779 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03428/5.628, allocations: 7.261 MB / 2.786 GB, free: 225.6 MB / 1.779 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3053/5.933, allocations: 133.7 MB / 2.917 GB, free: 89.73 MB / 1.779 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01551/5.949, allocations: 8.549 MB / 2.925 GB, free: 81.13 MB / 1.779 GB
Notification: Performance of simCode: alias equations: time 0.02649/5.975, allocations: 5.42 MB / 2.931 GB, free: 75.78 MB / 1.779 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0148/5.99, allocations: 7.364 MB / 2.938 GB, free: 68.41 MB / 1.779 GB
Notification: Performance of SimCode: time 1.854e-06/5.99, allocations: 0 / 2.938 GB, free: 68.41 MB / 1.779 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.852/7.842, allocations: 423.9 MB / 3.352 GB, free: 365 MB / 1.78 GB
Notification: Performance of buildModelFMU: Generate platform static: time 61.71/69.55, allocations: 0 / 3.352 GB, free: 365 MB / 1.78 GB
"
[Timeout remaining time 230]
(rm -f Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe ; mkfifo Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe >> ../files/Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables.sim & python3 -m fmpy simulate  --output-file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_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_DataCenterRenewables.fmu > Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables.pipe 2>&1) [Timeout 840.0]
diffSimulationResults("Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Examples_ChillerPlant_DataCenterRenewables.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
"Error: Could not read variable winTur.vWin in file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv.
Warning: Get data of variable winTur.vWin from file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv failed!
Error: Could not read variable winTur.P in file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv.
Warning: Get data of variable winTur.P from file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv failed!
Error: Could not read variable pv.P in file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv.
Warning: Get data of variable pv.P from file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv failed!
Error: Could not read variable gri.P.real in file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv.
Warning: Get data of variable gri.P.real from file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv failed!
Error: Could not read variable gri.P.cosPhi in file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv.
Warning: Get data of variable gri.P.cosPhi from file Buildings_latest_Buildings.Examples.ChillerPlant.DataCenterRenewables_res.csv failed!
"
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 77.95298165900022]