You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@subversion.apache.org by ne...@apache.org on 2014/01/06 01:41:50 UTC

[svnbench] Revision: 1555646 compiled Jan 6 2014, 00:22:00 on x86_64-unknown-linux-gnu

1.8.0@1492600 vs. trunk@1555625
Started at Mon Jan  6 00:27:24 UTC 2014

*DISCLAIMER* - This tests only file://-URL access on a GNU/Linux VM.
This is intended to measure changes in performance of the local working
copy layer, *only*. These results are *not* generally true for everyone.

Charts of this data are available at http://svn-qavm.apache.org/charts/

Averaged-total results across all runs:
---------------------------------------

Compare trunk@1555625 to 1.8.0
       N        avg         operation
     54/9    1.00| +0.021   TOTAL RUN
   3K/530    0.99| -0.000   add
   108/18    0.92| -0.062   checkout
   432/72    1.06| +0.110   commit
     54/9    0.95| -0.001   copy
     54/9    1.07| +0.020   delete
   270/45    0.69| -0.240   info
   108/18    1.14| +0.181   merge
   2K/516    1.05| +0.001   mkdir
   144/21    1.28| +0.003   propdel
   40K/6K    1.04| +0.000   proplist
   41K/6K    1.07| +0.001   propset
   3K/591    1.09| +0.001   ps
   108/18    0.99| -0.000   resolve
   108/18    0.98| -0.004   resolved
  756/126    1.06| +0.009   status
     54/9    0.84| -0.149   switch
  756/126    0.89| -0.067   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625' is faster.
 "2/3" means: '1.8.0' has 2 timings on record, the other has 3.)


Above totals split into separate <dir-levels>x<dir-spread> runs:
----------------------------------------------------------------

Compare trunk@1555625,5x5 to 1.8.0,5x5
       N        avg         operation
     18/3    1.01| +1.046   TOTAL RUN
   2K/456    0.96| -0.001   add
     36/6    0.90| -0.197   checkout
   144/24    1.09| +0.430   commit
     18/3    1.04| +0.001   copy
     18/3    1.16| +0.115   delete
    90/15    0.65| -0.718   info
     36/6    1.17| +0.594   merge
   2K/470    1.05| +0.001   mkdir
   144/20    1.23| +0.003   propdel
   37K/6K    1.04| +0.000   proplist
   38K/6K    1.07| +0.001   propset
   3K/552    1.09| +0.001   ps
     36/6    1.01| +0.000   resolve
     36/6    0.96| -0.017   resolved
   252/42    1.07| +0.026   status
     18/3    0.80| -0.507   switch
   252/42    0.90| -0.160   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625,5x5' is faster.
 "2/3" means: '1.8.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk@1555625,100x1 to 1.8.0,100x1
       N        avg         operation
     18/3    0.95| -0.750   TOTAL RUN
   504/71    1.19| +0.005   add
     36/6    1.03| +0.006   checkout
   144/24    0.82| -0.080   commit
     18/3    1.10| +0.003   copy
     18/3    0.61| -0.050   delete
    90/15    1.02| +0.004   info
     36/6    0.93| -0.024   merge
   252/46    1.11| +0.002   mkdir
   1K/337    1.02| +0.000   proplist
   1K/273    1.03| +0.000   propset
   126/33    1.02| +0.000   ps
     36/6    1.06| +0.001   resolve
     36/6    1.08| +0.008   resolved
   252/42    1.05| +0.004   status
     18/3    1.12| +0.034   switch
   252/42    0.86| -0.034   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625,100x1' is faster.
 "2/3" means: '1.8.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk@1555625,1x100 to 1.8.0,1x100
       N        avg         operation
     18/3    0.95| -0.234   TOTAL RUN
     18/3    0.79| -0.022   add
     36/6    1.05| +0.005   checkout
   144/24    0.86| -0.021   commit
     18/3    0.74| -0.007   copy
     18/3    0.84| -0.005   delete
    90/15    0.94| -0.005   info
     36/6    0.79| -0.028   merge
  666/111    1.14| +0.002   proplist
  756/126    1.20| +0.003   propset
     36/6    0.89| -0.001   ps
     36/6    0.86| -0.002   resolve
     36/6    0.85| -0.004   resolved
   252/42    0.88| -0.003   status
     18/3    1.28| +0.024   switch
   252/42    0.87| -0.008   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625,1x100' is faster.
 "2/3" means: '1.8.0,1x100' has 2 timings on record, the other has 3.)



More detail:
------------

Timings for 1.8.0,5x5
   N    min     max     avg   operation  (unit is seconds)
  18  121.88  186.59  145.49  TOTAL RUN
  2K    0.01    3.48    0.03  add
  36    0.02    4.44    2.02  checkout
 144    0.59   14.71    4.63  commit
  18    0.02    0.05    0.02  copy
  18    0.57    1.02    0.70  delete
  90    0.64    7.07    2.05  info
  36    2.59    5.22    3.48  merge
  2K    0.01    0.06    0.01  mkdir
 144    0.01    0.02    0.01  propdel
 37K    0.01    0.03    0.01  proplist
 38K    0.01    0.17    0.01  propset
  3K    0.01    0.18    0.01  ps
  36    0.03    0.11    0.04  resolve
  36    0.30    1.06    0.48  resolved
 252    0.12    1.24    0.36  status
  18    2.37    3.00    2.50  switch
 252    0.21    4.77    1.56  update
--
Timings for trunk@1555625,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  139.20  153.38  146.53  TOTAL RUN
 456    0.01    2.66    0.03  add
   6    0.02    3.94    1.83  checkout
  24    0.60   13.95    5.06  commit
   3    0.02    0.02    0.02  copy
   3    0.63    1.01    0.82  delete
  15    0.56    3.14    1.33  info
   6    3.24    5.07    4.07  merge
 470    0.01    0.03    0.01  mkdir
  20    0.01    0.02    0.01  propdel
  6K    0.01    0.02    0.01  proplist
  6K    0.01    0.04    0.01  propset
 552    0.01    0.02    0.01  ps
   6    0.03    0.06    0.04  resolve
   6    0.30    0.81    0.46  resolved
  42    0.12    1.02    0.39  status
   3    1.95    2.08    2.00  switch
  42    0.15    4.29    1.40  update
--
Compare trunk@1555625,5x5 to 1.8.0,5x5
       N        min              max              avg         operation
     18/3    1.14|+17.319     0.82|-33.214     1.01| +1.046   TOTAL RUN
   2K/456    0.95| -0.000     0.77| -0.815     0.96| -0.001   add
     36/6    1.08| +0.001     0.89| -0.504     0.90| -0.197   checkout
   144/24    1.00| +0.002     0.95| -0.762     1.09| +0.430   commit
     18/3    1.33| +0.006     0.44| -0.031     1.04| +0.001   copy
     18/3    1.11| +0.061     0.99| -0.005     1.16| +0.115   delete
    90/15    0.89| -0.072     0.44| -3.932     0.65| -0.718   info
     36/6    1.25| +0.651     0.97| -0.153     1.17| +0.594   merge
   2K/470    0.94| -0.001     0.44| -0.033     1.05| +0.001   mkdir
   144/20    0.96| -0.000     0.91| -0.002     1.23| +0.003   propdel
   37K/6K    0.93| -0.000     0.70| -0.009     1.04| +0.000   proplist
   38K/6K    0.93| -0.001     0.22| -0.133     1.07| +0.001   propset
   3K/552    0.94| -0.000     0.12| -0.160     1.09| +0.001   ps
     36/6    1.02| +0.000     0.53| -0.051     1.01| +0.000   resolve
     36/6    0.98| -0.007     0.76| -0.251     0.96| -0.017   resolved
   252/42    0.97| -0.004     0.83| -0.212     1.07| +0.026   status
     18/3    0.82| -0.424     0.69| -0.919     0.80| -0.507   switch
   252/42    0.73| -0.055     0.90| -0.484     0.90| -0.160   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625,5x5' is faster.
 "2/3" means: '1.8.0,5x5' has 2 timings on record, the other has 3.)


Timings for 1.8.0,100x1
   N    min     max     avg   operation  (unit is seconds)
  18    9.77   21.29   14.58  TOTAL RUN
 504    0.01    0.17    0.02  add
  36    0.02    0.54    0.17  checkout
 144    0.10    1.20    0.44  commit
  18    0.02    0.04    0.03  copy
  18    0.08    0.21    0.13  delete
  90    0.10    0.46    0.21  info
  36    0.21    0.62    0.35  merge
 252    0.01    0.05    0.02  mkdir
  1K    0.01    0.03    0.01  proplist
  1K    0.01    0.03    0.01  propset
 126    0.01    0.03    0.01  ps
  36    0.01    0.03    0.02  resolve
  36    0.06    0.17    0.10  resolved
 252    0.03    0.18    0.08  status
  18    0.21    0.50    0.29  switch
 252    0.04    0.70    0.24  update
