Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001474/0.001474, allocations: 122.1 kB / 19.44 MB, free: 2.398 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0016/0.0016, allocations: 197.8 kB / 22.67 MB, free: 5.113 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.552/1.552, allocations: 207.6 MB / 233.4 MB, free: 11 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 3.1.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 3.1.0-master/package.mo): time 0.3291/0.3291, allocations: 49.52 MB / 335 MB, free: 4.508 MB / 270.1 MB
"
[Timeout remaining time 179]
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: "" <> buildModelFMU(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J,fileNamePrefix="ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFEM_J",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J,fileNamePrefix="ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFEM_J",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"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.002231/0.002231, allocations: 75.88 kB / 474.7 MB, free: 13.44 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.125/0.1272, allocations: 62.33 MB / 0.5244 GB, free: 14.92 MB / 414.1 MB
Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J): time 0.2762/0.4034, allocations: 31 MB / 0.5547 GB, free: 7.102 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01821/0.4216, allocations: 14.95 MB / 0.5693 GB, free: 12.66 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005761/0.4222, allocations: 10.28 kB / 0.5693 GB, free: 12.66 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007924/0.423, allocations: 195.5 kB / 0.5695 GB, free: 12.55 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01647/0.4395, allocations: 4.73 MB / 0.5741 GB, free: 10.46 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004719/0.4442, allocations: 1.309 MB / 0.5754 GB, free: 9.461 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.006373/0.4505, allocations: 5.345 MB / 0.5806 GB, free: 6.426 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003556/0.4541, allocations: 1.614 MB / 0.5822 GB, free: 5.316 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003678/0.4578, allocations: 1.543 MB / 0.5837 GB, free: 4.625 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005029/0.4628, allocations: 2.548 MB / 0.5862 GB, free: 3.18 MB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001888/0.4647, allocations: 0.5401 MB / 0.5867 GB, free: 3.18 MB / 430.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01726/0.482, allocations: 7.692 MB / 0.5942 GB, free: 15.32 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.003386/0.4853, allocations: 1.964 MB / 0.5961 GB, free: 13.35 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004887/0.4902, allocations: 2.404 MB / 0.5985 GB, free: 10.93 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02111/0.5113, allocations: 9.654 MB / 0.6079 GB, free: 1.254 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.981e-06/0.5114, allocations: 0 / 0.6079 GB, free: 1.254 MB / 446.1 MB
Notification: Performance of FrontEnd: time 1.693e-06/0.5114, allocations: 0 / 0.6079 GB, free: 1.254 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.0001541/0.5115, allocations: 0 / 0.6079 GB, free: 1.254 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: 1155
 * Number of variables: 1155
