Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.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.001308/0.001308, allocations: 80.81 kB / 21.55 MB, free: 2.945 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.0009794/0.0009794, allocations: 165.9 kB / 24.97 MB, free: 9.184 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.9307/0.9307, 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.963/1.963, allocations: 389.6 MB / 0.6362 GB, free: 12.3 MB / 0.6042 GB
"
[Timeout remaining time 177]
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.Calibration.ScrollWaterToWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater")
translateModel(Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 6.91e-07/6.91e-07, allocations: 0 / 0.776 GB, free: 5.34 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.039e-05/1.108e-05, allocations: 7.766 kB / 0.776 GB, free: 5.332 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater): time 0.02567/0.02568, allocations: 34.09 MB / 0.8093 GB, free: 3.164 MB / 0.7605 GB
Notification: Performance of NFInst.instExpressions: time 0.01653/0.04222, allocations: 9.704 MB / 0.8188 GB, free: 9.5 MB / 0.7761 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001368/0.04359, allocations: 103.1 kB / 0.8189 GB, free: 9.398 MB / 0.7761 GB
Notification: Performance of NFTyping.typeComponents: time 0.001053/0.04464, allocations: 0.5555 MB / 0.8194 GB, free: 8.84 MB / 0.7761 GB
Notification: Performance of NFTyping.typeBindings: time 0.003311/0.04795, allocations: 2.185 MB / 0.8215 GB, free: 6.66 MB / 0.7761 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003537/0.05149, allocations: 1.877 MB / 0.8234 GB, free: 4.789 MB / 0.7761 GB
Notification: Performance of NFFlatten.flatten: time 0.00443/0.05592, allocations: 4.868 MB / 0.8281 GB, free: 15.91 MB / 0.7917 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001917/0.05783, allocations: 1.437 MB / 0.8295 GB, free: 14.44 MB / 0.7917 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002228/0.06006, allocations: 2.372 MB / 0.8318 GB, free: 12.09 MB / 0.7917 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001083/0.06115, allocations: 1.129 MB / 0.8329 GB, free: 10.95 MB / 0.7917 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001985/0.06134, allocations: 201.1 kB / 0.8331 GB, free: 10.76 MB / 0.7917 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002147/0.06349, allocations: 1.498 MB / 0.8346 GB, free: 9.258 MB / 0.7917 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003207/0.06381, allocations: 0.519 MB / 0.8351 GB, free: 8.738 MB / 0.7917 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005966/0.06441, allocations: 0.7366 MB / 0.8358 GB, free: 8 MB / 0.7917 GB
Notification: Performance of NFConvertDAE.convert: time 0.002651/0.06706, allocations: 2.465 MB / 0.8382 GB, free: 5.527 MB / 0.7917 GB
Notification: Performance of FrontEnd - DAE generated: time 3.376e-06/0.06706, allocations: 0 / 0.8382 GB, free: 5.527 MB / 0.7917 GB
Notification: Performance of FrontEnd: time 1.143e-06/0.06706, allocations: 5.031 kB / 0.8382 GB, free: 5.523 MB / 0.7917 GB
Notification: Performance of Transformations before backend: time 1.551e-05/0.06708, allocations: 0 / 0.8382 GB, free: 5.523 MB / 0.7917 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 312
 * Number of variables: 312
