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 2013/06/24 02:37:13 UTC

[svnbench] Revision: 1495899 compiled Jun 24 2013, 00:22:04 on x86_64-unknown-linux-gnu

1.7.0@1181106 vs. trunk@1495850
Started at Mon Jun 24 00:25:46 UTC 2013

*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@1495850 to 1.7.0
       N        avg         operation
     36/9    0.53|-36.897   TOTAL RUN
   2K/530    0.78| -0.005   add
    72/18    0.75| -0.218   checkout
   288/72    0.63| -0.769   commit
     36/9    0.75| -0.006   copy
     36/9    0.79| -0.060   delete
   180/45    0.16| -3.699   info
    72/18    0.52| -1.037   merge
   1K/516    0.76| -0.003   mkdir
    96/21    0.78| -0.002   propdel
   26K/6K    0.66| -0.003   proplist
   27K/6K    0.68| -0.004   propset
   2K/591    0.68| -0.004   ps
    72/18    1.86| +0.009   resolve
    72/18    0.81| -0.038   resolved
  504/126    0.68| -0.059   status
     36/9    0.69| -0.336   switch
  504/126    0.76| -0.162   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850' is faster.
 "2/3" means: '1.7.0' has 2 timings on record, the other has 3.)


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

Compare trunk@1495850,5x5 to 1.7.0,5x5
       N        avg         operation
     12/3    0.53|-99.646   TOTAL RUN
   1K/456    0.79| -0.005   add
     24/6    0.78| -0.513   checkout
    96/24    0.65| -1.912   commit
     12/3    0.72| -0.007   copy
     12/3    0.83| -0.119   delete
    60/15    0.15|-10.907   info
     24/6    0.54| -2.577   merge
   1K/470    0.75| -0.003   mkdir
    96/20    0.77| -0.002   propdel
   25K/6K    0.67| -0.003   proplist
   25K/6K    0.68| -0.004   propset
   2K/552    0.68| -0.004   ps
     24/6    3.90| +0.025   resolve
     24/6    0.81| -0.097   resolved
   168/42    0.70| -0.136   status
     12/3    0.73| -0.769   switch
   168/42    0.83| -0.277   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850,5x5' is faster.
 "2/3" means: '1.7.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk@1495850,100x1 to 1.7.0,100x1
       N        avg         operation
     12/3    0.50| -8.739   TOTAL RUN
   336/71    0.78| -0.004   add
     24/6    0.54| -0.094   checkout
    96/24    0.45| -0.301   commit
     12/3    0.75| -0.006   copy
     12/3    0.63| -0.046   delete
    60/15    0.44| -0.163   info
     24/6    0.34| -0.412   merge
   168/46    0.83| -0.003   mkdir
   1K/337    0.59| -0.005   proplist
   1K/273    0.61| -0.006   propset
    84/33    0.63| -0.005   ps
     24/6    1.30| +0.003   resolve
     24/6    0.88| -0.008   resolved
   168/42    0.61| -0.031   status
     12/3    0.49| -0.194   switch
   168/42    0.45| -0.185   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850,100x1' is faster.
 "2/3" means: '1.7.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk@1495850,1x100 to 1.7.0,1x100
       N        avg         operation
     12/3    0.53| -2.305   TOTAL RUN
     12/3    0.57| -0.025   add
     24/6    0.54| -0.046   checkout
    96/24    0.48| -0.092   commit
     12/3    0.77| -0.005   copy
     12/3    0.56| -0.015   delete
    60/15    0.64| -0.028   info
     24/6    0.38| -0.121   merge
  444/111    0.53| -0.006   proplist
  504/126    0.55| -0.006   propset
     24/6    0.54| -0.006   ps
     24/6    0.83| -0.002   resolve
     24/6    0.59| -0.010   resolved
   168/42    0.53| -0.010   status
     12/3    0.51| -0.047   switch
   168/42    0.58| -0.025   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850,1x100' is faster.
 "2/3" means: '1.7.0,1x100' has 2 timings on record, the other has 3.)



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

Timings for 1.7.0,5x5
   N    min     max     avg   operation  (unit is seconds)
  12  192.14  255.84  211.01  TOTAL RUN
  1K    0.01    2.21    0.02  add
  24    0.02    5.15    2.31  checkout
  96    1.07   17.29    5.43  commit
  12    0.01    0.13    0.03  copy
  12    0.61    0.96    0.72  delete
  60    6.32   31.69   12.77  info
  24    5.31    8.49    5.65  merge
  1K    0.01    0.04    0.01  mkdir
  96    0.01    0.02    0.01  propdel
 25K    0.01    0.03    0.01  proplist
 25K    0.01    0.06    0.01  propset
  2K    0.01    0.04    0.01  ps
  24    0.01    0.01    0.01  resolve
  24    0.40    0.66    0.51  resolved
 168    0.17    0.96    0.45  status
  12    2.71    3.02    2.81  switch
 168    0.21    4.98    1.66  update
--
Timings for trunk@1495850,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  110.34  112.22  111.37  TOTAL RUN
 456    0.01    1.39    0.02  add
   6    0.02    3.62    1.80  checkout
  24    0.57    9.22    3.52  commit
   3    0.02    0.02    0.02  copy
   3    0.59    0.60    0.60  delete
  15    0.59    3.37    1.86  info
   6    2.36    3.81    3.08  merge
 470    0.01    0.02    0.01  mkdir
  20    0.01    0.02    0.01  propdel
  6K    0.01    0.02    0.01  proplist
  6K    0.01    0.02    0.01  propset
 552    0.01    0.02    0.01  ps
   6    0.03    0.04    0.03  resolve
   6    0.30    0.55    0.41  resolved
  42    0.12    0.54    0.31  status
   3    2.03    2.07    2.05  switch
  42    0.20    3.86    1.38  update
--
Compare trunk@1495850,5x5 to 1.7.0,5x5
       N        min              max              avg         operation
     12/3    0.57|-81.794     0.44|-143.619    0.53|-99.646   TOTAL RUN
   1K/456    0.94| -0.000     0.63| -0.820     0.79| -0.005   add
     24/6    0.92| -0.002     0.70| -1.535     0.78| -0.513   checkout
    96/24    0.53| -0.502     0.53| -8.073     0.65| -1.912   commit
     12/3    1.16| +0.002     0.15| -0.113     0.72| -0.007   copy
     12/3    0.96| -0.022     0.63| -0.352     0.83| -0.119   delete
    60/15    0.09| -5.735     0.11|-28.321     0.15|-10.907   info
     24/6    0.44| -2.950     0.45| -4.682     0.54| -2.577   merge
   1K/470    0.94| -0.000     0.49| -0.021     0.75| -0.003   mkdir
    96/20    0.88| -0.001     0.78| -0.005     0.77| -0.002   propdel
   25K/6K    0.86| -0.001     0.55| -0.015     0.67| -0.003   proplist
   25K/6K    0.87| -0.001     0.29| -0.046     0.68| -0.004   propset
   2K/552    0.88| -0.001     0.59| -0.016     0.68| -0.004   ps
     24/6    3.14| +0.018     4.83| +0.035     3.90| +0.025   resolve
     24/6    0.74| -0.105     0.83| -0.112     0.81| -0.097   resolved
   168/42    0.69| -0.052     0.56| -0.424     0.70| -0.136   status
     12/3    0.75| -0.681     0.69| -0.951     0.73| -0.769   switch
   168/42    0.94| -0.012     0.78| -1.119     0.83| -0.277   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850,5x5' is faster.
 "2/3" means: '1.7.0,5x5' has 2 timings on record, the other has 3.)


Timings for 1.7.0,100x1
   N    min     max     avg   operation  (unit is seconds)
  12   13.04   22.57   17.56  TOTAL RUN
 336    0.01    0.13    0.02  add
  24    0.02    0.74    0.21  checkout
  96    0.12    1.41    0.55  commit
  12    0.02    0.03    0.02  copy
  12    0.09    0.22    0.12  delete
  60    0.15    0.80    0.29  info
  24    0.46    0.91    0.62  merge
 168    0.01    0.03    0.01  mkdir
  1K    0.01    0.03    0.01  proplist
  1K    0.01    0.03    0.01  propset
  84    0.01    0.03    0.01  ps
  24    0.01    0.02    0.01  resolve
  24    0.05    0.17    0.07  resolved
 168    0.04    0.21    0.08  status
  12    0.33    0.65    0.38  switch
 168    0.04    0.86    0.33  update
--
Timings for trunk@1495850,100x1
   N    min     max     avg   operation  (unit is seconds)
   3    8.73    8.90    8.82  TOTAL RUN
  71    0.01    0.10    0.01  add
   6    0.02    0.21    0.11  checkout
  24    0.09    0.48    0.25  commit
   3    0.02    0.02    0.02  copy
   3    0.08    0.08    0.08  delete
  15    0.10    0.19    0.13  info
   6    0.19    0.24    0.21  merge
  46    0.01    0.02    0.01  mkdir
   1    0.01    0.01    0.01  propdel
 337    0.01    0.01    0.01  proplist
 273    0.01    0.01    0.01  propset
  33    0.01    0.01    0.01  ps
   6    0.01    0.01    0.01  resolve
   6    0.06    0.07    0.06  resolved
  42    0.03    0.07    0.05  status
   3    0.18    0.19    0.18  switch
  42    0.04    0.28    0.15  update
--
Compare trunk@1495850,100x1 to 1.7.0,100x1
       N        min              max              avg         operation
     12/3    0.67| -4.308     0.39|-13.674     0.50| -8.739   TOTAL RUN
   336/71    0.92| -0.001     0.80| -0.026     0.78| -0.004   add
     24/6    0.92| -0.001     0.29| -0.526     0.54| -0.094   checkout
    96/24    0.79| -0.024     0.34| -0.932     0.45| -0.301   commit
     12/3    1.06| +0.001     0.52| -0.017     0.75| -0.006   copy
     12/3    0.83| -0.016     0.37| -0.138     0.63| -0.046   delete
    60/15    0.65| -0.052     0.24| -0.612     0.44| -0.163   info
     24/6    0.41| -0.271     0.26| -0.674     0.34| -0.412   merge
   168/46    0.91| -0.001     0.54| -0.015     0.83| -0.003   mkdir
   1K/337    0.82| -0.001     0.31| -0.020     0.59| -0.005   proplist
   1K/273    0.86| -0.001     0.33| -0.023     0.61| -0.006   propset
    84/33    0.80| -0.002     0.35| -0.020     0.63| -0.005   ps
     24/6    1.47| +0.004     0.70| -0.006     1.30| +0.003   resolve
     24/6    1.32| +0.015     0.39| -0.103     0.88| -0.008   resolved
   168/42    0.71| -0.011     0.34| -0.138     0.61| -0.031   status
     12/3    0.54| -0.152     0.29| -0.464     0.49| -0.194   switch
   168/42    0.92| -0.003     0.32| -0.581     0.45| -0.185   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850,100x1' is faster.
 "2/3" means: '1.7.0,100x1' has 2 timings on record, the other has 3.)


Timings for 1.7.0,1x100
   N    min     max     avg   operation  (unit is seconds)
  12    3.09    7.30    4.90  TOTAL RUN
  12    0.04    0.09    0.06  add
  24    0.02    0.27    0.10  checkout
  96    0.03    0.56    0.18  commit
  12    0.01    0.03    0.02  copy
  12    0.02    0.05    0.03  delete
  60    0.04    0.19    0.08  info
  24    0.12    0.31    0.19  merge
 444    0.01    0.02    0.01  proplist
 504    0.01    0.02    0.01  propset
  24    0.01    0.02    0.01  ps
  24    0.01    0.02    0.01  resolve
  24    0.01    0.04    0.02  resolved
 168    0.01    0.05    0.02  status
  12    0.06    0.15    0.10  switch
 168    0.02    0.27    0.06  update
--
Timings for trunk@1495850,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    2.59    2.59    2.59  TOTAL RUN
   3    0.03    0.03    0.03  add
   6    0.02    0.09    0.05  checkout
  24    0.02    0.20    0.09  commit
   3    0.02    0.02    0.02  copy
   3    0.02    0.02    0.02  delete
  15    0.04    0.08    0.05  info
   6    0.06    0.09    0.07  merge
 111    0.01    0.01    0.01  proplist
 126    0.01    0.01    0.01  propset
   6    0.01    0.01    0.01  ps
   6    0.01    0.01    0.01  resolve
   6    0.01    0.02    0.01  resolved
  42    0.01    0.02    0.01  status
   3    0.05    0.05    0.05  switch
  42    0.02    0.09    0.03  update
--
Compare trunk@1495850,1x100 to 1.7.0,1x100
       N        min              max              avg         operation
     12/3    0.84| -0.501     0.35| -4.712     0.53| -2.305   TOTAL RUN
     12/3    0.91| -0.003     0.39| -0.055     0.57| -0.025   add
     24/6    0.92| -0.001     0.35| -0.174     0.54| -0.046   checkout
    96/24    0.69| -0.010     0.35| -0.360     0.48| -0.092   commit
     12/3    1.11| +0.002     0.59| -0.013     0.77| -0.005   copy
     12/3    0.92| -0.002     0.40| -0.028     0.56| -0.015   delete
    60/15    1.01| +0.000     0.42| -0.109     0.64| -0.028   info
     24/6    0.50| -0.059     0.28| -0.223     0.38| -0.121   merge
  444/111    0.85| -0.001     0.37| -0.012     0.53| -0.006   proplist
  504/126    0.87| -0.001     0.38| -0.013     0.55| -0.006   propset
     24/6    0.87| -0.001     0.35| -0.014     0.54| -0.006   ps
     24/6    1.29| +0.002     0.58| -0.008     0.83| -0.002   resolve
     24/6    0.83| -0.002     0.42| -0.023     0.59| -0.010   resolved
   168/42    0.84| -0.002     0.35| -0.030     0.53| -0.010   status
     12/3    0.80| -0.012     0.33| -0.097     0.51| -0.047   switch
   168/42    0.99| -0.000     0.35| -0.173     0.58| -0.025   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850,1x100' is faster.
 "2/3" means: '1.7.0,1x100' has 2 timings on record, the other has 3.)


