Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001462/0.001462, allocations: 79.88 kB / 20.53 MB, free: 1.355 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001519/0.001519, allocations: 161.7 kB / 23.78 MB, free: 4.531 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.427/1.427, allocations: 177.2 MB / 204.2 MB, free: 9.285 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 4.0.0-dev/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 4.0.0-dev/package.mo): time 0.1389/0.1389, allocations: 19.7 MB / 280.3 MB, free: 13.06 MB / 270.1 MB
"
[Timeout remaining time 180]
Using package ThermoPower with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 4.0.0-dev/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K")
translateModel(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K") [Timeout 660]
"Notification: ThermoPower requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002214/0.002214, allocations: 63.91 kB / 416.9 MB, free: 0.6641 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2793/0.2815, allocations: 60.46 MB / 477.4 MB, free: 15.54 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K): time 0.03636/0.3179, allocations: 30.37 MB / 0.4958 GB, free: 3.805 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01764/0.3355, allocations: 12.78 MB / 0.5083 GB, free: 6.98 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004935/0.336, allocations: 15.81 kB / 0.5083 GB, free: 6.965 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0006881/0.3367, allocations: 218.6 kB / 0.5085 GB, free: 6.75 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0127/0.3494, allocations: 4.765 MB / 0.5132 GB, free: 1.984 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003382/0.3528, allocations: 1.187 MB / 0.5144 GB, free: 0.793 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.00608/0.3589, allocations: 5.575 MB / 0.5198 GB, free: 11.2 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002501/0.3614, allocations: 1.73 MB / 0.5215 GB, free: 9.449 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003168/0.3645, allocations: 2.348 MB / 0.5238 GB, free: 7.098 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004228/0.3688, allocations: 2.678 MB / 0.5264 GB, free: 4.414 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001285/0.3701, allocations: 0.5781 MB / 0.527 GB, free: 3.836 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01466/0.3847, allocations: 7.388 MB / 0.5342 GB, free: 12.44 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002382/0.3871, allocations: 2.062 MB / 0.5362 GB, free: 10.38 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003416/0.3905, allocations: 2.253 MB / 0.5384 GB, free: 8.113 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01681/0.4073, allocations: 10.2 MB / 0.5484 GB, free: 13.88 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.701e-06/0.4073, allocations: 0 / 0.5484 GB, free: 13.88 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.583e-06/0.4073, allocations: 0 / 0.5484 GB, free: 13.88 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 0.0001328/0.4075, allocations: 0 / 0.5484 GB, free: 13.88 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: 1242
 * Number of variables: 1242
Notification: Performance of Generate backend data structure: time 0.02895/0.4364, allocations: 8.685 MB / 0.5568 GB, free: 5.137 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.623e-05/0.4365, allocations: 12.03 kB / 0.5568 GB, free: 5.125 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004108/0.4406, allocations: 0.7517 MB / 0.5576 GB, free: 4.371 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007546/0.4481, allocations: 2.557 MB / 0.5601 GB, free: 1.777 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000558/0.4487, allocations: 413.3 kB / 0.5605 GB, free: 1.359 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002039/0.4507, allocations: 464.1 kB / 0.5609 GB, free: 0.9062 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02761/0.4783, allocations: 11.16 MB / 0.5718 GB, free: 5.621 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 9.527e-05/0.4784, allocations: 3.984 kB / 0.5718 GB, free: 5.617 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007943/0.4792, allocations: 192 kB / 0.572 GB, free: 5.43 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002329/0.4794, allocations: 221.7 kB / 0.5722 GB, free: 5.211 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03704/0.5165, allocations: 13.05 MB / 0.5849 GB, free: 8.141 MB / 494.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.03669/0.5532, allocations: 15.39 MB / 0.6 GB, free: 8.352 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01166/0.5648, allocations: 3.976 MB / 0.6039 GB, free: 4.363 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003521/0.5683, allocations: 1.741 MB / 0.6056 GB, free: 2.621 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.3592/0.9276, allocations: 35.11 MB / 0.6399 GB, free: 155.6 MB / 0.5294 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.373e-05/0.9277, allocations: 58 kB / 0.6399 GB, free: 155.5 MB / 0.5294 GB
Notification: Performance of pre-optimization done (n=232): time 5.02e-06/0.9277, allocations: 3.938 kB / 0.6399 GB, free: 155.5 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=232): time 0.1335/1.061, allocations: 30.11 MB / 0.6693 GB, free: 137.4 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.877e-05/1.061, allocations: 73.41 kB / 0.6694 GB, free: 137.4 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003338/1.065, allocations: 3.71 MB / 0.673 GB, free: 133.9 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007655/1.065, allocations: 61.7 kB / 0.6731 GB, free: 133.8 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001134/1.066, allocations: 2.899 MB / 0.6759 GB, free: 131.3 MB / 0.5294 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009677/1.067, allocations: 0.9725 MB / 0.6768 GB, free: 130.3 MB / 0.5294 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001783/1.069, allocations: 1.707 MB / 0.6785 GB, free: 128.6 MB / 0.5294 GB
Notification: Performance of setup shared object (initialization): time 7.673e-05/1.069, allocations: 345.9 kB / 0.6788 GB, free: 128.3 MB / 0.5294 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004269/1.074, allocations: 3.47 MB / 0.6822 GB, free: 124.8 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005748/1.079, allocations: 7.75 MB / 0.6898 GB, free: 115 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.06768/1.147, allocations: 25.39 MB / 0.7146 GB, free: 87.38 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001661/1.147, allocations: 44 kB / 0.7146 GB, free: 87.34 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=950) (initialization): time 0.01901/1.166, allocations: 12.41 MB / 0.7268 GB, free: 74.88 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 8.326e-05/1.166, allocations: 71.98 kB / 0.7268 GB, free: 74.8 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001577/1.166, allocations: 152 kB / 0.727 GB, free: 74.66 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03266/1.199, allocations: 7.655 MB / 0.7345 GB, free: 67 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00462/1.204, allocations: 1.749 MB / 0.7362 GB, free: 65.25 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009465/1.213, allocations: 6.391 MB / 0.7424 GB, free: 58.83 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005357/1.218, allocations: 1.047 MB / 0.7434 GB, free: 57.78 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001026/1.22, allocations: 0.5544 MB / 0.744 GB, free: 57.22 MB / 0.5294 GB
Warning: Assuming fixed start value for the following 12 variables:
         pipe1.p:VARIABLE(min = 611.657 max = 1e8 start = pipe1.pstart unit = \"Pa\" fixed = true nominal = 1e6 )  \"Fluid pressure\" type: Real
         pipe1.h[1]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[1] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[2]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[2] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[3]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[3] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[4]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[4] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[5]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[5] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[6]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[6] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[7]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[7] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[8]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[8] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[9]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[9] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[10]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[10] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[11]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[11] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.005851/1.225, allocations: 4.605 MB / 0.7485 GB, free: 52.62 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.005689/1.231, allocations: 7.74 MB / 0.756 GB, free: 42.74 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.05533/1.286, allocations: 23.72 MB / 0.7792 GB, free: 16.86 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001336/1.287, allocations: 44 kB / 0.7792 GB, free: 16.82 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=950) (initialization_lambda0): time 0.03368/1.32, allocations: 15.46 MB / 0.7943 GB, free: 1.344 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 8.705e-05/1.32, allocations: 72 kB / 0.7944 GB, free: 1.273 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001653/1.32, allocations: 152 kB / 0.7945 GB, free: 1.125 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02547/1.346, allocations: 6.218 MB / 0.8006 GB, free: 10.92 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005933/1.352, allocations: 1.805 MB / 0.8024 GB, free: 9.109 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05924/1.411, allocations: 29.43 MB / 0.8311 GB, free: 11.62 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00567/1.417, allocations: 0.7615 MB / 0.8319 GB, free: 10.85 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001189/1.418, allocations: 0.5584 MB / 0.8324 GB, free: 10.29 MB / 0.5762 GB
