Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 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 Buildings with version 9.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo)
Running command: translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol.dynBal.m|vol.T|sou.ports.1..m_flow|vol.ports.2..m_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass")
translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol.dynBal.m|vol.T|sou.ports.1..m_flow|vol.ports.2..m_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo): time 2.264/2.264, allocations: 390.3 MB / 405.3 MB, free: 13.45 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001166/0.001166, allocations: 175.3 kB / 498.1 MB, free: 5.688 MB / 394.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.664/1.664, allocations: 223.2 MB / 0.7948 GB, free: 17.89 MB / 0.5573 GB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001119/0.001119, allocations: 102.8 kB / 0.9346 GB, free: 6.16 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004037/0.000404, allocations: 11.91 kB / 1.084 GB, free: 221.1 MB / 0.823 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2998/0.3002, allocations: 142.3 MB / 1.223 GB, free: 114.2 MB / 0.823 GB
Notification: Performance of FrontEnd - scodeFlatten: time 4.283/4.584, allocations: 1.922 GB / 3.145 GB, free: 91.17 MB / 1.167 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003071/4.584, allocations: 91.95 kB / 3.145 GB, free: 91.08 MB / 1.167 GB
Notification: Performance of FrontEnd - DAE generated: time 1.327/5.911, allocations: 374.2 MB / 3.51 GB, free: 184.9 MB / 1.167 GB
Notification: Performance of FrontEnd: time 3.246e-06/5.911, allocations: 0 / 3.51 GB, free: 184.9 MB / 1.167 GB
Notification: Performance of Transformations before backend: time 7.108e-05/5.911, allocations: 16 kB / 3.51 GB, free: 184.9 MB / 1.167 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 104
 * Number of variables: 104