Timings for 1.7.0
   N    min     max     avg   operation  (unit is seconds)
  36    3.09  255.84   77.82  TOTAL RUN
  2K    0.01    2.21    0.02  add
  72    0.02    5.15    0.87  checkout
 288    0.03   17.29    2.05  commit
  36    0.01    0.13    0.02  copy
  36    0.02    0.96    0.29  delete
 180    0.04   31.69    4.38  info
  72    0.12    8.49    2.16  merge
  1K    0.01    0.04    0.01  mkdir
  96    0.01    0.02    0.01  propdel
 26K    0.01    0.03    0.01  proplist
 27K    0.01    0.06    0.01  propset
  2K    0.01    0.04    0.01  ps
  72    0.01    0.02    0.01  resolve
  72    0.01    0.66    0.20  resolved
 504    0.01    0.96    0.18  status
  36    0.06    3.02    1.10  switch
 504    0.02    4.98    0.68  update
--
Timings for trunk@1495850
   N    min     max     avg   operation  (unit is seconds)
   9    2.59  112.22   40.93  TOTAL RUN
 530    0.01    1.39    0.02  add
  18    0.02    3.62    0.65  checkout
  72    0.02    9.22    1.28  commit
   9    0.02    0.02    0.02  copy
   9    0.02    0.60    0.23  delete
  45    0.04    3.37    0.68  info
  18    0.06    3.81    1.12  merge
 516    0.01    0.02    0.01  mkdir
  21    0.01    0.02    0.01  propdel
  6K    0.01    0.02    0.01  proplist
  6K    0.01    0.02    0.01  propset
 591    0.01    0.02    0.01  ps
  18    0.01    0.04    0.02  resolve
  18    0.01    0.55    0.16  resolved
 126    0.01    0.54    0.12  status
   9    0.05    2.07    0.76  switch
 126    0.02    3.86    0.52  update
--
Compare trunk@1495850 to 1.7.0
       N        min              max              avg         operation
     36/9    0.84| -0.501     0.44|-143.619    0.53|-36.897   TOTAL RUN
   2K/530    0.94| -0.000     0.63| -0.820     0.78| -0.005   add
    72/18    0.92| -0.001     0.70| -1.535     0.75| -0.218   checkout
   288/72    0.69| -0.010     0.53| -8.073     0.63| -0.769   commit
     36/9    1.11| +0.002     0.15| -0.113     0.75| -0.006   copy
     36/9    0.92| -0.002     0.63| -0.352     0.79| -0.060   delete
   180/45    1.01| +0.000     0.11|-28.321     0.16| -3.699   info
    72/18    0.50| -0.059     0.45| -4.682     0.52| -1.037   merge
   1K/516    0.94| -0.000     0.49| -0.021     0.76| -0.003   mkdir
    96/21    0.88| -0.001     0.78| -0.005     0.78| -0.002   propdel
   26K/6K    0.86| -0.001     0.55| -0.015     0.66| -0.003   proplist
   27K/6K    0.87| -0.001     0.29| -0.046     0.68| -0.004   propset
   2K/591    0.88| -0.001     0.59| -0.016     0.68| -0.004   ps
    72/18    1.29| +0.002     2.35| +0.025     1.86| +0.009   resolve
    72/18    0.83| -0.002     0.83| -0.112     0.81| -0.038   resolved
  504/126    0.84| -0.002     0.56| -0.424     0.68| -0.059   status
     36/9    0.80| -0.012     0.69| -0.951     0.69| -0.336   switch
  504/126    0.99| -0.000     0.78| -1.119     0.76| -0.162   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk@1495850' is faster.
 "2/3" means: '1.7.0' has 2 timings on record, the other has 3.)



Had started at Mon Jun 24 00:25:46 UTC 2013,
       done at Mon Jun 24 00:36:00 UTC 2013
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk@last12.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk@last12,5x5.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk@last12,1x100.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk@last12,100x1.svg