Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.BaseClasses.Examples.InternalHEXTwoUTube.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.BaseClasses.Examples.InternalHEXTwoUTube,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.BaseClasses.Examples.InternalHEXTwoUTube")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001415/0.001414, allocations: 183.3 kB / 15.77 MB, free: 6.371 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.6623/0.6623, allocations: 82.94 MB / 99.43 MB, free: 2.23 MB / 74.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.173/2.173, allocations: 205.4 MB / 325.4 MB, free: 6.535 MB / 266.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001009/0.001009, allocations: 104 kB / 393.6 MB, free: 11.34 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004563/0.0004565, allocations: 12 kB / 471.6 MB, free: 13.3 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3973/0.3978, allocations: 67.43 MB / 0.5264 GB, free: 55.68 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.BaseClasses.Examples.InternalHEXTwoUTube): time 0.08446/0.4823, allocations: 71.52 MB / 0.5962 GB, free: 11.2 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04277/0.5251, allocations: 21.73 MB / 0.6175 GB, free: 5.434 MB / 442.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004726/0.5299, allocations: 95.38 kB / 0.6176 GB, free: 5.34 MB / 442.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.006396/0.5363, allocations: 1.613 MB / 0.6191 GB, free: 3.723 MB / 442.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.02039/0.5567, allocations: 3.872 MB / 0.6229 GB, free: 15.84 MB / 458.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02266/0.5794, allocations: 3.774 MB / 0.6266 GB, free: 12.1 MB / 458.7 MB
Notification: Performance of NFFlatten.flatten: time 0.0109/0.5904, allocations: 4.903 MB / 0.6314 GB, free: 7.191 MB / 458.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004486/0.5949, allocations: 2.089 MB / 0.6334 GB, free: 5.059 MB / 458.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005716/0.6006, allocations: 2.121 MB / 0.6355 GB, free: 2.93 MB / 458.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003504/0.6042, allocations: 1.587 MB / 0.637 GB, free: 1.336 MB / 458.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0007335/0.605, allocations: 144 kB / 0.6372 GB, free: 1.195 MB / 458.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.007809/0.6128, allocations: 2.419 MB / 0.6395 GB, free: 14.77 MB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.00126/0.6141, allocations: 0.5798 MB / 0.6401 GB, free: 14.19 MB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001422/0.6155, allocations: 0.7031 MB / 0.6408 GB, free: 13.48 MB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.009952/0.6255, allocations: 5.338 MB / 0.646 GB, free: 8.129 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.157e-06/0.6256, allocations: 0 / 0.646 GB, free: 8.129 MB / 474.7 MB
Notification: Performance of FrontEnd: time 3.146e-06/0.6256, allocations: 0 / 0.646 GB, free: 8.129 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 8.791e-05/0.6257, allocations: 0 / 0.646 GB, free: 8.129 MB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 526
 * Number of variables: 526
