Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.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.0008088/0.0008088, allocations: 92.2 kB / 20.21 MB, free: 4.352 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.0007842/0.0007842, allocations: 165.3 kB / 23.53 MB, free: 1.035 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.9095/0.9095, allocations: 177.1 MB / 203.9 MB, free: 5.617 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.034/2.034, allocations: 428.6 MB / 0.6727 GB, free: 4.918 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.BaseClasses.Controls.Examples.ChillerSetPointControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl")
translateModel(Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.683e-06/1.683e-06, allocations: 0 / 0.8771 GB, free: 7.887 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.301e-05/2.47e-05, allocations: 6.516 kB / 0.8771 GB, free: 7.883 MB / 0.8386 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl): time 0.7069/0.7069, allocations: 248.2 MB / 1.119 GB, free: 53.41 MB / 1.01 GB
Notification: Performance of NFInst.instExpressions: time 0.03637/0.7432, allocations: 27.12 MB / 1.146 GB, free: 51.66 MB / 1.01 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006945/0.7502, allocations: 221.1 kB / 1.146 GB, free: 51.66 MB / 1.01 GB
Notification: Performance of NFTyping.typeComponents: time 0.009797/0.76, allocations: 3.183 MB / 1.149 GB, free: 50.87 MB / 1.01 GB
Notification: Performance of NFTyping.typeBindings: time 0.01699/0.777, allocations: 5.961 MB / 1.155 GB, free: 48.58 MB / 1.01 GB
Notification: Performance of NFTyping.typeClassSections: time 0.011/0.788, allocations: 4.971 MB / 1.16 GB, free: 46.68 MB / 1.01 GB
Notification: Performance of NFFlatten.flatten: time 0.01744/0.8054, allocations: 13.35 MB / 1.173 GB, free: 41.43 MB / 1.01 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005132/0.8105, allocations: 2.791 MB / 1.176 GB, free: 39.75 MB / 1.01 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01397/0.8245, allocations: 6.386 MB / 1.182 GB, free: 37.32 MB / 1.01 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.005374/0.8299, allocations: 2.55 MB / 1.184 GB, free: 36.7 MB / 1.01 GB
Notification: Performance of NFPackage.collectConstants: time 0.001378/0.8313, allocations: 376.5 kB / 1.185 GB, free: 36.7 MB / 1.01 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008141/0.8394, allocations: 3.243 MB / 1.188 GB, free: 35.96 MB / 1.01 GB
Notification: Performance of NFScalarize.scalarize: time 0.001896/0.8413, allocations: 1.333 MB / 1.189 GB, free: 35.25 MB / 1.01 GB
Notification: Performance of NFVerifyModel.verify: time 0.004404/0.8457, allocations: 1.541 MB / 1.191 GB, free: 34.62 MB / 1.01 GB
Notification: Performance of NFConvertDAE.convert: time 0.01445/0.8602, allocations: 7.583 MB / 1.198 GB, free: 32.31 MB / 1.01 GB
Notification: Performance of FrontEnd - DAE generated: time 6.923e-06/0.8602, allocations: 0 / 1.198 GB, free: 32.31 MB / 1.01 GB
Notification: Performance of FrontEnd: time 2.525e-06/0.8602, allocations: 0 / 1.198 GB, free: 32.31 MB / 1.01 GB
Notification: Performance of Transformations before backend: time 0.0002539/0.8604, allocations: 2 kB / 1.198 GB, free: 32.31 MB / 1.01 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 573
 * Number of variables: 573
Notification: Performance of Generate backend data structure: time 0.009912/0.8703, allocations: 5.238 MB / 1.203 GB, free: 29.08 MB / 1.01 GB
Notification: Performance of prepare preOptimizeDAE: time 4.997e-05/0.8704, allocations: 14.72 kB / 1.203 GB, free: 29.07 MB / 1.01 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006374/0.8768, allocations: 1.755 MB / 1.205 GB, free: 28.6 MB / 1.01 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008402/0.8852, allocations: 4.795 MB / 1.21 GB, free: 26.39 MB / 1.01 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002961/0.8855, allocations: 325.6 kB / 1.21 GB, free: 26.17 MB / 1.01 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005448/0.886, allocations: 251.9 kB / 1.21 GB, free: 26.09 MB / 1.01 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004986/0.891, allocations: 3.511 MB / 1.214 GB, free: 24.31 MB / 1.01 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.524e-05/0.891, allocations: 7.984 kB / 1.214 GB, free: 24.31 MB / 1.01 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000196/0.8912, allocations: 90.94 kB / 1.214 GB, free: 24.24 MB / 1.01 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.623e-05/0.8913, allocations: 96.27 kB / 1.214 GB, free: 24.23 MB / 1.01 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005124/0.8964, allocations: 3.018 MB / 1.217 GB, free: 22.95 MB / 1.01 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.01568/0.9121, allocations: 10.35 MB / 1.227 GB, free: 15.62 MB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003895/0.916, allocations: 2.185 MB / 1.229 GB, free: 14.57 MB / 1.01 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001814/0.9178, allocations: 1.093 MB / 1.23 GB, free: 14.04 MB / 1.01 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.006793/0.9246, allocations: 3.28 MB / 1.233 GB, free: 11.83 MB / 1.01 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002056/0.9267, allocations: 1.567 MB / 1.235 GB, free: 10.72 MB / 1.01 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001776/0.9285, allocations: 274 kB / 1.235 GB, free: 10.57 MB / 1.01 GB
Notification: Performance of pre-optimization done (n=147): time 1.249e-05/0.9285, allocations: 0 / 1.235 GB, free: 10.57 MB / 1.01 GB
Notification: Performance of matching and sorting (n=147): time 0.006476/0.9349, allocations: 3.257 MB / 1.238 GB, free: 9.062 MB / 1.01 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.888e-05/0.935, allocations: 128.7 kB / 1.238 GB, free: 8.926 MB / 1.01 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004959/0.9399, allocations: 3.617 MB / 1.242 GB, free: 6.566 MB / 1.01 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004395/0.9404, allocations: 73.7 kB / 1.242 GB, free: 6.488 MB / 1.01 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001012/0.9414, allocations: 1.848 MB / 1.244 GB, free: 4.637 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000509/0.9419, allocations: 0.5124 MB / 1.244 GB, free: 4.133 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000515/0.9424, allocations: 467.6 kB / 1.245 GB, free: 3.668 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 3.703e-05/0.9425, allocations: 313.1 kB / 1.245 GB, free: 3.359 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001777/0.9442, allocations: 1.067 MB / 1.246 GB, free: 2.281 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002182/0.9464, allocations: 2.425 MB / 1.248 GB, free: 15.37 MB / 1.026 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004121/0.9505, allocations: 2.748 MB / 1.251 GB, free: 12.41 MB / 1.026 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.37e-05/0.9506, allocations: 8 kB / 1.251 GB, free: 12.4 MB / 1.026 GB
Notification: Performance of matching and sorting (n=271) (initialization): time 0.006216/0.9568, allocations: 3.324 MB / 1.254 GB, free: 9.203 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 3.129e-05/0.9568, allocations: 12 kB / 1.254 GB, free: 9.191 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.937e-05/0.9568, allocations: 27.97 kB / 1.254 GB, free: 9.164 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.779e-05/0.9569, allocations: 36 kB / 1.254 GB, free: 9.129 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00161/0.9585, allocations: 0.6281 MB / 1.255 GB, free: 8.535 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.951e-05/0.9585, allocations: 47.61 kB / 1.255 GB, free: 8.496 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002563/0.9611, allocations: 287.7 kB / 1.255 GB, free: 8.215 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002128/0.9613, allocations: 120.2 kB / 1.256 GB, free: 8.098 MB / 1.026 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003107/0.9644, allocations: 1.748 MB / 1.257 GB, free: 6.344 MB / 1.026 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002456/0.9669, allocations: 2.399 MB / 1.26 GB, free: 3.461 MB / 1.026 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003878/0.9707, allocations: 2.699 MB / 1.262 GB, free: 0.543 MB / 1.026 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.856e-05/0.9708, allocations: 8 kB / 1.262 GB, free: 0.5352 MB / 1.026 GB
Notification: Performance of matching and sorting (n=271) (initialization_lambda0): time 0.005829/0.9766, allocations: 3.273 MB / 1.265 GB, free: 13.39 MB / 1.042 GB
Notification: Performance of prepare postOptimizeDAE: time 2.403e-05/0.9766, allocations: 16 kB / 1.265 GB, free: 13.38 MB / 1.042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.397e-05/0.9766, allocations: 24.77 kB / 1.265 GB, free: 13.35 MB / 1.042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.464e-05/0.9767, allocations: 32 kB / 1.266 GB, free: 13.32 MB / 1.042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001514/0.9782, allocations: 0.6101 MB / 1.266 GB, free: 12.74 MB / 1.042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.861e-05/0.9782, allocations: 58.03 kB / 1.266 GB, free: 12.7 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002587/0.9808, allocations: 295.7 kB / 1.266 GB, free: 12.41 MB / 1.042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002013/0.981, allocations: 123.6 kB / 1.267 GB, free: 12.29 MB / 1.042 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 98
 * Number of states: 0 ()
 * Number of discrete variables: 19 (triAndRes.firstTrigger,$PRE.triAndRes.firstTrigger,triAndRes.sampleTrigger,$whenCondition3,triAndRes.uniDel1.firstTrigger,$PRE.triAndRes.uniDel1.firstTrigger,triAndRes.sam.firstTrigger,$PRE.triAndRes.sam.firstTrigger,triAndRes.sam.sampleTrigger,$whenCondition1,triAndRes.uniDel1.sampleTrigger,$whenCondition2,chi.tru.y,triAndRes.uniDel1.y,$PRE.triAndRes.uniDel1.y,triAndRes.sam.y,$PRE.triAndRes.sam.y,triAndRes.incY.y,limPID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (270):
 * Single equations (assignments): 269
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0005787/0.9816, allocations: 335.2 kB / 1.267 GB, free: 11.99 MB / 1.042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001043/0.9826, allocations: 435.9 kB / 1.267 GB, free: 11.56 MB / 1.042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004989/0.9876, allocations: 2.645 MB / 1.27 GB, free: 8.93 MB / 1.042 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003422/0.991, allocations: 2.338 MB / 1.272 GB, free: 6.508 MB / 1.042 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.151e-06/0.991, allocations: 0 / 1.272 GB, free: 6.508 MB / 1.042 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001777/0.9928, allocations: 0.6084 MB / 1.273 GB, free: 5.898 MB / 1.042 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005326/0.9934, allocations: 34.53 kB / 1.273 GB, free: 5.867 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001439/0.9948, allocations: 227.8 kB / 1.273 GB, free: 5.645 MB / 1.042 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00015/0.9949, allocations: 97.12 kB / 1.273 GB, free: 5.551 MB / 1.042 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004604/0.9995, allocations: 2.577 MB / 1.276 GB, free: 2.992 MB / 1.042 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.006575/1.006, allocations: 4.071 MB / 1.28 GB, free: 14.91 MB / 1.057 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001682/1.008, allocations: 1.013 MB / 1.281 GB, free: 13.89 MB / 1.057 GB
Notification: Performance of sorting global known variables: time 0.003371/1.011, allocations: 2.437 MB / 1.283 GB, free: 11.45 MB / 1.057 GB
Notification: Performance of Backend: time 6.41e-07/1.011, allocations: 0 / 1.283 GB, free: 11.45 MB / 1.057 GB
Notification: Performance of simCode: created initialization part: time 0.009969/1.021, allocations: 4.516 MB / 1.287 GB, free: 7.367 MB / 1.057 GB
Notification: Performance of SimCode: time 0.01191/1.033, allocations: 8.024 MB / 1.295 GB, free: 15.31 MB / 1.073 GB
Notification: Performance of Templates: time 0.1008/1.134, allocations: 90.12 MB / 1.383 GB, free: 6.93 MB / 1.151 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.pipe ; mkfifo Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.pipe >> ../files/Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.sim & ./Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl  -abortSlowSimulation -alarm=800 -lv LOG_STATS > Buildings_latest_Buildings.Examples.ChillerPlant.DataCenter.BaseClasses.Controls.Examples.ChillerSetPointControl.pipe 2>&1) [Timeout 800]
[Calling sys.exit(0), Time elapsed: 8.030673427507281]