Poor #requests/second performance

[Andreas Jung]

On 02.06.09 08:04, Poul-Henning Kamp wrote:
> In message <4A24A75E.1030608 at zopyx.com>, Andreas Jung writes:
>
>   
>>> Examining varnishstat to see what happens.
>>>   
>>>       
>> At what in particular. Looking at varnishstat does not give me a clue
>> about a possible problem.
>>     
> Dropped requests. A small number is OK, a continuos growth is not.
>
> ("overflowed" requests are OK).
>
> Threads not created should be zero.
>   
Output of varnishstat:

0+00:40:24                                                                                                                           
diaweb04
Hitrate ratio:       10       83       83
Hitrate avg:     1.0000   0.9912   0.9912

       50050         0.00        20.65 Client connections accepted
       50049         0.00        20.65 Client requests received
       50015         0.00        20.63 Cache hits
          35         0.00         0.01 Cache misses
          35         0.00         0.01 Backend connections success
          28         0.00         0.01 Backend connections reuses
          35         0.00         0.01 Backend connections recycles
           1          .            .   N struct srcaddr
           0          .            .   N active struct srcaddr
          93          .            .   N struct sess_mem
           0          .            .   N struct sess
          17          .            .   N struct object
          17          .            .   N struct objecthead
          28          .            .   N struct smf
           3          .            .   N small free smf
           3          .            .   N large free smf
           7          .            .   N struct vbe_conn
           6          .            .   N struct bereq
          12          .            .   N worker threads
          12         0.00         0.00 N worker threads created
          62         0.00         0.03 N overflowed work requests
           2          .            .   N backends
          30          .            .   N expired objects
          55          .            .   N LRU moved objects
       50048         0.00        20.65 Objects sent with write
       50050         0.00        20.65 Total Sessions
       50050         0.00        20.65 Total Requests
          35         0.00         0.01 Total fetch
    13213046         0.00      5450.93 Total header bytes
   423243959         0.00    174605.59 Total body bytes
       50050         0.00        20.65 Session herd


and the result of 'ab':

ajung at blackmoon:~> cat out.txt
Server Software:        Unknown
Server Hostname:        xxxxxxxx.de
Server Port:            80

Document Path:          /logo.jpg
Document Length:        8448 bytes

Concurrency Level:      10
Time taken for tests:   81.439 seconds
Complete requests:      50000
Failed requests:        0
Write errors:           0
Total transferred:      436644839 bytes
HTML transferred:       422400000 bytes
Requests per second:    613.95 [#/sec] (mean)
Time per request:       16.288 [ms] (mean)
Time per request:       1.629 [ms] (mean, across all concurrent requests)
Transfer rate:          5235.93 [Kbytes/sec] received

Connection Times (ms)
              min  mean[+/-sd] median   max
Connect:        0    2  35.5      1    2999
Processing:     2   14  31.3     12    3009
Waiting:        0   11  19.4     10    2895
Total:          3   16  47.3     14    3015

Percentage of the requests served within a certain time (ms)
  50%     14
  66%     16
  75%     18
  80%     19
  90%     23
  95%     26
  98%     31
  99%     36
 100%   3015 (longest request)

Andreas
-------------- next part --------------
A non-text attachment was scrubbed...
Name: lists.vcf
Type: text/x-vcard
Size: 316 bytes
Desc: not available
Url : http://projects.linpro.no/pipermail/varnish-misc/attachments/20090602/ba131925/attachment.vcf