--
Timings for trunk@1555625,100x1
   N    min     max     avg   operation  (unit is seconds)
   3   12.36   15.88   13.83  TOTAL RUN
  71    0.01    0.32    0.03  add
   6    0.02    0.46    0.17  checkout
  24    0.10    1.06    0.36  commit
   3    0.02    0.05    0.03  copy
   3    0.08    0.08    0.08  delete
  15    0.10    0.37    0.21  info
   6    0.19    0.55    0.32  merge
  46    0.01    0.04    0.02  mkdir
   1    0.03    0.03    0.03  propdel
 337    0.01    0.03    0.01  proplist
 273    0.01    0.03    0.01  propset
  33    0.01    0.03    0.01  ps
   6    0.01    0.03    0.02  resolve
   6    0.06    0.16    0.11  resolved
  42    0.03    0.17    0.08  status
   3    0.18    0.41    0.32  switch
  42    0.04    0.54    0.21  update
--
Compare trunk@1555625,100x1 to 1.8.0,100x1
       N        min              max              avg         operation
     18/3    1.27| +2.592     0.75| -5.410     0.95| -0.750   TOTAL RUN
   504/71    0.96| -0.000     1.86| +0.150     1.19| +0.005   add
     36/6    1.09| +0.002     0.86| -0.076     1.03| +0.006   checkout
   144/24    1.02| +0.002     0.88| -0.142     0.82| -0.080   commit
     18/3    1.11| +0.002     1.09| +0.004     1.10| +0.003   copy
     18/3    0.95| -0.004     0.39| -0.126     0.61| -0.050   delete
    90/15    0.97| -0.003     0.80| -0.093     1.02| +0.004   info
     36/6    0.89| -0.023     0.88| -0.075     0.93| -0.024   merge
   252/46    1.15| +0.001     0.91| -0.005     1.11| +0.002   mkdir
   1K/337    0.91| -0.001     0.79| -0.007     1.02| +0.000   proplist
   1K/273    0.96| -0.000     0.84| -0.005     1.03| +0.000   propset
   126/33    0.91| -0.001     0.91| -0.002     1.02| +0.000   ps
     36/6    1.12| +0.001     0.85| -0.005     1.06| +0.001   resolve
     36/6    1.00| -0.000     0.94| -0.011     1.08| +0.008   resolved
   252/42    0.97| -0.001     0.97| -0.005     1.05| +0.004   status
     18/3    0.87| -0.027     0.82| -0.090     1.12| +0.034   switch
   252/42    0.95| -0.002     0.77| -0.161     0.86| -0.034   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625,100x1' is faster.
 "2/3" means: '1.8.0,100x1' has 2 timings on record, the other has 3.)


Timings for 1.8.0,1x100
   N    min     max     avg   operation  (unit is seconds)
  18    2.84    6.47    4.57  TOTAL RUN
  18    0.07    0.18    0.11  add
  36    0.02    0.24    0.09  checkout
 144    0.03    0.48    0.15  commit
  18    0.02    0.04    0.03  copy
  18    0.02    0.05    0.03  delete
  90    0.04    0.19    0.08  info
  36    0.07    0.23    0.13  merge
 666    0.01    0.02    0.01  proplist
 756    0.01    0.02    0.01  propset
  36    0.01    0.02    0.01  ps
  36    0.01    0.03    0.02  resolve
  36    0.01    0.04    0.02  resolved
 252    0.01    0.04    0.02  status
  18    0.05    0.13    0.09  switch
 252    0.02    0.23    0.06  update
--
Timings for trunk@1555625,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    3.65    5.37    4.34  TOTAL RUN
   3    0.06    0.13    0.09  add
   6    0.02    0.21    0.10  checkout
  24    0.03    0.27    0.13  commit
   3    0.02    0.02    0.02  copy
   3    0.02    0.04    0.03  delete
  15    0.04    0.17    0.08  info
   6    0.06    0.20    0.11  merge
 111    0.01    0.02    0.01  proplist
 126    0.01    0.02    0.02  propset
   6    0.01    0.02    0.01  ps
   6    0.01    0.02    0.01  resolve
   6    0.01    0.04    0.02  resolved
  42    0.01    0.04    0.02  status
   3    0.11    0.11    0.11  switch
  42    0.02    0.17    0.05  update
--
Compare trunk@1555625,1x100 to 1.8.0,1x100
       N        min              max              avg         operation
     18/3    1.28| +0.808     0.83| -1.103     0.95| -0.234   TOTAL RUN
     18/3    0.95| -0.003     0.68| -0.058     0.79| -0.022   add
     36/6    1.09| +0.002     0.89| -0.025     1.05| +0.005   checkout
   144/24    0.99| -0.000     0.56| -0.213     0.86| -0.021   commit
     18/3    1.11| +0.002     0.55| -0.018     0.74| -0.007   copy
     18/3    0.93| -0.001     0.85| -0.007     0.84| -0.005   delete
    90/15    1.02| +0.001     0.87| -0.025     0.94| -0.005   info
     36/6    0.89| -0.007     0.88| -0.027     0.79| -0.028   merge
  666/111    0.92| -0.001     0.95| -0.001     1.14| +0.002   proplist
  756/126    0.95| -0.000     0.91| -0.002     1.20| +0.003   propset
     36/6    0.94| -0.001     0.86| -0.003     0.89| -0.001   ps
     36/6    0.96| -0.000     0.91| -0.002     0.86| -0.002   resolve
     36/6    0.94| -0.001     0.91| -0.004     0.85| -0.004   resolved
   252/42    0.93| -0.001     0.94| -0.002     0.88| -0.003   status
     18/3    2.04| +0.057     0.89| -0.014     1.28| +0.024   switch
   252/42    1.01| +0.000     0.74| -0.059     0.87| -0.008   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625,1x100' is faster.
 "2/3" means: '1.8.0,1x100' has 2 timings on record, the other has 3.)


