Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.TestComponents.Valves.TestValveVaporizing.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: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Valves.TestValveVaporizing,fileNamePrefix="ModelicaTest_3_2_1_ModelicaTest_Fluid_TestComponents_Valves_TestValveVaporizing",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.01472/0.01472, allocations: 164.5 kB / 15.11 MB, free: 5.934 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 1.674/1.674, allocations: 170.8 MB / 186.6 MB, free: 1.125 MB / 154.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.001952/0.001952, allocations: 107.3 kB / 226.2 MB, free: 10.1 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.4313/0.4313, allocations: 38.05 MB / 303.7 MB, free: 42.36 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004705/0.0004706, allocations: 12 kB / 363 MB, free: 5.512 MB / 266.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1031/0.1036, allocations: 48.71 MB / 411.7 MB, free: 4.727 MB / 314.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 7.779/7.883, allocations: 2.524 GB / 2.926 GB, free: 26.34 MB / 426.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002698/7.883, allocations: 89.7 kB / 2.926 GB, free: 26.29 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.444/9.328, allocations: 231.9 MB / 3.153 GB, free: 44.64 MB / 426.7 MB
Notification: Performance of FrontEnd: time 2.374e-06/9.328, allocations: 0 / 3.153 GB, free: 44.64 MB / 426.7 MB
Notification: Performance of Transformations before backend: time 4.586e-05/9.328, allocations: 11.69 kB / 3.153 GB, free: 44.64 MB / 426.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.006651/9.334, allocations: 1.336 MB / 3.154 GB, free: 43.96 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.847e-05/9.335, allocations: 11.91 kB / 3.154 GB, free: 43.96 MB / 426.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001769/9.335, allocations: 75 kB / 3.154 GB, free: 43.93 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002989/9.338, allocations: 244.1 kB / 3.154 GB, free: 43.9 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001081/9.339, allocations: 426.6 kB / 3.155 GB, free: 43.68 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.235e-05/9.339, allocations: 32.88 kB / 3.155 GB, free: 43.68 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 8.278e-05/9.339, allocations: 36.89 kB / 3.155 GB, free: 43.68 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002833/9.342, allocations: 0.6687 MB / 3.156 GB, free: 43.54 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.186e-05/9.342, allocations: 4.312 kB / 3.156 GB, free: 43.54 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.898e-05/9.342, allocations: 18.28 kB / 3.156 GB, free: 43.54 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.625e-05/9.342, allocations: 13.2 kB / 3.156 GB, free: 43.54 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003198/9.345, allocations: 0.6483 MB / 3.156 GB, free: 43.54 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.004389/9.35, allocations: 2.769 MB / 3.159 GB, free: 41.55 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002733/9.352, allocations: 0.5012 MB / 3.159 GB, free: 41.52 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.1899/9.542, allocations: 51.43 MB / 3.21 GB, free: 29.08 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.978e-05/9.542, allocations: 35.12 kB / 3.21 GB, free: 29.04 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=27): time 2.786e-06/9.542, allocations: 3.594 kB / 3.21 GB, free: 29.04 MB / 442.7 MB
Notification: Performance of matching and sorting (n=27): time 0.005068/9.548, allocations: 0.8672 MB / 3.211 GB, free: 28.97 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.32e-05/9.548, allocations: 110.1 kB / 3.211 GB, free: 28.84 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000568/9.548, allocations: 307.5 kB / 3.211 GB, free: 28.74 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.734e-05/9.548, allocations: 33.39 kB / 3.211 GB, free: 28.7 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001853/9.549, allocations: 249.9 kB / 3.211 GB, free: 28.55 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 9.995e-05/9.549, allocations: 88.59 kB / 3.211 GB, free: 28.5 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.596e-05/9.549, allocations: 6.625 kB / 3.211 GB, free: 28.5 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001641/9.549, allocations: 344 kB / 3.212 GB, free: 28.19 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009375/9.55, allocations: 183.7 kB / 3.212 GB, free: 28.18 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001/9.551, allocations: 311.3 kB / 3.212 GB, free: 28.02 MB / 442.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009843/9.552, allocations: 212.2 kB / 3.212 GB, free: 28 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.893e-06/9.552, allocations: 0 / 3.212 GB, free: 28 MB / 442.7 MB
Notification: Performance of matching and sorting (n=44) (initialization): time 0.002444/9.554, allocations: 0.5289 MB / 3.213 GB, free: 27.93 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0006643/9.555, allocations: 1.485 MB / 3.214 GB, free: 26.37 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.642e-05/9.555, allocations: 3.562 kB / 3.214 GB, free: 26.37 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.622e-05/9.555, allocations: 7.25 kB / 3.214 GB, free: 26.37 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009768/9.556, allocations: 124.6 kB / 3.214 GB, free: 26.36 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.993e-05/9.556, allocations: 12.64 kB / 3.214 GB, free: 26.36 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000895/9.557, allocations: 87.89 kB / 3.215 GB, free: 26.34 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.256e-05/9.557, allocations: 20.28 kB / 3.215 GB, free: 26.34 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.301e-05/9.557, allocations: 3.719 kB / 3.215 GB, free: 26.34 MB / 442.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002169/9.559, allocations: 480.7 kB / 3.215 GB, free: 26.31 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.897e-06/9.559, allocations: 3.594 kB / 3.215 GB, free: 26.31 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 1.27e-05/9.559, allocations: 7.938 kB / 3.215 GB, free: 26.31 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008532/9.56, allocations: 127 kB / 3.215 GB, free: 26.3 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.114e-05/9.56, allocations: 3.312 kB / 3.215 GB, free: 26.3 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008278/9.561, allocations: 76 kB / 3.215 GB, free: 26.28 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.962e-05/9.561, allocations: 24 kB / 3.215 GB, free: 26.28 MB / 442.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.0004519/9.562, allocations: 252.8 kB / 3.215 GB, free: 26.08 MB / 442.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001333/9.562, allocations: 33.28 kB / 3.215 GB, free: 26.06 MB / 442.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004/9.566, allocations: 1.989 MB / 3.217 GB, free: 25.79 MB / 442.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.207e-05/9.566, allocations: 28.97 kB / 3.217 GB, free: 25.78 MB / 442.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.205e-06/9.566, allocations: 0 / 3.217 GB, free: 25.78 MB / 442.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.117e-06/9.566, allocations: 3.797 kB / 3.217 GB, free: 25.78 MB / 442.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001478/9.567, allocations: 1.031 MB / 3.218 GB, free: 25.19 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.562e-06/9.567, allocations: 0 / 3.218 GB, free: 25.19 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007678/9.568, allocations: 96.11 kB / 3.219 GB, free: 25.18 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 9.388e-06/9.568, allocations: 3.594 kB / 3.219 GB, free: 25.18 MB / 442.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.786e-05/9.568, allocations: 11.66 kB / 3.219 GB, free: 25.17 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.48e-06/9.568, allocations: 0 / 3.219 GB, free: 25.17 MB / 442.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.394e-06/9.568, allocations: 0 / 3.219 GB, free: 25.17 MB / 442.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00266/9.571, allocations: 1.152 MB / 3.22 GB, free: 24.61 MB / 442.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004293/9.571, allocations: 254 kB / 3.22 GB, free: 24.41 MB / 442.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001049/9.572, allocations: 8 kB / 3.22 GB, free: 24.41 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007438/9.572, allocations: 61.22 kB / 3.22 GB, free: 24.39 MB / 442.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001219/9.572, allocations: 33.53 kB / 3.22 GB, free: 24.39 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.831e-05/9.573, allocations: 6.906 kB / 3.22 GB, free: 24.39 MB / 442.7 MB
Notification: Performance of sorting global known variables: time 0.0005572/9.573, allocations: 311.6 kB / 3.22 GB, free: 24.24 MB / 442.7 MB
Notification: Performance of sort global known variables: time 4.91e-07/9.573, allocations: 0 / 3.22 GB, free: 24.24 MB / 442.7 MB
Notification: Performance of remove unused functions: time 0.005928/9.579, allocations: 1.155 MB / 3.221 GB, free: 24 MB / 442.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.01357/9.593, allocations: 3.014 MB / 3.224 GB, free: 22.66 MB / 442.7 MB
Notification: Performance of simCode: created initialization part: time 0.003461/9.596, allocations: 0.924 MB / 3.225 GB, free: 22.36 MB / 442.7 MB
Notification: Performance of simCode: created event and clocks part: time 7.394e-06/9.596, allocations: 3.188 kB / 3.225 GB, free: 22.36 MB / 442.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001259/9.598, allocations: 0.5396 MB / 3.226 GB, free: 22.12 MB / 442.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001819/9.599, allocations: 206.8 kB / 3.226 GB, free: 22.06 MB / 442.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.5896/10.19, allocations: 80.8 MB / 3.305 GB, free: 52.09 MB / 442.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004861/10.19, allocations: 0.9951 MB / 3.306 GB, free: 51.39 MB / 442.7 MB
Notification: Performance of simCode: alias equations: time 0.001357/10.19, allocations: 0.5257 MB / 3.306 GB, free: 51.38 MB / 442.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004646/10.19, allocations: 268.9 kB / 3.307 GB, free: 51.38 MB / 442.7 MB
Notification: Performance of SimCode: time 1.182e-06/10.19, allocations: 0 / 3.307 GB, free: 51.38 MB / 442.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1064/10.3, allocations: 40.1 MB / 3.346 GB, free: 50.7 MB / 442.7 MB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002462/10.3, allocations: 234.5 kB / 3.346 GB, free: 50.46 MB / 442.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 4.313/14.61, allocations: 0 / 3.346 GB, free: 50.46 MB / 442.7 MB
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_3.2.1_ModelicaTest.Fluid.TestComponents.Valves.TestValveVaporizing_res.mat does not exist to compare? outputFormat=mat