Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.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.0008818/0.0008818, allocations: 92.2 kB / 20.21 MB, free: 4.348 MB / 18.57 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.00089/0.00089, allocations: 165.3 kB / 23.53 MB, free: 1.031 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.934/0.934, allocations: 177.2 MB / 203.9 MB, free: 5.586 MB / 186.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.042/2.042, allocations: 428.5 MB / 0.6727 GB, free: 4.91 MB / 0.6355 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: translateModel(Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl")
translateModel(Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 2.775e-06/2.775e-06, allocations: 3.984 kB / 0.8771 GB, free: 7.863 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.792e-05/3.07e-05, allocations: 4.703 kB / 0.8771 GB, free: 7.859 MB / 0.8386 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl): time 0.8378/0.8379, allocations: 428.4 MB / 1.295 GB, free: 15.23 MB / 1.073 GB
Notification: Performance of NFInst.instExpressions: time 0.08969/0.9276, allocations: 72.43 MB / 1.366 GB, free: 7.297 MB / 1.135 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01593/0.9435, allocations: 0.5076 MB / 1.367 GB, free: 6.785 MB / 1.135 GB
Notification: Performance of NFTyping.typeComponents: time 0.01704/0.9605, allocations: 6.394 MB / 1.373 GB, free: 372 kB / 1.135 GB
Notification: Performance of NFTyping.typeBindings: time 0.03807/0.9986, allocations: 15.31 MB / 1.388 GB, free: 0.9805 MB / 1.151 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0249/1.023, allocations: 10.95 MB / 1.399 GB, free: 6.02 MB / 1.167 GB
Notification: Performance of NFFlatten.flatten: time 0.07027/1.094, allocations: 48.45 MB / 1.446 GB, free: 5.449 MB / 1.214 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02159/1.115, allocations: 11.66 MB / 1.457 GB, free: 9.652 MB / 1.229 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04973/1.165, allocations: 21.07 MB / 1.478 GB, free: 4.559 MB / 1.245 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02082/1.186, allocations: 10.28 MB / 1.488 GB, free: 10.27 MB / 1.26 GB
Notification: Performance of NFPackage.collectConstants: time 0.006443/1.192, allocations: 1.535 MB / 1.489 GB, free: 8.734 MB / 1.26 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02313/1.215, allocations: 8.469 MB / 1.498 GB, free: 252 kB / 1.26 GB
Notification: Performance of NFScalarize.scalarize: time 0.00927/1.225, allocations: 5.166 MB / 1.503 GB, free: 11.06 MB / 1.276 GB
Notification: Performance of NFVerifyModel.verify: time 0.01548/1.24, allocations: 6.056 MB / 1.509 GB, free: 4.992 MB / 1.276 GB
Notification: Performance of NFConvertDAE.convert: time 0.04792/1.288, allocations: 28.66 MB / 1.537 GB, free: 8.246 MB / 1.307 GB
Notification: Performance of FrontEnd - DAE generated: time 8.386e-06/1.288, allocations: 0 / 1.537 GB, free: 8.246 MB / 1.307 GB
Notification: Performance of FrontEnd: time 2.184e-06/1.288, allocations: 0 / 1.537 GB, free: 8.246 MB / 1.307 GB
Notification: Performance of Transformations before backend: time 0.001105/1.289, allocations: 0 / 1.537 GB, free: 8.246 MB / 1.307 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2271
 * Number of variables: 2271
Notification: Performance of Generate backend data structure: time 0.7577/2.047, allocations: 17.94 MB / 1.554 GB, free: 488.6 MB / 1.307 GB
Notification: Performance of prepare preOptimizeDAE: time 4.847e-05/2.047, allocations: 9.031 kB / 1.554 GB, free: 488.6 MB / 1.307 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01764/2.065, allocations: 4.947 MB / 1.559 GB, free: 487.3 MB / 1.307 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02999/2.095, allocations: 17.24 MB / 1.576 GB, free: 480.4 MB / 1.307 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001096/2.096, allocations: 0.8668 MB / 1.577 GB, free: 480 MB / 1.307 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003674/2.099, allocations: 0.9757 MB / 1.578 GB, free: 479.7 MB / 1.307 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02809/2.127, allocations: 14.04 MB / 1.591 GB, free: 472.6 MB / 1.307 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003712/2.128, allocations: 17.33 kB / 1.591 GB, free: 472.6 MB / 1.307 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002422/2.13, allocations: 380.1 kB / 1.592 GB, free: 472.4 MB / 1.307 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003517/2.131, allocations: 378.4 kB / 1.592 GB, free: 472.3 MB / 1.307 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02456/2.155, allocations: 11.4 MB / 1.603 GB, free: 468.6 MB / 1.307 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.06993/2.225, allocations: 39.09 MB / 1.641 GB, free: 443 MB / 1.307 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01332/2.238, allocations: 7.883 MB / 1.649 GB, free: 435.4 MB / 1.307 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006109/2.245, allocations: 4.066 MB / 1.653 GB, free: 431.4 MB / 1.307 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.02651/2.271, allocations: 11.67 MB / 1.664 GB, free: 419.9 MB / 1.307 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007461/2.279, allocations: 5.889 MB / 1.67 GB, free: 413.6 MB / 1.307 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006789/2.285, allocations: 0.9063 MB / 1.671 GB, free: 412.9 MB / 1.307 GB
Notification: Performance of pre-optimization done (n=606): time 2.974e-05/2.285, allocations: 0 / 1.671 GB, free: 412.9 MB / 1.307 GB
Notification: Performance of matching and sorting (n=610): time 0.05253/2.338, allocations: 23.99 MB / 1.694 GB, free: 388.9 MB / 1.307 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.49e-05/2.338, allocations: 341.7 kB / 1.695 GB, free: 388.5 MB / 1.307 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0181/2.356, allocations: 11.9 MB / 1.706 GB, free: 376.7 MB / 1.307 GB
Notification: Performance of collectPreVariables (initialization): time 0.001812/2.358, allocations: 201.7 kB / 1.707 GB, free: 376.5 MB / 1.307 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004407/2.362, allocations: 6.582 MB / 1.713 GB, free: 369.9 MB / 1.307 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002448/2.365, allocations: 2.138 MB / 1.715 GB, free: 367.8 MB / 1.307 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002444/2.367, allocations: 1.752 MB / 1.717 GB, free: 366 MB / 1.307 GB
Notification: Performance of setup shared object (initialization): time 2.669e-05/2.367, allocations: 301.1 kB / 1.717 GB, free: 365.7 MB / 1.307 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005432/2.373, allocations: 3.811 MB / 1.721 GB, free: 361.9 MB / 1.307 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007356/2.38, allocations: 7.948 MB / 1.729 GB, free: 352.5 MB / 1.307 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01283/2.393, allocations: 10.16 MB / 1.739 GB, free: 341.3 MB / 1.307 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.292e-05/2.393, allocations: 20 kB / 1.739 GB, free: 341.3 MB / 1.307 GB
Notification: Performance of matching and sorting (n=1090) (initialization): time 0.02056/2.413, allocations: 12.35 MB / 1.751 GB, free: 328.9 MB / 1.307 GB
Notification: Performance of prepare postOptimizeDAE: time 5.207e-05/2.413, allocations: 36 kB / 1.751 GB, free: 328.8 MB / 1.307 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.513e-05/2.414, allocations: 72.09 kB / 1.751 GB, free: 328.8 MB / 1.307 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002075/2.416, allocations: 0.8525 MB / 1.752 GB, free: 327.9 MB / 1.307 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005553/2.421, allocations: 2.04 MB / 1.754 GB, free: 325.9 MB / 1.307 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00374/2.425, allocations: 6.921 MB / 1.76 GB, free: 318.6 MB / 1.307 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01002/2.435, allocations: 0.7049 MB / 1.761 GB, free: 317.9 MB / 1.307 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001716/2.437, allocations: 431.8 kB / 1.761 GB, free: 317.5 MB / 1.307 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0112/2.448, allocations: 7.098 MB / 1.768 GB, free: 310.4 MB / 1.307 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006327/2.454, allocations: 7.902 MB / 1.776 GB, free: 301 MB / 1.307 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01186/2.466, allocations: 10.04 MB / 1.786 GB, free: 289.9 MB / 1.307 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.252e-05/2.466, allocations: 20 kB / 1.786 GB, free: 289.8 MB / 1.307 GB
Notification: Performance of matching and sorting (n=1090) (initialization_lambda0): time 0.01875/2.485, allocations: 12.14 MB / 1.798 GB, free: 277.6 MB / 1.307 GB
Notification: Performance of prepare postOptimizeDAE: time 4.153e-05/2.485, allocations: 40 kB / 1.798 GB, free: 277.6 MB / 1.307 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.062e-05/2.485, allocations: 76.12 kB / 1.798 GB, free: 277.5 MB / 1.307 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001625/2.487, allocations: 0.6949 MB / 1.799 GB, free: 276.8 MB / 1.307 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005374/2.492, allocations: 2.008 MB / 1.8 GB, free: 274.8 MB / 1.307 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004632/2.497, allocations: 8.345 MB / 1.809 GB, free: 266 MB / 1.307 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009635/2.506, allocations: 0.7384 MB / 1.809 GB, free: 265.3 MB / 1.307 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001667/2.508, allocations: 430.9 kB / 1.81 GB, free: 264.8 MB / 1.307 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 333
 * Number of states: 0 ()
 * Number of discrete variables: 82 ($PRE.wseCon.T1.enableFire,$PRE.wseCon.T2.enableFire,triAndRes.firstTrigger,$PRE.triAndRes.firstTrigger,triAndRes.sampleTrigger,$whenCondition10,triAndRes.uniDel1.firstTrigger,$PRE.triAndRes.uniDel1.firstTrigger,triAndRes.sam.firstTrigger,$PRE.triAndRes.sam.firstTrigger,triAndRes.sam.sampleTrigger,$whenCondition8,triAndRes.uniDel1.sampleTrigger,$whenCondition9,wseCon.stateGraphRoot.resume,wseCon.stateGraphRoot.suspend,chi.tru.y,weaData.conTim.canRepeatWeatherFile,weaData.conTimMin.canRepeatWeatherFile,triAndRes.uniDel1.y,$PRE.triAndRes.uniDel1.y,triAndRes.sam.y,$PRE.triAndRes.sam.y,triAndRes.incY.y,or1.y,or1.u1,weaData.decAng.k,$PRE.weaData.decAng.k,weaData.decAng.tNext,$PRE.weaData.decAng.tNext,weaData.eqnTim.k,$PRE.weaData.eqnTim.k,weaData.eqnTim.tNext,$PRE.weaData.eqnTim.tNext,weaData.conTim.k,$PRE.weaData.conTim.k,weaData.conTim.tNext,$PRE.weaData.conTim.tNext,weaData.conTimMin.k,$PRE.weaData.conTimMin.k,weaData.conTimMin.tNext,$PRE.weaData.conTimMin.tNext,weaData.locTim.k,$PRE.weaData.locTim.k,weaData.locTim.tNext,$PRE.weaData.locTim.tNext,chiSwi.hysteresis.y,$PRE.chiSwi.hysteresis.y,wseCon.stateGraphRoot.activeSteps,wseCon.T2.t_start,$PRE.wseCon.T2.t_start,wseCon.T2.fire,wseCon.T2.enableFire,wseCon.T2.localCondition,wseCon.on.oldActive,$PRE.wseCon.on.oldActive,wseCon.on.newActive,$PRE.wseCon.on.newActive,wseCon.on.localActive,$PRE.wseCon.on.localActive,wseCon.on.active,wseCon.T1.t_start,$PRE.wseCon.T1.t_start,wseCon.T1.fire,wseCon.T1.enableFire,wseCon.T1.localCondition,wseCon.off.active,wseCon.off.oldActive,$PRE.wseCon.off.oldActive,wseCon.off.newActive,$PRE.wseCon.off.newActive,wseCon.off.localActive,$PRE.wseCon.off.localActive,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,EIT.local_reset,EHVAC.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1051):
 * Single equations (assignments): 1037
 * Array equations: 7
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 5
 * 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): 1 system
   {(1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(3,9), (1,2), (2,9), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.002094/2.51, allocations: 0.7506 MB / 1.81 GB, free: 264.1 MB / 1.307 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003362/2.513, allocations: 1.445 MB / 1.812 GB, free: 262.6 MB / 1.307 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01553/2.529, allocations: 9.83 MB / 1.822 GB, free: 252.7 MB / 1.307 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01158/2.54, allocations: 7.657 MB / 1.829 GB, free: 245 MB / 1.307 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.647e-05/2.54, allocations: 0 / 1.829 GB, free: 245 MB / 1.307 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006627/2.547, allocations: 2.221 MB / 1.831 GB, free: 242.7 MB / 1.307 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003438/2.551, allocations: 147.9 kB / 1.831 GB, free: 242.6 MB / 1.307 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006909/2.557, allocations: 0.5483 MB / 1.832 GB, free: 242 MB / 1.307 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001175/2.559, allocations: 456.4 kB / 1.832 GB, free: 241.6 MB / 1.307 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0156/2.574, allocations: 9.277 MB / 1.841 GB, free: 232.3 MB / 1.307 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0211/2.595, allocations: 13.97 MB / 1.855 GB, free: 218.3 MB / 1.307 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.007076/2.602, allocations: 3.696 MB / 1.859 GB, free: 214.5 MB / 1.307 GB
Notification: Performance of sorting global known variables: time 0.01082/2.613, allocations: 8.003 MB / 1.866 GB, free: 206.6 MB / 1.307 GB
Notification: Performance of Backend: time 8.62e-07/2.613, allocations: 4 kB / 1.866 GB, free: 206.6 MB / 1.307 GB
Notification: Performance of simCode: created initialization part: time 0.03247/2.646, allocations: 15.03 MB / 1.881 GB, free: 192.1 MB / 1.307 GB
Notification: Performance of SimCode: time 0.04515/2.691, allocations: 30.42 MB / 1.911 GB, free: 161.7 MB / 1.307 GB
Notification: Performance of Templates: time 0.688/3.379, allocations: 304 MB / 2.208 GB, free: 393.2 MB / 1.307 GB
"
[Timeout remaining time 297]
make -j1 -f Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.pipe ; mkfifo Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.pipe >> ../files/Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.sim & ./Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl  -abortSlowSimulation -alarm=800 -lv LOG_STATS > Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.DiscreteTimeControl.pipe 2>&1) [Timeout 800]
[Calling os._exit(0), Time elapsed: 36.72365268133581]