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

[svnbench] Revision: 1408161 compiled Nov 12 2012, 00:21:45 on x86_64-unknown-linux-gnu

From: <neels_at_apache.org>
Date: Mon, 12 Nov 2012 00:58:30 +0000

1.7.0_at_1181106 vs. trunk_at_1408153
Started at Mon Nov 12 00:25:11 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_1408153 to 1.7.0
       N avg operation
     59/9 0.92|-11.975 TOTAL RUN
   3K/530 0.72| -0.006 add
   118/18 0.56| -0.432 checkout
   472/72 1.32| +3.176 commit
     59/9 1.09| +0.023 copy
     59/9 0.78| -0.074 delete
   295/45 0.13| -5.027 info
   118/18 0.76| -0.939 merge
   3K/516 0.82| -0.003 mkdir
   160/21 0.80| -0.002 propdel
   44K/6K 0.76| -0.002 proplist
   45K/6K 0.81| -0.002 propset
   3K/591 0.75| -0.003 ps
   118/18 0.87| -0.001 resolve
   118/18 0.71| -0.068 resolved
  826/126 0.71| -0.061 status
     59/9 0.86| -0.189 switch
  826/126 0.66| -0.280 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_1408153' 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_1408153,5x5 to 1.7.0,5x5
       N avg operation
     20/3 0.94|-25.647 TOTAL RUN
   3K/456 0.69| -0.007 add
     40/6 0.56| -1.151 checkout
   160/24 1.37| +9.822 commit
     20/3 1.34| +0.094 copy
     20/3 0.79| -0.179 delete
   100/15 0.12|-14.647 info
     40/6 0.78| -2.366 merge
   2K/470 0.77| -0.003 mkdir
   160/20 0.78| -0.003 propdel
   41K/6K 0.76| -0.002 proplist
   43K/6K 0.81| -0.002 propset
   3K/552 0.75| -0.003 ps
     40/6 0.84| -0.002 resolve
     40/6 0.68| -0.196 resolved
   280/42 0.70| -0.155 status
     20/3 0.91| -0.317 switch
   280/42 0.67| -0.697 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_1408153,5x5' is faster.
 "2/3" means: '1.7.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk_at_1408153,100x1 to 1.7.0,100x1
       N avg operation
     20/3 0.92| -2.229 TOTAL RUN
   560/71 0.97| -0.001 add
     40/6 0.61| -0.074 checkout
   160/24 1.09| +0.175 commit
     20/3 0.92| -0.023 copy
     20/3 0.80| -0.022 delete
   100/15 0.47| -0.140 info
     40/6 0.71| -0.186 merge
   280/46 1.24| +0.004 mkdir
   2K/337 0.73| -0.003 proplist
   1K/273 0.74| -0.003 propset
   140/33 0.77| -0.003 ps
     40/6 0.88| -0.001 resolve
     40/6 1.11| +0.008 resolved
   280/42 0.79| -0.015 status
     20/3 0.58| -0.161 switch
   280/42 0.63| -0.100 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_1408153,100x1' is faster.
 "2/3" means: '1.7.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk_at_1408153,1x100 to 1.7.0,1x100
       N avg operation
     19/3 0.92| -0.719 TOTAL RUN
     19/3 0.60| -0.017 add
     38/6 0.65| -0.027 checkout
   152/24 0.99| -0.009 commit
     19/3 0.99| -0.001 copy
     19/3 0.77| -0.006 delete
    95/15 0.85| -0.009 info
     38/6 0.62| -0.082 merge
  703/111 0.76| -0.002 proplist
  798/126 0.75| -0.003 propset
     38/6 0.79| -0.002 ps
     38/6 0.90| -0.001 resolve
     38/6 0.71| -0.005 resolved
   266/42 0.74| -0.004 status
     19/3 0.67| -0.024 switch
   266/42 0.92| -0.004 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_1408153,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)
  20 391.94 561.33 422.19 TOTAL RUN
  3K 0.01 2.29 0.02 add
  40 0.02 5.81 2.64 checkout
 160 1.53 160.96 26.55 commit
  20 0.19 0.49 0.28 copy
  20 0.74 1.24 0.85 delete
 100 8.63 43.37 16.73 info
  40 6.40 21.02 10.61 merge
  2K 0.01 0.66 0.01 mkdir
 160 0.01 0.09 0.01 propdel
 41K 0.01 0.69 0.01 proplist
 43K 0.01 1.10 0.01 propset
  3K 0.01 0.92 0.01 ps
  40 0.01 0.01 0.01 resolve
  40 0.45 0.96 0.60 resolved
 280 0.20 2.36 0.53 status
  20 3.13 4.68 3.66 switch
 280 0.25 7.02 2.13 update

--
Timings for trunk_at_1408153,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  374.15  440.59  396.54  TOTAL RUN
 456    0.01    0.97    0.02  add
   6    0.02    3.02    1.49  checkout
  24    2.44  157.17   36.38  commit
   3    0.27    0.53    0.37  copy
   3    0.62    0.70    0.67  delete
  15    1.61    3.70    2.08  info
   6    3.11   14.61    8.25  merge
 470    0.01    0.49    0.01  mkdir
  20    0.01    0.03    0.01  propdel
  6K    0.01    0.53    0.01  proplist
  6K    0.01    1.36    0.01  propset
 552    0.01    0.35    0.01  ps
   6    0.01    0.01    0.01  resolve
   6    0.28    0.51    0.41  resolved
  42    0.12    1.10    0.37  status
   3    3.11    3.70    3.34  switch
  42    0.22    4.84    1.43  update
--
Compare trunk_at_1408153,5x5 to 1.7.0,5x5
       N        min              max              avg         operation
     20/3    0.95|-17.793     0.78|-120.742    0.94|-25.647   TOTAL RUN
   3K/456    0.85| -0.001     0.43| -1.318     0.69| -0.007   add
     40/6    0.85| -0.003     0.52| -2.793     0.56| -1.151   checkout
   160/24    1.59| +0.906     0.98| -3.796     1.37| +9.822   commit
     20/3    1.46| +0.085     1.08| +0.040     1.34| +0.094   copy
     20/3    0.84| -0.119     0.56| -0.547     0.79| -0.179   delete
   100/15    0.19| -7.017     0.09|-39.675     0.12|-14.647   info
     40/6    0.49| -3.283     0.70| -6.403     0.78| -2.366   merge
   2K/470    0.87| -0.001     0.75| -0.164     0.77| -0.003   mkdir
   160/20    0.81| -0.002     0.31| -0.059     0.78| -0.003   propdel
   41K/6K    0.79| -0.002     0.77| -0.160     0.76| -0.002   proplist
   43K/6K    0.77| -0.002     1.24| +0.261     0.81| -0.002   propset
   3K/552    0.78| -0.002     0.38| -0.577     0.75| -0.003   ps
     40/6    0.88| -0.001     0.62| -0.005     0.84| -0.002   resolve
     40/6    0.63| -0.167     0.53| -0.451     0.68| -0.196   resolved
   280/42    0.63| -0.073     0.46| -1.265     0.70| -0.155   status
     20/3    0.99| -0.026     0.79| -0.977     0.91| -0.317   switch
   280/42    0.87| -0.033     0.69| -2.175     0.67| -0.697   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_1408153,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)
  20   24.65   43.91   27.67  TOTAL RUN
 560    0.01    0.21    0.02  add
  40    0.02    0.43    0.19  checkout
 160    0.31   10.98    1.94  commit
  20    0.16    1.29    0.28  copy
  20    0.10    0.13    0.11  delete
 100    0.16    1.32    0.26  info
  40    0.56    0.83    0.63  merge
 280    0.01    0.47    0.02  mkdir
  2K    0.01    0.06    0.01  proplist
  1K    0.01    0.04    0.01  propset
 140    0.01    0.02    0.01  ps
  40    0.01    0.01    0.01  resolve
  40    0.05    0.10    0.07  resolved
 280    0.04    0.13    0.07  status
  20    0.37    0.41    0.38  switch
 280    0.05    1.02    0.27  update
--
Timings for trunk_at_1408153,100x1
   N    min     max     avg   operation  (unit is seconds)
   3   23.85   26.90   25.44  TOTAL RUN
  71    0.01    0.09    0.02  add
   6    0.02    0.22    0.12  checkout
  24    0.96    4.56    2.11  commit
   3    0.23    0.29    0.26  copy
   3    0.09    0.09    0.09  delete
  15    0.09    0.18    0.12  info
   6    0.31    0.78    0.45  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.10    0.08  resolved
  42    0.03    0.11    0.06  status
   3    0.22    0.23    0.22  switch
  42    0.04    0.33    0.17  update
--
Compare trunk_at_1408153,100x1 to 1.7.0,100x1
       N        min              max              avg         operation
     20/3    0.97| -0.796     0.61|-17.015     0.92| -2.229   TOTAL RUN
   560/71    0.90| -0.001     0.42| -0.119     0.97| -0.001   add
     40/6    0.85| -0.003     0.51| -0.211     0.61| -0.074   checkout
   160/24    3.12| +0.654     0.42| -6.412     1.09| +0.175   commit
     20/3    1.41| +0.067     0.23| -1.002     0.92| -0.023   copy
     20/3    0.86| -0.014     0.70| -0.038     0.80| -0.022   delete
   100/15    0.58| -0.068     0.14| -1.132     0.47| -0.140   info
     40/6    0.55| -0.256     0.94| -0.047     0.71| -0.186   merge
   280/46    0.90| -0.001     0.07| -0.435     1.24| +0.004   mkdir
   2K/337    0.79| -0.002     0.19| -0.050     0.73| -0.003   proplist
   1K/273    0.80| -0.002     0.30| -0.029     0.74| -0.003   propset
   140/33    0.75| -0.003     0.70| -0.006     0.77| -0.003   ps
     40/6    0.92| -0.001     0.79| -0.002     0.88| -0.001   resolve
     40/6    1.22| +0.011     1.06| +0.006     1.11| +0.008   resolved
   280/42    0.74| -0.011     0.86| -0.018     0.79| -0.015   status
     20/3    0.58| -0.156     0.57| -0.174     0.58| -0.161   switch
   280/42    0.86| -0.007     0.32| -0.695     0.63| -0.100   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_1408153,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)
  19    7.69   17.23    8.74  TOTAL RUN
  19    0.04    0.05    0.04  add
  38    0.02    0.15    0.08  checkout
 152    0.18    5.67    0.70  commit
  19    0.16    0.66    0.23  copy
  19    0.02    0.07    0.03  delete
  95    0.05    0.10    0.06  info
  38    0.14    0.61    0.21  merge
 703    0.01    0.03    0.01  proplist
 798    0.01    0.05    0.01  propset
  38    0.01    0.01    0.01  ps
  38    0.01    0.01    0.01  resolve
  38    0.02    0.02    0.02  resolved
 266    0.01    0.03    0.02  status
  19    0.07    0.08    0.07  switch
 266    0.02    0.14    0.05  update
--
Timings for trunk_at_1408153,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    7.71    8.43    8.02  TOTAL RUN
   3    0.03    0.03    0.03  add
   6    0.02    0.08    0.05  checkout
  24    0.24    2.28    0.69  commit
   3    0.20    0.25    0.23  copy
   3    0.02    0.02    0.02  delete
  15    0.04    0.08    0.05  info
   6    0.07    0.23    0.13  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.41    0.04  update