Warning: Assuming fixed start value for the following 12 variables:
         pipe1.p:VARIABLE(min = 611.657 max = 1e8 start = pipe1.pstart unit = \"Pa\" fixed = true nominal = 1e6 )  \"Fluid pressure\" type: Real
         pipe1.h[1]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[1] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[2]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[2] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[3]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[3] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[4]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[4] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[5]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[5] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[6]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[6] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[7]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[7] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[8]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[8] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[9]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[9] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[10]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[10] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
         pipe1.h[11]:VARIABLE(min = -1e10 max = 1e10 start = pipe1.hstart[11] unit = \"J/kg\" fixed = true nominal = 5e5 )  \"Fluid specific enthalpy\" type: Real [11]
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 684
 * Number of states: 0 ()
 * Number of discrete variables: 12 (pipe1.fluidState[11].phase,pipe1.fluidState[10].phase,pipe1.fluidState[9].phase,pipe1.fluidState[8].phase,pipe1.fluidState[7].phase,pipe1.fluidState[6].phase,pipe1.fluidState[5].phase,pipe1.fluidState[4].phase,pipe1.fluidState[3].phase,pipe1.fluidState[2].phase,pipe1.fluidState[1].phase,pipe1.friction.NoFriction)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (803):
 * Single equations (assignments): 802
 * 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,135)}
