Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.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: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Vessels.TestVolume,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Vessels_TestVolume",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Vessels.TestVolume,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Vessels_TestVolume",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.000923/0.0009229, allocations: 97.12 kB / 17.35 MB, free: 6.371 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001263/0.001263, allocations: 206.3 kB / 18.29 MB, free: 5.496 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.324/1.324, allocations: 227.7 MB / 246.8 MB, free: 11.41 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2032/0.2032, allocations: 46.18 MB / 345.2 MB, free: 11.39 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0002799/0.0002799, allocations: 4 kB / 419.6 MB, free: 19.64 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1258/0.1261, allocations: 63.56 MB / 483.2 MB, free: 4.055 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Vessels.TestVolume): time 0.2842/0.4104, allocations: 36.77 MB / 0.5078 GB, free: 10.94 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02124/0.4317, allocations: 17.56 MB / 0.5249 GB, free: 10.54 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001407/0.4331, allocations: 16.75 kB / 0.5249 GB, free: 10.53 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001673/0.4348, allocations: 380.3 kB / 0.5253 GB, free: 10.43 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01616/0.451, allocations: 3.28 MB / 0.5285 GB, free: 9.934 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01174/0.4628, allocations: 2.673 MB / 0.5311 GB, free: 9.5 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003767/0.4665, allocations: 2.427 MB / 0.5335 GB, free: 9.188 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008/0.4674, allocations: 469.1 kB / 0.5339 GB, free: 9.133 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001323/0.4687, allocations: 0.6739 MB / 0.5346 GB, free: 8.988 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000796/0.4695, allocations: 0.578 MB / 0.5351 GB, free: 8.879 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 9.678e-05/0.4696, allocations: 37.22 kB / 0.5352 GB, free: 8.879 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01611/0.4857, allocations: 7.35 MB / 0.5424 GB, free: 5.609 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002998/0.4861, allocations: 210.4 kB / 0.5426 GB, free: 5.477 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005286/0.4866, allocations: 414.2 kB / 0.5429 GB, free: 5.223 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.0103/0.4969, allocations: 4.999 MB / 0.5478 GB, free: 2.277 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 3.978e-06/0.4969, allocations: 0 / 0.5478 GB, free: 2.277 MB / 382.1 MB
Notification: Performance of FrontEnd: time 2.003e-06/0.497, allocations: 0 / 0.5478 GB, free: 2.277 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 1.134e-05/0.497, allocations: 3.312 kB / 0.5478 GB, free: 2.277 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 151
 * Number of variables: 151
Notification: Performance of Generate backend data structure: time 0.004563/0.5015, allocations: 1.464 MB / 0.5493 GB, free: 1.246 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.027e-05/0.5016, allocations: 9.25 kB / 0.5493 GB, free: 1.246 MB / 382.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001729/0.5018, allocations: 114.1 kB / 0.5494 GB, free: 1.152 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005131/0.5069, allocations: 372.2 kB / 0.5497 GB, free: 1.012 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001044/0.508, allocations: 0.524 MB / 0.5502 GB, free: 0.5742 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000139/0.5081, allocations: 115.1 kB / 0.5504 GB, free: 496 kB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001378/0.5083, allocations: 59.38 kB / 0.5504 GB, free: 472 kB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004018/0.5123, allocations: 1.166 MB / 0.5516 GB, free: 15.45 MB / 398.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.694e-05/0.5124, allocations: 4 kB / 0.5516 GB, free: 15.45 MB / 398.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001223/0.5125, allocations: 24.08 kB / 0.5516 GB, free: 15.43 MB / 398.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.869e-05/0.5126, allocations: 33.3 kB / 0.5516 GB, free: 15.39 MB / 398.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004406/0.517, allocations: 1.102 MB / 0.5527 GB, free: 14.29 MB / 398.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.00978/0.5268, allocations: 5.045 MB / 0.5576 GB, free: 8.906 MB / 398.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0044/0.5312, allocations: 0.9612 MB / 0.5586 GB, free: 7.93 MB / 398.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001215/0.5325, allocations: 401.9 kB / 0.5589 GB, free: 7.535 MB / 398.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.07459/0.6071, allocations: 26.99 MB / 0.5853 GB, free: 9.156 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.639e-05/0.6072, allocations: 39 kB / 0.5853 GB, free: 9.109 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=47): time 6.101e-06/0.6072, allocations: 4 kB / 0.5853 GB, free: 9.105 MB / 430.1 MB
Notification: Performance of matching and sorting (n=47): time 0.00759/0.6148, allocations: 2.079 MB / 0.5874 GB, free: 6.977 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.876e-05/0.6149, allocations: 115.2 kB / 0.5875 GB, free: 6.84 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0008384/0.6157, allocations: 0.5947 MB / 0.5881 GB, free: 6.242 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 8.014e-05/0.6158, allocations: 33.7 kB / 0.5881 GB, free: 6.203 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002534/0.6161, allocations: 318.9 kB / 0.5884 GB, free: 5.887 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002518/0.6164, allocations: 165.1 kB / 0.5885 GB, free: 5.727 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001005/0.6165, allocations: 57.69 kB / 0.5886 GB, free: 5.664 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001905/0.6167, allocations: 374.8 kB / 0.589 GB, free: 5.289 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008041/0.6175, allocations: 337 kB / 0.5893 GB, free: 4.961 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001014/0.6185, allocations: 0.4891 MB / 0.5898 GB, free: 4.41 MB / 430.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001534/0.62, allocations: 0.7748 MB / 0.5905 GB, free: 3.574 MB / 430.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.459e-06/0.6201, allocations: 3.938 kB / 0.5905 GB, free: 3.57 MB / 430.1 MB
Notification: Performance of matching and sorting (n=72) (initialization): time 0.002244/0.6223, allocations: 1.078 MB / 0.5916 GB, free: 2.477 MB / 430.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.533e-05/0.6224, allocations: 11.94 kB / 0.5916 GB, free: 2.465 MB / 430.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.27e-05/0.6224, allocations: 4 kB / 0.5916 GB, free: 2.461 MB / 430.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001179/0.6236, allocations: 432.6 kB / 0.592 GB, free: 2.035 MB / 430.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004465/0.624, allocations: 127.8 kB / 0.5921 GB, free: 1.91 MB / 430.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001809/0.6258, allocations: 1.635 MB / 0.5937 GB, free: 228 kB / 430.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007091/0.6266, allocations: 119.2 kB / 0.5938 GB, free: 108 kB / 430.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.094e-05/0.6266, allocations: 35.98 kB / 0.5939 GB, free: 72 kB / 430.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 20
 * Number of states: 0 ()
 * Number of discrete variables: 9 (Volume.regularFlow[1],Volume.regularFlow[2],Sink.medium.phase,FlowSource.medium.phase,Volume.inFlow[2],Volume.inFlow[1],Volume.heatTransfer.states[1].phase,Valve.state_b.phase,Valve.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (58):
 * Single equations (assignments): 56
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * 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): 2 systems
   {(2,1), (3,10)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003742/0.627, allocations: 225.7 kB / 0.5941 GB, free: 15.84 MB / 446.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001416/0.6272, allocations: 67.16 kB / 0.5941 GB, free: 15.77 MB / 446.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004421/0.6316, allocations: 3.307 MB / 0.5974 GB, free: 12.46 MB / 446.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.882e-05/0.6317, allocations: 43.94 kB / 0.5974 GB, free: 12.42 MB / 446.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.262e-06/0.6317, allocations: 0 / 0.5974 GB, free: 12.42 MB / 446.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.346e-06/0.6317, allocations: 4.125 kB / 0.5974 GB, free: 12.41 MB / 446.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001762/0.6334, allocations: 1.574 MB / 0.599 GB, free: 10.8 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.825e-06/0.6335, allocations: 3.984 kB / 0.599 GB, free: 10.8 MB / 446.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003585/0.6338, allocations: 91.88 kB / 0.599 GB, free: 10.71 MB / 446.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001538/0.6354, allocations: 0.8857 MB / 0.5999 GB, free: 9.812 MB / 446.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.012e-05/0.6354, allocations: 19.98 kB / 0.5999 GB, free: 9.793 MB / 446.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002403/0.6379, allocations: 2.314 MB / 0.6022 GB, free: 7.43 MB / 446.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.325e-06/0.6379, allocations: 0 / 0.6022 GB, free: 7.43 MB / 446.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003448/0.6413, allocations: 2.324 MB / 0.6045 GB, free: 5.086 MB / 446.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005065/0.6418, allocations: 358.6 kB / 0.6048 GB, free: 4.715 MB / 446.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001266/0.642, allocations: 15.94 kB / 0.6048 GB, free: 4.699 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006509/0.6426, allocations: 71.78 kB / 0.6049 GB, free: 4.629 MB / 446.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001657/0.6428, allocations: 64.47 kB / 0.6049 GB, free: 4.566 MB / 446.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.344e-05/0.6429, allocations: 19.98 kB / 0.605 GB, free: 4.547 MB / 446.1 MB
Notification: Performance of sorting global known variables: time 0.0007451/0.6436, allocations: 0.5185 MB / 0.6055 GB, free: 4.023 MB / 446.1 MB
Notification: Performance of sort global known variables: time 1.8e-07/0.6436, allocations: 0 / 0.6055 GB, free: 4.023 MB / 446.1 MB
Notification: Performance of remove unused functions: time 0.004437/0.6481, allocations: 1.167 MB / 0.6066 GB, free: 2.855 MB / 446.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 27 ($cse1.region3boundary,$cse2.region3boundary,$cse3.phase,$cse3.region,$cse4.phase,$cse4.region,$cse5.phase,$cse5.region,$cse6.region3boundary,$cse7.region3boundary,$cse8.phase,$cse8.region,$cse11.phase,$cse11.region,$cse13.phase,$cse13.region,$cse14.phase,$cse14.region,$cse16.phase,$cse16.region,$cse17.phase,$cse17.region,Volume.heatTransfer.states[1].phase,Volume.inFlow[1],Volume.inFlow[2],FlowSource.medium.phase,Sink.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (43):
 * Single equations (assignments): 32
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 9
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * 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): 2 systems
   {(2,1), (3,14)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01069/0.6588, allocations: 3.853 MB / 0.6104 GB, free: 15.09 MB / 462.1 MB
Notification: Performance of simCode: created initialization part: time 0.002725/0.6616, allocations: 1.152 MB / 0.6115 GB, free: 13.94 MB / 462.1 MB
Notification: Performance of simCode: created event and clocks part: time 5.089e-06/0.6616, allocations: 0 / 0.6115 GB, free: 13.94 MB / 462.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.001572/0.6632, allocations: 0.8926 MB / 0.6124 GB, free: 13.04 MB / 462.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002272/0.6655, allocations: 361.8 kB / 0.6127 GB, free: 12.7 MB / 462.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01587/0.6813, allocations: 9.286 MB / 0.6218 GB, free: 3.195 MB / 462.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000841/0.6822, allocations: 1.154 MB / 0.6229 GB, free: 2.012 MB / 462.1 MB
Notification: Performance of simCode: alias equations: time 0.0008505/0.6831, allocations: 360.3 kB / 0.6233 GB, free: 1.66 MB / 462.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000486/0.6836, allocations: 411.3 kB / 0.6236 GB, free: 1.258 MB / 462.1 MB
Notification: Performance of SimCode: time 9.32e-07/0.6836, allocations: 0 / 0.6236 GB, free: 1.258 MB / 462.1 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.09138/0.775, allocations: 59.64 MB / 0.6819 GB, free: 5.832 MB / 0.5137 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0003043/0.7753, allocations: 289.2 kB / 0.6822 GB, free: 5.445 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate platform static: time 4.618/5.393, allocations: 0 / 0.6822 GB, free: 5.445 MB / 0.5137 GB
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume_res.mat --tempDir=temp_ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Vessels_TestVolume_fmu --startTime=0 --stopTime=5 --timeout=50 --tolerance=1e-06 ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Vessels_TestVolume.fmu > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.pipe 2>&1)
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Fluid/TestComponents/Vessels/TestVolume/TestVolume.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches