[Varnish] #1467: Assert error in HSH_RefBusy(); Condition((bo)->magic == 0x23b95567) not true

[Varnish]

#1467: Assert error in HSH_RefBusy(); Condition((bo)->magic == 0x23b95567) not
true
----------------------+--------------------
 Reporter:  lkarsten  |       Owner:
     Type:  defect    |      Status:  new
 Priority:  normal    |   Milestone:
Component:  varnishd  |     Version:  trunk
 Severity:  normal    |  Resolution:
 Keywords:            |
----------------------+--------------------

Comment (by lkarsten):

 I've had three instances of this over the weekend, with trivial traffic
 levels. The two
 other panics:

 {{{
 Mar 30 13:00:38 sierra kernel: [61393.719657] varnishd[2358]: segfault at
 10 ip 00000000004399cc sp 00007f56696bbff0 error 4 in
 varnishd[400000+9e000]
 Mar 30 13:00:38 sierra varnishd[2125]: Child (2143) died signal=11 (core
 dumped)
 Mar 30 13:00:38 sierra varnishd[2125]: Child (2143) Panic message: Assert
 error in HSH_RefBusy(), cache/cache_hash.c line 737:#012
 Condition((bo)->magic == 0x23b95567) not true.#012thread = (cache-
 worker)#012ident =
 Linux,3.11.0-18-generic,x86_64,-smalloc,-smalloc,-hcritbit,epoll#012Backtrace:#012
 0x439f23: pan_backtrace+0x19#012  0x43a22d: pan_ic+0x1e9#012  0x42c37b:
 HSH_RefBusy+0x199#012  0x4382ea: ObjIterBegin+0xd8#012  0x44120e:
 v1d_WriteDirObj+0x99#012  0x441b54: V1D_Deliver+0x800#012  0x43d13b:
 cnt_deliver+0x7ba#012  0x4404a1: CNT_Request+0x529#012  0x4330c0:
 HTTP1_Session+0x426#012  0x443352: ses_req_pool_task+0x166#012req =
 0x7f56480409a0 {#012  sp = 0x7f563c000a90, vxid = 1073906261,  step =
 R_STP_DELIVER,#012  req_body = R_BODY_NONE,#012  err_code = 200,
 err_reason = (null),#012  restarts = 0, esi_level = 0#012  sp =
 0x7f563c000a90 {#012    fd = 14, vxid = 164436,#012    client =
 37.253.23.63 60534,#012    step = S_STP_WORKING,#012  },#012  worker =
 0x7f56696bcc30 {#012    ws = 0x7f56696bce30 {#012      id = "wrk",#012
 {s,f,r,e} = {0x7f56696bc400,+80,+2048,+2048},#012    },#012  VCL::method =
 0x0,#012  VCL::return = deliver,#012  },#012  ws = 0x7f5648040b28 {#012
 id = "req",#012    {s,f,r,e} = {0x7f5648042980,+320,(nil),+57376},#012
 },#012  http[req] = {#012    ws = 0x7f5648040b28[req]#012      "GET",#012
 "/djfriendly/djfriendly-nrkp3-2014-03-15__2200.mp3",#012
 "HTTP/1.1",#012      "Host: hyse.org",#012      "Connection: Keep-
 Alive",#012      "User-Agent: Dalvik/1.6.0 (Linux; U; Android 4.4.2;
 SM-N9005 Build/KOT49H)",#012      "X-Forwarded-For: 37.253.23.63",#012
 },#012  http[resp] = {#012    ws = 0x7f5648040b28[req]#012
 "HTTP/1.1",#012      "200",#012      "OK",#012      "Server: nginx/1.4.1
 (Ubuntu)",#012      "Content-Type: audio/mpeg",#012      "Last-Modified:
 Sat, 15 Mar 2014 23:00:05 GMT",#012      "ETag: "5324db75-a4e67e5"",#012
 "Date: Sun, 30 Mar 2014 11:00:37 GMT",#012      "X-Varnish: 164437",#012
 "Age: 0",#012      "Via: 1.1 varnish (v4)",#012      "Trans
 }}}
 {{{
 Mar 31 03:25:27 sierra kernel: [113283.511087] varnishd[12023]: segfault
 at 10 ip 00000000004399cc sp 00007f5669727ff0 error 4 in
 varnishd[400000+9e000]
 Mar 31 03:25:28 sierra varnishd[2125]: Child (11817) not responding to
 CLI, killing it.
 Mar 31 03:25:29 sierra varnishd[2125]: Child (11817) died signal=11 (core
 dumped)
 Mar 31 03:25:29 sierra varnishd[2125]: Child (11817) Panic message: Assert
 error in HSH_RefBusy(), cache/cache_hash.c line 737:#012
 Condition((bo)->magic == 0x23b95567) not true.#012thread = (cache-
 worker)#012ident =
 Linux,3.11.0-18-generic,x86_64,-smalloc,-smalloc,-hcritbit,epoll#012Backtrace:#012
 0x439f23: pan_backtrace+0x19#012  0x43a22d: pan_ic+0x1e9#012  0x42c37b:
 HSH_RefBusy+0x199#012  0x4382ea: ObjIterBegin+0xd8#012  0x44120e:
 v1d_WriteDirObj+0x99#012  0x441b54: V1D_Deliver+0x800#012  0x43d13b:
 cnt_deliver+0x7ba#012  0x4404a1: CNT_Request+0x529#012  0x4330c0:
 HTTP1_Session+0x426#012  0x443352: ses_req_pool_task+0x166#012req =
 0x7f56480008e0 {#012  sp = 0x7f564c001b70, vxid = 1073939965,  step =
 R_STP_DELIVER,#012  req_body = R_BODY_NONE,#012  err_code = 404,
 err_reason = (null),#012  restarts = 0, esi_level = 0#012  sp =
 0x7f564c001b70 {#012    fd = 15, vxid = 198140,#012    client =
 66.249.78.150 64324,#012    step = S_STP_WORKING,#012  },#012  worker =
 0x7f5669728c30 {#012    ws = 0x7f5669728e30 {#012      id = "wrk",#012
 {s,f,r,e} = {0x7f5669728400,+80,+2048,+2048},#012    },#012  VCL::method =
 0x0,#012  VCL::return = deliver,#012  },#012  ws = 0x7f5648000a68 {#012
 id = "req",#012    {s,f,r,e} = {0x7f56480028c0,+400,(nil),+57376},#012
 },#012  http[req] = {#012    ws = 0x7f5648000a68[req]#012      "GET",#012
 "/robots.txt",#012      "HTTP/1.1",#012      "Host: hyse.org",#012
 "Connection: Keep-alive",#012      "Accept: text/plain",#012      "Accept:
 text/html",#012      "From: googlebot(at)googlebot.com",#012      "User-
 Agent: Mozilla/5.0 (compatible; Googlebot/2.1;
 +http://www.google.com/bot.html)",#012      "X-Forwarded-For:
 66.249.78.150",#012      "Accept-Encoding: gzip",#012  },#012  http[resp]
 = {#012    ws = 0x7f5648000a68[req]#012      "HTTP/1.1",#012
 "404",#012      "Not Found",#012      "Server: nginx/1.4.1 (Ubuntu)",#012
 "Content-Type: text/html",#012      "Content-Encoding: gzip",#012
 "Date: Mon, 31 Mar 2014 01:25:27 GMT",#012      "X-Varnish: 198141",#012
 }}}

-- 
Ticket URL: <https://www.varnish-cache.org/trac/ticket/1467#comment:1>
Varnish <https://varnish-cache.org/>
The Varnish HTTP Accelerator