Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_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) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001314/0.001314, allocations: 107.5 kB / 16.45 MB, free: 6.488 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001389/0.001389, allocations: 196.6 kB / 19.41 MB, free: 3.68 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.41/1.41, allocations: 225.6 MB / 247.8 MB, free: 13.95 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.66/2.66, allocations: 476.7 MB / 0.7611 GB, free: 11.3 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/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: "" <> buildModelFMU(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube,fileNamePrefix="Buildings_11_Buildings_Fluid_Geothermal_Boreholes_Examples_UTube",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube,fileNamePrefix="Buildings_11_Buildings_Fluid_Geothermal_Boreholes_Examples_UTube",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002128/0.002128, allocations: 63.91 kB / 1.104 GB, free: 9.273 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8196/0.8218, allocations: 168.7 MB / 1.269 GB, free: 5.148 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Geothermal.Boreholes.Examples.UTube): time 0.05958/0.8813, allocations: 53.56 MB / 1.321 GB, free: 15.4 MB / 1.029 GB
Notification: Performance of NFInst.instExpressions: time 0.02284/0.9042, allocations: 14.56 MB / 1.335 GB, free: 0.8008 MB / 1.029 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003388/0.9076, allocations: 71.62 kB / 1.335 GB, free: 0.7305 MB / 1.029 GB
Notification: Performance of NFTyping.typeComponents: time 0.003153/0.9107, allocations: 1.029 MB / 1.336 GB, free: 15.7 MB / 1.045 GB
Notification: Performance of NFTyping.typeBindings: time 0.008412/0.9191, allocations: 2.935 MB / 1.339 GB, free: 12.75 MB / 1.045 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.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.004892/0.924, allocations: 1.801 MB / 1.341 GB, free: 10.96 MB / 1.045 GB
Notification: Performance of NFFlatten.flatten: time 0.08081/1.005, allocations: 55.29 MB / 1.395 GB, free: 3.551 MB / 1.092 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03397/1.039, allocations: 19.34 MB / 1.414 GB, free: 76 kB / 1.107 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03593/1.075, allocations: 17.96 MB / 1.431 GB, free: 14.13 MB / 1.139 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03156/1.106, allocations: 16.6 MB / 1.448 GB, free: 13.48 MB / 1.154 GB
Notification: Performance of NFPackage.collectConstants: time 0.01149/1.118, allocations: 3.328 MB / 1.451 GB, free: 10.15 MB / 1.154 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02094/1.139, allocations: 5.239 MB / 1.456 GB, free: 4.91 MB / 1.154 GB
Notification: Performance of NFScalarize.scalarize: time 0.01596/1.155, allocations: 7.729 MB / 1.463 GB, free: 13.16 MB / 1.17 GB
Notification: Performance of NFVerifyModel.verify: time 0.03508/1.19, allocations: 13.61 MB / 1.477 GB, free: 15.5 MB / 1.186 GB
Notification: Performance of NFConvertDAE.convert: time 0.07174/1.261, allocations: 46.46 MB / 1.522 GB, free: 0.9062 MB / 1.217 GB
Notification: Performance of FrontEnd - DAE generated: time 9.117e-06/1.261, allocations: 3.938 kB / 1.522 GB, free: 0.9023 MB / 1.217 GB
Notification: Performance of FrontEnd: time 2.194e-06/1.262, allocations: 0 / 1.522 GB, free: 0.9023 MB / 1.217 GB
Notification: Performance of Transformations before backend: time 0.00125/1.263, allocations: 7.938 kB / 1.522 GB, free: 0.8945 MB / 1.217 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.09919/1.362, allocations: 26.79 MB / 1.548 GB, free: 5.902 MB / 1.248 GB
Notification: Performance of prepare preOptimizeDAE: time 5.459e-05/1.362, allocations: 8.031 kB / 1.548 GB, free: 5.895 MB / 1.248 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.007362/1.369, allocations: 1.493 MB / 1.55 GB, free: 4.391 MB / 1.248 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01458/1.384, allocations: 2.133 MB / 1.552 GB, free: 2.246 MB / 1.248 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.06302/1.447, allocations: 23.28 MB / 1.575 GB, free: 10.87 MB / 1.279 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001442/1.448, allocations: 0.9585 MB / 1.576 GB, free: 9.91 MB / 1.279 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008568/1.457, allocations: 1.375 MB / 1.577 GB, free: 8.535 MB / 1.279 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05229/1.509, allocations: 17.85 MB / 1.594 GB, free: 6.367 MB / 1.295 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006443/1.51, allocations: 35.78 kB / 1.594 GB, free: 6.332 MB / 1.295 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004574/1.514, allocations: 452 kB / 1.595 GB, free: 5.891 MB / 1.295 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003443/1.515, allocations: 311.9 kB / 1.595 GB, free: 5.586 MB / 1.295 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 1.315/2.83, allocations: 16.04 MB / 1.611 GB, free: 269.2 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.1746/3.005, allocations: 98.62 MB / 1.707 GB, free: 189.7 MB / 1.295 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03217/3.037, allocations: 17.78 MB / 1.724 GB, free: 171.9 MB / 1.295 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01096/3.048, allocations: 6.892 MB / 1.731 GB, free: 165 MB / 1.295 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001049/3.049, allocations: 0.5651 MB / 1.732 GB, free: 164.3 MB / 1.295 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01289/3.062, allocations: 6.891 MB / 1.738 GB, free: 157.4 MB / 1.295 GB
Notification: Performance of pre-optimization done (n=784): time 1.72e-05/3.062, allocations: 0 / 1.738 GB, free: 157.4 MB / 1.295 GB
Notification: Performance of matching and sorting (n=784): time 0.04681/3.108, allocations: 22.74 MB / 1.761 GB, free: 133.9 MB / 1.295 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001873/3.109, allocations: 244.3 kB / 1.761 GB, free: 133.7 MB / 1.295 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03805/3.147, allocations: 18.13 MB / 1.779 GB, free: 115.8 MB / 1.295 GB
Notification: Performance of collectPreVariables (initialization): time 0.004219/3.151, allocations: 317.7 kB / 1.779 GB, free: 115.4 MB / 1.295 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01103/3.162, allocations: 6.944 MB / 1.786 GB, free: 109 MB / 1.295 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005086/3.167, allocations: 2.974 MB / 1.789 GB, free: 106.4 MB / 1.295 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01267/3.18, allocations: 3.176 MB / 1.792 GB, free: 103.2 MB / 1.295 GB
Notification: Performance of setup shared object (initialization): time 4.665e-05/3.18, allocations: 301.1 kB / 1.792 GB, free: 103 MB / 1.295 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01989/3.2, allocations: 11.19 MB / 1.803 GB, free: 91.75 MB / 1.295 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02246/3.222, allocations: 14.09 MB / 1.817 GB, free: 76.67 MB / 1.295 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03334/3.255, allocations: 20.17 MB / 1.836 GB, free: 55.66 MB / 1.295 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.138e-05/3.256, allocations: 20 kB / 1.836 GB, free: 55.64 MB / 1.295 GB
Notification: Performance of matching and sorting (n=1795) (initialization): time 0.05867/3.314, allocations: 28.96 MB / 1.865 GB, free: 26.55 MB / 1.295 GB
Notification: Performance of prepare postOptimizeDAE: time 8.427e-05/3.314, allocations: 65.69 kB / 1.865 GB, free: 26.48 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001802/3.314, allocations: 77.14 kB / 1.865 GB, free: 26.41 MB / 1.295 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003136/3.318, allocations: 1.833 MB / 1.867 GB, free: 24.48 MB / 1.295 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01778/3.335, allocations: 3.681 MB / 1.87 GB, free: 20.8 MB / 1.295 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04469/3.38, allocations: 58.54 MB / 1.927 GB, free: 6.164 MB / 1.342 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03294/3.413, allocations: 4.702 MB / 1.932 GB, free: 1.836 MB / 1.342 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00441/3.417, allocations: 0.5466 MB / 1.932 GB, free: 1.289 MB / 1.342 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03735/3.455, allocations: 17.65 MB / 1.95 GB, free: 15.61 MB / 1.373 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02799/3.483, allocations: 14.08 MB / 1.963 GB, free: 0.5469 MB / 1.373 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04119/3.524, allocations: 20.17 MB / 1.983 GB, free: 11.54 MB / 1.404 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.711e-05/3.524, allocations: 16 kB / 1.983 GB, free: 11.53 MB / 1.404 GB
Notification: Performance of matching and sorting (n=1795) (initialization_lambda0): time 0.07078/3.595, allocations: 28.97 MB / 2.011 GB, free: 14.43 MB / 1.436 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001526/3.595, allocations: 61.95 kB / 2.012 GB, free: 14.37 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002664/3.595, allocations: 72 kB / 2.012 GB, free: 14.3 MB / 1.436 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004084/3.599, allocations: 1.832 MB / 2.013 GB, free: 12.37 MB / 1.436 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01918/3.619, allocations: 3.674 MB / 2.017 GB, free: 8.691 MB / 1.436 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05116/3.67, allocations: 58.54 MB / 2.074 GB, free: 10.05 MB / 1.498 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03405/3.704, allocations: 4.359 MB / 2.078 GB, free: 5.914 MB / 1.498 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004346/3.708, allocations: 0.5427 MB / 2.079 GB, free: 5.371 MB / 1.498 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.005625/3.714, allocations: 0.9769 MB / 2.08 GB, free: 4.418 MB / 1.498 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005652/3.719, allocations: 1.463 MB / 2.081 GB, free: 2.945 MB / 1.498 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.032/3.751, allocations: 14.73 MB / 2.096 GB, free: 4.074 MB / 1.514 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.776e-05/3.751, allocations: 76 kB / 2.096 GB, free: 4 MB / 1.514 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.795e-05/3.752, allocations: 16 kB / 2.096 GB, free: 3.984 MB / 1.514 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02438/3.776, allocations: 12.44 MB / 2.108 GB, free: 7.387 MB / 1.529 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.09078/3.867, allocations: 37.98 MB / 2.145 GB, free: 1.012 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.821e-05/3.867, allocations: 0 / 2.145 GB, free: 1.012 MB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.008166/3.875, allocations: 1.478 MB / 2.146 GB, free: 15.53 MB / 1.576 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004355/3.879, allocations: 1.739 MB / 2.148 GB, free: 13.7 MB / 1.576 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002215/3.881, allocations: 355.7 kB / 2.148 GB, free: 13.35 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.342/5.223, allocations: 58.53 MB / 2.206 GB, free: 0.5297 GB / 1.623 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.907e-06/5.223, allocations: 1.25 kB / 2.206 GB, free: 0.5297 GB / 1.623 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05185/5.275, allocations: 21.97 MB / 2.227 GB, free: 0.5289 GB / 1.623 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01263/5.288, allocations: 3.862 MB / 2.231 GB, free: 0.5282 GB / 1.623 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006198/5.294, allocations: 364.5 kB / 2.231 GB, free: 0.528 GB / 1.623 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01932/5.313, allocations: 1.671 MB / 2.233 GB, free: 0.5279 GB / 1.623 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002631/5.316, allocations: 0.5045 MB / 2.233 GB, free: 0.5278 GB / 1.623 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002197/5.318, allocations: 291.9 kB / 2.234 GB, free: 0.5278 GB / 1.623 GB
Notification: Performance of sorting global known variables: time 0.02993/5.348, allocations: 12.62 MB / 2.246 GB, free: 0.5236 GB / 1.623 GB
Notification: Performance of sort global known variables: time 6.91e-07/5.348, allocations: 3.844 kB / 2.246 GB, free: 0.5236 GB / 1.623 GB
Notification: Performance of remove unused functions: time 0.04921/5.397, allocations: 12.45 MB / 2.258 GB, free: 0.5227 GB / 1.623 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.04967/5.447, allocations: 23.49 MB / 2.281 GB, free: 0.5057 GB / 1.623 GB
Notification: Performance of simCode: created initialization part: time 0.07478/5.522, allocations: 40.41 MB / 2.321 GB, free: 482.8 MB / 1.623 GB
Notification: Performance of simCode: created event and clocks part: time 1.569e-05/5.522, allocations: 4.562 kB / 2.321 GB, free: 482.8 MB / 1.623 GB
Notification: Performance of simCode: created simulation system equations: time 0.01424/5.536, allocations: 9.761 MB / 2.33 GB, free: 473.9 MB / 1.623 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04741/5.583, allocations: 8.714 MB / 2.339 GB, free: 467.7 MB / 1.623 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3655/5.949, allocations: 191.5 MB / 2.526 GB, free: 274.2 MB / 1.623 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02202/5.971, allocations: 11.67 MB / 2.537 GB, free: 262.5 MB / 1.623 GB
Notification: Performance of simCode: alias equations: time 0.03691/6.008, allocations: 13.48 MB / 2.55 GB, free: 249 MB / 1.623 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01895/6.027, allocations: 7.232 MB / 2.557 GB, free: 241.8 MB / 1.623 GB
Notification: Performance of SimCode: time 1.523e-06/6.027, allocations: 0 / 2.557 GB, free: 241.8 MB / 1.623 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 2.308/8.335, allocations: 0.5316 GB / 3.089 GB, free: 372.4 MB / 1.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 77.05/85.38, allocations: 3.281 kB / 3.089 GB, free: 372.4 MB / 1.67 GB
"
[Timeout remaining time 214]
(rm -f Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe ; mkfifo Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe >> ../files/Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube_res.mat --tempDir=temp_Buildings_11_Buildings_Fluid_Geothermal_Boreholes_Examples_UTube_fmu --startTime=0 --stopTime=1.5768e+08 --stepSize=63072 --timeout=400 --tolerance=1e-06 Buildings_11_Buildings_Fluid_Geothermal_Boreholes_Examples_UTube.fmu > Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.pipe 2>&1) [Timeout 420.0]
diffSimulationResults("Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_Fluid_Geothermal_Boreholes_Examples_UTube.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.Fluid.Geothermal.Boreholes.Examples.UTube.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 299]
Reference file matches
[Calling sys.exit(0), Time elapsed: 100.57388753211126]