Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.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.001601/0.001601, allocations: 82.88 kB / 21.28 MB, free: 0.5195 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.00194/0.00194, allocations: 159.6 kB / 24.53 MB, free: 3.832 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 2.126/2.126, allocations: 177.2 MB / 204.9 MB, free: 9.262 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.2083/0.2083, allocations: 19.71 MB / 281 MB, free: 13.04 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_J,tolerance=1e-07,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J")
translateModel(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J,tolerance=1e-07,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J") [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.003479/0.003479, allocations: 63.91 kB / 417.7 MB, free: 0.6523 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.451/0.4544, allocations: 60.45 MB / 478.1 MB, free: 15.52 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J): time 0.06679/0.5212, allocations: 30.29 MB / 0.4965 GB, free: 3.863 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03316/0.5544, allocations: 12.75 MB / 0.5089 GB, free: 7.07 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008055/0.5552, allocations: 11.88 kB / 0.5089 GB, free: 7.059 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0009247/0.5561, allocations: 218.6 kB / 0.5092 GB, free: 6.844 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01709/0.5732, allocations: 4.742 MB / 0.5138 GB, free: 2.102 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004152/0.5774, allocations: 1.191 MB / 0.5149 GB, free: 0.9062 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007836/0.5852, allocations: 5.466 MB / 0.5203 GB, free: 11.42 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003173/0.5884, allocations: 1.634 MB / 0.5219 GB, free: 9.773 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004162/0.5925, allocations: 2.274 MB / 0.5241 GB, free: 7.496 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00516/0.5977, allocations: 2.623 MB / 0.5267 GB, free: 4.867 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001385/0.5991, allocations: 0.5625 MB / 0.5272 GB, free: 4.305 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02289/0.622, allocations: 7.391 MB / 0.5344 GB, free: 12.91 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00322/0.6252, allocations: 2.003 MB / 0.5364 GB, free: 10.9 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004309/0.6295, allocations: 2.202 MB / 0.5385 GB, free: 8.688 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.0205/0.65, allocations: 10.08 MB / 0.5484 GB, free: 14.57 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.464e-06/0.65, allocations: 0 / 0.5484 GB, free: 14.57 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.963e-06/0.65, allocations: 0 / 0.5484 GB, free: 14.57 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 0.0001896/0.6502, allocations: 0 / 0.5484 GB, free: 14.57 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: 1221
 * Number of variables: 1221
Notification: Performance of Generate backend data structure: time 0.03794/0.6881, allocations: 8.567 MB / 0.5567 GB, free: 5.945 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.062e-05/0.6882, allocations: 8.031 kB / 0.5568 GB, free: 5.938 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005278/0.6935, allocations: 0.7401 MB / 0.5575 GB, free: 5.195 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.009185/0.7027, allocations: 2.51 MB / 0.5599 GB, free: 2.648 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005967/0.7033, allocations: 413.2 kB / 0.5603 GB, free: 2.23 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001887/0.7051, allocations: 456.1 kB / 0.5608 GB, free: 1.785 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03346/0.7386, allocations: 11.06 MB / 0.5716 GB, free: 6.598 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 9.654e-05/0.7387, allocations: 0 / 0.5716 GB, free: 6.598 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000902/0.7396, allocations: 184 kB / 0.5717 GB, free: 6.418 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002898/0.7399, allocations: 221.5 kB / 0.5719 GB, free: 6.199 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04992/0.7898, allocations: 12.96 MB / 0.5846 GB, free: 9.215 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.04755/0.8374, allocations: 16.95 MB / 0.6012 GB, free: 7.852 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01489/0.8522, allocations: 3.866 MB / 0.6049 GB, free: 3.977 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004235/0.8565, allocations: 1.647 MB / 0.6065 GB, free: 2.328 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.4748/1.331, allocations: 35.12 MB / 0.6408 GB, free: 155.9 MB / 0.5294 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.739e-05/1.331, allocations: 57.94 kB / 0.6409 GB, free: 155.9 MB / 0.5294 GB
Notification: Performance of pre-optimization done (n=218): time 6.472e-06/1.331, allocations: 0 / 0.6409 GB, free: 155.9 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=218): time 0.08384/1.415, allocations: 19.23 MB / 0.6597 GB, free: 148.2 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.626e-05/1.415, allocations: 80.78 kB / 0.6597 GB, free: 148.1 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004109/1.419, allocations: 3.766 MB / 0.6634 GB, free: 144.6 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005955/1.42, allocations: 61.7 kB / 0.6635 GB, free: 144.6 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001565/1.422, allocations: 2.925 MB / 0.6663 GB, free: 142 MB / 0.5294 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009784/1.423, allocations: 0.9239 MB / 0.6672 GB, free: 141.1 MB / 0.5294 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001879/1.424, allocations: 1.73 MB / 0.6689 GB, free: 139.4 MB / 0.5294 GB
Notification: Performance of setup shared object (initialization): time 9.222e-05/1.424, allocations: 337.8 kB / 0.6693 GB, free: 139 MB / 0.5294 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004429/1.429, allocations: 3.427 MB / 0.6726 GB, free: 135.6 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006768/1.436, allocations: 7.84 MB / 0.6803 GB, free: 125.6 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.06524/1.501, allocations: 24.56 MB / 0.7042 GB, free: 98.84 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001561/1.501, allocations: 44 kB / 0.7043 GB, free: 98.8 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=959) (initialization): time 0.01891/1.52, allocations: 12.23 MB / 0.7162 GB, free: 86.55 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 9.04e-05/1.52, allocations: 72 kB / 0.7163 GB, free: 86.48 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001661/1.52, allocations: 160 kB / 0.7165 GB, free: 86.32 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02972/1.55, allocations: 6.777 MB / 0.7231 GB, free: 79.55 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005261/1.555, allocations: 1.809 MB / 0.7248 GB, free: 77.74 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009576/1.565, allocations: 5.847 MB / 0.7305 GB, free: 71.86 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005417/1.57, allocations: 1.054 MB / 0.7316 GB, free: 70.8 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001039/1.571, allocations: 0.5699 MB / 0.7321 GB, free: 70.24 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.005782/1.577, allocations: 4.537 MB / 0.7366 GB, free: 65.71 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.005731/1.583, allocations: 7.828 MB / 0.7442 GB, free: 55.67 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.05183/1.635, allocations: 22.86 MB / 0.7665 GB, free: 30.58 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001543/1.635, allocations: 44.77 kB / 0.7666 GB, free: 30.54 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=959) (initialization_lambda0): time 0.0359/1.671, allocations: 14.97 MB / 0.7812 GB, free: 15.55 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 7.921e-05/1.671, allocations: 79.94 kB / 0.7813 GB, free: 15.48 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001153/1.671, allocations: 156 kB / 0.7814 GB, free: 15.32 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02039/1.691, allocations: 5.475 MB / 0.7868 GB, free: 9.844 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006046/1.697, allocations: 1.872 MB / 0.7886 GB, free: 7.969 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0504/1.748, allocations: 26.54 MB / 0.8145 GB, free: 13.38 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006821/1.755, allocations: 0.7537 MB / 0.8152 GB, free: 12.62 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001405/1.756, allocations: 0.5701 MB / 0.8158 GB, free: 12.05 MB / 0.5606 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: 708
 * 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 (845):
 * Single equations (assignments): 844
 * 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,102)}
Notification: Performance of prepare postOptimizeDAE: time 0.002321/1.758, allocations: 0.8322 MB / 0.8166 GB, free: 11.22 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001273/1.76, allocations: 321.9 kB / 0.8169 GB, free: 10.9 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0344/1.794, allocations: 26.85 MB / 0.8431 GB, free: 16 kB / 0.5762 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.083e-05/1.794, allocations: 55.94 kB / 0.8432 GB, free: 15.96 MB / 0.5919 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.011e-06/1.794, allocations: 1.875 kB / 0.8432 GB, free: 15.96 MB / 0.5919 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.585e-05/1.794, allocations: 11.95 kB / 0.8432 GB, free: 15.95 MB / 0.5919 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01577/1.81, allocations: 11.5 MB / 0.8544 GB, free: 3.867 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.959e-05/1.81, allocations: 7.938 kB / 0.8544 GB, free: 3.859 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002285/1.812, allocations: 311.3 kB / 0.8547 GB, free: 3.555 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03223/1.844, allocations: 6.994 MB / 0.8616 GB, free: 12.56 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001118/1.845, allocations: 111.9 kB / 0.8617 GB, free: 12.45 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01248/1.858, allocations: 5.771 MB / 0.8673 GB, free: 6.656 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.108e-06/1.858, allocations: 0 / 0.8673 GB, free: 6.656 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.3582/2.216, allocations: 9.534 MB / 0.8766 GB, free: 211.3 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002243/2.218, allocations: 0.7471 MB / 0.8774 GB, free: 211.3 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006575/2.219, allocations: 84.66 kB / 0.8774 GB, free: 211.3 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002358/2.221, allocations: 149.4 kB / 0.8776 GB, free: 211.3 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004697/2.222, allocations: 158.9 kB / 0.8777 GB, free: 211.3 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002362/2.222, allocations: 89.34 kB / 0.8778 GB, free: 211.3 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.002837/2.225, allocations: 2.037 MB / 0.8798 GB, free: 211 MB / 0.6075 GB
Notification: Performance of sort global known variables: time 1.11e-07/2.225, allocations: 0 / 0.8798 GB, free: 211 MB / 0.6075 GB
Notification: Performance of remove unused functions: time 0.01374/2.239, allocations: 3.264 MB / 0.883 GB, free: 210.6 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 ($cse21.phase,$cse21.region,$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)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (116):
 * Single equations (assignments): 104
 * 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
   {(13,124)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00469/2.243, allocations: 1.256 MB / 0.8842 GB, free: 210.5 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.02672/2.27, allocations: 14.32 MB / 0.8982 GB, free: 206.1 MB / 0.6075 GB
Notification: Performance of simCode: created event and clocks part: time 6.833e-06/2.27, allocations: 0 / 0.8982 GB, free: 206.1 MB / 0.6075 GB
Notification: Performance of simCode: created simulation system equations: time 0.006819/2.277, allocations: 3.005 MB / 0.9011 GB, free: 203.9 MB / 0.6075 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002793/2.28, allocations: 0.607 MB / 0.9017 GB, free: 203.4 MB / 0.6075 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01324/2.293, allocations: 10.34 MB / 0.9118 GB, free: 194.2 MB / 0.6075 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00158/2.295, allocations: 1.998 MB / 0.9138 GB, free: 192.3 MB / 0.6075 GB
Notification: Performance of simCode: alias equations: time 0.01698/2.312, allocations: 18.23 MB / 0.9316 GB, free: 174.1 MB / 0.6075 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001143/2.313, allocations: 380.2 kB / 0.9319 GB, free: 173.7 MB / 0.6075 GB
Notification: Performance of SimCode: time 1.713e-06/2.313, allocations: 0 / 0.9319 GB, free: 173.7 MB / 0.6075 GB
Notification: Performance of Templates: time 0.145/2.458, allocations: 122.2 MB / 1.051 GB, free: 51.56 MB / 0.6075 GB
"
[Timeout remaining time 658]
make -j1 -f ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.makefile [Timeout 660]
(rm -f ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe ; mkfifo ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe ; head -c 1048576 < ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe >> ../files/ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.sim & ./ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J  -abortSlowSimulation -alarm=480 -s cvode -lv LOG_STATS > ThermoPower_4.0.0-dev_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 14.622044206946157]
Failed to read output from testmodel.py, exit status != 0:
2.4808071759762242 2.479114192 1.8263240649999999
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f8a1b515210>