Notification: Performance of Generate backend data structure: time 0.00242/0.0695, allocations: 2.312 MB / 0.8405 GB, free: 3.164 MB / 0.7917 GB
Notification: Performance of prepare preOptimizeDAE: time 3.477e-05/0.06953, allocations: 9.344 kB / 0.8405 GB, free: 3.156 MB / 0.7917 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002207/0.07174, allocations: 0.6638 MB / 0.8411 GB, free: 2.512 MB / 0.7917 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001415/0.07316, allocations: 1.045 MB / 0.8422 GB, free: 1.43 MB / 0.7917 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001214/0.07328, allocations: 161.8 kB / 0.8423 GB, free: 1.258 MB / 0.7917 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001455/0.07342, allocations: 136 kB / 0.8425 GB, free: 1.125 MB / 0.7917 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001777/0.0752, allocations: 1.661 MB / 0.8441 GB, free: 15.27 MB / 0.8073 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.064e-05/0.07522, allocations: 4 kB / 0.8441 GB, free: 15.27 MB / 0.8073 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.15e-05/0.07531, allocations: 52.66 kB / 0.8441 GB, free: 15.21 MB / 0.8073 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.094e-05/0.07535, allocations: 44.53 kB / 0.8442 GB, free: 15.17 MB / 0.8073 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007795/0.07613, allocations: 0.5054 MB / 0.8447 GB, free: 14.64 MB / 0.8073 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.004539/0.08067, allocations: 4.499 MB / 0.8491 GB, free: 10.02 MB / 0.8073 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00105/0.08172, allocations: 0.6129 MB / 0.8497 GB, free: 9.391 MB / 0.8073 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005405/0.08226, allocations: 238.4 kB / 0.8499 GB, free: 9.156 MB / 0.8073 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002185/0.08248, allocations: 72.61 kB / 0.85 GB, free: 9.086 MB / 0.8073 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0005924/0.08307, allocations: 0.7719 MB / 0.8507 GB, free: 8.211 MB / 0.8073 GB
Notification: Performance of pre-optimization done (n=81): time 2.765e-06/0.08308, allocations: 0 / 0.8507 GB, free: 8.211 MB / 0.8073 GB
Notification: Performance of matching and sorting (n=81): time 0.007211/0.09029, allocations: 2.23 MB / 0.8529 GB, free: 5.969 MB / 0.8073 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.648e-05/0.09033, allocations: 137.2 kB / 0.853 GB, free: 5.805 MB / 0.8073 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007926/0.09113, allocations: 0.9635 MB / 0.854 GB, free: 4.824 MB / 0.8073 GB
Notification: Performance of collectPreVariables (initialization): time 8.43e-05/0.09121, allocations: 53.7 kB / 0.854 GB, free: 4.766 MB / 0.8073 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003146/0.09152, allocations: 0.5699 MB / 0.8546 GB, free: 4.188 MB / 0.8073 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000192/0.09172, allocations: 289.5 kB / 0.8548 GB, free: 3.902 MB / 0.8073 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002675/0.09198, allocations: 214.4 kB / 0.855 GB, free: 3.688 MB / 0.8073 GB
Notification: Performance of setup shared object (initialization): time 0.0001066/0.09209, allocations: 349.9 kB / 0.8554 GB, free: 3.34 MB / 0.8073 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002889/0.09238, allocations: 175.5 kB / 0.8555 GB, free: 3.164 MB / 0.8073 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005069/0.09289, allocations: 0.7623 MB / 0.8563 GB, free: 2.215 MB / 0.8073 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009408/0.09383, allocations: 0.6261 MB / 0.8569 GB, free: 1.5 MB / 0.8073 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.36e-06/0.09383, allocations: 4 kB / 0.8569 GB, free: 1.496 MB / 0.8073 GB
Notification: Performance of matching and sorting (n=117) (initialization): time 0.001553/0.09539, allocations: 0.7856 MB / 0.8577 GB, free: 0.6953 MB / 0.8073 GB
Notification: Performance of prepare postOptimizeDAE: time 2.543e-05/0.09541, allocations: 11.94 kB / 0.8577 GB, free: 0.6836 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.737e-06/0.09542, allocations: 4 kB / 0.8577 GB, free: 0.6797 MB / 0.8073 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008965/0.09632, allocations: 425.8 kB / 0.8581 GB, free: 272 kB / 0.8073 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000737/0.09705, allocations: 275.5 kB / 0.8584 GB, free: 15.99 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007293/0.09778, allocations: 0.7763 MB / 0.8591 GB, free: 15.19 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006805/0.09846, allocations: 139.3 kB / 0.8592 GB, free: 15.05 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.546e-05/0.09855, allocations: 51.94 kB / 0.8593 GB, free: 15 MB / 0.823 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0004494/0.099, allocations: 267.7 kB / 0.8596 GB, free: 14.74 MB / 0.823 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0004899/0.09949, allocations: 0.7675 MB / 0.8603 GB, free: 13.78 MB / 0.823 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0006537/0.1001, allocations: 0.6 MB / 0.8609 GB, free: 13.09 MB / 0.823 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.768e-06/0.1001, allocations: 7.938 kB / 0.8609 GB, free: 13.08 MB / 0.823 GB
Notification: Performance of matching and sorting (n=117) (initialization_lambda0): time 0.001545/0.1017, allocations: 0.7895 MB / 0.8617 GB, free: 12.28 MB / 0.823 GB
Notification: Performance of prepare postOptimizeDAE: time 1.249e-05/0.1017, allocations: 15.97 kB / 0.8617 GB, free: 12.26 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.812e-06/0.1017, allocations: 7.938 kB / 0.8617 GB, free: 12.25 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007975/0.1025, allocations: 410.4 kB / 0.8621 GB, free: 11.85 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007687/0.1033, allocations: 275.5 kB / 0.8623 GB, free: 11.58 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006938/0.104, allocations: 0.7841 MB / 0.8631 GB, free: 10.77 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000635/0.1046, allocations: 135.4 kB / 0.8632 GB, free: 10.64 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.644e-05/0.1047, allocations: 47.94 kB / 0.8633 GB, free: 10.59 MB / 0.823 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 28
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($PRE.calDat.nextTimeEvent,$whenCondition1,heaPum.com.isOn,$PRE.heaPum.com.isOn,calDat.nextTimeEventScaled,$PRE.calDat.nextTimeEventScaled,calDat.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (89):
 * Single equations (assignments): 88
 * 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
   {(11,18)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003736/0.1051, allocations: 249.8 kB / 0.8635 GB, free: 10.34 MB / 0.823 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001618/0.1052, allocations: 111.9 kB / 0.8636 GB, free: 10.23 MB / 0.823 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001095/0.1063, allocations: 0.7486 MB / 0.8644 GB, free: 9.465 MB / 0.823 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006606/0.107, allocations: 0.5537 MB / 0.8649 GB, free: 8.879 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.867e-06/0.107, allocations: 4 kB / 0.8649 GB, free: 8.875 MB / 0.823 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003542/0.1073, allocations: 206.8 kB / 0.8651 GB, free: 8.672 MB / 0.823 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001161/0.1074, allocations: 19.94 kB / 0.8651 GB, free: 8.652 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005856/0.108, allocations: 83.91 kB / 0.8652 GB, free: 8.57 MB / 0.823 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.344e-05/0.1081, allocations: 52.89 kB / 0.8653 GB, free: 8.52 MB / 0.823 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001336/0.1095, allocations: 0.7771 MB / 0.866 GB, free: 7.734 MB / 0.823 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001112/0.1106, allocations: 0.9922 MB / 0.867 GB, free: 6.727 MB / 0.823 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002914/0.1109, allocations: 234.6 kB / 0.8672 GB, free: 6.492 MB / 0.823 GB
Notification: Performance of sorting global known variables: time 0.0004511/0.1113, allocations: 492.8 kB / 0.8677 GB, free: 6.004 MB / 0.823 GB
Notification: Performance of Backend: time 6.31e-07/0.1113, allocations: 0 / 0.8677 GB, free: 6.004 MB / 0.823 GB
Notification: Performance of simCode: created initialization part: time 0.004639/0.1159, allocations: 2.164 MB / 0.8698 GB, free: 4.16 MB / 0.823 GB
Notification: Performance of SimCode: time 0.004532/0.1205, allocations: 3.8 MB / 0.8735 GB, free: 316 kB / 0.823 GB
Notification: Performance of Templates: time 0.05051/0.171, allocations: 48.08 MB / 0.9204 GB, free: 0.8516 MB / 0.8698 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.pipe ; mkfifo Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.pipe ; head -c 1048576 < Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.pipe >> ../files/Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.sim & ./Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Fluid.HeatPumps.Calibration.ScrollWaterToWater.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 5.9912041537463665]