Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization.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.DynamicPipeInitialization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipe.mediums.1..h|pipe.mediums.1..p|pipe.mediums.2..h|pipe.mediums.2..p|pipe.mediums.3..h|pipe.mediums.3..p|pipe.mediums.4..h|pipe.mediums.4..p|pipe.mediums.5..h|pipe.mediums.5..p|m_flow_initial",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002598/0.002603, allocations: 352.4 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.364/3.364, allocations: 341.5 MB / 358.2 MB, free: 12.65 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.003536/0.003536, allocations: 221.1 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.5116/0.5116, allocations: 76.09 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004595/0.0004596, allocations: 12 kB / 0.5592 GB, free: 53.47 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08374/0.08423, allocations: 48.72 MB / 0.6068 GB, free: 4.648 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestPipesAndValves.DynamicPipeInitialization): time 0.3201/0.4044, allocations: 44.37 MB / 0.6501 GB, free: 64.3 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04028/0.4448, allocations: 24.11 MB / 0.6736 GB, free: 44.57 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00173/0.4465, allocations: 35.69 kB / 0.6737 GB, free: 44.54 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.00217/0.4488, allocations: 453.5 kB / 0.6741 GB, free: 44.09 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.01989/0.4687, allocations: 4.649 MB / 0.6786 GB, free: 39.45 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01852/0.4873, allocations: 4.106 MB / 0.6826 GB, free: 35.38 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.006174/0.4935, allocations: 4.628 MB / 0.6872 GB, free: 30.73 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001784/0.4953, allocations: 0.8444 MB / 0.688 GB, free: 29.89 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.1146/0.6099, allocations: 51.17 MB / 0.738 GB, free: 10.69 MB / 394.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.05179/0.6618, allocations: 20.62 MB / 0.7581 GB, free: 6.055 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006261/0.6624, allocations: 84 kB / 0.7582 GB, free: 5.973 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.3486/1.011, allocations: 7.866 MB / 0.7659 GB, free: 82.49 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001401/1.013, allocations: 0.7034 MB / 0.7665 GB, free: 82.49 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001019/1.014, allocations: 451.5 kB / 0.767 GB, free: 82.46 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01283/1.026, allocations: 5.248 MB / 0.7721 GB, free: 82.34 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.175e-06/1.026, allocations: 0.9688 kB / 0.7721 GB, free: 82.34 MB / 410.7 MB
Notification: Performance of FrontEnd: time 2.775e-06/1.026, allocations: 2.141 kB / 0.7721 GB, free: 82.34 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 0.0001177/1.027, allocations: 0 / 0.7721 GB, free: 82.34 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: 509
 * Number of variables: 509