Timings for 1.8.0
   N    min     max     avg   operation  (unit is seconds)
  54    2.84  186.59   54.88  TOTAL RUN
  3K    0.01    3.48    0.03  add
 108    0.02    4.44    0.76  checkout
 432    0.03   14.71    1.74  commit
  54    0.02    0.05    0.03  copy
  54    0.02    1.02    0.29  delete
 270    0.04    7.07    0.78  info
 108    0.07    5.22    1.32  merge
  2K    0.01    0.06    0.01  mkdir
 144    0.01    0.02    0.01  propdel
 40K    0.01    0.03    0.01  proplist
 41K    0.01    0.17    0.01  propset
  3K    0.01    0.18    0.01  ps
 108    0.01    0.11    0.02  resolve
 108    0.01    1.06    0.20  resolved
 756    0.01    1.24    0.15  status
  54    0.05    3.00    0.96  switch
 756    0.02    4.77    0.62  update
--
Timings for trunk@1555625
   N    min     max     avg   operation  (unit is seconds)
   9    3.65  153.38   54.90  TOTAL RUN
 530    0.01    2.66    0.03  add
  18    0.02    3.94    0.70  checkout
  72    0.03   13.95    1.85  commit
   9    0.02    0.05    0.02  copy
   9    0.02    1.01    0.31  delete
  45    0.04    3.14    0.54  info
  18    0.06    5.07    1.50  merge
 516    0.01    0.04    0.01  mkdir
  21    0.01    0.03    0.01  propdel
  6K    0.01    0.03    0.01  proplist
  6K    0.01    0.04    0.01  propset
 591    0.01    0.03    0.01  ps
  18    0.01    0.06    0.02  resolve
  18    0.01    0.81    0.20  resolved
 126    0.01    1.02    0.16  status
   9    0.11    2.08    0.81  switch
 126    0.02    4.29    0.55  update
--
Compare trunk@1555625 to 1.8.0
       N        min              max              avg         operation
     54/9    1.28| +0.808     0.82|-33.214     1.00| +0.021   TOTAL RUN
   3K/530    0.95| -0.000     0.77| -0.815     0.99| -0.000   add
   108/18    1.09| +0.002     0.89| -0.504     0.92| -0.062   checkout
   432/72    0.99| -0.000     0.95| -0.762     1.06| +0.110   commit
     54/9    1.13| +0.002     0.83| -0.009     0.95| -0.001   copy
     54/9    0.93| -0.001     0.99| -0.005     1.07| +0.020   delete
   270/45    1.02| +0.001     0.44| -3.932     0.69| -0.240   info
   108/18    0.89| -0.007     0.97| -0.153     1.14| +0.181   merge
   2K/516    0.94| -0.001     0.75| -0.014     1.05| +0.001   mkdir
   144/21    0.96| -0.000     1.29| +0.006     1.28| +0.003   propdel
   40K/6K    0.93| -0.000     0.79| -0.007     1.04| +0.000   proplist
   41K/6K    0.93| -0.001     0.22| -0.133     1.07| +0.001   propset
   3K/591    0.94| -0.000     0.14| -0.156     1.09| +0.001   ps
   108/18    0.96| -0.000     0.53| -0.051     0.99| -0.000   resolve
   108/18    0.94| -0.001     0.76| -0.251     0.98| -0.004   resolved
  756/126    0.93| -0.001     0.83| -0.212     1.06| +0.009   status
     54/9    2.04| +0.057     0.69| -0.919     0.84| -0.149   switch
  756/126    1.01| +0.000     0.90| -0.484     0.89| -0.067   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1555625' is faster.
 "2/3" means: '1.8.0' has 2 timings on record, the other has 3.)



Had started at Mon Jan  6 00:27:24 UTC 2014,
       done at Mon Jan  6 00:39:45 UTC 2014
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.8.0_trunk@last12.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.8.0_trunk@last12,5x5.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.8.0_trunk@last12,1x100.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.8.0_trunk@last12,100x1.svg