Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo", uses=false)
Using package ModelicaTest with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues")
translateModel(ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.01333/0.01333, allocations: 165.6 kB / 15.11 MB, free: 5.973 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 1.665/1.665, allocations: 170.8 MB / 186.6 MB, free: 1.031 MB / 154.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.001821/0.001821, allocations: 117.6 kB / 226.2 MB, free: 10.1 MB / 186.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.4583/0.4583, allocations: 38.06 MB / 303.7 MB, free: 42.49 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004446/0.0004443, allocations: 12 kB / 362.9 MB, free: 5.582 MB / 266.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1468/0.1473, allocations: 48.7 MB / 411.6 MB, free: 4.809 MB / 314.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 7.396/7.544, allocations: 2.553 GB / 2.955 GB, free: 49.21 MB / 426.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002459/7.544, allocations: 78.66 kB / 2.955 GB, free: 49.18 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.943/9.487, allocations: 487.9 MB / 3.432 GB, free: 34.31 MB / 442.7 MB
Notification: Performance of FrontEnd: time 2.535e-06/9.487, allocations: 0 / 3.432 GB, free: 34.31 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0001152/9.487, allocations: 40.12 kB / 3.432 GB, free: 34.31 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: 474
 * Number of variables: 474
Notification: Performance of Generate backend data structure: time 0.01318/9.501, allocations: 3.041 MB / 3.435 GB, free: 32.88 MB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.67e-05/9.501, allocations: 10.44 kB / 3.435 GB, free: 32.88 MB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00539/9.506, allocations: 0.6604 MB / 3.435 GB, free: 32.72 MB / 442.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004717/9.511, allocations: 1.523 MB / 3.437 GB, free: 31.99 MB / 442.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001668/9.511, allocations: 156.8 kB / 3.437 GB, free: 31.93 MB / 442.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003969/9.511, allocations: 157.1 kB / 3.437 GB, free: 31.88 MB / 442.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006943/9.518, allocations: 3.356 MB / 3.441 GB, free: 30.51 MB / 442.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.376e-05/9.518, allocations: 11.72 kB / 3.441 GB, free: 30.5 MB / 442.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002401/9.519, allocations: 79.45 kB / 3.441 GB, free: 30.45 MB / 442.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001623/9.519, allocations: 164.4 kB / 3.441 GB, free: 30.42 MB / 442.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006577/9.525, allocations: 3.275 MB / 3.444 GB, free: 29.45 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.01589/9.541, allocations: 13.34 MB / 3.457 GB, free: 19.84 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004607/9.546, allocations: 2.184 MB / 3.459 GB, free: 19.09 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.4388/9.985, allocations: 61.62 MB / 3.519 GB, free: 42.71 MB / 458.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004903/9.99, allocations: 1.634 MB / 3.521 GB, free: 42.57 MB / 458.7 MB
Notification: Performance of pre-optimization done (n=143): time 5.4e-06/9.99, allocations: 0 / 3.521 GB, free: 42.57 MB / 458.7 MB
Notification: Performance of matching and sorting (n=163): time 0.02693/10.02, allocations: 10.39 MB / 3.531 GB, free: 40.92 MB / 458.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001201/10.02, allocations: 333.3 kB / 3.531 GB, free: 40.54 MB / 458.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001693/10.02, allocations: 1.112 MB / 3.532 GB, free: 40.39 MB / 458.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002715/10.02, allocations: 54.02 kB / 3.533 GB, free: 40.36 MB / 458.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0006558/10.02, allocations: 0.7942 MB / 3.533 GB, free: 40.05 MB / 458.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005647/10.02, allocations: 0.5636 MB / 3.534 GB, free: 39.77 MB / 458.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001238/10.02, allocations: 42.56 kB / 3.534 GB, free: 39.77 MB / 458.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001216/10.02, allocations: 389 kB / 3.534 GB, free: 39.46 MB / 458.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00201/10.02, allocations: 1.182 MB / 3.535 GB, free: 39.45 MB / 458.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002313/10.02, allocations: 1.748 MB / 3.537 GB, free: 38.81 MB / 458.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 4.896/14.92, allocations: 0.7374 GB / 4.274 GB, free: 75.67 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.34e-05/14.92, allocations: 4 kB / 4.274 GB, free: 75.66 MB / 490.7 MB
Notification: Performance of matching and sorting (n=257) (initialization): time 0.007359/14.93, allocations: 3.457 MB / 4.278 GB, free: 73.82 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.001362/14.93, allocations: 6.539 MB / 4.284 GB, free: 66.92 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.693e-05/14.93, allocations: 16 kB / 4.284 GB, free: 66.91 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001501/14.93, allocations: 466.8 kB / 4.285 GB, free: 66.63 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002374/14.93, allocations: 0.5109 MB / 4.285 GB, free: 66.25 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001757/14.94, allocations: 3.316 MB / 4.288 GB, free: 63.26 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002852/14.94, allocations: 256.5 kB / 4.289 GB, free: 63.11 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003068/14.94, allocations: 98.27 kB / 4.289 GB, free: 63.04 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.355e-05/14.94, allocations: 4 kB / 4.289 GB, free: 63.04 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005573/14.94, allocations: 3.186 MB / 4.292 GB, free: 61.35 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.261e-05/14.94, allocations: 17 kB / 4.292 GB, free: 61.33 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001295/14.95, allocations: 462.4 kB / 4.292 GB, free: 61.06 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002008/14.95, allocations: 0.506 MB / 4.293 GB, free: 60.68 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001618/14.95, allocations: 3.313 MB / 4.296 GB, free: 57.69 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002252/14.95, allocations: 252.2 kB / 4.296 GB, free: 57.55 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001933/14.95, allocations: 99.42 kB / 4.296 GB, free: 57.48 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 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.001596/14.95, allocations: 0.6848 MB / 4.297 GB, free: 57.09 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005337/14.95, allocations: 154.5 kB / 4.297 GB, free: 57.01 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009784/14.96, allocations: 6.65 MB / 4.304 GB, free: 53.56 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.83e-05/14.96, allocations: 71.45 kB / 4.304 GB, free: 53.53 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.935e-05/14.96, allocations: 4 kB / 4.304 GB, free: 53.52 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00606/14.97, allocations: 5.228 MB / 4.309 GB, free: 50.43 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01321/14.98, allocations: 9.104 MB / 4.318 GB, free: 45.08 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.901e-05/14.98, allocations: 0 / 4.318 GB, free: 45.08 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001626/14.98, allocations: 408.3 kB / 4.318 GB, free: 44.72 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002/14.99, allocations: 0.5637 MB / 4.319 GB, free: 44.25 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002664/14.99, allocations: 56.41 kB / 4.319 GB, free: 44.22 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001736/14.99, allocations: 3.402 MB / 4.322 GB, free: 41.02 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.671e-06/14.99, allocations: 4.875 kB / 4.322 GB, free: 41.01 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01007/15, allocations: 6.806 MB / 4.329 GB, free: 36.36 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002008/15, allocations: 0.7697 MB / 4.33 GB, free: 35.79 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006974/15, allocations: 50.81 kB / 4.33 GB, free: 35.76 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002115/15, allocations: 197.5 kB / 4.33 GB, free: 35.6 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004022/15, allocations: 171.5 kB / 4.33 GB, free: 35.45 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001877/15, allocations: 71.95 kB / 4.33 GB, free: 35.39 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.002132/15.01, allocations: 1.189 MB / 4.331 GB, free: 34.55 MB / 490.7 MB
Notification: Performance of sort global known variables: time 1.9e-07/15.01, allocations: 4 kB / 4.331 GB, free: 34.54 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.01212/15.02, allocations: 2.278 MB / 4.333 GB, free: 32.63 MB / 490.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.01159/15.03, allocations: 2.004 MB / 4.335 GB, free: 31.14 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.01014/15.04, allocations: 5.016 MB / 4.34 GB, free: 27.71 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 9.447e-06/15.04, allocations: 4 kB / 4.34 GB, free: 27.71 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.003685/15.04, allocations: 2.24 MB / 4.342 GB, free: 26.28 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004099/15.05, allocations: 0.7313 MB / 4.343 GB, free: 25.58 MB / 490.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4464/15.49, allocations: 92.03 MB / 4.433 GB, free: 67.82 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001518/15.5, allocations: 2.005 MB / 4.435 GB, free: 67.05 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.004728/15.5, allocations: 2.256 MB / 4.437 GB, free: 66.96 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005808/15.5, allocations: 163.9 kB / 4.437 GB, free: 66.95 MB / 490.7 MB
Notification: Performance of SimCode: time 1.323e-06/15.5, allocations: 0 / 4.437 GB, free: 66.95 MB / 490.7 MB
Notification: Performance of Templates: time 0.1099/15.61, allocations: 68.45 MB / 4.504 GB, free: 42.32 MB / 490.7 MB
make -j1 -f ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.makefile
(rm -f ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.pipe ; mkfifo ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.pipe ; head -c 1048576 < ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.pipe >> ../files/ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.sim & ./ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues  -abortSlowSimulation -alarm=480 -lv LOG_STATS > ModelicaTest_3.2.1_ModelicaTest.Fluid.TestOverdeterminedInitial.DynamicPipeInitialValues.pipe 2>&1)