Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube.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.001691/0.001691, allocations: 108.3 kB / 19.7 MB, free: 1.918 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.00259/0.00259, allocations: 215.5 kB / 22.99 MB, free: 4.977 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.606/1.606, allocations: 230.6 MB / 256.8 MB, free: 7.805 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.9658/0.9658, allocations: 149.9 MB / 463.1 MB, free: 10.34 MB / 366.1 MB
"
[Timeout remaining time 179]
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 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: "" <> buildModelFMU(IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube,fileNamePrefix="IBPSA_latest_IBPSA_Fluid_Geothermal_Borefields_BaseClasses_Boreholes_Examples_BoreholeTwoUTube",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube,fileNamePrefix="IBPSA_latest_IBPSA_Fluid_Geothermal_Borefields_BaseClasses_Boreholes_Examples_BoreholeTwoUTube",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: IBPSA 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.002094/0.002094, allocations: 67.19 kB / 0.6411 GB, free: 10.09 MB / 478.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.214/0.2161, allocations: 89.17 MB / 0.7282 GB, free: 0.9883 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube): time 0.5987/0.8148, allocations: 77.93 MB / 0.8043 GB, free: 8.77 MB / 0.5919 GB
Notification: Performance of NFInst.instExpressions: time 0.04278/0.8575, allocations: 23.91 MB / 0.8276 GB, free: 8.301 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007301/0.8648, allocations: 161.6 kB / 0.8278 GB, free: 8.223 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.007633/0.8725, allocations: 1.751 MB / 0.8295 GB, free: 6.84 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.01591/0.8884, allocations: 4.24 MB / 0.8336 GB, free: 3.445 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01273/0.9011, allocations: 4.08 MB / 0.8376 GB, free: 388 kB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.1305/1.032, allocations: 77.75 MB / 0.9136 GB, free: 7.996 MB / 0.6856 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.05062/1.082, allocations: 23.69 MB / 0.9367 GB, free: 136 kB / 0.7012 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05812/1.14, allocations: 25.25 MB / 0.9613 GB, free: 6.941 MB / 0.7325 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.05852/1.199, allocations: 24.35 MB / 0.9851 GB, free: 14.5 MB / 0.7637 GB
Notification: Performance of NFPackage.collectConstants: time 0.014/1.213, allocations: 3.848 MB / 0.9889 GB, free: 10.66 MB / 0.7637 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03031/1.243, allocations: 6.792 MB / 0.9955 GB, free: 3.859 MB / 0.7637 GB
Notification: Performance of NFScalarize.scalarize: time 0.01652/1.26, allocations: 8.621 MB / 1.004 GB, free: 11.21 MB / 0.7794 GB
Notification: Performance of NFVerifyModel.verify: time 0.04104/1.301, allocations: 14.36 MB / 1.018 GB, free: 12.8 MB / 0.795 GB
Notification: Performance of NFConvertDAE.convert: time 1.039/2.34, allocations: 63.5 MB / 1.08 GB, free: 118.6 MB / 0.8419 GB
Notification: Performance of FrontEnd - DAE generated: time 9.518e-06/2.34, allocations: 1.375 kB / 1.08 GB, free: 118.6 MB / 0.8419 GB
Notification: Performance of FrontEnd: time 2.264e-06/2.34, allocations: 2.156 kB / 1.08 GB, free: 118.6 MB / 0.8419 GB
Notification: Performance of Transformations before backend: time 0.001794/2.342, allocations: 1.75 kB / 1.08 GB, free: 118.6 MB / 0.8419 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4407
 * Number of variables: 4407
Notification: Performance of Generate backend data structure: time 0.1161/2.458, allocations: 32.09 MB / 1.111 GB, free: 106.9 MB / 0.8419 GB
Notification: Performance of prepare preOptimizeDAE: time 5.514e-05/2.458, allocations: 12.02 kB / 1.111 GB, free: 106.9 MB / 0.8419 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.01262/2.47, allocations: 2.33 MB / 1.114 GB, free: 106.8 MB / 0.8419 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01967/2.49, allocations: 3.188 MB / 1.117 GB, free: 105.2 MB / 0.8419 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.08342/2.573, allocations: 30.76 MB / 1.147 GB, free: 101.2 MB / 0.8419 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001643/2.575, allocations: 1.299 MB / 1.148 GB, free: 101.2 MB / 0.8419 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.009193/2.584, allocations: 1.762 MB / 1.15 GB, free: 101.1 MB / 0.8419 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1046/2.689, allocations: 29.97 MB / 1.179 GB, free: 88.45 MB / 0.8419 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.00163/2.691, allocations: 62.55 kB / 1.179 GB, free: 88.43 MB / 0.8419 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.009573/2.7, allocations: 0.7074 MB / 1.18 GB, free: 87.88 MB / 0.8419 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003071/2.7, allocations: 422.5 kB / 1.18 GB, free: 87.88 MB / 0.8419 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06704/2.767, allocations: 23.68 MB / 1.203 GB, free: 70.12 MB / 0.8419 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.1945/2.962, allocations: 86.23 MB / 1.288 GB, free: 0.8555 MB / 0.8575 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02557/2.988, allocations: 12.77 MB / 1.3 GB, free: 4.051 MB / 0.8732 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01853/3.006, allocations: 9.091 MB / 1.309 GB, free: 10.92 MB / 0.8888 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002517/3.009, allocations: 446.8 kB / 1.309 GB, free: 10.48 MB / 0.8888 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002239/3.009, allocations: 159.3 kB / 1.309 GB, free: 10.32 MB / 0.8888 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01437/3.023, allocations: 1.143 MB / 1.311 GB, free: 9.168 MB / 0.8888 GB
Notification: Performance of pre-optimization done (n=1034): time 4.697e-05/3.023, allocations: 0 / 1.311 GB, free: 9.168 MB / 0.8888 GB
Notification: Performance of matching and sorting (n=1034): time 0.06802/3.091, allocations: 24.06 MB / 1.334 GB, free: 0.9688 MB / 0.9044 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001577/3.091, allocations: 155.5 kB / 1.334 GB, free: 0.8008 MB / 0.9044 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.07363/3.165, allocations: 27.34 MB / 1.361 GB, free: 5.582 MB / 0.9357 GB
Notification: Performance of collectPreVariables (initialization): time 0.003444/3.169, allocations: 241.7 kB / 1.361 GB, free: 5.34 MB / 0.9357 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01953/3.188, allocations: 11.15 MB / 1.372 GB, free: 10.23 MB / 0.9513 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007773/3.196, allocations: 3.856 MB / 1.376 GB, free: 6.418 MB / 0.9513 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01248/3.208, allocations: 3.233 MB / 1.379 GB, free: 3.176 MB / 0.9513 GB
Notification: Performance of setup shared object (initialization): time 0.0001561/3.208, allocations: 301.1 kB / 1.379 GB, free: 2.879 MB / 0.9513 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01866/3.227, allocations: 8.245 MB / 1.387 GB, free: 10.62 MB / 0.9669 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02662/3.254, allocations: 13.57 MB / 1.401 GB, free: 11.41 MB / 0.9825 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04375/3.297, allocations: 19.43 MB / 1.419 GB, free: 7.125 MB / 0.9982 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001589/3.298, allocations: 27.94 kB / 1.42 GB, free: 7.098 MB / 0.9982 GB
Notification: Performance of matching and sorting (n=1984) (initialization): time 0.06904/3.367, allocations: 24.54 MB / 1.443 GB, free: 14.88 MB / 1.029 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001813/3.367, allocations: 42.84 kB / 1.444 GB, free: 14.84 MB / 1.029 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0006584/3.368, allocations: 112 kB / 1.444 GB, free: 14.73 MB / 1.029 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005681/3.373, allocations: 2.12 MB / 1.446 GB, free: 12.5 MB / 1.029 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01576/3.389, allocations: 3.53 MB / 1.449 GB, free: 9.168 MB / 1.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.5123/3.901, allocations: 69.24 MB / 1.517 GB, free: 345.4 MB / 1.029 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02409/3.925, allocations: 1.086 MB / 1.518 GB, free: 345.4 MB / 1.029 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0043/3.93, allocations: 0.5927 MB / 1.518 GB, free: 345.4 MB / 1.029 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03541/3.965, allocations: 17.54 MB / 1.536 GB, free: 339.2 MB / 1.029 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01818/3.983, allocations: 13.56 MB / 1.549 GB, free: 330.3 MB / 1.029 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03054/4.014, allocations: 19.41 MB / 1.568 GB, free: 320.2 MB / 1.029 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.000117/4.014, allocations: 24.47 kB / 1.568 GB, free: 320.2 MB / 1.029 GB
Notification: Performance of matching and sorting (n=1984) (initialization_lambda0): time 0.05769/4.072, allocations: 24.52 MB / 1.592 GB, free: 310.7 MB / 1.029 GB
Notification: Performance of prepare postOptimizeDAE: time 6.693e-05/4.072, allocations: 36 kB / 1.592 GB, free: 310.7 MB / 1.029 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003621/4.072, allocations: 111.7 kB / 1.592 GB, free: 310.6 MB / 1.029 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003884/4.076, allocations: 2.085 MB / 1.594 GB, free: 308.7 MB / 1.029 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01397/4.09, allocations: 3.53 MB / 1.597 GB, free: 305.6 MB / 1.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03873/4.129, allocations: 70.37 MB / 1.666 GB, free: 231.1 MB / 1.029 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02289/4.151, allocations: 1.276 MB / 1.667 GB, free: 229.9 MB / 1.029 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003418/4.155, allocations: 0.5937 MB / 1.668 GB, free: 229.3 MB / 1.029 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 361
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1820):
 * Single equations (assignments): 1769
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 10
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 41
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 40 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,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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.00531/4.16, allocations: 1.012 MB / 1.669 GB, free: 228.3 MB / 1.029 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008501/4.169, allocations: 2.181 MB / 1.671 GB, free: 227.3 MB / 1.029 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03666/4.205, allocations: 17.94 MB / 1.689 GB, free: 209.2 MB / 1.029 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.498e-05/4.205, allocations: 100 kB / 1.689 GB, free: 209.1 MB / 1.029 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.021e-05/4.206, allocations: 20 kB / 1.689 GB, free: 209.1 MB / 1.029 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02417/4.23, allocations: 14.44 MB / 1.703 GB, free: 194.5 MB / 1.029 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.09605/4.326, allocations: 39.51 MB / 1.741 GB, free: 155 MB / 1.029 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.678e-05/4.326, allocations: 4 kB / 1.741 GB, free: 155 MB / 1.029 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01117/4.337, allocations: 2.353 MB / 1.744 GB, free: 152.6 MB / 1.029 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003884/4.341, allocations: 1.975 MB / 1.746 GB, free: 150.5 MB / 1.029 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002519/4.343, allocations: 303.8 kB / 1.746 GB, free: 150.2 MB / 1.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03732/4.381, allocations: 69.53 MB / 1.814 GB, free: 76.17 MB / 1.029 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.376e-06/4.381, allocations: 3.938 kB / 1.814 GB, free: 76.16 MB / 1.029 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0475/4.428, allocations: 26.23 MB / 1.839 GB, free: 49.64 MB / 1.029 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0208/4.449, allocations: 4.884 MB / 1.844 GB, free: 44.73 MB / 1.029 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0123/4.461, allocations: 243.9 kB / 1.844 GB, free: 44.5 MB / 1.029 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01966/4.481, allocations: 0.6395 MB / 1.845 GB, free: 43.86 MB / 1.029 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003964/4.485, allocations: 0.694 MB / 1.846 GB, free: 43.16 MB / 1.029 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00256/4.487, allocations: 375.8 kB / 1.846 GB, free: 42.8 MB / 1.029 GB
Notification: Performance of sorting global known variables: time 0.04133/4.529, allocations: 19.28 MB / 1.865 GB, free: 23.62 MB / 1.029 GB
Notification: Performance of sort global known variables: time 2.51e-07/4.529, allocations: 4 kB / 1.865 GB, free: 23.61 MB / 1.029 GB
Notification: Performance of remove unused functions: time 0.06621/4.595, allocations: 12.91 MB / 1.877 GB, free: 11.44 MB / 1.029 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 80 (borHol.intHex[1].vol1.dynBal.U,borHol.intHex[1].vol2.dynBal.U,borHol.intHex[1].vol3.dynBal.U,borHol.intHex[1].vol4.dynBal.U,borHol.intHex[1].intRes2UTub.capFil1.T,borHol.intHex[1].intRes2UTub.capFil2.T,borHol.intHex[1].intRes2UTub.capFil3.T,borHol.intHex[1].intRes2UTub.capFil4.T,borHol.intHex[2].vol1.dynBal.U,borHol.intHex[2].vol2.dynBal.U,borHol.intHex[2].vol3.dynBal.U,borHol.intHex[2].vol4.dynBal.U,borHol.intHex[2].intRes2UTub.capFil1.T,borHol.intHex[2].intRes2UTub.capFil2.T,borHol.intHex[2].intRes2UTub.capFil3.T,borHol.intHex[2].intRes2UTub.capFil4.T,borHol.intHex[3].vol1.dynBal.U,borHol.intHex[3].vol2.dynBal.U,borHol.intHex[3].vol3.dynBal.U,borHol.intHex[3].vol4.dynBal.U,borHol.intHex[3].intRes2UTub.capFil1.T,borHol.intHex[3].intRes2UTub.capFil2.T,borHol.intHex[3].intRes2UTub.capFil3.T,borHol.intHex[3].intRes2UTub.capFil4.T,borHol.intHex[4].vol1.dynBal.U,borHol.intHex[4].vol2.dynBal.U,borHol.intHex[4].vol3.dynBal.U,borHol.intHex[4].vol4.dynBal.U,borHol.intHex[4].intRes2UTub.capFil1.T,borHol.intHex[4].intRes2UTub.capFil2.T,borHol.intHex[4].intRes2UTub.capFil3.T,borHol.intHex[4].intRes2UTub.capFil4.T,borHol.intHex[5].vol1.dynBal.U,borHol.intHex[5].vol2.dynBal.U,borHol.intHex[5].vol3.dynBal.U,borHol.intHex[5].vol4.dynBal.U,borHol.intHex[5].intRes2UTub.capFil1.T,borHol.intHex[5].intRes2UTub.capFil2.T,borHol.intHex[5].intRes2UTub.capFil3.T,borHol.intHex[5].intRes2UTub.capFil4.T,borHol.intHex[6].vol1.dynBal.U,borHol.intHex[6].vol2.dynBal.U,borHol.intHex[6].vol3.dynBal.U,borHol.intHex[6].vol4.dynBal.U,borHol.intHex[6].intRes2UTub.capFil1.T,borHol.intHex[6].intRes2UTub.capFil2.T,borHol.intHex[6].intRes2UTub.capFil3.T,borHol.intHex[6].intRes2UTub.capFil4.T,borHol.intHex[7].vol1.dynBal.U,borHol.intHex[7].vol2.dynBal.U,borHol.intHex[7].vol3.dynBal.U,borHol.intHex[7].vol4.dynBal.U,borHol.intHex[7].intRes2UTub.capFil1.T,borHol.intHex[7].intRes2UTub.capFil2.T,borHol.intHex[7].intRes2UTub.capFil3.T,borHol.intHex[7].intRes2UTub.capFil4.T,borHol.intHex[8].vol1.dynBal.U,borHol.intHex[8].vol2.dynBal.U,borHol.intHex[8].vol3.dynBal.U,borHol.intHex[8].vol4.dynBal.U,borHol.intHex[8].intRes2UTub.capFil1.T,borHol.intHex[8].intRes2UTub.capFil2.T,borHol.intHex[8].intRes2UTub.capFil3.T,borHol.intHex[8].intRes2UTub.capFil4.T,borHol.intHex[9].vol1.dynBal.U,borHol.intHex[9].vol2.dynBal.U,borHol.intHex[9].vol3.dynBal.U,borHol.intHex[9].vol4.dynBal.U,borHol.intHex[9].intRes2UTub.capFil1.T,borHol.intHex[9].intRes2UTub.capFil2.T,borHol.intHex[9].intRes2UTub.capFil3.T,borHol.intHex[9].intRes2UTub.capFil4.T,borHol.intHex[10].vol1.dynBal.U,borHol.intHex[10].vol2.dynBal.U,borHol.intHex[10].vol3.dynBal.U,borHol.intHex[10].vol4.dynBal.U,borHol.intHex[10].intRes2UTub.capFil1.T,borHol.intHex[10].intRes2UTub.capFil2.T,borHol.intHex[10].intRes2UTub.capFil3.T,borHol.intHex[10].intRes2UTub.capFil4.T)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (921):
 * Single equations (assignments): 874
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 41
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 40 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,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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.6418/5.237, allocations: 28.13 MB / 1.905 GB, free: 342.9 MB / 1.029 GB
Notification: Performance of simCode: created initialization part: time 0.07402/5.311, allocations: 38.35 MB / 1.942 GB, free: 327 MB / 1.029 GB
Notification: Performance of simCode: created event and clocks part: time 1.728e-05/5.311, allocations: 8.094 kB / 1.942 GB, free: 327 MB / 1.029 GB
Notification: Performance of simCode: created simulation system equations: time 0.01959/5.33, allocations: 11.9 MB / 1.954 GB, free: 319.9 MB / 1.029 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0742/5.405, allocations: 13.01 MB / 1.967 GB, free: 316.4 MB / 1.029 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4768/5.881, allocations: 228.1 MB / 2.189 GB, free: 109.3 MB / 1.029 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.04175/5.923, allocations: 16.8 MB / 2.206 GB, free: 92.49 MB / 1.029 GB
Notification: Performance of simCode: alias equations: time 0.04868/5.972, allocations: 17.28 MB / 2.223 GB, free: 75.44 MB / 1.029 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0264/5.998, allocations: 10.81 MB / 2.233 GB, free: 64.63 MB / 1.029 GB
Notification: Performance of SimCode: time 1.533e-06/5.998, allocations: 0 / 2.233 GB, free: 64.63 MB / 1.029 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 2.041/8.039, allocations: 0.7205 GB / 2.954 GB, free: 85.95 MB / 1.029 GB
Notification: Performance of buildModelFMU: Generate platform static: time 85.98/94.01, allocations: 3.938 kB / 2.954 GB, free: 85.94 MB / 1.029 GB
"
[Timeout remaining time 565]
(rm -f IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube.sim & python3 -m fmpy simulate  --output-file IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube_res.csv --start-time 0 --stop-time 360000 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 144 IBPSA_latest_IBPSA_Fluid_Geothermal_Borefields_BaseClasses_Boreholes_Examples_BoreholeTwoUTube.fmu > IBPSA_latest_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeTwoUTube.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 99.16136907506734]
Failed to read output from testmodel.py, exit status != 0:
94.55395937198773 94.570192133 92.226674167
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f13778f6fb0>