Notification: Performance of Generate backend data structure: time 0.007835/0.6335, allocations: 3.289 MB / 0.6492 GB, free: 4.762 MB / 474.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.074e-05/0.6336, allocations: 8.031 kB / 0.6492 GB, free: 4.754 MB / 474.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001358/0.635, allocations: 383.7 kB / 0.6496 GB, free: 4.375 MB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006239/0.6412, allocations: 2.348 MB / 0.6519 GB, free: 1.953 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001865/0.6414, allocations: 164.1 kB / 0.652 GB, free: 1.789 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005057/0.642, allocations: 220 kB / 0.6523 GB, free: 1.574 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005899/0.6479, allocations: 2.151 MB / 0.6544 GB, free: 15.31 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7.745e-05/0.648, allocations: 19.83 kB / 0.6544 GB, free: 15.29 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000283/0.6483, allocations: 84 kB / 0.6545 GB, free: 15.21 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.905e-05/0.6484, allocations: 48 kB / 0.6545 GB, free: 15.16 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005042/0.6534, allocations: 1.659 MB / 0.6561 GB, free: 13.49 MB / 490.7 MB
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.01956/0.673, allocations: 9.374 MB / 0.6653 GB, free: 3.684 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00273/0.6758, allocations: 1.172 MB / 0.6664 GB, free: 2.5 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.003479/0.6793, allocations: 2.922 MB / 0.6693 GB, free: 14.93 MB / 0.4948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.092e-05/0.6794, allocations: 51.88 kB / 0.6693 GB, free: 14.88 MB / 0.4948 GB
Notification: Performance of pre-optimization done (n=148): time 7.479e-06/0.6794, allocations: 4 kB / 0.6693 GB, free: 14.87 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=148): time 0.007643/0.6871, allocations: 2.709 MB / 0.672 GB, free: 12.03 MB / 0.4948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.853e-05/0.6872, allocations: 94.36 kB / 0.6721 GB, free: 11.91 MB / 0.4948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00476/0.692, allocations: 2.301 MB / 0.6743 GB, free: 9.598 MB / 0.4948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002997/0.6923, allocations: 61.7 kB / 0.6744 GB, free: 9.531 MB / 0.4948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00144/0.6938, allocations: 1.185 MB / 0.6755 GB, free: 8.332 MB / 0.4948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000837/0.6946, allocations: 0.5198 MB / 0.676 GB, free: 7.805 MB / 0.4948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001316/0.6948, allocations: 36 kB / 0.6761 GB, free: 7.77 MB / 0.4948 GB
Notification: Performance of setup shared object (initialization): time 0.000266/0.6951, allocations: 381.9 kB / 0.6764 GB, free: 7.391 MB / 0.4948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001515/0.6966, allocations: 0.5544 MB / 0.677 GB, free: 6.836 MB / 0.4948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002054/0.6987, allocations: 0.9257 MB / 0.6779 GB, free: 5.789 MB / 0.4948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001954/0.7006, allocations: 0.7127 MB / 0.6786 GB, free: 5.078 MB / 0.4948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.586e-05/0.7007, allocations: 4 kB / 0.6786 GB, free: 5.074 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=239) (initialization): time 0.006142/0.7068, allocations: 2.1 MB / 0.6806 GB, free: 2.945 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001554/0.7084, allocations: 2.718 MB / 0.6833 GB, free: 15.98 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.944e-05/0.7085, allocations: 11.98 kB / 0.6833 GB, free: 15.97 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001378/0.7099, allocations: 268.9 kB / 0.6835 GB, free: 15.69 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001996/0.7119, allocations: 383.5 kB / 0.6839 GB, free: 15.31 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00852/0.7205, allocations: 7.079 MB / 0.6908 GB, free: 7.652 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002957/0.7235, allocations: 310.5 kB / 0.6911 GB, free: 7.348 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003239/0.7238, allocations: 71.98 kB / 0.6912 GB, free: 7.277 MB / 0.5105 GB
Notification: Performance of prepare postOptimizeDAE: time 1.458e-05/0.7239, allocations: 8 kB / 0.6912 GB, free: 7.27 MB / 0.5105 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.004764/0.7286, allocations: 1.801 MB / 0.693 GB, free: 5.449 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.314e-05/0.7287, allocations: 12 kB / 0.693 GB, free: 5.438 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000747/0.7295, allocations: 213.2 kB / 0.6932 GB, free: 5.211 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002774/0.7323, allocations: 387.4 kB / 0.6935 GB, free: 4.832 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.3866/1.119, allocations: 9.135 MB / 0.7025 GB, free: 141.6 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002936/1.122, allocations: 288.7 kB / 0.7027 GB, free: 141.6 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003201/1.122, allocations: 74.97 kB / 0.7028 GB, free: 141.6 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 29
 * 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 (215):
 * Single equations (assignments): 208
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 4 {(1,100.0%) 3,(1,100.0%) 3,(1,100.0%) 3,(1,100.0%) 3}
 * Non-linear torn systems: 2 {1 4,1 4}
