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

[svnbench] Revision: 1416319 compiled Dec 3 2012, 00:21:55 on x86_64-unknown-linux-gnu

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

1.7.0_at_1181106 vs. trunk_at_1416283
Started at Mon Dec 3 00:25:24 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_1416283 to 1.7.0
       N avg operation
     68/9 0.74|-40.202 TOTAL RUN
   4K/530 0.70| -0.007 add
   136/18 0.64| -0.360 checkout
   544/72 0.95| -0.510 commit
     68/9 1.03| +0.008 copy
     68/9 0.73| -0.090 delete
   340/45 0.14| -4.941 info
   136/18 0.75| -0.975 merge
   3K/516 0.86| -0.002 mkdir
   184/21 0.72| -0.003 propdel
   51K/6K 0.77| -0.002 proplist
   52K/6K 0.81| -0.002 propset
   4K/591 0.70| -0.004 ps
   136/18 0.91| -0.001 resolve
   136/18 1.47| +0.111 resolved
  952/126 0.82| -0.036 status
     68/9 1.14| +0.196 switch
  952/126 0.64| -0.297 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_1416283' 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_1416283,5x5 to 1.7.0,5x5
       N avg operation
     23/3 0.74|-107.675 TOTAL RUN
   3K/456 0.67| -0.007 add
     46/6 0.65| -0.941 checkout
   184/24 0.97| -0.843 commit
     23/3 1.17| +0.046 copy
     23/3 0.73| -0.232 delete
   115/15 0.14|-14.455 info
     46/6 0.77| -2.483 merge
   3K/470 0.83| -0.002 mkdir
   184/20 0.70| -0.003 propdel
   48K/6K 0.77| -0.002 proplist
   49K/6K 0.81| -0.002 propset
   4K/552 0.69| -0.004 ps
     46/6 0.90| -0.001 resolve
     46/6 1.57| +0.346 resolved
   322/42 0.85| -0.080 status
     23/3 1.23| +0.836 switch
   322/42 0.65| -0.746 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_1416283,5x5' is faster.
 "2/3" means: '1.7.0,5x5' has 2 timings on record, the other has 3.)

Compare trunk_at_1416283,100x1 to 1.7.0,100x1
       N avg operation
     23/3 0.80| -5.399 TOTAL RUN
   644/71 0.92| -0.001 add
     46/6 0.62| -0.072 checkout
   184/24 0.88| -0.226 commit
     23/3 0.77| -0.061 copy
     23/3 0.82| -0.020 delete
   115/15 0.56| -0.115 info
     46/6 0.69| -0.193 merge
   322/46 1.13| +0.002 mkdir
   2K/337 0.73| -0.003 proplist
   2K/273 0.75| -0.003 propset
   161/33 0.77| -0.003 ps
     46/6 0.89| -0.001 resolve
     46/6 1.03| +0.002 resolved
   322/42 0.78| -0.016 status
     23/3 0.58| -0.163 switch
   322/42 0.64| -0.099 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_1416283,100x1' is faster.
 "2/3" means: '1.7.0,100x1' has 2 timings on record, the other has 3.)

Compare trunk_at_1416283,1x100 to 1.7.0,1x100
       N avg operation
     22/3 0.86| -1.202 TOTAL RUN
     22/3 0.61| -0.017 add
     44/6 0.65| -0.026 checkout
   176/24 0.90| -0.067 commit
     22/3 1.18| +0.039 copy
     22/3 0.80| -0.005 delete
   110/15 0.92| -0.005 info
     44/6 0.57| -0.089 merge
  814/111 0.77| -0.002 proplist
  924/126 0.82| -0.002 propset
     44/6 0.76| -0.002 ps
     44/6 0.94| -0.001 resolve
     44/6 0.72| -0.005 resolved
   308/42 0.77| -0.004 status
     22/3 0.62| -0.028 switch
   308/42 0.75| -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_1416283,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)
  23 391.94 561.33 420.36 TOTAL RUN
  3K 0.01 2.29 0.02 add
  46 0.02 5.83 2.66 checkout
 184 1.53 160.96 26.34 commit
  23 0.19 0.49 0.27 copy
  23 0.74 1.24 0.85 delete
 115 8.40 43.37 16.72 info
  46 6.40 21.02 10.57 merge
  3K 0.01 1.08 0.01 mkdir
 184 0.01 0.09 0.01 propdel
 48K 0.01 0.73 0.01 proplist
 49K 0.01 1.10 0.01 propset
  4K 0.01 0.92 0.01 ps
  46 0.01 0.01 0.01 resolve
  46 0.45 0.99 0.61 resolved
 322 0.20 2.36 0.52 status
  23 3.13 4.82 3.71 switch
 322 0.25 7.02 2.13 update

