Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes13.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.SeriesPipes13,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|pipe2.mediums.2..h|pipe2.mediums.2..p|pipe3.mediums.1..h|pipe3.mediums.1..p|valve.filter.x.1.|valve.filter.x.2.|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes13")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002721/0.002725, allocations: 350.9 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.142/3.142, allocations: 341.5 MB / 358.2 MB, free: 28.76 MB / 170.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.003524/0.003524, allocations: 223.9 kB / 397.9 MB, free: 6.16 MB / 186.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.4826/0.4826, allocations: 76.09 MB / 0.5014 GB, free: 0.8203 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004699/0.0004702, allocations: 12 kB / 0.5592 GB, free: 60.26 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08176/0.08225, allocations: 48.7 MB / 0.6067 GB, free: 11.55 MB / 282.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes13): time 0.4434/0.5257, allocations: 86.05 MB / 0.6908 GB, free: 3.062 MB / 314.7 MB
Notification: Performance of NFInst.instExpressions: time 0.0696/0.5954, allocations: 34.92 MB / 0.7249 GB, free: 3.566 MB / 346.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003723/0.5992, allocations: 99.25 kB / 0.725 GB, free: 3.469 MB / 346.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.004715/0.6039, allocations: 0.9517 MB / 0.7259 GB, free: 2.512 MB / 346.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.02757/0.6316, allocations: 6.592 MB / 0.7323 GB, free: 11.91 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02822/0.6598, allocations: 7.044 MB / 0.7392 GB, free: 4.883 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01358/0.6734, allocations: 7.84 MB / 0.7469 GB, free: 13.02 MB / 378.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003492/0.677, allocations: 1.203 MB / 0.748 GB, free: 11.8 MB / 378.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0065/0.6835, allocations: 2.137 MB / 0.7501 GB, free: 9.652 MB / 378.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.05475/0.7383, allocations: 21.89 MB / 0.7715 GB, free: 3.75 MB / 394.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001094/0.7395, allocations: 111.9 kB / 0.7716 GB, free: 3.641 MB / 394.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02948/0.769, allocations: 9.449 MB / 0.7808 GB, free: 10.18 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.002171/0.7712, allocations: 0.8178 MB / 0.7816 GB, free: 9.359 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001541/0.7728, allocations: 0.5083 MB / 0.7821 GB, free: 8.844 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01657/0.7894, allocations: 6.455 MB / 0.7884 GB, free: 2.375 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.04e-06/0.7894, allocations: 4 kB / 0.7884 GB, free: 2.371 MB / 410.7 MB
Notification: Performance of FrontEnd: time 2.755e-06/0.7895, allocations: 0 / 0.7884 GB, free: 2.371 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 0.0001388/0.7896, allocations: 0 / 0.7884 GB, free: 2.371 MB / 410.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 510
 * Number of variables: 510
