Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,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_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube")
translateModel(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,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_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001635/0.001635, allocations: 107 kB / 16.41 MB, free: 6.496 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001659/0.001659, allocations: 185.5 kB / 17.34 MB, free: 5.762 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.395/1.395, allocations: 222.9 MB / 241 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.548/2.548, allocations: 461.9 MB / 0.7355 GB, free: 11.07 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.00147/0.00147, allocations: 68.11 kB / 1.055 GB, free: 7.742 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8671/0.8686, allocations: 157.4 MB / 1.208 GB, free: 13.66 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube): time 0.05854/0.9272, allocations: 53.17 MB / 1.26 GB, free: 8.305 MB / 0.9825 GB
Notification: Performance of NFInst.instExpressions: time 0.02227/0.9495, allocations: 14.52 MB / 1.275 GB, free: 9.738 MB / 0.9981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003357/0.9529, allocations: 79.56 kB / 1.275 GB, free: 9.66 MB / 0.9981 GB
Notification: Performance of NFTyping.typeComponents: time 0.003326/0.9562, allocations: 0.9862 MB / 1.276 GB, free: 8.668 MB / 0.9981 GB
Notification: Performance of NFTyping.typeBindings: time 0.008603/0.9649, allocations: 2.783 MB / 1.278 GB, free: 5.879 MB / 0.9981 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/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.005024/0.9699, allocations: 1.799 MB / 1.28 GB, free: 4.094 MB / 0.9981 GB
Notification: Performance of NFFlatten.flatten: time 0.07035/1.04, allocations: 55.35 MB / 1.334 GB, free: 12.63 MB / 1.061 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0374/1.078, allocations: 23.13 MB / 1.357 GB, free: 5.352 MB / 1.076 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0383/1.116, allocations: 17.95 MB / 1.374 GB, free: 3.414 MB / 1.092 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03098/1.147, allocations: 16.07 MB / 1.39 GB, free: 3.285 MB / 1.107 GB
Notification: Performance of NFPackage.collectConstants: time 0.01071/1.158, allocations: 3.324 MB / 1.393 GB, free: 15.96 MB / 1.123 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02051/1.178, allocations: 5.216 MB / 1.398 GB, free: 10.74 MB / 1.123 GB
Notification: Performance of NFScalarize.scalarize: time 0.01658/1.195, allocations: 7.54 MB / 1.406 GB, free: 3.184 MB / 1.123 GB
Notification: Performance of NFVerifyModel.verify: time 0.03534/1.23, allocations: 13.62 MB / 1.419 GB, free: 5.516 MB / 1.139 GB
Notification: Performance of NFConvertDAE.convert: time 0.06323/1.294, allocations: 46.36 MB / 1.464 GB, free: 7.035 MB / 1.186 GB
Notification: Performance of FrontEnd - DAE generated: time 8.656e-06/1.294, allocations: 0 / 1.464 GB, free: 7.035 MB / 1.186 GB
Notification: Performance of FrontEnd: time 2.225e-06/1.294, allocations: 0 / 1.464 GB, free: 7.035 MB / 1.186 GB
Notification: Performance of Transformations before backend: time 0.001246/1.295, allocations: 0 / 1.464 GB, free: 7.035 MB / 1.186 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.09721/1.392, allocations: 26.27 MB / 1.49 GB, free: 12.57 MB / 1.217 GB
Notification: Performance of prepare preOptimizeDAE: time 5.17e-05/1.392, allocations: 8.031 kB / 1.49 GB, free: 12.56 MB / 1.217 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01476/1.407, allocations: 2.037 MB / 1.492 GB, free: 10.5 MB / 1.217 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.05541/1.463, allocations: 23.19 MB / 1.514 GB, free: 3.215 MB / 1.232 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001234/1.464, allocations: 0.9624 MB / 1.515 GB, free: 2.25 MB / 1.232 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008316/1.472, allocations: 1.363 MB / 1.517 GB, free: 0.8867 MB / 1.232 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05194/1.524, allocations: 17.85 MB / 1.534 GB, free: 14.72 MB / 1.264 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007596/1.525, allocations: 39.67 kB / 1.534 GB, free: 14.68 MB / 1.264 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004733/1.53, allocations: 452 kB / 1.535 GB, free: 14.24 MB / 1.264 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00036/1.53, allocations: 303.9 kB / 1.535 GB, free: 13.95 MB / 1.264 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04105/1.571, allocations: 16.04 MB / 1.551 GB, free: 13.88 MB / 1.279 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.9726/2.544, allocations: 98.49 MB / 1.647 GB, free: 240.4 MB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03503/2.579, allocations: 18.24 MB / 1.665 GB, free: 223 MB / 1.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01224/2.591, allocations: 7.243 MB / 1.672 GB, free: 215.7 MB / 1.279 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001134/2.592, allocations: 0.5685 MB / 1.672 GB, free: 215.1 MB / 1.279 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01215/2.604, allocations: 6.881 MB / 1.679 GB, free: 208.1 MB / 1.279 GB
Notification: Performance of pre-optimization done (n=784): time 1.221e-05/2.605, allocations: 0 / 1.679 GB, free: 208.1 MB / 1.279 GB
Notification: Performance of matching and sorting (n=784): time 0.04374/2.648, allocations: 22.72 MB / 1.701 GB, free: 184.8 MB / 1.279 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001508/2.648, allocations: 238.3 kB / 1.701 GB, free: 184.6 MB / 1.279 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03294/2.681, allocations: 18.12 MB / 1.719 GB, free: 166.6 MB / 1.279 GB
Notification: Performance of collectPreVariables (initialization): time 0.004778/2.686, allocations: 309.7 kB / 1.719 GB, free: 166.3 MB / 1.279 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01135/2.698, allocations: 6.836 MB / 1.726 GB, free: 159.8 MB / 1.279 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006537/2.704, allocations: 2.853 MB / 1.729 GB, free: 157 MB / 1.279 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01335/2.718, allocations: 3.167 MB / 1.732 GB, free: 153.8 MB / 1.279 GB
Notification: Performance of setup shared object (initialization): time 6.118e-05/2.718, allocations: 301.1 kB / 1.732 GB, free: 153.5 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0201/2.738, allocations: 11.18 MB / 1.743 GB, free: 142.3 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02251/2.76, allocations: 14.09 MB / 1.757 GB, free: 127.2 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03332/2.794, allocations: 20.17 MB / 1.777 GB, free: 106.2 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001107/2.794, allocations: 16 kB / 1.777 GB, free: 106.2 MB / 1.279 GB
Notification: Performance of matching and sorting (n=1795) (initialization): time 0.06289/2.857, allocations: 28.93 MB / 1.805 GB, free: 77.14 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 8.899e-05/2.857, allocations: 62.73 kB / 1.805 GB, free: 77.07 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001934/2.857, allocations: 75.98 kB / 1.805 GB, free: 77 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003039/2.86, allocations: 1.837 MB / 1.807 GB, free: 75.07 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01828/2.878, allocations: 3.678 MB / 1.81 GB, free: 71.39 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03204/2.911, allocations: 58.5 MB / 1.868 GB, free: 8.723 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03479/2.945, allocations: 4.656 MB / 1.872 GB, free: 4.047 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004855/2.95, allocations: 0.5466 MB / 1.873 GB, free: 3.5 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03731/2.988, allocations: 17.66 MB / 1.89 GB, free: 1.816 MB / 1.295 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02663/3.014, allocations: 14.08 MB / 1.904 GB, free: 2.746 MB / 1.311 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03865/3.053, allocations: 20.16 MB / 1.923 GB, free: 13.75 MB / 1.342 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001095/3.053, allocations: 16 kB / 1.923 GB, free: 13.73 MB / 1.342 GB
Notification: Performance of matching and sorting (n=1795) (initialization_lambda0): time 0.07379/3.127, allocations: 28.94 MB / 1.952 GB, free: 0.6602 MB / 1.357 GB
Notification: Performance of prepare postOptimizeDAE: time 8.965e-05/3.127, allocations: 58.48 kB / 1.952 GB, free: 0.5977 MB / 1.357 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001965/3.127, allocations: 75.98 kB / 1.952 GB, free: 0.5234 MB / 1.357 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003673/3.131, allocations: 1.829 MB / 1.953 GB, free: 14.6 MB / 1.373 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01954/3.15, allocations: 3.674 MB / 1.957 GB, free: 10.92 MB / 1.373 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04544/3.196, allocations: 58.51 MB / 2.014 GB, free: 12.25 MB / 1.436 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03537/3.231, allocations: 4.325 MB / 2.018 GB, free: 7.91 MB / 1.436 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005078/3.237, allocations: 0.5466 MB / 2.019 GB, free: 7.363 MB / 1.436 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.006242/3.243, allocations: 0.9674 MB / 2.02 GB, free: 6.383 MB / 1.436 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0061/3.249, allocations: 1.396 MB / 2.021 GB, free: 4.969 MB / 1.436 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03437/3.283, allocations: 14.76 MB / 2.036 GB, free: 6.059 MB / 1.451 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.332e-05/3.283, allocations: 80.59 kB / 2.036 GB, free: 5.98 MB / 1.451 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.912e-05/3.284, allocations: 16 kB / 2.036 GB, free: 5.965 MB / 1.451 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0259/3.309, allocations: 12.49 MB / 2.048 GB, free: 9.324 MB / 1.467 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.09416/3.404, allocations: 38.01 MB / 2.085 GB, free: 2.832 MB / 1.498 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.168e-05/3.404, allocations: 0 / 2.085 GB, free: 2.832 MB / 1.498 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008578/3.412, allocations: 1.475 MB / 2.087 GB, free: 1.355 MB / 1.498 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004249/3.417, allocations: 1.742 MB / 2.088 GB, free: 15.52 MB / 1.514 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002628/3.419, allocations: 355.7 kB / 2.089 GB, free: 15.17 MB / 1.514 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04744/3.467, allocations: 58.51 MB / 2.146 GB, free: 0.5 MB / 1.561 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.63e-06/3.467, allocations: 8 kB / 2.146 GB, free: 0.4922 MB / 1.561 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.9382/4.405, allocations: 21.93 MB / 2.167 GB, free: 0.5122 GB / 1.561 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01208/4.417, allocations: 3.791 MB / 2.171 GB, free: 0.5117 GB / 1.561 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006056/4.423, allocations: 362.8 kB / 2.171 GB, free: 0.5115 GB / 1.561 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01948/4.443, allocations: 1.659 MB / 2.173 GB, free: 0.5114 GB / 1.561 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002562/4.445, allocations: 0.5075 MB / 2.173 GB, free: 0.5113 GB / 1.561 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001549/4.447, allocations: 293.6 kB / 2.174 GB, free: 0.5113 GB / 1.561 GB
Notification: Performance of sorting global known variables: time 0.02698/4.474, allocations: 12.62 MB / 2.186 GB, free: 0.5071 GB / 1.561 GB
Notification: Performance of sort global known variables: time 6.31e-07/4.474, allocations: 0 / 2.186 GB, free: 0.5071 GB / 1.561 GB
Notification: Performance of remove unused functions: time 0.05358/4.527, allocations: 12.41 MB / 2.198 GB, free: 0.5061 GB / 1.561 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.003911/4.531, allocations: 0.9994 MB / 2.199 GB, free: 0.5059 GB / 1.561 GB
Notification: Performance of simCode: created initialization part: time 0.07293/4.604, allocations: 41.96 MB / 2.24 GB, free: 483.5 MB / 1.561 GB
Notification: Performance of simCode: created event and clocks part: time 1.571e-05/4.604, allocations: 11.23 kB / 2.24 GB, free: 483.5 MB / 1.561 GB
Notification: Performance of simCode: created simulation system equations: time 0.01523/4.62, allocations: 10.09 MB / 2.25 GB, free: 474.3 MB / 1.561 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04925/4.669, allocations: 8.716 MB / 2.258 GB, free: 468.1 MB / 1.561 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.09152/4.761, allocations: 45.76 MB / 2.303 GB, free: 424.4 MB / 1.561 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02166/4.782, allocations: 11.6 MB / 2.314 GB, free: 412.8 MB / 1.561 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009811/4.792, allocations: 1.19 MB / 2.316 GB, free: 411.6 MB / 1.561 GB
Notification: Performance of SimCode: time 8.52e-07/4.792, allocations: 0 / 2.316 GB, free: 411.6 MB / 1.561 GB
Notification: Performance of Templates: time 7.621/12.41, allocations: 3.341 GB / 5.656 GB, free: 135.3 MB / 1.639 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.makefile
(rm -f Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe >> ../files/Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.sim & ./Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Geothermal_Boreholes_Examples_UTube.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches