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.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.001577/0.001577, allocations: 109.1 kB / 18.99 MB, free: 2.609 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.001784/0.001784, allocations: 218.4 kB / 22.3 MB, free: 5.281 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.684/1.684, allocations: 230.6 MB / 256.1 MB, free: 7.797 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.512/3.512, allocations: 0.5107 GB / 0.8159 GB, free: 17.89 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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_latest_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_latest_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.002219/0.002219, allocations: 70.7 kB / 1.186 GB, free: 13.36 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4744/0.4766, allocations: 181.9 MB / 1.364 GB, free: 13.54 MB / 1.061 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube): time 0.07101/0.5476, allocations: 49.08 MB / 1.412 GB, free: 12.28 MB / 1.108 GB
Notification: Performance of NFInst.instExpressions: time 0.02648/0.5741, allocations: 13.55 MB / 1.425 GB, free: 14.7 MB / 1.123 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003496/0.5776, allocations: 103.2 kB / 1.425 GB, free: 14.6 MB / 1.123 GB
Notification: Performance of NFTyping.typeComponents: time 0.003829/0.5814, allocations: 0.9746 MB / 1.426 GB, free: 13.62 MB / 1.123 GB
Notification: Performance of NFTyping.typeBindings: time 0.01035/0.5918, allocations: 2.974 MB / 1.429 GB, free: 10.64 MB / 1.123 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 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.006381/0.5981, allocations: 1.827 MB / 1.431 GB, free: 8.824 MB / 1.123 GB
Notification: Performance of NFFlatten.flatten: time 0.09351/0.6917, allocations: 56.94 MB / 1.487 GB, free: 15.76 MB / 1.186 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0362/0.7279, allocations: 16.68 MB / 1.503 GB, free: 14.95 MB / 1.201 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04466/0.7725, allocations: 18.52 MB / 1.521 GB, free: 12.44 MB / 1.217 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04159/0.8141, allocations: 18.79 MB / 1.539 GB, free: 9.598 MB / 1.233 GB
Notification: Performance of NFPackage.collectConstants: time 0.01204/0.8261, allocations: 3.32 MB / 1.542 GB, free: 6.277 MB / 1.233 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02326/0.8494, allocations: 4.947 MB / 1.547 GB, free: 1.328 MB / 1.233 GB
Notification: Performance of NFScalarize.scalarize: time 0.0197/0.8691, allocations: 7.886 MB / 1.555 GB, free: 9.422 MB / 1.248 GB
Notification: Performance of NFVerifyModel.verify: time 0.03336/0.9025, allocations: 11.14 MB / 1.566 GB, free: 14.24 MB / 1.264 GB
Notification: Performance of NFConvertDAE.convert: time 1.624/2.526, allocations: 46.74 MB / 1.612 GB, free: 94.45 MB / 1.295 GB
Notification: Performance of FrontEnd - DAE generated: time 7.514e-06/2.526, allocations: 0 / 1.612 GB, free: 94.45 MB / 1.295 GB
Notification: Performance of FrontEnd: time 2.114e-06/2.526, allocations: 3.844 kB / 1.612 GB, free: 94.45 MB / 1.295 GB
Notification: Performance of Transformations before backend: time 0.001394/2.527, allocations: 3.344 kB / 1.612 GB, free: 94.45 MB / 1.295 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.112/2.639, allocations: 26.81 MB / 1.638 GB, free: 86.54 MB / 1.295 GB
Notification: Performance of prepare preOptimizeDAE: time 5.216e-05/2.64, allocations: 9.969 kB / 1.638 GB, free: 86.54 MB / 1.295 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04903/2.689, allocations: 6.744 MB / 1.644 GB, free: 85.32 MB / 1.295 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0601/2.749, allocations: 23.83 MB / 1.668 GB, free: 82.68 MB / 1.295 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001334/2.75, allocations: 0.9549 MB / 1.669 GB, free: 82.65 MB / 1.295 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007992/2.758, allocations: 1.37 MB / 1.67 GB, free: 82.62 MB / 1.295 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04703/2.805, allocations: 19.37 MB / 1.689 GB, free: 78.94 MB / 1.295 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006631/2.806, allocations: 40.78 kB / 1.689 GB, free: 78.93 MB / 1.295 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003912/2.81, allocations: 449.6 kB / 1.689 GB, free: 78.59 MB / 1.295 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002364/2.81, allocations: 307.4 kB / 1.69 GB, free: 78.58 MB / 1.295 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03302/2.843, allocations: 16 MB / 1.705 GB, free: 73.1 MB / 1.295 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.1707/3.014, allocations: 71.39 MB / 1.775 GB, free: 14.53 MB / 1.295 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03706/3.051, allocations: 17.67 MB / 1.792 GB, free: 12.94 MB / 1.311 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01494/3.066, allocations: 6.877 MB / 1.799 GB, free: 6.043 MB / 1.311 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001118/3.067, allocations: 183.8 kB / 1.799 GB, free: 5.863 MB / 1.311 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01757/3.084, allocations: 8.397 MB / 1.807 GB, free: 13.04 MB / 1.326 GB
Notification: Performance of pre-optimization done (n=784): time 1.82e-05/3.084, allocations: 1.422 kB / 1.807 GB, free: 13.04 MB / 1.326 GB
Notification: Performance of matching and sorting (n=784): time 0.05918/3.143, allocations: 20.35 MB / 1.827 GB, free: 8.617 MB / 1.342 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002638/3.144, allocations: 239.2 kB / 1.827 GB, free: 8.363 MB / 1.342 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.04049/3.184, allocations: 16.7 MB / 1.844 GB, free: 7.711 MB / 1.358 GB
Notification: Performance of collectPreVariables (initialization): time 0.005167/3.189, allocations: 317.7 kB / 1.844 GB, free: 7.395 MB / 1.358 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01664/3.206, allocations: 6.974 MB / 1.851 GB, free: 460 kB / 1.358 GB
Notification: Performance of collectInitialBindings (initialization): time 0.009085/3.215, allocations: 2.981 MB / 1.854 GB, free: 13.5 MB / 1.373 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01881/3.234, allocations: 3.18 MB / 1.857 GB, free: 10.31 MB / 1.373 GB
Notification: Performance of setup shared object (initialization): time 0.0001654/3.234, allocations: 304.9 kB / 1.857 GB, free: 10.02 MB / 1.373 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02596/3.26, allocations: 11.21 MB / 1.868 GB, free: 14.78 MB / 1.389 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0333/3.293, allocations: 15.74 MB / 1.883 GB, free: 13.68 MB / 1.404 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04602/3.339, allocations: 20.17 MB / 1.903 GB, free: 8.91 MB / 1.42 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001141/3.339, allocations: 20 kB / 1.903 GB, free: 8.891 MB / 1.42 GB
Notification: Performance of matching and sorting (n=1795) (initialization): time 0.08481/3.424, allocations: 28.88 MB / 1.931 GB, free: 12.28 MB / 1.451 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001214/3.424, allocations: 53.7 kB / 1.931 GB, free: 12.22 MB / 1.451 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000249/3.425, allocations: 75.98 kB / 1.931 GB, free: 12.15 MB / 1.451 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004676/3.429, allocations: 1.837 MB / 1.933 GB, free: 10.23 MB / 1.451 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02189/3.451, allocations: 3.675 MB / 1.937 GB, free: 6.727 MB / 1.451 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05847/3.51, allocations: 54.43 MB / 1.99 GB, free: 13.66 MB / 1.514 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03901/3.549, allocations: 4.007 MB / 1.994 GB, free: 9.645 MB / 1.514 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006232/3.555, allocations: 0.5506 MB / 1.994 GB, free: 9.094 MB / 1.514 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04658/3.601, allocations: 17.71 MB / 2.012 GB, free: 7.355 MB / 1.529 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03448/3.636, allocations: 15.73 MB / 2.027 GB, free: 6.273 MB / 1.545 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04703/3.683, allocations: 20.17 MB / 2.047 GB, free: 1.504 MB / 1.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001555/3.683, allocations: 20 kB / 2.047 GB, free: 1.484 MB / 1.561 GB
Notification: Performance of matching and sorting (n=1795) (initialization_lambda0): time 0.08499/3.768, allocations: 28.88 MB / 2.075 GB, free: 4.875 MB / 1.592 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001099/3.768, allocations: 57.64 kB / 2.075 GB, free: 4.812 MB / 1.592 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.00026/3.769, allocations: 79.98 kB / 2.075 GB, free: 4.734 MB / 1.592 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0045/3.773, allocations: 1.827 MB / 2.077 GB, free: 2.824 MB / 1.592 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02143/3.794, allocations: 3.673 MB / 2.08 GB, free: 15.32 MB / 1.608 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05494/3.849, allocations: 54.42 MB / 2.134 GB, free: 6.215 MB / 1.654 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03702/3.886, allocations: 3.827 MB / 2.137 GB, free: 2.379 MB / 1.654 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005914/3.892, allocations: 0.5466 MB / 2.138 GB, free: 1.832 MB / 1.654 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.009893/3.902, allocations: 0.9728 MB / 2.139 GB, free: 1.02 MB / 1.654 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008836/3.911, allocations: 1.335 MB / 2.14 GB, free: 15.67 MB / 1.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03499/3.946, allocations: 14.64 MB / 2.154 GB, free: 0.9609 MB / 1.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001006/3.946, allocations: 76 kB / 2.154 GB, free: 0.8867 MB / 1.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.198e-05/3.946, allocations: 19.94 kB / 2.155 GB, free: 0.8672 MB / 1.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02766/3.974, allocations: 12.44 MB / 2.167 GB, free: 4.336 MB / 1.686 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.08554/4.059, allocations: 31.02 MB / 2.197 GB, free: 5.367 MB / 1.717 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.333e-05/4.059, allocations: 4 kB / 2.197 GB, free: 5.363 MB / 1.717 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.009385/4.069, allocations: 1.475 MB / 2.198 GB, free: 3.941 MB / 1.717 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00478/4.074, allocations: 1.735 MB / 2.2 GB, free: 2.125 MB / 1.717 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002688/4.076, allocations: 353 kB / 2.2 GB, free: 1.781 MB / 1.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.05454/4.131, allocations: 54.46 MB / 2.254 GB, free: 8.578 MB / 1.779 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.475e-06/4.131, allocations: 0 / 2.254 GB, free: 8.578 MB / 1.779 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05853/4.189, allocations: 21.87 MB / 2.275 GB, free: 2.578 MB / 1.795 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.8797/5.069, allocations: 3.804 MB / 2.279 GB, free: 0.6295 GB / 1.795 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006699/5.076, allocations: 365.9 kB / 2.279 GB, free: 0.6295 GB / 1.795 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01981/5.096, allocations: 1.36 MB / 2.28 GB, free: 0.6295 GB / 1.795 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003134/5.099, allocations: 0.53 MB / 2.281 GB, free: 0.6295 GB / 1.795 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00183/5.101, allocations: 294.2 kB / 2.281 GB, free: 0.6295 GB / 1.795 GB
Notification: Performance of sorting global known variables: time 0.03253/5.133, allocations: 11.46 MB / 2.292 GB, free: 0.6292 GB / 1.795 GB
Notification: Performance of sort global known variables: time 1.7e-07/5.133, allocations: 3.75 kB / 2.292 GB, free: 0.6292 GB / 1.795 GB
Notification: Performance of remove unused functions: time 0.06196/5.195, allocations: 12.84 MB / 2.305 GB, free: 0.6292 GB / 1.795 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.004221/5.199, allocations: 0.9733 MB / 2.306 GB, free: 0.629 GB / 1.795 GB
Notification: Performance of simCode: created initialization part: time 0.07681/5.276, allocations: 40.47 MB / 2.345 GB, free: 0.6138 GB / 1.795 GB
Notification: Performance of simCode: created event and clocks part: time 1.583e-05/5.276, allocations: 4.406 kB / 2.345 GB, free: 0.6138 GB / 1.795 GB
Notification: Performance of simCode: created simulation system equations: time 0.01526/5.291, allocations: 9.758 MB / 2.355 GB, free: 0.6083 GB / 1.795 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04558/5.337, allocations: 7.296 MB / 2.362 GB, free: 0.604 GB / 1.795 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.08279/5.42, allocations: 45.7 MB / 2.407 GB, free: 0.5642 GB / 1.795 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02049/5.44, allocations: 11.4 MB / 2.418 GB, free: 0.5544 GB / 1.795 GB
Notification: Performance of simCode: alias equations: time 0.03739/5.478, allocations: 13.07 MB / 2.431 GB, free: 0.5417 GB / 1.795 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009646/5.487, allocations: 1.086 MB / 2.432 GB, free: 0.5407 GB / 1.795 GB
Notification: Performance of SimCode: time 1.372e-06/5.487, allocations: 3.938 kB / 2.432 GB, free: 0.5407 GB / 1.795 GB
Notification: Performance of Templates: time 0.4836/5.971, allocations: 380.2 MB / 2.803 GB, free: 175.6 MB / 1.795 GB
"
[Timeout remaining time 294]
make -j1 -f Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.makefile [Timeout 300]
(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=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe 2>&1) [Timeout 800]
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/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_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: 29.950560366734862]