Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.conf.json
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/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/ModelicaTest 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 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)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe2.mediums.1..h|pipe2.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..p|splitter.medium.h|splitter.medium.p|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent|valveOpening2.a|valveOpening2.b|valveOpening2.last|valveOpening2.nextEvent",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4")
translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe2.mediums.1..h|pipe2.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..p|splitter.medium.h|splitter.medium.p|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent|valveOpening2.a|valveOpening2.b|valveOpening2.last|valveOpening2.nextEvent",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001264/0.001264, allocations: 110.5 kB / 18.45 MB, free: 4.598 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001218/0.001218, allocations: 187.2 kB / 19.39 MB, free: 3.672 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.387/1.387, allocations: 222.9 MB / 243.1 MB, free: 15.05 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.2245/0.2245, allocations: 44.19 MB / 337.4 MB, free: 2.652 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001555/0.001555, allocations: 63.89 kB / 471.2 MB, free: 13.16 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.345/0.3466, allocations: 60.82 MB / 0.5196 GB, free: 3.602 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4): time 0.1056/0.4522, allocations: 101.9 MB / 0.619 GB, free: 5.898 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.05524/0.5075, allocations: 39.05 MB / 0.6572 GB, free: 14.73 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003038/0.5106, allocations: 91.5 kB / 0.6573 GB, free: 14.64 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.003633/0.5142, allocations: 1.243 MB / 0.6585 GB, free: 13.39 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.02336/0.5377, allocations: 8.315 MB / 0.6666 GB, free: 5.059 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01959/0.5573, allocations: 8.086 MB / 0.6745 GB, free: 12.98 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.00945/0.5667, allocations: 6.901 MB / 0.6812 GB, free: 6.051 MB / 0.5294 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003247/0.57, allocations: 1.567 MB / 0.6828 GB, free: 4.465 MB / 0.5294 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005949/0.576, allocations: 2.726 MB / 0.6854 GB, free: 1.73 MB / 0.5294 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02515/0.6012, allocations: 12.11 MB / 0.6973 GB, free: 5.457 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.001101/0.6023, allocations: 232 kB / 0.6975 GB, free: 5.23 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02188/0.6242, allocations: 10.57 MB / 0.7078 GB, free: 10.65 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.001806/0.6261, allocations: 0.9505 MB / 0.7087 GB, free: 9.699 MB / 0.5606 GB
Notification: Performance of NFVerifyModel.verify: time 0.002277/0.6283, allocations: 1.454 MB / 0.7101 GB, free: 8.238 MB / 0.5606 GB
Notification: Performance of NFConvertDAE.convert: time 0.3261/0.9544, allocations: 9.682 MB / 0.7196 GB, free: 42.33 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 6.292e-06/0.9545, allocations: 1.188 kB / 0.7196 GB, free: 42.33 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 2.094e-06/0.9545, allocations: 1.953 kB / 0.7196 GB, free: 42.33 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.0001032/0.9546, allocations: 0.75 kB / 0.7196 GB, free: 42.33 MB / 0.5606 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 536
 * Number of variables: 536
Notification: Performance of Generate backend data structure: time 0.01143/0.966, allocations: 4.365 MB / 0.7239 GB, free: 40.39 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 5.173e-05/0.9661, allocations: 10.41 kB / 0.7239 GB, free: 40.39 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006157/0.9723, allocations: 0.8538 MB / 0.7247 GB, free: 40.24 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01127/0.9836, allocations: 6.713 MB / 0.7313 GB, free: 39.64 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001952/0.9838, allocations: 180.6 kB / 0.7314 GB, free: 39.64 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003802/0.9842, allocations: 202.4 kB / 0.7316 GB, free: 39.64 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007133/0.9913, allocations: 3.583 MB / 0.7351 GB, free: 39.22 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.27e-05/0.9914, allocations: 9.469 kB / 0.7351 GB, free: 39.22 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002364/0.9916, allocations: 88.89 kB / 0.7352 GB, free: 39.22 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002268/0.9919, allocations: 199.5 kB / 0.7354 GB, free: 39.21 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006617/0.9985, allocations: 3.36 MB / 0.7387 GB, free: 39.19 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.01605/1.015, allocations: 15.44 MB / 0.7538 GB, free: 29.82 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005116/1.02, allocations: 2.215 MB / 0.7559 GB, free: 29.78 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001696/1.021, allocations: 1.133 MB / 0.757 GB, free: 29.76 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.04538/1.067, allocations: 24.76 MB / 0.7812 GB, free: 13.88 MB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004801/1.072, allocations: 1.656 MB / 0.7828 GB, free: 13.75 MB / 0.5606 GB
Notification: Performance of pre-optimization done (n=163): time 4.329e-06/1.072, allocations: 0 / 0.7828 GB, free: 13.75 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=179): time 0.02307/1.095, allocations: 8.752 MB / 0.7914 GB, free: 12.42 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.863e-05/1.095, allocations: 183.9 kB / 0.7916 GB, free: 12.21 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002076/1.097, allocations: 1.661 MB / 0.7932 GB, free: 11.23 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001928/1.097, allocations: 64.14 kB / 0.7932 GB, free: 11.19 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000693/1.098, allocations: 1.025 MB / 0.7942 GB, free: 10.64 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004132/1.098, allocations: 0.6309 MB / 0.7949 GB, free: 10.15 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006176/1.099, allocations: 437.1 kB / 0.7953 GB, free: 9.895 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 4.245e-05/1.099, allocations: 301.1 kB / 0.7956 GB, free: 9.598 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001911/1.101, allocations: 1.133 MB / 0.7967 GB, free: 8.828 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002208/1.103, allocations: 1.604 MB / 0.7982 GB, free: 7.449 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004162/1.107, allocations: 2.882 MB / 0.801 GB, free: 5.332 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.058e-05/1.107, allocations: 4 kB / 0.801 GB, free: 5.328 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=266) (initialization): time 0.005877/1.113, allocations: 3.351 MB / 0.8043 GB, free: 2.973 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 5.336e-05/1.113, allocations: 75.02 kB / 0.8044 GB, free: 2.891 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.11e-05/1.113, allocations: 15.94 kB / 0.8044 GB, free: 2.875 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007801/1.114, allocations: 236.6 kB / 0.8046 GB, free: 2.68 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00192/1.116, allocations: 0.5082 MB / 0.8051 GB, free: 2.223 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001468/1.117, allocations: 2.433 MB / 0.8075 GB, free: 15.85 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001858/1.119, allocations: 106.9 kB / 0.8076 GB, free: 15.77 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001764/1.119, allocations: 103.3 kB / 0.8077 GB, free: 15.69 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002622/1.122, allocations: 1.561 MB / 0.8092 GB, free: 14.64 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002361/1.124, allocations: 1.529 MB / 0.8107 GB, free: 13.31 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.00431/1.129, allocations: 2.745 MB / 0.8134 GB, free: 11.24 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.526e-06/1.129, allocations: 4 kB / 0.8134 GB, free: 11.24 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=266) (initialization_lambda0): time 0.00602/1.135, allocations: 3.21 MB / 0.8165 GB, free: 8.953 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 5.999e-05/1.135, allocations: 71.77 kB / 0.8166 GB, free: 8.875 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.738e-05/1.135, allocations: 16 kB / 0.8166 GB, free: 8.859 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008208/1.136, allocations: 237.9 kB / 0.8169 GB, free: 8.664 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001989/1.138, allocations: 0.5089 MB / 0.8173 GB, free: 8.207 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0016/1.139, allocations: 2.431 MB / 0.8197 GB, free: 5.832 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001673/1.141, allocations: 99.23 kB / 0.8198 GB, free: 5.766 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001773/1.141, allocations: 106.3 kB / 0.8199 GB, free: 5.684 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 60
 * Number of states: 0 ()
 * Number of discrete variables: 30 (pipe3.state_a.phase,pipe2.state_a.phase,pipe1.state_b.phase,pipe1.state_a.phase,valveIncompressible1.state_b.phase,valveIncompressible1.state_a.phase,valveIncompressible.state_b.phase,valveIncompressible.state_a.phase,splitter.medium.phase,valveOpening2.nextEventScaled,valveOpening2.nextEvent,$PRE.valveOpening2.nextEvent,valveOpening2.last,valveOpening2.b,valveOpening2.a,valveOpening1.nextEventScaled,valveOpening1.nextEvent,$PRE.valveOpening1.nextEvent,valveOpening1.last,valveOpening1.b,valveOpening1.a,pipe3.statesFM[2].phase,pipe2.statesFM[2].phase,sink.medium.phase,pipe1.statesFM[2].phase,source.medium.phase,$whenCondition2,$whenCondition1,pipe3.state_b.phase,pipe2.state_b.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (252):
 * Single equations (assignments): 246
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * 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): 4 systems
   {(1,1), (1,1), (1,1), (1,1)}
Notification: Performance of prepare postOptimizeDAE: time 0.000653/1.142, allocations: 401 kB / 0.8203 GB, free: 5.367 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004015/1.142, allocations: 222.6 kB / 0.8205 GB, free: 5.148 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009757/1.152, allocations: 7.553 MB / 0.8279 GB, free: 24 kB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.008425/1.161, allocations: 6.621 MB / 0.8344 GB, free: 9.41 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.534e-06/1.161, allocations: 4.844 kB / 0.8344 GB, free: 9.41 MB / 0.5919 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001347/1.162, allocations: 0.6464 MB / 0.835 GB, free: 8.742 MB / 0.5919 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004072/1.162, allocations: 87.61 kB / 0.8351 GB, free: 8.656 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001323/1.164, allocations: 127.9 kB / 0.8352 GB, free: 8.531 MB / 0.5919 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003104/1.164, allocations: 153.7 kB / 0.8353 GB, free: 8.379 MB / 0.5919 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.007825/1.172, allocations: 4.796 MB / 0.84 GB, free: 3.496 MB / 0.5919 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01009/1.182, allocations: 6.876 MB / 0.8467 GB, free: 12.49 MB / 0.6075 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003144/1.185, allocations: 2.193 MB / 0.8489 GB, free: 10.3 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.0021/1.187, allocations: 1.31 MB / 0.8502 GB, free: 8.969 MB / 0.6075 GB
Notification: Performance of Backend: time 1.834e-06/1.187, allocations: 0 / 0.8502 GB, free: 8.969 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.0187/1.206, allocations: 6.362 MB / 0.8564 GB, free: 2.93 MB / 0.6075 GB
Notification: Performance of SimCode: time 0.01153/1.217, allocations: 6.518 MB / 0.8627 GB, free: 12.38 MB / 0.6231 GB
Notification: Performance of Templates: time 0.1674/1.385, allocations: 103 MB / 0.9634 GB, free: 5.969 MB / 0.7169 GB
make -j1 -f ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.makefile
(rm -f ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.pipe ; mkfifo ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.pipe ; head -c 1048576 < ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.pipe >> ../files/ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.sim & ./ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.pipe 2>&1)
diffSimulationResults("ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Fluid/TestPipesAndValves/BranchingPipes4/BranchingPipes4.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes4.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches