Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeLumpedPressureInitialization.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeLumpedPressureInitialization,fileNamePrefix="ModelicaTest_3_2_1_ModelicaTest_Fluid_TestOverdeterminedInitial_DynamicPipeLumpedPressureInitialization",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.01036/0.01036, allocations: 165.3 kB / 15.11 MB, free: 5.93 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 1.693/1.693, allocations: 170.8 MB / 186.6 MB, free: 1.133 MB / 154.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.001978/0.001977, allocations: 110.5 kB / 226.2 MB, free: 10.1 MB / 186.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.4449/0.4449, allocations: 38.06 MB / 303.7 MB, free: 42.37 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005032/0.0005032, allocations: 19.98 kB / 363 MB, free: 5.492 MB / 266.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1244/0.1249, allocations: 48.7 MB / 411.7 MB, free: 4.707 MB / 314.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 7.776/7.901, allocations: 2.553 GB / 2.955 GB, free: 50.77 MB / 442.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000237/7.901, allocations: 84.14 kB / 2.955 GB, free: 50.73 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 2.622/10.52, allocations: 484.2 MB / 3.428 GB, free: 32.89 MB / 442.7 MB
Notification: Performance of FrontEnd: time 3.015e-06/10.52, allocations: 0 / 3.428 GB, free: 32.89 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0001266/10.52, allocations: 44.36 kB / 3.428 GB, free: 32.88 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 369
 * Number of variables: 369
Notification: Performance of Generate backend data structure: time 0.01558/10.54, allocations: 3.029 MB / 3.431 GB, free: 31.76 MB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.113e-05/10.54, allocations: 11.91 kB / 3.431 GB, free: 31.76 MB / 442.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001125/10.54, allocations: 211.7 kB / 3.432 GB, free: 31.71 MB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006698/10.55, allocations: 0.5715 MB / 3.432 GB, free: 31.63 MB / 442.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006139/10.55, allocations: 1.479 MB / 3.434 GB, free: 31.29 MB / 442.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002947/10.55, allocations: 131 kB / 3.434 GB, free: 31.28 MB / 442.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0007741/10.55, allocations: 145.2 kB / 3.434 GB, free: 31.28 MB / 442.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00989/10.56, allocations: 2.745 MB / 3.436 GB, free: 30.86 MB / 442.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7.518e-05/10.56, allocations: 9.484 kB / 3.436 GB, free: 30.86 MB / 442.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003291/10.56, allocations: 61.47 kB / 3.437 GB, free: 30.86 MB / 442.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000174/10.56, allocations: 113 kB / 3.437 GB, free: 30.86 MB / 442.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01094/10.58, allocations: 2.684 MB / 3.439 GB, free: 30.84 MB / 442.7 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.02128/10.6, allocations: 10.92 MB / 3.45 GB, free: 24.16 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.007359/10.6, allocations: 1.826 MB / 3.452 GB, free: 23.56 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.223/10.83, allocations: 61.62 MB / 3.512 GB, free: 16.99 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006194/10.83, allocations: 1.428 MB / 3.513 GB, free: 15.89 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=127): time 5.671e-06/10.83, allocations: 0 / 3.513 GB, free: 15.89 MB / 474.7 MB
Notification: Performance of matching and sorting (n=151): time 0.03517/10.87, allocations: 8.337 MB / 3.521 GB, free: 8.75 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002015/10.87, allocations: 278.5 kB / 3.522 GB, free: 8.418 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001869/10.87, allocations: 0.8969 MB / 3.523 GB, free: 7.637 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0004965/10.87, allocations: 57.7 kB / 3.523 GB, free: 7.574 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0006443/10.87, allocations: 0.6678 MB / 3.523 GB, free: 6.969 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0007185/10.87, allocations: 0.5161 MB / 3.524 GB, free: 6.504 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002135/10.87, allocations: 36 kB / 3.524 GB, free: 6.469 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002182/10.87, allocations: 379.8 kB / 3.524 GB, free: 6.113 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00321/10.88, allocations: 1.01 MB / 3.525 GB, free: 5.281 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003777/10.88, allocations: 1.498 MB / 3.527 GB, free: 3.777 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 7.196/18.08, allocations: 0.5704 GB / 4.097 GB, free: 75.08 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.621e-05/18.08, allocations: 3.938 kB / 4.097 GB, free: 75.08 MB / 490.7 MB
Notification: Performance of matching and sorting (n=230) (initialization): time 0.01076/18.09, allocations: 3.423 MB / 4.1 GB, free: 74.99 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.001316/18.09, allocations: 5.669 MB / 4.106 GB, free: 69.05 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.109e-05/18.09, allocations: 14.56 kB / 4.106 GB, free: 69.05 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02013/18.11, allocations: 2.567 MB / 4.108 GB, free: 68.96 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001867/18.11, allocations: 280.2 kB / 4.109 GB, free: 68.96 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008568/18.12, allocations: 3.259 MB / 4.112 GB, free: 68.4 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003245/18.12, allocations: 214.2 kB / 4.112 GB, free: 68.39 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004025/18.12, allocations: 88.7 kB / 4.112 GB, free: 68.39 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.697e-05/18.12, allocations: 5.031 kB / 4.112 GB, free: 68.39 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01121/18.13, allocations: 3.244 MB / 4.115 GB, free: 68.32 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.752e-05/18.13, allocations: 22.95 kB / 4.115 GB, free: 68.32 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01389/18.15, allocations: 2.006 MB / 4.117 GB, free: 68.25 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002042/18.15, allocations: 297.3 kB / 4.118 GB, free: 68.25 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007817/18.16, allocations: 2.987 MB / 4.12 GB, free: 67.7 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00315/18.16, allocations: 215 kB / 4.121 GB, free: 67.69 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005554/18.16, allocations: 86.12 kB / 4.121 GB, free: 67.69 MB / 490.7 MB
Warning: Assuming fixed start value for the following 1 variables:
         m_flow_initial:DISCRETE(unit = "kg/s" fixed = true )  type: Real
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization sytem:
         $DER.pipe.mediums[2].p = 0.0
         $DER.pipe.mediums[3].p = 0.0
         $DER.pipe.mediums[4].p = 0.0
         $DER.pipe.mediums[1].p = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 65
 * Number of states: 0 ()
 * Number of discrete variables: 17 (source.medium.phase,$PRE.m_flow_initial,m_flow_initial,$whenCondition2,$whenCondition1,valve.state_b.phase,valve.state_a.phase,pipe.state_a.phase,pipe.mediums[1].phase,pipe.mediums[2].phase,pipe.mediums[4].phase,pipe.mediums[5].phase,pipe.statesFM[2].phase,sink.state.phase,sink.medium.phase,pipe.state_b.phase,source.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (146):
 * Single equations (assignments): 145
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {6 79}
Notification: Performance of prepare postOptimizeDAE: time 0.002075/18.16, allocations: 0.6024 MB / 4.121 GB, free: 67.5 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004638/18.16, allocations: 141.4 kB / 4.122 GB, free: 67.5 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01292/18.18, allocations: 5.833 MB / 4.127 GB, free: 67.11 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.586e-05/18.18, allocations: 54.3 kB / 4.127 GB, free: 67.11 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.063e-05/18.18, allocations: 3.938 kB / 4.127 GB, free: 67.11 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.009598/18.19, allocations: 4.716 MB / 4.132 GB, free: 66.44 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0193/18.21, allocations: 8.183 MB / 4.14 GB, free: 65.64 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.249e-05/18.21, allocations: 0 / 4.14 GB, free: 65.64 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001952/18.21, allocations: 255.7 kB / 4.14 GB, free: 65.64 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00782/18.22, allocations: 1.29 MB / 4.141 GB, free: 65.59 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004139/18.22, allocations: 52.23 kB / 4.141 GB, free: 65.59 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003915/18.22, allocations: 2.192 MB / 4.144 GB, free: 65.04 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.256e-06/18.22, allocations: 4.891 kB / 4.144 GB, free: 65.04 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01373/18.23, allocations: 5.792 MB / 4.149 GB, free: 64.34 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002084/18.24, allocations: 0.6082 MB / 4.15 GB, free: 64.13 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006754/18.24, allocations: 47.53 kB / 4.15 GB, free: 64.13 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00296/18.24, allocations: 175.1 kB / 4.15 GB, free: 64.12 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007188/18.24, allocations: 156.7 kB / 4.15 GB, free: 64.11 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002044/18.24, allocations: 58.59 kB / 4.15 GB, free: 64.11 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.002107/18.24, allocations: 0.9594 MB / 4.151 GB, free: 64 MB / 490.7 MB
Notification: Performance of sort global known variables: time 5.21e-07/18.24, allocations: 0 / 4.151 GB, free: 64 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.0104/18.25, allocations: 2.109 MB / 4.153 GB, free: 64 MB / 490.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 6 (pipe.mediums[1].h,pipe.mediums[2].h,pipe.mediums[3].h,pipe.mediums[4].h,pipe.mediums[5].p,pipe.mediums[5].h)
 * Number of discrete variables: 31 ($cse4.region3boundary,$cse5.region3boundary,$cse6.phase,$cse6.region,$cse7.phase,$cse7.region,$cse8.phase,$cse8.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse13.phase,$cse13.region,$cse19.phase,$cse19.region,$cse23.phase,$cse23.region,$cse24.phase,$cse24.region,$whenCondition2,$whenCondition1,pipe.mediums[1].phase,pipe.mediums[2].phase,pipe.mediums[4].phase,pipe.mediums[5].phase,pipe.statesFM[2].phase,m_flow_initial,$cse3.phase,$cse3.region,source.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (124):
 * Single equations (assignments): 110
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 12
 * When equations: 1
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {10 39}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02616/18.28, allocations: 8.823 MB / 4.162 GB, free: 60.44 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.01456/18.3, allocations: 4.351 MB / 4.166 GB, free: 57.62 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 1.505e-05/18.3, allocations: 7.531 kB / 4.166 GB, free: 57.61 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.00538/18.3, allocations: 1.94 MB / 4.168 GB, free: 55.94 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006378/18.31, allocations: 0.6754 MB / 4.169 GB, free: 55.46 MB / 490.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.5639/18.87, allocations: 72.8 MB / 4.24 GB, free: 57.66 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001741/18.87, allocations: 1.738 MB / 4.241 GB, free: 56.93 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.004431/18.88, allocations: 1.289 MB / 4.243 GB, free: 56.91 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001928/18.88, allocations: 0.8294 MB / 4.244 GB, free: 56.9 MB / 490.7 MB
Notification: Performance of SimCode: time 1.423e-06/18.88, allocations: 3 kB / 4.244 GB, free: 56.9 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.2308/19.11, allocations: 92.18 MB / 4.334 GB, free: 48.63 MB / 490.7 MB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0003021/19.11, allocations: 302.1 kB / 4.334 GB, free: 48.26 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 6.344/25.45, allocations: 0 / 4.334 GB, free: 48.26 MB / 490.7 MB