Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/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 10.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol.p|vol1.p|vol.T|vol1.T",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47")
translateModel(Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol.p|vol1.p|vol.T|vol1.T",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/package.mo): time 2.234/2.234, allocations: 393.5 MB / 408.4 MB, free: 10.88 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.001187/0.001187, allocations: 180 kB / 0.4902 GB, free: 2.129 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.5/1.5, allocations: 223.2 MB / 0.7992 GB, free: 14.68 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.0009866/0.0009865, allocations: 98.66 kB / 0.9396 GB, free: 1.867 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003691/0.0003691, allocations: 13.3 kB / 1.09 GB, free: 216.2 MB / 0.823 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3154/0.3158, allocations: 143 MB / 1.229 GB, free: 105.7 MB / 0.823 GB
Notification: Performance of FrontEnd - scodeFlatten: time 1.23/1.546, allocations: 0.5217 GB / 1.751 GB, free: 12.92 MB / 1.073 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003392/1.547, allocations: 92.64 kB / 1.751 GB, free: 12.87 MB / 1.073 GB
Notification: Performance of FrontEnd - DAE generated: time 1.648/3.194, allocations: 409 MB / 2.15 GB, free: 184.3 MB / 1.167 GB
Notification: Performance of FrontEnd: time 2.194e-06/3.194, allocations: 0 / 2.15 GB, free: 184.3 MB / 1.167 GB
Notification: Performance of Transformations before backend: time 0.000146/3.195, allocations: 24 kB / 2.151 GB, free: 184.3 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: 112
 * Number of variables: 112
Notification: Performance of Generate backend data structure: time 0.00364/3.198, allocations: 1.282 MB / 2.152 GB, free: 182.9 MB / 1.167 GB
Notification: Performance of prepare preOptimizeDAE: time 4.432e-05/3.198, allocations: 12.03 kB / 2.152 GB, free: 182.9 MB / 1.167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00145/3.2, allocations: 154.9 kB / 2.152 GB, free: 182.8 MB / 1.167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002629/3.202, allocations: 1.003 MB / 2.153 GB, free: 181.7 MB / 1.167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.186e-05/3.202, allocations: 36.94 kB / 2.153 GB, free: 181.7 MB / 1.167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001403/3.203, allocations: 44 kB / 2.153 GB, free: 181.6 MB / 1.167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0009207/3.203, allocations: 0.504 MB / 2.153 GB, free: 181.1 MB / 1.167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.221e-05/3.204, allocations: 0 / 2.153 GB, free: 181.1 MB / 1.167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.48e-05/3.204, allocations: 20 kB / 2.153 GB, free: 181.1 MB / 1.167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.202e-05/3.204, allocations: 12 kB / 2.154 GB, free: 181.1 MB / 1.167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000548/3.204, allocations: 323.7 kB / 2.154 GB, free: 180.8 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.00284/3.207, allocations: 2.235 MB / 2.156 GB, free: 178.4 MB / 1.167 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0003754/3.207, allocations: 264.5 kB / 2.156 GB, free: 178.1 MB / 1.167 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001025/3.208, allocations: 2.019 MB / 2.158 GB, free: 175.6 MB / 1.167 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.652e-05/3.208, allocations: 43.09 kB / 2.158 GB, free: 175.6 MB / 1.167 GB
Notification: Performance of pre-optimization done (n=31): time 3.066e-06/3.208, allocations: 0 / 2.158 GB, free: 175.6 MB / 1.167 GB
Notification: Performance of matching and sorting (n=43): time 0.004307/3.213, allocations: 1.791 MB / 2.16 GB, free: 173.7 MB / 1.167 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.162e-05/3.213, allocations: 59.41 kB / 2.16 GB, free: 173.6 MB / 1.167 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005606/3.213, allocations: 442.2 kB / 2.16 GB, free: 173.2 MB / 1.167 GB
Notification: Performance of collectPreVariables (initialization): time 4.889e-05/3.213, allocations: 37.7 kB / 2.161 GB, free: 173.2 MB / 1.167 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000174/3.214, allocations: 328.4 kB / 2.161 GB, free: 172.8 MB / 1.167 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001146/3.214, allocations: 149.8 kB / 2.161 GB, free: 172.7 MB / 1.167 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 1.881e-05/3.214, allocations: 8 kB / 2.161 GB, free: 172.7 MB / 1.167 GB
Notification: Performance of setup shared object (initialization): time 0.0001029/3.214, allocations: 370.7 kB / 2.161 GB, free: 172.3 MB / 1.167 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002053/3.214, allocations: 149 kB / 2.161 GB, free: 172.2 MB / 1.167 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002483/3.214, allocations: 259.7 kB / 2.162 GB, free: 171.9 MB / 1.167 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0002711/3.215, allocations: 197.5 kB / 2.162 GB, free: 171.7 MB / 1.167 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.784e-06/3.215, allocations: 0 / 2.162 GB, free: 171.7 MB / 1.167 GB
Notification: Performance of matching and sorting (n=57) (initialization): time 0.0009447/3.216, allocations: 0.6149 MB / 2.163 GB, free: 171 MB / 1.167 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002687/3.216, allocations: 1.134 MB / 2.164 GB, free: 169.8 MB / 1.167 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.088e-05/3.216, allocations: 4 kB / 2.164 GB, free: 169.8 MB / 1.167 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007004/3.217, allocations: 201.5 kB / 2.164 GB, free: 169.6 MB / 1.167 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002291/3.217, allocations: 63.91 kB / 2.164 GB, free: 169.5 MB / 1.167 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008425/3.218, allocations: 1.347 MB / 2.165 GB, free: 168.1 MB / 1.167 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005384/3.218, allocations: 39.81 kB / 2.165 GB, free: 168.1 MB / 1.167 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.028e-05/3.218, allocations: 24 kB / 2.165 GB, free: 168.1 MB / 1.167 GB
Notification: Performance of prepare postOptimizeDAE: time 1.108e-05/3.218, allocations: 4 kB / 2.165 GB, free: 168.1 MB / 1.167 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0008058/3.219, allocations: 0.5242 MB / 2.166 GB, free: 167.5 MB / 1.167 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.484e-06/3.219, allocations: 7.984 kB / 2.166 GB, free: 167.5 MB / 1.167 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005995/3.22, allocations: 205.9 kB / 2.166 GB, free: 167.3 MB / 1.167 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000206/3.22, allocations: 63.91 kB / 2.166 GB, free: 167.3 MB / 1.167 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007419/3.221, allocations: 1.351 MB / 2.167 GB, free: 165.9 MB / 1.167 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005081/3.221, allocations: 36.06 kB / 2.167 GB, free: 165.8 MB / 1.167 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.211e-05/3.221, allocations: 24 kB / 2.167 GB, free: 165.8 MB / 1.167 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 13
 * 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 (41):
 * Single equations (assignments): 39
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 8,1 7}
Notification: Performance of prepare postOptimizeDAE: time 0.0003619/3.222, allocations: 297 kB / 2.168 GB, free: 165.5 MB / 1.167 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001158/3.222, allocations: 63.2 kB / 2.168 GB, free: 165.4 MB / 1.167 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001184/3.223, allocations: 0.6264 MB / 2.168 GB, free: 164.8 MB / 1.167 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.129e-05/3.223, allocations: 11.94 kB / 2.168 GB, free: 164.8 MB / 1.167 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.272e-06/3.223, allocations: 0 / 2.168 GB, free: 164.8 MB / 1.167 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0007351/3.224, allocations: 0.6433 MB / 2.169 GB, free: 164.1 MB / 1.167 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002095/3.226, allocations: 1.454 MB / 2.17 GB, free: 162.6 MB / 1.167 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.548e-06/3.226, allocations: 3.938 kB / 2.17 GB, free: 162.6 MB / 1.167 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0001674/3.226, allocations: 43.98 kB / 2.17 GB, free: 162.5 MB / 1.167 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0008945/3.227, allocations: 217.5 kB / 2.171 GB, free: 162.3 MB / 1.167 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.467e-05/3.227, allocations: 11.98 kB / 2.171 GB, free: 162.3 MB / 1.167 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0007839/3.228, allocations: 1.323 MB / 2.172 GB, free: 160.9 MB / 1.167 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.656e-06/3.228, allocations: 4.031 kB / 2.172 GB, free: 160.9 MB / 1.167 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00118/3.229, allocations: 0.8787 MB / 2.173 GB, free: 160 MB / 1.167 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003197/3.229, allocations: 196.3 kB / 2.173 GB, free: 159.8 MB / 1.167 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001037/3.229, allocations: 8 kB / 2.173 GB, free: 159.8 MB / 1.167 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00048/3.23, allocations: 35.95 kB / 2.173 GB, free: 159.7 MB / 1.167 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 5.513e-05/3.23, allocations: 23.95 kB / 2.173 GB, free: 159.7 MB / 1.167 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.842e-05/3.23, allocations: 16 kB / 2.173 GB, free: 159.7 MB / 1.167 GB
Notification: Performance of sorting global known variables: time 0.0004261/3.231, allocations: 358.8 kB / 2.173 GB, free: 159.4 MB / 1.167 GB
Notification: Performance of sort global known variables: time 1.5e-07/3.231, allocations: 0 / 2.173 GB, free: 159.4 MB / 1.167 GB
Notification: Performance of remove unused functions: time 0.001808/3.232, allocations: 0.4996 MB / 2.174 GB, free: 158.9 MB / 1.167 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 2 (vol.dynBal.medium.T,vol1.dynBal.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 (30):
 * Single equations (assignments): 27
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 7,2 5}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001509/3.234, allocations: 0.5086 MB / 2.174 GB, free: 158.3 MB / 1.167 GB
Notification: Performance of simCode: created initialization part: time 0.00129/3.235, allocations: 0.6606 MB / 2.175 GB, free: 157.7 MB / 1.167 GB
Notification: Performance of simCode: created event and clocks part: time 4.869e-06/3.235, allocations: 0 / 2.175 GB, free: 157.7 MB / 1.167 GB
Notification: Performance of simCode: created simulation system equations: time 0.0004229/3.236, allocations: 243.7 kB / 2.175 GB, free: 157.4 MB / 1.167 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00139/3.237, allocations: 311.3 kB / 2.176 GB, free: 157.1 MB / 1.167 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002217/3.239, allocations: 1.498 MB / 2.177 GB, free: 155.6 MB / 1.167 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003808/3.24, allocations: 0.9303 MB / 2.178 GB, free: 154.7 MB / 1.167 GB
Notification: Performance of simCode: alias equations: time 0.0006591/3.24, allocations: 199.3 kB / 2.178 GB, free: 154.5 MB / 1.167 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001579/3.24, allocations: 67.39 kB / 2.178 GB, free: 154.4 MB / 1.167 GB
Notification: Performance of SimCode: time 4.21e-07/3.24, allocations: 0 / 2.178 GB, free: 154.4 MB / 1.167 GB
Notification: Performance of Templates: time 0.02486/3.265, allocations: 15.93 MB / 2.194 GB, free: 138.7 MB / 1.167 GB
make -j1 -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.makefile
(rm -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe ; mkfifo Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe >> ../files/Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.sim & ./Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_MixingVolumes_Validation_CoupledVolumesGlycol47.csv","../files/Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches