Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes1.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.SeriesPipes1,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.2_ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes1")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.003994/0.003994, allocations: 364.4 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 4.059/4.059, allocations: 388.9 MB / 405.6 MB, free: 10.24 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.003496/0.003496, allocations: 232.5 kB / 451 MB, free: 145.1 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.5568/0.5568, allocations: 80.03 MB / 0.5627 GB, free: 19.84 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004618/0.0004622, allocations: 12 kB / 0.6265 GB, free: 96.56 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1193/0.1198, allocations: 54.87 MB / 0.6801 GB, free: 41.67 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.SeriesPipes1): time 0.5986/0.7185, allocations: 86.66 MB / 0.7647 GB, free: 436 kB / 346.7 MB
Notification: Performance of NFInst.instExpressions: time 0.1009/0.8195, allocations: 35.11 MB / 0.799 GB, free: 2.301 MB / 378.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003451/0.823, allocations: 99.25 kB / 0.7991 GB, free: 2.203 MB / 378.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.004495/0.8276, allocations: 0.9478 MB / 0.8 GB, free: 1.25 MB / 378.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.02741/0.855, allocations: 6.668 MB / 0.8065 GB, free: 10.57 MB / 394.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.03437/0.8894, allocations: 7.089 MB / 0.8135 GB, free: 3.508 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01365/0.9031, allocations: 7.891 MB / 0.8212 GB, free: 11.6 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003233/0.9064, allocations: 1.226 MB / 0.8224 GB, free: 10.36 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006559/0.913, allocations: 2.156 MB / 0.8245 GB, free: 8.195 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0553/0.9684, allocations: 22.12 MB / 0.8461 GB, free: 2.062 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0008896/0.9693, allocations: 108 kB / 0.8462 GB, free: 1.957 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.03029/0.9996, allocations: 9.621 MB / 0.8556 GB, free: 8.324 MB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.002186/1.002, allocations: 0.81 MB / 0.8564 GB, free: 7.512 MB / 442.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001632/1.004, allocations: 0.5083 MB / 0.8569 GB, free: 6.996 MB / 442.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01709/1.021, allocations: 6.525 MB / 0.8632 GB, free: 468 kB / 442.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.983e-06/1.021, allocations: 7.938 kB / 0.8632 GB, free: 460 kB / 442.7 MB
Notification: Performance of FrontEnd: time 2.655e-06/1.021, allocations: 0 / 0.8632 GB, free: 460 kB / 442.7 MB
Notification: Performance of Transformations before backend: time 0.0001232/1.021, allocations: 0 / 0.8632 GB, free: 460 kB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 512
 * Number of variables: 512
Notification: Performance of Generate backend data structure: time 0.01446/1.035, allocations: 3.607 MB / 0.8668 GB, free: 12.77 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.068e-05/1.035, allocations: 8.031 kB / 0.8668 GB, free: 12.77 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008346/1.044, allocations: 0.8361 MB / 0.8676 GB, free: 11.93 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01872/1.063, allocations: 6.535 MB / 0.874 GB, free: 5.328 MB / 458.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003704/1.063, allocations: 183.7 kB / 0.8741 GB, free: 5.148 MB / 458.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0007638/1.064, allocations: 192 kB / 0.8743 GB, free: 4.961 MB / 458.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01275/1.077, allocations: 3.5 MB / 0.8777 GB, free: 1.301 MB / 458.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.801e-05/1.077, allocations: 11.92 kB / 0.8778 GB, free: 1.289 MB / 458.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003829/1.077, allocations: 91.92 kB / 0.8778 GB, free: 1.199 MB / 458.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004256/1.078, allocations: 187.5 kB / 0.878 GB, free: 1.016 MB / 458.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01355/1.091, allocations: 3.277 MB / 0.8812 GB, free: 13.73 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.04336/1.134, allocations: 14.98 MB / 0.8958 GB, free: 13.5 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01571/1.15, allocations: 2.31 MB / 0.8981 GB, free: 11.18 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005715/1.156, allocations: 1.133 MB / 0.8992 GB, free: 10.05 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.4163/1.572, allocations: 19.02 MB / 0.9178 GB, free: 170.6 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007307/1.58, allocations: 1.627 MB / 0.9194 GB, free: 170.5 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=155): time 7.654e-06/1.58, allocations: 3.906 kB / 0.9194 GB, free: 170.5 MB / 490.7 MB
Notification: Performance of matching and sorting (n=171): time 0.04021/1.62, allocations: 8.751 MB / 0.9279 GB, free: 168 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.268e-05/1.62, allocations: 230.4 kB / 0.9281 GB, free: 167.8 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003382/1.624, allocations: 1.558 MB / 0.9297 GB, free: 167.2 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0004618/1.624, allocations: 62.48 kB / 0.9297 GB, free: 167.1 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001079/1.625, allocations: 1.004 MB / 0.9307 GB, free: 166.4 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001004/1.626, allocations: 0.5838 MB / 0.9313 GB, free: 165.9 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002368/1.626, allocations: 41.56 kB / 0.9313 GB, free: 165.9 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001745/1.627, allocations: 390.1 kB / 0.9317 GB, free: 165.6 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003799/1.63, allocations: 1.14 MB / 0.9328 GB, free: 165.2 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004211/1.635, allocations: 1.677 MB / 0.9344 GB, free: 164.2 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004138/1.639, allocations: 1.381 MB / 0.9358 GB, free: 163.5 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.532e-05/1.639, allocations: 3.906 kB / 0.9358 GB, free: 163.5 MB / 490.7 MB
Notification: Performance of matching and sorting (n=270) (initialization): time 0.01591/1.655, allocations: 3.337 MB / 0.9391 GB, free: 161.8 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0005239/1.656, allocations: 0.5588 MB / 0.9396 GB, free: 161.1 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.657e-05/1.656, allocations: 23.72 kB / 0.9396 GB, free: 161.1 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002419/1.658, allocations: 277.3 kB / 0.9399 GB, free: 160.9 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00679/1.665, allocations: 0.5264 MB / 0.9404 GB, free: 160.8 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002869/1.668, allocations: 2.503 MB / 0.9428 GB, free: 158.4 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005844/1.674, allocations: 260.4 kB / 0.9431 GB, free: 158.3 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008099/1.675, allocations: 103.3 kB / 0.9432 GB, free: 158.3 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.988e-05/1.675, allocations: 3.344 kB / 0.9432 GB, free: 158.3 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.009867/1.685, allocations: 3.086 MB / 0.9462 GB, free: 156.3 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.327e-05/1.685, allocations: 19.98 kB / 0.9462 GB, free: 156.3 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001389/1.686, allocations: 275.3 kB / 0.9465 GB, free: 156 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004122/1.69, allocations: 0.5305 MB / 0.947 GB, free: 155.5 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00185/1.692, allocations: 2.498 MB / 0.9494 GB, free: 152.9 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00362/1.696, allocations: 255.6 kB / 0.9497 GB, free: 152.6 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005095/1.696, allocations: 108 kB / 0.9498 GB, free: 152.5 MB / 490.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: 23 (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,valveOpening1.nextEventScaled,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 (258):
 * Single equations (assignments): 251
 * 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: 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.002021/1.698, allocations: 0.733 MB / 0.9505 GB, free: 151.8 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006657/1.699, allocations: 197.6 kB / 0.9507 GB, free: 151.6 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01579/1.715, allocations: 7.737 MB / 0.9583 GB, free: 143.7 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01249/1.727, allocations: 6.639 MB / 0.9647 GB, free: 136.9 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.331e-05/1.728, allocations: 0 / 0.9647 GB, free: 136.9 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002003/1.73, allocations: 0.7331 MB / 0.9655 GB, free: 136.2 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008574/1.73, allocations: 51.98 kB / 0.9655 GB, free: 136.1 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003202/1.734, allocations: 243.6 kB / 0.9657 GB, free: 135.9 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005853/1.734, allocations: 141.8 kB / 0.9659 GB, free: 135.8 MB / 490.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01252/1.747, allocations: 4.835 MB / 0.9706 GB, free: 130.9 MB / 490.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01434/1.761, allocations: 6.891 MB / 0.9773 GB, free: 123.8 MB / 490.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004329/1.766, allocations: 2.247 MB / 0.9795 GB, free: 121.6 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.002332/1.768, allocations: 1.151 MB / 0.9806 GB, free: 120.4 MB / 490.7 MB
Notification: Performance of Backend: time 1.243e-06/1.768, allocations: 0 / 0.9806 GB, free: 120.4 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.02396/1.792, allocations: 6.106 MB / 0.9866 GB, free: 114.8 MB / 490.7 MB
Notification: Performance of SimCode: time 0.0148/1.807, allocations: 7.192 MB / 0.9936 GB, free: 107.6 MB / 490.7 MB
Notification: Performance of Templates: time 0.1924/1.999, allocations: 94.76 MB / 1.086 GB, free: 12.98 MB / 490.7 MB