Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2.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.SeriesPipes2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe1.mediums.1..h|pipe1.mediums.1..p|pipe3.mediums.1..h|pipe3.mediums.1..p|valveIncompressible1.filter.x.1.|valveIncompressible1.filter.x.2.|valveOpening1.a|valveOpening1.b|valveOpening1.last|valveOpening1.nextEvent",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002599/0.002604, allocations: 349.8 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.432/3.432, allocations: 341.5 MB / 358.2 MB, free: 12.64 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.003724/0.003724, allocations: 221.2 kB / 397.9 MB, free: 4.984 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.4838/0.4838, allocations: 76.09 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004945/0.0004947, allocations: 16 kB / 0.5592 GB, free: 53.47 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08786/0.0884, allocations: 48.71 MB / 0.6067 GB, free: 4.652 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes2): time 0.3673/0.4558, allocations: 61.42 MB / 0.6667 GB, free: 50.63 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04656/0.5024, allocations: 27.7 MB / 0.6938 GB, free: 23.9 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002495/0.505, allocations: 67.5 kB / 0.6938 GB, free: 23.83 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003051/0.5081, allocations: 0.6759 MB / 0.6945 GB, free: 23.15 MB / 362.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.02241/0.5305, allocations: 5.364 MB / 0.6997 GB, free: 17.8 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02078/0.5513, allocations: 5.514 MB / 0.7051 GB, free: 12.32 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.007129/0.5585, allocations: 5.189 MB / 0.7102 GB, free: 7.121 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001952/0.5605, allocations: 0.8074 MB / 0.711 GB, free: 6.312 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004058/0.5646, allocations: 1.432 MB / 0.7124 GB, free: 4.875 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.03072/0.5954, allocations: 12.76 MB / 0.7248 GB, free: 8.105 MB / 378.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006835/0.5962, allocations: 68 kB / 0.7249 GB, free: 8.039 MB / 378.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02736/0.6235, allocations: 8.724 MB / 0.7334 GB, free: 15.3 MB / 394.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001505/0.6251, allocations: 0.514 MB / 0.7339 GB, free: 14.79 MB / 394.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.00104/0.6262, allocations: 360.8 kB / 0.7343 GB, free: 14.43 MB / 394.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01446/0.6407, allocations: 5.184 MB / 0.7393 GB, free: 9.234 MB / 394.7 MB
Notification: Performance of FrontEnd - DAE generated: time 9.277e-06/0.6408, allocations: 0 / 0.7393 GB, free: 9.234 MB / 394.7 MB
Notification: Performance of FrontEnd: time 3.587e-06/0.6408, allocations: 0 / 0.7393 GB, free: 9.234 MB / 394.7 MB
Notification: Performance of Transformations before backend: time 9.754e-05/0.6409, allocations: 0 / 0.7393 GB, free: 9.234 MB / 394.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 320
 * Number of variables: 320
Notification: Performance of Generate backend data structure: time 0.01032/0.6512, allocations: 2.59 MB / 0.7419 GB, free: 6.582 MB / 394.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.593e-05/0.6513, allocations: 16.03 kB / 0.7419 GB, free: 6.566 MB / 394.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00548/0.6568, allocations: 0.5209 MB / 0.7424 GB, free: 6.043 MB / 394.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01252/0.6694, allocations: 4.317 MB / 0.7466 GB, free: 1.684 MB / 394.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002001/0.6696, allocations: 114.4 kB / 0.7467 GB, free: 1.57 MB / 394.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003864/0.67, allocations: 124 kB / 0.7468 GB, free: 1.449 MB / 394.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007741/0.6778, allocations: 2.216 MB / 0.749 GB, free: 15.12 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.132e-05/0.6779, allocations: 7.938 kB / 0.749 GB, free: 15.11 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002255/0.6781, allocations: 59.92 kB / 0.7491 GB, free: 15.05 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002717/0.6784, allocations: 114.2 kB / 0.7492 GB, free: 14.94 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00827/0.6867, allocations: 2.038 MB / 0.7512 GB, free: 12.89 MB / 410.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.02118/0.7079, allocations: 9.567 MB / 0.7605 GB, free: 2.512 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.005977/0.714, allocations: 1.37 MB / 0.7618 GB, free: 1.137 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002209/0.7162, allocations: 0.6584 MB / 0.7625 GB, free: 492 kB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.3368/1.053, allocations: 18.97 MB / 0.781 GB, free: 114.9 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004377/1.058, allocations: 1.025 MB / 0.782 GB, free: 114.8 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=94): time 6.693e-06/1.058, allocations: 0 / 0.782 GB, free: 114.8 MB / 410.7 MB
Notification: Performance of matching and sorting (n=102): time 0.02329/1.081, allocations: 5.03 MB / 0.7869 GB, free: 114.2 MB / 410.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000102/1.081, allocations: 223.7 kB / 0.7871 GB, free: 113.9 MB / 410.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002264/1.083, allocations: 1.074 MB / 0.7882 GB, free: 113.5 MB / 410.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0003108/1.084, allocations: 44.41 kB / 0.7882 GB, free: 113.5 MB / 410.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0007629/1.084, allocations: 0.6727 MB / 0.7889 GB, free: 113 MB / 410.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005907/1.085, allocations: 358.2 kB / 0.7892 GB, free: 112.7 MB / 410.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001273/1.085, allocations: 26.41 kB / 0.7893 GB, free: 112.7 MB / 410.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001341/1.085, allocations: 360.8 kB / 0.7896 GB, free: 112.4 MB / 410.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002294/1.088, allocations: 0.673 MB / 0.7903 GB, free: 112.1 MB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002572/1.09, allocations: 1.019 MB / 0.7912 GB, free: 111.5 MB / 410.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002592/1.093, allocations: 0.8326 MB / 0.7921 GB, free: 111.2 MB / 410.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.614e-05/1.093, allocations: 4 kB / 0.7921 GB, free: 111.2 MB / 410.7 MB
Notification: Performance of matching and sorting (n=166) (initialization): time 0.006369/1.099, allocations: 2.019 MB / 0.794 GB, free: 110.4 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.000276/1.1, allocations: 403.9 kB / 0.7944 GB, free: 109.9 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.833e-05/1.1, allocations: 12.44 kB / 0.7944 GB, free: 109.9 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008387/1.101, allocations: 144.2 kB / 0.7946 GB, free: 109.8 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002674/1.103, allocations: 338.7 kB / 0.7949 GB, free: 109.8 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001037/1.104, allocations: 1.255 MB / 0.7961 GB, free: 108.7 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002351/1.107, allocations: 158.1 kB / 0.7963 GB, free: 108.6 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002982/1.107, allocations: 67.19 kB / 0.7963 GB, free: 108.6 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.613e-05/1.107, allocations: 3.75 kB / 0.7963 GB, free: 108.6 MB / 410.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006064/1.113, allocations: 1.859 MB / 0.7982 GB, free: 107.9 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.658e-05/1.113, allocations: 13.09 kB / 0.7982 GB, free: 107.9 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007427/1.114, allocations: 148 kB / 0.7983 GB, free: 107.8 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002619/1.117, allocations: 321.9 kB / 0.7986 GB, free: 107.7 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001047/1.118, allocations: 1.262 MB / 0.7998 GB, free: 106.5 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002223/1.12, allocations: 153.4 kB / 0.8 GB, free: 106.5 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002874/1.12, allocations: 66.27 kB / 0.8001 GB, free: 106.4 MB / 410.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 43
 * Number of states: 0 ()
 * Number of discrete variables: 16 (pipe3.state_a.phase,pipe1.state_a.phase,valveIncompressible1.state_b.phase,valveIncompressible1.state_a.phase,$whenCondition1,source.medium.phase,pipe1.statesFM[2].phase,sink.medium.phase,pipe3.statesFM[2].phase,valveOpening1.a,valveOpening1.b,valveOpening1.last,$PRE.valveOpening1.nextEvent,valveOpening1.nextEvent,pipe3.state_b.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 (158):
 * Single equations (assignments): 153
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 1,1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.001305/1.122, allocations: 0.5421 MB / 0.8006 GB, free: 106 MB / 410.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004354/1.122, allocations: 133.8 kB / 0.8007 GB, free: 106 MB / 410.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009792/1.132, allocations: 4.728 MB / 0.8053 GB, free: 103.3 MB / 410.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007414/1.139, allocations: 3.953 MB / 0.8092 GB, free: 99.61 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.285e-05/1.139, allocations: 4 kB / 0.8092 GB, free: 99.61 MB / 410.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001304/1.141, allocations: 0.5052 MB / 0.8097 GB, free: 99.08 MB / 410.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000543/1.141, allocations: 32 kB / 0.8097 GB, free: 99.05 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001911/1.143, allocations: 151.7 kB / 0.8099 GB, free: 98.9 MB / 410.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003296/1.144, allocations: 88.88 kB / 0.8099 GB, free: 98.82 MB / 410.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.007127/1.151, allocations: 2.948 MB / 0.8128 GB, free: 95.84 MB / 410.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.00856/1.159, allocations: 4.206 MB / 0.8169 GB, free: 91.57 MB / 410.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002571/1.162, allocations: 1.317 MB / 0.8182 GB, free: 90.25 MB / 410.7 MB
Notification: Performance of sorting global known variables: time 0.001545/1.164, allocations: 0.8293 MB / 0.819 GB, free: 89.42 MB / 410.7 MB
Notification: Performance of Backend: time 9.92e-07/1.164, allocations: 0 / 0.819 GB, free: 89.42 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.01748/1.181, allocations: 4.342 MB / 0.8233 GB, free: 85.5 MB / 410.7 MB
Notification: Performance of SimCode: time 0.009745/1.191, allocations: 4.921 MB / 0.8281 GB, free: 80.57 MB / 410.7 MB
Notification: Performance of Templates: time 0.1462/1.337, allocations: 73.75 MB / 0.9001 GB, free: 7.316 MB / 410.7 MB