--
Compare trunk_at_1408153,1x100 to 1.7.0,1x100
       N        min              max              avg         operation
     19/3    1.00| +0.025     0.49| -8.797     0.92| -0.719   TOTAL RUN
     19/3    0.63| -0.015     0.54| -0.022     0.60| -0.017   add
     38/6    0.86| -0.003     0.55| -0.067     0.65| -0.027   checkout
   152/24    1.30| +0.054     0.40| -3.383     0.99| -0.009   commit
     19/3    1.25| +0.041     0.38| -0.410     0.99| -0.001   copy
     19/3    0.90| -0.002     0.29| -0.050     0.77| -0.006   delete
    95/15    0.91| -0.004     0.76| -0.024     0.85| -0.009   info
     38/6    0.51| -0.069     0.39| -0.375     0.62| -0.082   merge
  703/111    0.81| -0.002     0.29| -0.021     0.76| -0.002   proplist
  798/126    0.80| -0.002     0.25| -0.034     0.75| -0.003   propset
     38/6    0.81| -0.002     0.67| -0.005     0.79| -0.002   ps
     38/6    0.90| -0.001     0.82| -0.002     0.90| -0.001   resolve
     38/6    0.67| -0.005     0.61| -0.009     0.71| -0.005   resolved
   266/42    0.82| -0.002     0.63| -0.010     0.74| -0.004   status
     19/3    0.65| -0.024     0.70| -0.024     0.67| -0.024   switch
   266/42    0.91| -0.002     2.88| +0.266     0.92| -0.004   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_1408153,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)
  59    7.69  561.33  155.31  TOTAL RUN
  3K    0.01    2.29    0.02  add
 118    0.02    5.81    0.98  checkout
 472    0.18  160.96    9.89  commit
  59    0.16    1.29    0.26  copy
  59    0.02    1.24    0.33  delete
 295    0.05   43.37    5.78  info
 118    0.14   21.02    3.88  merge
  3K    0.01    0.66    0.01  mkdir
 160    0.01    0.09    0.01  propdel
 44K    0.01    0.69    0.01  proplist
 45K    0.01    1.10    0.01  propset
  3K    0.01    0.92    0.01  ps
 118    0.01    0.01    0.01  resolve
 118    0.02    0.96    0.23  resolved
 826    0.01    2.36    0.21  status
  59    0.07    4.68    1.39  switch
 826    0.02    7.02    0.83  update
--
Timings for trunk_at_1408153
   N    min     max     avg   operation  (unit is seconds)
   9    7.71  440.59  143.33  TOTAL RUN
 530    0.01    0.97    0.02  add
  18    0.02    3.02    0.55  checkout
  72    0.24  157.17   13.06  commit
   9    0.20    0.53    0.29  copy
   9    0.02    0.70    0.26  delete
  45    0.04    3.70    0.75  info
  18    0.07   14.61    2.94  merge
 516    0.01    0.49    0.01  mkdir
  21    0.01    0.03    0.01  propdel
  6K    0.01    0.53    0.01  proplist
  6K    0.01    1.36    0.01  propset
 591    0.01    0.35    0.01  ps
  18    0.01    0.01    0.01  resolve
  18    0.01    0.51    0.17  resolved
 126    0.01    1.10    0.15  status
   9    0.04    3.70    1.20  switch
 126    0.02    4.84    0.55  update
--
Compare trunk_at_1408153 to 1.7.0
       N        min              max              avg         operation
     59/9    1.00| +0.025     0.78|-120.742    0.92|-11.975   TOTAL RUN
   3K/530    0.85| -0.001     0.43| -1.318     0.72| -0.006   add
   118/18    0.85| -0.003     0.52| -2.793     0.56| -0.432   checkout
   472/72    1.30| +0.054     0.98| -3.796     1.32| +3.176   commit
     59/9    1.25| +0.041     0.41| -0.764     1.09| +0.023   copy
     59/9    0.90| -0.002     0.56| -0.547     0.78| -0.074   delete
   295/45    0.91| -0.004     0.09|-39.675     0.13| -5.027   info
   118/18    0.51| -0.069     0.70| -6.403     0.76| -0.939   merge
   3K/516    0.87| -0.001     0.75| -0.164     0.82| -0.003   mkdir
   160/21    0.81| -0.002     0.31| -0.059     0.80| -0.002   propdel
   44K/6K    0.79| -0.002     0.77| -0.160     0.76| -0.002   proplist
   45K/6K    0.78| -0.002     1.24| +0.261     0.81| -0.002   propset
   3K/591    0.78| -0.002     0.38| -0.577     0.75| -0.003   ps
   118/18    0.90| -0.001     0.64| -0.005     0.87| -0.001   resolve
   118/18    0.67| -0.005     0.53| -0.451     0.71| -0.068   resolved
  826/126    0.82| -0.002     0.46| -1.265     0.71| -0.061   status
     59/9    0.65| -0.024     0.79| -0.977     0.86| -0.189   switch
  826/126    0.91| -0.002     0.69| -2.175     0.66| -0.280   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_1408153' is faster.
 "2/3" means: '1.7.0' has 2 timings on record, the other has 3.)
Had started at Mon Nov 12 00:25:11 UTC 2012,
       done at Mon Nov 12 00:56:23 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-11-12 01:59:45 CET

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