Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001171/0.001171, allocations: 79.75 kB / 20.08 MB, free: 4.176 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001903/0.001903, allocations: 156.9 kB / 23.51 MB, free: 0.75 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.144/1.144, allocations: 177.1 MB / 204 MB, free: 5.414 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 2.45/2.45, allocations: 439.8 MB / 0.6839 GB, free: 12.55 MB / 0.6511 GB
"
[Timeout remaining time 177]
Using package Buildings with version 15.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.MixingVolumes.Validation.MassAccumulation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|vol.Xi.[0-9,]+.|mWat|mWatExp|mAir|vol.C.[0-9,]+.|vol.p",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation")
translateModel(Buildings.Fluid.MixingVolumes.Validation.MassAccumulation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|vol.Xi.[0-9,]+.|mWat|mWatExp|mAir|vol.C.[0-9,]+.|vol.p",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.653e-06/1.653e-06, allocations: 0 / 0.8402 GB, free: 12.67 MB / 0.8073 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.681e-05/2.846e-05, allocations: 13.62 kB / 0.8402 GB, free: 12.66 MB / 0.8073 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MassAccumulation): time 0.1794/0.1795, allocations: 146.9 MB / 0.9837 GB, free: 9.16 MB / 0.948 GB
Notification: Performance of NFInst.instExpressions: time 0.003167/0.1826, allocations: 2.606 MB / 0.9863 GB, free: 6.547 MB / 0.948 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002651/0.1829, allocations: 23.81 kB / 0.9863 GB, free: 6.523 MB / 0.948 GB
Notification: Performance of NFTyping.typeComponents: time 0.0005446/0.1835, allocations: 150.9 kB / 0.9864 GB, free: 6.375 MB / 0.948 GB
Notification: Performance of NFTyping.typeBindings: time 0.001012/0.1845, allocations: 0.6565 MB / 0.9871 GB, free: 5.715 MB / 0.948 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0005154/0.185, allocations: 426.9 kB / 0.9875 GB, free: 5.297 MB / 0.948 GB
Notification: Performance of NFFlatten.flatten: time 0.0009512/0.1859, allocations: 1.162 MB / 0.9886 GB, free: 4.129 MB / 0.948 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.000642/0.1866, allocations: 315.6 kB / 0.9889 GB, free: 3.832 MB / 0.948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008252/0.1874, allocations: 0.6413 MB / 0.9896 GB, free: 3.203 MB / 0.948 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003462/0.1877, allocations: 331.1 kB / 0.9899 GB, free: 2.879 MB / 0.948 GB
Notification: Performance of NFPackage.collectConstants: time 5.032e-05/0.1878, allocations: 44 kB / 0.9899 GB, free: 2.836 MB / 0.948 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0004139/0.1882, allocations: 355 kB / 0.9903 GB, free: 2.488 MB / 0.948 GB
Notification: Performance of NFScalarize.scalarize: time 0.0001708/0.1884, allocations: 235.4 kB / 0.9905 GB, free: 2.258 MB / 0.948 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001567/0.1885, allocations: 199.5 kB / 0.9907 GB, free: 2.062 MB / 0.948 GB
Notification: Performance of NFConvertDAE.convert: time 0.0006434/0.1892, allocations: 0.6035 MB / 0.9913 GB, free: 1.457 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 5.059e-06/0.1892, allocations: 0 / 0.9913 GB, free: 1.457 MB / 0.948 GB
Notification: Performance of FrontEnd: time 1.563e-06/0.1892, allocations: 4 kB / 0.9913 GB, free: 1.453 MB / 0.948 GB
Notification: Performance of Transformations before backend: time 6.522e-06/0.1892, allocations: 0 / 0.9913 GB, free: 1.453 MB / 0.948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 87
 * Number of variables: 87
Notification: Performance of Generate backend data structure: time 0.0008012/0.19, allocations: 0.6899 MB / 0.9919 GB, free: 0.7344 MB / 0.948 GB
Notification: Performance of prepare preOptimizeDAE: time 4.095e-05/0.19, allocations: 8.625 kB / 0.9919 GB, free: 0.7266 MB / 0.948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006018/0.1906, allocations: 196.4 kB / 0.9921 GB, free: 0.5352 MB / 0.948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000419/0.1911, allocations: 356.2 kB / 0.9925 GB, free: 160 kB / 0.948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.504e-05/0.1911, allocations: 33.12 kB / 0.9925 GB, free: 128 kB / 0.948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.512e-05/0.1911, allocations: 40 kB / 0.9925 GB, free: 88 kB / 0.948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.000353/0.1915, allocations: 379.7 kB / 0.9929 GB, free: 15.68 MB / 0.9636 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.412e-05/0.1915, allocations: 0 / 0.9929 GB, free: 15.68 MB / 0.9636 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 2.651e-05/0.1915, allocations: 16 kB / 0.9929 GB, free: 15.66 MB / 0.9636 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.795e-05/0.1916, allocations: 20.98 kB / 0.9929 GB, free: 15.64 MB / 0.9636 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0001629/0.1917, allocations: 117.8 kB / 0.993 GB, free: 15.52 MB / 0.9636 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.001038/0.1928, allocations: 0.7845 MB / 0.9938 GB, free: 14.71 MB / 0.9636 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0003174/0.1931, allocations: 230.1 kB / 0.994 GB, free: 14.47 MB / 0.9636 GB
Notification: Performance of preOpt resolveLoops (simulation): time 6.247e-05/0.1931, allocations: 60.56 kB / 0.9941 GB, free: 14.41 MB / 0.9636 GB
Notification: Performance of preOpt evalFunc (simulation): time 8.336e-05/0.1932, allocations: 20 kB / 0.9941 GB, free: 14.39 MB / 0.9636 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.68e-05/0.1932, allocations: 42.48 kB / 0.9942 GB, free: 14.34 MB / 0.9636 GB
Notification: Performance of pre-optimization done (n=25): time 2.595e-06/0.1933, allocations: 0 / 0.9942 GB, free: 14.34 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=25): time 0.0003319/0.1936, allocations: 169.8 kB / 0.9943 GB, free: 14.16 MB / 0.9636 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.264e-05/0.1936, allocations: 85.23 kB / 0.9944 GB, free: 14.06 MB / 0.9636 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0001835/0.1938, allocations: 283.4 kB / 0.9947 GB, free: 13.78 MB / 0.9636 GB
Notification: Performance of collectPreVariables (initialization): time 2.449e-05/0.1938, allocations: 37.64 kB / 0.9947 GB, free: 13.73 MB / 0.9636 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001008/0.1939, allocations: 204.9 kB / 0.9949 GB, free: 13.52 MB / 0.9636 GB
Notification: Performance of collectInitialBindings (initialization): time 5.604e-05/0.194, allocations: 91.2 kB / 0.995 GB, free: 13.43 MB / 0.9636 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 7.187e-05/0.1941, allocations: 61.91 kB / 0.995 GB, free: 13.36 MB / 0.9636 GB
Notification: Performance of setup shared object (initialization): time 0.0001025/0.1942, allocations: 346.7 kB / 0.9954 GB, free: 13.02 MB / 0.9636 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 4.261e-05/0.1942, allocations: 27.38 kB / 0.9954 GB, free: 12.99 MB / 0.9636 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 8.52e-05/0.1943, allocations: 106.2 kB / 0.9955 GB, free: 12.86 MB / 0.9636 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0001409/0.1944, allocations: 150.2 kB / 0.9956 GB, free: 12.69 MB / 0.9636 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.296e-06/0.1944, allocations: 4 kB / 0.9956 GB, free: 12.69 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=33) (initialization): time 0.000184/0.1946, allocations: 160.8 kB / 0.9958 GB, free: 12.52 MB / 0.9636 GB
Notification: Performance of prepare postOptimizeDAE: time 1.52e-05/0.1946, allocations: 5.562 kB / 0.9958 GB, free: 12.52 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.831e-06/0.1946, allocations: 4 kB / 0.9958 GB, free: 12.52 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.013e-05/0.1947, allocations: 8.188 kB / 0.9958 GB, free: 12.51 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0001576/0.1948, allocations: 59.91 kB / 0.9959 GB, free: 12.45 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.62e-06/0.1948, allocations: 7.938 kB / 0.9959 GB, free: 12.44 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0001235/0.1949, allocations: 19.89 kB / 0.9959 GB, free: 12.42 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 1.684e-05/0.195, allocations: 8 kB / 0.9959 GB, free: 12.41 MB / 0.9636 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 7
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (33):
 * Single equations (assignments): 33
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.000103/0.1951, allocations: 128.5 kB / 0.996 GB, free: 12.28 MB / 0.9636 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 4.345e-05/0.1951, allocations: 31.97 kB / 0.9961 GB, free: 12.25 MB / 0.9636 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 5.995e-05/0.1952, allocations: 43.38 kB / 0.9961 GB, free: 12.2 MB / 0.9636 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.757e-06/0.1952, allocations: 7.984 kB / 0.9961 GB, free: 12.2 MB / 0.9636 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.844e-06/0.1952, allocations: 0 / 0.9961 GB, free: 12.2 MB / 0.9636 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001707/0.1953, allocations: 279.3 kB / 0.9964 GB, free: 11.88 MB / 0.9636 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0005753/0.1959, allocations: 0.5481 MB / 0.9969 GB, free: 11.28 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.893e-06/0.1959, allocations: 0 / 0.9969 GB, free: 11.28 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002725/0.1962, allocations: 94.7 kB / 0.997 GB, free: 11.19 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (simulation): time 4.969e-06/0.1962, allocations: 4 kB / 0.997 GB, free: 11.18 MB / 0.9636 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.836e-05/0.1962, allocations: 12.12 kB / 0.997 GB, free: 11.17 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.784e-06/0.1962, allocations: 0 / 0.997 GB, free: 11.17 MB / 0.9636 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.128e-06/0.1962, allocations: 7.938 kB / 0.997 GB, free: 11.16 MB / 0.9636 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0002845/0.1965, allocations: 355.4 kB / 0.9974 GB, free: 10.78 MB / 0.9636 GB
Notification: Performance of postOpt removeConstants (simulation): time 7.812e-05/0.1966, allocations: 59.67 kB / 0.9974 GB, free: 10.72 MB / 0.9636 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 2.952e-05/0.1966, allocations: 8 kB / 0.9974 GB, free: 10.71 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001275/0.1967, allocations: 12 kB / 0.9974 GB, free: 10.7 MB / 0.9636 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 3.083e-05/0.1968, allocations: 27.84 kB / 0.9975 GB, free: 10.67 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.164e-05/0.1968, allocations: 7.938 kB / 0.9975 GB, free: 10.66 MB / 0.9636 GB
Notification: Performance of sorting global known variables: time 8.549e-05/0.1969, allocations: 112.7 kB / 0.9976 GB, free: 10.55 MB / 0.9636 GB
Notification: Performance of sort global known variables: time 4e-08/0.1969, allocations: 4 kB / 0.9976 GB, free: 10.55 MB / 0.9636 GB
Notification: Performance of remove unused functions: time 0.000274/0.1971, allocations: 143.7 kB / 0.9977 GB, free: 10.41 MB / 0.9636 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 4 (vol.dynBal.medium.Xi[1],vol.dynBal.U,vol.dynBal.m,vol.dynBal.mC[1])
 * 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 (25):
 * Single equations (assignments): 25
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0002072/0.1973, allocations: 116.3 kB / 0.9978 GB, free: 10.28 MB / 0.9636 GB
Notification: Performance of simCode: created initialization part: time 0.0001719/0.1975, allocations: 123.5 kB / 0.998 GB, free: 10.16 MB / 0.9636 GB
Notification: Performance of simCode: created event and clocks part: time 5.25e-06/0.1975, allocations: 4.375 kB / 0.998 GB, free: 10.16 MB / 0.9636 GB
Notification: Performance of simCode: created simulation system equations: time 6.268e-05/0.1976, allocations: 68.7 kB / 0.998 GB, free: 10.09 MB / 0.9636 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0005783/0.1982, allocations: 247.6 kB / 0.9983 GB, free: 9.848 MB / 0.9636 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001139/0.1993, allocations: 0.8236 MB / 0.9991 GB, free: 8.977 MB / 0.9636 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 9.358e-05/0.1994, allocations: 137.2 kB / 0.9992 GB, free: 8.824 MB / 0.9636 GB
Notification: Performance of simCode: alias equations: time 0.0001489/0.1995, allocations: 59.28 kB / 0.9993 GB, free: 8.766 MB / 0.9636 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003231/0.1999, allocations: 205.2 kB / 0.9994 GB, free: 8.566 MB / 0.9636 GB
Notification: Performance of SimCode: time 1.082e-06/0.1999, allocations: 0 / 0.9994 GB, free: 8.566 MB / 0.9636 GB
Notification: Performance of Templates: time 0.0113/0.2112, allocations: 9.109 MB / 1.008 GB, free: 15.7 MB / 0.9792 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.pipe ; mkfifo Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.pipe >> ../files/Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.sim & ./Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation.pipe 2>&1) [Timeout 240]
diffSimulationResults("Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MassAccumulation_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_MixingVolumes_Validation_MassAccumulation.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 6.043812803924084]