Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
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/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 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)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volume.medium.T|volume.medium.p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition")
translateModel(ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volume.medium.T|volume.medium.p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001313/0.001313, allocations: 103.4 kB / 17.98 MB, free: 5.367 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001358/0.001358, allocations: 209.8 kB / 18.92 MB, free: 4.434 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.466/1.466, allocations: 227.4 MB / 247.1 MB, free: 10.79 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2309/0.2309, allocations: 46.1 MB / 344.4 MB, free: 11.77 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001556/0.001555, allocations: 75.88 kB / 417.7 MB, free: 20.07 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1178/0.1194, allocations: 62.44 MB / 480.2 MB, free: 5.613 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition): time 0.4554/0.5748, allocations: 178.4 MB / 0.6431 GB, free: 1.297 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009504/0.5844, allocations: 6.571 MB / 0.6495 GB, free: 10.71 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009807/0.5854, allocations: 23.81 kB / 0.6496 GB, free: 10.68 MB / 494.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001518/0.5869, allocations: 378.2 kB / 0.6499 GB, free: 10.31 MB / 494.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004762/0.5918, allocations: 1.641 MB / 0.6515 GB, free: 8.668 MB / 494.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003983/0.5958, allocations: 1.397 MB / 0.6529 GB, free: 7.281 MB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002776/0.5986, allocations: 2.114 MB / 0.655 GB, free: 5.164 MB / 494.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001001/0.5996, allocations: 0.5322 MB / 0.6555 GB, free: 4.625 MB / 494.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003898/0.6035, allocations: 1.768 MB / 0.6572 GB, free: 2.852 MB / 494.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002928/0.6065, allocations: 1.601 MB / 0.6588 GB, free: 1.246 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002735/0.6067, allocations: 76 kB / 0.6588 GB, free: 1.172 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00334/0.6101, allocations: 1.661 MB / 0.6605 GB, free: 15.5 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005966/0.6107, allocations: 450.9 kB / 0.6609 GB, free: 15.06 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.001052/0.6118, allocations: 0.564 MB / 0.6614 GB, free: 14.5 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.002507/0.6143, allocations: 1.625 MB / 0.663 GB, free: 12.87 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 5.29e-06/0.6143, allocations: 0 / 0.663 GB, free: 12.87 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 2.044e-06/0.6143, allocations: 0 / 0.663 GB, free: 12.87 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 5.06e-05/0.6144, allocations: 0 / 0.663 GB, free: 12.87 MB / 0.4981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 192
 * Number of variables: 192
Notification: Performance of Generate backend data structure: time 0.003564/0.618, allocations: 1.457 MB / 0.6645 GB, free: 11.36 MB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 4.046e-05/0.618, allocations: 8.031 kB / 0.6645 GB, free: 11.36 MB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001411/0.6194, allocations: 286.5 kB / 0.6647 GB, free: 11.07 MB / 0.4981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009961/0.6204, allocations: 0.6014 MB / 0.6653 GB, free: 10.43 MB / 0.4981 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001286/0.6206, allocations: 112.6 kB / 0.6654 GB, free: 10.31 MB / 0.4981 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001172/0.6207, allocations: 71.92 kB / 0.6655 GB, free: 10.24 MB / 0.4981 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001842/0.6225, allocations: 1.271 MB / 0.6667 GB, free: 8.902 MB / 0.4981 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.58e-05/0.6226, allocations: 4 kB / 0.6667 GB, free: 8.898 MB / 0.4981 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001066/0.6227, allocations: 35.92 kB / 0.6668 GB, free: 8.863 MB / 0.4981 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001003/0.6228, allocations: 85.2 kB / 0.6669 GB, free: 8.781 MB / 0.4981 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001664/0.6245, allocations: 1.047 MB / 0.6679 GB, free: 7.73 MB / 0.4981 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.006819/0.6313, allocations: 4.927 MB / 0.6727 GB, free: 2.512 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0005325/0.6319, allocations: 307.3 kB / 0.673 GB, free: 2.207 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002308/0.6321, allocations: 151.2 kB / 0.6731 GB, free: 2.059 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001054/0.6322, allocations: 97.09 kB / 0.6732 GB, free: 1.945 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.649e-05/0.6323, allocations: 34.56 kB / 0.6733 GB, free: 1.902 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=28): time 3.817e-06/0.6323, allocations: 4 kB / 0.6733 GB, free: 1.898 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=33): time 0.006198/0.6385, allocations: 1.819 MB / 0.675 GB, free: 15.99 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.876e-05/0.6386, allocations: 136.5 kB / 0.6752 GB, free: 15.83 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001188/0.6397, allocations: 0.9426 MB / 0.6761 GB, free: 14.86 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 5.406e-05/0.6398, allocations: 29.7 kB / 0.6761 GB, free: 14.82 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004078/0.6402, allocations: 0.5711 MB / 0.6767 GB, free: 14.25 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001342/0.6404, allocations: 130.3 kB / 0.6768 GB, free: 14.12 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002929/0.6407, allocations: 218.6 kB / 0.677 GB, free: 13.9 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.000173/0.6409, allocations: 402.7 kB / 0.6774 GB, free: 13.5 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004469/0.6413, allocations: 274.4 kB / 0.6777 GB, free: 13.23 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008603/0.6422, allocations: 0.8678 MB / 0.6785 GB, free: 12.07 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001306/0.6435, allocations: 1.175 MB / 0.6796 GB, free: 10.62 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.253e-05/0.6435, allocations: 4 kB / 0.6797 GB, free: 10.61 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=130) (initialization): time 0.001988/0.6455, allocations: 1.24 MB / 0.6809 GB, free: 9.363 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 2.814e-05/0.6456, allocations: 12 kB / 0.6809 GB, free: 9.352 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.997e-05/0.6456, allocations: 23.98 kB / 0.6809 GB, free: 9.328 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001295/0.6469, allocations: 295.1 kB / 0.6812 GB, free: 9.039 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005601/0.6475, allocations: 207.6 kB / 0.6814 GB, free: 8.836 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001097/0.6486, allocations: 0.9151 MB / 0.6823 GB, free: 7.895 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008754/0.6495, allocations: 56.05 kB / 0.6823 GB, free: 7.84 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001057/0.6496, allocations: 71.98 kB / 0.6824 GB, free: 7.77 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 90
 * Number of states: 0 ()
 * Number of discrete variables: 4 (volume.regularFlow[1],volume.regularFlow[2],volume.inFlow[2],volume.inFlow[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (112):
 * Single equations (assignments): 111
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,17)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005646/0.6502, allocations: 341.2 kB / 0.6827 GB, free: 7.426 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002105/0.6504, allocations: 102.8 kB / 0.6828 GB, free: 7.324 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001133/0.6515, allocations: 0.5119 MB / 0.6833 GB, free: 6.805 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.191e-06/0.6515, allocations: 4 kB / 0.6833 GB, free: 6.801 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.023e-06/0.6515, allocations: 0 / 0.6833 GB, free: 6.801 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.694e-06/0.6515, allocations: 7.984 kB / 0.6833 GB, free: 6.793 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002023/0.6536, allocations: 1.129 MB / 0.6844 GB, free: 5.602 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.39e-06/0.6536, allocations: 4 kB / 0.6844 GB, free: 5.598 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001374/0.655, allocations: 179.8 kB / 0.6846 GB, free: 5.422 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0001401/0.6551, allocations: 28.81 kB / 0.6846 GB, free: 5.391 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.591e-05/0.6552, allocations: 11.94 kB / 0.6846 GB, free: 5.379 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003514/0.6587, allocations: 2.873 MB / 0.6875 GB, free: 2.23 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.575e-06/0.6587, allocations: 0 / 0.6875 GB, free: 2.23 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001892/0.6606, allocations: 0.7068 MB / 0.6881 GB, free: 1.5 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007702/0.6614, allocations: 196 kB / 0.6883 GB, free: 1.289 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003373/0.6618, allocations: 7.906 kB / 0.6883 GB, free: 1.281 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008903/0.6627, allocations: 32.05 kB / 0.6884 GB, free: 1.25 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001138/0.6628, allocations: 27.91 kB / 0.6884 GB, free: 1.223 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.533e-05/0.6629, allocations: 15.98 kB / 0.6884 GB, free: 1.207 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.001684/0.6646, allocations: 0.6282 MB / 0.689 GB, free: 0.5664 MB / 0.5137 GB
Notification: Performance of sort global known variables: time 2.91e-07/0.6646, allocations: 0 / 0.689 GB, free: 0.5664 MB / 0.5137 GB
Notification: Performance of remove unused functions: time 0.003204/0.6678, allocations: 383.9 kB / 0.6894 GB, free: 196 kB / 0.5137 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.T)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (33):
 * Single equations (assignments): 31
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.003821/0.6717, allocations: 0.6556 MB / 0.69 GB, free: 15.53 MB / 0.5294 GB
Notification: Performance of simCode: created initialization part: time 0.002429/0.6741, allocations: 0.7247 MB / 0.6907 GB, free: 14.81 MB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 5.781e-06/0.6741, allocations: 0 / 0.6907 GB, free: 14.81 MB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 0.001376/0.6755, allocations: 367.2 kB / 0.6911 GB, free: 14.44 MB / 0.5294 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003364/0.6789, allocations: 445.2 kB / 0.6915 GB, free: 14.02 MB / 0.5294 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004865/0.6838, allocations: 1.936 MB / 0.6934 GB, free: 12.04 MB / 0.5294 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00157/0.6854, allocations: 1.024 MB / 0.6944 GB, free: 10.98 MB / 0.5294 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000628/0.686, allocations: 91.42 kB / 0.6945 GB, free: 10.89 MB / 0.5294 GB
Notification: Performance of SimCode: time 9.02e-07/0.6861, allocations: 0 / 0.6945 GB, free: 10.89 MB / 0.5294 GB
Notification: Performance of Templates: time 0.3003/0.9864, allocations: 22.69 MB / 0.7166 GB, free: 194 MB / 0.5294 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.makefile
(rm -f ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.sim & ./ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.pipe 2>&1)
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Media/TestsWithFluid/MediaTestModels/IdealGases/SimpleNaturalGasFixedComposition/SimpleNaturalGasFixedComposition.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_trunk_ModelicaTest.Media.TestsWithFluid.MediaTestModels.IdealGases.SimpleNaturalGasFixedComposition.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
""

Variables in the reference:time,volume.medium.T,volume.medium.p

Variables in the result:time,volume.medium.T,volume.medium.p