Notification: Performance of Generate backend data structure: time 0.0161/1.043, allocations: 3.056 MB / 0.7751 GB, free: 81.05 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.383e-05/1.043, allocations: 12.64 kB / 0.7751 GB, free: 81.05 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007432/1.05, allocations: 0.6688 MB / 0.7758 GB, free: 80.95 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00411/1.054, allocations: 1.177 MB / 0.7769 GB, free: 80.62 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003472/1.055, allocations: 162.5 kB / 0.7771 GB, free: 80.62 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009613/1.056, allocations: 171.3 kB / 0.7772 GB, free: 80.62 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01343/1.069, allocations: 3.572 MB / 0.7807 GB, free: 80.24 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.92e-05/1.069, allocations: 7.812 kB / 0.7807 GB, free: 80.24 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004985/1.07, allocations: 72.16 kB / 0.7808 GB, free: 80.24 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003883/1.07, allocations: 222.9 kB / 0.781 GB, free: 80.24 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01493/1.085, allocations: 3.535 MB / 0.7845 GB, free: 80.22 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.03092/1.116, allocations: 14.13 MB / 0.7982 GB, free: 71.3 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.009205/1.125, allocations: 2.308 MB / 0.8005 GB, free: 70.73 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003971/1.129, allocations: 1.201 MB / 0.8017 GB, free: 70.12 MB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.2108/1.34, allocations: 64.23 MB / 0.8644 GB, free: 15.57 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007678/1.348, allocations: 1.724 MB / 0.8661 GB, free: 14.23 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=154): time 5.871e-06/1.348, allocations: 0 / 0.8661 GB, free: 14.23 MB / 426.7 MB
Notification: Performance of matching and sorting (n=174): time 0.04098/1.389, allocations: 9.473 MB / 0.8753 GB, free: 6.922 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001643/1.389, allocations: 291.8 kB / 0.8756 GB, free: 6.582 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002957/1.392, allocations: 1.318 MB / 0.8769 GB, free: 5.598 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0006125/1.393, allocations: 58.77 kB / 0.877 GB, free: 5.559 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001005/1.394, allocations: 0.8343 MB / 0.8778 GB, free: 4.957 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001171/1.395, allocations: 0.5965 MB / 0.8784 GB, free: 4.445 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002886/1.395, allocations: 44.38 kB / 0.8784 GB, free: 4.438 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002435/1.396, allocations: 390.3 kB / 0.8788 GB, free: 4.082 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004765/1.4, allocations: 1.287 MB / 0.88 GB, free: 3.199 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00555/1.406, allocations: 1.88 MB / 0.8819 GB, free: 1.539 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005278/1.411, allocations: 1.519 MB / 0.8833 GB, free: 0.5703 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.714e-05/1.411, allocations: 4 kB / 0.8833 GB, free: 0.5664 MB / 426.7 MB
Notification: Performance of matching and sorting (n=275) (initialization): time 0.01596/1.427, allocations: 4.362 MB / 0.8876 GB, free: 13.6 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0005613/1.428, allocations: 0.5911 MB / 0.8882 GB, free: 12.84 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.344e-05/1.428, allocations: 20 kB / 0.8882 GB, free: 12.82 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03029/1.458, allocations: 3.748 MB / 0.8919 GB, free: 9.484 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002636/1.461, allocations: 341.2 kB / 0.8922 GB, free: 9.188 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01354/1.475, allocations: 4.061 MB / 0.8962 GB, free: 6.211 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004462/1.479, allocations: 276.8 kB / 0.8964 GB, free: 5.977 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007125/1.48, allocations: 107.3 kB / 0.8965 GB, free: 5.891 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.881e-05/1.48, allocations: 8 kB / 0.8965 GB, free: 5.883 MB / 442.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01552/1.496, allocations: 3.975 MB / 0.9004 GB, free: 2.613 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.262e-05/1.496, allocations: 16 kB / 0.9004 GB, free: 2.598 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01871/1.514, allocations: 2.496 MB / 0.9029 GB, free: 96 kB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002948/1.517, allocations: 377.8 kB / 0.9032 GB, free: 15.75 MB / 458.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01001/1.527, allocations: 3.344 MB / 0.9065 GB, free: 12.39 MB / 458.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00416/1.532, allocations: 273.5 kB / 0.9068 GB, free: 12.12 MB / 458.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0006294/1.532, allocations: 105.3 kB / 0.9069 GB, free: 12.02 MB / 458.7 MB
Warning: Assuming fixed start value for the following 1 variables:
         m_flow_initial:DISCRETE(unit = "kg/s" fixed = true )  type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 77
 * Number of states: 0 ()
 * Number of discrete variables: 17 (source.medium.phase,$PRE.m_flow_initial,m_flow_initial,$whenCondition2,$whenCondition1,pipe.state_a.phase,valve.state_b.phase,valve.state_a.phase,pipe.statesFM[2].phase,pipe.statesFM[3].phase,pipe.statesFM[4].phase,pipe.statesFM[5].phase,pipe.statesFM[6].phase,sink.state.phase,sink.medium.phase,pipe.state_b.phase,source.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (171):
 * Single equations (assignments): 170
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * 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 {14 91}
Notification: Performance of prepare postOptimizeDAE: time 0.002411/1.535, allocations: 0.7071 MB / 0.9075 GB, free: 11.33 MB / 458.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000624/1.535, allocations: 166 kB / 0.9077 GB, free: 11.17 MB / 458.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01866/1.554, allocations: 6.843 MB / 0.9144 GB, free: 4.336 MB / 458.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01386/1.568, allocations: 5.487 MB / 0.9197 GB, free: 14.74 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.581e-05/1.568, allocations: 4 kB / 0.9197 GB, free: 14.74 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002649/1.571, allocations: 0.7545 MB / 0.9205 GB, free: 13.96 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009372/1.572, allocations: 51.98 kB / 0.9205 GB, free: 13.91 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003817/1.576, allocations: 262.4 kB / 0.9208 GB, free: 13.66 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007802/1.576, allocations: 189.7 kB / 0.921 GB, free: 13.47 MB / 474.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01561/1.592, allocations: 5.107 MB / 0.926 GB, free: 8.375 MB / 474.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01854/1.611, allocations: 7.117 MB / 0.9329 GB, free: 1.227 MB / 474.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.2869/1.898, allocations: 2.239 MB / 0.9351 GB, free: 187 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.002894/1.9, allocations: 1.234 MB / 0.9363 GB, free: 186.9 MB / 474.7 MB
Notification: Performance of Backend: time 1.092e-06/1.901, allocations: 0 / 0.9363 GB, free: 186.9 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.02837/1.929, allocations: 5.591 MB / 0.9418 GB, free: 186.8 MB / 474.7 MB
Notification: Performance of SimCode: time 0.01515/1.944, allocations: 6.515 MB / 0.9481 GB, free: 183.9 MB / 474.7 MB
Notification: Performance of Templates: time 0.1906/2.135, allocations: 92.55 MB / 1.038 GB, free: 103.9 MB / 474.7 MB