Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.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.0008912/0.0008912, allocations: 80.81 kB / 21.55 MB, free: 2.941 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.0009828/0.0009828, allocations: 168.4 kB / 24.97 MB, free: 9.18 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.9161/0.9161, allocations: 177.1 MB / 205.4 MB, free: 5.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.959/1.959, allocations: 389.6 MB / 0.6362 GB, free: 12.3 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.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed")
translateModel(Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.072e-06/1.072e-06, allocations: 0 / 0.776 GB, free: 5.223 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.103e-05/1.21e-05, allocations: 4.562 kB / 0.776 GB, free: 5.219 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed): time 0.01484/0.01485, allocations: 21.74 MB / 0.7972 GB, free: 15.45 MB / 0.7605 GB
Notification: Performance of NFInst.instExpressions: time 0.01069/0.02555, allocations: 9.176 MB / 0.8062 GB, free: 6.324 MB / 0.7605 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009093/0.02645, allocations: 99.19 kB / 0.8063 GB, free: 6.227 MB / 0.7605 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008659/0.02732, allocations: 0.5273 MB / 0.8068 GB, free: 5.695 MB / 0.7605 GB
Notification: Performance of NFTyping.typeBindings: time 0.002935/0.03026, allocations: 2.198 MB / 0.8089 GB, free: 3.504 MB / 0.7605 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00223/0.03249, allocations: 1.734 MB / 0.8106 GB, free: 1.777 MB / 0.7605 GB
Notification: Performance of NFFlatten.flatten: time 0.003068/0.03555, allocations: 4.676 MB / 0.8152 GB, free: 13.09 MB / 0.7761 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001395/0.03695, allocations: 1.341 MB / 0.8165 GB, free: 11.73 MB / 0.7761 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001902/0.03885, allocations: 2.285 MB / 0.8187 GB, free: 9.457 MB / 0.7761 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009483/0.0398, allocations: 1.064 MB / 0.8198 GB, free: 8.391 MB / 0.7761 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001779/0.03998, allocations: 192 kB / 0.8199 GB, free: 8.203 MB / 0.7761 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001611/0.04159, allocations: 1.46 MB / 0.8214 GB, free: 6.742 MB / 0.7761 GB
Notification: Performance of NFScalarize.scalarize: time 0.0002897/0.04188, allocations: 498.7 kB / 0.8218 GB, free: 6.254 MB / 0.7761 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005176/0.04239, allocations: 0.7023 MB / 0.8225 GB, free: 5.551 MB / 0.7761 GB
Notification: Performance of NFConvertDAE.convert: time 0.001944/0.04434, allocations: 2.344 MB / 0.8248 GB, free: 3.199 MB / 0.7761 GB
Notification: Performance of FrontEnd - DAE generated: time 2.615e-06/0.04434, allocations: 0 / 0.8248 GB, free: 3.199 MB / 0.7761 GB
Notification: Performance of FrontEnd: time 1.623e-06/0.04434, allocations: 4.656 kB / 0.8248 GB, free: 3.195 MB / 0.7761 GB
Notification: Performance of Transformations before backend: time 1.511e-05/0.04436, allocations: 1.188 kB / 0.8248 GB, free: 3.195 MB / 0.7761 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 296
 * Number of variables: 296
Notification: Performance of Generate backend data structure: time 0.00199/0.04635, allocations: 2.148 MB / 0.8269 GB, free: 1.004 MB / 0.7761 GB
Notification: Performance of prepare preOptimizeDAE: time 3.255e-05/0.04638, allocations: 9.344 kB / 0.8269 GB, free: 0.9961 MB / 0.7761 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002136/0.04852, allocations: 0.6478 MB / 0.8276 GB, free: 376 kB / 0.7761 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001177/0.04969, allocations: 0.9797 MB / 0.8285 GB, free: 15.35 MB / 0.7917 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.411e-05/0.04979, allocations: 149.7 kB / 0.8287 GB, free: 15.19 MB / 0.7917 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001447/0.04993, allocations: 128 kB / 0.8288 GB, free: 15.06 MB / 0.7917 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001535/0.05147, allocations: 1.563 MB / 0.8303 GB, free: 13.31 MB / 0.7917 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.449e-05/0.05149, allocations: 11.98 kB / 0.8303 GB, free: 13.3 MB / 0.7917 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.846e-05/0.05158, allocations: 51.98 kB / 0.8304 GB, free: 13.25 MB / 0.7917 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.273e-05/0.05161, allocations: 35.94 kB / 0.8304 GB, free: 13.21 MB / 0.7917 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006573/0.05227, allocations: 484.2 kB / 0.8309 GB, free: 12.72 MB / 0.7917 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.004035/0.05631, allocations: 4.186 MB / 0.835 GB, free: 8.414 MB / 0.7917 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007515/0.05706, allocations: 439.2 kB / 0.8354 GB, free: 7.973 MB / 0.7917 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000227/0.05728, allocations: 187.3 kB / 0.8355 GB, free: 7.789 MB / 0.7917 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002133/0.0575, allocations: 88.58 kB / 0.8356 GB, free: 7.703 MB / 0.7917 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.931e-05/0.05753, allocations: 47.22 kB / 0.8357 GB, free: 7.645 MB / 0.7917 GB
Notification: Performance of pre-optimization done (n=69): time 2.034e-06/0.05753, allocations: 4 kB / 0.8357 GB, free: 7.641 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=69): time 0.004027/0.06156, allocations: 1.395 MB / 0.837 GB, free: 6.238 MB / 0.7917 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.525e-05/0.06159, allocations: 111.5 kB / 0.8372 GB, free: 6.105 MB / 0.7917 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006845/0.06227, allocations: 0.9105 MB / 0.838 GB, free: 5.184 MB / 0.7917 GB
Notification: Performance of collectPreVariables (initialization): time 6.52e-05/0.06234, allocations: 41.7 kB / 0.8381 GB, free: 5.137 MB / 0.7917 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002693/0.06261, allocations: 0.5647 MB / 0.8386 GB, free: 4.562 MB / 0.7917 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001444/0.06275, allocations: 257.8 kB / 0.8389 GB, free: 4.309 MB / 0.7917 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000249/0.063, allocations: 222.3 kB / 0.8391 GB, free: 4.082 MB / 0.7917 GB
Notification: Performance of setup shared object (initialization): time 8.389e-05/0.06309, allocations: 341.9 kB / 0.8394 GB, free: 3.742 MB / 0.7917 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002492/0.06334, allocations: 159.6 kB / 0.8396 GB, free: 3.582 MB / 0.7917 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004402/0.06378, allocations: 0.7213 MB / 0.8403 GB, free: 2.676 MB / 0.7917 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.000566/0.06434, allocations: 0.5508 MB / 0.8408 GB, free: 2.035 MB / 0.7917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.869e-06/0.06435, allocations: 4 kB / 0.8408 GB, free: 2.031 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=112) (initialization): time 0.0008696/0.06522, allocations: 0.6663 MB / 0.8415 GB, free: 1.352 MB / 0.7917 GB
Notification: Performance of prepare postOptimizeDAE: time 1.458e-05/0.06523, allocations: 8.125 kB / 0.8415 GB, free: 1.344 MB / 0.7917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.324e-06/0.06524, allocations: 8 kB / 0.8415 GB, free: 1.336 MB / 0.7917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007281/0.06597, allocations: 360.8 kB / 0.8418 GB, free: 0.9844 MB / 0.7917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007002/0.06667, allocations: 275.5 kB / 0.8421 GB, free: 0.7148 MB / 0.7917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0005694/0.06724, allocations: 0.7201 MB / 0.8428 GB, free: 15.96 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006911/0.06793, allocations: 163.3 kB / 0.8429 GB, free: 15.8 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.349e-05/0.068, allocations: 48.06 kB / 0.843 GB, free: 15.76 MB / 0.8073 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0003898/0.06839, allocations: 251.7 kB / 0.8432 GB, free: 15.51 MB / 0.8073 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0004373/0.06883, allocations: 0.7225 MB / 0.8439 GB, free: 14.61 MB / 0.8073 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0005624/0.06939, allocations: 0.5675 MB / 0.8445 GB, free: 13.94 MB / 0.8073 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.435e-06/0.06939, allocations: 0 / 0.8445 GB, free: 13.94 MB / 0.8073 GB
Notification: Performance of matching and sorting (n=112) (initialization_lambda0): time 0.0008444/0.07024, allocations: 0.6624 MB / 0.8451 GB, free: 13.27 MB / 0.8073 GB
Notification: Performance of prepare postOptimizeDAE: time 8.586e-06/0.07025, allocations: 8 kB / 0.8451 GB, free: 13.26 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.099e-06/0.07025, allocations: 4 kB / 0.8452 GB, free: 13.25 MB / 0.8073 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006623/0.07091, allocations: 367.8 kB / 0.8455 GB, free: 12.9 MB / 0.8073 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006844/0.0716, allocations: 275.5 kB / 0.8458 GB, free: 12.63 MB / 0.8073 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0005248/0.07212, allocations: 0.7222 MB / 0.8465 GB, free: 11.88 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006838/0.07281, allocations: 143.7 kB / 0.8466 GB, free: 11.74 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.91e-05/0.07288, allocations: 43.94 kB / 0.8466 GB, free: 11.7 MB / 0.8073 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 29
 * Number of states: 0 ()
 * Number of discrete variables: 2 (heaPum.com.isOn,$PRE.heaPum.com.isOn)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (92):
 * Single equations (assignments): 91
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
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): 1 system
   {(9,12)}
