[Varnish] #626: Varnish Crashses cache_acceptor.c

[Varnish]

#626: Varnish Crashses cache_acceptor.c
---------------------+------------------------------------------------------
 Reporter:  victori  |        Owner:       
     Type:  defect   |       Status:  new  
 Priority:  normal   |    Milestone:       
Component:  build    |      Version:  trunk
 Severity:  normal   |   Resolution:       
 Keywords:           |  
---------------------+------------------------------------------------------
Old description:

> Here is the trace
>
> # /opt/startvarnish.sh
> storage_file: filename: /sessions/varnish_cache.bin size 512 MB.
> Message from C-compiler:
> "./vcl.hndxcCNb.c", line 355: warning: initializer will be sign-extended:
> -1
> Using old SHMFILE
> child (16367) Started
> Child (16367) said Closed fds: 3 5 6 9 10 12 13
> Child (16367) said Child starts
> Child (16367) said managed to mmap 536870912 bytes of 536870912
> Child (16367) died signal=6
> Child (16367) Panic message: Assert error in VCA_Prep(), cache_acceptor.c
> line 149:
>   Condition((setsockopt(sp->fd, 0xffff, 0x0080, &linger, sizeof linger))
> == 0) not true.
> errno = 9 (Bad file number)
> thread = (cache-worker)
> Backtrace:
>   42e3c5: /opt/extra/sbin/varnishd'pan_ic+0x95 [0x42e3c5]
>   10: [0x10]
> sp = b95018 {
>   fd = 16, id = 16, xid = 0,
>   client = 78.155.225.100:50256,
>   step = STP_FIRST,
>   handling = deliver,
>   err_code = 200, err_reason = (null),
>   restarts = 0, esis = 0
>   ws = b95088 {
>     id = "sess",
>     {s,f,r,e} = {b95da8,+21,0,+65536},
>   },
>   http[req] = {
>     ws = b95088[sess]
>       "",
>       "/question/id/4786",
>       "HTTP/1.1",
>       "Accept: */*",
>       "Host: fabulously40.com",
>       "If-Modified-Since: Tue, 12 Jan 2010 07:15:17 GMT",
>       "User-Agent: msnbot/2.0b (+http://search.msn.com/msnbot.htm)",
>       "Connection: Keep-Alive",
>       "Cache-Control: no-cache",
>       "Pragma: no-cache",
>       "X-Forwarded-For: 65.55.106.163",
>       "Accept-Encoding: gzip",
>   },
>   worker = fffffd7fc7889d20 {
>     ws = fffffd7fc7889e68 {
>       id = "wrk",
>       {s,f,r,e} = {fffffd7fc7877cb0,fffffd7fc7877cb0,0,+65536},
>     },
>     },
> },
>

> Child cleanup complete
> child (19587) Started
> Child (19587) said Closed fds: 3 5 6 9 10 12 13
> Child (19587) said Child starts
> Child (19587) said managed to mmap 536870912 bytes of 536870912

New description:

 Here is the trace
 {{{
 # /opt/startvarnish.sh;svcadm enable nginx-master
 storage_file: filename: /sessions/varnish_cache.bin size 512 MB.
 Message from C-compiler:
 "./vcl.hndxcCNb.c", line 355: warning: initializer will be sign-extended:
 -1
 Using old SHMFILE
 child (16367) Started
 Child (16367) said Closed fds: 3 5 6 9 10 12 13
 Child (16367) said Child starts
 Child (16367) said managed to mmap 536870912 bytes of 536870912
 Child (16367) died signal=6
 Child (16367) Panic message: Assert error in VCA_Prep(), cache_acceptor.c
 line 149:
   Condition((setsockopt(sp->fd, 0xffff, 0x0080, &linger, sizeof linger))
 == 0) not true.
 errno = 9 (Bad file number)
 thread = (cache-worker)
 Backtrace:
   42e3c5: /opt/extra/sbin/varnishd'pan_ic+0x95 [0x42e3c5]
   10: [0x10]
 sp = b95018 {
   fd = 16, id = 16, xid = 0,
   client = 78.155.225.100:50256,
   step = STP_FIRST,
   handling = deliver,
   err_code = 200, err_reason = (null),
   restarts = 0, esis = 0
   ws = b95088 {
     id = "sess",
     {s,f,r,e} = {b95da8,+21,0,+65536},
   },
   http[req] = {
     ws = b95088[sess]
       "",
       "/question/id/4786",
       "HTTP/1.1",
       "Accept: */*",
       "Host: fabulously40.com",
       "If-Modified-Since: Tue, 12 Jan 2010 07:15:17 GMT",
       "User-Agent: msnbot/2.0b (+http://search.msn.com/msnbot.htm)",
       "Connection: Keep-Alive",
       "Cache-Control: no-cache",
       "Pragma: no-cache",
       "X-Forwarded-For: 65.55.106.163",
       "Accept-Encoding: gzip",
   },
   worker = fffffd7fc7889d20 {
     ws = fffffd7fc7889e68 {
       id = "wrk",
       {s,f,r,e} = {fffffd7fc7877cb0,fffffd7fc7877cb0,0,+65536},
     },
     },
 },


 Child cleanup complete
 child (19587) Started
 Child (19587) said Closed fds: 3 5 6 9 10 12 13
 Child (19587) said Child starts
 Child (19587) said managed to mmap 536870912 bytes of 536870912
 }}}

Comment (by phk):

 Edit trace in.

 See also #615, #588

-- 
Ticket URL: <http://www.varnish-cache.org/ticket/626#comment:2>
Varnish <http://varnish.projects.linpro.no/>
The Varnish HTTP Accelerator