Notification: Performance of prepare postOptimizeDAE: time 0.001612/1.124, allocations: 0.6418 MB / 0.7034 GB, free: 141.4 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007182/1.125, allocations: 260.2 kB / 0.7037 GB, free: 141.4 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005217/1.13, allocations: 2.018 MB / 0.7057 GB, free: 140.9 MB / 0.5105 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.343e-05/1.13, allocations: 17.86 kB / 0.7057 GB, free: 140.9 MB / 0.5105 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.014e-05/1.13, allocations: 3.906 kB / 0.7057 GB, free: 140.9 MB / 0.5105 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003492/1.133, allocations: 1.64 MB / 0.7073 GB, free: 140 MB / 0.5105 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01026/1.144, allocations: 4.396 MB / 0.7116 GB, free: 138.1 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.243e-05/1.144, allocations: 1.344 kB / 0.7116 GB, free: 138.1 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001535/1.145, allocations: 274.4 kB / 0.7118 GB, free: 138 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.000767/1.146, allocations: 206.9 kB / 0.712 GB, free: 137.9 MB / 0.5105 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001502/1.146, allocations: 46.62 kB / 0.7121 GB, free: 137.9 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00534/1.152, allocations: 7.094 MB / 0.719 GB, free: 131.1 MB / 0.5105 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.064e-06/1.152, allocations: 1.469 kB / 0.719 GB, free: 131.1 MB / 0.5105 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005992/1.158, allocations: 2.708 MB / 0.7216 GB, free: 129.7 MB / 0.5105 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001715/1.159, allocations: 0.6201 MB / 0.7223 GB, free: 129.3 MB / 0.5105 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000472/1.16, allocations: 29.64 kB / 0.7223 GB, free: 129.3 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00187/1.162, allocations: 140 kB / 0.7224 GB, free: 129.2 MB / 0.5105 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002557/1.162, allocations: 108.9 kB / 0.7225 GB, free: 129.2 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001728/1.162, allocations: 55.64 kB / 0.7226 GB, free: 129.2 MB / 0.5105 GB
Notification: Performance of sorting global known variables: time 0.003759/1.166, allocations: 1.559 MB / 0.7241 GB, free: 128.6 MB / 0.5105 GB
Notification: Performance of sort global known variables: time 1.106e-06/1.166, allocations: 0 / 0.7241 GB, free: 128.6 MB / 0.5105 GB
Notification: Performance of remove unused functions: time 0.007619/1.174, allocations: 1.897 MB / 0.7259 GB, free: 128.3 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 12 (intHex.vol1.dynBal.U,intHex.vol2.dynBal.U,intHex.vol3.dynBal.U,intHex.vol4.dynBal.U,intHex.intRes2UTub.capFil1.T,intHex.intRes2UTub.capFil2.T,intHex.intRes2UTub.capFil3.T,intHex.intRes2UTub.capFil4.T,senTem.T,senTem1.T,senTem2.T,senTem3.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 (140):
 * Single equations (assignments): 123
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 11
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 4 {(1,100.0%) 3,(1,100.0%) 3,(1,100.0%) 3,(1,100.0%) 3}
 * Non-linear torn systems: 2 {1 4,1 4}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002804/1.177, allocations: 1.101 MB / 0.727 GB, free: 128.1 MB / 0.5105 GB
Notification: Performance of simCode: created initialization part: time 0.007496/1.184, allocations: 3.723 MB / 0.7307 GB, free: 126 MB / 0.5105 GB
Notification: Performance of simCode: created event and clocks part: time 9.426e-06/1.184, allocations: 1.375 kB / 0.7307 GB, free: 126 MB / 0.5105 GB
Notification: Performance of simCode: created simulation system equations: time 0.002369/1.187, allocations: 1.224 MB / 0.7319 GB, free: 125.3 MB / 0.5105 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00757/1.194, allocations: 1.301 MB / 0.7331 GB, free: 125 MB / 0.5105 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01016/1.204, allocations: 6.058 MB / 0.739 GB, free: 121.5 MB / 0.5105 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001539/1.206, allocations: 1.792 MB / 0.7408 GB, free: 120.7 MB / 0.5105 GB
Notification: Performance of simCode: alias equations: time 0.003649/1.21, allocations: 0.5875 MB / 0.7414 GB, free: 120.6 MB / 0.5105 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007286/1.21, allocations: 213.5 kB / 0.7416 GB, free: 120.5 MB / 0.5105 GB
Notification: Performance of SimCode: time 1.632e-06/1.21, allocations: 0 / 0.7416 GB, free: 120.5 MB / 0.5105 GB
Notification: Performance of Templates: time 0.1174/1.328, allocations: 60.81 MB / 0.801 GB, free: 62.64 MB / 0.5105 GB