Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes16.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes16,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junctionIdeal.medium.T|junctionIdeal.medium.p|pipe1.mediums.1..T|pipe1.mediums.1..p|pipe2.mediums.1..T|pipe2.mediums.1..p|pipe3.mediums.1..T|pipe3.mediums.1..p|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent|valveOpening2.a|valveOpening2.b|valveOpening2.last|valveOpening2.nextEvent",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes16")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.0041/0.004107, allocations: 349.6 kB / 15.95 MB, free: 6.219 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 3.775/3.775, allocations: 341.5 MB / 358.2 MB, free: 12.63 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.003426/0.003426, allocations: 220.4 kB / 397.9 MB, free: 4.988 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.4701/0.4701, allocations: 76.1 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000652/0.0006522, allocations: 16 kB / 0.5592 GB, free: 53.48 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.07926/0.07994, allocations: 48.71 MB / 0.6067 GB, free: 4.672 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.BranchingPipes16): time 0.8939/0.9739, allocations: 229.1 MB / 0.8304 GB, free: 3.855 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.03595/1.01, allocations: 18.22 MB / 0.8482 GB, free: 1.672 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003503/1.013, allocations: 107.2 kB / 0.8483 GB, free: 1.672 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003602/1.017, allocations: 0.8018 MB / 0.8491 GB, free: 1.383 MB / 410.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+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.1+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.1+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.1+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.01633/1.033, allocations: 4.307 MB / 0.8533 GB, free: 220 kB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01999/1.053, allocations: 5.22 MB / 0.8584 GB, free: 14.77 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01285/1.066, allocations: 7.956 MB / 0.8662 GB, free: 9.855 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003245/1.07, allocations: 1.231 MB / 0.8674 GB, free: 8.895 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006187/1.076, allocations: 2.114 MB / 0.8695 GB, free: 7.496 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006311/1.082, allocations: 2.416 MB / 0.8718 GB, free: 5.727 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001031/1.083, allocations: 108 kB / 0.8719 GB, free: 5.621 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01324/1.097, allocations: 3.326 MB / 0.8752 GB, free: 2.992 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.003188/1.1, allocations: 0.8083 MB / 0.876 GB, free: 2.355 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.002504/1.102, allocations: 470.1 kB / 0.8764 GB, free: 2.012 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01202/1.114, allocations: 3.907 MB / 0.8802 GB, free: 14.71 MB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.893e-06/1.115, allocations: 0 / 0.8802 GB, free: 14.71 MB / 442.7 MB
Notification: Performance of FrontEnd: time 2.825e-06/1.115, allocations: 0 / 0.8802 GB, free: 14.71 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0001196/1.115, allocations: 0 / 0.8802 GB, free: 14.71 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 423
 * Number of variables: 423
