Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001247/0.001247, allocations: 104.4 kB / 18.05 MB, free: 4.289 MB / 14.72 MB
[Timeout remaining time 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001242/0.001242, allocations: 192.4 kB / 21.17 MB, free: 1.18 MB / 14.72 MB
[Timeout remaining time 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.397/1.397, allocations: 225.6 MB / 249.7 MB, free: 3.355 MB / 190.1 MB
[Timeout remaining time 88]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8613/0.8613, allocations: 137.4 MB / 442.2 MB, free: 13.79 MB / 350.1 MB
[Timeout remaining time 89]
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube")
translateModel(IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube") [Timeout 660]
Notification: Performance of FrontEnd - loaded program: time 0.00192/0.00192, allocations: 71.89 kB / 0.6134 GB, free: 1.535 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4919/0.4938, allocations: 85.53 MB / 0.6969 GB, free: 14.7 MB / 0.5137 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube): time 0.08046/0.5743, allocations: 70.75 MB / 0.766 GB, free: 9.867 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.02735/0.6016, allocations: 17.74 MB / 0.7834 GB, free: 8.074 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003042/0.6047, allocations: 67.62 kB / 0.7834 GB, free: 8.008 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.003905/0.6086, allocations: 1.23 MB / 0.7846 GB, free: 6.773 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.00729/0.6159, allocations: 2.47 MB / 0.787 GB, free: 4.293 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007887/0.6237, allocations: 2.942 MB / 0.7899 GB, free: 1.375 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.06407/0.6878, allocations: 38.58 MB / 0.8276 GB, free: 10.71 MB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0262/0.714, allocations: 14.14 MB / 0.8414 GB, free: 12.44 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02745/0.7414, allocations: 12.64 MB / 0.8537 GB, free: 15.82 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02233/0.7638, allocations: 11.61 MB / 0.8651 GB, free: 4.164 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.00556/0.7693, allocations: 1.945 MB / 0.867 GB, free: 2.219 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.7267/1.496, allocations: 4.611 MB / 0.8715 GB, free: 56.1 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.01089/1.507, allocations: 4.59 MB / 0.876 GB, free: 56.1 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.03322/1.54, allocations: 9.456 MB / 0.8852 GB, free: 54.85 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.04376/1.584, allocations: 33.6 MB / 0.918 GB, free: 46.83 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 6.582e-06/1.584, allocations: 0 / 0.918 GB, free: 46.83 MB / 0.67 GB
Notification: Performance of FrontEnd: time 1.853e-06/1.584, allocations: 1.688 kB / 0.918 GB, free: 46.83 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 0.0009722/1.585, allocations: 0 / 0.918 GB, free: 46.83 MB / 0.67 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2147
 * Number of variables: 2147
Notification: Performance of Generate backend data structure: time 0.05021/1.635, allocations: 17.38 MB / 0.935 GB, free: 38.2 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 5.585e-05/1.635, allocations: 7.75 kB / 0.935 GB, free: 38.2 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01085/1.646, allocations: 1.709 MB / 0.9367 GB, free: 37.32 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03621/1.682, allocations: 16.41 MB / 0.9527 GB, free: 27.82 MB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006972/1.683, allocations: 0.6359 MB / 0.9533 GB, free: 27.53 MB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004166/1.687, allocations: 0.8702 MB / 0.9542 GB, free: 27.23 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03403/1.721, allocations: 12.86 MB / 0.9667 GB, free: 19.57 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000561/1.722, allocations: 25.23 kB / 0.9667 GB, free: 19.56 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003395/1.725, allocations: 362.2 kB / 0.9671 GB, free: 19.29 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001718/1.725, allocations: 208.7 kB / 0.9673 GB, free: 19.29 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02539/1.751, allocations: 11.17 MB / 0.9782 GB, free: 9.402 MB / 0.67 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.1142/1.865, allocations: 53.43 MB / 1.03 GB, free: 2.723 MB / 0.7169 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01267/1.877, allocations: 5.637 MB / 1.036 GB, free: 13.09 MB / 0.7325 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008137/1.886, allocations: 3.69 MB / 1.039 GB, free: 9.387 MB / 0.7325 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003017/1.889, allocations: 2.188 MB / 1.042 GB, free: 6.754 MB / 0.7325 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001681/1.889, allocations: 98.3 kB / 1.042 GB, free: 6.648 MB / 0.7325 GB
Notification: Performance of pre-optimization done (n=484): time 2.453e-05/1.889, allocations: 0 / 1.042 GB, free: 6.648 MB / 0.7325 GB
Notification: Performance of matching and sorting (n=484): time 0.03259/1.921, allocations: 12.67 MB / 1.054 GB, free: 9.578 MB / 0.7482 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002441/1.922, allocations: 368.2 kB / 1.054 GB, free: 9.145 MB / 0.7482 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.04246/1.964, allocations: 16.03 MB / 1.07 GB, free: 9.188 MB / 0.7638 GB
Notification: Performance of collectPreVariables (initialization): time 0.001726/1.966, allocations: 129.7 kB / 1.07 GB, free: 9.055 MB / 0.7638 GB
Notification: Performance of collectInitialEqns (initialization): time 0.009739/1.976, allocations: 5.995 MB / 1.076 GB, free: 3.062 MB / 0.7638 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003717/1.979, allocations: 1.808 MB / 1.078 GB, free: 1.277 MB / 0.7638 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003731/1.983, allocations: 1.517 MB / 1.079 GB, free: 15.75 MB / 0.7794 GB
Notification: Performance of setup shared object (initialization): time 0.0001434/1.983, allocations: 317 kB / 1.08 GB, free: 15.44 MB / 0.7794 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006912/1.99, allocations: 3.816 MB / 1.083 GB, free: 11.62 MB / 0.7794 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0117/2.002, allocations: 5.879 MB / 1.089 GB, free: 5.02 MB / 0.7794 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01665/2.018, allocations: 9.027 MB / 1.098 GB, free: 11.54 MB / 0.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.7e-05/2.019, allocations: 13.97 kB / 1.098 GB, free: 11.52 MB / 0.795 GB
Notification: Performance of matching and sorting (n=927) (initialization): time 0.03117/2.05, allocations: 11.68 MB / 1.109 GB, free: 15.98 MB / 0.8107 GB
Notification: Performance of prepare postOptimizeDAE: time 7.331e-05/2.05, allocations: 24.25 kB / 1.109 GB, free: 15.96 MB / 0.8107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002636/2.05, allocations: 67.94 kB / 1.109 GB, free: 15.9 MB / 0.8107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002519/2.053, allocations: 1.012 MB / 1.11 GB, free: 14.83 MB / 0.8107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00665/2.059, allocations: 1.57 MB / 1.112 GB, free: 13.35 MB / 0.8107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03402/2.093, allocations: 36.63 MB / 1.148 GB, free: 6.176 MB / 0.8419 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01216/2.105, allocations: 1.115 MB / 1.149 GB, free: 5.055 MB / 0.8419 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001966/2.107, allocations: 288 kB / 1.149 GB, free: 4.773 MB / 0.8419 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02142/2.129, allocations: 8.867 MB / 1.158 GB, free: 11.89 MB / 0.8575 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01158/2.14, allocations: 5.878 MB / 1.163 GB, free: 5.297 MB / 0.8575 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01844/2.159, allocations: 9.022 MB / 1.172 GB, free: 11.82 MB / 0.8732 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.82e-05/2.159, allocations: 12 kB / 1.172 GB, free: 11.81 MB / 0.8732 GB
Notification: Performance of matching and sorting (n=927) (initialization_lambda0): time 0.03155/2.19, allocations: 11.68 MB / 1.184 GB, free: 284 kB / 0.8732 GB
Notification: Performance of prepare postOptimizeDAE: time 5.742e-05/2.19, allocations: 20 kB / 1.184 GB, free: 264 kB / 0.8732 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002639/2.191, allocations: 67.98 kB / 1.184 GB, free: 196 kB / 0.8732 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002513/2.193, allocations: 1.023 MB / 1.185 GB, free: 15.11 MB / 0.8888 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006826/2.2, allocations: 1.573 MB / 1.186 GB, free: 13.63 MB / 0.8888 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.41/2.61, allocations: 36.64 MB / 1.222 GB, free: 292.6 MB / 0.8888 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01177/2.622, allocations: 1.045 MB / 1.223 GB, free: 292.6 MB / 0.8888 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001654/2.623, allocations: 291.5 kB / 1.223 GB, free: 292.6 MB / 0.8888 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 183
 * 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 (837):
 * Single equations (assignments): 807
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 10
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 20
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 20 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.001814/2.625, allocations: 0.5797 MB / 1.224 GB, free: 292.4 MB / 0.8888 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004652/2.63, allocations: 1.229 MB / 1.225 GB, free: 292.4 MB / 0.8888 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01624/2.646, allocations: 8.597 MB / 1.234 GB, free: 291.9 MB / 0.8888 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.008808/2.655, allocations: 6.54 MB / 1.24 GB, free: 290.3 MB / 0.8888 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.318e-05/2.655, allocations: 2.062 kB / 1.24 GB, free: 290.3 MB / 0.8888 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008068/2.663, allocations: 2.7 MB / 1.243 GB, free: 289.4 MB / 0.8888 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004668/2.668, allocations: 120.5 kB / 1.243 GB, free: 289.3 MB / 0.8888 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008494/2.676, allocations: 321 kB / 1.243 GB, free: 289.3 MB / 0.8888 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001024/2.677, allocations: 334 kB / 1.243 GB, free: 289.2 MB / 0.8888 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01642/2.694, allocations: 8.762 MB / 1.252 GB, free: 286.5 MB / 0.8888 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01726/2.711, allocations: 11.87 MB / 1.263 GB, free: 281.9 MB / 0.8888 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003729/2.715, allocations: 3.107 MB / 1.267 GB, free: 280.7 MB / 0.8888 GB
Notification: Performance of sorting global known variables: time 0.02238/2.737, allocations: 11.35 MB / 1.278 GB, free: 276 MB / 0.8888 GB
Notification: Performance of Backend: time 6.11e-07/2.737, allocations: 3.406 kB / 1.278 GB, free: 276 MB / 0.8888 GB
Notification: Performance of simCode: created initialization part: time 0.0345/2.772, allocations: 16.76 MB / 1.294 GB, free: 260.2 MB / 0.8888 GB
Notification: Performance of SimCode: time 0.07176/2.843, allocations: 34.39 MB / 1.328 GB, free: 226.1 MB / 0.8888 GB
Notification: Performance of Templates: time 0.7315/3.575, allocations: 293.5 MB / 1.614 GB, free: 261 MB / 0.8888 GB
[Timeout remaining time 656]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.sim & ./IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.Examples.BoreholeOneUTube.pipe 2>&1) [Timeout 480]