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/02/10 01:44:18 UTC

[svnbench] Revision: 1566478 compiled Feb 10 2014, 00:22:07 on x86_64-unknown-linux-gnu

1.8.0@1492600 vs. trunk@1566230
Started at Mon Feb 10 00:27:44 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@1566230 to 1.8.0
       N        avg         operation
     69/9    1.14| +7.820   TOTAL RUN
   4K/530    1.11| +0.003   add
   138/18    1.08| +0.060   checkout
   552/72    1.14| +0.248   commit
     69/9    1.17| +0.005   copy
     69/9    1.19| +0.057   delete
   345/45    1.31| +0.247   info
   138/18    1.11| +0.146   merge
   3K/516    1.20| +0.003   mkdir
   184/21    1.15| +0.002   propdel
   51K/6K    1.17| +0.002   proplist
   52K/6K    1.20| +0.002   propset
   4K/591    1.18| +0.002   ps
   138/18    1.24| +0.006   resolve
   138/18    1.12| +0.025   resolved
  966/126    1.19| +0.031   status
     69/9    0.99| -0.007   switch
  966/126    0.99| -0.009   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230' 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@1566230,5x5 to 1.8.0,5x5
       N        avg         operation
     23/3    1.14|+20.232   TOTAL RUN
   3K/456    1.07| +0.002   add
     46/6    1.08| +0.160   checkout
   184/24    1.13| +0.636   commit
     23/3    0.78| -0.007   copy
     23/3    1.21| +0.148   delete
   115/15    1.32| +0.679   info
     46/6    1.12| +0.438   merge
   3K/470    1.20| +0.003   mkdir
   184/20    1.09| +0.001   propdel
   48K/6K    1.17| +0.002   proplist
   49K/6K    1.21| +0.002   propset
   4K/552    1.17| +0.002   ps
     46/6    1.32| +0.013   resolve
     46/6    1.10| +0.050   resolved
   322/42    1.18| +0.066   status
     23/3    0.94| -0.151   switch
   322/42    0.97| -0.052   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230,5x5' is faster.
 "2/3" means: '1.8.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk@1566230,100x1 to 1.8.0,100x1
       N        avg         operation
     23/3    1.14| +2.148   TOTAL RUN
   644/71    1.32| +0.008   add
     46/6    0.96| -0.006   checkout
   184/24    1.15| +0.070   commit
     23/3    1.44| +0.012   copy
     23/3    1.17| +0.023   delete
   115/15    1.18| +0.038   info
     46/6    0.97| -0.012   merge
   322/46    1.19| +0.004   mkdir
   2K/337    1.13| +0.002   proplist
   2K/273    1.11| +0.002   propset
   161/33    1.28| +0.004   ps
     46/6    1.23| +0.004   resolve
     46/6    1.22| +0.022   resolved
   322/42    1.28| +0.022   status
     23/3    1.37| +0.113   switch
   322/42    1.04| +0.011   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230,100x1' is faster.
 "2/3" means: '1.8.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk@1566230,1x100 to 1.8.0,1x100
       N        avg         operation
     23/3    1.22| +1.081   TOTAL RUN
     23/3    1.30| +0.036   add
     46/6    1.24| +0.025   checkout
   184/24    1.23| +0.038   commit
     23/3    1.33| +0.010   copy
     23/3    1.01| +0.000   delete
   115/15    1.27| +0.024   info
     46/6    1.08| +0.011   merge
  851/111    1.23| +0.003   proplist
  966/126    1.25| +0.003   propset
     46/6    1.26| +0.004   ps
     46/6    1.08| +0.002   resolve
     46/6    1.11| +0.003   resolved
   322/42    1.19| +0.004   status
     23/3    1.17| +0.016   switch
   322/42    1.20| +0.013   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230,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)
  23  121.88  186.59  149.86  TOTAL RUN
  3K    0.01    3.48    0.03  add
  46    0.02    4.44    2.03  checkout
 184    0.59   14.71    4.79  commit
  23    0.02    0.23    0.03  copy
  23    0.57    1.02    0.71  delete
 115    0.64    7.07    2.09  info
  46    2.59    5.22    3.50  merge
  3K    0.01    0.06    0.01  mkdir
 184    0.01    0.02    0.01  propdel
 48K    0.01    0.03    0.01  proplist
 49K    0.01    0.17    0.01  propset
  4K    0.01    0.18    0.01  ps
  46    0.03    0.11    0.04  resolve
  46    0.30    1.06    0.48  resolved
 322    0.12    1.24    0.38  status
  23    2.37    3.21    2.54  switch
 322    0.21    4.77    1.57  update
--
Timings for trunk@1566230,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  154.50  178.63  170.09  TOTAL RUN
 456    0.01    3.16    0.04  add
   6    0.02    4.80    2.19  checkout
  24    0.64   13.37    5.43  commit
   3    0.02    0.02    0.02  copy
   3    0.60    1.05    0.85  delete
  15    0.57    7.01    2.77  info
   6    2.69    4.88    3.94  merge
 470    0.01    0.03    0.02  mkdir
  20    0.01    0.02    0.01  propdel
  6K    0.01    0.03    0.01  proplist
  6K    0.01    0.09    0.01  propset
 552    0.01    0.02    0.01  ps
   6    0.03    0.09    0.05  resolve
   6    0.31    0.88    0.53  resolved
  42    0.12    1.05    0.44  status
   3    2.30    2.55    2.39  switch
  42    0.15    5.17    1.52  update
--
Compare trunk@1566230,5x5 to 1.8.0,5x5
       N        min              max              avg         operation
     23/3    1.27|+32.620     0.96| -7.956     1.14|+20.232   TOTAL RUN
   3K/456    0.95| -0.000     0.91| -0.314     1.07| +0.002   add
     46/6    1.08| +0.001     1.08| +0.356     1.08| +0.160   checkout
   184/24    1.08| +0.048     0.91| -1.334     1.13| +0.636   commit
     23/3    1.37| +0.006     0.11| -0.205     0.78| -0.007   copy
     23/3    1.05| +0.030     1.03| +0.033     1.21| +0.148   delete
   115/15    0.90| -0.063     0.99| -0.062     1.32| +0.679   info
     46/6    1.04| +0.095     0.94| -0.339     1.12| +0.438   merge
   3K/470    0.95| -0.000     0.52| -0.028     1.20| +0.003   mkdir
   184/20    0.96| -0.000     0.87| -0.003     1.09| +0.001   propdel
   48K/6K    0.93| -0.000     0.88| -0.004     1.17| +0.002   proplist
   49K/6K    0.93| -0.001     0.55| -0.077     1.21| +0.002   propset
   4K/552    0.94| -0.000     0.11| -0.161     1.17| +0.002   ps
     46/6    1.02| +0.001     0.85| -0.016     1.32| +0.013   resolve
     46/6    1.01| +0.002     0.83| -0.176     1.10| +0.050   resolved
   322/42    0.99| -0.001     0.85| -0.188     1.18| +0.066   status
     23/3    0.97| -0.075     0.80| -0.656     0.94| -0.151   switch
   322/42    0.73| -0.055     1.08| +0.394     0.97| -0.052   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230,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)
  23    9.77   21.29   15.25  TOTAL RUN
 644    0.01    0.35    0.03  add
  46    0.02    0.54    0.17  checkout
 184    0.10    1.29    0.47  commit
  23    0.02    0.04    0.03  copy
  23    0.08    0.21    0.14  delete
 115    0.10    0.46    0.21  info
  46    0.21    0.62    0.37  merge
 322    0.01    0.05    0.02  mkdir
  2K    0.01    0.03    0.01  proplist
  2K    0.01    0.03    0.02  propset
 161    0.01    0.03    0.02  ps
  46    0.01    0.03    0.02  resolve
  46    0.06    0.17    0.10  resolved
 322    0.03    0.18    0.08  status
  23    0.21    0.50    0.30  switch
 322    0.04    0.70    0.25  update
--
Timings for trunk@1566230,100x1
   N    min     max     avg   operation  (unit is seconds)
   3   14.62   19.31   17.40  TOTAL RUN
  71    0.01    0.33    0.03  add
   6    0.02    0.49    0.17  checkout
  24    0.10    1.13    0.54  commit
   3    0.02    0.05    0.04  copy
   3    0.12    0.19    0.16  delete
  15    0.10    0.45    0.25  info
   6    0.20    0.55    0.35  merge
  46    0.01    0.04    0.03  mkdir
   1    0.03    0.03    0.03  propdel
 337    0.01    0.02    0.02  proplist
 273    0.01    0.03    0.02  propset
  33    0.01    0.03    0.02  ps
   6    0.01    0.03    0.02  resolve
   6    0.06    0.15    0.12  resolved
  42    0.03    0.17    0.10  status
   3    0.41    0.42    0.42  switch
  42    0.04    0.60    0.26  update
