Hi,<div><br></div><div>Recently we see a weird problem surfaced while serving contents from varnish. A 20 Byte response is seen in the varnish logs whereas no genuine apache request log is seen on the origin server. Suspect is that we receive first 20 Byte response form origin servers and then the connection gets closed but the response is cached as 200 OK and thereafter all request failed because of incorrectly cached content. Below is trace of such event; can someone go through to help me understand the cause. <br><br><br><br><br><p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana">136
SessionOpen c 10.50.252.5 4319 :80<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ReqStart c 10.50.252.5 4319 1560877350<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxRequest c GET<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxURL c /vi/ent/gi60s-4-/230987<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxProtocol c HTTP/1.1<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Host: rest.anand.com<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Pragma: no-cache<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Accept: */*<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Accept-Encoding: deflate, gzip<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Referer: http://world.anand.com<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Connection: Close<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Cipher-Suite:<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c SSL-Version: 0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 RxHeader c Cipher-Bits: 0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_call c recv<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_acl c MATCH purge 10.50.0.0/16<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_return c lookup<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_call c hash<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 Hash c /vi/ent/gi60s-4-/230987<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 Hash c rest.is.anand.com<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_return c hash<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_call c miss fetch<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 Backend c 42 isharerest isharerest[1]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TTL c 1560877350 RFC 120 -1 -1 1360686521
0 1360686464 0 0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_call c fetch<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TTL c 1560877350 VCL 2592000 -1 -1 1360686521
-0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_return c deliver<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjProtocol c HTTP/1.1<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjResponse c OK<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c Date: Tue, 12 Feb 2013 16:27:44 GMT<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c Server: Apache<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c X-Powered-By: PHP/5.1.4<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c Content-Encoding: gzip<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c Last-Modified: Tue, 12 Feb 2013 16:28:40
GMT<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c cache-control: max-age=2592000<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ObjHeader c Content-Type: text/html; charset=utf-8<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 Gzip c u F - 20 0 80 80 90<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 VCL_call c deliver deliver<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxProtocol c HTTP/1.1<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxStatus c 200<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxResponse c OK<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Content-Encoding: gzip<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Last-Modified: Tue, 12 Feb 2013 16:28:40
GMT<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c cache-control: max-age=2592000<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Content-Type: text/html; charset=utf-8<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Content-Length: 20<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Accept-Ranges: bytes<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Date: Tue, 12 Feb 2013 16:28:40 GMT<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Connection: close<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c X-Served-By: cdnserver<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c Server: Rediff/3.0.2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 TxHeader c X-Cache: TCP_MISS<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 Length c 20<o:p></o:p></span></p>
<p class="MsoNormal"><span style="font-size:10.0pt;font-family:Verdana"> 136 ReqEnd c 1560877350 1360686520.826237917
1360686520.841027975 0.000053883 0.004394054 0.010396004<o:p></o:p></span></p><br>Regards,<br>
Anand Shah<br>
<strong>A pessimist sees the difficulty in every opportunity; an optimist sees the opportunity in every difficulty.</strong><br>
</div>