Notification: Performance of Generate backend data structure: time 0.03246/0.544, allocations: 9.219 MB / 0.6169 GB, free: 7.953 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.539e-05/0.544, allocations: 15.89 kB / 0.6169 GB, free: 7.938 MB / 462.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001387/0.5454, allocations: 0.6405 MB / 0.6176 GB, free: 7.285 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004059/0.5495, allocations: 0.7129 MB / 0.6183 GB, free: 6.57 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.009186/0.5587, allocations: 2.482 MB / 0.6207 GB, free: 4.039 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003674/0.559, allocations: 333.3 kB / 0.621 GB, free: 3.711 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001677/0.5607, allocations: 428.4 kB / 0.6214 GB, free: 3.293 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02472/0.5854, allocations: 10.51 MB / 0.6317 GB, free: 8.711 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.648e-05/0.5855, allocations: 0 / 0.6317 GB, free: 8.711 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0009169/0.5864, allocations: 180 kB / 0.6318 GB, free: 8.535 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002157/0.5866, allocations: 185 kB / 0.632 GB, free: 8.352 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03636/0.623, allocations: 12.3 MB / 0.644 GB, free: 12.03 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.04072/0.6637, allocations: 21.41 MB / 0.6649 GB, free: 5.121 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01085/0.6746, allocations: 3.881 MB / 0.6687 GB, free: 1.23 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003072/0.6776, allocations: 1.643 MB / 0.6703 GB, free: 15.58 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1474/0.8251, allocations: 64.28 MB / 0.7331 GB, free: 7.66 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.02e-05/0.8252, allocations: 60.56 kB / 0.7332 GB, free: 7.59 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=218): time 5.981e-06/0.8252, allocations: 0 / 0.7332 GB, free: 7.59 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=218): time 0.09466/0.9198, allocations: 19.26 MB / 0.752 GB, free: 4.273 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.808e-05/0.9199, allocations: 77.34 kB / 0.752 GB, free: 4.188 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005734/0.9257, allocations: 3.443 MB / 0.7554 GB, free: 0.7344 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007935/0.9264, allocations: 65.7 kB / 0.7555 GB, free: 0.6641 MB / 0.5919 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002587/0.929, allocations: 2.811 MB / 0.7582 GB, free: 13.82 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001737/0.9308, allocations: 0.9189 MB / 0.7591 GB, free: 12.89 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004548/0.9353, allocations: 1.715 MB / 0.7608 GB, free: 11.17 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 0.0002199/0.9355, allocations: 334 kB / 0.7611 GB, free: 10.84 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007092/0.9426, allocations: 3.403 MB / 0.7644 GB, free: 7.43 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2301/1.173, allocations: 7.728 MB / 0.772 GB, free: 204.8 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.07451/1.247, allocations: 24.52 MB / 0.7959 GB, free: 195.2 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002289/1.247, allocations: 44.03 kB / 0.796 GB, free: 195.2 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=948) (initialization): time 0.02431/1.272, allocations: 12.13 MB / 0.8078 GB, free: 190.6 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002208/1.272, allocations: 72.41 kB / 0.8079 GB, free: 190.6 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002771/1.272, allocations: 153.7 kB / 0.808 GB, free: 190.6 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02986/1.302, allocations: 6.793 MB / 0.8147 GB, free: 187.5 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005425/1.308, allocations: 1.79 MB / 0.8164 GB, free: 186.9 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0122/1.32, allocations: 5.826 MB / 0.8221 GB, free: 181.8 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007518/1.327, allocations: 1.034 MB / 0.8231 GB, free: 181 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001568/1.329, allocations: 0.5574 MB / 0.8237 GB, free: 180.5 MB / 0.6075 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.007351/1.336, allocations: 4.459 MB / 0.828 GB, free: 176 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0069/1.343, allocations: 7.675 MB / 0.8355 GB, free: 166.2 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.05076/1.394, allocations: 22.65 MB / 0.8576 GB, free: 141.4 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001307/1.394, allocations: 44 kB / 0.8577 GB, free: 141.4 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=948) (initialization_lambda0): time 0.03502/1.429, allocations: 14.85 MB / 0.8722 GB, free: 126.5 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001812/1.429, allocations: 75.91 kB / 0.8722 GB, free: 126.4 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002401/1.429, allocations: 152.8 kB / 0.8724 GB, free: 126.3 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01994/1.449, allocations: 5.486 MB / 0.8777 GB, free: 120.8 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005378/1.455, allocations: 1.842 MB / 0.8795 GB, free: 118.9 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04608/1.501, allocations: 27.08 MB / 0.906 GB, free: 91.82 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006108/1.507, allocations: 0.7496 MB / 0.9067 GB, free: 91.2 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001873/1.509, allocations: 0.5545 MB / 0.9073 GB, free: 90.64 MB / 0.6075 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: 696
 * Number of states: 0 ()
 * Number of discrete variables: 11 (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)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (834):
 * Single equations (assignments): 833
 * 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.003321/1.512, allocations: 0.8305 MB / 0.9081 GB, free: 89.91 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00139/1.514, allocations: 325.9 kB / 0.9084 GB, free: 89.59 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02534/1.539, allocations: 25.39 MB / 0.9332 GB, free: 64.18 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.199e-05/1.539, allocations: 59.94 kB / 0.9332 GB, free: 64.12 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.121e-06/1.539, allocations: 0 / 0.9332 GB, free: 64.12 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.881e-05/1.539, allocations: 15.89 kB / 0.9332 GB, free: 64.11 MB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00912/1.548, allocations: 11.66 MB / 0.9446 GB, free: 51.87 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.534e-05/1.548, allocations: 0 / 0.9446 GB, free: 51.87 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001818/1.55, allocations: 299.5 kB / 0.9449 GB, free: 51.57 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.02873/1.579, allocations: 7.005 MB / 0.9518 GB, free: 44.56 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001219/1.58, allocations: 111.9 kB / 0.9519 GB, free: 44.45 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01195/1.592, allocations: 5.758 MB / 0.9575 GB, free: 38.66 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.479e-06/1.592, allocations: 3.375 kB / 0.9575 GB, free: 38.66 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01682/1.609, allocations: 9.442 MB / 0.9667 GB, free: 29.18 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002863/1.611, allocations: 0.8293 MB / 0.9675 GB, free: 28.33 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001432/1.613, allocations: 75.97 kB / 0.9676 GB, free: 28.25 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00333/1.616, allocations: 148.6 kB / 0.9677 GB, free: 28.11 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001303/1.618, allocations: 145.7 kB / 0.9679 GB, free: 27.96 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001048/1.619, allocations: 91.91 kB / 0.968 GB, free: 27.88 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.003834/1.622, allocations: 2.003 MB / 0.9699 GB, free: 25.88 MB / 0.6075 GB
