Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes18.conf.json
Using package ModelicaTest with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes18,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junctionIdeal.medium.h|junctionIdeal.medium.p|junctionVolume.medium.h|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_3.2.2_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes18")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.004194/0.004199, allocations: 371.3 kB / 15.96 MB, free: 6.199 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 3.814/3.814, allocations: 388.9 MB / 405.6 MB, free: 9.664 MB / 346.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.0036/0.0036, allocations: 224.5 kB / 451 MB, free: 145 MB / 346.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo): time 0.5383/0.5383, allocations: 80.02 MB / 0.5627 GB, free: 19.77 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006526/0.0006529, allocations: 8 kB / 0.6265 GB, free: 96.54 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09365/0.09434, allocations: 54.88 MB / 0.6801 GB, free: 41.65 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes18): time 0.4499/0.5443, allocations: 105.3 MB / 0.783 GB, free: 1.566 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.07541/0.6197, allocations: 36.77 MB / 0.8189 GB, free: 14.02 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004154/0.6239, allocations: 111.1 kB / 0.819 GB, free: 13.91 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.005527/0.6295, allocations: 1.173 MB / 0.8201 GB, free: 12.73 MB / 410.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:772:36-773:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:770:36-771:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:772:36-773:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:770:36-771:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.02785/0.6574, allocations: 7.067 MB / 0.827 GB, free: 5.648 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.03937/0.6969, allocations: 7.601 MB / 0.8344 GB, free: 14.09 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.02153/0.7184, allocations: 8.901 MB / 0.8431 GB, free: 5.16 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004794/0.7233, allocations: 1.402 MB / 0.8445 GB, free: 3.738 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.008259/0.7316, allocations: 2.46 MB / 0.8469 GB, free: 1.27 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.04796/0.7796, allocations: 19.68 MB / 0.8661 GB, free: 13.57 MB / 458.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001181/0.7808, allocations: 128 kB / 0.8662 GB, free: 13.45 MB / 458.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02885/0.8097, allocations: 9.302 MB / 0.8753 GB, free: 4.133 MB / 458.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.002322/0.8121, allocations: 0.8762 MB / 0.8762 GB, free: 3.254 MB / 458.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001793/0.8139, allocations: 0.5745 MB / 0.8767 GB, free: 2.672 MB / 458.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.0164/0.8304, allocations: 6.743 MB / 0.8833 GB, free: 11.91 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.556e-06/0.8304, allocations: 0 / 0.8833 GB, free: 11.91 MB / 474.7 MB
Notification: Performance of FrontEnd: time 2.215e-06/0.8305, allocations: 3.938 kB / 0.8833 GB, free: 11.91 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 0.0001118/0.8306, allocations: 4 kB / 0.8833 GB, free: 11.91 MB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 575
 * Number of variables: 575
Notification: Performance of Generate backend data structure: time 0.01534/0.8459, allocations: 3.907 MB / 0.8872 GB, free: 7.918 MB / 474.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.855e-05/0.846, allocations: 8.031 kB / 0.8872 GB, free: 7.91 MB / 474.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008705/0.8547, allocations: 0.8904 MB / 0.888 GB, free: 7.016 MB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.3271/1.182, allocations: 6.646 MB / 0.8945 GB, free: 161.6 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003632/1.182, allocations: 198.3 kB / 0.8947 GB, free: 161.6 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006925/1.183, allocations: 219.4 kB / 0.8949 GB, free: 161.6 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01297/1.196, allocations: 3.806 MB / 0.8986 GB, free: 160.5 MB / 474.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.393e-05/1.196, allocations: 9.625 kB / 0.8986 GB, free: 160.5 MB / 474.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003878/1.197, allocations: 93 kB / 0.8987 GB, free: 160.4 MB / 474.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004324/1.197, allocations: 209.8 kB / 0.8989 GB, free: 160.4 MB / 474.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01346/1.21, allocations: 3.583 MB / 0.9024 GB, free: 159.4 MB / 474.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.02953/1.24, allocations: 16.62 MB / 0.9187 GB, free: 146.9 MB / 474.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01148/1.252, allocations: 3.145 MB / 0.9217 GB, free: 145.1 MB / 474.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004186/1.256, allocations: 1.336 MB / 0.923 GB, free: 144.5 MB / 474.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.05913/1.315, allocations: 18.8 MB / 0.9414 GB, free: 129.4 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007392/1.322, allocations: 1.845 MB / 0.9432 GB, free: 127.7 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=192): time 6.442e-06/1.322, allocations: 3.938 kB / 0.9432 GB, free: 127.7 MB / 474.7 MB
Notification: Performance of matching and sorting (n=212): time 0.04366/1.366, allocations: 9.995 MB / 0.953 GB, free: 117.6 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.922e-05/1.366, allocations: 188.2 kB / 0.9531 GB, free: 117.4 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002569/1.369, allocations: 1.597 MB / 0.9547 GB, free: 115.8 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005284/1.369, allocations: 73.69 kB / 0.9548 GB, free: 115.8 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000881/1.37, allocations: 1.068 MB / 0.9558 GB, free: 114.7 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0008684/1.371, allocations: 0.7117 MB / 0.9565 GB, free: 114 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002273/1.371, allocations: 51.09 kB / 0.9566 GB, free: 113.9 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001475/1.372, allocations: 407 kB / 0.9569 GB, free: 113.5 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003836/1.375, allocations: 1.25 MB / 0.9582 GB, free: 112.3 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004409/1.38, allocations: 1.852 MB / 0.96 GB, free: 110.2 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004459/1.384, allocations: 1.532 MB / 0.9615 GB, free: 108.6 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.747e-05/1.384, allocations: 4 kB / 0.9615 GB, free: 108.6 MB / 474.7 MB
Notification: Performance of matching and sorting (n=318) (initialization): time 0.0114/1.396, allocations: 3.747 MB / 0.9651 GB, free: 104.9 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0003429/1.396, allocations: 0.6264 MB / 0.9657 GB, free: 104 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.451e-05/1.396, allocations: 20 kB / 0.9658 GB, free: 104 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00189/1.398, allocations: 349.5 kB / 0.9661 GB, free: 103.6 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004836/1.403, allocations: 0.6202 MB / 0.9667 GB, free: 103 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002273/1.405, allocations: 3.101 MB / 0.9697 GB, free: 99.77 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00472/1.41, allocations: 335.6 kB / 0.9701 GB, free: 99.44 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005614/1.411, allocations: 128 kB / 0.9702 GB, free: 99.31 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.306e-05/1.411, allocations: 4 kB / 0.9702 GB, free: 99.31 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01135/1.422, allocations: 3.478 MB / 0.9736 GB, free: 95.8 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.116e-05/1.422, allocations: 20 kB / 0.9736 GB, free: 95.78 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002/1.424, allocations: 354 kB / 0.9739 GB, free: 95.43 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007383/1.432, allocations: 0.6046 MB / 0.9745 GB, free: 94.82 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003559/1.435, allocations: 3.112 MB / 0.9776 GB, free: 91.58 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006846/1.442, allocations: 323.6 kB / 0.9779 GB, free: 91.27 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008753/1.443, allocations: 120 kB / 0.978 GB, free: 91.15 MB / 474.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 73
 * Number of states: 0 ()
 * Number of discrete variables: 31 (valve2.state_b.phase,valve2.state_a.phase,valve1.state_b.phase,valve1.state_a.phase,$whenCondition1,$whenCondition2,source.medium.phase,pipe1.statesFM[2].phase,sink.medium.phase,pipe2.statesFM[2].phase,pipe3.statesFM[2].phase,valveOpening1.a,valveOpening1.b,valveOpening1.last,$PRE.valveOpening1.nextEvent,valveOpening1.nextEvent,valveOpening1.nextEventScaled,valveOpening2.a,valveOpening2.b,valveOpening2.last,$PRE.valveOpening2.nextEvent,valveOpening2.nextEvent,valveOpening2.nextEventScaled,junctionIdeal.medium.phase,junctionVolume.medium.phase,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 (296):
 * Single equations (assignments): 289
 * Array equations: 0
 * Algorithm blocks: 2
 * 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 {1 1,1 1,1 1,1 6,1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.003058/1.446, allocations: 0.8004 MB / 0.9788 GB, free: 90.32 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008568/1.447, allocations: 221.3 kB / 0.979 GB, free: 90.11 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02791/1.475, allocations: 8.189 MB / 0.987 GB, free: 81.82 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02189/1.497, allocations: 7.094 MB / 0.9939 GB, free: 74.55 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.294e-05/1.497, allocations: 0 / 0.9939 GB, free: 74.55 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002629/1.5, allocations: 0.7688 MB / 0.9947 GB, free: 73.75 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001115/1.501, allocations: 52 kB / 0.9947 GB, free: 73.7 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004719/1.506, allocations: 291.4 kB / 0.995 GB, free: 73.42 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006613/1.506, allocations: 173.7 kB / 0.9951 GB, free: 73.25 MB / 474.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0146/1.521, allocations: 5.375 MB / 1 GB, free: 67.8 MB / 474.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01707/1.538, allocations: 7.58 MB / 1.008 GB, free: 60.09 MB / 474.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004858/1.543, allocations: 2.458 MB / 1.01 GB, free: 57.63 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.002251/1.545, allocations: 1.159 MB / 1.011 GB, free: 56.46 MB / 474.7 MB
Notification: Performance of Backend: time 1.312e-06/1.545, allocations: 3.844 kB / 1.011 GB, free: 56.46 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.02431/1.57, allocations: 6.689 MB / 1.018 GB, free: 50.22 MB / 474.7 MB
Notification: Performance of SimCode: time 0.01569/1.585, allocations: 7.909 MB / 1.026 GB, free: 42.24 MB / 474.7 MB
Notification: Performance of Templates: time 0.5166/2.102, allocations: 101.9 MB / 1.125 GB, free: 116.7 MB / 474.7 MB