Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false)
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97OnePhase_ph",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97OnePhase_ph",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001681/0.001681, allocations: 198.9 kB / 17.08 MB, free: 5.078 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.548/1.548, allocations: 227.2 MB / 245 MB, free: 7.664 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001632/0.001632, allocations: 105.2 kB / 297.3 MB, free: 6.188 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.4691/0.4691, allocations: 45.22 MB / 394.6 MB, free: 31.65 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003496/0.0003501, allocations: 8.219 kB / 468.5 MB, free: 7.621 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.521/0.5214, allocations: 63.24 MB / 0.5193 GB, free: 44.15 MB / 394.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 6.917/7.439, allocations: 2.802 GB / 3.321 GB, free: 108.9 MB / 0.5417 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003904/7.439, allocations: 102.7 kB / 3.321 GB, free: 108.8 MB / 0.5417 GB
Notification: Performance of FrontEnd - DAE generated: time 1.889/9.328, allocations: 0.4998 GB / 3.821 GB, free: 38.62 MB / 0.5417 GB
Notification: Performance of FrontEnd: time 1.263e-06/9.328, allocations: 0 / 3.821 GB, free: 38.62 MB / 0.5417 GB
Notification: Performance of Transformations before backend: time 8.967e-05/9.329, allocations: 20 kB / 3.821 GB, free: 38.61 MB / 0.5417 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 160
 * Number of variables: 160
Notification: Performance of Generate backend data structure: time 0.008367/9.337, allocations: 1.799 MB / 3.823 GB, free: 36.81 MB / 0.5417 GB
Notification: Performance of prepare preOptimizeDAE: time 4.979e-05/9.337, allocations: 12.56 kB / 3.823 GB, free: 36.8 MB / 0.5417 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0004573/9.337, allocations: 115.2 kB / 3.823 GB, free: 36.68 MB / 0.5417 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002843/9.34, allocations: 327.8 kB / 3.823 GB, free: 36.37 MB / 0.5417 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002032/9.342, allocations: 0.5954 MB / 3.824 GB, free: 35.74 MB / 0.5417 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00018/9.343, allocations: 116.5 kB / 3.824 GB, free: 35.62 MB / 0.5417 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003021/9.343, allocations: 56 kB / 3.824 GB, free: 35.56 MB / 0.5417 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002965/9.346, allocations: 1.174 MB / 3.825 GB, free: 34.3 MB / 0.5417 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.171e-05/9.346, allocations: 3.938 kB / 3.825 GB, free: 34.3 MB / 0.5417 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001549/9.346, allocations: 29.8 kB / 3.825 GB, free: 34.27 MB / 0.5417 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.732e-05/9.346, allocations: 45.3 kB / 3.825 GB, free: 34.22 MB / 0.5417 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001907/9.348, allocations: 0.8281 MB / 3.826 GB, free: 33.4 MB / 0.5417 GB
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.006829/9.355, allocations: 5.502 MB / 3.831 GB, free: 27.6 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00115/9.356, allocations: 0.5763 MB / 3.832 GB, free: 27.01 MB / 0.5417 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.501/9.857, allocations: 51.04 MB / 3.882 GB, free: 66.01 MB / 0.5573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.004e-05/9.857, allocations: 38.48 kB / 3.882 GB, free: 65.97 MB / 0.5573 GB
Notification: Performance of pre-optimization done (n=42): time 2.154e-06/9.857, allocations: 0 / 3.882 GB, free: 65.97 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=46): time 0.005606/9.863, allocations: 1.944 MB / 3.883 GB, free: 65.57 MB / 0.5573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.295e-05/9.863, allocations: 161.5 kB / 3.884 GB, free: 65.38 MB / 0.5573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007208/9.864, allocations: 0.5479 MB / 3.884 GB, free: 65.25 MB / 0.5573 GB
Notification: Performance of collectPreVariables (initialization): time 5.453e-05/9.864, allocations: 39.86 kB / 3.884 GB, free: 65.21 MB / 0.5573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002519/9.864, allocations: 389.9 kB / 3.885 GB, free: 65.04 MB / 0.5573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000158/9.864, allocations: 167.5 kB / 3.885 GB, free: 64.96 MB / 0.5573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.522e-05/9.864, allocations: 15.06 kB / 3.885 GB, free: 64.96 MB / 0.5573 GB
Notification: Performance of setup shared object (initialization): time 0.0001145/9.864, allocations: 372.9 kB / 3.885 GB, free: 64.64 MB / 0.5573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003222/9.865, allocations: 225.2 kB / 3.885 GB, free: 64.64 MB / 0.5573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004898/9.865, allocations: 0.5624 MB / 3.886 GB, free: 64.22 MB / 0.5573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0004492/9.866, allocations: 329.9 kB / 3.886 GB, free: 64.22 MB / 0.5573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.809e-06/9.866, allocations: 2.938 kB / 3.886 GB, free: 64.22 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=96) (initialization): time 0.001268/9.867, allocations: 0.8723 MB / 3.887 GB, free: 64.13 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 2.042e-05/9.867, allocations: 11.05 kB / 3.887 GB, free: 64.13 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.07e-05/9.867, allocations: 11.53 kB / 3.887 GB, free: 64.13 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002807/9.867, allocations: 69.95 kB / 3.887 GB, free: 64.12 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001132/9.868, allocations: 282 kB / 3.887 GB, free: 64.12 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001307/9.87, allocations: 1.973 MB / 3.889 GB, free: 62.29 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007811/9.87, allocations: 68.59 kB / 3.889 GB, free: 62.29 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.724e-05/9.871, allocations: 43.44 kB / 3.889 GB, free: 62.29 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 50
 * Number of states: 0 ()
 * Number of discrete variables: 10 (ambient.medium.phase,fixedMassFlowRate.medium.phase,volume.medium.phase,volume.regularFlow[1],volume.regularFlow[2],volume.inFlow[2],volume.inFlow[1],shortPipe.flowModel.states[2].phase,shortPipe.flowModel.states[1].phase,ambient.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (95):
 * Single equations (assignments): 93
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.0004582/9.871, allocations: 270.8 kB / 3.89 GB, free: 62.18 MB / 0.5573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001267/9.871, allocations: 74.44 kB / 3.89 GB, free: 62.14 MB / 0.5573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002108/9.873, allocations: 2.228 MB / 3.892 GB, free: 61.89 MB / 0.5573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.691e-05/9.873, allocations: 31.5 kB / 3.892 GB, free: 61.89 MB / 0.5573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.176e-06/9.873, allocations: 0 / 3.892 GB, free: 61.89 MB / 0.5573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.326e-06/9.873, allocations: 6.891 kB / 3.892 GB, free: 61.88 MB / 0.5573 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003289/9.877, allocations: 3.285 MB / 3.895 GB, free: 61.44 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.492e-06/9.877, allocations: 3.312 kB / 3.895 GB, free: 61.44 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000906/9.878, allocations: 190.7 kB / 3.895 GB, free: 61.44 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003805/9.878, allocations: 91.52 kB / 3.895 GB, free: 61.43 MB / 0.5573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.49e-05/9.878, allocations: 18.81 kB / 3.895 GB, free: 61.42 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001156/9.879, allocations: 2.006 MB / 3.897 GB, free: 59.59 MB / 0.5573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.064e-06/9.879, allocations: 3.094 kB / 3.897 GB, free: 59.59 MB / 0.5573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00205/9.881, allocations: 1.984 MB / 3.899 GB, free: 59.23 MB / 0.5573 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000519/9.882, allocations: 287.6 kB / 3.9 GB, free: 59.08 MB / 0.5573 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.991e-05/9.882, allocations: 11.94 kB / 3.9 GB, free: 59.08 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005814/9.882, allocations: 63.14 kB / 3.9 GB, free: 59.07 MB / 0.5573 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.049e-05/9.882, allocations: 34.22 kB / 3.9 GB, free: 59.07 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.582e-05/9.883, allocations: 21 kB / 3.9 GB, free: 59.07 MB / 0.5573 GB
Notification: Performance of sorting global known variables: time 0.0006417/9.883, allocations: 0.503 MB / 3.9 GB, free: 58.98 MB / 0.5573 GB
Notification: Performance of sort global known variables: time 1.9e-07/9.883, allocations: 1.125 kB / 3.9 GB, free: 58.98 MB / 0.5573 GB
Notification: Performance of remove unused functions: time 0.006554/9.89, allocations: 1.142 MB / 3.901 GB, free: 58.98 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 2 (volume.medium.p,volume.medium.h)
 * Number of discrete variables: 16 ($cse2.phase,$cse2.region,$cse3.phase,$cse3.region,$cse4.phase,$cse4.region,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,$cse7.phase,$cse7.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (53):
 * Single equations (assignments): 43
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 8
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 1}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01122/9.901, allocations: 4.07 MB / 3.905 GB, free: 58.01 MB / 0.5573 GB
Notification: Performance of simCode: created initialization part: time 0.002004/9.903, allocations: 0.9126 MB / 3.906 GB, free: 57.99 MB / 0.5573 GB
Notification: Performance of simCode: created event and clocks part: time 7.143e-06/9.903, allocations: 4.531 kB / 3.906 GB, free: 57.99 MB / 0.5573 GB
Notification: Performance of simCode: created simulation system equations: time 0.001114/9.904, allocations: 0.6661 MB / 3.907 GB, free: 57.99 MB / 0.5573 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002027/9.906, allocations: 355.3 kB / 3.907 GB, free: 57.98 MB / 0.5573 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01465/9.921, allocations: 13.24 MB / 3.92 GB, free: 48.57 MB / 0.5573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000725/9.922, allocations: 1.135 MB / 3.921 GB, free: 47.87 MB / 0.5573 GB
Notification: Performance of simCode: alias equations: time 0.001223/9.923, allocations: 452.9 kB / 3.922 GB, free: 47.86 MB / 0.5573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004367/9.923, allocations: 393.6 kB / 3.922 GB, free: 47.86 MB / 0.5573 GB
Notification: Performance of SimCode: time 1.372e-06/9.923, allocations: 0 / 3.922 GB, free: 47.86 MB / 0.5573 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09572/10.02, allocations: 51.24 MB / 3.972 GB, free: 46.59 MB / 0.5573 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001813/10.02, allocations: 285.1 kB / 3.972 GB, free: 46.23 MB / 0.5573 GB
Notification: Performance of buildModelFMU: Generate platform static: time 3.701/13.72, allocations: 3.094 kB / 3.972 GB, free: 46.23 MB / 0.5573 GB
(rm -f ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator -r=ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph_res.mat --tempDir=temp_ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97OnePhase_ph_fmu --startTime=0 --stopTime=1.01 --timeout=50 --tolerance=1e-06 ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97OnePhase_ph.fmu > ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph.pipe 2>&1)
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97OnePhase_ph_res.mat does not exist to compare? outputFormat=mat