Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.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.TestFlow1Dfem2ph,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph")
translateModel(ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001083/0.001083, allocations: 102.4 kB / 17.74 MB, free: 5.344 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.001004/0.001004, allocations: 189.3 kB / 18.68 MB, free: 4.414 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.346/1.346, allocations: 205.1 MB / 224.6 MB, free: 12.24 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 3.1.0-master/package.mo): time 0.2649/0.2649, allocations: 48.85 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.001509/0.001509, allocations: 63.91 kB / 451.2 MB, free: 8.535 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09371/0.09523, allocations: 59.16 MB / 0.4984 GB, free: 13.24 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph): time 0.244/0.3392, allocations: 36 MB / 0.5336 GB, free: 7.656 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01999/0.3593, allocations: 12.51 MB / 0.5458 GB, free: 7.309 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005634/0.3599, allocations: 11.75 kB / 0.5458 GB, free: 7.305 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0008234/0.3607, allocations: 234.6 kB / 0.546 GB, free: 7.215 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.006724/0.3675, allocations: 1.815 MB / 0.5478 GB, free: 6.695 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01336/0.3808, allocations: 4.424 MB / 0.5521 GB, free: 5.562 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01358/0.3944, allocations: 15.18 MB / 0.567 GB, free: 13.9 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.008763/0.4032, allocations: 5.388 MB / 0.5722 GB, free: 10.14 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.007708/0.4109, allocations: 4.869 MB / 0.577 GB, free: 7.82 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0125/0.4235, allocations: 6.958 MB / 0.5838 GB, free: 2.922 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.004397/0.4279, allocations: 1.387 MB / 0.5851 GB, free: 1.535 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02034/0.4482, allocations: 7.756 MB / 0.5927 GB, free: 9.773 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.006457/0.4547, allocations: 4.125 MB / 0.5967 GB, free: 5.641 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.008643/0.4634, allocations: 4.64 MB / 0.6013 GB, free: 0.9844 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02282/0.4862, allocations: 15.67 MB / 0.6166 GB, free: 1.277 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.27e-06/0.4863, allocations: 4 kB / 0.6166 GB, free: 1.273 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.803e-06/0.4863, allocations: 0 / 0.6166 GB, free: 1.273 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 0.0002006/0.4865, allocations: 0 / 0.6166 GB, free: 1.273 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1653
 * Number of variables: 1653
Notification: Performance of Generate backend data structure: time 0.07161/0.5581, allocations: 17.3 MB / 0.6335 GB, free: 15.87 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5e-05/0.5582, allocations: 15.89 kB / 0.6335 GB, free: 15.86 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007024/0.5652, allocations: 1.063 MB / 0.6345 GB, free: 14.79 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04206/0.6073, allocations: 9.783 MB / 0.6441 GB, free: 4.949 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.003836/0.6112, allocations: 2.007 MB / 0.646 GB, free: 2.809 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004376/0.6156, allocations: 0.6406 MB / 0.6467 GB, free: 2.164 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.08618/0.7018, allocations: 31.52 MB / 0.6774 GB, free: 1.953 MB / 0.5137 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002854/0.7021, allocations: 33.62 kB / 0.6775 GB, free: 1.922 MB / 0.5137 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004458/0.7066, allocations: 280 kB / 0.6777 GB, free: 1.648 MB / 0.5137 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001476/0.7067, allocations: 168 kB / 0.6779 GB, free: 1.484 MB / 0.5137 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.09838/0.8051, allocations: 35.79 MB / 0.7129 GB, free: 13.65 MB / 0.5606 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.3481/1.153, allocations: 120.1 MB / 0.8301 GB, free: 126.4 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.06232/1.216, allocations: 21.73 MB / 0.8513 GB, free: 115.9 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03831/1.254, allocations: 17.06 MB / 0.868 GB, free: 102 MB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1291/1.383, allocations: 76.11 MB / 0.9423 GB, free: 17.6 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000156/1.383, allocations: 90.19 kB / 0.9424 GB, free: 17.5 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=530): time 1.731e-05/1.383, allocations: 4 kB / 0.9424 GB, free: 17.5 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=530): time 0.7125/2.096, allocations: 118.2 MB / 1.058 GB, free: 193.5 MB / 0.6231 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.848e-05/2.096, allocations: 133.3 kB / 1.058 GB, free: 193.3 MB / 0.6231 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003874/2.1, allocations: 4.302 MB / 1.062 GB, free: 189.3 MB / 0.6231 GB
Notification: Performance of collectPreVariables (initialization): time 0.003227/2.103, allocations: 109.7 kB / 1.062 GB, free: 189.2 MB / 0.6231 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001401/2.104, allocations: 3.461 MB / 1.066 GB, free: 186.3 MB / 0.6231 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004014/2.108, allocations: 2.192 MB / 1.068 GB, free: 184.2 MB / 0.6231 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006192/2.115, allocations: 3.163 MB / 1.071 GB, free: 181 MB / 0.6231 GB
Notification: Performance of setup shared object (initialization): time 7.3e-05/2.115, allocations: 349.9 kB / 1.071 GB, free: 180.7 MB / 0.6231 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.04035/2.155, allocations: 18.87 MB / 1.09 GB, free: 161.8 MB / 0.6231 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.04373/2.199, allocations: 24.43 MB / 1.114 GB, free: 134.7 MB / 0.6231 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.07825/2.277, allocations: 37.52 MB / 1.15 GB, free: 94.43 MB / 0.6231 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001568/2.277, allocations: 56 kB / 1.15 GB, free: 94.37 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=1447) (initialization): time 0.1411/2.418, allocations: 56.24 MB / 1.205 GB, free: 38 MB / 0.6231 GB
Notification: Performance of prepare postOptimizeDAE: time 9.92e-05/2.419, allocations: 95.84 kB / 1.205 GB, free: 37.91 MB / 0.6231 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001739/2.419, allocations: 192 kB / 1.205 GB, free: 37.72 MB / 0.6231 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3445/2.763, allocations: 51.88 MB / 1.256 GB, free: 203.5 MB / 0.6231 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1254/2.889, allocations: 31 MB / 1.286 GB, free: 178.5 MB / 0.6231 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08507/2.974, allocations: 35.61 MB / 1.321 GB, free: 143 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03165/3.005, allocations: 5.334 MB / 1.326 GB, free: 138.1 MB / 0.6231 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00396/3.009, allocations: 0.981 MB / 1.327 GB, free: 137.1 MB / 0.6231 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04556/3.055, allocations: 20.22 MB / 1.347 GB, free: 116.9 MB / 0.6231 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.04379/3.099, allocations: 24.36 MB / 1.371 GB, free: 89.88 MB / 0.6231 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.07761/3.177, allocations: 37.36 MB / 1.407 GB, free: 49.73 MB / 0.6231 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001223/3.177, allocations: 55.75 kB / 1.407 GB, free: 49.68 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=1447) (initialization_lambda0): time 0.6154/3.792, allocations: 93.25 MB / 1.498 GB, free: 180.2 MB / 0.6231 GB
Notification: Performance of prepare postOptimizeDAE: time 9.555e-05/3.792, allocations: 87.12 kB / 1.499 GB, free: 180.2 MB / 0.6231 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001392/3.792, allocations: 189.5 kB / 1.499 GB, free: 180.2 MB / 0.6231 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1213/3.914, allocations: 51.84 MB / 1.549 GB, free: 132.5 MB / 0.6231 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1209/4.035, allocations: 30.99 MB / 1.58 GB, free: 101.6 MB / 0.6231 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08393/4.119, allocations: 35.61 MB / 1.614 GB, free: 66.09 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03019/4.149, allocations: 4.975 MB / 1.619 GB, free: 61.46 MB / 0.6231 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003793/4.153, allocations: 0.9717 MB / 1.62 GB, free: 60.49 MB / 0.6231 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 870
 * Number of states: 0 ()
 * Number of discrete variables: 13 (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,hex.dew.phase,hex.bubble.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1243):
 * Single equations (assignments): 1242
 * 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
   {(12,193)}
Notification: Performance of prepare postOptimizeDAE: time 0.004624/4.157, allocations: 0.9851 MB / 1.621 GB, free: 59.81 MB / 0.6231 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002941/4.16, allocations: 496.8 kB / 1.622 GB, free: 59.32 MB / 0.6231 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.6058/4.766, allocations: 114.2 MB / 1.733 GB, free: 182.9 MB / 0.6231 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001409/4.766, allocations: 25.97 kB / 1.733 GB, free: 182.8 MB / 0.6231 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.622e-05/4.766, allocations: 7.75 kB / 1.733 GB, free: 182.8 MB / 0.6231 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007448/4.774, allocations: 3.21 MB / 1.736 GB, free: 181.1 MB / 0.6231 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002971/4.777, allocations: 371 kB / 1.737 GB, free: 180.9 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.03548/4.812, allocations: 6.388 MB / 1.743 GB, free: 174.5 MB / 0.6231 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.005491/4.818, allocations: 1.04 MB / 1.744 GB, free: 173.5 MB / 0.6231 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.2196/5.037, allocations: 67.31 MB / 1.81 GB, free: 106.2 MB / 0.6231 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.1002/5.137, allocations: 44.47 MB / 1.853 GB, free: 61.57 MB / 0.6231 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.03154/5.169, allocations: 15.68 MB / 1.868 GB, free: 45.84 MB / 0.6231 GB
Notification: Performance of sorting global known variables: time 0.002754/5.172, allocations: 2.523 MB / 1.871 GB, free: 43.31 MB / 0.6231 GB
Notification: Performance of Backend: time 5.61e-07/5.172, allocations: 0 / 1.871 GB, free: 43.31 MB / 0.6231 GB
Notification: Performance of simCode: created initialization part: time 0.9458/6.118, allocations: 146.5 MB / 2.014 GB, free: 136.7 MB / 0.6231 GB
Notification: Performance of SimCode: time 0.01653/6.134, allocations: 13.06 MB / 2.027 GB, free: 123.7 MB / 0.6231 GB
Notification: Performance of Templates: time 0.9665/7.101, allocations: 0.504 GB / 2.531 GB, free: 66.82 MB / 0.6231 GB
make -j1 -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.makefile
(rm -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.pipe ; mkfifo ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.pipe ; head -c 1048576 < ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.pipe >> ../files/ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.sim & ./ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestFlow1Dfem2ph.pipe 2>&1)