[Varnish] #415: Varnish Hangs

Varnish varnish-bugs at projects.linpro.no
Thu Jan 22 10:33:17 CET 2009


#415: Varnish Hangs
--------------------+-------------------------------------------------------
 Reporter:  plfgoa  |        Owner:       
     Type:  defect  |       Status:  new  
 Priority:  high    |    Milestone:       
Component:  build   |      Version:  trunk
 Severity:  major   |   Resolution:       
 Keywords:          |  
--------------------+-------------------------------------------------------
Comment (by perbu):

 With proper formatting:

 {{{
 16 ReqStart?     c 194.19.36.2 34546 902563468
 16 RxRequest?    c GET
 16 RxURL        c
 /multimedia/dynamic/00069/14NYHHAguddingsmo002_69559p.jpg
 16 RxProtocol?   c HTTP/1.1
 16 RxHeader?     c Host: grandis09.adresseavisen.no
 16 RxHeader?     c User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1;
 nb-N rv:1.9.0.5) Gecko/2008120122 Firefox/3.0.5
 16 RxHeader?     c Accept: image/png,image/*;q=0.8,*/*;q=0.5
 16 RxHeader?     c Accept-Language: nb,no;q=0.8,nn;q=0.6,en-
 us;q=0.4,en;q=0.
 16 RxHeader?     c Accept-Encoding: gzip,deflate
 16 RxHeader?     c Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7
 16 RxHeader?     c Keep-Alive: 300
 16 RxHeader?     c Connection: keep-alive
 16 RxHeader?     c Referer: http://grandis09.adresseavisen.no/

 16 RxHeader?     c Cookie:
 utma=112304850.2329896987502384600.1228385752.12459661.1232461691.23;
 utmz=112304850.1232456212.21.9.utmcsr=grandis09|utmcc(referral)|utmcmd=referral|utmcct=/;
 JSESSIONID=abcj4fI_VAP_TbuzICZ7r; utmc=2304850; utmb=112304850.17.10.1232
 16 VCL_call     c recv
 16 VCL_return   c lookup
 16 VCL_call     c hash
 16 VCL_return   c hash
 16 VCL_call     c miss
 16 VCL_return   c fetch
 24 BackendOpen?  b default 127.0.0.1 44110 127.0.0.1 90
 24 BackendXID   b 902563468
 16 Backend      c 24 default
 24 TxRequest?    b GET
 24 TxURL        b
 /multimedia/dynamic/00069/14NYHHAguddingsmo002_69559p.jpg
 24 TxProtocol?   b HTTP/1.1
 24 TxHeader?     b Host: grandis09.adresseavisen.no
 24 TxHeader?     b User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1;
 nb-N rv:1.9.0.5) Gecko/2008120122 Firefox/3.0.5
 24 TxHeader?     b Accept: image/png,image/*;q=0.8,*/*;q=0.5
 24 TxHeader?     b Accept-Language: nb,no;q=0.8,nn;q=0.6,en-
 us;q=0.4,en;q=0.
 24 TxHeader?     b Accept-Encoding: gzip,deflate
 24 TxHeader?     b Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7
 24 TxHeader?     b Referer: http://grandis09.adresseavisen.no/

 24 TxHeader?     b Cookie:
 utma=112304850.2329896987502384600.1228385752.12459661.1232461691.23;
 utmz=112304850.1232456212.21.9.utmcsr=grandis09|utmcc(referral)|utmcmd=referral|utmcct=/;
 JSESSIONID=abcj4fI_VAP_TbuzICZ7r; utmc=2304850; utmb=112304850.17.10.1232
 24 TxHeader?     b X-Varnish: 902563468
 24 TxHeader?     b X-Forwarded-for: 194.19.36.2
 24 RxProtocol?   b HTTP/1.1
 24 RxStatus?     b 200
 24 RxResponse?   b OK
 24 RxHeader?     b Date: Tue, 20 Jan 2009 14:30:28 GMT
 24 RxHeader?     b Server: Resin/3.1.8
 24 RxHeader?     b Content-Type: image/jpeg
 24 RxHeader?     b Connection: close
 24 RxHeader?     b Transfer-Encoding: chunked
 16 ObjProtocol?  c HTTP/1.1
 16 ObjStatus?    c 200
 16 ObjResponse?  c OK
 16 ObjHeader?    c Date: Tue, 20 Jan 2009 14:30:28 GMT
 16 ObjHeader?    c Server: Resin/3.1.8
 16 ObjHeader?    c Content-Type: image/jpeg
 24 BackendClose? b default
 16 TTL          c 902563468 RFC 120 1232461828 1232461828 0 0 0
 16 VCL_call     c fetch
 16 VCL_return   c insert
 16 Length       c 4299
 16 VCL_call     c deliver
 16 VCL_return   c deliver
 16 TxProtocol?   c HTTP/1.1
 16 TxStatus?     c 200
 16 TxResponse?   c OK
 16 TxHeader?     c Date: Tue, 20 Jan 2009 14:30:28 GMT
 16 TxHeader?     c Server: Resin/3.1.8
 16 TxHeader?     c Content-Type: image/jpeg
 16 TxHeader?     c Content-Length: 4299
 16 TxHeader?     c X-Varnish: 902563468
 16 TxHeader?     c Age: 0
 16 TxHeader?     c Via: 1.1 varnish
 16 ReqEnd?       c 902563468 1232461828.629636049 1232461828.749588013
 0.0566091 0.119915009 0.000036955




 0 StatAddr?       194.19.36.2 0 139 112 382 0 0 345 67281 6177207



 28 SessionOpen?  c 194.19.36.2 34557
 28 Debug        c
 "/multimedia/dynamic/00069/DSO_69532h.jpg#grandis09.adresavisen.no#"
 37 ReqStart?     c 194.19.36.2 34552 902563475
 37 RxRequest?    c GET
 37 RxURL        c
 /multimedia/dynamic/00069/15NYHHAgjerstad013_3_69582d.jpg
 37 RxProtocol?   c HTTP/1.1
 37 RxHeader?     c Host: grandis09.adresseavisen.no
 37 RxHeader?     c User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1;
 nb-N rv:1.9.0.5) Gecko/2008120122 Firefox/3.0.5
 37 RxHeader?     c Accept: image/png,image/*;q=0.8,*/*;q=0.5
 37 RxHeader?     c Accept-Language: nb,no;q=0.8,nn;q=0.6,en-
 us;q=0.4,en;q=0.
 37 RxHeader?     c Accept-Encoding: gzip,deflate
 37 RxHeader?     c Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7
 37 RxHeader?     c Keep-Alive: 300
 37 RxHeader?     c Connection: keep-alive
 37 RxHeader?     c Referer: http://grandis09.adresseavisen.no/

 37 RxHeader?     c Cookie:
 utma=112304850.2329896987502384600.1228385752.12459661.1232461691.23;
 utmz=112304850.1232456212.21.9.utmcsr=grandis09|utmcc(referral)|utmcmd=referral|utmcct=/;
 JSESSIONID=abcj4fI_VAP_TbuzICZ7r; utmc=2304850; utmb=112304850.17.10.1232
 37 VCL_call     c recv
 37 VCL_return   c lookup
 37 VCL_call     c hash
 37 VCL_return   c hash
 37 VCL_call     c miss
 37 VCL_return   c fetch
 46 BackendOpen?  b default 127.0.0.1 44117 127.0.0.1 90
 46 BackendXID   b 902563475
 37 Backend      c 46 default
 46 TxRequest?    b GET
 46 TxURL        b
 /multimedia/dynamic/00069/15NYHHAgjerstad013_3_69582d.jpg
 46 TxProtocol?   b HTTP/1.1
 46 TxHeader?     b Host: grandis09.adresseavisen.no
 46 TxHeader?     b User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1;
 nb-N rv:1.9.0.5) Gecko/2008120122 Firefox/3.0.5
 46 TxHeader?     b Accept: image/png,image/*;q=0.8,*/*;q=0.5
 46 TxHeader?     b Accept-Language: nb,no;q=0.8,nn;q=0.6,en-
 us;q=0.4,en;q=0.
 46 TxHeader?     b Accept-Encoding: gzip,deflate
 46 TxHeader?     b Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7
 46 TxHeader?     b Referer: http://grandis09.adresseavisen.no/

 46 TxHeader?     b Cookie:
 utma=112304850.2329896987502384600.1228385752.12459661.1232461691.23;
 utmz=112304850.1232456212.21.9.utmcsr=grandis09|utmcc(referral)|utmcmd=referral|utmcct=/;
 JSESSIONID=abcj4fI_VAP_TbuzICZ7r; utmc=2304850; utmb=112304850.17.10.1232
 46 TxHeader?     b X-Varnish: 902563475
 46 TxHeader?     b X-Forwarded-for: 194.19.36.2
 46 RxProtocol?   b HTTP/1.1
 46 RxStatus?     b 200
 46 RxResponse?   b OK
 46 RxHeader?     b Date: Tue, 20 Jan 2009 14:30:28 GMT
 46 RxHeader?     b Server: Resin/3.1.8
 46 RxHeader?     b Content-Type: image/jpeg
 46 RxHeader?     b Connection: close
 46 RxHeader?     b Transfer-Encoding: chunked
 37 ObjProtocol?  c HTTP/1.1
 37 ObjStatus?    c 200
 37 ObjResponse?  c OK
 37 ObjHeader?    c Date: Tue, 20 Jan 2009 14:30:28 GMT
 37 ObjHeader?    c Server: Resin/3.1.8
 37 ObjHeader?    c Content-Type: image/jpeg
 46 BackendClose? b default
 37 TTL          c 902563475 RFC 120 1232461828 1232461828 0 0 0
 37 VCL_call     c fetch
 37 VCL_return   c insert
 37 Length       c 13979
 37 VCL_call     c deliver
 37 VCL_return   c deliver
 37 TxProtocol?   c HTTP/1.1
 37 TxStatus?     c 200
 37 TxResponse?   c OK
 37 TxHeader?     c Date: Tue, 20 Jan 2009 14:30:28 GMT
 37 TxHeader?     c Server: Resin/3.1.8
 37 TxHeader?     c Content-Type: image/jpeg
 37 TxHeader?     c Content-Length: 13979
 37 TxHeader?     c X-Varnish: 902563475
 37 TxHeader?     c Age: 0
 37 TxHeader?     c Via: 1.1 varnish
 37 ReqEnd?       c 902563475 1232461828.633925915 1232461828.750211954
 0.0019804 0.116243124 0.000042915




 0 StatAddr?       194.19.36.2 0 139 113 383 0 0 346 67455 6191186



 29 SessionOpen?  c 194.19.36.2 34558
 29 Debug        c
 "/multimedia/dynamic/00069/090114_-_Bellman_69531i.jpg#grdis09.adresseavisen.no#"
 19 Debug        c
 "/multimedia/dynamic/00068/pondus_front_68819h.jpg#grandi9.adresseavisen.no#"
 23 Debug        c
 "/multimedia/dynamic/00069/splatt_69454i.jpg#grandis09.adsseavisen.no#"




 0 WorkThread?     0x44004cf0 start



 22 Debug        c
 "/multimedia/dynamic/00069/090114_-_Midnight_Ch_69530i.jpgrandis09.adresseavisen.no#"



 0 WorkThread?     0x46008cf0 start
 0 WorkThread?     0x43002cf0 start
 0 WorkThread?     0x4a010cf0 start




 16 Debug        c "/multimedia/dynamic/00069/TS-20080317-NYHETER-
 _69455h.jpgrandis09.adresseavisen.no#"
 13 Debug        c
 "/multimedia/dynamic/00069/mosviksentrum_69449h.jpg#grand09.adresseavisen.no#"
 37 Debug        c
 "/multimedia/dynamic/00069/31REPkjellrun01_69506h.jpg#grais09.adresseavisen.no#"
 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461830



 14 SessionClose? c timeout
 14 StatSess?     c 192.168.101.83 17635 nan 1 4 0 0 2 974 30246




 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461833
 0 WorkThread?     0x4a811cf0 start



 14 SessionOpen?  c 194.19.36.2 34833
 14 Debug        c "/i/t.gif#grandis09.adresseavisen.no#"




 0 WorkThread?     0x4b012cf0 start



 53 SessionOpen?  c 194.19.36.2 34834



 0 WorkThread?     0x4b813cf0 start




 56 SessionOpen?  c 194.19.36.2 34836
 53 Debug        c
 "/multimedia/dynamic/00069/19KULmus_og_menn2_69604h.jpg#gndis09.adresseavisen.no#"
 56 Debug        c "/#grandis09.adresseavisen.no#"



 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461836
 0 WorkThread?     0x4c014cf0 start




 63 SessionOpen?  c 194.19.36.2 34910
 63 Debug        c "/template/ver1-0/css/none#grandis09.adresseavisen.no#"



 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461839
 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461842
 0 WorkThread?     0x4c815cf0 start



 70 SessionOpen?  c 194.19.36.2 35144
 70 Debug        c "/nyheter/article60936.ece#grandis09.adresseavisen.no#"




 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461845
 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461848
 0 WorkThread?     0x4d016cf0 start



 73 SessionOpen?  c 194.19.36.2 35264
 73 Debug        c "/nyheter/article60943.ece#grandis09.adresseavisen.no#"




 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461851
 0 WorkThread?     0x4d817cf0 start



 76 SessionOpen?  c 194.19.36.2 35466
 76 Debug        c "/nyheter/article60946.ece#grandis09.adresseavisen.no#"



 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461855
 0 CLI            Rd ping
 0 CLI            Wr 0 200 PONG 1232461858
 }}}

-- 
Ticket URL: <http://varnish.projects.linpro.no/ticket/415#comment:7>
Varnish <http://varnish.projects.linpro.no/>
The Varnish HTTP Accelerator


More information about the varnish-bugs mailing list