Debug: On Waiting list?

[Erik]

Hi,
Im struggling with a couple of high response times when using
 varnish on our site. I have configured varnish so it will
 cache only static content (jpg,gif,png,css,js etc) even if a
 cookie is set. But all our jpeg's are getting a high response
 time when Im running some test against the site. 
One of the jpeg's are pic_mini.jpg, it has a response time of 357ms. I turned on logging and vcl_trace and found the line:

   14 Debug        c "Hash Match:
 /Portals/0/Picture/pic_mini.jpg#www3.mydomain.com#"
   14 Debug        c "on waiting list on obj 1767384108"

Does "on waiting list" has something to do with the high response time?

The rest fo the log for pic_mini.jpg is:

   14 ReqStart     c xx.xx.xx.187 41506 1767384112
   14 RxRequest    c GET
   14 RxURL        c /Portals/0/Picture/pic_mini.jpg
   14 RxProtocol   c HTTP/1.1
   14 RxHeader     c Host: www3.mydomain.com
   14 RxHeader     c User-Agent: Mozilla/5.0 (Windows; U; Windows
 NT 5.1; sv-SE; rv:1.8.1.8) Gecko/20071008 Firefox/2.0.0.8
   14 RxHeader     c Accept: */*
   14 RxHeader     c Accept-Language: sv,en-us;q=3D0.7,en;q=3D0.3
   14 RxHeader     c Accept-Encoding: gzip,deflate
   14 RxHeader     c Accept-Charset:=
 ISO-8859-1,utf-8;q=3D0.7,*;q=3D0.7
   14 RxHeader     c Keep-Alive: 300
   14 RxHeader     c Connection: Keep-Alive
   14 RxHeader     c Cookie: language=3Den-US;
 .ASPXANONYMOUS=3DnBeDLiReyAEkAAAAYTIwNmNiYjYtNmRmMS00MmQ4LThlZGItY=
mZlNThjYjhjZjky0
   14 VCL_call     c recv
   14 VCL_trace    c 1 84.14
   14 VCL_trace    c 2 87.13
   14 VCL_trace    c 3 87.51
   14 VCL_return   c lookup
   14 VCL_call     c hash
   14 VCL_trace    c 47 22.14
   14 VCL_trace    c 48 24.9
   14 VCL_trace    c 49 24.24
   14 VCL_return   c hash
   14 Debug        c "Hash Match:
 /Portals/0/Picture/pic_mini.jpg#www3.mydomain.com#"
   14 Debug        c "on waiting list on obj 1767384108"

In vcl_recv im fetching static content using:

sub vcl_recv {

        # *.jpg , *.jpeg , *.gif , *.png , *.ico
        if (req.url ~ ".(jpg|gif|png|jpeg|ico)$") {
                lookup;
        }

        # *.js , *.css , *.swf
        if (req.url ~ ".(js|css|swf)$") {
                lookup;
        }

        if (req.http.Cookie) {

                # *.jpg , *.jpeg , *.gif , *.png , *.ico
                if (req.url ~ ".(jpg|gif|png|jpeg|ico)$") {
                        lookup;
                }

                # *.js , *.css , *.swf
                if (req.url ~ ".(js|css|swf)$") {
                        lookup;
                }
        }

        pass;
} #RECV


and my vcl_fetch is using:
sub vcl_fetch {

        # *.jpg , *.jpeg , *.gif , *.png , *.ico
        if (req.url ~ ".(jpg|gif|png|jpeg|ico)$") {
                insert;
        }

        # *.js , *.css , *.swf
        if (req.url ~ ".(js|css|swf)$") {
                insert;
        }

        if (obj.http.Set-Cookie) {
                # *.jpg , *.jpeg , *.gif , *.png , *.ico
                if (req.url ~ ".(jpg|gif|png|jpeg|ico)$") {
                        insert;
                }

                # *.js , *.css , *.swf
                if (req.url ~ ".(js|css|swf)$") {
                        insert;
                }

        pass;
        }

        #
        pass;

} #FETCH


// Erik