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.002496/0.002501, allocations: 353 kB / 16.58 MB, free: 5.566 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.33/1.33, allocations: 165.8 MB / 183.1 MB, free: 5.918 MB / 90.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.195/4.195, allocations: 410.7 MB / 0.6001 GB, free: 2.207 MB / 410.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001864/0.001863, allocations: 184.8 kB / 0.6668 GB, free: 14.05 MB / 490.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004392/0.0004393, allocations: 8 kB / 0.7429 GB, free: 8 kB / 0.5417 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4876/0.4881, allocations: 67.45 MB / 0.8088 GB, free: 245.5 MB / 0.5886 GB
Notification: Performance of FrontEnd - scodeFlatten: time 0.8571/1.345, allocations: 389.5 MB / 1.189 GB, free: 99.68 MB / 0.5886 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0004356/1.346, allocations: 131.3 kB / 1.189 GB, free: 99.6 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 5.076/6.422, allocations: 1.016 GB / 2.205 GB, free: 18.2 MB / 0.6042 GB
Notification: Performance of FrontEnd: time 3.146e-06/6.422, allocations: 0 / 2.205 GB, free: 18.2 MB / 0.6042 GB
Notification: Performance of Transformations before backend: time 0.0004126/6.422, allocations: 75.92 kB / 2.205 GB, free: 18.12 MB / 0.6042 GB
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.0126/6.435, allocations: 3.607 MB / 2.209 GB, free: 14.44 MB / 0.6042 GB
Notification: Performance of prepare preOptimizeDAE: time 4.393e-05/6.435, allocations: 8.031 kB / 2.209 GB, free: 14.43 MB / 0.6042 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001949/6.437, allocations: 375.8 kB / 2.209 GB, free: 14.06 MB / 0.6042 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00933/6.446, allocations: 2.791 MB / 2.212 GB, free: 11.19 MB / 0.6042 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001465/6.446, allocations: 160.1 kB / 2.212 GB, free: 11.03 MB / 0.6042 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004712/6.447, allocations: 223.9 kB / 2.212 GB, free: 10.81 MB / 0.6042 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005608/6.452, allocations: 2.124 MB / 2.214 GB, free: 8.578 MB / 0.6042 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.438e-05/6.453, allocations: 11.89 kB / 2.214 GB, free: 8.566 MB / 0.6042 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003027/6.453, allocations: 92 kB / 2.214 GB, free: 8.477 MB / 0.6042 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.456e-05/6.453, allocations: 54.89 kB / 2.214 GB, free: 8.43 MB / 0.6042 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004555/6.457, allocations: 1.612 MB / 2.216 GB, free: 6.801 MB / 0.6042 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.4958/6.953, allocations: 8.781 MB / 2.224 GB, free: 35.3 MB / 0.6042 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002865/6.956, allocations: 1.345 MB / 2.226 GB, free: 35.08 MB / 0.6042 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001879/6.958, allocations: 0.8752 MB / 2.227 GB, free: 35.07 MB / 0.6042 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002778/6.961, allocations: 2.925 MB / 2.229 GB, free: 31.79 MB / 0.6042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.468e-05/6.961, allocations: 47.78 kB / 2.23 GB, free: 31.75 MB / 0.6042 GB
Notification: Performance of pre-optimization done (n=148): time 4.288e-06/6.961, allocations: 0 / 2.23 GB, free: 31.75 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=148): time 0.009145/6.97, allocations: 2.754 MB / 2.232 GB, free: 31.07 MB / 0.6042 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.03e-05/6.97, allocations: 91.89 kB / 2.232 GB, free: 30.97 MB / 0.6042 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00526/6.976, allocations: 2.198 MB / 2.234 GB, free: 30.76 MB / 0.6042 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004398/6.976, allocations: 61.11 kB / 2.235 GB, free: 30.73 MB / 0.6042 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00119/6.977, allocations: 1.203 MB / 2.236 GB, free: 30.46 MB / 0.6042 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007814/6.978, allocations: 0.5208 MB / 2.236 GB, free: 30.2 MB / 0.6042 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001293/6.978, allocations: 32.5 kB / 2.236 GB, free: 30.2 MB / 0.6042 GB
Notification: Performance of setup shared object (initialization): time 0.0001308/6.978, allocations: 373.9 kB / 2.237 GB, free: 29.89 MB / 0.6042 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001407/6.98, allocations: 0.5256 MB / 2.237 GB, free: 29.89 MB / 0.6042 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001698/6.981, allocations: 0.9028 MB / 2.238 GB, free: 29.54 MB / 0.6042 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001723/6.983, allocations: 0.6792 MB / 2.239 GB, free: 29.52 MB / 0.6042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.727e-06/6.983, allocations: 1.125 kB / 2.239 GB, free: 29.52 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=215) (initialization): time 0.005832/6.989, allocations: 2.006 MB / 2.241 GB, free: 29.25 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001841/6.989, allocations: 292.9 kB / 2.241 GB, free: 28.93 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.748e-05/6.989, allocations: 13.91 kB / 2.241 GB, free: 28.93 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001471/6.991, allocations: 265.1 kB / 2.241 GB, free: 28.88 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002475/6.993, allocations: 351.1 kB / 2.241 GB, free: 28.88 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006835/7, allocations: 7.046 MB / 2.248 GB, free: 38.54 MB / 0.6198 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00399/7.004, allocations: 275.7 kB / 2.249 GB, free: 38.49 MB / 0.6198 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003487/7.005, allocations: 76.62 kB / 2.249 GB, free: 38.49 MB / 0.6198 GB
Notification: Performance of prepare postOptimizeDAE: time 1.096e-05/7.005, allocations: 3.875 kB / 2.249 GB, free: 38.49 MB / 0.6198 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.004587/7.009, allocations: 1.712 MB / 2.25 GB, free: 38.38 MB / 0.6198 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.638e-05/7.009, allocations: 7.812 kB / 2.25 GB, free: 38.38 MB / 0.6198 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007835/7.01, allocations: 210.2 kB / 2.251 GB, free: 38.34 MB / 0.6198 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002344/7.012, allocations: 351.8 kB / 2.251 GB, free: 38.34 MB / 0.6198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009283/7.022, allocations: 8.981 MB / 2.26 GB, free: 30.36 MB / 0.6198 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003813/7.026, allocations: 255.3 kB / 2.26 GB, free: 30.32 MB / 0.6198 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003385/7.026, allocations: 71.91 kB / 2.26 GB, free: 30.32 MB / 0.6198 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 (191):
 * Single equations (assignments): 184
 * 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.00205/7.028, allocations: 0.6434 MB / 2.261 GB, free: 30.12 MB / 0.6198 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008596/7.029, allocations: 259.4 kB / 2.261 GB, free: 29.99 MB / 0.6198 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005446/7.034, allocations: 2.039 MB / 2.263 GB, free: 29.82 MB / 0.6198 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.997e-05/7.034, allocations: 18.22 kB / 2.263 GB, free: 29.82 MB / 0.6198 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.869e-06/7.035, allocations: 3.812 kB / 2.263 GB, free: 29.82 MB / 0.6198 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003665/7.038, allocations: 1.668 MB / 2.265 GB, free: 29.46 MB / 0.6198 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01121/7.049, allocations: 4.486 MB / 2.269 GB, free: 28.84 MB / 0.6198 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.073e-05/7.049, allocations: 0 / 2.269 GB, free: 28.84 MB / 0.6198 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002102/7.052, allocations: 267.7 kB / 2.269 GB, free: 28.84 MB / 0.6198 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0008086/7.052, allocations: 217 kB / 2.269 GB, free: 28.79 MB / 0.6198 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001519/7.053, allocations: 40.59 kB / 2.269 GB, free: 28.79 MB / 0.6198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006648/7.059, allocations: 7.061 MB / 2.276 GB, free: 22.43 MB / 0.6198 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.895e-06/7.059, allocations: 0 / 2.276 GB, free: 22.43 MB / 0.6198 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006598/7.066, allocations: 2.695 MB / 2.279 GB, free: 21.99 MB / 0.6198 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002124/7.068, allocations: 0.5556 MB / 2.279 GB, free: 21.77 MB / 0.6198 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000708/7.069, allocations: 31.84 kB / 2.28 GB, free: 21.77 MB / 0.6198 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002855/7.072, allocations: 159.8 kB / 2.28 GB, free: 21.76 MB / 0.6198 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002623/7.072, allocations: 102 kB / 2.28 GB, free: 21.76 MB / 0.6198 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001943/7.072, allocations: 60.42 kB / 2.28 GB, free: 21.76 MB / 0.6198 GB
