Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false)
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..p|valveIncompressible1.filter.x.1.|valveIncompressible1.filter.x.2.|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2")
translateModel(ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..p|valveIncompressible1.filter.x.1.|valveIncompressible1.filter.x.2.|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001038/0.001038, allocations: 199 kB / 17.08 MB, free: 5.078 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.201/1.201, allocations: 227.2 MB / 245 MB, free: 7.465 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.0008469/0.0008471, allocations: 103.2 kB / 297.3 MB, free: 6.156 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.3224/0.3224, allocations: 45.23 MB / 394.7 MB, free: 31.67 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000287/0.000287, allocations: 11.98 kB / 468.4 MB, free: 7.727 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3358/0.3361, allocations: 63.23 MB / 0.5192 GB, free: 43.43 MB / 394.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.267/5.603, allocations: 2.831 GB / 3.35 GB, free: 76.75 MB / 0.5417 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000266/5.603, allocations: 80.14 kB / 3.35 GB, free: 76.7 MB / 0.5417 GB
Notification: Performance of FrontEnd - DAE generated: time 1.795/7.399, allocations: 0.5839 GB / 3.934 GB, free: 55.48 MB / 0.5573 GB
Notification: Performance of FrontEnd: time 1.313e-06/7.399, allocations: 0 / 3.934 GB, free: 55.48 MB / 0.5573 GB
Notification: Performance of Transformations before backend: time 0.0001472/7.399, allocations: 45.86 kB / 3.934 GB, free: 55.47 MB / 0.5573 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 322
 * Number of variables: 322
Notification: Performance of Generate backend data structure: time 0.008809/7.408, allocations: 3.05 MB / 3.937 GB, free: 53.88 MB / 0.5573 GB
Notification: Performance of prepare preOptimizeDAE: time 3.235e-05/7.408, allocations: 7.844 kB / 3.937 GB, free: 53.88 MB / 0.5573 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00328/7.411, allocations: 0.5445 MB / 3.938 GB, free: 53.79 MB / 0.5573 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002859/7.414, allocations: 1.448 MB / 3.939 GB, free: 53.42 MB / 0.5573 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.299e-05/7.414, allocations: 117.8 kB / 3.939 GB, free: 53.41 MB / 0.5573 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001756/7.414, allocations: 129.9 kB / 3.939 GB, free: 53.41 MB / 0.5573 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003644/7.418, allocations: 2.293 MB / 3.941 GB, free: 53.02 MB / 0.5573 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.062e-05/7.418, allocations: 2.906 kB / 3.941 GB, free: 53.02 MB / 0.5573 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001362/7.418, allocations: 57.28 kB / 3.942 GB, free: 53.02 MB / 0.5573 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.524e-05/7.418, allocations: 101.6 kB / 3.942 GB, free: 53.02 MB / 0.5573 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00368/7.422, allocations: 2.061 MB / 3.944 GB, free: 53 MB / 0.5573 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.009645/7.431, allocations: 9.796 MB / 3.953 GB, free: 47.07 MB / 0.5573 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002849/7.434, allocations: 1.416 MB / 3.955 GB, free: 47.05 MB / 0.5573 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03792/7.472, allocations: 27.01 MB / 3.981 GB, free: 29.3 MB / 0.5573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002436/7.475, allocations: 1.065 MB / 3.982 GB, free: 29.2 MB / 0.5573 GB
Notification: Performance of pre-optimization done (n=96): time 2.595e-06/7.475, allocations: 0 / 3.982 GB, free: 29.2 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=104): time 0.0113/7.486, allocations: 5.318 MB / 3.987 GB, free: 28.34 MB / 0.5573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000122/7.486, allocations: 272.2 kB / 3.987 GB, free: 28.03 MB / 0.5573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001185/7.487, allocations: 1.037 MB / 3.988 GB, free: 27.88 MB / 0.5573 GB
Notification: Performance of collectPreVariables (initialization): time 9.438e-05/7.487, allocations: 48.92 kB / 3.989 GB, free: 27.84 MB / 0.5573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003988/7.488, allocations: 0.6424 MB / 3.989 GB, free: 27.58 MB / 0.5573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000202/7.488, allocations: 350.2 kB / 3.989 GB, free: 27.36 MB / 0.5573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.899e-05/7.488, allocations: 21.97 kB / 3.989 GB, free: 27.36 MB / 0.5573 GB
Notification: Performance of setup shared object (initialization): time 0.0001251/7.488, allocations: 353.4 kB / 3.99 GB, free: 27.06 MB / 0.5573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001064/7.489, allocations: 0.7001 MB / 3.991 GB, free: 27.05 MB / 0.5573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001171/7.491, allocations: 0.9882 MB / 3.991 GB, free: 26.73 MB / 0.5573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001203/7.492, allocations: 0.8362 MB / 3.992 GB, free: 26.68 MB / 0.5573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.428e-06/7.492, allocations: 3.938 kB / 3.992 GB, free: 26.67 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=156) (initialization): time 0.003141/7.495, allocations: 2.038 MB / 3.994 GB, free: 26.48 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0008358/7.496, allocations: 2.766 MB / 3.997 GB, free: 23.61 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.236e-05/7.496, allocations: 11.59 kB / 3.997 GB, free: 23.61 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004513/7.496, allocations: 139.9 kB / 3.997 GB, free: 23.59 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001146/7.497, allocations: 317.9 kB / 3.997 GB, free: 23.59 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007272/7.498, allocations: 1.248 MB / 3.999 GB, free: 22.55 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001183/7.499, allocations: 159.2 kB / 3.999 GB, free: 22.53 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001124/7.499, allocations: 65.77 kB / 3.999 GB, free: 22.53 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 7.024e-06/7.499, allocations: 3.656 kB / 3.999 GB, free: 22.53 MB / 0.5573 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002853/7.502, allocations: 1.863 MB / 4.001 GB, free: 22.44 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.748e-05/7.502, allocations: 7.75 kB / 4.001 GB, free: 22.44 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003942/7.503, allocations: 137.8 kB / 4.001 GB, free: 22.43 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00108/7.504, allocations: 313.7 kB / 4.001 GB, free: 22.42 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006881/7.505, allocations: 1.257 MB / 4.002 GB, free: 21.38 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001088/7.506, allocations: 154.8 kB / 4.003 GB, free: 21.36 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001008/7.506, allocations: 58.33 kB / 4.003 GB, free: 21.36 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 31
 * Number of states: 0 ()
 * Number of discrete variables: 17 (pipe3.state_a.phase,valveIncompressible1.state_b.phase,valveIncompressible1.state_a.phase,pipe1.state_a.phase,$whenCondition1,source.medium.phase,pipe1.statesFM[2].phase,sink.medium.phase,pipe3.statesFM[2].phase,valveOpening1.a,valveOpening1.b,valveOpening1.last,$PRE.valveOpening1.nextEvent,valveOpening1.nextEvent,valveOpening1.nextEventScaled,pipe3.state_b.phase,pipe1.state_b.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (147):
 * Single equations (assignments): 142
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 1,1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.0008026/7.507, allocations: 0.5428 MB / 4.003 GB, free: 21.12 MB / 0.5573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001642/7.507, allocations: 140.5 kB / 4.003 GB, free: 21.05 MB / 0.5573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004935/7.512, allocations: 4.816 MB / 4.008 GB, free: 19.46 MB / 0.5573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.574e-05/7.512, allocations: 56.94 kB / 4.008 GB, free: 19.44 MB / 0.5573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.043e-06/7.512, allocations: 3.906 kB / 4.008 GB, free: 19.44 MB / 0.5573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003868/7.516, allocations: 4.039 MB / 4.012 GB, free: 17.63 MB / 0.5573 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007161/7.523, allocations: 6.872 MB / 4.019 GB, free: 14.68 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.772e-06/7.523, allocations: 7.141 kB / 4.019 GB, free: 14.67 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0009394/7.524, allocations: 246 kB / 4.019 GB, free: 14.65 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006868/7.524, allocations: 190.8 kB / 4.019 GB, free: 14.59 MB / 0.5573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 9.299e-05/7.525, allocations: 42.62 kB / 4.019 GB, free: 14.57 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0006942/7.525, allocations: 1.289 MB / 4.02 GB, free: 13.42 MB / 0.5573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.272e-06/7.525, allocations: 0 / 4.02 GB, free: 13.42 MB / 0.5573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004656/7.53, allocations: 4.451 MB / 4.025 GB, free: 11.5 MB / 0.5573 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008345/7.531, allocations: 0.5587 MB / 4.025 GB, free: 11.13 MB / 0.5573 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001932/7.531, allocations: 35.45 kB / 4.025 GB, free: 11.11 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008462/7.532, allocations: 128.1 kB / 4.025 GB, free: 11.08 MB / 0.5573 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001591/7.532, allocations: 94.92 kB / 4.026 GB, free: 11.06 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.03e-05/7.532, allocations: 40.83 kB / 4.026 GB, free: 11.05 MB / 0.5573 GB
Notification: Performance of sorting global known variables: time 0.001109/7.533, allocations: 0.9938 MB / 4.027 GB, free: 10.68 MB / 0.5573 GB
Notification: Performance of sort global known variables: time 1.5e-07/7.533, allocations: 0 / 4.027 GB, free: 10.68 MB / 0.5573 GB
Notification: Performance of remove unused functions: time 0.006196/7.539, allocations: 2.229 MB / 4.029 GB, free: 10.19 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 6 (pipe1.mediums[1].p,pipe1.mediums[1].h,valveIncompressible1.filter.x[1],valveIncompressible1.filter.x[2],pipe3.mediums[1].p,pipe3.mediums[1].h)
 * Number of discrete variables: 36 ($cse3.phase,$cse3.region,$cse5.region3boundary,$cse6.region3boundary,$cse7.phase,$cse7.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse15.phase,$cse15.region,$cse16.phase,$cse16.region,$cse18.phase,$cse18.region,$cse19.phase,$cse19.region,$cse22.phase,$cse22.region,$cse24.region3boundary,$cse25.region3boundary,$cse26.phase,$cse26.region,$cse28.phase,$cse28.region,$whenCondition1,source.medium.phase,pipe1.statesFM[2].phase,sink.medium.phase,pipe3.statesFM[2].phase,valveOpening1.a,valveOpening1.b,valveOpening1.last,valveOpening1.nextEvent,valveOpening1.nextEventScaled)
 * Number of discrete states: 6 (valveOpening1.nextEvent,valveOpening1.last,valveOpening1.nextEventScaled,valveOpening1.b,valveOpening1.a,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (119):
 * Single equations (assignments): 101
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 15
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 1,1 1}
Notification: Performance of Backend phase and start with SimCode phase: time 0.007369/7.547, allocations: 2.406 MB / 4.031 GB, free: 9.512 MB / 0.5573 GB
Notification: Performance of simCode: created initialization part: time 0.004718/7.552, allocations: 3.241 MB / 4.034 GB, free: 8.266 MB / 0.5573 GB
Notification: Performance of simCode: created event and clocks part: time 9.327e-06/7.552, allocations: 2.438 kB / 4.034 GB, free: 8.266 MB / 0.5573 GB
Notification: Performance of simCode: created simulation system equations: time 0.001686/7.553, allocations: 1.486 MB / 4.036 GB, free: 7.602 MB / 0.5573 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002816/7.556, allocations: 0.6426 MB / 4.036 GB, free: 7.445 MB / 0.5573 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005824/7.562, allocations: 5.677 MB / 4.042 GB, free: 4.371 MB / 0.5573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001004/7.563, allocations: 1.715 MB / 4.044 GB, free: 3.281 MB / 0.5573 GB
Notification: Performance of simCode: alias equations: time 0.002313/7.565, allocations: 1.612 MB / 4.045 GB, free: 2.32 MB / 0.5573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003268/7.566, allocations: 130.7 kB / 4.045 GB, free: 2.199 MB / 0.5573 GB
Notification: Performance of SimCode: time 6.92e-07/7.566, allocations: 0 / 4.045 GB, free: 2.199 MB / 0.5573 GB
Notification: Performance of Templates: time 0.3096/7.875, allocations: 63.44 MB / 4.107 GB, free: 68.8 MB / 0.573 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.makefile
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.sim & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.pipe 2>&1)
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Fluid/TestPipesAndValves/SeriesPipes2/SeriesPipes2.csv","../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches