[Varnish] #1006: varnishncsa stops with no apparent reason
Varnish
varnish-bugs at varnish-cache.org
Thu Sep 8 10:10:15 CEST 2011
#1006: varnishncsa stops with no apparent reason
-----------------------+----------------------------------------------------
Reporter: tmagnien | Type: defect
Status: closed | Priority: normal
Milestone: | Component: varnishncsa
Version: 3.0.1 | Severity: normal
Resolution: fixed | Keywords: varnishncsa stops
-----------------------+----------------------------------------------------
Comment(by tmagnien):
Just to keep track of what happened, here are the varnishlog output and
tcpdump making this bug happen. This was due to a broken client sending
linefeed in the cookie header:
{{{
100 ReqStart c 95.136.165.85 49759 1046477818
100 RxRequest c GET
100 RxURL c /reboot/images/mn-trame.png
100 RxProtocol c HTTP/1.1
100 RxHeader c Host: cache.20minutes.fr
100 RxHeader c User-Agent: Mozilla/5.0 (Windows NT 6.1; rv:5.0)
Gecko/20100101 Firefox/5.0
100 RxHeader c Accept: image/png,image/*;q=0.8,*/*;q=0.5
100 RxHeader c Accept-Language: fr,fr-fr;q=0.8,en-
us;q=0.5,en;q=0.3
100 RxHeader c Accept-Encoding: gzip, deflate
100 RxHeader c Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7
100 RxHeader c Connection: keep-alive
100 RxHeader c Referer: http://cache.20minutes.fr/minified
/common-prepend-1311002095.css
100 RxHeader c Cookie:
__utma=141384369.1022668416.1305831876.1315410001.1315428713.17;
__utmz=141384369.1315428713.17.17.utmcsr=news.google.fr|utmccn=(referral)|utmcmd=referral|utmcct=/nwshp;
TestIfCookieP=ok; pid=9015983930972768243;
pbw=%24b%3D12999%3B%24o%3D11061%3B
100 RxHeader c
�zAsuivreet%C3%A0commenterici%C3%A0partirde17h&cliccz=N&dest=http%3A%2F%2Fwww.20minutes.fr%2Farticle%2F781966
%2Fus-open-simon-isner-suivre-live-comme-a-la-maison-retarde-
pluie&posx=0.5&posy=0.5&time=77&pmed=Simon-Isner&s2med=3
100 RxHeader c If-Modified-Since: Tue, 16 Aug 2011 09:33:22 GMT
100 RxHeader c If-None-Match: "1242f3-67-4aa9c12179c80"
100 VCL_call c recv
100 VCL_Log c X-Backend: bush_pilote_cdn_16
100 VCL_return c lookup
100 VCL_call c hash
100 Hash c /reboot/images/mn-trame.png
100 Hash c cache.20minutes.pullorigin.pilote-cdn.sfr-sh.fr
100 VCL_return c hash
100 Hit c 970966282
100 VCL_call c hit deliver
100 VCL_call c deliver deliver
100 TxProtocol c HTTP/1.1
100 TxStatus c 304
100 TxResponse c Not Modified
100 TxHeader c Server: Apache
100 TxHeader c Last-Modified: Tue, 16 Aug 2011 09:33:22 GMT
100 TxHeader c ETag: "1242f3-67-4aa9c12179c80"
100 TxHeader c Content-Type: image/png
100 TxHeader c X-Pad: avoid browser bug
100 TxHeader c Accept-Ranges: bytes
100 TxHeader c Date: Wed, 07 Sep 2011 20:53:29 GMT
100 TxHeader c X-Varnish: 1046477818 970966282
100 TxHeader c Age: 211277
100 TxHeader c Connection: keep-alive
100 TxHeader c Via: 1.1 proxy-1.pilote-cdn.sfr-sh.fr, 1.1 cbv4
-ncdn-cache05
100 Length c 0
100 ReqEnd c 1046477818 1315428809.932852983
1315428809.932941437 2.745071650 0.000051498 0.000036955
}}}
{{{
22:53:29.932802 IP (tos 0x0, ttl 116, id 8418, offset 0, flags [DF], proto
TCP (6), length 1282) 95.136.165.85.49759 > 93.20.64.247.80: P, cksum
0xf573 (correct), 1239:2481(1242) ack 368 win 17057
0x0000: 4500 0502 20e2 4000 7406 3e2b 5f88 a555 E..... at .t.>+_..U
0x0010: 5d14 40f7 c25f 0050 133c 4519 56cb 0a8a ]. at .._.P.<E.V...
0x0020: 5018 42a1 f573 0000 4745 5420 2f72 6562 P.B..s..GET./reb
0x0030: 6f6f 742f 696d 6167 6573 2f6d 6e2d 7472 oot/images/mn-tr
0x0040: 616d 652e 706e 6720 4854 5450 2f31 2e31 ame.png.HTTP/1.1
0x0050: 0d0a 486f 7374 3a20 6361 6368 652e 3230 ..Host:.cache.20
0x0060: 6d69 6e75 7465 732e 6672 0d0a 5573 6572 minutes.fr..User
0x0070: 2d41 6765 6e74 3a20 4d6f 7a69 6c6c 612f -Agent:.Mozilla/
0x0080: 352e 3020 2857 696e 646f 7773 204e 5420 5.0.(Windows.NT.
0x0090: 362e 313b 2072 763a 352e 3029 2047 6563 6.1;.rv:5.0).Gec
0x00a0: 6b6f 2f32 3031 3030 3130 3120 4669 7265 ko/20100101.Fire
0x00b0: 666f 782f 352e 300d 0a41 6363 6570 743a fox/5.0..Accept:
0x00c0: 2069 6d61 6765 2f70 6e67 2c69 6d61 6765 .image/png,image
0x00d0: 2f2a 3b71 3d30 2e38 2c2a 2f2a 3b71 3d30 /*;q=0.8,*/*;q=0
0x00e0: 2e35 0d0a 4163 6365 7074 2d4c 616e 6775 .5..Accept-Langu
0x00f0: 6167 653a 2066 722c 6672 2d66 723b 713d age:.fr,fr-fr;q=
0x0100: 302e 382c 656e 2d75 733b 713d 302e 352c 0.8,en-us;q=0.5,
0x0110: 656e 3b71 3d30 2e33 0d0a 4163 6365 7074 en;q=0.3..Accept
0x0120: 2d45 6e63 6f64 696e 673a 2067 7a69 702c -Encoding:.gzip,
0x0130: 2064 6566 6c61 7465 0d0a 4163 6365 7074 .deflate..Accept
0x0140: 2d43 6861 7273 6574 3a20 4953 4f2d 3838 -Charset:.ISO-88
0x0150: 3539 2d31 2c75 7466 2d38 3b71 3d30 2e37 59-1,utf-8;q=0.7
0x0160: 2c2a 3b71 3d30 2e37 0d0a 436f 6e6e 6563 ,*;q=0.7..Connec
0x0170: 7469 6f6e 3a20 6b65 6570 2d61 6c69 7665 tion:.keep-alive
0x0180: 0d0a 5265 6665 7265 723a 2068 7474 703a ..Referer:.http:
0x0190: 2f2f 6361 6368 652e 3230 6d69 6e75 7465 //cache.20minute
0x01a0: 732e 6672 2f6d 696e 6966 6965 642f 636f s.fr/minified/co
0x01b0: 6d6d 6f6e 2d70 7265 7065 6e64 2d31 3331 mmon-prepend-131
0x01c0: 3130 3032 3039 352e 6373 730d 0a43 6f6f 1002095.css..Coo
0x01d0: 6b69 653a 205f 5f75 746d 613d 3134 3133 kie:.__utma=1413
0x01e0: 3834 3336 392e 3130 3232 3636 3834 3136 84369.1022668416
0x01f0: 2e31 3330 3538 3331 3837 362e 3133 3135 .1305831876.1315
0x0200: 3431 3030 3031 2e31 3331 3534 3238 3731 410001.131542871
0x0210: 332e 3137 3b20 5f5f 7574 6d7a 3d31 3431 3.17;.__utmz=141
0x0220: 3338 3433 3639 2e31 3331 3534 3238 3731 384369.131542871
0x0230: 332e 3137 2e31 372e 7574 6d63 7372 3d6e 3.17.17.utmcsr=n
0x0240: 6577 732e 676f 6f67 6c65 2e66 727c 7574 ews.google.fr|ut
0x0250: 6d63 636e 3d28 7265 6665 7272 616c 297c mccn=(referral)|
0x0260: 7574 6d63 6d64 3d72 6566 6572 7261 6c7c utmcmd=referral|
0x0270: 7574 6d63 6374 3d2f 6e77 7368 703b 2054 utmcct=/nwshp;.T
0x0280: 6573 7449 6643 6f6f 6b69 6550 3d6f 6b3b estIfCookieP=ok;
0x0290: 2070 6964 3d39 3031 3539 3833 3933 3039 .pid=90159839309
0x02a0: 3732 3736 3832 3433 3b20 7062 773d 2532 72768243;.pbw=%2
0x02b0: 3462 2533 4431 3239 3939 2533 4225 3234 4b%3D12999%3B%24
0x02c0: 6f25 3344 3131 3036 3125 3342 2532 3473 o%3D11061%3B%24s
0x02d0: 6825 3344 3736 3825 3342 2532 3473 7725 h%3D768%3B%24sw%
0x02e0: 3344 3132 3830 3b20 7064 6f6d 6964 3d31 3D1280;.pdomid=1
0x02f0: 373b 2078 7476 726e 3d24 3239 3034 3238 7;.xtvrn=$290428
0x0300: 243b 2070 6277 6d61 6a36 3d79 3b20 5f5f $;.pbwmaj6=y;.__
0x0310: 7574 6d62 3d31 3431 3338 3433 3639 2e32 utmb=141384369.2
0x0320: 2e31 302e 3133 3135 3432 3837 3133 3b20 .10.1315428713;.
0x0330: 5f5f 7574 6d63 3d31 3431 3338 3433 3639 __utmc=141384369
0x0340: 3b20 7673 3d33 3331 333d 3435 3637 3631 ;.vs=3313=456761
0x0350: 313b 2078 7476 616c 435a 3d26 6964 7063 1;.xtvalCZ=&idpc
0x0360: 7a3d 3232 3532 3034 3336 3837 3035 3026 z=2252043687050&
0x0370: 7874 637a 763d 3331 3031 3126 6964 6d6f xtczv=31011&idmo
0x0380: 643d 3026 6375 7272 656e 743d 5369 6d6f d=0¤t=Simo
0x0390: 6e2d 4973 6e65 7226 6265 666f 7265 3d41 n-Isner&before=A
0x03a0: 7265 6dbf 8db6 fddd e73f f8a7 d2de 3ef4 rem......?....>.
0x03b0: d1c9 9356 095f dcb9 7bcb 223e 7492 940a ...V._..{.">t...
0x03c0: e87a 4173 7569 7672 6565 7425 4333 2541 .zAsuivreet%C3%A
0x03d0: 3063 6f6d 6d65 6e74 6572 6963 6925 4333 0commenterici%C3
0x03e0: 2541 3070 6172 7469 7264 6531 3768 2663 %A0partirde17h&c
0x03f0: 6c69 6363 7a3d 4e26 6465 7374 3d68 7474 liccz=N&dest=htt
0x0400: 7025 3341 2532 4625 3246 7777 772e 3230 p%3A%2F%2Fwww.20
0x0410: 6d69 6e75 7465 732e 6672 2532 4661 7274 minutes.fr%2Fart
0x0420: 6963 6c65 2532 4637 3831 3936 3625 3246 icle%2F781966%2F
0x0430: 7573 2d6f 7065 6e2d 7369 6d6f 6e2d 6973 us-open-simon-is
0x0440: 6e65 722d 7375 6976 7265 2d6c 6976 652d ner-suivre-live-
0x0450: 636f 6d6d 652d 612d 6c61 2d6d 6169 736f comme-a-la-maiso
0x0460: 6e2d 7265 7461 7264 652d 706c 7569 6526 n-retarde-pluie&
0x0470: 706f 7378 3d30 2e35 2670 6f73 793d 302e posx=0.5&posy=0.
0x0480: 3526 7469 6d65 3d37 3726 706d 6564 3d53 5&time=77&pmed=S
0x0490: 696d 6f6e 2d49 736e 6572 2673 326d 6564 imon-Isner&s2med
0x04a0: 3d33 0d0a 4966 2d4d 6f64 6966 6965 642d =3..If-Modified-
0x04b0: 5369 6e63 653a 2054 7565 2c20 3136 2041 Since:.Tue,.16.A
0x04c0: 7567 2032 3031 3120 3039 3a33 333a 3232 ug.2011.09:33:22
0x04d0: 2047 4d54 0d0a 4966 2d4e 6f6e 652d 4d61 .GMT..If-None-Ma
0x04e0: 7463 683a 2022 3132 3432 6633 2d36 372d tch:."1242f3-67-
0x04f0: 3461 6139 6331 3231 3739 6338 3022 0d0a 4aa9c12179c80"..
0x0500: 0d0a
}}}
--
Ticket URL: <http://www.varnish-cache.org/trac/ticket/1006#comment:9>
Varnish <http://varnish-cache.org/>
The Varnish HTTP Accelerator
More information about the varnish-bugs
mailing list