Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 3.1.0-master/package.mo", uses=false)
Using package ThermoPower with version 3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 3.1.0-master/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D")
translateModel(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00145/0.00145, allocations: 107.1 kB / 17.74 MB, free: 5.352 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001541/0.001541, allocations: 190.5 kB / 18.67 MB, free: 4.43 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.29/1.29, allocations: 205.1 MB / 224.6 MB, free: 12.25 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 3.1.0-master/package.mo): time 0.254/0.254, allocations: 48.84 MB / 320.8 MB, free: 11.02 MB / 270.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001404/0.001404, allocations: 67.91 kB / 451.2 MB, free: 8.543 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09287/0.09428, allocations: 59.15 MB / 0.4984 GB, free: 13.26 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D): time 0.2274/0.3217, allocations: 39.96 MB / 0.5374 GB, free: 7.016 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009996/0.3317, allocations: 10.18 MB / 0.5474 GB, free: 5.594 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003106/0.3321, allocations: 10.81 kB / 0.5474 GB, free: 5.59 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0005457/0.3327, allocations: 226.1 kB / 0.5476 GB, free: 5.488 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0006239/0.3333, allocations: 365.2 kB / 0.548 GB, free: 5.312 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01191/0.3452, allocations: 5.05 MB / 0.5529 GB, free: 4.027 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004915/0.3502, allocations: 6.041 MB / 0.5588 GB, free: 2.191 MB / 414.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002097/0.3523, allocations: 1.988 MB / 0.5607 GB, free: 1.195 MB / 414.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001685/0.354, allocations: 1.729 MB / 0.5624 GB, free: 440 kB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003617/0.3576, allocations: 2.849 MB / 0.5652 GB, free: 14.82 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001222/0.3588, allocations: 0.6269 MB / 0.5658 GB, free: 14.82 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01378/0.3726, allocations: 6.734 MB / 0.5724 GB, free: 11.63 MB / 430.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00249/0.3751, allocations: 2.257 MB / 0.5746 GB, free: 10.07 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003819/0.379, allocations: 2.767 MB / 0.5773 GB, free: 8.055 MB / 430.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.0125/0.3915, allocations: 9.914 MB / 0.587 GB, free: 15.42 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.829e-06/0.3915, allocations: 0 / 0.587 GB, free: 15.42 MB / 446.1 MB
Notification: Performance of FrontEnd: time 1.703e-06/0.3915, allocations: 0 / 0.587 GB, free: 15.42 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 7.55e-05/0.3916, allocations: 0 / 0.587 GB, free: 15.42 MB / 446.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1341
 * Number of variables: 1341