Notification: Performance of Generate backend data structure: time 0.01123/1.126, allocations: 2.956 MB / 0.8831 GB, free: 11.89 MB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.342e-05/1.126, allocations: 8.031 kB / 0.8831 GB, free: 11.89 MB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004155/1.13, allocations: 435.7 kB / 0.8835 GB, free: 11.48 MB / 442.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006126/1.136, allocations: 1.862 MB / 0.8854 GB, free: 10.07 MB / 442.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001991/1.137, allocations: 130.1 kB / 0.8855 GB, free: 9.992 MB / 442.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000632/1.137, allocations: 163.2 kB / 0.8856 GB, free: 9.887 MB / 442.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007315/1.145, allocations: 2.518 MB / 0.8881 GB, free: 7.656 MB / 442.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7.184e-05/1.145, allocations: 7.938 kB / 0.8881 GB, free: 7.648 MB / 442.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003463/1.145, allocations: 65.92 kB / 0.8882 GB, free: 7.594 MB / 442.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004444/1.146, allocations: 194.9 kB / 0.8884 GB, free: 7.402 MB / 442.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007392/1.153, allocations: 2.21 MB / 0.8905 GB, free: 5.188 MB / 442.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.02454/1.178, allocations: 10.71 MB / 0.901 GB, free: 9.844 MB / 458.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.005295/1.183, allocations: 1.783 MB / 0.9027 GB, free: 8.012 MB / 458.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003014/1.186, allocations: 1.019 MB / 0.9037 GB, free: 6.996 MB / 458.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.00417/1.19, allocations: 2.433 MB / 0.9061 GB, free: 4.184 MB / 458.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003378/1.194, allocations: 1.146 MB / 0.9072 GB, free: 3.016 MB / 458.7 MB
Notification: Performance of pre-optimization done (n=158): time 6.632e-06/1.194, allocations: 0 / 0.9072 GB, free: 3.016 MB / 458.7 MB
Warning: Some equations could not be differentiated for following variables having attribute stateSelect=StateSelect.prefer. They will be treated as if they had stateSelect=StateSelect.default
========================================
1: pipe1.mediums[1].T
2: pipe2.mediums[1].T
3: pipe3.mediums[1].T
4: junctionIdeal.medium.T
Please use -d=bltdump for more information.
Notification: Performance of matching and sorting (n=181): time 0.04728/1.241, allocations: 10.49 MB / 0.9174 GB, free: 8.348 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001113/1.241, allocations: 176.2 kB / 0.9176 GB, free: 8.137 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002896/1.244, allocations: 1.482 MB / 0.9191 GB, free: 6.652 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005062/1.245, allocations: 61.64 kB / 0.9191 GB, free: 6.586 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001031/1.246, allocations: 0.8987 MB / 0.92 GB, free: 5.68 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001033/1.247, allocations: 0.6178 MB / 0.9206 GB, free: 5.07 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002395/1.247, allocations: 48 kB / 0.9206 GB, free: 5.023 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002118/1.247, allocations: 382.2 kB / 0.921 GB, free: 4.645 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003072/1.25, allocations: 1.007 MB / 0.922 GB, free: 3.633 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003649/1.254, allocations: 1.508 MB / 0.9235 GB, free: 1.93 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003727/1.258, allocations: 1.29 MB / 0.9247 GB, free: 0.625 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.44e-05/1.258, allocations: 4 kB / 0.9247 GB, free: 0.6211 MB / 474.7 MB
Notification: Performance of matching and sorting (n=271) (initialization): time 0.00926/1.267, allocations: 3.122 MB / 0.9278 GB, free: 13.46 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0004421/1.267, allocations: 0.5305 MB / 0.9283 GB, free: 12.75 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.673e-05/1.268, allocations: 12 kB / 0.9283 GB, free: 12.73 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007216/1.268, allocations: 195.3 kB / 0.9285 GB, free: 12.53 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004756/1.273, allocations: 0.5578 MB / 0.929 GB, free: 11.97 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00219/1.275, allocations: 2.335 MB / 0.9313 GB, free: 9.535 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003838/1.279, allocations: 211.7 kB / 0.9315 GB, free: 9.328 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006646/1.28, allocations: 188 kB / 0.9317 GB, free: 9.145 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.609e-05/1.28, allocations: 4 kB / 0.9317 GB, free: 9.141 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.008283/1.288, allocations: 2.86 MB / 0.9345 GB, free: 6.258 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.676e-05/1.288, allocations: 12 kB / 0.9345 GB, free: 6.246 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006484/1.289, allocations: 195.4 kB / 0.9347 GB, free: 6.043 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004498/1.293, allocations: 0.55 MB / 0.9352 GB, free: 5.492 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002087/1.296, allocations: 2.342 MB / 0.9375 GB, free: 3.047 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003516/1.299, allocations: 203.8 kB / 0.9377 GB, free: 2.848 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005661/1.3, allocations: 188 kB / 0.9379 GB, free: 2.664 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 58
 * Number of states: 0 ()
 * Number of discrete variables: 12 ($whenCondition1,$whenCondition2,valveOpening1.a,valveOpening1.b,valveOpening1.last,$PRE.valveOpening1.nextEvent,valveOpening1.nextEvent,valveOpening2.a,valveOpening2.b,valveOpening2.last,$PRE.valveOpening2.nextEvent,valveOpening2.nextEvent)
 * 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 (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 1,1 1,1 1,1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.001831/1.302, allocations: 0.6853 MB / 0.9386 GB, free: 1.957 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006072/1.302, allocations: 209.5 kB / 0.9388 GB, free: 1.75 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01184/1.314, allocations: 3.485 MB / 0.9422 GB, free: 14.26 MB / 0.4948 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006969/1.321, allocations: 2.728 MB / 0.9448 GB, free: 11.42 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.033e-05/1.321, allocations: 0 / 0.9448 GB, free: 11.42 MB / 0.4948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001841/1.323, allocations: 0.5256 MB / 0.9453 GB, free: 10.88 MB / 0.4948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000738/1.324, allocations: 46.12 kB / 0.9454 GB, free: 10.83 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002289/1.326, allocations: 127.7 kB / 0.9455 GB, free: 10.71 MB / 0.4948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005045/1.327, allocations: 153.8 kB / 0.9457 GB, free: 10.56 MB / 0.4948 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01016/1.337, allocations: 3.02 MB / 0.9486 GB, free: 7.516 MB / 0.4948 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01138/1.348, allocations: 4.214 MB / 0.9527 GB, free: 3.273 MB / 0.4948 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003156/1.351, allocations: 1.198 MB / 0.9539 GB, free: 2.074 MB / 0.4948 GB
Notification: Performance of sorting global known variables: time 0.002111/1.354, allocations: 0.9723 MB / 0.9548 GB, free: 1.109 MB / 0.4948 GB
Notification: Performance of Backend: time 5.91e-07/1.354, allocations: 0 / 0.9548 GB, free: 1.109 MB / 0.4948 GB
Notification: Performance of simCode: created initialization part: time 0.2797/1.633, allocations: 4.846 MB / 0.9596 GB, free: 218 MB / 0.4948 GB
Notification: Performance of SimCode: time 0.01508/1.648, allocations: 5.706 MB / 0.9651 GB, free: 215.5 MB / 0.4948 GB
Notification: Performance of Templates: time 0.1587/1.807, allocations: 66.71 MB / 1.03 GB, free: 169 MB / 0.4948 GB