Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001313/0.001313, allocations: 113.9 kB / 21.18 MB, free: 0.6289 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001412/0.001412, allocations: 209.8 kB / 24.48 MB, free: 4.035 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.449/1.449, allocations: 230.2 MB / 257.8 MB, free: 8.516 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2339/0.2339, allocations: 46.88 MB / 361.1 MB, free: 4.652 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/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)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5006,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.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14")
translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5006,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.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14") [Timeout 660]
"Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.00231/0.00231, allocations: 87.86 kB / 0.4968 GB, free: 7.848 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3547/0.357, allocations: 65.98 MB / 0.5612 GB, free: 5.09 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14): time 0.1101/0.4671, allocations: 103.8 MB / 0.6625 GB, free: 12.98 MB / 0.4981 GB
Notification: Performance of NFInst.instExpressions: time 0.05625/0.5234, allocations: 37.16 MB / 0.6988 GB, free: 7.711 MB / 0.5294 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003588/0.527, allocations: 91.5 kB / 0.6989 GB, free: 7.621 MB / 0.5294 GB
Notification: Performance of NFTyping.typeComponents: time 0.003975/0.531, allocations: 1.262 MB / 0.7001 GB, free: 6.352 MB / 0.5294 GB
Notification: Performance of NFTyping.typeBindings: time 0.02393/0.5549, allocations: 8.09 MB / 0.708 GB, free: 14.24 MB / 0.545 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02179/0.5767, allocations: 7.681 MB / 0.7155 GB, free: 6.574 MB / 0.545 GB
Notification: Performance of NFFlatten.flatten: time 0.01418/0.5909, allocations: 7.008 MB / 0.7224 GB, free: 15.54 MB / 0.5606 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003712/0.5946, allocations: 1.38 MB / 0.7237 GB, free: 14.14 MB / 0.5606 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007821/0.6024, allocations: 2.773 MB / 0.7264 GB, free: 11.36 MB / 0.5606 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.3864/0.9888, allocations: 12.35 MB / 0.7385 GB, free: 24.43 MB / 0.5606 GB
Notification: Performance of NFPackage.collectConstants: time 0.001303/0.9901, allocations: 235.7 kB / 0.7387 GB, free: 24.43 MB / 0.5606 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02112/1.011, allocations: 10.1 MB / 0.7486 GB, free: 24.43 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.002073/1.013, allocations: 0.9882 MB / 0.7495 GB, free: 24.43 MB / 0.5606 GB
Notification: Performance of NFVerifyModel.verify: time 0.002617/1.016, allocations: 1.464 MB / 0.751 GB, free: 24.43 MB / 0.5606 GB
Notification: Performance of NFConvertDAE.convert: time 0.02239/1.038, allocations: 9.405 MB / 0.7602 GB, free: 23.99 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 4.929e-06/1.038, allocations: 0 / 0.7602 GB, free: 23.99 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 1.913e-06/1.038, allocations: 0 / 0.7602 GB, free: 23.99 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.0001008/1.038, allocations: 3.062 kB / 0.7602 GB, free: 23.99 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.01274/1.051, allocations: 4.307 MB / 0.7644 GB, free: 22.11 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 4.654e-05/1.051, allocations: 8.062 kB / 0.7644 GB, free: 22.11 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005442/1.057, allocations: 0.8127 MB / 0.7652 GB, free: 21.95 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01048/1.067, allocations: 6.72 MB / 0.7717 GB, free: 21.29 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001839/1.067, allocations: 184.2 kB / 0.7719 GB, free: 21.29 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003982/1.068, allocations: 203.5 kB / 0.7721 GB, free: 21.29 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007304/1.075, allocations: 3.551 MB / 0.7756 GB, free: 20.84 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.076e-05/1.075, allocations: 13.19 kB / 0.7756 GB, free: 20.84 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000228/1.075, allocations: 90.61 kB / 0.7757 GB, free: 20.84 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002271/1.075, allocations: 201.6 kB / 0.7759 GB, free: 20.84 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007001/1.082, allocations: 3.273 MB / 0.7791 GB, free: 20.81 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.01697/1.099, allocations: 15.53 MB / 0.7942 GB, free: 10.73 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005343/1.105, allocations: 2.643 MB / 0.7968 GB, free: 9.695 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001765/1.107, allocations: 1.162 MB / 0.7979 GB, free: 9.5 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0524/1.159, allocations: 27.28 MB / 0.8246 GB, free: 15.6 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005012/1.164, allocations: 1.676 MB / 0.8262 GB, free: 14.31 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=173): time 6.832e-06/1.164, allocations: 3.984 kB / 0.8262 GB, free: 14.31 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=189): time 0.02491/1.189, allocations: 8.932 MB / 0.8349 GB, free: 7.562 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001282/1.189, allocations: 179.4 kB / 0.8351 GB, free: 7.352 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002347/1.191, allocations: 1.577 MB / 0.8366 GB, free: 6.16 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002503/1.192, allocations: 58.27 kB / 0.8367 GB, free: 6.121 MB / 0.5919 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009159/1.193, allocations: 1.014 MB / 0.8377 GB, free: 5.469 MB / 0.5919 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006856/1.193, allocations: 0.6562 MB / 0.8383 GB, free: 4.906 MB / 0.5919 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007264/1.194, allocations: 438.3 kB / 0.8388 GB, free: 4.625 MB / 0.5919 GB
Notification: Performance of setup shared object (initialization): time 0.000154/1.194, allocations: 306.2 kB / 0.839 GB, free: 4.324 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002234/1.196, allocations: 1.143 MB / 0.8402 GB, free: 3.551 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002749/1.199, allocations: 1.659 MB / 0.8418 GB, free: 2.137 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004934/1.204, allocations: 2.958 MB / 0.8447 GB, free: 15.95 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.111e-05/1.204, allocations: 4 kB / 0.8447 GB, free: 15.95 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=273) (initialization): time 0.006817/1.211, allocations: 3.392 MB / 0.848 GB, free: 13.56 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 8.716e-05/1.211, allocations: 74.77 kB / 0.8481 GB, free: 13.48 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.492e-05/1.211, allocations: 12 kB / 0.8481 GB, free: 13.47 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008623/1.212, allocations: 245 kB / 0.8483 GB, free: 13.27 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002315/1.214, allocations: 0.5208 MB / 0.8488 GB, free: 12.8 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00198/1.216, allocations: 2.442 MB / 0.8512 GB, free: 10.41 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002181/1.218, allocations: 134.5 kB / 0.8513 GB, free: 10.32 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002487/1.219, allocations: 110 kB / 0.8514 GB, free: 10.23 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003123/1.222, allocations: 1.565 MB / 0.853 GB, free: 9.184 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00278/1.224, allocations: 1.585 MB / 0.8545 GB, free: 7.418 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005143/1.23, allocations: 2.822 MB / 0.8573 GB, free: 4.445 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.114e-05/1.23, allocations: 4 kB / 0.8573 GB, free: 4.441 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=273) (initialization_lambda0): time 0.006868/1.236, allocations: 3.244 MB / 0.8604 GB, free: 1.246 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 8.226e-05/1.237, allocations: 75.39 kB / 0.8605 GB, free: 1.16 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.284e-05/1.237, allocations: 19.75 kB / 0.8605 GB, free: 1.145 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008237/1.237, allocations: 243.8 kB / 0.8608 GB, free: 0.8945 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002187/1.24, allocations: 0.5107 MB / 0.8613 GB, free: 424 kB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001976/1.242, allocations: 2.438 MB / 0.8636 GB, free: 13.88 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00216/1.244, allocations: 132 kB / 0.8638 GB, free: 13.75 MB / 0.6231 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002334/1.244, allocations: 104 kB / 0.8639 GB, free: 13.65 MB / 0.6231 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.0008742/1.245, allocations: 403 kB / 0.8642 GB, free: 13.27 MB / 0.6231 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005268/1.245, allocations: 222.6 kB / 0.8645 GB, free: 13.05 MB / 0.6231 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01247/1.258, allocations: 7.485 MB / 0.8718 GB, free: 5.473 MB / 0.6231 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01034/1.268, allocations: 6.532 MB / 0.8781 GB, free: 14.77 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.385e-05/1.268, allocations: 3.984 kB / 0.8782 GB, free: 14.76 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00206/1.27, allocations: 0.6581 MB / 0.8788 GB, free: 14.08 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000552/1.271, allocations: 91.55 kB / 0.8789 GB, free: 13.99 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001384/1.272, allocations: 135.8 kB / 0.879 GB, free: 13.86 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003263/1.272, allocations: 157.8 kB / 0.8792 GB, free: 13.71 MB / 0.6387 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.009057/1.282, allocations: 4.93 MB / 0.884 GB, free: 8.695 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01134/1.293, allocations: 7.095 MB / 0.8909 GB, free: 1.477 MB / 0.6387 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002997/1.296, allocations: 1.837 MB / 0.8927 GB, free: 15.64 MB / 0.6544 GB
Notification: Performance of sorting global known variables: time 0.002035/1.298, allocations: 1.251 MB / 0.8939 GB, free: 14.37 MB / 0.6544 GB
Notification: Performance of Backend: time 3.2e-07/1.298, allocations: 0 / 0.8939 GB, free: 14.37 MB / 0.6544 GB
Notification: Performance of simCode: created initialization part: time 0.01782/1.316, allocations: 5.885 MB / 0.8997 GB, free: 8.777 MB / 0.6544 GB
Notification: Performance of SimCode: time 0.01156/1.327, allocations: 6.601 MB / 0.9061 GB, free: 2.145 MB / 0.6544 GB
Notification: Performance of Templates: time 0.427/1.754, allocations: 104.8 MB / 1.008 GB, free: 340.9 MB / 0.7481 GB
"
[Timeout remaining time 658]
make -j1 -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.sim & ./ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Fluid/TestPipesAndValves/BranchingPipes14/BranchingPipes14.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes14.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 11.829919292125851]