Notification: Performance of prepare postOptimizeDAE: time 0.0001754/0.07305, allocations: 244 kB / 0.8469 GB, free: 11.45 MB / 0.8073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001415/0.07319, allocations: 95.89 kB / 0.847 GB, free: 11.36 MB / 0.8073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0008321/0.07402, allocations: 0.5895 MB / 0.8475 GB, free: 10.76 MB / 0.8073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004883/0.07451, allocations: 448.9 kB / 0.848 GB, free: 10.29 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.318e-06/0.07452, allocations: 3.984 kB / 0.848 GB, free: 10.29 MB / 0.8073 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002856/0.0748, allocations: 174.9 kB / 0.8481 GB, free: 10.12 MB / 0.8073 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001014/0.0749, allocations: 19.98 kB / 0.8482 GB, free: 10.1 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000565/0.07547, allocations: 87.97 kB / 0.8482 GB, free: 10.01 MB / 0.8073 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.856e-05/0.07554, allocations: 48.56 kB / 0.8483 GB, free: 9.965 MB / 0.8073 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001071/0.07661, allocations: 0.6343 MB / 0.8489 GB, free: 9.32 MB / 0.8073 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0008586/0.07747, allocations: 0.799 MB / 0.8497 GB, free: 8.504 MB / 0.8073 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002169/0.07768, allocations: 171.2 kB / 0.8499 GB, free: 8.332 MB / 0.8073 GB
Notification: Performance of sorting global known variables: time 0.0003462/0.07803, allocations: 453.2 kB / 0.8503 GB, free: 7.883 MB / 0.8073 GB
Notification: Performance of Backend: time 2.71e-07/0.07803, allocations: 0 / 0.8503 GB, free: 7.883 MB / 0.8073 GB
Notification: Performance of simCode: created initialization part: time 0.002857/0.08089, allocations: 1.519 MB / 0.8518 GB, free: 6.352 MB / 0.8073 GB
Notification: Performance of SimCode: time 0.00375/0.08464, allocations: 3.527 MB / 0.8552 GB, free: 2.766 MB / 0.8073 GB
Notification: Performance of Templates: time 0.04419/0.1288, allocations: 45.43 MB / 0.8996 GB, free: 5.953 MB / 0.8542 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.pipe ; mkfifo Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.pipe >> ../files/Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.sim & ./Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.HeatPumps.Validation.ScrollWaterToWater_VariableSpeed.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 5.7146643456071615]