Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C.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.001304/0.001304, allocations: 113.1 kB / 20.43 MB, free: 1.457 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.001472/0.001472, allocations: 216.4 kB / 23.75 MB, free: 4.668 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.446/1.446, allocations: 207.6 MB / 234.5 MB, free: 9.988 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower master/package.mo): time 0.2908/0.2908, allocations: 49.56 MB / 336.3 MB, free: 4.191 MB / 270.1 MB
"
[Timeout remaining time 179]
Using package ThermoPower with version 3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoPower 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.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: "" <> buildModelFMU(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C,fileNamePrefix="ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFV2ph_C",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C,fileNamePrefix="ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFV2ph_C",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Modelica requested package Complex of version 3.2.3. Complex 4.1.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.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002258/0.002258, allocations: 75.89 kB / 476.4 MB, free: 12.91 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1136/0.1159, allocations: 62.42 MB / 0.5262 GB, free: 14.3 MB / 414.1 MB
Notification: Performance of NFInst.instantiate(ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C): time 0.256/0.3719, allocations: 31.52 MB / 0.5569 GB, free: 6.031 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01511/0.387, allocations: 12.51 MB / 0.5691 GB, free: 13.3 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000537/0.3876, allocations: 18.28 kB / 0.5692 GB, free: 13.29 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007277/0.3883, allocations: 222.1 kB / 0.5694 GB, free: 13.17 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001232/0.3895, allocations: 0.4915 MB / 0.5699 GB, free: 12.88 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01707/0.4066, allocations: 5.398 MB / 0.5751 GB, free: 10.32 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01404/0.4206, allocations: 14.55 MB / 0.5893 GB, free: 1.324 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.008124/0.4288, allocations: 4.729 MB / 0.594 GB, free: 13.83 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.007772/0.4365, allocations: 4.59 MB / 0.5984 GB, free: 11.52 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01252/0.449, allocations: 6.001 MB / 0.6043 GB, free: 5.965 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.003784/0.4528, allocations: 1.121 MB / 0.6054 GB, free: 4.844 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01698/0.4698, allocations: 7.482 MB / 0.6127 GB, free: 13.36 MB / 462.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.005176/0.475, allocations: 3.154 MB / 0.6158 GB, free: 10.2 MB / 462.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.006596/0.4816, allocations: 3.529 MB / 0.6192 GB, free: 6.656 MB / 462.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02473/0.5063, allocations: 13.13 MB / 0.6321 GB, free: 9.492 MB / 478.1 MB
Notification: Performance of FrontEnd - DAE generated: time 1.172e-05/0.5063, allocations: 11.92 kB / 0.6321 GB, free: 9.48 MB / 478.1 MB
Notification: Performance of FrontEnd: time 2.144e-06/0.5063, allocations: 0 / 0.6321 GB, free: 9.48 MB / 478.1 MB
Notification: Performance of Transformations before backend: time 0.0001656/0.5065, allocations: 0 / 0.6321 GB, free: 9.48 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 853
 * Number of variables: 853
Notification: Performance of Generate backend data structure: time 0.06868/0.5752, allocations: 13.05 MB / 0.6448 GB, free: 12.37 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.806e-05/0.5752, allocations: 12.03 kB / 0.6448 GB, free: 12.36 MB / 494.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003233/0.5784, allocations: 0.543 MB / 0.6454 GB, free: 11.8 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008541/0.587, allocations: 1.018 MB / 0.6463 GB, free: 10.78 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01172/0.5987, allocations: 3.128 MB / 0.6494 GB, free: 7.621 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.008432/0.6071, allocations: 5.361 MB / 0.6546 GB, free: 1.367 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003731/0.6109, allocations: 331.9 kB / 0.655 GB, free: 1.043 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.076/0.6869, allocations: 24.34 MB / 0.6787 GB, free: 8.625 MB / 0.5137 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001017/0.687, allocations: 3.938 kB / 0.6787 GB, free: 8.621 MB / 0.5137 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003961/0.6909, allocations: 128 kB / 0.6789 GB, free: 8.496 MB / 0.5137 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002319/0.6912, allocations: 178.6 kB / 0.679 GB, free: 8.32 MB / 0.5137 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1242/0.8153, allocations: 43.74 MB / 0.7217 GB, free: 12.53 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.3765/1.192, allocations: 68.22 MB / 0.7884 GB, free: 164.9 MB / 0.6075 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05014/1.242, allocations: 18.86 MB / 0.8068 GB, free: 162.9 MB / 0.6075 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.03356/1.276, allocations: 15.2 MB / 0.8216 GB, free: 157 MB / 0.6075 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1283/1.404, allocations: 42.1 MB / 0.8627 GB, free: 122.9 MB / 0.6075 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000115/1.404, allocations: 72.89 kB / 0.8628 GB, free: 122.8 MB / 0.6075 GB
Notification: Performance of pre-optimization done (n=371): time 6.592e-06/1.404, allocations: 0 / 0.8628 GB, free: 122.8 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=373): time 0.2288/1.633, allocations: 78.28 MB / 0.9393 GB, free: 44.67 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.338e-05/1.633, allocations: 90.33 kB / 0.9393 GB, free: 44.57 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000972/1.634, allocations: 0.7682 MB / 0.9401 GB, free: 43.8 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 0.003439/1.637, allocations: 93.7 kB / 0.9402 GB, free: 43.7 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004111/1.638, allocations: 0.8119 MB / 0.941 GB, free: 43 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004774/1.642, allocations: 1.341 MB / 0.9423 GB, free: 41.8 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01043/1.653, allocations: 1.794 MB / 0.944 GB, free: 39.99 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 0.0001361/1.653, allocations: 357.9 kB / 0.9444 GB, free: 39.64 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03603/1.689, allocations: 15.96 MB / 0.96 GB, free: 23.65 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03606/1.725, allocations: 16.32 MB / 0.9759 GB, free: 7.234 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.6386/2.364, allocations: 142.4 MB / 1.115 GB, free: 164.4 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.187e-06/2.364, allocations: 0 / 1.115 GB, free: 164.4 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=419) (initialization): time 0.2738/2.638, allocations: 82.67 MB / 1.196 GB, free: 81.71 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 3.181e-05/2.638, allocations: 15.94 kB / 1.196 GB, free: 81.7 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.972e-05/2.638, allocations: 4 kB / 1.196 GB, free: 81.69 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.4148/3.052, allocations: 92.13 MB / 1.286 GB, free: 232 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002719/3.055, allocations: 0.5265 MB / 1.286 GB, free: 231.9 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1074/3.162, allocations: 55.04 MB / 1.34 GB, free: 192.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01951/3.182, allocations: 3.05 MB / 1.343 GB, free: 189.2 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004356/3.186, allocations: 0.6433 MB / 1.344 GB, free: 188.5 MB / 0.6387 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         $DER.hex.p = 0.0.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0383/3.225, allocations: 16.55 MB / 1.36 GB, free: 171.9 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03494/3.26, allocations: 16.23 MB / 1.376 GB, free: 155.6 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.3597/3.619, allocations: 140.2 MB / 1.512 GB, free: 15.18 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.143e-05/3.619, allocations: 4 kB / 1.513 GB, free: 15.18 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=419) (initialization_lambda0): time 0.5175/4.137, allocations: 83.85 MB / 1.594 GB, free: 198.1 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 3.16e-05/4.137, allocations: 8 kB / 1.594 GB, free: 198.1 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.412e-05/4.137, allocations: 8.672 kB / 1.594 GB, free: 198.1 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2067/4.344, allocations: 92.14 MB / 1.684 GB, free: 105.8 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002467/4.346, allocations: 0.5031 MB / 1.685 GB, free: 105.3 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1125/4.459, allocations: 55.03 MB / 1.739 GB, free: 49.76 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02065/4.479, allocations: 3.043 MB / 1.742 GB, free: 46.71 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004765/4.484, allocations: 0.6394 MB / 1.742 GB, free: 46.07 MB / 0.6387 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         $DER.hex.p = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 25
 * Number of states: 0 ()
 * Number of discrete variables: 20 (hex.fluidState[20].phase,hex.fluidState[19].phase,hex.fluidState[18].phase,hex.fluidState[17].phase,hex.fluidState[16].phase,hex.fluidState[15].phase,hex.fluidState[14].phase,hex.fluidState[13].phase,hex.fluidState[12].phase,hex.fluidState[11].phase,hex.fluidState[10].phase,hex.fluidState[9].phase,hex.fluidState[8].phase,hex.fluidState[7].phase,hex.fluidState[6].phase,hex.fluidState[5].phase,hex.fluidState[4].phase,hex.fluidState[3].phase,hex.fluidState[2].phase,hex.fluidState[1].phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (251):
 * Single equations (assignments): 231
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 19
 * 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): 19 systems
   {(1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,9), (1,5)}