Notification: Performance of Generate backend data structure: time 0.02537/0.417, allocations: 8.052 MB / 0.5948 GB, free: 7.301 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.943e-05/0.417, allocations: 15.89 kB / 0.5949 GB, free: 7.285 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003323/0.4204, allocations: 0.7609 MB / 0.5956 GB, free: 6.52 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005751/0.4261, allocations: 2.764 MB / 0.5983 GB, free: 3.711 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000264/0.4264, allocations: 390.7 kB / 0.5987 GB, free: 3.328 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00102/0.4274, allocations: 0.4966 MB / 0.5992 GB, free: 2.832 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0228/0.4502, allocations: 12.05 MB / 0.6109 GB, free: 6.727 MB / 462.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.052e-05/0.4504, allocations: 0 / 0.6109 GB, free: 6.727 MB / 462.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0006208/0.451, allocations: 212 kB / 0.6111 GB, free: 6.52 MB / 462.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001649/0.4512, allocations: 214.4 kB / 0.6113 GB, free: 6.309 MB / 462.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03758/0.4887, allocations: 14.18 MB / 0.6252 GB, free: 8.105 MB / 478.1 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.03198/0.5208, allocations: 24.23 MB / 0.6488 GB, free: 14.11 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01026/0.5311, allocations: 4.466 MB / 0.6532 GB, free: 9.645 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002828/0.5339, allocations: 1.997 MB / 0.6552 GB, free: 7.637 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1268/0.6607, allocations: 64.28 MB / 0.7179 GB, free: 15.72 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.007e-05/0.6608, allocations: 68.48 kB / 0.718 GB, free: 15.64 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=240): time 4.278e-06/0.6608, allocations: 0 / 0.718 GB, free: 15.64 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=240): time 0.09844/0.7592, allocations: 23.6 MB / 0.741 GB, free: 7.957 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.417e-05/0.7593, allocations: 77.41 kB / 0.7411 GB, free: 7.867 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004787/0.7641, allocations: 3.968 MB / 0.745 GB, free: 3.906 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005165/0.7646, allocations: 69.7 kB / 0.7451 GB, free: 3.832 MB / 0.5919 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00193/0.7666, allocations: 3.132 MB / 0.7481 GB, free: 0.6484 MB / 0.5919 GB
Notification: Performance of collectInitialBindings (initialization): time 0.2173/0.9839, allocations: 0.9745 MB / 0.7491 GB, free: 172.1 MB / 0.5919 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00279/0.9867, allocations: 1.954 MB / 0.751 GB, free: 172.1 MB / 0.5919 GB
Notification: Performance of setup shared object (initialization): time 8.845e-05/0.9868, allocations: 339.3 kB / 0.7513 GB, free: 171.7 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006123/0.993, allocations: 3.83 MB / 0.755 GB, free: 171.7 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007948/1.001, allocations: 8.931 MB / 0.7638 GB, free: 165.1 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01498/1.016, allocations: 13.38 MB / 0.7768 GB, free: 157.7 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000288/1.016, allocations: 55.56 kB / 0.7769 GB, free: 157.7 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=1097) (initialization): time 0.02419/1.04, allocations: 15.06 MB / 0.7916 GB, free: 153.3 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001348/1.041, allocations: 86.75 kB / 0.7917 GB, free: 153.3 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002777/1.041, allocations: 177.5 kB / 0.7918 GB, free: 153.3 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03124/1.072, allocations: 10.27 MB / 0.8019 GB, free: 150.7 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00446/1.077, allocations: 1.742 MB / 0.8036 GB, free: 149.2 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01318/1.09, allocations: 9.12 MB / 0.8125 GB, free: 140.7 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005825/1.096, allocations: 1.168 MB / 0.8136 GB, free: 139.5 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009442/1.097, allocations: 0.6443 MB / 0.8142 GB, free: 138.9 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00607/1.103, allocations: 4.956 MB / 0.8191 GB, free: 133.9 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006086/1.109, allocations: 8.862 MB / 0.8277 GB, free: 122.5 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01095/1.12, allocations: 13.25 MB / 0.8407 GB, free: 106.7 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.979e-05/1.12, allocations: 54.58 kB / 0.8407 GB, free: 106.6 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=1097) (initialization_lambda0): time 0.02011/1.14, allocations: 14.99 MB / 0.8554 GB, free: 91.65 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 6.47e-05/1.14, allocations: 84 kB / 0.8555 GB, free: 91.57 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.96e-05/1.14, allocations: 180 kB / 0.8556 GB, free: 91.39 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03097/1.171, allocations: 10.25 MB / 0.8656 GB, free: 81.12 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004309/1.176, allocations: 1.735 MB / 0.8673 GB, free: 79.39 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01332/1.189, allocations: 9.094 MB / 0.8762 GB, free: 70.26 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005752/1.195, allocations: 0.8437 MB / 0.877 GB, free: 69.41 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000852/1.195, allocations: 0.6409 MB / 0.8777 GB, free: 68.77 MB / 0.5919 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 820
 * Number of states: 0 ()
 * Number of discrete variables: 12 (hex.fluidState[12].phase,hex.fluidState[11].phase,hex.fluidState[10].phase,hex.fluidState[9].phase,hex.fluidState[8].phase,hex.fluidState[7].phase,hex.fluidState[6].phase,hex.fluidState[5].phase,hex.fluidState[4].phase,hex.fluidState[3].phase,hex.fluidState[2].phase,hex.fluidState[1].phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (943):
 * Single equations (assignments): 942
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(13,142)}
Notification: Performance of prepare postOptimizeDAE: time 0.001922/1.197, allocations: 0.845 MB / 0.8785 GB, free: 67.92 MB / 0.5919 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007098/1.198, allocations: 351.5 kB / 0.8788 GB, free: 67.57 MB / 0.5919 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03663/1.235, allocations: 31.18 MB / 0.9093 GB, free: 36.34 MB / 0.5919 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.821e-05/1.235, allocations: 11.95 kB / 0.9093 GB, free: 36.33 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.078e-06/1.235, allocations: 0 / 0.9093 GB, free: 36.33 MB / 0.5919 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001533/1.236, allocations: 0.8343 MB / 0.9101 GB, free: 35.47 MB / 0.5919 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005161/1.237, allocations: 87.95 kB / 0.9102 GB, free: 35.38 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002654/1.24, allocations: 275.5 kB / 0.9104 GB, free: 35.11 MB / 0.5919 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008391/1.24, allocations: 334.2 kB / 0.9108 GB, free: 34.79 MB / 0.5919 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01887/1.259, allocations: 8.621 MB / 0.9192 GB, free: 26.21 MB / 0.5919 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0101/1.269, allocations: 8.692 MB / 0.9277 GB, free: 17.45 MB / 0.5919 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002975/1.272, allocations: 2.724 MB / 0.9303 GB, free: 14.71 MB / 0.5919 GB
Notification: Performance of sorting global known variables: time 0.002327/1.275, allocations: 2.314 MB / 0.9326 GB, free: 12.42 MB / 0.5919 GB
Notification: Performance of Backend: time 4.41e-07/1.275, allocations: 0 / 0.9326 GB, free: 12.42 MB / 0.5919 GB
Notification: Performance of simCode: created initialization part: time 0.02885/1.304, allocations: 15.19 MB / 0.9474 GB, free: 13.52 MB / 0.6075 GB
Notification: Performance of SimCode: time 0.01442/1.318, allocations: 10.38 MB / 0.9576 GB, free: 3.125 MB / 0.6075 GB
Notification: Performance of Templates: time 0.3968/1.715, allocations: 182.1 MB / 1.135 GB, free: 103.6 MB / 0.6387 GB
make -j1 -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.makefile
(rm -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.pipe ; mkfifo ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.pipe ; head -c 1048576 < ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.pipe >> ../files/ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.sim & ./ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_D.pipe 2>&1)