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.002577/0.002582, allocations: 357.3 kB / 16.59 MB, free: 5.562 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.581/1.581, allocations: 165.8 MB / 183.1 MB, free: 5.492 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.025/4.025, allocations: 410.8 MB / 0.6001 GB, free: 15.15 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001727/0.001726, allocations: 199.8 kB / 0.6668 GB, free: 6.91 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004582/0.0004584, allocations: 16 kB / 0.7429 GB, free: 8.902 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4015/0.402, allocations: 67.45 MB / 0.8088 GB, free: 28.76 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Geothermal.Borefields.BaseClasses.Boreholes.BaseClasses.Examples.InternalHEXTwoUTube): time 0.1234/0.5255, allocations: 79.3 MB / 0.8862 GB, free: 13.25 MB / 442.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04938/0.5749, allocations: 23.16 MB / 0.9089 GB, free: 6.039 MB / 458.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0048/0.5798, allocations: 103.3 kB / 0.9089 GB, free: 5.938 MB / 458.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.007217/0.5871, allocations: 1.483 MB / 0.9104 GB, free: 4.445 MB / 458.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01713/0.6042, allocations: 4.049 MB / 0.9144 GB, free: 388 kB / 458.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01661/0.6209, allocations: 3.749 MB / 0.918 GB, free: 12.69 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.017/0.6379, allocations: 9.233 MB / 0.927 GB, free: 3.434 MB / 474.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.005346/0.6433, allocations: 2.065 MB / 0.929 GB, free: 1.324 MB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.4326/1.076, allocations: 2.287 MB / 0.9313 GB, free: 11.97 MB / 474.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006023/1.082, allocations: 2.17 MB / 0.9334 GB, free: 11.97 MB / 474.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.002073/1.084, allocations: 144.8 kB / 0.9335 GB, free: 11.97 MB / 474.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01369/1.098, allocations: 2.269 MB / 0.9358 GB, free: 11.97 MB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001861/1.1, allocations: 0.597 MB / 0.9363 GB, free: 11.97 MB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.00205/1.102, allocations: 0.704 MB / 0.937 GB, free: 11.94 MB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01002/1.112, allocations: 5.363 MB / 0.9423 GB, free: 11.59 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.124e-06/1.112, allocations: 2.656 kB / 0.9423 GB, free: 11.59 MB / 474.7 MB
Notification: Performance of FrontEnd: time 3.517e-06/1.112, allocations: 0 / 0.9423 GB, free: 11.59 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 0.0001859/1.112, allocations: 2.734 kB / 0.9423 GB, free: 11.59 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.01046/1.123, allocations: 3.287 MB / 0.9455 GB, free: 9.902 MB / 474.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.338e-05/1.123, allocations: 8.625 kB / 0.9455 GB, free: 9.902 MB / 474.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002366/1.125, allocations: 377.2 kB / 0.9458 GB, free: 9.727 MB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008171/1.133, allocations: 2.465 MB / 0.9483 GB, free: 9.203 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001953/1.134, allocations: 166.2 kB / 0.9484 GB, free: 9.191 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008352/1.135, allocations: 213.8 kB / 0.9486 GB, free: 9.191 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007045/1.142, allocations: 2.172 MB / 0.9507 GB, free: 8.922 MB / 474.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001062/1.142, allocations: 10.09 kB / 0.9507 GB, free: 8.918 MB / 474.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003117/1.142, allocations: 89.44 kB / 0.9508 GB, free: 8.918 MB / 474.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.944e-05/1.142, allocations: 49.12 kB / 0.9509 GB, free: 8.918 MB / 474.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005577/1.148, allocations: 1.658 MB / 0.9525 GB, free: 8.887 MB / 474.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.02151/1.169, allocations: 9.302 MB / 0.9616 GB, free: 21.57 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002881/1.172, allocations: 1.182 MB / 0.9627 GB, free: 21.54 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001924/1.174, allocations: 0.8509 MB / 0.9636 GB, free: 21.51 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.003818/1.178, allocations: 2.918 MB / 0.9664 GB, free: 18.23 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.024e-05/1.178, allocations: 52.81 kB / 0.9665 GB, free: 18.18 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=148): time 5e-06/1.178, allocations: 0 / 0.9665 GB, free: 18.18 MB / 490.7 MB
Notification: Performance of matching and sorting (n=148): time 0.00951/1.188, allocations: 2.723 MB / 0.9691 GB, free: 17.34 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.347e-05/1.188, allocations: 92.69 kB / 0.9692 GB, free: 17.25 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005209/1.193, allocations: 2.222 MB / 0.9714 GB, free: 17.01 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0004117/1.194, allocations: 55.98 kB / 0.9714 GB, free: 16.98 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001305/1.195, allocations: 1.189 MB / 0.9726 GB, free: 16.59 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0008323/1.196, allocations: 0.5212 MB / 0.9731 GB, free: 16.26 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001558/1.196, allocations: 35.94 kB / 0.9731 GB, free: 16.26 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002238/1.196, allocations: 380.8 kB / 0.9735 GB, free: 15.95 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001648/1.198, allocations: 0.5564 MB / 0.974 GB, free: 15.95 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002259/1.2, allocations: 0.9295 MB / 0.975 GB, free: 15.61 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002124/1.202, allocations: 0.7153 MB / 0.9757 GB, free: 15.57 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.357e-05/1.202, allocations: 2.938 kB / 0.9757 GB, free: 15.57 MB / 490.7 MB
Notification: Performance of matching and sorting (n=239) (initialization): time 0.006841/1.209, allocations: 2.086 MB / 0.9777 GB, free: 15.3 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002062/1.209, allocations: 290.4 kB / 0.978 GB, free: 14.97 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.776e-05/1.21, allocations: 25.22 kB / 0.978 GB, free: 14.96 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001614/1.211, allocations: 265.5 kB / 0.9782 GB, free: 14.9 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002789/1.214, allocations: 390 kB / 0.9786 GB, free: 14.9 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007708/1.222, allocations: 7.045 MB / 0.9855 GB, free: 8.516 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004434/1.226, allocations: 305.8 kB / 0.9858 GB, free: 8.406 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004823/1.227, allocations: 79.56 kB / 0.9859 GB, free: 8.402 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.336e-05/1.227, allocations: 7.547 kB / 0.9859 GB, free: 8.402 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00585/1.233, allocations: 1.801 MB / 0.9876 GB, free: 8.207 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.295e-05/1.233, allocations: 11.98 kB / 0.9876 GB, free: 8.203 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008393/1.234, allocations: 213.5 kB / 0.9878 GB, free: 8.121 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00274/1.236, allocations: 386 kB / 0.9882 GB, free: 8.074 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01037/1.247, allocations: 9.092 MB / 0.9971 GB, free: 15.65 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003986/1.251, allocations: 287.1 kB / 0.9974 GB, free: 15.51 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004587/1.251, allocations: 75.05 kB / 0.9974 GB, free: 15.5 MB / 0.4948 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.002319/1.254, allocations: 0.6449 MB / 0.9981 GB, free: 15.29 MB / 0.4948 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001031/1.255, allocations: 261.4 kB / 0.9983 GB, free: 15.15 MB / 0.4948 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006439/1.261, allocations: 2.01 MB / 1 GB, free: 14.68 MB / 0.4948 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00436/1.266, allocations: 1.643 MB / 1.002 GB, free: 14.18 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.588e-05/1.266, allocations: 0 / 1.002 GB, free: 14.18 MB / 0.4948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002372/1.268, allocations: 0.5887 MB / 1.002 GB, free: 13.83 MB / 0.4948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001041/1.269, allocations: 29.03 kB / 1.002 GB, free: 13.83 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003245/1.272, allocations: 131.7 kB / 1.003 GB, free: 13.78 MB / 0.4948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004396/1.273, allocations: 111.5 kB / 1.003 GB, free: 13.73 MB / 0.4948 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.007059/1.28, allocations: 1.937 MB / 1.005 GB, free: 13.25 MB / 0.4948 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.006896/1.287, allocations: 2.6 MB / 1.007 GB, free: 12.25 MB / 0.4948 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001869/1.289, allocations: 0.6692 MB / 1.008 GB, free: 11.84 MB / 0.4948 GB
Notification: Performance of sorting global known variables: time 0.004324/1.293, allocations: 1.489 MB / 1.009 GB, free: 10.78 MB / 0.4948 GB
Notification: Performance of Backend: time 6.11e-07/1.293, allocations: 0 / 1.009 GB, free: 10.78 MB / 0.4948 GB
Notification: Performance of simCode: created initialization part: time 0.01513/1.308, allocations: 4.393 MB / 1.014 GB, free: 7.137 MB / 0.4948 GB
Notification: Performance of SimCode: time 0.02201/1.33, allocations: 7.309 MB / 1.021 GB, free: 368 kB / 0.4948 GB
Notification: Performance of Templates: time 0.1783/1.509, allocations: 64.93 MB / 1.084 GB, free: 408 kB / 0.5573 GB