Notification: Performance of sort global known variables: time 9.72e-07/1.622, allocations: 0 / 0.9699 GB, free: 25.88 MB / 0.6075 GB
Notification: Performance of remove unused functions: time 0.01454/1.637, allocations: 3.133 MB / 0.973 GB, free: 22.74 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.02155/1.659, allocations: 11.16 MB / 0.9839 GB, free: 11.63 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.03029/1.689, allocations: 14.2 MB / 0.9977 GB, free: 13.48 MB / 0.6231 GB
Notification: Performance of simCode: created event and clocks part: time 1.041e-05/1.689, allocations: 4 kB / 0.9977 GB, free: 13.47 MB / 0.6231 GB
Notification: Performance of simCode: created simulation system equations: time 0.2458/1.935, allocations: 2.975 MB / 1.001 GB, free: 210.6 MB / 0.6231 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004064/1.939, allocations: 0.6069 MB / 1.001 GB, free: 210.6 MB / 0.6231 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.09031/2.029, allocations: 52.56 MB / 1.053 GB, free: 180.8 MB / 0.6231 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003142/2.032, allocations: 2.439 MB / 1.055 GB, free: 179.8 MB / 0.6231 GB
Notification: Performance of simCode: alias equations: time 0.01715/2.049, allocations: 18.16 MB / 1.073 GB, free: 163.4 MB / 0.6231 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00258/2.052, allocations: 1.608 MB / 1.074 GB, free: 161.7 MB / 0.6231 GB
Notification: Performance of SimCode: time 1.493e-06/2.052, allocations: 3.938 kB / 1.074 GB, free: 161.7 MB / 0.6231 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.5711/2.623, allocations: 164 MB / 1.234 GB, free: 212.6 MB / 0.6387 GB
Notification: Performance of buildModelFMU: Generate platform static: time 26.21/28.83, allocations: 9.484 kB / 1.234 GB, free: 212.6 MB / 0.6387 GB
"
[Timeout remaining time 631]
(rm -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe ; mkfifo ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe ; head -c 1048576 < ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe >> ../files/ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFEM_J_fmu --startTime=-10 --stopTime=10 --stepSize=0.008 --timeout=50 --tolerance=1e-07 ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFEM_J.fmu > ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFEM_J.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 31.995216169161722]
Failed to read output from testmodel.py, exit status != 0:
29.014080284861848 29.036707938 28.520631426
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe6ff236020>