[svn.haxx.se] · SVN Dev · SVN Users · SVN Org · TSVN Dev · TSVN Users · Subclipse Dev · Subclipse Users · this month's index

[svnbench] Revision: 1425563 compiled Dec 24 2012, 00:21:43 on x86_64-unknown-linux-gnu

From: <neels_at_apache.org>
Date: Mon, 24 Dec 2012 00:53:01 +0000

1.7.0_at_1181106 vs. trunk_at_1425370
Started at Mon Dec 24 00:25:10 UTC 2012

*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_at_1425370 to 1.7.0
       N avg operation
     77/9 0.70|-45.679 TOTAL RUN
   4K/530 0.78| -0.005 add
   154/18 0.56| -0.433 checkout
   616/72 0.90| -0.962 commit
     77/9 1.00| -0.000 copy
     77/9 0.86| -0.047 delete
   385/45 0.14| -4.976 info
   154/18 0.69| -1.196 merge
   4K/516 0.86| -0.002 mkdir
   208/21 0.82| -0.002 propdel
   58K/6K 0.77| -0.002 proplist
   59K/6K 0.78| -0.003 propset
   4K/591 0.70| -0.004 ps
   154/18 0.88| -0.001 resolve
   154/18 0.92| -0.018 resolved
   1K/126 0.70| -0.062 status
     77/9 0.77| -0.322 switch
   1K/126 0.66| -0.282 update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk_at_1425370' 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_at_1425370,5x5 to 1.7.0,5x5
       N avg operation
     26/3 0.70|-124.298 TOTAL RUN
   4K/456 0.75| -0.006 add
     52/6 0.56| -1.163 checkout
   208/24 0.92| -2.184 commit
     26/3 1.06| +0.018 copy
     26/3 0.84| -0.135 delete
   130/15 0.13|-14.574 info
     52/6 0.70| -3.127 merge
   3K/470 0.85| -0.002 mkdir
   208/20 0.81| -0.002 propdel
   54K/6K 0.77| -0.002 proplist
   56K/6K 0.78| -0.002 propset
   4K/552 0.69| -0.004 ps
     52/6 0.88| -0.001 resolve
     52/6 0.93| -0.040 resolved
   364/42 0.70| -0.158 status
     26/3 0.80| -0.738 switch
   364/42 0.67| -0.712 update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk_at_1425370,5x5' is faster.
 "2/3" means: '1.7.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk_at_1425370,100x1 to 1.7.0,100x1
       N avg operation
     26/3 0.79| -5.959 TOTAL RUN
   728/71 0.94| -0.001 add
     52/6 0.62| -0.073 checkout
   208/24 0.85| -0.298 commit
     26/3 0.99| -0.003 copy
     26/3 1.09| +0.010 delete
   130/15 0.51| -0.128 info
     52/6 0.65| -0.232 merge
   364/46 1.00| -0.000 mkdir
   2K/337 0.74| -0.003 proplist
   2K/273 0.75| -0.003 propset
   182/33 0.78| -0.003 ps
     52/6 0.85| -0.001 resolve
     52/6 1.01| +0.001 resolved
   364/42 0.77| -0.017 status
     26/3 0.60| -0.154 switch
   364/42 0.66| -0.092 update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk_at_1425370,100x1' is faster.
 "2/3" means: '1.7.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk_at_1425370,1x100 to 1.7.0,1x100
       N avg operation
     25/3 0.86| -1.177 TOTAL RUN
     25/3 0.60| -0.017 add
     50/6 0.63| -0.028 checkout
   200/24 0.92| -0.054 commit
     25/3 0.94| -0.014 copy
     25/3 0.81| -0.005 delete
   125/15 0.91| -0.005 info
     50/6 0.58| -0.087 merge
  925/111 0.77| -0.002 proplist
   1K/126 0.78| -0.002 propset
     50/6 0.76| -0.002 ps
     50/6 0.90| -0.001 resolve
     50/6 0.69| -0.005 resolved
   350/42 0.76| -0.004 status
     25/3 0.69| -0.023 switch
   350/42 0.77| -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_at_1425370,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)
  26 391.94 561.33 420.61 TOTAL RUN
  4K 0.01 2.29 0.02 add
  52 0.02 6.14 2.67 checkout
 208 1.53 160.96 26.38 commit
  26 0.19 0.49 0.27 copy
  26 0.73 1.24 0.84 delete
 130 8.40 43.37 16.76 info
  52 6.40 21.02 10.55 merge
  3K 0.01 1.08 0.01 mkdir
 208 0.01 0.09 0.01 propdel
 54K 0.01 0.73 0.01 proplist
 56K 0.01 1.10 0.01 propset
  4K 0.01 0.92 0.01 ps
  52 0.01 0.01 0.01 resolve
  52 0.45 0.99 0.60 resolved
 364 0.20 2.36 0.52 status
  26 3.13 4.82 3.70 switch
 364 0.25 7.02 2.14 update

--
Timings for trunk_at_1425370,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  292.82  299.85  296.32  TOTAL RUN
 456    0.01    1.01    0.02  add
   6    0.02    3.04    1.51  checkout
  24    2.17   82.72   24.20  commit
   3    0.28    0.29    0.29  copy
   3    0.60    0.89    0.70  delete
  15    1.63    3.78    2.19  info
   6    3.15   12.38    7.42  merge
 470    0.01    0.64    0.01  mkdir
  20    0.01    0.03    0.01  propdel
  6K    0.01    0.36    0.01  proplist
  6K    0.01    0.62    0.01  propset
 552    0.01    0.09    0.01  ps
   6    0.01    0.01    0.01  resolve
   6    0.29    1.27    0.56  resolved
  42    0.13    1.16    0.36  status
   3    2.71    3.23    2.96  switch
  42    0.22    4.19    1.42  update
--
Compare trunk_at_1425370,5x5 to 1.7.0,5x5
       N        min              max              avg         operation
     26/3    0.75|-99.122     0.53|-261.485    0.70|-124.298  TOTAL RUN
   4K/456    0.84| -0.001     0.44| -1.284     0.75| -0.006   add
     52/6    0.83| -0.003     0.49| -3.104     0.56| -1.163   checkout
   208/24    1.42| +0.639     0.51|-78.239     0.92| -2.184   commit
     26/3    1.54| +0.099     0.60| -0.197     1.06| +0.018   copy
     26/3    0.81| -0.137     0.72| -0.351     0.84| -0.135   delete
   130/15    0.19| -6.771     0.09|-39.596     0.13|-14.574   info
     52/6    0.49| -3.250     0.59| -8.641     0.70| -3.127   merge
   3K/470    0.85| -0.001     0.59| -0.439     0.85| -0.002   mkdir
   208/20    0.82| -0.002     0.36| -0.055     0.81| -0.002   propdel
   54K/6K    0.79| -0.002     0.49| -0.372     0.77| -0.002   proplist
   56K/6K    0.79| -0.002     0.56| -0.480     0.78| -0.002   propset
   4K/552    0.78| -0.002     0.10| -0.831     0.69| -0.004   ps
     52/6    0.91| -0.001     0.65| -0.005     0.88| -0.001   resolve
     52/6    0.63| -0.166     1.28| +0.279     0.93| -0.040   resolved
   364/42    0.64| -0.070     0.49| -1.197     0.70| -0.158   status
     26/3    0.86| -0.427     0.67| -1.587     0.80| -0.738   switch
   364/42    0.89| -0.027     0.60| -2.827     0.67| -0.712   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk_at_1425370,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)
  26   24.65   43.91   28.02  TOTAL RUN
 728    0.01    0.21    0.02  add
  52    0.02    0.43    0.19  checkout
 208    0.31   10.98    1.98  commit
  26    0.16    1.29    0.27  copy
  26    0.10    0.13    0.11  delete
 130    0.16    1.32    0.26  info
  52    0.56    2.07    0.66  merge
 364    0.01    0.81    0.02  mkdir
  2K    0.01    0.07    0.01  proplist
  2K    0.01    0.04    0.01  propset
 182    0.01    0.02    0.01  ps
  52    0.01    0.01    0.01  resolve
  52    0.05    0.10    0.07  resolved
 364    0.04    0.13    0.07  status
  26    0.37    0.41    0.38  switch
 364    0.05    1.02    0.27  update
--
Timings for trunk_at_1425370,100x1
   N    min     max     avg   operation  (unit is seconds)
   3   21.59   22.34   22.06  TOTAL RUN
  71    0.01    0.09    0.02  add
   6    0.02    0.22    0.12  checkout
  24    0.85    3.55    1.68  commit
   3    0.26    0.28    0.27  copy
   3    0.09    0.17    0.12  delete
  15    0.10    0.20    0.13  info
   6    0.29    0.74    0.42  merge
  46    0.01    0.03    0.02  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.09    0.07  resolved
  42    0.03    0.09    0.06  status
   3    0.22    0.24    0.23  switch
  42    0.04    0.41    0.18  update
--
Compare trunk_at_1425370,100x1 to 1.7.0,100x1
       N        min              max              avg         operation
     26/3    0.88| -3.064     0.51|-21.576     0.79| -5.959   TOTAL RUN
   728/71    0.84| -0.002     0.43| -0.118     0.94| -0.001   add
     52/6    0.82| -0.003     0.52| -0.207     0.62| -0.073   checkout
   208/24    2.75| +0.541     0.32| -7.423     0.85| -0.298   commit
     26/3    1.59| +0.097     0.22| -1.016     0.99| -0.003   copy
     26/3    0.88| -0.012     1.39| +0.049     1.09| +0.010   delete
   130/15    0.63| -0.060     0.15| -1.116     0.51| -0.128   info
     52/6    0.51| -0.274     0.36| -1.329     0.65| -0.232   merge
   364/46    0.86| -0.001     0.04| -0.779     1.00| -0.000   mkdir
   2K/337    0.77| -0.002     0.20| -0.054     0.74| -0.003   proplist
   2K/273    0.79| -0.002     0.31| -0.029     0.75| -0.003   propset
   182/33    0.73| -0.003     0.70| -0.006     0.78| -0.003   ps
     52/6    0.91| -0.001     0.73| -0.003     0.85| -0.001   resolve
     52/6    1.23| +0.012     0.89| -0.011     1.01| +0.001   resolved
   364/42    0.74| -0.011     0.74| -0.034     0.77| -0.017   status
     26/3    0.60| -0.150     0.58| -0.169     0.60| -0.154   switch
   364/42    0.88| -0.005     0.40| -0.612     0.66| -0.092   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk_at_1425370,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)
  25    7.65   17.23    8.68  TOTAL RUN
  25    0.04    0.05    0.04  add
  50    0.02    0.15    0.08  checkout
 200    0.18    5.67    0.70  commit
  25    0.15    0.66    0.22  copy
  25    0.02    0.07    0.03  delete
 125    0.05    0.10    0.06  info
  50    0.14    0.61    0.21  merge
 925    0.01    0.03    0.01  proplist
  1K    0.01    0.05    0.01  propset
  50    0.01    0.01    0.01  ps
  50    0.01    0.01    0.01  resolve
  50    0.02    0.02    0.02  resolved
 350    0.01    0.03    0.02  status
  25    0.07    0.09    0.07  switch
 350    0.02    0.14    0.05  update
--
Timings for trunk_at_1425370,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    7.08    8.02    7.51  TOTAL RUN
   3    0.03    0.03    0.03  add
   6    0.02    0.08    0.05  checkout
  24    0.25    2.30    0.65  commit
   3    0.21    0.21    0.21  copy
   3    0.02    0.02    0.02  delete
  15    0.04    0.09    0.05  info
   6    0.07    0.19    0.12  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.01    0.01  resolved
  42    0.01    0.02    0.01  status
   3    0.04    0.06    0.05  switch
  42    0.02    0.10    0.04  update
--
Compare trunk_at_1425370,1x100 to 1.7.0,1x100
       N        min              max              avg         operation
     25/3    0.92| -0.577     0.47| -9.208     0.86| -1.177   TOTAL RUN
     25/3    0.62| -0.016     0.55| -0.022     0.60| -0.017   add
     50/6    0.83| -0.003     0.54| -0.068     0.63| -0.028   checkout
   200/24    1.38| +0.068     0.41| -3.364     0.92| -0.054   commit
     25/3    1.37| +0.055     0.32| -0.450     0.94| -0.014   copy
     25/3    0.90| -0.002     0.30| -0.049     0.81| -0.005   delete
   125/15    0.96| -0.002     0.84| -0.016     0.91| -0.005   info
     50/6    0.49| -0.071     0.31| -0.419     0.58| -0.087   merge
  925/111    0.79| -0.002     0.28| -0.021     0.77| -0.002   proplist
   1K/126    0.80| -0.002     0.24| -0.035     0.78| -0.002   propset
     50/6    0.79| -0.002     0.62| -0.005     0.76| -0.002   ps
     50/6    0.90| -0.001     0.87| -0.001     0.90| -0.001   resolve
     50/6    0.65| -0.005     0.60| -0.009     0.69| -0.005   resolved
   350/42    0.81| -0.002     0.72| -0.007     0.76| -0.004   status
     25/3    0.65| -0.024     0.71| -0.025     0.69| -0.023   switch
   350/42    0.91| -0.002     0.71| -0.041     0.77| -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_at_1425370,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)
  77    7.65  561.33  154.31  TOTAL RUN
  4K    0.01    2.29    0.02  add
 154    0.02    6.14    0.99  checkout
 616    0.18  160.96    9.80  commit
  77    0.15    1.29    0.26  copy
  77    0.02    1.24    0.33  delete
 385    0.05   43.37    5.77  info
 154    0.14   21.02    3.85  merge
  4K    0.01    1.08    0.02  mkdir
 208    0.01    0.09    0.01  propdel
 58K    0.01    0.73    0.01  proplist
 59K    0.01    1.10    0.01  propset
  4K    0.01    0.92    0.01  ps
 154    0.01    0.01    0.01  resolve
 154    0.02    0.99    0.23  resolved
  1K    0.01    2.36    0.21  status
  77    0.07    4.82    1.40  switch
  1K    0.02    7.02    0.83  update
--
Timings for trunk_at_1425370
   N    min     max     avg   operation  (unit is seconds)
   9    7.08  299.85  108.63  TOTAL RUN
 530    0.01    1.01    0.02  add
  18    0.02    3.04    0.56  checkout
  72    0.25   82.72    8.84  commit
   9    0.21    0.29    0.26  copy
   9    0.02    0.89    0.28  delete
  45    0.04    3.78    0.79  info
  18    0.07   12.38    2.66  merge
 516    0.01    0.64    0.01  mkdir
  21    0.01    0.03    0.01  propdel
  6K    0.01    0.36    0.01  proplist
  6K    0.01    0.62    0.01  propset
 591    0.01    0.09    0.01  ps
  18    0.01    0.01    0.01  resolve
  18    0.01    1.27    0.22  resolved
 126    0.01    1.16    0.14  status
   9    0.04    3.23    1.08  switch
 126    0.02    4.19    0.55  update
--
Compare trunk_at_1425370 to 1.7.0
       N        min              max              avg         operation
     77/9    0.92| -0.577     0.53|-261.485    0.70|-45.679   TOTAL RUN
   4K/530    0.84| -0.001     0.44| -1.284     0.78| -0.005   add
   154/18    0.83| -0.003     0.49| -3.104     0.56| -0.433   checkout
   616/72    1.38| +0.068     0.51|-78.239     0.90| -0.962   commit
     77/9    1.37| +0.055     0.23| -1.001     1.00| -0.000   copy
     77/9    0.90| -0.002     0.72| -0.351     0.86| -0.047   delete
   385/45    0.96| -0.002     0.09|-39.596     0.14| -4.976   info
   154/18    0.49| -0.071     0.59| -8.641     0.69| -1.196   merge
   4K/516    0.85| -0.001     0.59| -0.439     0.86| -0.002   mkdir
   208/21    0.82| -0.002     0.36| -0.055     0.82| -0.002   propdel
   58K/6K    0.79| -0.002     0.49| -0.372     0.77| -0.002   proplist
   59K/6K    0.79| -0.002     0.56| -0.480     0.78| -0.003   propset
   4K/591    0.78| -0.002     0.10| -0.831     0.70| -0.004   ps
   154/18    0.90| -0.001     0.67| -0.005     0.88| -0.001   resolve
   154/18    0.65| -0.005     1.28| +0.279     0.92| -0.018   resolved
   1K/126    0.81| -0.002     0.49| -1.197     0.70| -0.062   status
     77/9    0.65| -0.024     0.67| -1.587     0.77| -0.322   switch
   1K/126    0.91| -0.002     0.60| -2.827     0.66| -0.282   update
(legend: "1.23|+0.45" means: slower by factor 1.23 and by 0.45 seconds;
 factor < 1 and seconds < 0 means 'trunk_at_1425370' is faster.
 "2/3" means: '1.7.0' has 2 timings on record, the other has 3.)
Had started at Mon Dec 24 00:25:10 UTC 2012,
       done at Mon Dec 24 00:50:20 UTC 2012
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk_at_last12.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk_at_last12,5x5.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk_at_last12,1x100.svg
wrote chart file: /home/neels/svnbench/charts/.busy/compare_1.7.0_trunk_at_last12,100x1.svg
Received on 2012-12-24 01:54:04 CET

This is an archived mail posted to the Subversion Dev mailing list.