Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.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.BranchingPipes14,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junctionIdeal.medium.h|junctionIdeal.medium.p|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe2.mediums.1..h|pipe2.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..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.BranchingPipes14")
translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junctionIdeal.medium.h|junctionIdeal.medium.p|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe2.mediums.1..h|pipe2.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..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.BranchingPipes14")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001092/0.001092, allocations: 111.3 kB / 18.46 MB, free: 4.617 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.001208/0.001208, allocations: 187.1 kB / 19.39 MB, free: 3.695 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.08 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.2162/0.2162, allocations: 44.18 MB / 337.4 MB, free: 2.688 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00135/0.00135, allocations: 71.91 kB / 471.2 MB, free: 13.2 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3634/0.3648, allocations: 60.82 MB / 0.5196 GB, free: 3.613 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14): time 0.1122/0.477, allocations: 101.9 MB / 0.619 GB, free: 5.918 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.05466/0.5317, allocations: 36.91 MB / 0.6551 GB, free: 0.8984 MB / 0.4981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004432/0.5362, allocations: 91.5 kB / 0.6552 GB, free: 0.8086 MB / 0.4981 GB
Notification: Performance of NFTyping.typeComponents: time 0.004186/0.5404, allocations: 1.243 MB / 0.6564 GB, free: 15.55 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.02534/0.5659, allocations: 8.071 MB / 0.6643 GB, free: 7.473 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02151/0.5874, allocations: 7.642 MB / 0.6717 GB, free: 15.84 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.01089/0.5983, allocations: 6.995 MB / 0.6786 GB, free: 8.82 MB / 0.5294 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003227/0.6016, allocations: 1.579 MB / 0.6801 GB, free: 7.223 MB / 0.5294 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006076/0.6077, allocations: 2.761 MB / 0.6828 GB, free: 4.453 MB / 0.5294 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02721/0.6349, allocations: 12.13 MB / 0.6947 GB, free: 8.16 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.00127/0.6362, allocations: 236 kB / 0.6949 GB, free: 7.93 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02221/0.6584, allocations: 10.02 MB / 0.7047 GB, free: 13.89 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.001929/0.6604, allocations: 0.9505 MB / 0.7056 GB, free: 12.94 MB / 0.5606 GB
Notification: Performance of NFVerifyModel.verify: time 0.003694/0.6641, allocations: 1.47 MB / 0.707 GB, free: 11.46 MB / 0.5606 GB
Notification: Performance of NFConvertDAE.convert: time 0.02551/0.6897, allocations: 9.342 MB / 0.7162 GB, free: 2.098 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 5.38e-06/0.6897, allocations: 0 / 0.7162 GB, free: 2.098 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 2.775e-06/0.6897, allocations: 4 kB / 0.7162 GB, free: 2.094 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.0001387/0.6899, allocations: 7.875 kB / 0.7162 GB, free: 2.086 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.2811/0.971, allocations: 4.173 MB / 0.7202 GB, free: 179.1 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 5.058e-05/0.971, allocations: 9.406 kB / 0.7202 GB, free: 179.1 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006206/0.9772, allocations: 0.8025 MB / 0.721 GB, free: 178.9 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01173/0.989, allocations: 6.714 MB / 0.7276 GB, free: 176.5 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003196/0.9894, allocations: 180.8 kB / 0.7278 GB, free: 176.4 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008704/0.9902, allocations: 196.2 kB / 0.7279 GB, free: 176.4 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01043/1.001, allocations: 3.552 MB / 0.7314 GB, free: 174.2 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001238/1.001, allocations: 11.03 kB / 0.7314 GB, free: 174.2 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0006598/1.002, allocations: 89.22 kB / 0.7315 GB, free: 174.2 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003273/1.002, allocations: 204.9 kB / 0.7317 GB, free: 174.1 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008839/1.011, allocations: 3.267 MB / 0.7349 GB, free: 172.5 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.02023/1.031, allocations: 15.5 MB / 0.75 GB, free: 158.8 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00585/1.037, allocations: 2.733 MB / 0.7527 GB, free: 157.1 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001963/1.039, allocations: 1.23 MB / 0.7539 GB, free: 156.5 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.04446/1.083, allocations: 24.72 MB / 0.778 GB, free: 130.3 MB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004777/1.088, allocations: 1.674 MB / 0.7797 GB, free: 128.6 MB / 0.5606 GB
Notification: Performance of pre-optimization done (n=173): time 6.172e-06/1.088, allocations: 0 / 0.7797 GB, free: 128.6 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=189): time 0.02354/1.112, allocations: 8.885 MB / 0.7884 GB, free: 119.7 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.526e-05/1.112, allocations: 184.2 kB / 0.7885 GB, free: 119.5 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001883/1.114, allocations: 1.575 MB / 0.7901 GB, free: 117.9 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002092/1.114, allocations: 57.7 kB / 0.7901 GB, free: 117.8 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006248/1.115, allocations: 0.9858 MB / 0.7911 GB, free: 116.8 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004168/1.115, allocations: 0.6311 MB / 0.7917 GB, free: 116.2 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006576/1.116, allocations: 447.6 kB / 0.7921 GB, free: 115.8 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 3.747e-05/1.116, allocations: 301.1 kB / 0.7924 GB, free: 115.5 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001929/1.118, allocations: 1.149 MB / 0.7935 GB, free: 114.3 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002262/1.12, allocations: 1.65 MB / 0.7951 GB, free: 112.5 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004181/1.124, allocations: 2.959 MB / 0.798 GB, free: 109.3 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.129e-05/1.124, allocations: 4 kB / 0.798 GB, free: 109.3 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=273) (initialization): time 0.005731/1.13, allocations: 3.383 MB / 0.8013 GB, free: 105.9 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 5.239e-05/1.13, allocations: 75.39 kB / 0.8014 GB, free: 105.8 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.975e-05/1.13, allocations: 12 kB / 0.8014 GB, free: 105.8 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007838/1.131, allocations: 240 kB / 0.8017 GB, free: 105.5 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002083/1.133, allocations: 0.5188 MB / 0.8022 GB, free: 105 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00111/1.134, allocations: 2.439 MB / 0.8045 GB, free: 102.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00198/1.136, allocations: 139.9 kB / 0.8047 GB, free: 102.3 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002098/1.136, allocations: 112 kB / 0.8048 GB, free: 102.2 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002556/1.139, allocations: 1.568 MB / 0.8063 GB, free: 100.7 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002125/1.141, allocations: 1.584 MB / 0.8079 GB, free: 98.87 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003955/1.145, allocations: 2.817 MB / 0.8106 GB, free: 95.84 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.012e-05/1.145, allocations: 4 kB / 0.8106 GB, free: 95.84 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=273) (initialization_lambda0): time 0.005461/1.15, allocations: 3.235 MB / 0.8138 GB, free: 92.57 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 4.105e-05/1.15, allocations: 75.39 kB / 0.8139 GB, free: 92.48 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.576e-05/1.15, allocations: 19.88 kB / 0.8139 GB, free: 92.46 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007468/1.151, allocations: 240 kB / 0.8141 GB, free: 92.21 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001975/1.153, allocations: 0.511 MB / 0.8146 GB, free: 91.7 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001053/1.154, allocations: 2.436 MB / 0.817 GB, free: 89.16 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00188/1.156, allocations: 139.9 kB / 0.8171 GB, free: 89.03 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001996/1.156, allocations: 99.97 kB / 0.8172 GB, free: 88.93 MB / 0.5606 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 (valve2.state_b.phase,valve2.state_a.phase,valve1.state_b.phase,valve1.state_a.phase,junctionIdeal.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_a.phase,pipe2.state_a.phase,pipe1.state_b.phase,pipe1.state_a.phase,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 (259):
 * Single equations (assignments): 253
 * 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.0005765/1.157, allocations: 410 kB / 0.8176 GB, free: 88.51 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000489/1.157, allocations: 217.4 kB / 0.8178 GB, free: 88.3 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008981/1.166, allocations: 7.475 MB / 0.8251 GB, free: 80.72 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006966/1.173, allocations: 6.536 MB / 0.8315 GB, free: 74.01 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.965e-06/1.173, allocations: 0 / 0.8315 GB, free: 74.01 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00121/1.175, allocations: 0.6446 MB / 0.8321 GB, free: 73.34 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005713/1.175, allocations: 83.47 kB / 0.8322 GB, free: 73.26 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001457/1.177, allocations: 135.8 kB / 0.8323 GB, free: 73.12 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000298/1.177, allocations: 157.8 kB / 0.8325 GB, free: 72.97 MB / 0.5606 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.006876/1.184, allocations: 4.914 MB / 0.8373 GB, free: 67.97 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.008204/1.192, allocations: 7.072 MB / 0.8442 GB, free: 60.76 MB / 0.5606 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002352/1.194, allocations: 2.251 MB / 0.8464 GB, free: 58.51 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.001618/1.196, allocations: 1.247 MB / 0.8476 GB, free: 57.24 MB / 0.5606 GB
Notification: Performance of Backend: time 7.21e-07/1.196, allocations: 0 / 0.8476 GB, free: 57.24 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.01509/1.211, allocations: 6.203 MB / 0.8537 GB, free: 51.34 MB / 0.5606 GB
Notification: Performance of SimCode: time 0.00873/1.22, allocations: 6.489 MB / 0.86 GB, free: 44.81 MB / 0.5606 GB
Notification: Performance of Templates: time 0.3629/1.583, allocations: 102.9 MB / 0.9605 GB, free: 216.6 MB / 0.6075 GB
make -j1 -f ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.makefile
(rm -f ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe ; mkfifo ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe ; head -c 1048576 < ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe >> ../files/ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.sim & ./ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe 2>&1)
diffSimulationResults("ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Fluid/TestPipesAndValves/BranchingPipes14/BranchingPipes14.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.0.0_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches