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

[svnbench] Revision: 1460490 compiled Mar 25 2013, 00:22:00 on x86_64-unknown-linux-gnu

From: <neels_at_apache.org>
Date: Mon, 25 Mar 2013 00:44:08 +0000

1.7.0_at_1181106 vs. trunk_at_1460178
Started at Mon Mar 25 00:26:36 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_at_1460178 to 1.7.0
       N avg operation
    116/9 0.37|-96.018 TOTAL RUN
   7K/530 1.10| +0.002 add
   232/18 0.80| -0.200 checkout
   928/72 0.16| -8.013 commit
    116/9 0.10| -0.216 copy
    116/9 0.89| -0.038 delete
   580/45 0.16| -4.787 info
   232/18 0.32| -2.558 merge
   6K/516 1.04| +0.001 mkdir
   312/21 1.02| +0.000 propdel
   87K/6K 1.13| +0.001 proplist
   89K/6K 1.11| +0.001 propset
   7K/591 1.06| +0.001 ps
   232/18 2.44| +0.014 resolve
   232/18 0.88| -0.029 resolved
   1K/126 0.78| -0.046 status
    116/9 0.72| -0.390 switch
   1K/126 0.76| -0.196 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_1460178' 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_1460178,5x5 to 1.7.0,5x5
       N avg operation
     39/3 0.35|-272.503 TOTAL RUN
   6K/456 1.01| +0.000 add
     78/6 0.74| -0.679 checkout
   312/24 0.15|-21.993 commit
     39/3 0.06| -0.247 copy
     39/3 0.79| -0.180 delete
   195/15 0.14|-14.254 info
     78/6 0.30| -7.301 merge
   5K/470 0.98| -0.000 mkdir
   312/20 0.97| -0.000 propdel
   81K/6K 1.11| +0.001 proplist
   84K/6K 1.10| +0.001 propset
   6K/552 1.03| +0.000 ps
     78/6 3.19| +0.022 resolve
     78/6 0.77| -0.144 resolved
   546/42 0.69| -0.164 status
     39/3 0.68| -1.180 switch
   546/42 0.70| -0.625 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_1460178,5x5' is faster.
 "2/3" means: '1.7.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk_at_1460178,100x1 to 1.7.0,100x1
       N avg operation
     39/3 0.67| -8.915 TOTAL RUN
    1K/71 1.71| +0.013 add
     78/6 1.28| +0.055 checkout
   312/24 0.28| -1.331 commit
     39/3 0.11| -0.220 copy
     39/3 1.52| +0.060 delete
   195/15 0.97| -0.008 info
     78/6 0.66| -0.220 merge
   546/46 1.63| +0.010 mkdir
   4K/337 1.31| +0.004 proplist
   3K/273 1.31| +0.004 propset
   273/33 1.37| +0.005 ps
     78/6 2.19| +0.012 resolve
     78/6 1.73| +0.054 resolved
   546/42 1.30| +0.023 status
     39/3 1.03| +0.012 switch
   546/42 1.11| +0.032 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_1460178,100x1' is faster.
 "2/3" means: '1.7.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk_at_1460178,1x100 to 1.7.0,1x100
       N avg operation
     38/3 0.65| -2.953 TOTAL RUN
     38/3 1.76| +0.034 add
     76/6 1.59| +0.045 checkout
   304/24 0.27| -0.485 commit
     38/3 0.14| -0.179 copy
     38/3 1.59| +0.015 delete
   190/15 1.78| +0.045 info
     76/6 0.70| -0.061 merge
   1K/111 1.48| +0.004 proplist
   1K/126 1.52| +0.005 propset
     76/6 1.53| +0.006 ps
     76/6 1.93| +0.009 resolve
     76/6 1.50| +0.009 resolved
   532/42 1.41| +0.007 status
     38/3 1.40| +0.031 switch
   532/42 1.53| +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_at_1460178,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)
  39 227.56 624.64 416.70 TOTAL RUN
  6K 0.01 2.29 0.02 add
  78 0.02 6.14 2.66 checkout
 312 1.26 203.68 26.01 commit
  39 0.02 0.49 0.26 copy
  39 0.69 2.76 0.87 delete
 195 6.35 43.37 16.57 info
  78 5.28 21.02 10.37 merge
  5K 0.01 1.08 0.01 mkdir
 312 0.01 0.09 0.01 propdel
 81K 0.01 0.88 0.01 proplist
 84K 0.01 2.03 0.01 propset
  6K 0.01 0.92 0.01 ps
  78 0.01 0.02 0.01 resolve
  78 0.43 2.30 0.63 resolved
 546 0.17 2.36 0.52 status
  39 2.71 4.82 3.65 switch
 546 0.21 7.19 2.10 update

--
Timings for trunk_at_1460178,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  134.11  162.28  144.20  TOTAL RUN
 456    0.01    1.64    0.02  add
   6    0.02    4.19    1.98  checkout
  24    0.59    9.51    4.02  commit
   3    0.02    0.02    0.02  copy
   3    0.51    0.98    0.69  delete
  15    0.58    7.34    2.32  info
   6    2.24    3.96    3.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.07    0.01  propset
 552    0.01    0.02    0.01  ps
   6    0.02    0.04    0.03  resolve
   6    0.30    0.80    0.48  resolved
  42    0.11    0.80    0.36  status
   3    2.30    2.77    2.47  switch
  42    0.19    3.81    1.48  update
--
Compare trunk_at_1460178,5x5 to 1.7.0,5x5
       N        min              max              avg         operation
     39/3    0.59|-93.451     0.26|-462.354    0.35|-272.503  TOTAL RUN
   6K/456    0.88| -0.001     0.71| -0.655     1.01| +0.000   add
     78/6    0.80| -0.004     0.68| -1.954     0.74| -0.679   checkout
   312/24    0.47| -0.670     0.05|-194.163    0.15|-21.993   commit
     39/3    0.94| -0.001     0.03| -0.474     0.06| -0.247   copy
     39/3    0.74| -0.183     0.36| -1.778     0.79| -0.180   delete
   195/15    0.09| -5.768     0.17|-36.031     0.14|-14.254   info
     78/6    0.42| -3.043     0.19|-17.061     0.30| -7.301   merge
   5K/470    0.90| -0.001     0.02| -1.053     0.98| -0.000   mkdir
   312/20    0.82| -0.001     0.20| -0.069     0.97| -0.000   propdel
   81K/6K    0.80| -0.001     0.03| -0.856     1.11| +0.001   proplist
   84K/6K    0.83| -0.001     0.03| -1.962     1.10| +0.001   propset
   6K/552    0.83| -0.001     0.02| -0.902     1.03| +0.000   ps
     78/6    3.00| +0.017     2.13| +0.021     3.19| +0.022   resolve
     78/6    0.69| -0.132     0.35| -1.504     0.77| -0.144   resolved
   546/42    0.67| -0.056     0.34| -1.560     0.69| -0.164   status
     39/3    0.85| -0.405     0.57| -2.048     0.68| -1.180   switch
   546/42    0.92| -0.017     0.53| -3.389     0.70| -0.625   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_1460178,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)
  39   21.81   43.91   27.28  TOTAL RUN
  1K    0.01    0.21    0.02  add
  78    0.02    0.74    0.20  checkout
 312    0.19   10.98    1.86  commit
  39    0.02    1.29    0.25  copy
  39    0.10    0.22    0.12  delete
 195    0.16    1.32    0.27  info
  78    0.46    2.07    0.65  merge
 546    0.01    0.81    0.02  mkdir
  4K    0.01    0.14    0.01  proplist
  3K    0.01    0.26    0.01  propset
 273    0.01    0.03    0.01  ps
  78    0.01    0.03    0.01  resolve
  78    0.05    0.18    0.07  resolved
 546    0.04    0.26    0.08  status
  39    0.33    0.51    0.39  switch
 546    0.04    1.42    0.28  update
--
Timings for trunk_at_1460178,100x1
   N    min     max     avg   operation  (unit is seconds)
   3   17.34   19.08   18.37  TOTAL RUN
  71    0.01    0.23    0.03  add
   6    0.03    0.48    0.25  checkout
  24    0.11    1.01    0.53  commit
   3    0.02    0.03    0.03  copy
   3    0.17    0.18    0.18  delete
  15    0.12    0.42    0.26  info
   6    0.18    0.54    0.43  merge
  46    0.01    0.04    0.03  mkdir
   1    0.02    0.02    0.02  propdel
 337    0.01    0.02    0.02  proplist
 273    0.01    0.03    0.02  propset
  33    0.01    0.02    0.02  ps
   6    0.01    0.03    0.02  resolve
   6    0.06    0.15    0.13  resolved
  42    0.03    0.16    0.10  status
   3    0.36    0.42    0.40  switch
  42    0.04    0.63    0.31  update
--
Compare trunk_at_1460178,100x1 to 1.7.0,100x1
       N        min              max              avg         operation
     39/3    0.79| -4.472     0.43|-24.836     0.67| -8.915   TOTAL RUN
    1K/71    0.89| -0.001     1.10| +0.020     1.71| +0.013   add
     78/6    1.94| +0.017     0.64| -0.265     1.28| +0.055   checkout
   312/24    0.57| -0.080     0.09| -9.962     0.28| -1.331   commit
     39/3    1.15| +0.003     0.02| -1.264     0.11| -0.220   copy
     39/3    1.74| +0.074     0.82| -0.040     1.52| +0.060   delete
   195/15    0.78| -0.034     0.32| -0.894     0.97| -0.008   info
     78/6    0.40| -0.273     0.26| -1.531     0.66| -0.220   merge
   546/46    1.03| +0.000     0.05| -0.766     1.63| +0.010   mkdir
   4K/337    0.80| -0.001     0.14| -0.124     1.31| +0.004   proplist
   3K/273    0.83| -0.001     0.11| -0.233     1.31| +0.004   propset
   273/33    0.80| -0.002     0.79| -0.006     1.37| +0.005   ps
     78/6    1.56| +0.004     0.89| -0.003     2.19| +0.012   resolve
     78/6    1.29| +0.014     0.84| -0.028     1.73| +0.054   resolved
   546/42    0.66| -0.014     0.59| -0.109     1.30| +0.023   status
     39/3    1.09| +0.028     0.82| -0.090     1.03| +0.012   switch
   546/42    0.88| -0.005     0.44| -0.795     1.11| +0.032   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_1460178,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)
  38    5.01   17.23    8.44  TOTAL RUN
  38    0.04    0.09    0.04  add
  76    0.02    0.26    0.08  checkout
 304    0.03    5.67    0.67  commit
  38    0.02    0.66    0.21  copy
  38    0.02    0.07    0.03  delete
 190    0.04    0.18    0.06  info
  76    0.12    0.61    0.21  merge
  1K    0.01    0.03    0.01  proplist
  1K    0.01    0.05    0.01  propset
  76    0.01    0.02    0.01  ps
  76    0.01    0.02    0.01  resolve
  76    0.01    0.03    0.02  resolved
 532    0.01    0.04    0.02  status
  38    0.07    0.14    0.08  switch
 532    0.02    0.22    0.05  update
--
Timings for trunk_at_1460178,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    5.05    5.71    5.49  TOTAL RUN
   3    0.08    0.08    0.08  add
   6    0.03    0.21    0.12  checkout
  24    0.04    0.43    0.18  commit
   3    0.03    0.03    0.03  copy
   3    0.04    0.04    0.04  delete
  15    0.04    0.18    0.10  info
   6    0.08    0.20    0.14  merge
 111    0.01    0.02    0.01  proplist
 126    0.01    0.02    0.02  propset
   6    0.02    0.02    0.02  ps
   6    0.01    0.02    0.02  resolve
   6    0.02    0.04    0.03  resolved
  42    0.01    0.04    0.02  status
   3    0.11    0.11    0.11  switch
  42    0.02    0.21    0.07  update
--
Compare trunk_at_1460178,1x100 to 1.7.0,1x100
       N        min              max              avg         operation
     38/3    1.01| +0.049     0.33|-11.523     0.65| -2.953   TOTAL RUN
     38/3    2.08| +0.040     0.95| -0.005     1.76| +0.034   add
     76/6    1.95| +0.017     0.83| -0.044     1.59| +0.045   checkout
   304/24    1.28| +0.010     0.08| -5.230     0.27| -0.485   commit
     38/3    1.88| +0.013     0.05| -0.627     0.14| -0.179   copy
     38/3    1.82| +0.019     0.59| -0.029     1.59| +0.015   delete
   190/15    0.97| -0.001     0.97| -0.005     1.78| +0.045   info
     76/6    0.69| -0.038     0.32| -0.414     0.70| -0.061   merge
   1K/111    1.81| +0.006     0.53| -0.014     1.48| +0.004   proplist
   1K/126    1.77| +0.006     0.35| -0.030     1.52| +0.005   propset
     76/6    1.70| +0.007     0.84| -0.003     1.53| +0.006   ps
     76/6    1.31| +0.002     1.23| +0.004     1.93| +0.009   resolve
     76/6    1.13| +0.002     1.06| +0.002     1.50| +0.009   resolved
   532/42    1.27| +0.003     0.80| -0.009     1.41| +0.007   status
     38/3    1.55| +0.038     0.74| -0.037     1.40| +0.031   switch
   532/42    1.12| +0.002     0.95| -0.010     1.53| +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_at_1460178,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)
 116    5.01  624.64  152.04  TOTAL RUN
  7K    0.01    2.29    0.02  add
 232    0.02    6.14    0.99  checkout
 928    0.03  203.68    9.59  commit
 116    0.02    1.29    0.24  copy
 116    0.02    2.76    0.34  delete
 580    0.04   43.37    5.68  info
 232    0.12   21.02    3.77  merge
  6K    0.01    1.08    0.01  mkdir
 312    0.01    0.09    0.01  propdel
 87K    0.01    0.88    0.01  proplist
 89K    0.01    2.03    0.01  propset
  7K    0.01    0.92    0.01  ps
 232    0.01    0.03    0.01  resolve
 232    0.01    2.30    0.24  resolved
  1K    0.01    2.36    0.21  status
 116    0.07    4.82    1.38  switch
  1K    0.02    7.19    0.82  update
--
Timings for trunk_at_1460178
   N    min     max     avg   operation  (unit is seconds)
   9    5.05  162.28   56.02  TOTAL RUN
 530    0.01    1.64    0.02  add
  18    0.02    4.19    0.79  checkout
  72    0.04    9.51    1.58  commit
   9    0.02    0.03    0.02  copy
   9    0.04    0.98    0.30  delete
  45    0.04    7.34    0.89  info
  18    0.08    3.96    1.21  merge
 516    0.01    0.04    0.02  mkdir
  21    0.01    0.02    0.01  propdel
  6K    0.01    0.02    0.01  proplist
  6K    0.01    0.07    0.01  propset
 591    0.01    0.02    0.01  ps
  18    0.01    0.04    0.02  resolve
  18    0.02    0.80    0.21  resolved
 126    0.01    0.80    0.16  status
   9    0.11    2.77    0.99  switch
 126    0.02    3.81    0.62  update
--
Compare trunk_at_1460178 to 1.7.0
       N        min              max              avg         operation
    116/9    1.01| +0.049     0.26|-462.354    0.37|-96.018   TOTAL RUN
   7K/530    0.88| -0.001     0.71| -0.655     1.10| +0.002   add
   232/18    0.90| -0.002     0.68| -1.954     0.80| -0.200   checkout
   928/72    1.28| +0.010     0.05|-194.163    0.16| -8.013   commit
    116/9    1.05| +0.001     0.02| -1.264     0.10| -0.216   copy
    116/9    1.82| +0.019     0.36| -1.778     0.89| -0.038   delete
   580/45    0.97| -0.001     0.17|-36.031     0.16| -4.787   info
   232/18    0.69| -0.038     0.19|-17.061     0.32| -2.558   merge
   6K/516    0.90| -0.001     0.04| -1.038     1.04| +0.001   mkdir
   312/21    0.82| -0.001     0.28| -0.062     1.02| +0.000   propdel
   87K/6K    0.80| -0.001     0.03| -0.856     1.13| +0.001   proplist
   89K/6K    0.83| -0.001     0.03| -1.962     1.11| +0.001   propset
   7K/591    0.83| -0.001     0.03| -0.900     1.06| +0.001   ps
   232/18    1.31| +0.002     1.31| +0.009     2.44| +0.014   resolve
   232/18    1.13| +0.002     0.35| -1.504     0.88| -0.029   resolved
   1K/126    1.27| +0.003     0.34| -1.560     0.78| -0.046   status
    116/9    1.55| +0.038     0.57| -2.048     0.72| -0.390   switch
   1K/126    1.12| +0.002     0.53| -3.389     0.76| -0.196   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_1460178' is faster.
 "2/3" means: '1.7.0' has 2 timings on record, the other has 3.)
Had started at Mon Mar 25 00:26:36 UTC 2013,
       done at Mon Mar 25 00:40:55 UTC 2013
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 2013-03-25 01:44:51 CET

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