Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.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/Buildings 9.1.2-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.2-maint.9.1.x/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(Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|heaTan.vol.1..T|heaTan.vol.2..T|heaTan.vol.3..T|heaTan.vol.4..T|heaTan.vol.5..T|heaTan.vol.6..T|heaTan.vol.7..T|cooTan.vol.1..T|cooTan.vol.2..T|cooTan.vol.3..T|cooTan.vol.4..T|cooTan.vol.5..T|cooTan.vol.6..T|cooTan.vol.7..T|dHTan.y|dHTanEnh.y",fileNamePrefix="Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial")
translateModel(Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|heaTan.vol.1..T|heaTan.vol.2..T|heaTan.vol.3..T|heaTan.vol.4..T|heaTan.vol.5..T|heaTan.vol.6..T|heaTan.vol.7..T|cooTan.vol.1..T|cooTan.vol.2..T|cooTan.vol.3..T|cooTan.vol.4..T|cooTan.vol.5..T|cooTan.vol.6..T|cooTan.vol.7..T|dHTan.y|dHTanEnh.y",fileNamePrefix="Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001041/0.001041, allocations: 84.38 kB / 15.06 MB, free: 1.09 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.001254/0.001254, allocations: 168.7 kB / 15.95 MB, free: 204 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.49/1.49, allocations: 223.3 MB / 240 MB, free: 5.418 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.2-maint.9.1.x/package.mo): time 2.574/2.574, allocations: 390.9 MB / 0.666 GB, free: 2.484 MB / 0.5137 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003647/0.0003648, allocations: 8 kB / 0.8153 GB, free: 13.66 MB / 0.67 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8537/0.8541, allocations: 142.4 MB / 0.9544 GB, free: 7.727 MB / 0.7169 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial): time 0.04429/0.8984, allocations: 45.35 MB / 0.9987 GB, free: 2.059 MB / 0.7481 GB
Notification: Performance of NFInst.instExpressions: time 0.02054/0.919, allocations: 12.96 MB / 1.011 GB, free: 5.066 MB / 0.7637 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002893/0.9219, allocations: 59.62 kB / 1.011 GB, free: 5.008 MB / 0.7637 GB
Notification: Performance of NFTyping.typeComponents: time 0.001906/0.9238, allocations: 0.5743 MB / 1.012 GB, free: 4.43 MB / 0.7637 GB
Notification: Performance of NFTyping.typeBindings: time 0.005488/0.9293, allocations: 1.79 MB / 1.014 GB, free: 2.633 MB / 0.7637 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00284/0.9322, allocations: 0.9358 MB / 1.015 GB, free: 1.703 MB / 0.7637 GB
Notification: Performance of NFFlatten.flatten: time 0.02098/0.9532, allocations: 21.74 MB / 1.036 GB, free: 11.91 MB / 0.795 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00988/0.9631, allocations: 6.531 MB / 1.042 GB, free: 5.301 MB / 0.795 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0121/0.9753, allocations: 4.767 MB / 1.047 GB, free: 0.5156 MB / 0.795 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01078/0.9861, allocations: 4.936 MB / 1.052 GB, free: 11.56 MB / 0.8106 GB
Notification: Performance of NFPackage.collectConstants: time 0.001875/0.988, allocations: 300 kB / 1.052 GB, free: 11.27 MB / 0.8106 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005271/0.9933, allocations: 0.7411 MB / 1.053 GB, free: 10.52 MB / 0.8106 GB
Notification: Performance of NFScalarize.scalarize: time 0.001799/0.9951, allocations: 1.354 MB / 1.054 GB, free: 9.164 MB / 0.8106 GB
Notification: Performance of NFVerifyModel.verify: time 0.003391/0.9985, allocations: 1.483 MB / 1.056 GB, free: 7.672 MB / 0.8106 GB
Notification: Performance of NFConvertDAE.convert: time 0.01033/1.009, allocations: 9.461 MB / 1.065 GB, free: 14.19 MB / 0.8262 GB
Notification: Performance of FrontEnd - DAE generated: time 7.875e-06/1.009, allocations: 0 / 1.065 GB, free: 14.19 MB / 0.8262 GB
Notification: Performance of FrontEnd: time 2.195e-06/1.009, allocations: 0 / 1.065 GB, free: 14.19 MB / 0.8262 GB
Notification: Performance of Transformations before backend: time 0.0003257/1.009, allocations: 4 kB / 1.065 GB, free: 14.18 MB / 0.8262 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1414
 * Number of variables: 1414
