Consistent panic in http1_cleanup

[Beck, Stuart (ADE-MNT)]

Hi,

I am evaluating the varnish cache in our environment in order to alleviate load on backend servers.

I'm running with the following parameters on a solaris11.1 server
sudo /opt/varnish-4.0.2/sbin/varnishd -a :6081 -u varnishuser -g varnishgroup -n /data/varnish/cache -f /data/varnish/conf.d/default.vcl -s malloc,256m -p 'cc_command=exec cp /opt/varnish-4.0.2/config/varnish-config.so %o'
(the copy option is to avoid having to install a compiler on the server the cache is running on as the application is built elsewhere)

I'm finding that the child process regularly restarts with the following panic message being logged into the messages file, this can be after a few minutes or a few hours.
I'm wondering if this is likely to be a bug or possibly something to do with my environment
It does seem to be similar to https://www.varnish-cache.org/trac/ticket/1552 but that was in a separate function.

Oct 31 01:45:56 t3 /data/varnish/cache[29402]: [ID 232431 local0.error] Child (29404) Panic message:
Oct 31 12:45:56 t3 Assert error in http1_cleanup(), cache/cache_http1_fsm.c line 207:
Oct 31 12:45:56 t3   Condition((req->vsl->wid) != 0) not true.
Oct 31 12:45:56 t3 errno = 131 (Connection reset by peer)
Oct 31 12:45:56 t3 thread = (cache-worker)
Oct 31 12:45:56 t3 ident = -smalloc,-smalloc,-hcritbit,ports
Oct 31 12:45:56 t3 Backtrace:
Oct 31 12:45:56 t3   80882f2: /opt/varnish-4.0.2/sbin/varnishd'pan_ic+0xd2 [0x80882f2]
Oct 31 12:45:56 t3   8080c43: /opt/varnish-4.0.2/sbin/varnishd'http1_cleanup+0x3b3 [0x8080c43]
Oct 31 12:45:56 t3   80813a7: /opt/varnish-4.0.2/sbin/varnishd'HTTP1_Session+0x467 [0x80813a7]
Oct 31 12:45:56 t3   8091d24: /opt/varnish-4.0.2/sbin/varnishd'ses_req_pool_task+0x64 [0x8091d24]
Oct 31 12:45:56 t3   808b79b: /opt/varnish-4.0.2/sbin/varnishd'Pool_Work_Thread+0x4bb [0x808b79b]
Oct 31 12:45:56 t3   80a1fe5: /opt/varnish-4.0.2/sbin/varnishd'wrk_thread_real+0xc5 [0x80a1fe5]
Oct 31 12:45:56 t3   fe43444c: /lib/libc.so.1'_thrp_setup+0x9d [0xfe43444c]
Oct 31 12:45:56 t3   fe4346f0: /lib/libc.so.1'_lwp_start+0x0 [0xfe4346f0]
Oct 31 12:45:56 t3 req = 8219030 {
Oct 31 12:45:56 t3   sp = 8212cd0, vxid = 0,  step = R_STP_RESTART,
Oct 31 12:45:56 t3   req_body = R_BODY_INIT,
Oct 31 12:45:56 t3   restarts = 0, esi_level = 0
Oct 31 12:45:56 t3

My VCL file is just the example basic pass-through to the local apache server as follows (comments removed):



vcl 4.0;

backend default {
    .host = "127.0.0.1";
    .port = "80";
}

sub vcl_recv {
}

sub vcl_backend_response {
}

sub vcl_deliver {
}


--
[cid:1414729218.31302.161.camel at ademnt-dlx0001.ap.corp.ipgnetwork.com]  Stuart Beck
Systems Administrator



P       +61 8 8115 6649
E       stuart.beck at mnetmobile.com<mailto:stuart.beck at mnetmobile.com>
A       Level 1, 16 Anster Street,
Adelaide SA 5000
[cid:1414729218.31302.162.camel at ademnt-dlx0001.ap.corp.ipgnetwork.com]

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-misc/attachments/20141031/9e6c6485/attachment-0001.html>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: AwardFooter_crisp01.png
Type: image/png
Size: 25524 bytes
Desc: AwardFooter_crisp01.png
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-misc/attachments/20141031/9e6c6485/attachment-0002.png>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image001.png
Type: image/png
Size: 3554 bytes
Desc: image001.png
URL: <https://www.varnish-cache.org/lists/pipermail/varnish-misc/attachments/20141031/9e6c6485/attachment-0003.png>