Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.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.0009251/0.0009251, allocations: 80.81 kB / 21.55 MB, free: 2.938 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.0009786/0.0009786, allocations: 163.3 kB / 24.97 MB, free: 8.223 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.8934/0.8934, allocations: 177.1 MB / 205.4 MB, free: 4.484 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 1.94/1.94, allocations: 389.6 MB / 0.6362 GB, free: 13.33 MB / 0.6042 GB
"
[Timeout remaining time 178]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.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: translateModel(Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS")
translateModel(Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.463e-06/1.463e-06, allocations: 0 / 0.776 GB, free: 13.93 MB / 0.7448 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.634e-05/2.78e-05, allocations: 5.547 kB / 0.776 GB, free: 13.92 MB / 0.7448 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS): time 0.6645/0.6646, allocations: 286.4 MB / 1.056 GB, free: 4.09 MB / 0.9636 GB
Notification: Performance of NFInst.instExpressions: time 0.114/0.7786, allocations: 71.49 MB / 1.125 GB, free: 12.5 MB / 1.042 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02624/0.8048, allocations: 1.007 MB / 1.126 GB, free: 11.49 MB / 1.042 GB
Notification: Performance of NFTyping.typeComponents: time 0.01044/0.8153, allocations: 3.718 MB / 1.13 GB, free: 7.75 MB / 1.042 GB
Notification: Performance of NFTyping.typeBindings: time 0.02478/0.84, allocations: 10.22 MB / 1.14 GB, free: 13.48 MB / 1.057 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01876/0.8588, allocations: 9.496 MB / 1.149 GB, free: 3.984 MB / 1.057 GB
Notification: Performance of NFFlatten.flatten: time 0.06772/0.9265, allocations: 46.17 MB / 1.194 GB, free: 9.234 MB / 1.104 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01277/0.9393, allocations: 7.202 MB / 1.201 GB, free: 1.938 MB / 1.104 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02503/0.9643, allocations: 12.3 MB / 1.213 GB, free: 5.695 MB / 1.12 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01036/0.9747, allocations: 5.258 MB / 1.219 GB, free: 436 kB / 1.12 GB
Notification: Performance of NFPackage.collectConstants: time 0.003386/0.9781, allocations: 1.285 MB / 1.22 GB, free: 15.14 MB / 1.135 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01122/0.9893, allocations: 5.218 MB / 1.225 GB, free: 9.914 MB / 1.135 GB
Notification: Performance of NFScalarize.scalarize: time 0.00445/0.9937, allocations: 3.151 MB / 1.228 GB, free: 6.754 MB / 1.135 GB
Notification: Performance of NFVerifyModel.verify: time 0.008075/1.002, allocations: 3.742 MB / 1.232 GB, free: 3.004 MB / 1.135 GB
Notification: Performance of NFConvertDAE.convert: time 0.5483/1.55, allocations: 10.95 MB / 1.242 GB, free: 84.02 MB / 1.135 GB
Notification: Performance of FrontEnd - DAE generated: time 8.586e-06/1.55, allocations: 3.062 kB / 1.242 GB, free: 84.02 MB / 1.135 GB
Notification: Performance of FrontEnd: time 1.052e-06/1.55, allocations: 0 / 1.242 GB, free: 84.02 MB / 1.135 GB
Notification: Performance of Transformations before backend: time 0.0004255/1.551, allocations: 0 / 1.242 GB, free: 84.02 MB / 1.135 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1282
 * Number of variables: 1282
Notification: Performance of Generate backend data structure: time 0.01937/1.57, allocations: 10.46 MB / 1.253 GB, free: 79.38 MB / 1.135 GB
Notification: Performance of prepare preOptimizeDAE: time 4.912e-05/1.57, allocations: 9.312 kB / 1.253 GB, free: 79.38 MB / 1.135 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009427/1.579, allocations: 2.965 MB / 1.256 GB, free: 79.26 MB / 1.135 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01688/1.596, allocations: 10.46 MB / 1.266 GB, free: 77.48 MB / 1.135 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000308/1.597, allocations: 472.7 kB / 1.266 GB, free: 77.41 MB / 1.135 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008027/1.597, allocations: 0.5378 MB / 1.267 GB, free: 77.41 MB / 1.135 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006613/1.604, allocations: 5.025 MB / 1.272 GB, free: 75.67 MB / 1.135 GB
Notification: Performance of preOpt findStateOrder (simulation): time 9.425e-05/1.604, allocations: 15.06 kB / 1.272 GB, free: 75.67 MB / 1.135 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004199/1.604, allocations: 211.7 kB / 1.272 GB, free: 75.67 MB / 1.135 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000122/1.605, allocations: 189.6 kB / 1.272 GB, free: 75.66 MB / 1.135 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003055/1.608, allocations: 1.737 MB / 1.274 GB, free: 75.51 MB / 1.135 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.0234/1.631, allocations: 21.07 MB / 1.294 GB, free: 67.83 MB / 1.135 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002254/1.633, allocations: 1.573 MB / 1.296 GB, free: 67.68 MB / 1.135 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009558/1.634, allocations: 0.6579 MB / 1.296 GB, free: 67.66 MB / 1.135 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.008741/1.643, allocations: 5.01 MB / 1.301 GB, free: 67.17 MB / 1.135 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00144/1.644, allocations: 1.788 MB / 1.303 GB, free: 66.22 MB / 1.135 GB
Notification: Performance of pre-optimization done (n=263): time 4.739e-06/1.644, allocations: 3.969 kB / 1.303 GB, free: 66.22 MB / 1.135 GB
Notification: Performance of matching and sorting (n=263): time 0.01741/1.662, allocations: 6.32 MB / 1.309 GB, free: 65.96 MB / 1.135 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.147e-05/1.662, allocations: 263.7 kB / 1.31 GB, free: 65.68 MB / 1.135 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005598/1.668, allocations: 5.368 MB / 1.315 GB, free: 65.07 MB / 1.135 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003248/1.668, allocations: 93.55 kB / 1.315 GB, free: 65.04 MB / 1.135 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001496/1.669, allocations: 2.497 MB / 1.317 GB, free: 63.87 MB / 1.135 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005556/1.67, allocations: 0.9631 MB / 1.318 GB, free: 63.25 MB / 1.135 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009793/1.671, allocations: 0.8474 MB / 1.319 GB, free: 63.18 MB / 1.135 GB
Notification: Performance of setup shared object (initialization): time 2.861e-05/1.671, allocations: 308.8 kB / 1.319 GB, free: 62.88 MB / 1.135 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001434/1.672, allocations: 0.6715 MB / 1.32 GB, free: 62.84 MB / 1.135 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002159/1.674, allocations: 3.116 MB / 1.323 GB, free: 59.93 MB / 1.135 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002652/1.677, allocations: 2.499 MB / 1.326 GB, free: 58.59 MB / 1.135 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.532e-05/1.677, allocations: 10.34 kB / 1.326 GB, free: 58.59 MB / 1.135 GB
Notification: Performance of matching and sorting (n=489) (initialization): time 0.006034/1.683, allocations: 3.152 MB / 1.329 GB, free: 58.37 MB / 1.135 GB
Notification: Performance of prepare postOptimizeDAE: time 2.709e-05/1.683, allocations: 19.69 kB / 1.329 GB, free: 58.37 MB / 1.135 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.551e-05/1.683, allocations: 32.97 kB / 1.329 GB, free: 58.37 MB / 1.135 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004451/1.688, allocations: 2.192 MB / 1.331 GB, free: 57.98 MB / 1.135 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002207/1.69, allocations: 0.9305 MB / 1.332 GB, free: 57.97 MB / 1.135 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002848/1.693, allocations: 4.8 MB / 1.336 GB, free: 54.03 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003794/1.697, allocations: 0.5251 MB / 1.337 GB, free: 53.82 MB / 1.135 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003112/1.697, allocations: 190.9 kB / 1.337 GB, free: 53.82 MB / 1.135 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002954/1.7, allocations: 0.8077 MB / 1.338 GB, free: 53.71 MB / 1.135 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001959/1.702, allocations: 3.108 MB / 1.341 GB, free: 50.8 MB / 1.135 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002677/1.704, allocations: 2.441 MB / 1.343 GB, free: 49.47 MB / 1.135 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.569e-05/1.704, allocations: 17.19 kB / 1.343 GB, free: 49.46 MB / 1.135 GB
Notification: Performance of matching and sorting (n=489) (initialization_lambda0): time 0.005009/1.709, allocations: 2.962 MB / 1.346 GB, free: 49.25 MB / 1.135 GB
Notification: Performance of prepare postOptimizeDAE: time 2.016e-05/1.709, allocations: 18.41 kB / 1.346 GB, free: 49.25 MB / 1.135 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.319e-05/1.71, allocations: 34.36 kB / 1.346 GB, free: 49.25 MB / 1.135 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002951/1.712, allocations: 1.816 MB / 1.348 GB, free: 48.89 MB / 1.135 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002126/1.715, allocations: 0.9475 MB / 1.349 GB, free: 48.88 MB / 1.135 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002616/1.717, allocations: 5.028 MB / 1.354 GB, free: 44.76 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003318/1.721, allocations: 469.7 kB / 1.354 GB, free: 44.61 MB / 1.135 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000313/1.721, allocations: 176.2 kB / 1.354 GB, free: 44.61 MB / 1.135 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 150
 * Number of states: 0 ()
 * Number of discrete variables: 13 ($PRE.buiWitETS.bui.loa.nextTimeEvent,$whenCondition1,buiWitETS.ets.con.con1.y,buiWitETS.bui.terUniCoo.hexWetNtu.flowRegime_nominal,buiWitETS.bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,buiWitETS.bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,buiWitETS.bui.terUniCoo.greThr.greHys.y,$PRE.buiWitETS.bui.terUniCoo.greThr.greHys.y,buiWitETS.bui.loa.nextTimeEventScaled,$PRE.buiWitETS.bui.loa.nextTimeEventScaled,buiWitETS.bui.loa.nextTimeEvent,$whenCondition2,buiWitETS.ets.int.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (411):
 * Single equations (assignments): 402
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 4
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(1,5), (1,2), (2,59), (5,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0008667/1.722, allocations: 446.3 kB / 1.355 GB, free: 44.39 MB / 1.135 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007523/1.722, allocations: 488.9 kB / 1.355 GB, free: 44.39 MB / 1.135 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007172/1.73, allocations: 3.048 MB / 1.358 GB, free: 44.01 MB / 1.135 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004645/1.734, allocations: 1.916 MB / 1.36 GB, free: 43.59 MB / 1.135 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.674e-06/1.734, allocations: 5.203 kB / 1.36 GB, free: 43.59 MB / 1.135 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002068/1.736, allocations: 0.9967 MB / 1.361 GB, free: 43.13 MB / 1.135 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006024/1.737, allocations: 61.19 kB / 1.361 GB, free: 43.13 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001651/1.739, allocations: 211.1 kB / 1.361 GB, free: 43.12 MB / 1.135 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002636/1.739, allocations: 182 kB / 1.362 GB, free: 43.11 MB / 1.135 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005584/1.744, allocations: 2.802 MB / 1.364 GB, free: 42.37 MB / 1.135 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003415/1.748, allocations: 2.85 MB / 1.367 GB, free: 41.54 MB / 1.135 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.000849/1.749, allocations: 0.59 MB / 1.368 GB, free: 41.48 MB / 1.135 GB
Notification: Performance of sorting global known variables: time 0.003068/1.752, allocations: 2.675 MB / 1.37 GB, free: 41.26 MB / 1.135 GB
Notification: Performance of Backend: time 3.81e-07/1.752, allocations: 0 / 1.37 GB, free: 41.26 MB / 1.135 GB
Notification: Performance of simCode: created initialization part: time 0.01143/1.763, allocations: 5.423 MB / 1.376 GB, free: 40.24 MB / 1.135 GB
Notification: Performance of SimCode: time 0.02331/1.787, allocations: 17.39 MB / 1.393 GB, free: 31.93 MB / 1.135 GB
Notification: Performance of Templates: time 0.2248/2.011, allocations: 210.5 MB / 1.598 GB, free: 9.078 MB / 1.307 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.pipe ; mkfifo Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.pipe ; head -c 1048576 < Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.pipe >> ../files/Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.sim & ./Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.DHC.Loads.Cooling.Examples.BuildingTimeSeriesWithETS.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 9.677721832878888]