Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTestOverdetermined_ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTestOverdetermined 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaTestOverdetermined with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTestOverdetermined 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)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+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)
Running command: "" <> buildModelFMU(ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues,fileNamePrefix="ModelicaTestOverdetermined_ModelicaTestOverdetermined_ConsistentInitialization_Fluid_DynamicPipeInitialValues",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues,fileNamePrefix="ModelicaTestOverdetermined_ModelicaTestOverdetermined_ConsistentInitialization_Fluid_DynamicPipeInitialValues",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.007132/0.007132, allocations: 169.5 kB / 15.11 MB, free: 5.973 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.461/1.461, allocations: 223.2 MB / 239 MB, free: 1.793 MB / 186.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001273/0.001273, allocations: 100.3 kB / 290.2 MB, free: 13.95 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTestOverdetermined 4.0.0+maint.om/package.mo): time 0.002748/0.002748, allocations: 0.566 MB / 341.9 MB, free: 10.27 MB / 282.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003446/0.000345, allocations: 8.797 kB / 403 MB, free: 98.28 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1114/0.1118, allocations: 50.57 MB / 453.6 MB, free: 59.12 MB / 330.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 6.001/6.113, allocations: 2.828 GB / 3.271 GB, free: 36.27 MB / 458.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002545/6.114, allocations: 83.73 kB / 3.271 GB, free: 36.23 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.747/7.86, allocations: 0.495 GB / 3.766 GB, free: 39.19 MB / 458.7 MB
Notification: Performance of FrontEnd: time 2.555e-06/7.86, allocations: 3.688 kB / 3.766 GB, free: 39.19 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 0.0001093/7.86, allocations: 44.34 kB / 3.767 GB, free: 39.19 MB / 458.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 474
 * Number of variables: 474
Notification: Performance of Generate backend data structure: time 0.01146/7.872, allocations: 3.107 MB / 3.77 GB, free: 37.76 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.682e-05/7.872, allocations: 10.84 kB / 3.77 GB, free: 37.76 MB / 458.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0008483/7.873, allocations: 268.3 kB / 3.77 GB, free: 37.61 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004759/7.877, allocations: 0.6673 MB / 3.77 GB, free: 37.45 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004153/7.882, allocations: 1.531 MB / 3.772 GB, free: 36.71 MB / 458.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001646/7.882, allocations: 160.8 kB / 3.772 GB, free: 36.65 MB / 458.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002773/7.882, allocations: 163.9 kB / 3.772 GB, free: 36.6 MB / 458.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006123/7.888, allocations: 3.364 MB / 3.776 GB, free: 35.24 MB / 458.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.219e-05/7.888, allocations: 7.719 kB / 3.776 GB, free: 35.23 MB / 458.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002016/7.888, allocations: 71.17 kB / 3.776 GB, free: 35.19 MB / 458.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000144/7.889, allocations: 156.6 kB / 3.776 GB, free: 35.16 MB / 458.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006193/7.895, allocations: 3.275 MB / 3.779 GB, free: 34.22 MB / 458.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.01622/7.911, allocations: 13.36 MB / 3.792 GB, free: 24.62 MB / 458.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004644/7.916, allocations: 2.178 MB / 3.794 GB, free: 23.88 MB / 458.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.4074/8.323, allocations: 61.73 MB / 3.854 GB, free: 48.28 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004666/8.328, allocations: 1.632 MB / 3.856 GB, free: 48.14 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=143): time 4.809e-06/8.328, allocations: 0 / 3.856 GB, free: 48.14 MB / 474.7 MB
Notification: Performance of matching and sorting (n=163): time 0.02464/8.353, allocations: 10.4 MB / 3.866 GB, free: 46.47 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001071/8.353, allocations: 329.7 kB / 3.867 GB, free: 46.1 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001365/8.354, allocations: 1.111 MB / 3.868 GB, free: 45.94 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001962/8.354, allocations: 55.36 kB / 3.868 GB, free: 45.91 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005122/8.355, allocations: 0.792 MB / 3.868 GB, free: 45.6 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.00047/8.355, allocations: 0.5707 MB / 3.869 GB, free: 45.32 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001185/8.355, allocations: 41.19 kB / 3.869 GB, free: 45.32 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001068/8.356, allocations: 388.8 kB / 3.869 GB, free: 45.01 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001877/8.357, allocations: 1.185 MB / 3.871 GB, free: 45 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002032/8.359, allocations: 1.751 MB / 3.872 GB, free: 44.36 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05053/8.41, allocations: 9.332 MB / 3.881 GB, free: 44.23 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.21e-05/8.41, allocations: 6.312 kB / 3.881 GB, free: 44.23 MB / 474.7 MB
Notification: Performance of matching and sorting (n=257) (initialization): time 0.00708/8.417, allocations: 3.458 MB / 3.885 GB, free: 44.04 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.001294/8.418, allocations: 6.533 MB / 3.891 GB, free: 37.24 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.771e-05/8.419, allocations: 18.41 kB / 3.891 GB, free: 37.24 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001501/8.42, allocations: 467 kB / 3.892 GB, free: 37.2 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002166/8.422, allocations: 0.5097 MB / 3.892 GB, free: 37.2 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001624/8.424, allocations: 3.312 MB / 3.895 GB, free: 34.61 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002323/8.426, allocations: 260.2 kB / 3.896 GB, free: 34.6 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002203/8.426, allocations: 97.86 kB / 3.896 GB, free: 34.6 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.222e-05/8.426, allocations: 7.875 kB / 3.896 GB, free: 34.6 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005276/8.432, allocations: 3.188 MB / 3.899 GB, free: 34.51 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.303e-05/8.432, allocations: 18.38 kB / 3.899 GB, free: 34.51 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001325/8.433, allocations: 468 kB / 3.899 GB, free: 34.47 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001915/8.435, allocations: 0.5002 MB / 3.9 GB, free: 34.47 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001672/8.437, allocations: 3.315 MB / 3.903 GB, free: 31.88 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00205/8.439, allocations: 249 kB / 3.903 GB, free: 31.87 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001783/8.439, allocations: 106 kB / 3.903 GB, free: 31.87 MB / 474.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 1 initial equations are redundant, so they are removed from the initialization sytem:
         pipe.mediums[1].p = 10000000.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 75
 * Number of states: 0 ()
 * Number of discrete variables: 16 (source.medium.phase,$PRE.m_flow_initial,m_flow_initial,$whenCondition1,valve.state_b.phase,valve.state_a.phase,pipe.statesFM[1].phase,pipe.statesFM[2].phase,pipe.statesFM[3].phase,pipe.statesFM[4].phase,pipe.statesFM[5].phase,sink.state.phase,sink.medium.phase,pipe.state_b.phase,pipe.state_a.phase,source.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (244):
 * Single equations (assignments): 239
 * 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: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 5 {2 8,1 1,1 1,1 1,1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.001371/8.44, allocations: 0.6767 MB / 3.904 GB, free: 31.68 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003184/8.441, allocations: 152.5 kB / 3.904 GB, free: 31.61 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008306/8.449, allocations: 6.658 MB / 3.911 GB, free: 31.09 MB / 474.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.483e-05/8.449, allocations: 72.03 kB / 3.911 GB, free: 31.09 MB / 474.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.093e-05/8.449, allocations: 3.156 kB / 3.911 GB, free: 31.09 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.005942/8.455, allocations: 5.222 MB / 3.916 GB, free: 30.39 MB / 474.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01314/8.468, allocations: 9.112 MB / 3.925 GB, free: 29.76 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.045e-05/8.468, allocations: 3.5 kB / 3.925 GB, free: 29.76 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001619/8.47, allocations: 398.3 kB / 3.925 GB, free: 29.76 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001953/8.472, allocations: 0.5686 MB / 3.926 GB, free: 29.71 MB / 474.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001994/8.472, allocations: 57.23 kB / 3.926 GB, free: 29.71 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001687/8.474, allocations: 3.397 MB / 3.929 GB, free: 27.11 MB / 474.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.058e-06/8.474, allocations: 8.359 kB / 3.929 GB, free: 27.11 MB / 474.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008509/8.482, allocations: 6.804 MB / 3.936 GB, free: 26.24 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001593/8.484, allocations: 0.7739 MB / 3.936 GB, free: 25.78 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000362/8.484, allocations: 49.66 kB / 3.936 GB, free: 25.75 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001415/8.486, allocations: 197 kB / 3.937 GB, free: 25.71 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002899/8.486, allocations: 168.2 kB / 3.937 GB, free: 25.69 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000123/8.486, allocations: 64.64 kB / 3.937 GB, free: 25.68 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.001448/8.488, allocations: 1.197 MB / 3.938 GB, free: 25.24 MB / 474.7 MB
Notification: Performance of sort global known variables: time 1.61e-07/8.488, allocations: 0 / 3.938 GB, free: 25.24 MB / 474.7 MB
Notification: Performance of remove unused functions: time 0.009437/8.497, allocations: 2.296 MB / 3.94 GB, free: 25 MB / 474.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * Number of states: 9 (pipe.mediums[1].h,pipe.mediums[2].p,pipe.mediums[2].h,pipe.mediums[3].p,pipe.mediums[3].h,pipe.mediums[4].p,pipe.mediums[4].h,pipe.mediums[5].p,pipe.mediums[5].h)
 * Number of discrete variables: 36 ($cse8.phase,$cse8.region,$cse9.region3boundary,$cse10.region3boundary,$cse11.phase,$cse11.region,$cse12.region3boundary,$cse13.region3boundary,$cse14.phase,$cse14.region,$cse15.region3boundary,$cse16.region3boundary,$cse17.phase,$cse17.region,$cse18.region3boundary,$cse19.region3boundary,$cse20.phase,$cse20.region,$cse25.phase,$cse25.region,$cse31.phase,$cse31.region,$cse35.phase,$cse35.region,$cse36.phase,$cse36.region,$whenCondition1,pipe.statesFM[1].phase,pipe.statesFM[2].phase,pipe.statesFM[3].phase,pipe.statesFM[4].phase,pipe.statesFM[5].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 (180):
 * Single equations (assignments): 156
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 18
 * When equations: 1
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 5 {2 8,1 1,1 1,1 1,1 1}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01724/8.514, allocations: 9.734 MB / 3.95 GB, free: 20.96 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.00913/8.524, allocations: 5.016 MB / 3.955 GB, free: 19.43 MB / 474.7 MB
Notification: Performance of simCode: created event and clocks part: time 1.177e-05/8.524, allocations: 3.844 kB / 3.955 GB, free: 19.43 MB / 474.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.003154/8.527, allocations: 2.246 MB / 3.957 GB, free: 18.57 MB / 474.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003545/8.53, allocations: 0.7342 MB / 3.958 GB, free: 18.41 MB / 474.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4022/8.933, allocations: 108.8 MB / 4.064 GB, free: 52.6 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001426/8.934, allocations: 2.004 MB / 4.066 GB, free: 51.86 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.004031/8.938, allocations: 2.259 MB / 4.068 GB, free: 51.83 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00139/8.939, allocations: 1.063 MB / 4.069 GB, free: 51.82 MB / 490.7 MB
Notification: Performance of SimCode: time 8.61e-07/8.939, allocations: 0 / 4.069 GB, free: 51.82 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1204/9.06, allocations: 92.95 MB / 4.16 GB, free: 33.85 MB / 490.7 MB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002955/9.06, allocations: 296 kB / 4.16 GB, free: 33.5 MB / 490.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 5.537/14.6, allocations: 2.5 kB / 4.16 GB, free: 33.5 MB / 490.7 MB
(rm -f ModelicaTestOverdetermined_ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues.pipe ; mkfifo ModelicaTestOverdetermined_ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues.pipe ; head -c 1048576 < ModelicaTestOverdetermined_ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues.pipe >> ../files/ModelicaTestOverdetermined_ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_ModelicaTestOverdetermined_ModelicaTestOverdetermined_ConsistentInitialization_Fluid_DynamicPipeInitialValues_fmu --startTime=0 --stopTime=4 --timeout=50 --tolerance=1e-06 ModelicaTestOverdetermined_ModelicaTestOverdetermined_ConsistentInitialization_Fluid_DynamicPipeInitialValues.fmu > ModelicaTestOverdetermined_ModelicaTestOverdetermined.ConsistentInitialization.Fluid.DynamicPipeInitialValues.pipe 2>&1)