Notification: Performance of Generate backend data structure: time 0.002383/5.913, allocations: 0.9662 MB / 3.511 GB, free: 183.9 MB / 1.167 GB
Notification: Performance of prepare preOptimizeDAE: time 5.156e-05/5.913, allocations: 8.031 kB / 3.511 GB, free: 183.9 MB / 1.167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001143/5.915, allocations: 179 kB / 3.511 GB, free: 183.7 MB / 1.167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001059/5.916, allocations: 0.5715 MB / 3.512 GB, free: 183.1 MB / 1.167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.06e-05/5.916, allocations: 33 kB / 3.512 GB, free: 183.1 MB / 1.167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 7.758e-05/5.916, allocations: 44 kB / 3.512 GB, free: 183 MB / 1.167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0007996/5.917, allocations: 446.3 kB / 3.512 GB, free: 182.6 MB / 1.167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.883e-05/5.917, allocations: 0 / 3.512 GB, free: 182.6 MB / 1.167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.008e-05/5.917, allocations: 19.98 kB / 3.512 GB, free: 182.6 MB / 1.167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.208e-05/5.917, allocations: 20.95 kB / 3.512 GB, free: 182.6 MB / 1.167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006906/5.917, allocations: 407.8 kB / 3.513 GB, free: 182.2 MB / 1.167 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.002546/5.92, allocations: 2.01 MB / 3.515 GB, free: 180 MB / 1.167 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0004715/5.921, allocations: 301.2 kB / 3.515 GB, free: 179.7 MB / 1.167 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003237/5.921, allocations: 186.2 kB / 3.515 GB, free: 179.5 MB / 1.167 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.48e-05/5.921, allocations: 46.55 kB / 3.515 GB, free: 179.4 MB / 1.167 GB
Notification: Performance of pre-optimization done (n=30): time 2.224e-06/5.921, allocations: 0 / 3.515 GB, free: 179.4 MB / 1.167 GB
Notification: Performance of matching and sorting (n=30): time 0.001496/5.922, allocations: 0.6486 MB / 3.516 GB, free: 178.7 MB / 1.167 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.798e-05/5.922, allocations: 59.41 kB / 3.516 GB, free: 178.7 MB / 1.167 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003921/5.923, allocations: 385.2 kB / 3.516 GB, free: 178.3 MB / 1.167 GB
Notification: Performance of collectPreVariables (initialization): time 3.573e-05/5.923, allocations: 29.7 kB / 3.516 GB, free: 178.2 MB / 1.167 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001875/5.923, allocations: 276.2 kB / 3.516 GB, free: 178 MB / 1.167 GB
Notification: Performance of collectInitialBindings (initialization): time 8.471e-05/5.923, allocations: 114.4 kB / 3.517 GB, free: 177.9 MB / 1.167 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 1.525e-05/5.923, allocations: 11.94 kB / 3.517 GB, free: 177.8 MB / 1.167 GB
Notification: Performance of setup shared object (initialization): time 0.0001154/5.923, allocations: 354.8 kB / 3.517 GB, free: 177.5 MB / 1.167 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000219/5.924, allocations: 123.9 kB / 3.517 GB, free: 177.4 MB / 1.167 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002879/5.924, allocations: 216.4 kB / 3.517 GB, free: 177.1 MB / 1.167 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0002622/5.924, allocations: 163.9 kB / 3.517 GB, free: 177 MB / 1.167 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.226e-06/5.924, allocations: 0 / 3.517 GB, free: 177 MB / 1.167 GB
Notification: Performance of matching and sorting (n=37) (initialization): time 0.0006608/5.925, allocations: 416.9 kB / 3.518 GB, free: 176.6 MB / 1.167 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000156/5.925, allocations: 0.5293 MB / 3.518 GB, free: 176 MB / 1.167 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.155e-06/5.925, allocations: 0 / 3.518 GB, free: 176 MB / 1.167 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.157e-05/5.925, allocations: 4 kB / 3.518 GB, free: 176 MB / 1.167 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003449/5.925, allocations: 71.84 kB / 3.518 GB, free: 175.9 MB / 1.167 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 9.768e-06/5.925, allocations: 0 / 3.518 GB, free: 175.9 MB / 1.167 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005152/5.926, allocations: 67.64 kB / 3.518 GB, free: 175.8 MB / 1.167 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.232e-05/5.926, allocations: 12 kB / 3.518 GB, free: 175.8 MB / 1.167 GB
Notification: Performance of prepare postOptimizeDAE: time 7.454e-06/5.926, allocations: 4 kB / 3.518 GB, free: 175.8 MB / 1.167 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0005036/5.926, allocations: 339.7 kB / 3.519 GB, free: 175.5 MB / 1.167 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.114e-06/5.927, allocations: 0 / 3.519 GB, free: 175.5 MB / 1.167 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.639e-06/5.927, allocations: 7.953 kB / 3.519 GB, free: 175.5 MB / 1.167 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002791/5.927, allocations: 80.05 kB / 3.519 GB, free: 175.4 MB / 1.167 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.846e-06/5.927, allocations: 0 / 3.519 GB, free: 175.4 MB / 1.167 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004264/5.927, allocations: 63.64 kB / 3.519 GB, free: 175.3 MB / 1.167 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.705e-05/5.927, allocations: 16 kB / 3.519 GB, free: 175.3 MB / 1.167 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 6
 * 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 (37):
 * Single equations (assignments): 37
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0002618/5.928, allocations: 284.8 kB / 3.519 GB, free: 175 MB / 1.167 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 6.985e-05/5.928, allocations: 47.44 kB / 3.519 GB, free: 175 MB / 1.167 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0007231/5.928, allocations: 431.1 kB / 3.52 GB, free: 174.6 MB / 1.167 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.791e-06/5.928, allocations: 7.984 kB / 3.52 GB, free: 174.6 MB / 1.167 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.292e-06/5.928, allocations: 0 / 3.52 GB, free: 174.6 MB / 1.167 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0005654/5.929, allocations: 450.4 kB / 3.52 GB, free: 174.1 MB / 1.167 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001486/5.93, allocations: 1.135 MB / 3.521 GB, free: 172.9 MB / 1.167 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.158e-06/5.93, allocations: 4 kB / 3.521 GB, free: 172.9 MB / 1.167 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002687/5.931, allocations: 68.06 kB / 3.521 GB, free: 172.8 MB / 1.167 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0002119/5.931, allocations: 44.83 kB / 3.521 GB, free: 172.8 MB / 1.167 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.533e-05/5.931, allocations: 15.94 kB / 3.521 GB, free: 172.7 MB / 1.167 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0008852/5.932, allocations: 1.445 MB / 3.523 GB, free: 171.2 MB / 1.167 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.044e-06/5.932, allocations: 3.938 kB / 3.523 GB, free: 171.1 MB / 1.167 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0008902/5.933, allocations: 0.7952 MB / 3.524 GB, free: 170.3 MB / 1.167 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001932/5.933, allocations: 168.3 kB / 3.524 GB, free: 170.1 MB / 1.167 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 5.325e-05/5.933, allocations: 8 kB / 3.524 GB, free: 170.1 MB / 1.167 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004208/5.933, allocations: 36.03 kB / 3.524 GB, free: 170 MB / 1.167 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.926e-05/5.934, allocations: 27.92 kB / 3.524 GB, free: 170 MB / 1.167 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.219e-05/5.934, allocations: 11.98 kB / 3.524 GB, free: 170 MB / 1.167 GB
Notification: Performance of sorting global known variables: time 0.0002661/5.934, allocations: 314.9 kB / 3.524 GB, free: 169.7 MB / 1.167 GB
Notification: Performance of sort global known variables: time 1.3e-07/5.934, allocations: 3.938 kB / 3.524 GB, free: 169.7 MB / 1.167 GB
Notification: Performance of remove unused functions: time 0.001175/5.935, allocations: 419.1 kB / 3.524 GB, free: 169.3 MB / 1.167 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * Number of states: 2 (vol.dynBal.medium.Xi[1],vol.dynBal.U)
 * 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 (28):
 * Single equations (assignments): 27
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 2}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001356/5.936, allocations: 1.098 MB / 3.526 GB, free: 168.2 MB / 1.167 GB
Notification: Performance of simCode: created initialization part: time 0.0008791/5.937, allocations: 0.4918 MB / 3.526 GB, free: 167.7 MB / 1.167 GB
Notification: Performance of simCode: created event and clocks part: time 3.787e-06/5.937, allocations: 0 / 3.526 GB, free: 167.7 MB / 1.167 GB
Notification: Performance of simCode: created simulation system equations: time 0.000421/5.938, allocations: 299.3 kB / 3.526 GB, free: 167.4 MB / 1.167 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001263/5.939, allocations: 303.3 kB / 3.527 GB, free: 167.1 MB / 1.167 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001503/5.941, allocations: 1.339 MB / 3.528 GB, free: 165.7 MB / 1.167 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003276/5.941, allocations: 0.9134 MB / 3.529 GB, free: 164.8 MB / 1.167 GB
Notification: Performance of simCode: alias equations: time 0.0005163/5.941, allocations: 164.4 kB / 3.529 GB, free: 164.6 MB / 1.167 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001021/5.942, allocations: 39.44 kB / 3.529 GB, free: 164.6 MB / 1.167 GB
Notification: Performance of SimCode: time 4.51e-07/5.942, allocations: 0 / 3.529 GB, free: 164.6 MB / 1.167 GB
Notification: Performance of Templates: time 0.02892/5.97, allocations: 22.72 MB / 3.551 GB, free: 141.9 MB / 1.167 GB
make -j1 -f Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.makefile
(rm -f Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.pipe ; mkfifo Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.pipe >> ../files/Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.sim & ./Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_MixingVolumes_Validation_MixingVolumeSteadyStateMass.csv","../files/Buildings_9_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches