Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.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.001696/0.001696, allocations: 79.97 kB / 19.76 MB, free: 1.875 MB / 14.72 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.002155/0.002155, allocations: 162.5 kB / 23.01 MB, free: 4.602 MB / 14.72 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 1.492/1.492, allocations: 177.2 MB / 203.4 MB, free: 8.969 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.84/2.84, allocations: 377.9 MB / 0.6228 GB, free: 12.56 MB / 0.5919 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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.Geothermal.Boreholes.Examples.UTube,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|borHol.port_a.m_flow|borHol.sta_a.T|borHol.sta_b.T|borHol.borHol.1..TBouCon.port.T|borHol.borHol.2..TBouCon.port.T|borHol.borHol.3..TBouCon.port.T|borHol.borHol.4..TBouCon.port.T|borHol.borHol.5..TBouCon.port.T|borHol.borHol.6..TBouCon.port.T|borHol.borHol.7..TBouCon.port.T|borHol.borHol.8..TBouCon.port.T|borHol.borHol.9..TBouCon.port.T|borHol.borHol.10..TBouCon.port.T|borHol.borHol.10..soi.T.5.",fileNamePrefix="Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube")
translateModel(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|borHol.port_a.m_flow|borHol.sta_a.T|borHol.sta_b.T|borHol.borHol.1..TBouCon.port.T|borHol.borHol.2..TBouCon.port.T|borHol.borHol.3..TBouCon.port.T|borHol.borHol.4..TBouCon.port.T|borHol.borHol.5..TBouCon.port.T|borHol.borHol.6..TBouCon.port.T|borHol.borHol.7..TBouCon.port.T|borHol.borHol.8..TBouCon.port.T|borHol.borHol.9..TBouCon.port.T|borHol.borHol.10..TBouCon.port.T|borHol.borHol.10..soi.T.5.",fileNamePrefix="Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002109/0.002109, allocations: 63.89 kB / 0.9819 GB, free: 12.18 MB / 0.9356 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.9501/0.9522, allocations: 176.1 MB / 1.154 GB, free: 33.3 MB / 1.076 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube): time 0.04214/0.9944, allocations: 49.06 MB / 1.202 GB, free: 292 kB / 1.076 GB
Notification: Performance of NFInst.instExpressions: time 0.02487/1.019, allocations: 13.56 MB / 1.215 GB, free: 6.965 MB / 1.092 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00373/1.023, allocations: 103.4 kB / 1.215 GB, free: 6.91 MB / 1.092 GB
Notification: Performance of NFTyping.typeComponents: time 0.003573/1.027, allocations: 0.9766 MB / 1.216 GB, free: 6.352 MB / 1.092 GB
Notification: Performance of NFTyping.typeBindings: time 0.01033/1.037, allocations: 2.971 MB / 1.219 GB, free: 4.566 MB / 1.092 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/Fluid/Geothermal/Boreholes/BaseClasses/temperatureDrop.mo:2:1-109:20:writable] Warning: Pure function 'Buildings.Fluid.Geothermal.Boreholes.BaseClasses.temperatureDrop' contains a call to impure function 'Buildings.Fluid.Geothermal.Boreholes.BaseClasses.exchangeValues'.
Notification: Performance of NFTyping.typeClassSections: time 0.005882/1.043, allocations: 1.826 MB / 1.221 GB, free: 3.492 MB / 1.092 GB
Notification: Performance of NFFlatten.flatten: time 0.09361/1.136, allocations: 56.94 MB / 1.276 GB, free: 6.188 MB / 1.123 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04586/1.182, allocations: 16.69 MB / 1.293 GB, free: 10.68 MB / 1.139 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04809/1.23, allocations: 18.51 MB / 1.311 GB, free: 8.188 MB / 1.154 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0433/1.274, allocations: 18.79 MB / 1.329 GB, free: 5.34 MB / 1.17 GB
Notification: Performance of NFPackage.collectConstants: time 0.0117/1.285, allocations: 3.324 MB / 1.332 GB, free: 2.016 MB / 1.17 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02331/1.309, allocations: 4.935 MB / 1.337 GB, free: 13.08 MB / 1.186 GB
Notification: Performance of NFScalarize.scalarize: time 0.01812/1.327, allocations: 7.894 MB / 1.345 GB, free: 5.164 MB / 1.186 GB
Notification: Performance of NFVerifyModel.verify: time 0.03392/1.361, allocations: 11.14 MB / 1.356 GB, free: 9.988 MB / 1.201 GB
Notification: Performance of NFConvertDAE.convert: time 0.07713/1.438, allocations: 46.74 MB / 1.401 GB, free: 11.12 MB / 1.248 GB
Notification: Performance of FrontEnd - DAE generated: time 7.935e-06/1.438, allocations: 0 / 1.401 GB, free: 11.12 MB / 1.248 GB
Notification: Performance of FrontEnd: time 2.074e-06/1.438, allocations: 0 / 1.401 GB, free: 11.12 MB / 1.248 GB
Notification: Performance of Transformations before backend: time 0.00117/1.439, allocations: 0 / 1.401 GB, free: 11.12 MB / 1.248 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2751
 * Number of variables: 2751
Notification: Performance of Generate backend data structure: time 0.09857/1.538, allocations: 26.82 MB / 1.428 GB, free: 120 kB / 1.264 GB
Notification: Performance of prepare preOptimizeDAE: time 5.029e-05/1.538, allocations: 8.031 kB / 1.428 GB, free: 112 kB / 1.264 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04801/1.586, allocations: 6.751 MB / 1.434 GB, free: 9.34 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.06143/1.647, allocations: 23.82 MB / 1.457 GB, free: 1.387 MB / 1.295 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001482/1.649, allocations: 0.9585 MB / 1.458 GB, free: 436 kB / 1.295 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008097/1.657, allocations: 1.363 MB / 1.46 GB, free: 15.06 MB / 1.311 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05382/1.71, allocations: 19.37 MB / 1.479 GB, free: 11.01 MB / 1.326 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007576/1.711, allocations: 39.77 kB / 1.479 GB, free: 10.97 MB / 1.326 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00467/1.716, allocations: 456 kB / 1.479 GB, free: 10.53 MB / 1.326 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004027/1.716, allocations: 307.9 kB / 1.479 GB, free: 10.23 MB / 1.326 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0439/1.76, allocations: 16 MB / 1.495 GB, free: 10.2 MB / 1.342 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.2014/1.962, allocations: 71.38 MB / 1.565 GB, free: 2.23 MB / 1.404 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04358/2.005, allocations: 17.67 MB / 1.582 GB, free: 0.543 MB / 1.42 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01537/2.021, allocations: 6.875 MB / 1.589 GB, free: 9.641 MB / 1.436 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001199/2.022, allocations: 177.9 kB / 1.589 GB, free: 9.465 MB / 1.436 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01681/2.039, allocations: 8.4 MB / 1.597 GB, free: 0.6328 MB / 1.436 GB
Notification: Performance of pre-optimization done (n=784): time 1.852e-05/2.039, allocations: 0 / 1.597 GB, free: 0.6328 MB / 1.436 GB
Notification: Performance of matching and sorting (n=784): time 0.05737/2.096, allocations: 20.36 MB / 1.617 GB, free: 12.12 MB / 1.467 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002673/2.096, allocations: 240.9 kB / 1.617 GB, free: 11.86 MB / 1.467 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03992/2.136, allocations: 16.69 MB / 1.634 GB, free: 11.21 MB / 1.482 GB
Notification: Performance of collectPreVariables (initialization): time 0.004729/2.141, allocations: 317.7 kB / 1.634 GB, free: 10.9 MB / 1.482 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01394/2.155, allocations: 6.969 MB / 1.641 GB, free: 3.895 MB / 1.482 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007258/2.162, allocations: 2.979 MB / 1.644 GB, free: 0.8906 MB / 1.482 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01669/2.179, allocations: 3.18 MB / 1.647 GB, free: 13.7 MB / 1.498 GB
Notification: Performance of setup shared object (initialization): time 0.0001408/2.179, allocations: 305.1 kB / 1.647 GB, free: 13.39 MB / 1.498 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02566/2.205, allocations: 11.22 MB / 1.658 GB, free: 2.152 MB / 1.498 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03109/2.236, allocations: 15.73 MB / 1.673 GB, free: 1.027 MB / 1.514 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04516/2.281, allocations: 20.18 MB / 1.693 GB, free: 12.01 MB / 1.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001686/2.281, allocations: 20 kB / 1.693 GB, free: 11.99 MB / 1.545 GB
Notification: Performance of matching and sorting (n=1795) (initialization): time 0.0796/2.361, allocations: 28.87 MB / 1.721 GB, free: 14.99 MB / 1.576 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001904/2.361, allocations: 53.7 kB / 1.721 GB, free: 14.93 MB / 1.576 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003338/2.361, allocations: 79.92 kB / 1.721 GB, free: 14.85 MB / 1.576 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004575/2.366, allocations: 1.825 MB / 1.723 GB, free: 12.93 MB / 1.576 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02034/2.386, allocations: 3.689 MB / 1.727 GB, free: 9.238 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.37/3.756, allocations: 54.42 MB / 1.78 GB, free: 412.6 MB / 1.576 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03273/3.789, allocations: 4.01 MB / 1.784 GB, free: 412.4 MB / 1.576 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004803/3.794, allocations: 0.54 MB / 1.784 GB, free: 412.2 MB / 1.576 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0387/3.832, allocations: 17.71 MB / 1.802 GB, free: 405.8 MB / 1.576 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02808/3.86, allocations: 15.73 MB / 1.817 GB, free: 397 MB / 1.576 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.045/3.905, allocations: 20.17 MB / 1.837 GB, free: 387.6 MB / 1.576 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0002485/3.906, allocations: 16 kB / 1.837 GB, free: 387.6 MB / 1.576 GB
Notification: Performance of matching and sorting (n=1795) (initialization_lambda0): time 0.08015/3.986, allocations: 28.88 MB / 1.865 GB, free: 377.8 MB / 1.576 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00023/3.986, allocations: 56.17 kB / 1.865 GB, free: 377.8 MB / 1.576 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003504/3.986, allocations: 82.38 kB / 1.865 GB, free: 377.8 MB / 1.576 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004024/3.99, allocations: 1.821 MB / 1.867 GB, free: 377.1 MB / 1.576 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01874/4.009, allocations: 3.68 MB / 1.87 GB, free: 376.8 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03288/4.042, allocations: 54.42 MB / 1.923 GB, free: 329.9 MB / 1.576 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03447/4.077, allocations: 3.834 MB / 1.927 GB, free: 329.7 MB / 1.576 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004793/4.081, allocations: 0.5454 MB / 1.928 GB, free: 329.6 MB / 1.576 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 261
 * Number of states: 0 ()
 * Number of discrete variables: 95 (borHol.borHol[1].TBouCon.iSam,$PRE.borHol.borHol[1].TBouCon.iSam,borHol.borHol[1].TBouCon.UOld,$PRE.borHol.borHol[1].TBouCon.UOld,borHol.borHol[1].TBouCon.QAve_flow,$PRE.borHol.borHol[1].TBouCon.QAve_flow,borHol.borHol[2].TBouCon.iSam,$PRE.borHol.borHol[2].TBouCon.iSam,borHol.borHol[2].TBouCon.UOld,$PRE.borHol.borHol[2].TBouCon.UOld,borHol.borHol[2].TBouCon.QAve_flow,$PRE.borHol.borHol[2].TBouCon.QAve_flow,borHol.borHol[3].TBouCon.iSam,$PRE.borHol.borHol[3].TBouCon.iSam,borHol.borHol[3].TBouCon.UOld,$PRE.borHol.borHol[3].TBouCon.UOld,borHol.borHol[3].TBouCon.QAve_flow,$PRE.borHol.borHol[3].TBouCon.QAve_flow,borHol.borHol[4].TBouCon.iSam,$PRE.borHol.borHol[4].TBouCon.iSam,borHol.borHol[4].TBouCon.UOld,$PRE.borHol.borHol[4].TBouCon.UOld,borHol.borHol[4].TBouCon.QAve_flow,$PRE.borHol.borHol[4].TBouCon.QAve_flow,borHol.borHol[5].TBouCon.iSam,$PRE.borHol.borHol[5].TBouCon.iSam,borHol.borHol[5].TBouCon.UOld,$PRE.borHol.borHol[5].TBouCon.UOld,borHol.borHol[5].TBouCon.QAve_flow,$PRE.borHol.borHol[5].TBouCon.QAve_flow,borHol.borHol[6].TBouCon.iSam,$PRE.borHol.borHol[6].TBouCon.iSam,borHol.borHol[6].TBouCon.UOld,$PRE.borHol.borHol[6].TBouCon.UOld,borHol.borHol[6].TBouCon.QAve_flow,$PRE.borHol.borHol[6].TBouCon.QAve_flow,borHol.borHol[7].TBouCon.iSam,$PRE.borHol.borHol[7].TBouCon.iSam,borHol.borHol[7].TBouCon.UOld,$PRE.borHol.borHol[7].TBouCon.UOld,borHol.borHol[7].TBouCon.QAve_flow,$PRE.borHol.borHol[7].TBouCon.QAve_flow,borHol.borHol[8].TBouCon.iSam,$PRE.borHol.borHol[8].TBouCon.iSam,borHol.borHol[8].TBouCon.UOld,$PRE.borHol.borHol[8].TBouCon.UOld,borHol.borHol[8].TBouCon.QAve_flow,$PRE.borHol.borHol[8].TBouCon.QAve_flow,borHol.borHol[9].TBouCon.iSam,$PRE.borHol.borHol[9].TBouCon.iSam,borHol.borHol[9].TBouCon.UOld,$PRE.borHol.borHol[9].TBouCon.UOld,borHol.borHol[9].TBouCon.QAve_flow,$PRE.borHol.borHol[9].TBouCon.QAve_flow,borHol.borHol[10].TBouCon.iSam,$PRE.borHol.borHol[10].TBouCon.iSam,borHol.borHol[10].TBouCon.UOld,$PRE.borHol.borHol[10].TBouCon.UOld,borHol.borHol[10].TBouCon.QAve_flow,$PRE.borHol.borHol[10].TBouCon.QAve_flow,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,borHol.borHol[10].TBouCon.port.T,$PRE.borHol.borHol[10].TBouCon.port.T,borHol.borHol[9].TBouCon.port.T,$PRE.borHol.borHol[9].TBouCon.port.T,borHol.borHol[8].TBouCon.port.T,$PRE.borHol.borHol[8].TBouCon.port.T,borHol.borHol[7].TBouCon.port.T,$PRE.borHol.borHol[7].TBouCon.port.T,borHol.borHol[6].TBouCon.port.T,$PRE.borHol.borHol[6].TBouCon.port.T,borHol.borHol[5].TBouCon.port.T,$PRE.borHol.borHol[5].TBouCon.port.T,borHol.borHol[4].TBouCon.port.T,$PRE.borHol.borHol[4].TBouCon.port.T,borHol.borHol[3].TBouCon.port.T,$PRE.borHol.borHol[3].TBouCon.port.T,borHol.borHol[2].TBouCon.port.T,$PRE.borHol.borHol[2].TBouCon.port.T,borHol.borHol[1].TBouCon.port.T,$PRE.borHol.borHol[1].TBouCon.port.T,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1654):
 * Single equations (assignments): 1613
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 10
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 30
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 30 systems
   {(1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0058/4.087, allocations: 0.9772 MB / 1.929 GB, free: 328.9 MB / 1.576 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006395/4.093, allocations: 1.33 MB / 1.93 GB, free: 328.3 MB / 1.576 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02884/4.122, allocations: 14.64 MB / 1.944 GB, free: 322.8 MB / 1.576 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.632e-05/4.122, allocations: 80.08 kB / 1.944 GB, free: 322.8 MB / 1.576 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.252e-05/4.122, allocations: 19.12 kB / 1.944 GB, free: 322.8 MB / 1.576 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0183/4.141, allocations: 12.44 MB / 1.957 GB, free: 311.9 MB / 1.576 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 postOpt removeSimpleEquations (simulation): time 0.06436/4.205, allocations: 31.02 MB / 1.987 GB, free: 281 MB / 1.576 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.316e-05/4.205, allocations: 0 / 1.987 GB, free: 281 MB / 1.576 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.007288/4.212, allocations: 1.467 MB / 1.988 GB, free: 279.5 MB / 1.576 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00322/4.216, allocations: 1.735 MB / 1.99 GB, free: 277.7 MB / 1.576 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001696/4.217, allocations: 351.7 kB / 1.99 GB, free: 277.3 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03219/4.25, allocations: 54.47 MB / 2.044 GB, free: 219.9 MB / 1.576 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.785e-06/4.25, allocations: 3.938 kB / 2.044 GB, free: 219.9 MB / 1.576 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03576/4.285, allocations: 21.87 MB / 2.065 GB, free: 197.9 MB / 1.576 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01323/4.299, allocations: 3.797 MB / 2.069 GB, free: 194.2 MB / 1.576 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005642/4.304, allocations: 359.8 kB / 2.069 GB, free: 193.8 MB / 1.576 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01748/4.322, allocations: 1.365 MB / 2.07 GB, free: 192.4 MB / 1.576 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002391/4.324, allocations: 0.536 MB / 2.071 GB, free: 191.9 MB / 1.576 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001983/4.326, allocations: 295.8 kB / 2.071 GB, free: 191.6 MB / 1.576 GB
Notification: Performance of sorting global known variables: time 0.02361/4.35, allocations: 11.46 MB / 2.082 GB, free: 180.2 MB / 1.576 GB
Notification: Performance of sort global known variables: time 2.2e-07/4.35, allocations: 0 / 2.082 GB, free: 180.2 MB / 1.576 GB
Notification: Performance of remove unused functions: time 0.04916/4.399, allocations: 12.83 MB / 2.095 GB, free: 167.9 MB / 1.576 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 150 (borHol.borHol[1].pipFil.vol1.dynBal.U,borHol.borHol[1].pipFil.vol2.dynBal.U,borHol.borHol[1].pipFil.capFil1.T,borHol.borHol[1].pipFil.capFil2.T,borHol.borHol[1].soi.T[1],borHol.borHol[1].soi.T[2],borHol.borHol[1].soi.T[3],borHol.borHol[1].soi.T[4],borHol.borHol[1].soi.T[5],borHol.borHol[1].soi.T[6],borHol.borHol[1].soi.T[7],borHol.borHol[1].soi.T[8],borHol.borHol[1].soi.T[9],borHol.borHol[1].soi.T[10],borHol.borHol[1].TBouCon.U,borHol.borHol[2].pipFil.vol1.dynBal.U,borHol.borHol[2].pipFil.vol2.dynBal.U,borHol.borHol[2].pipFil.capFil1.T,borHol.borHol[2].pipFil.capFil2.T,borHol.borHol[2].soi.T[1],borHol.borHol[2].soi.T[2],borHol.borHol[2].soi.T[3],borHol.borHol[2].soi.T[4],borHol.borHol[2].soi.T[5],borHol.borHol[2].soi.T[6],borHol.borHol[2].soi.T[7],borHol.borHol[2].soi.T[8],borHol.borHol[2].soi.T[9],borHol.borHol[2].soi.T[10],borHol.borHol[2].TBouCon.U,borHol.borHol[3].pipFil.vol1.dynBal.U,borHol.borHol[3].pipFil.vol2.dynBal.U,borHol.borHol[3].pipFil.capFil1.T,borHol.borHol[3].pipFil.capFil2.T,borHol.borHol[3].soi.T[1],borHol.borHol[3].soi.T[2],borHol.borHol[3].soi.T[3],borHol.borHol[3].soi.T[4],borHol.borHol[3].soi.T[5],borHol.borHol[3].soi.T[6],borHol.borHol[3].soi.T[7],borHol.borHol[3].soi.T[8],borHol.borHol[3].soi.T[9],borHol.borHol[3].soi.T[10],borHol.borHol[3].TBouCon.U,borHol.borHol[4].pipFil.vol1.dynBal.U,borHol.borHol[4].pipFil.vol2.dynBal.U,borHol.borHol[4].pipFil.capFil1.T,borHol.borHol[4].pipFil.capFil2.T,borHol.borHol[4].soi.T[1],borHol.borHol[4].soi.T[2],borHol.borHol[4].soi.T[3],borHol.borHol[4].soi.T[4],borHol.borHol[4].soi.T[5],borHol.borHol[4].soi.T[6],borHol.borHol[4].soi.T[7],borHol.borHol[4].soi.T[8],borHol.borHol[4].soi.T[9],borHol.borHol[4].soi.T[10],borHol.borHol[4].TBouCon.U,borHol.borHol[5].pipFil.vol1.dynBal.U,borHol.borHol[5].pipFil.vol2.dynBal.U,borHol.borHol[5].pipFil.capFil1.T,borHol.borHol[5].pipFil.capFil2.T,borHol.borHol[5].soi.T[1],borHol.borHol[5].soi.T[2],borHol.borHol[5].soi.T[3],borHol.borHol[5].soi.T[4],borHol.borHol[5].soi.T[5],borHol.borHol[5].soi.T[6],borHol.borHol[5].soi.T[7],borHol.borHol[5].soi.T[8],borHol.borHol[5].soi.T[9],borHol.borHol[5].soi.T[10],borHol.borHol[5].TBouCon.U,borHol.borHol[6].pipFil.vol1.dynBal.U,borHol.borHol[6].pipFil.vol2.dynBal.U,borHol.borHol[6].pipFil.capFil1.T,borHol.borHol[6].pipFil.capFil2.T,borHol.borHol[6].soi.T[1],borHol.borHol[6].soi.T[2],borHol.borHol[6].soi.T[3],borHol.borHol[6].soi.T[4],borHol.borHol[6].soi.T[5],borHol.borHol[6].soi.T[6],borHol.borHol[6].soi.T[7],borHol.borHol[6].soi.T[8],borHol.borHol[6].soi.T[9],borHol.borHol[6].soi.T[10],borHol.borHol[6].TBouCon.U,borHol.borHol[7].pipFil.vol1.dynBal.U,borHol.borHol[7].pipFil.vol2.dynBal.U,borHol.borHol[7].pipFil.capFil1.T,borHol.borHol[7].pipFil.capFil2.T,borHol.borHol[7].soi.T[1],borHol.borHol[7].soi.T[2],borHol.borHol[7].soi.T[3],borHol.borHol[7].soi.T[4],borHol.borHol[7].soi.T[5],borHol.borHol[7].soi.T[6],borHol.borHol[7].soi.T[7],borHol.borHol[7].soi.T[8],borHol.borHol[7].soi.T[9],borHol.borHol[7].soi.T[10],borHol.borHol[7].TBouCon.U,borHol.borHol[8].pipFil.vol1.dynBal.U,borHol.borHol[8].pipFil.vol2.dynBal.U,borHol.borHol[8].pipFil.capFil1.T,borHol.borHol[8].pipFil.capFil2.T,borHol.borHol[8].soi.T[1],borHol.borHol[8].soi.T[2],borHol.borHol[8].soi.T[3],borHol.borHol[8].soi.T[4],borHol.borHol[8].soi.T[5],borHol.borHol[8].soi.T[6],borHol.borHol[8].soi.T[7],borHol.borHol[8].soi.T[8],borHol.borHol[8].soi.T[9],borHol.borHol[8].soi.T[10],borHol.borHol[8].TBouCon.U,borHol.borHol[9].pipFil.vol1.dynBal.U,borHol.borHol[9].pipFil.vol2.dynBal.U,borHol.borHol[9].pipFil.capFil1.T,borHol.borHol[9].pipFil.capFil2.T,borHol.borHol[9].soi.T[1],borHol.borHol[9].soi.T[2],borHol.borHol[9].soi.T[3],borHol.borHol[9].soi.T[4],borHol.borHol[9].soi.T[5],borHol.borHol[9].soi.T[6],borHol.borHol[9].soi.T[7],borHol.borHol[9].soi.T[8],borHol.borHol[9].soi.T[9],borHol.borHol[9].soi.T[10],borHol.borHol[9].TBouCon.U,borHol.borHol[10].pipFil.vol1.dynBal.U,borHol.borHol[10].pipFil.vol2.dynBal.U,borHol.borHol[10].pipFil.capFil1.T,borHol.borHol[10].pipFil.capFil2.T,borHol.borHol[10].soi.T[1],borHol.borHol[10].soi.T[2],borHol.borHol[10].soi.T[3],borHol.borHol[10].soi.T[4],borHol.borHol[10].soi.T[5],borHol.borHol[10].soi.T[6],borHol.borHol[10].soi.T[7],borHol.borHol[10].soi.T[8],borHol.borHol[10].soi.T[9],borHol.borHol[10].soi.T[10],borHol.borHol[10].TBouCon.U)
 * Number of discrete variables: 53 ($whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,borHol.borHol[1].TBouCon.QAve_flow,borHol.borHol[1].TBouCon.port.T,borHol.borHol[1].TBouCon.UOld,borHol.borHol[1].TBouCon.iSam,borHol.borHol[2].TBouCon.QAve_flow,borHol.borHol[2].TBouCon.port.T,borHol.borHol[2].TBouCon.UOld,borHol.borHol[2].TBouCon.iSam,borHol.borHol[3].TBouCon.QAve_flow,borHol.borHol[3].TBouCon.port.T,borHol.borHol[3].TBouCon.UOld,borHol.borHol[3].TBouCon.iSam,borHol.borHol[4].TBouCon.QAve_flow,borHol.borHol[4].TBouCon.port.T,borHol.borHol[4].TBouCon.UOld,borHol.borHol[4].TBouCon.iSam,borHol.borHol[5].TBouCon.QAve_flow,borHol.borHol[5].TBouCon.port.T,borHol.borHol[5].TBouCon.UOld,borHol.borHol[5].TBouCon.iSam,borHol.borHol[6].TBouCon.QAve_flow,borHol.borHol[6].TBouCon.port.T,borHol.borHol[6].TBouCon.UOld,borHol.borHol[6].TBouCon.iSam,borHol.borHol[7].TBouCon.QAve_flow,borHol.borHol[7].TBouCon.port.T,borHol.borHol[7].TBouCon.UOld,borHol.borHol[7].TBouCon.iSam,borHol.borHol[8].TBouCon.QAve_flow,borHol.borHol[8].TBouCon.port.T,borHol.borHol[8].TBouCon.UOld,borHol.borHol[8].TBouCon.iSam,borHol.borHol[9].TBouCon.QAve_flow,borHol.borHol[9].TBouCon.port.T,borHol.borHol[9].TBouCon.UOld,borHol.borHol[9].TBouCon.iSam,borHol.borHol[10].TBouCon.QAve_flow,borHol.borHol[10].TBouCon.port.T,borHol.borHol[10].TBouCon.UOld,borHol.borHol[10].TBouCon.iSam,pulse.T_start,pulse.count)
 * Number of discrete states: 21 (pulse.count,borHol.borHol[1].TBouCon.iSam,borHol.borHol[1].TBouCon.UOld,borHol.borHol[2].TBouCon.iSam,borHol.borHol[2].TBouCon.UOld,borHol.borHol[3].TBouCon.iSam,borHol.borHol[3].TBouCon.UOld,borHol.borHol[4].TBouCon.iSam,borHol.borHol[4].TBouCon.UOld,borHol.borHol[5].TBouCon.iSam,borHol.borHol[5].TBouCon.UOld,borHol.borHol[6].TBouCon.iSam,borHol.borHol[6].TBouCon.UOld,borHol.borHol[7].TBouCon.iSam,borHol.borHol[7].TBouCon.UOld,borHol.borHol[8].TBouCon.iSam,borHol.borHol[8].TBouCon.UOld,borHol.borHol[9].TBouCon.iSam,borHol.borHol[9].TBouCon.UOld,borHol.borHol[10].TBouCon.iSam,borHol.borHol[10].TBouCon.UOld)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (675):
 * Single equations (assignments): 602
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 42
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 30
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 30 systems
   {(1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.003494/4.402, allocations: 0.98 MB / 2.096 GB, free: 167 MB / 1.576 GB
Notification: Performance of simCode: created initialization part: time 0.07203/4.474, allocations: 40.47 MB / 2.135 GB, free: 125.6 MB / 1.576 GB
Notification: Performance of simCode: created event and clocks part: time 1.407e-05/4.474, allocations: 5.438 kB / 2.135 GB, free: 125.6 MB / 1.576 GB
Notification: Performance of simCode: created simulation system equations: time 0.01516/4.489, allocations: 9.759 MB / 2.145 GB, free: 115.5 MB / 1.576 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04219/4.532, allocations: 7.283 MB / 2.152 GB, free: 108.5 MB / 1.576 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.08309/4.615, allocations: 45.7 MB / 2.197 GB, free: 62.94 MB / 1.576 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01886/4.634, allocations: 11.4 MB / 2.208 GB, free: 51.48 MB / 1.576 GB
Notification: Performance of simCode: alias equations: time 0.03712/4.671, allocations: 13.07 MB / 2.22 GB, free: 38.42 MB / 1.576 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0101/4.681, allocations: 1.082 MB / 2.221 GB, free: 37.34 MB / 1.576 GB
Notification: Performance of SimCode: time 1.904e-06/4.681, allocations: 1.75 kB / 2.221 GB, free: 37.34 MB / 1.576 GB
Notification: Performance of Templates: time 1.783/6.464, allocations: 380.3 MB / 2.593 GB, free: 384 MB / 1.686 GB
"
[Timeout remaining time 294]
make -j1 -f Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe ; mkfifo Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe >> ../files/Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.sim & ./Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube  -abortSlowSimulation -alarm=400 -s ida -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Fluid_Geothermal_Boreholes_Examples_UTube.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 28.811544255004264]