Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_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.WaterIF97_ph,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97_ph",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97_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.001665/0.001665, allocations: 202.7 kB / 17.08 MB, free: 5.062 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.63/1.63, allocations: 227.2 MB / 245 MB, free: 7.605 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.0009394/0.0009397, allocations: 102.8 kB / 297.3 MB, free: 6.18 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.6868/0.6868, allocations: 45.22 MB / 394.6 MB, free: 31.65 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003824/0.0003823, allocations: 4 kB / 468.5 MB, free: 7.605 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5399/0.5403, allocations: 63.24 MB / 0.5193 GB, free: 43.88 MB / 394.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 6.777/7.317, allocations: 2.802 GB / 3.321 GB, free: 160.8 MB / 0.5417 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002836/7.317, allocations: 101 kB / 3.321 GB, free: 160.8 MB / 0.5417 GB
Notification: Performance of FrontEnd - DAE generated: time 1.907/9.224, allocations: 0.4997 GB / 3.821 GB, free: 62.9 MB / 0.5417 GB
Notification: Performance of FrontEnd: time 1.513e-06/9.224, allocations: 2.438 kB / 3.821 GB, free: 62.9 MB / 0.5417 GB
Notification: Performance of Transformations before backend: time 0.0001236/9.224, allocations: 18.09 kB / 3.821 GB, free: 62.9 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.008302/9.232, allocations: 1.845 MB / 3.822 GB, free: 61.96 MB / 0.5417 GB
Notification: Performance of prepare preOptimizeDAE: time 5.561e-05/9.232, allocations: 11.97 kB / 3.822 GB, free: 61.96 MB / 0.5417 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0004114/9.233, allocations: 120.3 kB / 3.823 GB, free: 61.89 MB / 0.5417 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002642/9.236, allocations: 321.8 kB / 3.823 GB, free: 61.82 MB / 0.5417 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001534/9.237, allocations: 0.5969 MB / 3.823 GB, free: 61.45 MB / 0.5417 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000129/9.237, allocations: 116.8 kB / 3.824 GB, free: 61.36 MB / 0.5417 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000157/9.237, allocations: 66.75 kB / 3.824 GB, free: 61.34 MB / 0.5417 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002609/9.24, allocations: 1.209 MB / 3.825 GB, free: 60.75 MB / 0.5417 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.683e-05/9.24, allocations: 7.875 kB / 3.825 GB, free: 60.75 MB / 0.5417 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.791e-05/9.24, allocations: 31.61 kB / 3.825 GB, free: 60.73 MB / 0.5417 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.375e-05/9.24, allocations: 44.41 kB / 3.825 GB, free: 60.72 MB / 0.5417 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00245/9.243, allocations: 1.047 MB / 3.826 GB, free: 60.44 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.005981/9.249, allocations: 5.615 MB / 3.831 GB, free: 55.98 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002111/9.251, allocations: 0.7997 MB / 3.832 GB, free: 55.74 MB / 0.5417 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.02823/9.279, allocations: 17.16 MB / 3.849 GB, free: 44.47 MB / 0.5417 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.366e-05/9.279, allocations: 40.88 kB / 3.849 GB, free: 44.43 MB / 0.5417 GB
Notification: Performance of pre-optimization done (n=45): time 3.156e-06/9.279, allocations: 3.938 kB / 3.849 GB, free: 44.42 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=49): time 0.007279/9.286, allocations: 2.367 MB / 3.851 GB, free: 43.44 MB / 0.5417 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.312e-05/9.287, allocations: 158.6 kB / 3.851 GB, free: 43.25 MB / 0.5417 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007769/9.287, allocations: 0.5376 MB / 3.852 GB, free: 43 MB / 0.5417 GB
Notification: Performance of collectPreVariables (initialization): time 6.289e-05/9.287, allocations: 37.55 kB / 3.852 GB, free: 42.96 MB / 0.5417 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002108/9.288, allocations: 391.7 kB / 3.852 GB, free: 42.65 MB / 0.5417 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001377/9.288, allocations: 181.1 kB / 3.853 GB, free: 42.52 MB / 0.5417 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.911e-05/9.288, allocations: 15.91 kB / 3.853 GB, free: 42.51 MB / 0.5417 GB
Notification: Performance of setup shared object (initialization): time 0.000122/9.288, allocations: 376.1 kB / 3.853 GB, free: 42.17 MB / 0.5417 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005798/9.289, allocations: 290.9 kB / 3.853 GB, free: 42.08 MB / 0.5417 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006843/9.289, allocations: 0.6081 MB / 3.854 GB, free: 41.57 MB / 0.5417 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006471/9.29, allocations: 377.3 kB / 3.854 GB, free: 41.43 MB / 0.5417 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.601e-06/9.29, allocations: 7.406 kB / 3.854 GB, free: 41.43 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=96) (initialization): time 0.001856/9.292, allocations: 0.9775 MB / 3.855 GB, free: 41.05 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 2.198e-05/9.292, allocations: 6.438 kB / 3.855 GB, free: 41.05 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.624e-05/9.292, allocations: 13.78 kB / 3.855 GB, free: 41.05 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002807/9.292, allocations: 62.72 kB / 3.855 GB, free: 41.03 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001233/9.293, allocations: 315.7 kB / 3.856 GB, free: 41 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00114/9.294, allocations: 1.983 MB / 3.857 GB, free: 39.06 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007923/9.295, allocations: 84.42 kB / 3.858 GB, free: 39.04 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.825e-05/9.295, allocations: 46.06 kB / 3.858 GB, free: 39.04 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 47
 * Number of states: 0 ()
 * Number of discrete variables: 10 (volume.heatTransfer.states[1].phase,fixedMassFlowRate.medium.phase,ambient.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.0003912/9.296, allocations: 275.7 kB / 3.858 GB, free: 38.84 MB / 0.5417 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001517/9.296, allocations: 77.36 kB / 3.858 GB, free: 38.8 MB / 0.5417 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002822/9.299, allocations: 2.606 MB / 3.86 GB, free: 37.63 MB / 0.5417 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.729e-05/9.299, allocations: 29.5 kB / 3.86 GB, free: 37.62 MB / 0.5417 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.991e-06/9.299, allocations: 7.875 kB / 3.86 GB, free: 37.62 MB / 0.5417 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.055e-06/9.299, allocations: 9.984 kB / 3.861 GB, free: 37.62 MB / 0.5417 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004259/9.303, allocations: 3.792 MB / 3.864 GB, free: 35.83 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.468e-06/9.303, allocations: 3.875 kB / 3.864 GB, free: 35.83 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001083/9.304, allocations: 238.9 kB / 3.864 GB, free: 35.82 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003874/9.305, allocations: 94.33 kB / 3.865 GB, free: 35.79 MB / 0.5417 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.658e-05/9.305, allocations: 11.28 kB / 3.865 GB, free: 35.78 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00108/9.306, allocations: 2.002 MB / 3.866 GB, free: 33.83 MB / 0.5417 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.504e-06/9.306, allocations: 3.219 kB / 3.866 GB, free: 33.83 MB / 0.5417 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002907/9.309, allocations: 2.379 MB / 3.869 GB, free: 32.7 MB / 0.5417 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000633/9.309, allocations: 328 kB / 3.869 GB, free: 32.45 MB / 0.5417 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002014/9.31, allocations: 15.58 kB / 3.869 GB, free: 32.44 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007349/9.31, allocations: 60.5 kB / 3.869 GB, free: 32.43 MB / 0.5417 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000128/9.31, allocations: 54.55 kB / 3.869 GB, free: 32.41 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.614e-05/9.311, allocations: 22.09 kB / 3.869 GB, free: 32.41 MB / 0.5417 GB
Notification: Performance of sorting global known variables: time 0.0008602/9.311, allocations: 0.5546 MB / 3.87 GB, free: 32.17 MB / 0.5417 GB
Notification: Performance of sort global known variables: time 1.8e-07/9.311, allocations: 0 / 3.87 GB, free: 32.17 MB / 0.5417 GB
Notification: Performance of remove unused functions: time 0.00605/9.317, allocations: 1.143 MB / 3.871 GB, free: 31.95 MB / 0.5417 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: 21 ($cse2.region3boundary,$cse3.region3boundary,$cse4.phase,$cse4.region,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,$cse7.phase,$cse7.region,$cse8.phase,$cse8.region,$cse11.phase,$cse11.region,$cse13.phase,$cse13.region,$cse14.phase,$cse14.region,volume.heatTransfer.states[1].phase,fixedMassFlowRate.medium.phase,ambient.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (58):
 * Single equations (assignments): 46
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 10
 * 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.01247/9.33, allocations: 4.466 MB / 3.875 GB, free: 29.92 MB / 0.5417 GB
Notification: Performance of simCode: created initialization part: time 0.002662/9.333, allocations: 1.105 MB / 3.876 GB, free: 29.55 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 7.384e-06/9.333, allocations: 0 / 3.876 GB, free: 29.55 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.001755/9.334, allocations: 0.8132 MB / 3.877 GB, free: 29.21 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002105/9.337, allocations: 371.6 kB / 3.878 GB, free: 29.13 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01356/9.35, allocations: 13.35 MB / 3.891 GB, free: 18.72 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006466/9.351, allocations: 1.189 MB / 3.892 GB, free: 17.88 MB / 0.5417 GB
Notification: Performance of simCode: alias equations: time 0.001047/9.352, allocations: 433.6 kB / 3.892 GB, free: 17.62 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004913/9.352, allocations: 447.7 kB / 3.893 GB, free: 17.22 MB / 0.5417 GB
Notification: Performance of SimCode: time 8.22e-07/9.352, allocations: 0 / 3.893 GB, free: 17.22 MB / 0.5417 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.3498/9.702, allocations: 52.91 MB / 3.944 GB, free: 82.89 MB / 0.5573 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001616/9.702, allocations: 270.5 kB / 3.944 GB, free: 82.54 MB / 0.5573 GB
Notification: Performance of buildModelFMU: Generate platform static: time 3.962/13.66, allocations: 1.719 kB / 3.944 GB, free: 82.54 MB / 0.5573 GB
(rm -f ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator -r=ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph_res.mat --tempDir=temp_ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97_ph_fmu --startTime=0 --stopTime=1.01 --timeout=50 --tolerance=1e-06 ModelicaTest_trunk_ModelicaTest_Media_TestsWithFluid_MediaTestModels_Water_WaterIF97_ph.fmu > ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph.pipe 2>&1)
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.WaterIF97_ph_res.mat does not exist to compare? outputFormat=mat