--
Compare trunk@1566230,100x1 to 1.8.0,100x1
       N        min              max              avg         operation
     23/3    1.50| +4.850     0.91| -1.976     1.14| +2.148   TOTAL RUN
   644/71    1.00| +0.000     0.97| -0.012     1.32| +0.008   add
     46/6    1.10| +0.002     0.91| -0.049     0.96| -0.006   checkout
   184/24    1.07| +0.006     0.87| -0.166     1.15| +0.070   commit
     23/3    1.21| +0.004     1.30| +0.012     1.44| +0.012   copy
     23/3    1.42| +0.035     0.90| -0.022     1.17| +0.023   delete
   115/15    0.99| -0.001     0.96| -0.017     1.18| +0.038   info
     46/6    0.93| -0.015     0.88| -0.075     0.97| -0.012   merge
   322/46    1.01| +0.000     0.89| -0.005     1.19| +0.004   mkdir
   2K/337    0.91| -0.001     0.64| -0.012     1.13| +0.002   proplist
   2K/273    0.95| -0.000     0.79| -0.007     1.11| +0.002   propset
   161/33    1.05| +0.000     0.93| -0.002     1.28| +0.004   ps
     46/6    0.99| -0.000     0.96| -0.001     1.23| +0.004   resolve
     46/6    0.99| -0.001     0.92| -0.014     1.22| +0.022   resolved
   322/42    1.01| +0.000     0.96| -0.006     1.28| +0.022   status
     23/3    1.99| +0.205     0.85| -0.075     1.37| +0.113   switch
   322/42    0.94| -0.003     0.85| -0.109     1.04| +0.011   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230,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)
  23    2.84    6.62    4.98  TOTAL RUN
  23    0.07    0.18    0.12  add
  46    0.02    0.24    0.10  checkout
 184    0.03    0.49    0.16  commit
  23    0.02    0.04    0.03  copy
  23    0.02    0.05    0.04  delete
 115    0.04    0.19    0.09  info
  46    0.07    0.23    0.15  merge
 851    0.01    0.02    0.01  proplist
 966    0.01    0.02    0.01  propset
  46    0.01    0.02    0.01  ps
  46    0.01    0.03    0.02  resolve
  46    0.01    0.04    0.03  resolved
 322    0.01    0.04    0.02  status
  23    0.05    0.13    0.10  switch
 322    0.02    0.23    0.06  update
--
Timings for trunk@1566230,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    5.76    6.24    6.06  TOTAL RUN
   3    0.15    0.15    0.15  add
   6    0.04    0.22    0.13  checkout
  24    0.03    0.48    0.20  commit
   3    0.04    0.04    0.04  copy
   3    0.02    0.05    0.04  delete
  15    0.10    0.18    0.11  info
   6    0.06    0.20    0.16  merge
 111    0.01    0.02    0.02  proplist
 126    0.02    0.02    0.02  propset
   6    0.02    0.02    0.02  ps
   6    0.01    0.02    0.02  resolve
   6    0.01    0.04    0.03  resolved
  42    0.01    0.04    0.03  status
   3    0.11    0.12    0.11  switch
  42    0.02    0.20    0.08  update
--
Compare trunk@1566230,1x100 to 1.8.0,1x100
       N        min              max              avg         operation
     23/3    2.02| +2.913     0.94| -0.381     1.22| +1.081   TOTAL RUN
     23/3    2.26| +0.085     0.84| -0.029     1.30| +0.036   add
     46/6    2.35| +0.022     0.91| -0.021     1.24| +0.025   checkout
   184/24    1.21| +0.006     0.98| -0.011     1.23| +0.038   commit
     23/3    2.19| +0.021     1.05| +0.002     1.33| +0.010   copy
     23/3    0.94| -0.001     0.92| -0.004     1.01| +0.000   delete
   115/15    2.29| +0.054     0.96| -0.008     1.27| +0.024   info
     46/6    0.93| -0.005     0.88| -0.027     1.08| +0.011   merge
  851/111    2.14| +0.008     0.86| -0.002     1.23| +0.003   proplist
  966/126    2.18| +0.009     0.90| -0.002     1.25| +0.003   propset
     46/6    2.16| +0.009     0.89| -0.002     1.26| +0.004   ps
     46/6    0.94| -0.001     0.92| -0.002     1.08| +0.002   resolve
     46/6    0.95| -0.001     0.90| -0.004     1.11| +0.003   resolved
   322/42    1.42| +0.004     0.96| -0.002     1.19| +0.004   status
     23/3    2.06| +0.057     0.89| -0.014     1.17| +0.016   switch
   322/42    1.33| +0.006     0.87| -0.029     1.20| +0.013   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230,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)
  69    2.84  186.59   56.70  TOTAL RUN
  4K    0.01    3.48    0.03  add
 138    0.02    4.44    0.77  checkout
 552    0.03   14.71    1.81  commit
  69    0.02    0.23    0.03  copy
  69    0.02    1.02    0.29  delete
 345    0.04    7.07    0.80  info
 138    0.07    5.22    1.34  merge
  3K    0.01    0.06    0.01  mkdir
 184    0.01    0.02    0.01  propdel
 51K    0.01    0.03    0.01  proplist
 52K    0.01    0.17    0.01  propset
  4K    0.01    0.18    0.01  ps
 138    0.01    0.11    0.03  resolve
 138    0.01    1.06    0.20  resolved
 966    0.01    1.24    0.16  status
  69    0.05    3.21    0.98  switch
 966    0.02    4.77    0.63  update
--
Timings for trunk@1566230
   N    min     max     avg   operation  (unit is seconds)
   9    5.76  178.63   64.52  TOTAL RUN
 530    0.01    3.16    0.04  add
  18    0.02    4.80    0.83  checkout
  72    0.03   13.37    2.06  commit
   9    0.02    0.05    0.03  copy
   9    0.02    1.05    0.35  delete
  45    0.10    7.01    1.05  info
  18    0.06    4.88    1.48  merge
 516    0.01    0.04    0.02  mkdir
  21    0.01    0.03    0.01  propdel
  6K    0.01    0.03    0.01  proplist
  6K    0.01    0.09    0.01  propset
 591    0.01    0.03    0.01  ps
  18    0.01    0.09    0.03  resolve
  18    0.01    0.88    0.23  resolved
 126    0.01    1.05    0.19  status
   9    0.11    2.55    0.97  switch
 126    0.02    5.17    0.62  update
--
Compare trunk@1566230 to 1.8.0
       N        min              max              avg         operation
     69/9    2.02| +2.913     0.96| -7.956     1.14| +7.820   TOTAL RUN
   4K/530    0.95| -0.000     0.91| -0.314     1.11| +0.003   add
   138/18    1.09| +0.002     1.08| +0.356     1.08| +0.060   checkout
   552/72    1.21| +0.006     0.91| -1.334     1.14| +0.248   commit
     69/9    1.21| +0.004     0.24| -0.175     1.17| +0.005   copy
     69/9    0.94| -0.001     1.03| +0.033     1.19| +0.057   delete
   345/45    2.29| +0.054     0.99| -0.062     1.31| +0.247   info
   138/18    0.93| -0.005     0.94| -0.339     1.11| +0.146   merge
   3K/516    0.95| -0.000     0.74| -0.015     1.20| +0.003   mkdir
   184/21    0.96| -0.000     1.26| +0.005     1.15| +0.002   propdel
   51K/6K    0.93| -0.000     0.87| -0.004     1.17| +0.002   proplist
   52K/6K    0.93| -0.001     0.55| -0.077     1.20| +0.002   propset
   4K/591    0.94| -0.000     0.14| -0.155     1.18| +0.002   ps
   138/18    0.94| -0.001     0.85| -0.016     1.24| +0.006   resolve
   138/18    0.95| -0.001     0.83| -0.176     1.12| +0.025   resolved
  966/126    1.42| +0.004     0.85| -0.188     1.19| +0.031   status
     69/9    2.06| +0.057     0.80| -0.656     0.99| -0.007   switch
  966/126    1.33| +0.006     1.08| +0.394     0.99| -0.009   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1566230' is faster.
 "2/3" means: '1.8.0' has 2 timings on record, the other has 3.)



Had started at Mon Feb 10 00:27:44 UTC 2014,
       done at Mon Feb 10 00:41:48 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