Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volume.medium.T|volume.medium.p",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam")
translateModel(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volume.medium.T|volume.medium.p",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001388/0.001388, allocations: 108.3 kB / 18.41 MB, free: 4.566 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001622/0.001622, allocations: 191 kB / 19.34 MB, free: 3.637 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.413/1.413, allocations: 222.9 MB / 243 MB, free: 15.08 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.2068/0.2068, allocations: 44.18 MB / 337.4 MB, free: 2.727 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001216/0.001216, allocations: 58.25 kB / 409.9 MB, free: 26.57 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1207/0.1219, allocations: 60.83 MB / 470.7 MB, free: 13.68 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam): time 0.4411/0.563, allocations: 175.2 MB / 0.6308 GB, free: 0.8789 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007078/0.5702, allocations: 5.341 MB / 0.636 GB, free: 11.52 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000676/0.5709, allocations: 19.88 kB / 0.6361 GB, free: 11.5 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0009274/0.5718, allocations: 314 kB / 0.6364 GB, free: 11.2 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0034/0.5752, allocations: 1.323 MB / 0.6376 GB, free: 9.875 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002904/0.5782, allocations: 1.063 MB / 0.6387 GB, free: 8.82 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002221/0.5804, allocations: 1.848 MB / 0.6405 GB, free: 6.969 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008345/0.5812, allocations: 464.5 kB / 0.6409 GB, free: 6.512 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002421/0.5837, allocations: 1.07 MB / 0.642 GB, free: 5.438 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001381/0.5851, allocations: 0.7471 MB / 0.6427 GB, free: 4.688 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000127/0.5852, allocations: 64 kB / 0.6428 GB, free: 4.625 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001422/0.5866, allocations: 0.6242 MB / 0.6434 GB, free: 4 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002983/0.587, allocations: 263.3 kB / 0.6436 GB, free: 3.742 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004777/0.5874, allocations: 394.2 kB / 0.644 GB, free: 3.355 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.002121/0.5896, allocations: 1.305 MB / 0.6453 GB, free: 2.047 MB / 478.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.859e-06/0.5896, allocations: 0 / 0.6453 GB, free: 2.047 MB / 478.1 MB
Notification: Performance of FrontEnd: time 1.653e-06/0.5896, allocations: 0 / 0.6453 GB, free: 2.047 MB / 478.1 MB
Notification: Performance of Transformations before backend: time 1.507e-05/0.5896, allocations: 0 / 0.6453 GB, free: 2.047 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 130
 * Number of variables: 130
Notification: Performance of Generate backend data structure: time 0.002258/0.5919, allocations: 1.095 MB / 0.6464 GB, free: 0.8984 MB / 478.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.566e-05/0.5919, allocations: 12.03 kB / 0.6464 GB, free: 0.8867 MB / 478.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008034/0.5927, allocations: 139.1 kB / 0.6465 GB, free: 0.75 MB / 478.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009802/0.5937, allocations: 0.5275 MB / 0.647 GB, free: 188 kB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001068/0.5939, allocations: 104.3 kB / 0.6471 GB, free: 68 kB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 9.519e-05/0.594, allocations: 44 kB / 0.6472 GB, free: 24 kB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001219/0.5952, allocations: 0.8136 MB / 0.6479 GB, free: 15.14 MB / 494.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.931e-05/0.5952, allocations: 11.94 kB / 0.648 GB, free: 15.13 MB / 494.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.835e-05/0.5953, allocations: 23.98 kB / 0.648 GB, free: 15.11 MB / 494.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.259e-05/0.5954, allocations: 44.86 kB / 0.648 GB, free: 15.06 MB / 494.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000999/0.5964, allocations: 0.6205 MB / 0.6486 GB, free: 14.44 MB / 494.1 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.004494/0.6009, allocations: 3.968 MB / 0.6525 GB, free: 10.21 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0005859/0.6015, allocations: 351.6 kB / 0.6528 GB, free: 9.863 MB / 494.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002651/0.6017, allocations: 177.2 kB / 0.653 GB, free: 9.688 MB / 494.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001197/0.6019, allocations: 93.38 kB / 0.6531 GB, free: 9.578 MB / 494.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.723e-05/0.6019, allocations: 34.84 kB / 0.6531 GB, free: 9.535 MB / 494.1 MB
Notification: Performance of pre-optimization done (n=34): time 2.054e-06/0.6019, allocations: 0 / 0.6531 GB, free: 9.535 MB / 494.1 MB
Notification: Performance of matching and sorting (n=39): time 0.005326/0.6073, allocations: 1.667 MB / 0.6548 GB, free: 7.801 MB / 494.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.671e-05/0.6073, allocations: 136.5 kB / 0.6549 GB, free: 7.637 MB / 494.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006924/0.608, allocations: 0.6132 MB / 0.6555 GB, free: 7.016 MB / 494.1 MB
Notification: Performance of collectPreVariables (initialization): time 5.173e-05/0.6081, allocations: 37.7 kB / 0.6555 GB, free: 6.973 MB / 494.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002623/0.6084, allocations: 362.9 kB / 0.6559 GB, free: 6.613 MB / 494.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001119/0.6085, allocations: 142 kB / 0.656 GB, free: 6.473 MB / 494.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002237/0.6087, allocations: 162.5 kB / 0.6562 GB, free: 6.309 MB / 494.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001611/0.6089, allocations: 370.8 kB / 0.6565 GB, free: 5.938 MB / 494.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003714/0.6093, allocations: 205.9 kB / 0.6567 GB, free: 5.734 MB / 494.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000547/0.6098, allocations: 0.5202 MB / 0.6572 GB, free: 5.07 MB / 494.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008893/0.6107, allocations: 0.7513 MB / 0.658 GB, free: 4.18 MB / 494.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.436e-06/0.6107, allocations: 0 / 0.658 GB, free: 4.18 MB / 494.1 MB
Notification: Performance of matching and sorting (n=85) (initialization): time 0.00136/0.6121, allocations: 0.8914 MB / 0.6588 GB, free: 3.277 MB / 494.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.22e-05/0.6121, allocations: 12 kB / 0.6588 GB, free: 3.266 MB / 494.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.335e-05/0.6122, allocations: 8 kB / 0.6588 GB, free: 3.258 MB / 494.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001367/0.6135, allocations: 321.1 kB / 0.6591 GB, free: 2.941 MB / 494.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003844/0.6139, allocations: 119.8 kB / 0.6593 GB, free: 2.824 MB / 494.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001031/0.615, allocations: 0.9335 MB / 0.6602 GB, free: 1.867 MB / 494.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004491/0.6154, allocations: 24 kB / 0.6602 GB, free: 1.844 MB / 494.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.222e-05/0.6155, allocations: 67.98 kB / 0.6603 GB, free: 1.777 MB / 494.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 45
 * 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 (67):
 * Single equations (assignments): 66
 * 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.0003032/0.6158, allocations: 253.8 kB / 0.6605 GB, free: 1.52 MB / 494.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001144/0.616, allocations: 71.16 kB / 0.6606 GB, free: 1.449 MB / 494.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001539/0.6175, allocations: 0.8606 MB / 0.6614 GB, free: 0.5703 MB / 494.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.161e-06/0.6175, allocations: 4 kB / 0.6614 GB, free: 0.5664 MB / 494.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.551e-06/0.6175, allocations: 0 / 0.6614 GB, free: 0.5664 MB / 494.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.759e-06/0.6176, allocations: 0 / 0.6614 GB, free: 0.5664 MB / 494.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001987/0.6195, allocations: 1.469 MB / 0.6628 GB, free: 14.96 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.318e-06/0.6196, allocations: 0.8125 kB / 0.6629 GB, free: 14.96 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001044/0.6206, allocations: 203.8 kB / 0.663 GB, free: 14.76 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (simulation): time 8.552e-05/0.6207, allocations: 33.02 kB / 0.6631 GB, free: 14.73 MB / 0.4981 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.559e-05/0.6208, allocations: 20 kB / 0.6631 GB, free: 14.71 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00203/0.6228, allocations: 2.881 MB / 0.6659 GB, free: 11.55 MB / 0.4981 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.577e-06/0.6228, allocations: 4.031 kB / 0.6659 GB, free: 11.55 MB / 0.4981 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001245/0.6241, allocations: 0.818 MB / 0.6667 GB, free: 10.69 MB / 0.4981 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003095/0.6244, allocations: 188.3 kB / 0.6669 GB, free: 10.49 MB / 0.4981 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.266e-05/0.6245, allocations: 8 kB / 0.6669 GB, free: 10.48 MB / 0.4981 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003959/0.6249, allocations: 19.98 kB / 0.6669 GB, free: 10.46 MB / 0.4981 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001001/0.625, allocations: 47.89 kB / 0.667 GB, free: 10.41 MB / 0.4981 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.17e-05/0.6251, allocations: 43.98 kB / 0.667 GB, free: 10.37 MB / 0.4981 GB
Notification: Performance of sorting global known variables: time 0.000531/0.6256, allocations: 439 kB / 0.6674 GB, free: 9.945 MB / 0.4981 GB
Notification: Performance of sort global known variables: time 1.7e-07/0.6256, allocations: 0 / 0.6674 GB, free: 9.945 MB / 0.4981 GB
Notification: Performance of remove unused functions: time 0.0008561/0.6265, allocations: 251.9 kB / 0.6677 GB, free: 9.699 MB / 0.4981 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * 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 (39):
 * Single equations (assignments): 37
 * 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.0007312/0.6272, allocations: 298.4 kB / 0.6679 GB, free: 9.406 MB / 0.4981 GB
Notification: Performance of simCode: created initialization part: time 0.001093/0.6283, allocations: 0.5618 MB / 0.6685 GB, free: 8.848 MB / 0.4981 GB
Notification: Performance of simCode: created event and clocks part: time 2.715e-06/0.6284, allocations: 0.5 kB / 0.6685 GB, free: 8.848 MB / 0.4981 GB
Notification: Performance of simCode: created simulation system equations: time 0.0009487/0.6293, allocations: 426.3 kB / 0.6689 GB, free: 8.418 MB / 0.4981 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001455/0.6308, allocations: 357.6 kB / 0.6692 GB, free: 8.078 MB / 0.4981 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002022/0.6328, allocations: 1.333 MB / 0.6705 GB, free: 6.699 MB / 0.4981 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005287/0.6334, allocations: 0.93 MB / 0.6715 GB, free: 5.742 MB / 0.4981 GB
Notification: Performance of simCode: alias equations: time 0.0009637/0.6343, allocations: 474.2 kB / 0.6719 GB, free: 5.281 MB / 0.4981 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002965/0.6346, allocations: 111.4 kB / 0.672 GB, free: 5.172 MB / 0.4981 GB
Notification: Performance of SimCode: time 6.11e-07/0.6346, allocations: 0 / 0.672 GB, free: 5.172 MB / 0.4981 GB
Notification: Performance of Templates: time 0.02694/0.6616, allocations: 17.39 MB / 0.689 GB, free: 3.934 MB / 0.5137 GB
make -j1 -f ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.makefile
(rm -f ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.pipe ; mkfifo ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.pipe ; head -c 1048576 < ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.pipe >> ../files/ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.sim & ./ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam  -abortSlowSimulation -alarm=480 -s cvode -emit_protected -lv LOG_STATS > ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.pipe 2>&1)
diffSimulationResults("ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Media/TestsWithFluid/MediaTestModels/Water/IdealSteam/IdealSteam.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.0.0_ModelicaTest.Media.TestsWithFluid.MediaTestModels.Water.IdealSteam.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches