[Varnish] #873: Assert error in vfp_esi_bytes_ug
Varnish
varnish-bugs at varnish-cache.org
Mon Mar 14 12:19:01 CET 2011
#873: Assert error in vfp_esi_bytes_ug
----------------------+-----------------------------------------------------
Reporter: kristian | Owner:
Type: defect | Status: new
Priority: normal | Milestone: Varnish 3.0 dev
Component: varnishd | Version: trunk
Severity: normal | Keywords:
----------------------+-----------------------------------------------------
As of 12:15 today. ESI and gzip is enabled. Does NOT fail with gzip
disabled.
{{{
Child (3142) said Child starts
Child (3142) died signal=6
Child (3142) Panic message: Assert error in vfp_esi_bytes_ug(),
cache_esi_fetch.c line 235:
Condition(w + vef->npend < sizeof vef->pending) not true.
thread = (cache-worker)
ident = Linux,2.6.18-194.el5,x86_64,-smalloc,-smalloc,-hcritbit,epoll
Backtrace:
0x429bc6: pan_ic+b6
0x4198db: vfp_esi_bytes_ug+16b
0x419dd8: vfp_esi_bytes+148
0x41f911: FetchBody+711
0x414942: cnt_fetch+6d2
0x415f56: CNT_Session+376
0x42c188: wrk_do_cnt_sess+b8
0x42b38a: wrk_thread_real+3ea
0x3aac40673d: _end+3aabd952e5
0x3aabcd3f6d: _end+3aab662b15
sp = 0x2aaaac900008 {
fd = 3, id = 3, xid = 1388183079,
client = 87.238.55.186 35259,
step = STP_FETCH,
handling = deliver,
err_code = 200, err_reason = (null),
restarts = 0, esi_level = 0
ws = 0x2aaaac900080 {
id = "sess",
{s,f,r,e} = {0x2aaaac900cf0,+112,(nil),+2621440},
},
http[req] = {
ws = 0x2aaaac900080[sess]
"GET",
"/",
"HTTP/1.1",
"Host: www.ba.no",
"X-Forwarded-For: 87.238.55.186",
},
worker = 0x549e6e00 {
ws = 0x549e6f90 {
id = "wrk",
{s,f,r,e} = {0x549d4db0,+4752,(nil),+65536},
},
http[bereq] = {
ws = 0x549e6f90[wrk]
"GET",
"/",
"HTTP/1.1",
"Host: www.ba.no",
"X-Forwarded-For: 87.238.55.186",
"X-Varnish: 1388183079",
},
http[beresp] = {
ws = 0x549e6f90[wrk]
"HTTP/1.1",
"200",
"OK",
"X-Trace-App: [seamstress ; fibba.api.kunder.linpro.no ; Mon Mar
14 11:26:34 CET 2011]",
"Surrogate-Control: content="ESI/1.0"",
"Cache-Control: max-age=86400,
channel="http://localhost:9006/atomizer/event/current", channel-maxage,
group="/seamstress-fibba", group="/relax-nominell", group="/pub41",
group="/redirect", group="/redirect41", group="/jawrcounter", group
="/relax-verksam", group="/sec71", group="/sec8755", group="/sec29757",
group="/art4715233", group="/art5427319", group="/art4715209",
group="/art5513415"",
"X-Trace-App: [relax ; nominell.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"X-Trace-App: [relax ; verksam.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"Content-Language: nb-NO-www.ba.no",
"Content-Type: text/html; charset=utf-8",
"Server: Jetty(6.1.24)",
"Content-Length: 67284",
"Date: Mon, 14 Mar 2011 11:04:38 GMT",
"X-Varnish: 1051344559 1051111584",
"Age: 2284",
"Via: 1.1 varnish",
"Connection: keep-alive",
"X-Src-Webcache: samtid varnish 3.0 fibba",
"Content-Encoding: gzip",
},
},
vcl = {
srcname = {
"input",
"Default",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
},
},
obj = 0x2aaaacd07300 {
xid = 1388183079,
ws = 0x2aaaacd07318 {
id = "obj",
{s,f,r,e} = {0x2aaaacd075a0,+1000,(nil),+1056},
},
http[obj] = {
ws = 0x2aaaacd07318[obj]
"HTTP/1.1",
"OK",
"X-Trace-App: [seamstress ; fibba.api.kunder.linpro.no ; Mon Mar
14 11:26:34 CET 2011]",
"Surrogate-Control: content="ESI/1.0"",
"Cache-Control: max-age=86400,
channel="http://localhost:9006/atomizer/event/current", channel-maxage,
group="/seamstress-fibba", group="/relax-nominell", group="/pub41",
group="/redirect", group="/redirect41", group="/jawrcounter", group
="/relax-verksam", group="/sec71", group="/sec8755", group="/sec29757",
group="/art4715233", group="/art5427319", group="/art4715209",
group="/art5513415"",
"X-Trace-App: [relax ; nominell.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"X-Trace-App: [relax ; verksam.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"Content-Language: nb-NO-www.ba.no",
"Content-Type: text/html; charset=utf-8",
"Server: Jetty(6.1.24)",
"Date: Mon, 14 Mar 2011 11:04:38 GMT",
"X-Varnish: 1051344559 1051111584",
"Via: 1.1 varnish",
"X-Src-Webcache: samtid varnish 3.0 fibba",
"Content-Encoding: gzip",
},
len = 31982,
store = {
31982 {
1f 8b 08 00 00 00 00 00 00 03 02 00 00 00 ff ff |................|
14 8c b1 0a c2 30 14 00 f7 7e c5 33 7b f3 94 76 |.....0...~.3{..v|
92 d8 a1 49 41 a1 6a 91 88 38 06 1a 6c 20 4d b4 |...IA.j..8..l M.|
7d 9a df 97 4c 07 07 77 62 a3 ae 52 3f 87 0e 26 |}...L..wb..R?..&|
[31918 more]
},
},
},
},
Child cleanup complete
child (3175) Started
Child (3175) said Child starts
Child (3175) died signal=6
Child (3175) Panic message: Assert error in vfp_esi_bytes_ug(),
cache_esi_fetch.c line 235:
Condition(w + vef->npend < sizeof vef->pending) not true.
thread = (cache-worker)
ident = Linux,2.6.18-194.el5,x86_64,-smalloc,-smalloc,-hcritbit,epoll
Backtrace:
0x429bc6: pan_ic+b6
0x4198db: vfp_esi_bytes_ug+16b
0x419dd8: vfp_esi_bytes+148
0x41f911: FetchBody+711
0x414942: cnt_fetch+6d2
0x415f56: CNT_Session+376
0x42c188: wrk_do_cnt_sess+b8
0x42b38a: wrk_thread_real+3ea
0x3aac40673d: _end+3aabd952e5
0x3aabcd3f6d: _end+3aab662b15
sp = 0x2aaaad200008 {
fd = 3, id = 3, xid = 2034524242,
client = 87.238.55.186 35292,
step = STP_FETCH,
handling = deliver,
err_code = 200, err_reason = (null),
restarts = 0, esi_level = 0
ws = 0x2aaaad200080 {
id = "sess",
{s,f,r,e} = {0x2aaaad200cf0,+112,(nil),+2621440},
},
http[req] = {
ws = 0x2aaaad200080[sess]
"GET",
"/",
"HTTP/1.1",
"Host: www.ba.no",
"X-Forwarded-For: 87.238.55.186",
},
worker = 0x51885e00 {
ws = 0x51885f90 {
id = "wrk",
{s,f,r,e} = {0x51873db0,+4752,(nil),+65536},
},
http[bereq] = {
ws = 0x51885f90[wrk]
"GET",
"/",
"HTTP/1.1",
"Host: www.ba.no",
"X-Forwarded-For: 87.238.55.186",
"X-Varnish: 2034524242",
},
http[beresp] = {
ws = 0x51885f90[wrk]
"HTTP/1.1",
"200",
"OK",
"X-Trace-App: [seamstress ; fibba.api.kunder.linpro.no ; Mon Mar
14 11:26:34 CET 2011]",
"Surrogate-Control: content="ESI/1.0"",
"Cache-Control: max-age=86400,
channel="http://localhost:9006/atomizer/event/current", channel-maxage,
group="/seamstress-fibba", group="/relax-nominell", group="/pub41",
group="/redirect", group="/redirect41", group="/jawrcounter", group
="/relax-verksam", group="/sec71", group="/sec8755", group="/sec29757",
group="/art4715233", group="/art5427319", group="/art4715209",
group="/art5513415"",
"X-Trace-App: [relax ; nominell.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"X-Trace-App: [relax ; verksam.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"Content-Language: nb-NO-www.ba.no",
"Content-Type: text/html; charset=utf-8",
"Server: Jetty(6.1.24)",
"Content-Length: 67284",
"Date: Mon, 14 Mar 2011 11:04:40 GMT",
"X-Varnish: 1051344858 1051111584",
"Age: 2286",
"Via: 1.1 varnish",
"Connection: keep-alive",
"X-Src-Webcache: samtid varnish 3.0 fibba",
"Content-Encoding: gzip",
},
},
vcl = {
srcname = {
"input",
"Default",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
},
},
obj = 0x2aaaace0c300 {
xid = 2034524242,
ws = 0x2aaaace0c318 {
id = "obj",
{s,f,r,e} = {0x2aaaace0c5a0,+1000,(nil),+1056},
},
http[obj] = {
ws = 0x2aaaace0c318[obj]
"HTTP/1.1",
"OK",
"X-Trace-App: [seamstress ; fibba.api.kunder.linpro.no ; Mon Mar
14 11:26:34 CET 2011]",
"Surrogate-Control: content="ESI/1.0"",
"Cache-Control: max-age=86400,
channel="http://localhost:9006/atomizer/event/current", channel-maxage,
group="/seamstress-fibba", group="/relax-nominell", group="/pub41",
group="/redirect", group="/redirect41", group="/jawrcounter", group
="/relax-verksam", group="/sec71", group="/sec8755", group="/sec29757",
group="/art4715233", group="/art5427319", group="/art4715209",
group="/art5513415"",
"X-Trace-App: [relax ; nominell.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"X-Trace-App: [relax ; verksam.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"Content-Language: nb-NO-www.ba.no",
"Content-Type: text/html; charset=utf-8",
"Server: Jetty(6.1.24)",
"Date: Mon, 14 Mar 2011 11:04:40 GMT",
"X-Varnish: 1051344858 1051111584",
"Via: 1.1 varnish",
"X-Src-Webcache: samtid varnish 3.0 fibba",
"Content-Encoding: gzip",
},
len = 31982,
store = {
31982 {
1f 8b 08 00 00 00 00 00 00 03 02 00 00 00 ff ff |................|
14 8c b1 0a c2 30 14 00 f7 7e c5 33 7b f3 94 76 |.....0...~.3{..v|
92 d8 a1 49 41 a1 6a 91 88 38 06 1a 6c 20 4d b4 |...IA.j..8..l M.|
7d 9a df 97 4c 07 07 77 62 a3 ae 52 3f 87 0e 26 |}...L..wb..R?..&|
[31918 more]
},
},
},
},
Child cleanup complete
child (3225) Started
Child (3225) said Child starts
Child (3225) died signal=6
Child (3225) Panic message: Assert error in vfp_esi_bytes_ug(),
cache_esi_fetch.c line 235:
Condition(w + vef->npend < sizeof vef->pending) not true.
thread = (cache-worker)
ident = Linux,2.6.18-194.el5,x86_64,-smalloc,-smalloc,-hcritbit,epoll
Backtrace:
0x429bc6: pan_ic+b6
0x4198db: vfp_esi_bytes_ug+16b
0x419dd8: vfp_esi_bytes+148
0x41f911: FetchBody+711
0x414942: cnt_fetch+6d2
0x415f56: CNT_Session+376
0x42c188: wrk_do_cnt_sess+b8
0x42b38a: wrk_thread_real+3ea
0x3aac40673d: _end+3aabd952e5
0x3aabcd3f6d: _end+3aab662b15
sp = 0x2aaaac900008 {
fd = 3, id = 3, xid = 1339149085,
client = 87.238.55.186 35326,
step = STP_FETCH,
handling = deliver,
err_code = 200, err_reason = (null),
restarts = 0, esi_level = 0
ws = 0x2aaaac900080 {
id = "sess",
{s,f,r,e} = {0x2aaaac900cf0,+112,(nil),+2621440},
},
http[req] = {
ws = 0x2aaaac900080[sess]
"GET",
"/",
"HTTP/1.1",
"Host: www.ba.no",
"X-Forwarded-For: 87.238.55.186",
},
worker = 0x54580e00 {
ws = 0x54580f90 {
id = "wrk",
{s,f,r,e} = {0x5456edb0,+4744,(nil),+65536},
},
http[bereq] = {
ws = 0x54580f90[wrk]
"GET",
"/",
"HTTP/1.1",
"Host: www.ba.no",
"X-Forwarded-For: 87.238.55.186",
"X-Varnish: 1339149085",
},
http[beresp] = {
ws = 0x54580f90[wrk]
"HTTP/1.1",
"200",
"OK",
"X-Trace-App: [seamstress ; akut.api.kunder.linpro.no ; Mon Mar 14
11:26:38 CET 2011]",
"Surrogate-Control: content="ESI/1.0"",
"Cache-Control: max-age=86400,
channel="http://localhost:9006/atomizer/event/current", channel-maxage,
group="/seamstress-akut", group="/relax-nominell", group="/pub41",
group="/redirect", group="/redirect41", group="/jawrcounter", group
="/relax-verksam", group="/sec71", group="/sec8755", group="/sec29757",
group="/art4715233", group="/art5427319", group="/art4715209",
group="/art5513415"",
"X-Trace-App: [relax ; nominell.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"X-Trace-App: [relax ; verksam.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"Content-Language: nb-NO-www.ba.no",
"Content-Type: text/html; charset=utf-8",
"Server: Jetty(6.1.24)",
"Content-Length: 67284",
"Date: Mon, 14 Mar 2011 11:04:42 GMT",
"X-Varnish: 1155699237 1155465531",
"Age: 2283",
"Via: 1.1 varnish",
"Connection: keep-alive",
"X-Src-Webcache: samtid varnish 3.0 akut",
"Content-Encoding: gzip",
},
},
vcl = {
srcname = {
"input",
"Default",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
"/etc/varnish/include-v3art-ng.vcl",
},
},
obj = 0x2aaaacd07300 {
xid = 1339149085,
ws = 0x2aaaacd07318 {
id = "obj",
{s,f,r,e} = {0x2aaaacd075a0,+992,(nil),+1048},
},
http[obj] = {
ws = 0x2aaaacd07318[obj]
"HTTP/1.1",
"OK",
"X-Trace-App: [seamstress ; akut.api.kunder.linpro.no ; Mon Mar 14
11:26:38 CET 2011]",
"Surrogate-Control: content="ESI/1.0"",
"Cache-Control: max-age=86400,
channel="http://localhost:9006/atomizer/event/current", channel-maxage,
group="/seamstress-akut", group="/relax-nominell", group="/pub41",
group="/redirect", group="/redirect41", group="/jawrcounter", group
="/relax-verksam", group="/sec71", group="/sec8755", group="/sec29757",
group="/art4715233", group="/art5427319", group="/art4715209",
group="/art5513415"",
"X-Trace-App: [relax ; nominell.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"X-Trace-App: [relax ; verksam.api.kunder.linpro.no ; Mon Mar 14
11:26:34 CET 2011]",
"Content-Language: nb-NO-www.ba.no",
"Content-Type: text/html; charset=utf-8",
"Server: Jetty(6.1.24)",
"Date: Mon, 14 Mar 2011 11:04:42 GMT",
"X-Varnish: 1155699237 1155465531",
"Via: 1.1 varnish",
"X-Src-Webcache: samtid varnish 3.0 akut",
"Content-Encoding: gzip",
},
len = 31982,
store = {
31982 {
1f 8b 08 00 00 00 00 00 00 03 02 00 00 00 ff ff |................|
14 8c b1 0a c2 30 14 00 f7 7e c5 33 7b f3 94 76 |.....0...~.3{..v|
92 d8 a1 49 41 a1 6a 91 88 38 06 1a 6c 20 4d b4 |...IA.j..8..l M.|
7d 9a df 97 4c 07 07 77 62 a3 ae 52 3f 87 0e 26 |}...L..wb..R?..&|
[31918 more]
},
},
},
},
Child cleanup complete
child (3258) Started
Child (3258) said Child starts
Manager got SIGINT
Stopping Child
}}}
--
Ticket URL: <http://www.varnish-cache.org/trac/ticket/873>
Varnish <http://varnish-cache.org/>
The Varnish HTTP Accelerator
More information about the varnish-bugs
mailing list