Notification: Performance of Generate backend data structure: time 0.01298/1.022, allocations: 6.297 MB / 1.071 GB, free: 7.812 MB / 0.8262 GB
Notification: Performance of prepare preOptimizeDAE: time 6.539e-05/1.022, allocations: 8.562 kB / 1.071 GB, free: 7.805 MB / 0.8262 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0029/1.025, allocations: 0.7843 MB / 1.072 GB, free: 7.012 MB / 0.8262 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01148/1.037, allocations: 6.09 MB / 1.078 GB, free: 0.8594 MB / 0.8262 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003509/1.037, allocations: 419 kB / 1.078 GB, free: 460 kB / 0.8262 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001597/1.039, allocations: 0.5389 MB / 1.079 GB, free: 15.91 MB / 0.8419 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0186/1.057, allocations: 8.037 MB / 1.086 GB, free: 7.633 MB / 0.8419 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002187/1.058, allocations: 11.94 kB / 1.086 GB, free: 7.621 MB / 0.8419 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001307/1.059, allocations: 236 kB / 1.087 GB, free: 7.391 MB / 0.8419 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001863/1.059, allocations: 163.9 kB / 1.087 GB, free: 7.23 MB / 0.8419 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01237/1.071, allocations: 6.485 MB / 1.093 GB, free: 0.7344 MB / 0.8419 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.05246/1.124, allocations: 31.16 MB / 1.124 GB, free: 15.74 MB / 0.8887 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006531/1.13, allocations: 3.633 MB / 1.127 GB, free: 12.11 MB / 0.8887 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004557/1.135, allocations: 2.882 MB / 1.13 GB, free: 9.219 MB / 0.8887 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001052/1.136, allocations: 0.8358 MB / 1.131 GB, free: 8.215 MB / 0.8887 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.606e-05/1.136, allocations: 72.67 kB / 1.131 GB, free: 8.133 MB / 0.8887 GB
Notification: Performance of pre-optimization done (n=267): time 5.561e-06/1.136, allocations: 0 / 1.131 GB, free: 8.133 MB / 0.8887 GB
Notification: Performance of matching and sorting (n=267): time 0.01184/1.148, allocations: 5.743 MB / 1.136 GB, free: 2.289 MB / 0.8887 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.471e-05/1.148, allocations: 77.52 kB / 1.136 GB, free: 2.199 MB / 0.8887 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01059/1.159, allocations: 4.993 MB / 1.141 GB, free: 13.21 MB / 0.9044 GB
Notification: Performance of collectPreVariables (initialization): time 0.0006831/1.16, allocations: 85.64 kB / 1.141 GB, free: 13.12 MB / 0.9044 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003121/1.163, allocations: 2.872 MB / 1.144 GB, free: 10.21 MB / 0.9044 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001726/1.164, allocations: 0.9398 MB / 1.145 GB, free: 9.262 MB / 0.9044 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000432/1.165, allocations: 68 kB / 1.145 GB, free: 9.195 MB / 0.9044 GB
Notification: Performance of setup shared object (initialization): time 0.0003574/1.165, allocations: 465.8 kB / 1.146 GB, free: 8.734 MB / 0.9044 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003053/1.168, allocations: 1.662 MB / 1.147 GB, free: 7.07 MB / 0.9044 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003957/1.172, allocations: 2.912 MB / 1.15 GB, free: 3.605 MB / 0.9044 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003936/1.176, allocations: 2.277 MB / 1.152 GB, free: 1.309 MB / 0.9044 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.231e-05/1.176, allocations: 12 kB / 1.152 GB, free: 1.297 MB / 0.9044 GB
Notification: Performance of matching and sorting (n=475) (initialization): time 0.01042/1.187, allocations: 5.399 MB / 1.158 GB, free: 11.84 MB / 0.92 GB
Notification: Performance of prepare postOptimizeDAE: time 6.799e-05/1.187, allocations: 24.06 kB / 1.158 GB, free: 11.82 MB / 0.92 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.351e-05/1.187, allocations: 47.89 kB / 1.158 GB, free: 11.77 MB / 0.92 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001041/1.188, allocations: 436.8 kB / 1.158 GB, free: 11.34 MB / 0.92 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003044/1.191, allocations: 0.858 MB / 1.159 GB, free: 10.48 MB / 0.92 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005892/1.197, allocations: 5.262 MB / 1.164 GB, free: 4.953 MB / 0.92 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005632/1.203, allocations: 0.6432 MB / 1.165 GB, free: 4.305 MB / 0.92 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007566/1.203, allocations: 180 kB / 1.165 GB, free: 4.129 MB / 0.92 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 181
 * Number of states: 0 ()
 * Number of discrete variables: 2 (dHTan.local_reset,dHTanEnh.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (447):
 * Single equations (assignments): 445
 * 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: 2 {(1,100.0%) 14,(1,100.0%) 14}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.005127/1.208, allocations: 2.284 MB / 1.167 GB, free: 1.832 MB / 0.92 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001891/1.21, allocations: 494.1 kB / 1.168 GB, free: 1.344 MB / 0.92 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008116/1.218, allocations: 4.159 MB / 1.172 GB, free: 13.13 MB / 0.9356 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.638e-05/1.219, allocations: 28 kB / 1.172 GB, free: 13.1 MB / 0.9356 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.984e-05/1.219, allocations: 4 kB / 1.172 GB, free: 13.1 MB / 0.9356 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.005406/1.224, allocations: 3.62 MB / 1.175 GB, free: 9.363 MB / 0.9356 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02195/1.246, allocations: 10.2 MB / 1.185 GB, free: 14.99 MB / 0.9512 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.732e-05/1.246, allocations: 8 kB / 1.185 GB, free: 14.98 MB / 0.9512 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00216/1.248, allocations: 0.4993 MB / 1.186 GB, free: 14.48 MB / 0.9512 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0008668/1.249, allocations: 369.5 kB / 1.186 GB, free: 14.11 MB / 0.9512 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002788/1.249, allocations: 79.95 kB / 1.186 GB, free: 14.04 MB / 0.9512 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005529/1.255, allocations: 5.203 MB / 1.191 GB, free: 8.566 MB / 0.9512 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.522e-06/1.255, allocations: 7.938 kB / 1.191 GB, free: 8.559 MB / 0.9512 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01064/1.266, allocations: 6.213 MB / 1.197 GB, free: 2.176 MB / 0.9512 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004057/1.27, allocations: 1.166 MB / 1.198 GB, free: 0.9844 MB / 0.9512 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001869/1.272, allocations: 63.95 kB / 1.198 GB, free: 0.9219 MB / 0.9512 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004684/1.276, allocations: 338.5 kB / 1.199 GB, free: 0.5938 MB / 0.9512 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004673/1.277, allocations: 177.6 kB / 1.199 GB, free: 428 kB / 0.9512 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004779/1.277, allocations: 127.9 kB / 1.199 GB, free: 300 kB / 0.9512 GB
Notification: Performance of sorting global known variables: time 0.009128/1.286, allocations: 3.644 MB / 1.203 GB, free: 12.66 MB / 0.9669 GB
Notification: Performance of sort global known variables: time 1.513e-06/1.286, allocations: 0 / 1.203 GB, free: 12.66 MB / 0.9669 GB
Notification: Performance of remove unused functions: time 0.01177/1.298, allocations: 1.777 MB / 1.204 GB, free: 10.88 MB / 0.9669 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 19
 * Number of states: 16 (heaTan.vol[1].dynBal.U,heaTan.vol[2].dynBal.U,heaTan.vol[3].dynBal.U,heaTan.vol[4].dynBal.U,heaTan.vol[5].dynBal.U,heaTan.vol[6].dynBal.U,heaTan.vol[7].dynBal.U,cooTan.vol[1].dynBal.U,cooTan.vol[2].dynBal.U,cooTan.vol[3].dynBal.U,cooTan.vol[4].dynBal.U,cooTan.vol[5].dynBal.U,cooTan.vol[6].dynBal.U,cooTan.vol[7].dynBal.U,dHTanEnh.y,dHTan.y)
 * 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 (242):
 * Single equations (assignments): 237
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * 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: 2 {(1,100.0%) 14,(1,100.0%) 14}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.002239/1.301, allocations: 473.3 kB / 1.205 GB, free: 10.42 MB / 0.9669 GB
Notification: Performance of simCode: created initialization part: time 0.009801/1.31, allocations: 4.242 MB / 1.209 GB, free: 6.141 MB / 0.9669 GB
Notification: Performance of simCode: created event and clocks part: time 1.155e-05/1.31, allocations: 4 kB / 1.209 GB, free: 6.137 MB / 0.9669 GB
Notification: Performance of simCode: created simulation system equations: time 0.003786/1.314, allocations: 2.028 MB / 1.211 GB, free: 4.078 MB / 0.9669 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02009/1.334, allocations: 3.276 MB / 1.214 GB, free: 0.8633 MB / 0.9669 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0298/1.364, allocations: 14.63 MB / 1.228 GB, free: 2.152 MB / 0.9825 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005346/1.37, allocations: 4.307 MB / 1.233 GB, free: 13.82 MB / 0.9981 GB
Notification: Performance of simCode: alias equations: time 0.006775/1.376, allocations: 1.846 MB / 1.234 GB, free: 11.98 MB / 0.9981 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001227/1.378, allocations: 407.3 kB / 1.235 GB, free: 11.59 MB / 0.9981 GB
Notification: Performance of SimCode: time 1.433e-06/1.378, allocations: 0 / 1.235 GB, free: 11.59 MB / 0.9981 GB
Notification: Performance of Templates: time 0.7531/2.131, allocations: 107.2 MB / 1.34 GB, free: 221.2 MB / 1.014 GB
make -j1 -f Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.makefile
(rm -f Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.pipe ; mkfifo Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.pipe >> ../files/Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.sim & ./Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_Storage_Validation_StratifiedNonUniformInitial.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Fluid.Storage.Validation.StratifiedNonUniformInitial.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches