Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.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.001559/0.001559, allocations: 77.86 kB / 19.18 MB, free: 2.527 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.001888/0.001888, allocations: 169.5 kB / 22.46 MB, free: 5.359 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.397/1.397, allocations: 177.1 MB / 202.8 MB, free: 9.176 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo): time 0.05728/0.05728, allocations: 9.136 MB / 268.3 MB, free: 7.926 MB / 254.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.0006843/0.0006843, allocations: 31.94 kB / 327.8 MB, free: 42.35 MB / 286.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo): time 2.35/2.35, allocations: 275 MB / 0.6467 GB, free: 6.223 MB / 0.4982 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 177]
Using package AixLib with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo)
Using package SDF with version 0.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo)
Using package Modelica_DeviceDrivers with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/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(AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics")
translateModel(AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.593e-06/1.593e-06, allocations: 0 / 0.9285 GB, free: 22.51 MB / 0.7325 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.507e-05/2.666e-05, allocations: 6.453 kB / 0.9285 GB, free: 22.51 MB / 0.7325 GB
Notification: Performance of NFInst.instantiate(AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics): time 0.2842/0.2842, allocations: 266.6 MB / 1.189 GB, free: 7.793 MB / 0.9513 GB
Notification: Performance of NFInst.instExpressions: time 0.1045/0.3887, allocations: 65.97 MB / 1.253 GB, free: 5.652 MB / 1.014 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01581/0.4045, allocations: 0.5077 MB / 1.254 GB, free: 5.141 MB / 1.014 GB
Notification: Performance of NFTyping.typeComponents: time 0.01801/0.4225, allocations: 5.054 MB / 1.259 GB, free: 56 kB / 1.014 GB
Notification: Performance of NFTyping.typeBindings: time 0.0458/0.4683, allocations: 14.16 MB / 1.273 GB, free: 1.828 MB / 1.029 GB
Notification: Performance of NFTyping.typeClassSections: time 0.6109/1.079, allocations: 9.765 MB / 1.282 GB, free: 41.45 MB / 1.029 GB
Notification: Performance of NFFlatten.flatten: time 0.2656/1.345, allocations: 232.3 MB / 1.509 GB, free: 12.09 MB / 1.108 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1485/1.493, allocations: 70.33 MB / 1.578 GB, free: 8.074 MB / 1.17 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.2532/1.746, allocations: 107.8 MB / 1.683 GB, free: 0.7656 MB / 1.264 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1353/1.882, allocations: 65.62 MB / 1.747 GB, free: 3.848 MB / 1.326 GB
Notification: Performance of NFPackage.collectConstants: time 1.157/3.038, allocations: 10.95 MB / 1.758 GB, free: 164.8 MB / 1.326 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.084/3.122, allocations: 17.16 MB / 1.774 GB, free: 164.8 MB / 1.326 GB
Notification: Performance of NFScalarize.scalarize: time 0.05318/3.176, allocations: 25.93 MB / 1.8 GB, free: 164.8 MB / 1.326 GB
Notification: Performance of NFVerifyModel.verify: time 0.1216/3.297, allocations: 36.46 MB / 1.835 GB, free: 164.8 MB / 1.326 GB
Notification: Performance of NFConvertDAE.convert: time 0.2279/3.525, allocations: 185 MB / 2.016 GB, free: 101.5 MB / 1.326 GB
Notification: Performance of FrontEnd - DAE generated: time 6.322e-06/3.525, allocations: 0 / 2.016 GB, free: 101.5 MB / 1.326 GB
Notification: Performance of FrontEnd: time 1.803e-06/3.525, allocations: 0.6875 kB / 2.016 GB, free: 101.5 MB / 1.326 GB
Notification: Performance of Transformations before backend: time 0.005809/3.531, allocations: 0 / 2.016 GB, free: 101.5 MB / 1.326 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 12889
 * Number of variables: 12889
Notification: Performance of Generate backend data structure: time 0.2815/3.812, allocations: 95.32 MB / 2.109 GB, free: 33.27 MB / 1.326 GB
Notification: Performance of prepare preOptimizeDAE: time 4.31e-05/3.813, allocations: 15.98 kB / 2.109 GB, free: 33.26 MB / 1.326 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05066/3.863, allocations: 9.654 MB / 2.119 GB, free: 23.55 MB / 1.326 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2266/4.09, allocations: 93.16 MB / 2.21 GB, free: 13.36 MB / 1.405 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.004887/4.095, allocations: 3.798 MB / 2.213 GB, free: 9.578 MB / 1.405 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.02803/4.123, allocations: 5.068 MB / 2.218 GB, free: 4.527 MB / 1.405 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.8462/4.969, allocations: 87.52 MB / 2.304 GB, free: 449.1 MB / 1.436 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.003611/4.972, allocations: 151.1 kB / 2.304 GB, free: 449 MB / 1.436 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.02269/4.995, allocations: 2.095 MB / 2.306 GB, free: 449 MB / 1.436 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002317/4.997, allocations: 1.456 MB / 2.307 GB, free: 449 MB / 1.436 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1581/5.156, allocations: 66.16 MB / 2.372 GB, free: 426.7 MB / 1.436 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.4896/5.645, allocations: 258.6 MB / 2.624 GB, free: 218.6 MB / 1.436 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05861/5.704, allocations: 38.82 MB / 2.662 GB, free: 180.6 MB / 1.436 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0386/5.742, allocations: 24.05 MB / 2.686 GB, free: 156.5 MB / 1.436 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.004288/5.747, allocations: 0.9181 MB / 2.687 GB, free: 155.6 MB / 1.436 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0005611/5.747, allocations: 402.2 kB / 2.687 GB, free: 155.2 MB / 1.436 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.02863/5.776, allocations: 2.38 MB / 2.689 GB, free: 153.4 MB / 1.436 GB
Notification: Performance of pre-optimization done (n=2661): time 5.525e-05/5.776, allocations: 0 / 2.689 GB, free: 153.4 MB / 1.436 GB
Notification: Performance of matching and sorting (n=2661): time 0.1393/5.915, allocations: 62.73 MB / 2.751 GB, free: 90.36 MB / 1.436 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002563/5.915, allocations: 0.8225 MB / 2.751 GB, free: 89.39 MB / 1.436 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1711/6.087, allocations: 78.27 MB / 2.828 GB, free: 11.84 MB / 1.436 GB
Notification: Performance of collectPreVariables (initialization): time 0.008191/6.095, allocations: 0.5993 MB / 2.828 GB, free: 11.24 MB / 1.436 GB
Notification: Performance of collectInitialEqns (initialization): time 0.6144/6.709, allocations: 35.82 MB / 2.863 GB, free: 424.3 MB / 1.436 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01537/6.724, allocations: 9.804 MB / 2.873 GB, free: 417.9 MB / 1.436 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.03149/6.756, allocations: 8.751 MB / 2.882 GB, free: 417.3 MB / 1.436 GB
Notification: Performance of setup shared object (initialization): time 4.831e-05/6.756, allocations: 303 kB / 2.882 GB, free: 417 MB / 1.436 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04642/6.802, allocations: 21.99 MB / 2.903 GB, free: 412.6 MB / 1.436 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.05576/6.858, allocations: 39 MB / 2.941 GB, free: 385.6 MB / 1.436 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.07726/6.935, allocations: 51.85 MB / 2.992 GB, free: 357.9 MB / 1.436 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0003176/6.936, allocations: 68.97 kB / 2.992 GB, free: 357.9 MB / 1.436 GB
Notification: Performance of matching and sorting (n=5346) (initialization): time 0.1368/7.073, allocations: 68.76 MB / 3.059 GB, free: 330.9 MB / 1.436 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002072/7.073, allocations: 107.2 kB / 3.059 GB, free: 330.9 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0009989/7.074, allocations: 361.6 kB / 3.06 GB, free: 330.9 MB / 1.436 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.04666/7.12, allocations: 41.11 MB / 3.1 GB, free: 303.7 MB / 1.436 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03153/7.152, allocations: 7.789 MB / 3.107 GB, free: 297 MB / 1.436 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08461/7.237, allocations: 126.2 MB / 3.231 GB, free: 173.4 MB / 1.436 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0539/7.29, allocations: 2.966 MB / 3.234 GB, free: 171.3 MB / 1.436 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.009455/7.3, allocations: 1.612 MB / 3.235 GB, free: 169.7 MB / 1.436 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.09737/7.397, allocations: 50.05 MB / 3.284 GB, free: 122.5 MB / 1.436 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.05224/7.45, allocations: 38.97 MB / 3.322 GB, free: 78.06 MB / 1.436 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.08324/7.533, allocations: 51.8 MB / 3.373 GB, free: 22.69 MB / 1.436 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0003064/7.533, allocations: 68 kB / 3.373 GB, free: 22.62 MB / 1.436 GB
Notification: Performance of matching and sorting (n=5346) (initialization_lambda0): time 0.816/8.349, allocations: 68.71 MB / 3.44 GB, free: 368.7 MB / 1.436 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002187/8.349, allocations: 108.1 kB / 3.44 GB, free: 368.7 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001157/8.35, allocations: 355.6 kB / 3.44 GB, free: 368.7 MB / 1.436 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.05391/8.404, allocations: 41.04 MB / 3.48 GB, free: 367.8 MB / 1.436 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02965/8.434, allocations: 7.791 MB / 3.488 GB, free: 367.3 MB / 1.436 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08764/8.522, allocations: 128.3 MB / 3.613 GB, free: 270.1 MB / 1.436 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.05354/8.575, allocations: 3.628 MB / 3.617 GB, free: 269.4 MB / 1.436 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008697/8.584, allocations: 1.614 MB / 3.618 GB, free: 269.1 MB / 1.436 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1088
 * 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 (4218):
 * Single equations (assignments): 4114
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 40
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 64
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 60 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%), (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): 4 systems
   {(32,530), (1,4), (1,4), (11,229)}
Notification: Performance of prepare postOptimizeDAE: time 0.01589/8.6, allocations: 2.425 MB / 3.621 GB, free: 267.4 MB / 1.436 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.02695/8.627, allocations: 6.011 MB / 3.627 GB, free: 265.8 MB / 1.436 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.09838/8.725, allocations: 51.19 MB / 3.677 GB, free: 240.7 MB / 1.436 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001994/8.725, allocations: 268.7 kB / 3.677 GB, free: 240.4 MB / 1.436 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.000127/8.725, allocations: 28 kB / 3.677 GB, free: 240.4 MB / 1.436 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.06849/8.794, allocations: 39.87 MB / 3.716 GB, free: 206.4 MB / 1.436 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.265/9.059, allocations: 112.7 MB / 3.826 GB, free: 100.3 MB / 1.436 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002097/9.059, allocations: 12 kB / 3.826 GB, free: 100.2 MB / 1.436 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01803/9.077, allocations: 4.102 MB / 3.83 GB, free: 96.17 MB / 1.436 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0339/9.111, allocations: 16.66 MB / 3.846 GB, free: 79.18 MB / 1.436 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.005631/9.117, allocations: 0.6521 MB / 3.847 GB, free: 78.53 MB / 1.436 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.6934/9.81, allocations: 126.4 MB / 3.97 GB, free: 363.6 MB / 1.467 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.686e-05/9.81, allocations: 23.28 kB / 3.97 GB, free: 363.6 MB / 1.467 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1502/9.96, allocations: 71.86 MB / 4.04 GB, free: 353.9 MB / 1.467 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.046/10.01, allocations: 13.41 MB / 4.054 GB, free: 348.9 MB / 1.467 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.02686/10.03, allocations: 0.5499 MB / 4.054 GB, free: 348.5 MB / 1.467 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0492/10.08, allocations: 1.942 MB / 4.056 GB, free: 348.1 MB / 1.467 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.008419/10.09, allocations: 1.659 MB / 4.058 GB, free: 347.9 MB / 1.467 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.008472/10.1, allocations: 1.091 MB / 4.059 GB, free: 347.7 MB / 1.467 GB
Notification: Performance of sorting global known variables: time 0.1222/10.22, allocations: 55.1 MB / 4.113 GB, free: 329.1 MB / 1.467 GB
Notification: Performance of sort global known variables: time 1.9e-07/10.22, allocations: 0 / 4.113 GB, free: 329.1 MB / 1.467 GB
Notification: Performance of remove unused functions: time 0.1615/10.38, allocations: 37.94 MB / 4.15 GB, free: 324 MB / 1.467 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 60
 * Number of states: 120 (borHolOneUTubDyn.intHex[1].vol1.dynBal.U,borHolOneUTubDyn.intHex[1].vol2.dynBal.U,borHolOneUTubDyn.intHex[1].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[1].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[2].vol1.dynBal.U,borHolOneUTubDyn.intHex[2].vol2.dynBal.U,borHolOneUTubDyn.intHex[2].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[2].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[3].vol1.dynBal.U,borHolOneUTubDyn.intHex[3].vol2.dynBal.U,borHolOneUTubDyn.intHex[3].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[3].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[4].vol1.dynBal.U,borHolOneUTubDyn.intHex[4].vol2.dynBal.U,borHolOneUTubDyn.intHex[4].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[4].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[5].vol1.dynBal.U,borHolOneUTubDyn.intHex[5].vol2.dynBal.U,borHolOneUTubDyn.intHex[5].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[5].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[6].vol1.dynBal.U,borHolOneUTubDyn.intHex[6].vol2.dynBal.U,borHolOneUTubDyn.intHex[6].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[6].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[7].vol1.dynBal.U,borHolOneUTubDyn.intHex[7].vol2.dynBal.U,borHolOneUTubDyn.intHex[7].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[7].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[8].vol1.dynBal.U,borHolOneUTubDyn.intHex[8].vol2.dynBal.U,borHolOneUTubDyn.intHex[8].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[8].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[9].vol1.dynBal.U,borHolOneUTubDyn.intHex[9].vol2.dynBal.U,borHolOneUTubDyn.intHex[9].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[9].intResUTub.capFil2.T,borHolOneUTubDyn.intHex[10].vol1.dynBal.U,borHolOneUTubDyn.intHex[10].vol2.dynBal.U,borHolOneUTubDyn.intHex[10].intResUTub.capFil1.T,borHolOneUTubDyn.intHex[10].intResUTub.capFil2.T,borHol2UTubDyn.intHex[1].vol1.dynBal.U,borHol2UTubDyn.intHex[1].vol2.dynBal.U,borHol2UTubDyn.intHex[1].vol3.dynBal.U,borHol2UTubDyn.intHex[1].vol4.dynBal.U,borHol2UTubDyn.intHex[1].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[1].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[1].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[1].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[2].vol1.dynBal.U,borHol2UTubDyn.intHex[2].vol2.dynBal.U,borHol2UTubDyn.intHex[2].vol3.dynBal.U,borHol2UTubDyn.intHex[2].vol4.dynBal.U,borHol2UTubDyn.intHex[2].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[2].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[2].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[2].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[3].vol1.dynBal.U,borHol2UTubDyn.intHex[3].vol2.dynBal.U,borHol2UTubDyn.intHex[3].vol3.dynBal.U,borHol2UTubDyn.intHex[3].vol4.dynBal.U,borHol2UTubDyn.intHex[3].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[3].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[3].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[3].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[4].vol1.dynBal.U,borHol2UTubDyn.intHex[4].vol2.dynBal.U,borHol2UTubDyn.intHex[4].vol3.dynBal.U,borHol2UTubDyn.intHex[4].vol4.dynBal.U,borHol2UTubDyn.intHex[4].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[4].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[4].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[4].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[5].vol1.dynBal.U,borHol2UTubDyn.intHex[5].vol2.dynBal.U,borHol2UTubDyn.intHex[5].vol3.dynBal.U,borHol2UTubDyn.intHex[5].vol4.dynBal.U,borHol2UTubDyn.intHex[5].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[5].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[5].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[5].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[6].vol1.dynBal.U,borHol2UTubDyn.intHex[6].vol2.dynBal.U,borHol2UTubDyn.intHex[6].vol3.dynBal.U,borHol2UTubDyn.intHex[6].vol4.dynBal.U,borHol2UTubDyn.intHex[6].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[6].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[6].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[6].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[7].vol1.dynBal.U,borHol2UTubDyn.intHex[7].vol2.dynBal.U,borHol2UTubDyn.intHex[7].vol3.dynBal.U,borHol2UTubDyn.intHex[7].vol4.dynBal.U,borHol2UTubDyn.intHex[7].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[7].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[7].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[7].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[8].vol1.dynBal.U,borHol2UTubDyn.intHex[8].vol2.dynBal.U,borHol2UTubDyn.intHex[8].vol3.dynBal.U,borHol2UTubDyn.intHex[8].vol4.dynBal.U,borHol2UTubDyn.intHex[8].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[8].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[8].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[8].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[9].vol1.dynBal.U,borHol2UTubDyn.intHex[9].vol2.dynBal.U,borHol2UTubDyn.intHex[9].vol3.dynBal.U,borHol2UTubDyn.intHex[9].vol4.dynBal.U,borHol2UTubDyn.intHex[9].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[9].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[9].intRes2UTub.capFil3.T,borHol2UTubDyn.intHex[9].intRes2UTub.capFil4.T,borHol2UTubDyn.intHex[10].vol1.dynBal.U,borHol2UTubDyn.intHex[10].vol2.dynBal.U,borHol2UTubDyn.intHex[10].vol3.dynBal.U,borHol2UTubDyn.intHex[10].vol4.dynBal.U,borHol2UTubDyn.intHex[10].intRes2UTub.capFil1.T,borHol2UTubDyn.intHex[10].intRes2UTub.capFil2.T,borHol2UTubDyn.intHex[10].intRes2UTub.capFil3.T,borHol2UTubDyn.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 (1705):
 * Single equations (assignments): 1617
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 24
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 64
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 60 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%), (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): 4 systems
   {(11,229), (33,529), (1,4), (1,4)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01387/10.4, allocations: 3.148 MB / 4.153 GB, free: 323.2 MB / 1.467 GB
Notification: Performance of simCode: created initialization part: time 0.1691/10.57, allocations: 93.24 MB / 4.244 GB, free: 244.5 MB / 1.467 GB
Notification: Performance of simCode: created event and clocks part: time 4.547e-05/10.57, allocations: 35.44 kB / 4.244 GB, free: 244.5 MB / 1.467 GB
Notification: Performance of simCode: created simulation system equations: time 0.04672/10.61, allocations: 26.18 MB / 4.269 GB, free: 221.1 MB / 1.467 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.204/10.82, allocations: 32.48 MB / 4.301 GB, free: 192.3 MB / 1.467 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3316/11.15, allocations: 163.1 MB / 4.46 GB, free: 29.05 MB / 1.467 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 1.29/12.44, allocations: 49.99 MB / 4.509 GB, free: 299.4 MB / 1.499 GB
Notification: Performance of simCode: alias equations: time 0.1142/12.55, allocations: 35.21 MB / 4.543 GB, free: 298.2 MB / 1.499 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02221/12.57, allocations: 3.797 MB / 4.547 GB, free: 298.2 MB / 1.499 GB
Notification: Performance of SimCode: time 1.202e-06/12.57, allocations: 0 / 4.547 GB, free: 298.2 MB / 1.499 GB
Notification: Performance of Templates: time 3.089/15.66, allocations: 1.302 GB / 5.849 GB, free: 368.7 MB / 1.608 GB
"
[Timeout remaining time 644]
make -j1 -f AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.makefile [Timeout 660]
(rm -f AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.pipe ; mkfifo AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.pipe >> ../files/AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.sim & ./AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_AixLib.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeDynamics.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 64.1583311073482]
Failed to read output from testmodel.py, exit status != 0:
15.672902956604958 15.683264725 12.15527229
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe3a58d51e0>