Notification: Performance of sorting global known variables: time 0.003575/7.076, allocations: 1.485 MB / 2.281 GB, free: 21.61 MB / 0.6198 GB
Notification: Performance of sort global known variables: time 6.51e-07/7.076, allocations: 1.219 kB / 2.281 GB, free: 21.61 MB / 0.6198 GB
Notification: Performance of remove unused functions: time 0.009049/7.085, allocations: 1.963 MB / 2.283 GB, free: 21.54 MB / 0.6198 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.00476/7.09, allocations: 1.712 MB / 2.285 GB, free: 21.29 MB / 0.6198 GB
Notification: Performance of simCode: created initialization part: time 0.008012/7.098, allocations: 3.59 MB / 2.288 GB, free: 20.07 MB / 0.6198 GB
Notification: Performance of simCode: created event and clocks part: time 1.076e-05/7.098, allocations: 2.438 kB / 2.288 GB, free: 20.07 MB / 0.6198 GB
Notification: Performance of simCode: created simulation system equations: time 0.002555/7.1, allocations: 1.245 MB / 2.29 GB, free: 19.61 MB / 0.6198 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01199/7.112, allocations: 1.369 MB / 2.291 GB, free: 19.59 MB / 0.6198 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01287/7.125, allocations: 6.101 MB / 2.297 GB, free: 17.05 MB / 0.6198 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00189/7.127, allocations: 1.8 MB / 2.299 GB, free: 16.32 MB / 0.6198 GB
Notification: Performance of simCode: alias equations: time 0.004024/7.131, allocations: 0.5903 MB / 2.299 GB, free: 16.29 MB / 0.6198 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008965/7.132, allocations: 208.2 kB / 2.299 GB, free: 16.29 MB / 0.6198 GB
Notification: Performance of SimCode: time 1.223e-06/7.132, allocations: 2.719 kB / 2.299 GB, free: 16.29 MB / 0.6198 GB
Notification: Performance of Templates: time 0.1534/7.286, allocations: 64.18 MB / 2.362 GB, free: 12.33 MB / 0.6198 GB