Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Fluid.TestComponents.Valves.TestValveVaporizing.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.TestComponents.Valves.TestValveVaporizing,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|SourceP1.ports.1..m_flow|SourceP1.ports.1..p|SourceP1.ports.1..h_outflow|V1.port_b.m_flow|V1.port_b.p|V1.port_b.h_outflow|V1.minLimiter.y|SinkP1.ports.1..m_flow|SinkP1.ports.1..p|SinkP1.ports.1..h_outflow|Opening.y|downstreamPressure.y",fileNamePrefix="ModelicaTest_3.2.2_ModelicaTest.Fluid.TestComponents.Valves.TestValveVaporizing")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.002727/0.002727, allocations: 363.1 kB / 15.95 MB, free: 6.203 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 3.748/3.748, allocations: 388.9 MB / 405.6 MB, free: 9.582 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.003583/0.003583, allocations: 229.4 kB / 451 MB, free: 145 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.5345/0.5345, allocations: 80.02 MB / 0.5627 GB, free: 19.76 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006549/0.0006552, allocations: 16 kB / 0.6265 GB, free: 96.52 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.101/0.1017, allocations: 54.88 MB / 0.6801 GB, free: 41.64 MB / 346.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 8.131/8.232, allocations: 2.635 GB / 3.315 GB, free: 10.62 MB / 490.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002996/8.233, allocations: 94.69 kB / 3.315 GB, free: 10.56 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.523/9.756, allocations: 235 MB / 3.545 GB, free: 74.45 MB / 490.7 MB
Notification: Performance of FrontEnd: time 2.315e-06/9.756, allocations: 0 / 3.545 GB, free: 74.45 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 4.467e-05/9.756, allocations: 12.08 kB / 3.545 GB, free: 74.45 MB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 84
 * Number of variables: 84
Notification: Performance of Generate backend data structure: time 0.006648/9.763, allocations: 1.354 MB / 3.546 GB, free: 73.82 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.14e-05/9.763, allocations: 8.938 kB / 3.546 GB, free: 73.82 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00314/9.766, allocations: 266.2 kB / 3.546 GB, free: 73.79 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001137/9.767, allocations: 425.4 kB / 3.547 GB, free: 73.58 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.098e-05/9.767, allocations: 32.33 kB / 3.547 GB, free: 73.58 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 7.602e-05/9.767, allocations: 35.11 kB / 3.547 GB, free: 73.57 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0029/9.77, allocations: 0.668 MB / 3.547 GB, free: 73.44 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.969e-05/9.77, allocations: 7.812 kB / 3.547 GB, free: 73.44 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.021e-05/9.77, allocations: 14.44 kB / 3.547 GB, free: 73.44 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.335e-05/9.77, allocations: 6.781 kB / 3.547 GB, free: 73.44 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003448/9.774, allocations: 0.652 MB / 3.548 GB, free: 73.44 MB / 490.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.004766/9.779, allocations: 2.765 MB / 3.551 GB, free: 71.45 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002855/9.781, allocations: 0.5074 MB / 3.551 GB, free: 71.43 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001005/9.782, allocations: 204.6 kB / 3.551 GB, free: 71.42 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.1846/9.967, allocations: 51.48 MB / 3.602 GB, free: 43.18 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.586e-05/9.967, allocations: 40.81 kB / 3.602 GB, free: 43.14 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=27): time 3.577e-06/9.967, allocations: 0 / 3.602 GB, free: 43.14 MB / 490.7 MB
Notification: Performance of matching and sorting (n=27): time 0.005018/9.972, allocations: 0.8714 MB / 3.602 GB, free: 43.07 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.332e-05/9.972, allocations: 115.3 kB / 3.603 GB, free: 42.94 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006009/9.973, allocations: 344 kB / 3.603 GB, free: 42.82 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 7.621e-05/9.973, allocations: 33.36 kB / 3.603 GB, free: 42.79 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001592/9.973, allocations: 240.6 kB / 3.603 GB, free: 42.66 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001032/9.973, allocations: 89.39 kB / 3.603 GB, free: 42.62 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.138e-05/9.973, allocations: 14.2 kB / 3.603 GB, free: 42.62 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 9.262e-05/9.973, allocations: 343.9 kB / 3.604 GB, free: 42.3 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009312/9.974, allocations: 180.5 kB / 3.604 GB, free: 42.3 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001013/9.975, allocations: 313.4 kB / 3.604 GB, free: 42.13 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001021/9.976, allocations: 202.5 kB / 3.604 GB, free: 42.12 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.272e-06/9.977, allocations: 4 kB / 3.604 GB, free: 42.12 MB / 490.7 MB
Notification: Performance of matching and sorting (n=44) (initialization): time 0.002357/9.979, allocations: 0.5297 MB / 3.605 GB, free: 42.05 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001434/9.979, allocations: 202 kB / 3.605 GB, free: 41.83 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.233e-05/9.979, allocations: 7.719 kB / 3.605 GB, free: 41.83 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.127e-05/9.979, allocations: 6.75 kB / 3.605 GB, free: 41.83 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008855/9.98, allocations: 114.1 kB / 3.605 GB, free: 41.83 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.794e-05/9.98, allocations: 12.3 kB / 3.605 GB, free: 41.83 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009273/9.981, allocations: 90.42 kB / 3.605 GB, free: 41.81 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.459e-05/9.981, allocations: 25.86 kB / 3.605 GB, free: 41.81 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.22e-05/9.981, allocations: 3 kB / 3.605 GB, free: 41.81 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002201/9.983, allocations: 477.2 kB / 3.606 GB, free: 41.79 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.066e-05/9.983, allocations: 8.031 kB / 3.606 GB, free: 41.79 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 1.308e-05/9.983, allocations: 7.453 kB / 3.606 GB, free: 41.79 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008481/9.984, allocations: 118.4 kB / 3.606 GB, free: 41.79 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.258e-05/9.984, allocations: 9.469 kB / 3.606 GB, free: 41.79 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008751/9.985, allocations: 82.62 kB / 3.606 GB, free: 41.77 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.085e-05/9.985, allocations: 25.83 kB / 3.606 GB, free: 41.77 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 4 (SourceP1.medium.phase,SinkP1.medium.phase,V1.state_b.phase,V1.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (44):
 * Single equations (assignments): 44
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003772/9.986, allocations: 238.4 kB / 3.606 GB, free: 41.58 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001311/9.986, allocations: 45.19 kB / 3.606 GB, free: 41.57 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004031/9.99, allocations: 1.981 MB / 3.608 GB, free: 41.34 MB / 490.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.2e-05/9.99, allocations: 31.47 kB / 3.608 GB, free: 41.34 MB / 490.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.654e-06/9.99, allocations: 0 / 3.608 GB, free: 41.34 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.015e-05/9.99, allocations: 3.938 kB / 3.608 GB, free: 41.34 MB / 490.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001519/9.991, allocations: 1.023 MB / 3.609 GB, free: 41.09 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.262e-06/9.992, allocations: 0 / 3.609 GB, free: 41.09 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007677/9.992, allocations: 102 kB / 3.609 GB, free: 41.08 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 7.714e-06/9.992, allocations: 0 / 3.609 GB, free: 41.08 MB / 490.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.389e-05/9.992, allocations: 7.781 kB / 3.609 GB, free: 41.08 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.326e-06/9.992, allocations: 7.422 kB / 3.609 GB, free: 41.08 MB / 490.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.364e-06/9.992, allocations: 6.062 kB / 3.609 GB, free: 41.07 MB / 490.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002721/9.995, allocations: 1.144 MB / 3.61 GB, free: 40.84 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000434/9.996, allocations: 250.1 kB / 3.611 GB, free: 40.66 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001074/9.996, allocations: 6.781 kB / 3.611 GB, free: 40.66 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007399/9.996, allocations: 65.42 kB / 3.611 GB, free: 40.66 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001265/9.997, allocations: 33.58 kB / 3.611 GB, free: 40.65 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.1e-05/9.997, allocations: 20.86 kB / 3.611 GB, free: 40.65 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.0005517/9.997, allocations: 306.8 kB / 3.611 GB, free: 40.57 MB / 490.7 MB
Notification: Performance of sort global known variables: time 5.11e-07/9.997, allocations: 4 kB / 3.611 GB, free: 40.57 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.006005/10, allocations: 1.157 MB / 3.612 GB, free: 40.39 MB / 490.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 18 ($cse1.phase,$cse1.region,$cse2.phase,$cse2.region,$cse3.region3boundary,$cse4.region3boundary,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse13.phase,$cse13.region,SourceP1.medium.phase,SinkP1.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (38):
 * Single equations (assignments): 29
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 9
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.01037/10.01, allocations: 1.415 MB / 3.614 GB, free: 40.08 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.003533/10.02, allocations: 0.9261 MB / 3.614 GB, free: 40.04 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 6.682e-06/10.02, allocations: 0 / 3.614 GB, free: 40.04 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001309/10.02, allocations: 0.5444 MB / 3.615 GB, free: 40.04 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002088/10.02, allocations: 206.5 kB / 3.615 GB, free: 40.02 MB / 490.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1076/10.13, allocations: 39.6 MB / 3.654 GB, free: 32.11 MB / 490.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004818/10.13, allocations: 1.001 MB / 3.655 GB, free: 31.39 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.001391/10.13, allocations: 0.5143 MB / 3.655 GB, free: 31.36 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001899/10.13, allocations: 48.17 kB / 3.655 GB, free: 31.35 MB / 490.7 MB
Notification: Performance of SimCode: time 1.403e-06/10.13, allocations: 0 / 3.655 GB, free: 31.35 MB / 490.7 MB
Notification: Performance of Templates: time 0.07307/10.2, allocations: 34.78 MB / 3.689 GB, free: 11.59 MB / 490.7 MB