--
Timings for trunk_at_1416283,5x5
   N    min     max     avg   operation  (unit is seconds)
   3  305.10  319.11  312.69  TOTAL RUN
 456    0.01    0.98    0.02  add
   6    0.02    3.75    1.72  checkout
  24    2.23   91.71   25.50  commit
   3    0.26    0.37    0.32  copy
   3    0.61    0.62    0.62  delete
  15    1.66    3.86    2.27  info
   6    3.25   12.54    8.09  merge
 470    0.01    0.35    0.01  mkdir
  20    0.01    0.01    0.01  propdel
  6K    0.01    0.26    0.01  proplist
  6K    0.01    0.61    0.01  propset
 552    0.01    0.12    0.01  ps
   6    0.01    0.01    0.01  resolve
   6    0.29    2.61    0.95  resolved
  42    0.13    3.05    0.44  status
   3    2.95    5.73    4.54  switch
  42    0.22    3.94    1.39  update
--
Compare trunk_at_1416283,5x5 to 1.7.0,5x5
       N        min              max              avg         operation
     23/3    0.78|-86.847     0.57|-242.224    0.74|-107.675  TOTAL RUN
   3K/456    0.87| -0.001     0.43| -1.312     0.67| -0.007   add
     46/6    0.88| -0.002     0.64| -2.085     0.65| -0.941   checkout
   184/24    1.46| +0.698     0.57|-69.256     0.97| -0.843   commit
     23/3    1.38| +0.071     0.75| -0.124     1.17| +0.046   copy
     23/3    0.83| -0.123     0.50| -0.626     0.73| -0.232   delete
   115/15    0.20| -6.741     0.09|-39.512     0.14|-14.455   info
     46/6    0.51| -3.145     0.60| -8.476     0.77| -2.483   merge
   3K/470    0.89| -0.001     0.32| -0.734     0.83| -0.002   mkdir
   184/20    0.83| -0.002     0.10| -0.077     0.70| -0.003   propdel
   48K/6K    0.83| -0.001     0.36| -0.471     0.77| -0.002   proplist
   49K/6K    0.81| -0.002     0.56| -0.484     0.81| -0.002   propset
   4K/552    0.82| -0.002     0.13| -0.805     0.69| -0.004   ps
     46/6    0.95| -0.001     0.66| -0.005     0.90| -0.001   resolve
     46/6    0.64| -0.160     2.62| +1.611     1.57| +0.346   resolved
   322/42    0.64| -0.070     1.29| +0.685     0.85| -0.080   status
     23/3    0.94| -0.186     1.19| +0.910     1.23| +0.836   switch
   322/42    0.86| -0.034     0.56| -3.076     0.65| -0.746   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_1416283,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)
  23   24.65   43.91   27.53  TOTAL RUN
 644    0.01    0.21    0.02  add
  46    0.02    0.43    0.19  checkout
 184    0.31   10.98    1.92  commit
  23    0.16    1.29    0.27  copy
  23    0.10    0.13    0.11  delete
 115    0.16    1.32    0.26  info
  46    0.56    0.83    0.63  merge
 322    0.01    0.47    0.01  mkdir
  2K    0.01    0.06    0.01  proplist
  2K    0.01    0.04    0.01  propset
 161    0.01    0.02    0.01  ps
  46    0.01    0.01    0.01  resolve
  46    0.05    0.10    0.07  resolved
 322    0.04    0.13    0.07  status
  23    0.37    0.41    0.38  switch
 322    0.05    1.02    0.27  update
--
Timings for trunk_at_1416283,100x1
   N    min     max     avg   operation  (unit is seconds)
   3   21.44   22.76   22.13  TOTAL RUN
  71    0.01    0.09    0.02  add
   6    0.02    0.22    0.12  checkout
  24    0.89    3.83    1.70  commit
   3    0.19    0.23    0.21  copy
   3    0.09    0.09    0.09  delete
  15    0.11    0.27    0.15  info
   6    0.31    0.72    0.44  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.07    0.09    0.07  resolved
  42    0.03    0.10    0.06  status
   3    0.22    0.22    0.22  switch
  42    0.04    0.33    0.17  update
--
Compare trunk_at_1416283,100x1 to 1.7.0,100x1
       N        min              max              avg         operation
     23/3    0.87| -3.214     0.52|-21.152     0.80| -5.399   TOTAL RUN
   644/71    0.85| -0.001     0.43| -0.118     0.92| -0.001   add
     46/6    0.87| -0.003     0.52| -0.206     0.62| -0.072   checkout
   184/24    2.89| +0.584     0.35| -7.143     0.88| -0.226   commit
     23/3    1.17| +0.028     0.18| -1.063     0.77| -0.061   copy
     23/3    0.88| -0.012     0.73| -0.034     0.82| -0.020   delete
   115/15    0.65| -0.056     0.20| -1.049     0.56| -0.115   info
     46/6    0.55| -0.254     0.87| -0.111     0.69| -0.193   merge
   322/46    0.88| -0.001     0.06| -0.438     1.13| +0.002   mkdir
   2K/337    0.81| -0.002     0.19| -0.050     0.73| -0.003   proplist
   2K/273    0.82| -0.002     0.31| -0.029     0.75| -0.003   propset
   161/33    0.76| -0.003     0.69| -0.006     0.77| -0.003   ps
     46/6    0.95| -0.000     0.81| -0.002     0.89| -0.001   resolve
     46/6    1.26| +0.014     0.90| -0.010     1.03| +0.002   resolved
   322/42    0.76| -0.010     0.74| -0.033     0.78| -0.016   status
     23/3    0.58| -0.154     0.55| -0.181     0.58| -0.163   switch
   322/42    0.88| -0.006     0.32| -0.695     0.64| -0.099   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_1416283,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)
  22    7.69   17.23    8.70  TOTAL RUN
  22    0.04    0.05    0.04  add
  44    0.02    0.15    0.08  checkout
 176    0.18    5.67    0.70  commit
  22    0.15    0.66    0.22  copy
  22    0.02    0.07    0.03  delete
 110    0.05    0.10    0.06  info
  44    0.14    0.61    0.21  merge
 814    0.01    0.03    0.01  proplist
 924    0.01    0.05    0.01  propset
  44    0.01    0.01    0.01  ps
  44    0.01    0.01    0.01  resolve
  44    0.02    0.02    0.02  resolved
 308    0.01    0.03    0.02  status
  22    0.07    0.09    0.07  switch
 308    0.02    0.14    0.05  update
--
Timings for trunk_at_1416283,1x100
   N    min     max     avg   operation  (unit is seconds)
   3    7.09    8.23    7.49  TOTAL RUN
   3    0.03    0.03    0.03  add
   6    0.02    0.08    0.05  checkout
  24    0.21    2.16    0.63  commit
   3    0.22    0.29    0.26  copy
   3    0.02    0.02    0.02  delete
  15    0.04    0.08    0.05  info
   6    0.07    0.17    0.12  merge
 111    0.01    0.01    0.01  proplist
 126    0.01    0.06    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.08    0.03  update
--
Compare trunk_at_1416283,1x100 to 1.7.0,1x100
       N        min              max              avg         operation
     22/3    0.92| -0.599     0.48| -9.000     0.86| -1.202   TOTAL RUN
     22/3    0.64| -0.015     0.56| -0.021     0.61| -0.017   add
     44/6    0.87| -0.003     0.55| -0.066     0.65| -0.026   checkout
   176/24    1.17| +0.031     0.38| -3.506     0.90| -0.067   commit
     22/3    1.48| +0.072     0.45| -0.365     1.18| +0.039   copy
     22/3    0.91| -0.002     0.30| -0.050     0.80| -0.005   delete
   110/15    0.97| -0.001     0.82| -0.019     0.92| -0.005   info
     44/6    0.52| -0.067     0.28| -0.436     0.57| -0.089   merge
  814/111    0.82| -0.001     0.48| -0.015     0.77| -0.002   proplist
  924/126    0.83| -0.002     1.32| +0.015     0.82| -0.002   propset
     44/6    0.82| -0.002     0.58| -0.006     0.76| -0.002   ps
     44/6    0.93| -0.001     0.90| -0.001     0.94| -0.001   resolve
     44/6    0.67| -0.005     0.67| -0.007     0.72| -0.005   resolved
   308/42    0.84| -0.002     0.76| -0.006     0.77| -0.004   status
     22/3    0.66| -0.024     0.53| -0.040     0.62| -0.028   switch
   308/42    0.93| -0.001     0.58| -0.060     0.75| -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_1416283,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)
  68    7.69  561.33  154.31  TOTAL RUN
  4K    0.01    2.29    0.02  add
 136    0.02    5.83    0.99  checkout
 544    0.18  160.96    9.79  commit
  68    0.15    1.29    0.26  copy
  68    0.02    1.24    0.33  delete
 340    0.05   43.37    5.76  info
 136    0.14   21.02    3.86  merge
  3K    0.01    1.08    0.01  mkdir
 184    0.01    0.09    0.01  propdel
 51K    0.01    0.73    0.01  proplist
 52K    0.01    1.10    0.01  propset
  4K    0.01    0.92    0.01  ps
 136    0.01    0.01    0.01  resolve
 136    0.02    0.99    0.24  resolved
 952    0.01    2.36    0.21  status
  68    0.07    4.82    1.41  switch
 952    0.02    7.02    0.83  update
--
Timings for trunk_at_1416283
   N    min     max     avg   operation  (unit is seconds)
   9    7.09  319.11  114.10  TOTAL RUN
 530    0.01    0.98    0.02  add
  18    0.02    3.75    0.63  checkout
  72    0.21   91.71    9.28  commit
   9    0.19    0.37    0.26  copy
   9    0.02    0.62    0.24  delete
  45    0.04    3.86    0.82  info
  18    0.07   12.54    2.88  merge
 516    0.01    0.35    0.01  mkdir
  21    0.01    0.01    0.01  propdel
  6K    0.01    0.26    0.01  proplist
  6K    0.01    0.61    0.01  propset
 591    0.01    0.12    0.01  ps
  18    0.01    0.01    0.01  resolve
  18    0.01    2.61    0.35  resolved
 126    0.01    3.05    0.17  status
   9    0.05    5.73    1.60  switch
 126    0.02    3.94    0.53  update
--
Compare trunk_at_1416283 to 1.7.0
       N        min              max              avg         operation
     68/9    0.92| -0.599     0.57|-242.224    0.74|-40.202   TOTAL RUN
   4K/530    0.87| -0.001     0.43| -1.312     0.70| -0.007   add
   136/18    0.87| -0.003     0.64| -2.085     0.64| -0.360   checkout
   544/72    1.17| +0.031     0.57|-69.256     0.95| -0.510   commit
     68/9    1.26| +0.040     0.28| -0.928     1.03| +0.008   copy
     68/9    0.91| -0.002     0.50| -0.626     0.73| -0.090   delete
   340/45    0.97| -0.001     0.09|-39.512     0.14| -4.941   info
   136/18    0.52| -0.067     0.60| -8.476     0.75| -0.975   merge
   3K/516    0.89| -0.001     0.32| -0.734     0.86| -0.002   mkdir
   184/21    0.83| -0.002     0.14| -0.074     0.72| -0.003   propdel
   51K/6K    0.83| -0.001     0.36| -0.471     0.77| -0.002   proplist
   52K/6K    0.82| -0.002     0.56| -0.484     0.81| -0.002   propset
   4K/591    0.82| -0.002     0.13| -0.805     0.70| -0.004   ps
   136/18    0.93| -0.001     0.70| -0.004     0.91| -0.001   resolve
   136/18    0.67| -0.005     2.62| +1.611     1.47| +0.111   resolved
  952/126    0.84| -0.002     1.29| +0.685     0.82| -0.036   status
     68/9    0.66| -0.024     1.19| +0.910     1.14| +0.196   switch
  952/126    0.93| -0.001     0.56| -3.076     0.64| -0.297   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_1416283' is faster.
 "2/3" means: '1.7.0' has 2 timings on record, the other has 3.)
Had started at Mon Dec  3 00:25:24 UTC 2012,
       done at Mon Dec  3 00:51:22 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-03 01:56:22 CET

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