Notification: Performance of Generate backend data structure: time 0.01466/0.8043, allocations: 3.522 MB / 0.7919 GB, free: 14.79 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.242e-05/0.8044, allocations: 8.031 kB / 0.7919 GB, free: 14.78 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008422/0.8128, allocations: 0.8088 MB / 0.7927 GB, free: 13.96 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01838/0.8312, allocations: 6.418 MB / 0.7989 GB, free: 7.484 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003241/0.8316, allocations: 179.7 kB / 0.7991 GB, free: 7.309 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006976/0.8323, allocations: 196.8 kB / 0.7993 GB, free: 7.117 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0125/0.8448, allocations: 3.499 MB / 0.8027 GB, free: 3.484 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.575e-05/0.845, allocations: 7.938 kB / 0.8027 GB, free: 3.477 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003649/0.8454, allocations: 87.95 kB / 0.8028 GB, free: 3.391 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004668/0.8458, allocations: 195.5 kB / 0.803 GB, free: 3.199 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.3137/1.16, allocations: 3.269 MB / 0.8062 GB, free: 147.2 MB / 426.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.0319/1.192, allocations: 14.94 MB / 0.8208 GB, free: 136.7 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.009233/1.201, allocations: 2.305 MB / 0.823 GB, free: 136.1 MB / 426.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00365/1.205, allocations: 1.121 MB / 0.8241 GB, free: 135.7 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.06037/1.265, allocations: 19 MB / 0.8427 GB, free: 120.7 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.008929/1.274, allocations: 1.617 MB / 0.8443 GB, free: 119.8 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=153): time 8.787e-06/1.274, allocations: 0 / 0.8443 GB, free: 119.8 MB / 426.7 MB
Notification: Performance of matching and sorting (n=169): time 0.04845/1.323, allocations: 8.073 MB / 0.8521 GB, free: 113.8 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001003/1.323, allocations: 222.9 kB / 0.8524 GB, free: 113.5 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003825/1.327, allocations: 1.559 MB / 0.8539 GB, free: 112 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005369/1.327, allocations: 58.25 kB / 0.8539 GB, free: 111.9 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001237/1.328, allocations: 1.002 MB / 0.8549 GB, free: 110.9 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0009728/1.329, allocations: 0.5804 MB / 0.8555 GB, free: 110.3 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002986/1.33, allocations: 40 kB / 0.8555 GB, free: 110.3 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001996/1.33, allocations: 394.1 kB / 0.8559 GB, free: 109.9 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005627/1.335, allocations: 1.136 MB / 0.857 GB, free: 108.8 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006232/1.342, allocations: 1.673 MB / 0.8586 GB, free: 106.9 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005938/1.348, allocations: 1.382 MB / 0.86 GB, free: 105.5 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.523e-05/1.348, allocations: 4 kB / 0.86 GB, free: 105.5 MB / 426.7 MB
Notification: Performance of matching and sorting (n=268) (initialization): time 0.01941/1.367, allocations: 3.952 MB / 0.8639 GB, free: 101.5 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0004671/1.368, allocations: 0.5524 MB / 0.8644 GB, free: 100.7 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.356e-05/1.368, allocations: 16 kB / 0.8644 GB, free: 100.7 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0404/1.408, allocations: 2.967 MB / 0.8673 GB, free: 97.76 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003395/1.412, allocations: 335.5 kB / 0.8676 GB, free: 97.43 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009566/1.421, allocations: 3.482 MB / 0.871 GB, free: 93.92 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003706/1.425, allocations: 251.5 kB / 0.8713 GB, free: 93.68 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005096/1.426, allocations: 104 kB / 0.8714 GB, free: 93.57 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.39e-05/1.426, allocations: 4 kB / 0.8714 GB, free: 93.57 MB / 426.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01123/1.437, allocations: 3.624 MB / 0.8749 GB, free: 89.93 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.795e-05/1.437, allocations: 16 kB / 0.8749 GB, free: 89.92 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01203/1.449, allocations: 1.781 MB / 0.8767 GB, free: 88.14 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002574/1.452, allocations: 375.4 kB / 0.877 GB, free: 87.77 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006537/1.458, allocations: 2.771 MB / 0.8797 GB, free: 84.98 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003475/1.462, allocations: 259.5 kB / 0.88 GB, free: 84.73 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000407/1.462, allocations: 99.78 kB / 0.8801 GB, free: 84.63 MB / 426.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 66
 * Number of states: 0 ()
 * Number of discrete variables: 22 (pipe3.state_a.phase,pipe1.state_a.phase,simpleGenericOrifice.state_b.phase,simpleGenericOrifice.state_a.phase,valve.state_b.phase,valve.state_a.phase,$whenCondition1,source.medium.phase,pipe1.statesFM[2].phase,sink.medium.phase,pipe2.statesFM[1].phase,pipe2.statesFM[2].phase,valveOpening1.a,valveOpening1.b,valveOpening1.last,$PRE.valveOpening1.nextEvent,valveOpening1.nextEvent,pipe3.statesFM[2].phase,pipe3.state_b.phase,pipe2.state_b.phase,pipe2.state_a.phase,pipe1.state_b.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (169):
 * Single equations (assignments): 165
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {8 86}
Notification: Performance of prepare postOptimizeDAE: time 0.001702/1.464, allocations: 0.7316 MB / 0.8808 GB, free: 83.88 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000536/1.465, allocations: 193.7 kB / 0.881 GB, free: 83.69 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01488/1.479, allocations: 7.733 MB / 0.8885 GB, free: 75.87 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01214/1.492, allocations: 6.638 MB / 0.895 GB, free: 69.07 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.455e-05/1.492, allocations: 0 / 0.895 GB, free: 69.07 MB / 426.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002591/1.494, allocations: 0.726 MB / 0.8957 GB, free: 68.32 MB / 426.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001055/1.495, allocations: 51.98 kB / 0.8958 GB, free: 68.27 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003247/1.499, allocations: 251.5 kB / 0.896 GB, free: 68.03 MB / 426.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004295/1.499, allocations: 145.8 kB / 0.8961 GB, free: 67.89 MB / 426.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01168/1.511, allocations: 4.83 MB / 0.9009 GB, free: 62.98 MB / 426.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01416/1.525, allocations: 6.888 MB / 0.9076 GB, free: 55.97 MB / 426.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004297/1.529, allocations: 2.232 MB / 0.9098 GB, free: 53.73 MB / 426.7 MB
Notification: Performance of sorting global known variables: time 0.002357/1.532, allocations: 1.144 MB / 0.9109 GB, free: 52.57 MB / 426.7 MB
Notification: Performance of Backend: time 8.42e-07/1.532, allocations: 0 / 0.9109 GB, free: 52.57 MB / 426.7 MB
Notification: Performance of simCode: created initialization part: time 0.02372/1.556, allocations: 6.108 MB / 0.9168 GB, free: 46.93 MB / 426.7 MB
Notification: Performance of SimCode: time 0.01425/1.57, allocations: 7.188 MB / 0.9239 GB, free: 39.68 MB / 426.7 MB
Notification: Performance of Templates: time 0.4836/2.054, allocations: 98.82 MB / 1.02 GB, free: 100.1 MB / 426.7 MB