Notification: Performance of prepare postOptimizeDAE: time 0.007951/4.492, allocations: 367.2 kB / 1.743 GB, free: 45.71 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004768/4.497, allocations: 200.7 kB / 1.743 GB, free: 45.61 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.3538/4.85, allocations: 72.44 MB / 1.813 GB, free: 221.2 MB / 0.6387 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.1004/4.951, allocations: 68.76 MB / 1.881 GB, free: 170.8 MB / 0.6387 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.748e-05/4.951, allocations: 8 kB / 1.881 GB, free: 170.8 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001078/4.951, allocations: 20.53 kB / 1.881 GB, free: 170.8 MB / 0.6387 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1754/5.126, allocations: 121.4 MB / 1.999 GB, free: 46.04 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.739e-05/5.126, allocations: 8 kB / 1.999 GB, free: 46.04 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.02269/5.149, allocations: 4.251 MB / 2.003 GB, free: 41.78 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004502/5.154, allocations: 1.657 MB / 2.005 GB, free: 40.07 MB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003525/5.157, allocations: 431 kB / 2.005 GB, free: 39.65 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01902/5.176, allocations: 30.92 MB / 2.036 GB, free: 6.648 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.915e-06/5.176, allocations: 15.94 kB / 2.036 GB, free: 6.633 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.3539/5.53, allocations: 50.95 MB / 2.085 GB, free: 211.1 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008528/5.539, allocations: 2.61 MB / 2.088 GB, free: 210.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004158/5.543, allocations: 108.3 kB / 2.088 GB, free: 210.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02014/5.563, allocations: 3.063 MB / 2.091 GB, free: 210.1 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003876/5.567, allocations: 0.6495 MB / 2.092 GB, free: 209.6 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003184/5.57, allocations: 443.4 kB / 2.092 GB, free: 209.3 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.0006199/5.571, allocations: 0.5213 MB / 2.093 GB, free: 209 MB / 0.6387 GB
Notification: Performance of sort global known variables: time 2.3e-07/5.571, allocations: 0 / 2.093 GB, free: 209 MB / 0.6387 GB
Notification: Performance of remove unused functions: time 0.01722/5.588, allocations: 4.604 MB / 2.097 GB, free: 207.6 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 41
 * Number of states: 20 (Mbal,hex.htilde[1],hex.htilde[2],hex.htilde[3],hex.htilde[4],hex.htilde[5],hex.htilde[6],hex.htilde[7],hex.htilde[8],hex.htilde[9],hex.htilde[10],hex.htilde[11],hex.htilde[12],hex.htilde[13],hex.htilde[14],hex.htilde[15],hex.htilde[16],hex.htilde[17],hex.htilde[18],hex.htilde[19])
 * Number of discrete variables: 82 ($cse2.phase,$cse2.region,$cse3.phase,$cse3.region,$cse4.phase,$cse4.region,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,$cse7.phase,$cse7.region,$cse8.phase,$cse8.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse11.phase,$cse11.region,$cse12.phase,$cse12.region,$cse13.phase,$cse13.region,$cse14.phase,$cse14.region,$cse15.phase,$cse15.region,$cse16.phase,$cse16.region,$cse17.phase,$cse17.region,$cse18.phase,$cse18.region,$cse19.phase,$cse19.region,$cse20.phase,$cse20.region,$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,$cse32.phase,$cse32.region,$cse33.phase,$cse33.region,$cse34.phase,$cse34.region,$cse35.phase,$cse35.region,$cse36.phase,$cse36.region,$cse37.phase,$cse37.region,$cse38.phase,$cse38.region,$cse39.phase,$cse39.region,$cse40.phase,$cse40.region,$cse41.phase,$cse41.region,$cse42.region3boundary,$cse43.region3boundary)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (378):
 * Single equations (assignments): 316
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 43
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 19
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 19 systems
   {(1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.1276/5.715, allocations: 52.54 MB / 2.148 GB, free: 155.2 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.1191/5.834, allocations: 52.39 MB / 2.2 GB, free: 102.8 MB / 0.6387 GB
Notification: Performance of simCode: created event and clocks part: time 1.997e-05/5.834, allocations: 4 kB / 2.2 GB, free: 102.8 MB / 0.6387 GB
Notification: Performance of simCode: created simulation system equations: time 0.0413/5.876, allocations: 19.94 MB / 2.219 GB, free: 82.56 MB / 0.6387 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.009957/5.886, allocations: 1.02 MB / 2.22 GB, free: 81.59 MB / 0.6387 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.7659/6.652, allocations: 191.1 MB / 2.407 GB, free: 135.2 MB / 0.6387 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002121/6.654, allocations: 2.706 MB / 2.409 GB, free: 132.5 MB / 0.6387 GB
Notification: Performance of simCode: alias equations: time 0.01266/6.666, allocations: 4.344 MB / 2.414 GB, free: 128.2 MB / 0.6387 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0106/6.677, allocations: 2.232 MB / 2.416 GB, free: 125.9 MB / 0.6387 GB
Notification: Performance of SimCode: time 1.463e-06/6.677, allocations: 0 / 2.416 GB, free: 125.9 MB / 0.6387 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.438/8.115, allocations: 0.6134 GB / 3.029 GB, free: 163.9 MB / 0.6387 GB
Notification: Performance of buildModelFMU: Generate platform static: time 38.04/46.15, allocations: 14.27 kB / 3.029 GB, free: 163.8 MB / 0.6387 GB
"
[Timeout remaining time 614]
(rm -f ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C.pipe ; mkfifo ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C.pipe ; head -c 1048576 < ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C.pipe >> ../files/ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C.sim & python3 -m fmpy simulate  --output-file ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C_res.csv --start-time 0 --stop-time 250 --timeout 50 --relative-tolerance 1e-09 --interface-type ModelExchange --solver CVode --output-interval 0.1 ThermoPower_ThermoPower_Test_DistributedParameterComponents_TestWaterFlow1DFV2ph_C.fmu > ThermoPower_ThermoPower.Test.DistributedParameterComponents.TestWaterFlow1DFV2ph_C.pipe 2>&1) [Timeout 52.5]
[Calling sys.exit(0), Time elapsed: 58.21966450100081]
Failed to read output from testmodel.py, exit status != 0:
46.44658254499882 46.459064725 45.949604416
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3fea48af20>