Notification: Performance of prepare postOptimizeDAE: time 0.001926/1.42, allocations: 0.8175 MB / 0.8332 GB, free: 9.48 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009698/1.421, allocations: 325.8 kB / 0.8335 GB, free: 9.16 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03418/1.455, allocations: 26.85 MB / 0.8597 GB, free: 14.27 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.163e-05/1.455, allocations: 67.88 kB / 0.8598 GB, free: 14.2 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.717e-06/1.455, allocations: 0 / 0.8598 GB, free: 14.2 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.778e-05/1.455, allocations: 11.95 kB / 0.8598 GB, free: 14.19 MB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01425/1.469, allocations: 11.62 MB / 0.8712 GB, free: 1.996 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.115e-05/1.469, allocations: 4 kB / 0.8712 GB, free: 1.992 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001933/1.471, allocations: 263.5 kB / 0.8714 GB, free: 1.734 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.2559/1.727, allocations: 7.996 MB / 0.8792 GB, free: 211.2 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007002/1.728, allocations: 112.8 kB / 0.8793 GB, free: 211.2 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.009175/1.737, allocations: 6.31 MB / 0.8855 GB, free: 210.4 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.074e-06/1.737, allocations: 0 / 0.8855 GB, free: 210.4 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01296/1.75, allocations: 9.987 MB / 0.8952 GB, free: 206.3 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002253/1.752, allocations: 0.7822 MB / 0.896 GB, free: 206 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006036/1.753, allocations: 85.58 kB / 0.8961 GB, free: 206 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002546/1.756, allocations: 163 kB / 0.8962 GB, free: 205.9 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005547/1.756, allocations: 166.6 kB / 0.8964 GB, free: 205.9 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002351/1.756, allocations: 91.67 kB / 0.8965 GB, free: 205.9 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.002317/1.759, allocations: 2.009 MB / 0.8984 GB, free: 205.3 MB / 0.6075 GB
Notification: Performance of sort global known variables: time 8e-08/1.759, allocations: 0 / 0.8984 GB, free: 205.3 MB / 0.6075 GB
Notification: Performance of remove unused functions: time 0.01237/1.771, allocations: 3.332 MB / 0.9017 GB, free: 203.9 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 12 (pipe1.p,pipe1.h[1],pipe1.h[2],pipe1.h[3],pipe1.h[4],pipe1.h[5],pipe1.h[6],pipe1.h[7],pipe1.h[8],pipe1.h[9],pipe1.h[10],pipe1.h[11])
 * Number of discrete variables: 22 ($cse22.phase,$cse22.region,$cse23.phase,$cse23.region,$cse24.phase,$cse24.region,$cse25.phase,$cse25.region,$cse26.phase,$cse26.region,$cse27.phase,$cse27.region,$cse28.phase,$cse28.region,$cse29.phase,$cse29.region,$cse30.phase,$cse30.region,$cse31.phase,$cse31.region,$cse32.phase,$cse32.region)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (97):
 * Single equations (assignments): 85
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 11
 * 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
   {(14,156)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.004106/1.775, allocations: 1.257 MB / 0.9029 GB, free: 202.9 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.02363/1.799, allocations: 14.32 MB / 0.9169 GB, free: 188.7 MB / 0.6075 GB
Notification: Performance of simCode: created event and clocks part: time 5.45e-06/1.799, allocations: 4.75 kB / 0.9169 GB, free: 188.7 MB / 0.6075 GB
Notification: Performance of simCode: created simulation system equations: time 0.006265/1.805, allocations: 2.967 MB / 0.9198 GB, free: 185.7 MB / 0.6075 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002513/1.808, allocations: 0.6024 MB / 0.9204 GB, free: 185.2 MB / 0.6075 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01227/1.82, allocations: 10.6 MB / 0.9308 GB, free: 174.6 MB / 0.6075 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001613/1.821, allocations: 2.047 MB / 0.9328 GB, free: 172.5 MB / 0.6075 GB
Notification: Performance of simCode: alias equations: time 0.01653/1.838, allocations: 17.95 MB / 0.9503 GB, free: 154.5 MB / 0.6075 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001238/1.839, allocations: 364.2 kB / 0.9506 GB, free: 154.2 MB / 0.6075 GB
Notification: Performance of SimCode: time 1.051e-06/1.839, allocations: 4 kB / 0.9506 GB, free: 154.2 MB / 0.6075 GB
Notification: Performance of Templates: time 0.1367/1.976, allocations: 127.6 MB / 1.075 GB, free: 26.52 MB / 0.6075 GB
"
[Timeout remaining time 658]
make -j1 -f ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.makefile [Timeout 660]
(rm -f ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.pipe ; mkfifo ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.pipe ; head -c 1048576 < ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.pipe >> ../files/ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.sim & ./ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_K.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 12.164218939840794]
Failed to read output from testmodel.py, exit status != 0:
1.9850330706685781 1.993730236 1.583945606
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f62f6bc91e0>