Lexa Software: Nginx-ru@sysoev.ru archive

		Apache-Talk @lexa.ru
		Inet-Admins @info.east.ru
		Filmscanners @halftone.co.uk
		Security-alerts @yandex-team.ru
		nginx-ru @sysoev.ru
СТАТЬИ
ПЕРСОНАЛЬНОЕ
ПРОГРАММЫ
ПИШИТЕ
ПИСЬМА
АРХИВ :: nginx-ru
Nginx-ru mailing list archive (nginx-ru@sysoev.ru)
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
Re: wget keep-alive

To: nginx-ru@xxxxxxxxx
Subject: Re: wget keep-alive
From: Igor Sysoev <is@xxxxxxxxxxxxx>
Date: Sat, 24 Nov 2007 11:38:35 +0300
In-reply-to: <47473F7C.5010700@xxxxxxxxxx>
References: <47473F7C.5010700@xxxxxxxxxx>
On Fri, Nov 23, 2007 at 11:00:44PM +0200, Alex Vorona wrote:

> Привет
> 
> Почему nginx не говорит wget'у что не умеет keep-alive?
> 
> wget -Yoff -SO/dev/null http://192.168.78.2/2.cgi
> --22:21:35--  http://192.168.78.2/2.cgi
>           => `/dev/null'
> Устанавливается соединение с 192.168.78.2:80... соединение установлено.
> Запрос HTTP послан, ожидается ответ...
>  HTTP/1.1 200 OK
>  Server: nginx/0.5.33
>  Date: Fri, 23 Nov 2007 20:22:36 GMT
>  Content-Type: text/html
>  Connection: close
> Длина: нет информации [text/html]

У ответа нет длины. HTTP/1.0 не понимает chunked ответы:

2007/11/23 20:45:29 [debug] 13043#0: *12 http request line: "GET /2.cgi 
HTTP/1.0"

Как сказать, что ответ кончился ? Только закрыв соединение.

> nginx -V
> nginx version: nginx/0.5.33
> configure arguments: --prefix=/usr --conf-path=/etc/nginx/nginx.conf 
> --http-log-path=/var/log/nginx/access_log 
> --error-log-path=/var/log/nginx/error_log --pid-path=/var/run/nginx.pid 
> --http-client-body-temp-path=/var/tmp/nginx/client 
> --http-proxy-temp-path=/var/tmp/nginx/proxy 
> --http-fastcgi-temp-path=/var/tmp/nginx/fastcgi --with-md5-asm 
> --with-md5=/usr/include --with-http_realip_module --with-http_flv_module 
> --with-debug --with-http_ssl_module --with-http_stub_status_module 
> --with-http_dav_module
> 
> то же поведение у 0.6.16
> 
> Аналогичное поведение и с Firefox. Дебаг-логи вложил

> 2007/11/23 20:45:29 [debug] 13043#0: accept on 0.0.0.0:80, ready: 0
> 2007/11/23 20:45:29 [debug] 13043#0: malloc: 00000000006930B0:256
> 2007/11/23 20:45:29 [debug] 13043#0: *12 accept: 192.168.78.2 fd:8
> 2007/11/23 20:45:29 [debug] 13043#0: *12 event timer add: 8: 
> 600000:1195851329987
> 2007/11/23 20:45:29 [debug] 13043#0: *12 epoll add event: fd:8 op:1 
> ev:80000001
> 2007/11/23 20:45:29 [debug] 13043#0: *12 malloc: 00000000006A96B0:1248
> 2007/11/23 20:45:29 [debug] 13043#0: *12 malloc: 0000000000693370:256
> 2007/11/23 20:45:29 [debug] 13043#0: *12 malloc: 00000000006A9BA0:1024
> 2007/11/23 20:45:29 [debug] 13043#0: *12 malloc: 00000000006A0A30:4096
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http process request line
> 2007/11/23 20:45:29 [debug] 13043#0: *12 recv: fd:8 404 of 1024
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http request line: "GET /2.cgi 
> HTTP/1.0"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http uri: "/2.cgi"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http args: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http exten: "cgi"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http process request header line
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "Host: 192.168.78.2"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "User-Agent: 
> Mozilla/5.0 (X11; U; Linux i686; ru; rv:1.8.1.9) Gecko/20071123 
> Firefox/2.0.0.9"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "Accept: 
> text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "Accept-Language: 
> ru-ru,ru;q=0.8,en-us;q=0.5,en;q=0.3"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "Accept-Encoding: 
> gzip,deflate"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "Accept-Charset: 
> windows-1251,utf-8;q=0.7,*;q=0.7"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header: "Connection: keep-alive"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http header done
> 2007/11/23 20:45:29 [debug] 13043#0: *12 event timer del: 8: 1195851329987
> 2007/11/23 20:45:29 [debug] 13043#0: *12 generic phase: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 generic phase: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 find location for "/2.cgi"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 find location: "/"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 find location: = "/50x.html"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 find location for "/2.cgi"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 find location: ~ "/\.ht"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 using configuration "/"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http cl:-1 max:10485760
> 2007/11/23 20:45:29 [debug] 13043#0: *12 generic phase: 3
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script value: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script set var
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: "/2.cgi"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script regex: ".php(/.+)$"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script if
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script if: false
> 2007/11/23 20:45:29 [debug] 13043#0: *12 post rewrite phase: 4
> 2007/11/23 20:45:29 [debug] 13043#0: *12 generic phase: 5
> 2007/11/23 20:45:29 [debug] 13043#0: *12 generic phase: 6
> 2007/11/23 20:45:29 [debug] 13043#0: *12 access phase: 7
> 2007/11/23 20:45:29 [debug] 13043#0: *12 access phase: 8
> 2007/11/23 20:45:29 [debug] 13043#0: *12 post access phase: 9
> 2007/11/23 20:45:29 [debug] 13043#0: *12 malloc: 00000000006976E0:4096
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http init upstream, client timer: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 epoll add event: fd:8 op:3 
> ev:80000005
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script var: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http script copy: ""
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http cleanup add: 0000000000697B70
> 2007/11/23 20:45:29 [debug] 13043#0: *12 get rr peer, try: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 socket 13
> 2007/11/23 20:45:29 [debug] 13043#0: *12 epoll add connection: fd:13 
> ev:80000005
> 2007/11/23 20:45:29 [debug] 13043#0: *12 connect to unix:/tmp/123.sock, fd:13 
> #13
> 2007/11/23 20:45:29 [debug] 13043#0: *12 connected
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream connect: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream send request
> 2007/11/23 20:45:29 [debug] 13043#0: *12 chain writer buf fl:0 s:856
> 2007/11/23 20:45:29 [debug] 13043#0: *12 chain writer in: 0000000000697B88
> 2007/11/23 20:45:29 [debug] 13043#0: *12 writev: 856
> 2007/11/23 20:45:29 [debug] 13043#0: *12 chain writer out: 0000000000000000
> 2007/11/23 20:45:29 [debug] 13043#0: *12 event timer add: 13: 
> 60000:1195850789987
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream check client, write 
> event:1, "/2.cgi"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream recv(): -1 (11: 
> Resource temporarily unavailable)
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream dummy handler
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream dummy handler
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream process header
> 2007/11/23 20:45:29 [debug] 13043#0: *12 malloc: 00000000006986F0:4096
> 2007/11/23 20:45:29 [debug] 13043#0: *12 recv: fd:13 112 of 4096
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 01
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 06
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 01
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 4C
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 04
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record length: 76
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi parser: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi header: "Content-type: 
> text/html"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi parser: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi header done
> 2007/11/23 20:45:29 [debug] 13043#0: *12 HTTP/1.1 200 OK
> Server: nginx/0.5.33
> Date: Fri, 23 Nov 2007 20:45:29 GMT
> Content-Type: text/html
> Connection: close
> 
> 
> 2007/11/23 20:45:29 [debug] 13043#0: *12 write new buf t:1 f:0 
> 0000000000697DE0, pos 0000000000697DE0, size: 122 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http write filter: l:0 f:0 s:122
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream process upstream
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe read upstream: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe preread: 77
> 2007/11/23 20:45:29 [debug] 13043#0: *12 readv: 1:3984
> 2007/11/23 20:45:29 [debug] 13043#0: *12 readv() not ready (11: Resource 
> temporarily unavailable)
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe recv chain: -2
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe buf free s:0 t:1 f:0 
> 00000000006986F0, pos 0000000000698713, size: 77 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe write downstream: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe write busy: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe write: out:0000000000000000, f:0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe read upstream: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe buf free s:0 t:1 f:0 
> 00000000006986F0, pos 0000000000698713, size: 77 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 event timer: 13, old: 1195850789987, 
> new: 1195850789997
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream dummy handler
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream process upstream
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe read upstream: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 readv: 1:3984
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe recv chain: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe buf free s:0 t:1 f:0 
> 00000000006986F0, pos 0000000000698713, size: 77 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 input buf #0 0000000000698713
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 01
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 06
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 01
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record length: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi closed stdout
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 01
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 03
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 01
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 08
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record byte: 00
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi record length: 8
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http fastcgi sent end request
> 2007/11/23 20:45:29 [debug] 13043#0: *12 input buf 0000000000698713 49
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe write downstream: 1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe write downstream flush in
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http output filter "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 copy filter: "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http postpone filter "/2.cgi?" 
> 0000000000697FC8
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http postpone filter out "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 write old buf t:1 f:0 
> 0000000000697DE0, pos 0000000000697DE0, size: 122 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 write new buf t:1 f:0 
> 00000000006986F0, pos 0000000000698713, size: 49 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http write filter: l:0 f:0 s:171
> 2007/11/23 20:45:29 [debug] 13043#0: *12 copy filter: 0 "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 pipe write downstream done
> 2007/11/23 20:45:29 [debug] 13043#0: *12 event timer: 13, old: 1195850789987, 
> new: 1195850789997
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream exit: 0000000000000000
> 2007/11/23 20:45:29 [debug] 13043#0: *12 finalize http upstream request: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 finalize http fastcgi request
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free rr peer 1 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 close http upstream connection: 13
> 2007/11/23 20:45:29 [debug] 13043#0: *12 event timer del: 13: 1195850789987
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http upstream temp fd: -1
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http output filter "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 copy filter: "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http postpone filter "/2.cgi?" 
> 0000760066A85C30
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http postpone filter out "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 write old buf t:1 f:0 
> 0000000000697DE0, pos 0000000000697DE0, size: 122 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 write old buf t:1 f:0 
> 00000000006986F0, pos 0000000000698713, size: 49 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 write new buf t:0 f:0 
> 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http write filter: l:1 f:0 s:171
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http write filter limit 1048576
> 2007/11/23 20:45:29 [debug] 13043#0: *12 writev: 171
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http write filter 0000000000000000
> 2007/11/23 20:45:29 [debug] 13043#0: *12 copy filter: 0 "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http finalize request: 0, "/2.cgi?"
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http close request
> 2007/11/23 20:45:29 [debug] 13043#0: *12 http log handler
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 00000000006986F0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 00000000006A0A30, unused: 3
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 00000000006976E0, unused: 1584
> 2007/11/23 20:45:29 [debug] 13043#0: *12 close http connection: 8
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 00000000006A9BA0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 00000000006A96B0
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 00000000006930B0, unused: 8
> 2007/11/23 20:45:29 [debug] 13043#0: *12 free: 0000000000693370, unused: 112

> 2007/11/23 20:22:25 [debug] 12635#0: epoll add event: fd:9 op:1 ev:00000001
> 2007/11/23 20:22:36 [debug] 12635#0: accept on 0.0.0.0:80, ready: 0
> 2007/11/23 20:22:36 [debug] 12635#0: malloc: 00000000006A03F0:256
> 2007/11/23 20:22:36 [debug] 12635#0: *1 accept: 192.168.78.1 fd:10
> 2007/11/23 20:22:36 [debug] 12635#0: *1 event timer add: 10: 
> 600000:1195849956013
> 2007/11/23 20:22:36 [debug] 12635#0: *1 epoll add event: fd:10 op:1 
> ev:80000001
> 2007/11/23 20:22:36 [debug] 12635#0: *1 malloc: 00000000006B69E0:1248
> 2007/11/23 20:22:36 [debug] 12635#0: *1 malloc: 00000000006A06B0:256
> 2007/11/23 20:22:36 [debug] 12635#0: *1 malloc: 00000000006B6ED0:1024
> 2007/11/23 20:22:36 [debug] 12635#0: *1 malloc: 00000000006ADD60:4096
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http process request line
> 2007/11/23 20:22:36 [debug] 12635#0: *1 recv: fd:10 144 of 1024
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http request line: "GET /2.cgi 
> HTTP/1.0"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http uri: "/2.cgi"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http args: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http exten: "cgi"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http process request header line
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http header: "User-Agent: Wget/1.10.2"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http header: "Accept: */*"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http header: "Authorization: Basic 
> dm9yb246dm9yb24="
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http header: "Host: 192.168.78.2"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http header: "Connection: Keep-Alive"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http header done
> 2007/11/23 20:22:36 [debug] 12635#0: *1 event timer del: 10: 1195849956013
> 2007/11/23 20:22:36 [debug] 12635#0: *1 generic phase: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 generic phase: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 find location for "/2.cgi"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 find location: "/"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 find location: = "/50x.html"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 find location for "/2.cgi"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 find location: ~ "/\.ht"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 using configuration "/"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http cl:-1 max:10485760
> 2007/11/23 20:22:36 [debug] 12635#0: *1 generic phase: 3
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script value: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script set var
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: "/2.cgi"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script regex: ".php(/.+)$"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script if
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script if: false
> 2007/11/23 20:22:36 [debug] 12635#0: *1 post rewrite phase: 4
> 2007/11/23 20:22:36 [debug] 12635#0: *1 generic phase: 5
> 2007/11/23 20:22:36 [debug] 12635#0: *1 generic phase: 6
> 2007/11/23 20:22:36 [debug] 12635#0: *1 access phase: 7
> 2007/11/23 20:22:36 [debug] 12635#0: *1 access phase: 8
> 2007/11/23 20:22:36 [debug] 12635#0: *1 post access phase: 9
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http init upstream, client timer: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 epoll add event: fd:10 op:3 
> ev:80000005
> 2007/11/23 20:22:36 [debug] 12635#0: *1 malloc: 00000000006A4A10:4096
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script var: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http script copy: ""
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http cleanup add: 00000000006A4D78
> 2007/11/23 20:22:36 [debug] 12635#0: *1 get rr peer, try: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 socket 13
> 2007/11/23 20:22:36 [debug] 12635#0: *1 epoll add connection: fd:13 
> ev:80000005
> 2007/11/23 20:22:36 [debug] 12635#0: *1 connect to unix:/tmp/123.sock, fd:13 
> #2
> 2007/11/23 20:22:36 [debug] 12635#0: *1 connected
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream connect: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream send request
> 2007/11/23 20:22:36 [debug] 12635#0: *1 chain writer buf fl:0 s:592
> 2007/11/23 20:22:36 [debug] 12635#0: *1 chain writer in: 00000000006A4D90
> 2007/11/23 20:22:36 [debug] 12635#0: *1 writev: 592
> 2007/11/23 20:22:36 [debug] 12635#0: *1 chain writer out: 0000000000000000
> 2007/11/23 20:22:36 [debug] 12635#0: *1 event timer add: 13: 
> 60000:1195849416015
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream check client, write 
> event:1, "/2.cgi"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream recv(): -1 (11: 
> Resource temporarily unavailable)
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream dummy handler
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream process header
> 2007/11/23 20:22:36 [debug] 12635#0: *1 malloc: 00000000006A5A20:4096
> 2007/11/23 20:22:36 [debug] 12635#0: *1 recv: fd:13 112 of 4096
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 01
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 06
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 01
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 4C
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 04
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record length: 76
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi parser: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi header: "Content-type: 
> text/html"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi parser: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi header done
> 2007/11/23 20:22:36 [debug] 12635#0: *1 HTTP/1.1 200 OK
> Server: nginx/0.5.33
> Date: Fri, 23 Nov 2007 20:22:36 GMT
> Content-Type: text/html
> Connection: close
> 
> 
> 2007/11/23 20:22:36 [debug] 12635#0: *1 write new buf t:1 f:0 
> 00000000006A4FE8, pos 00000000006A4FE8, size: 122 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http write filter: l:0 f:0 s:122
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream process upstream
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe read upstream: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe preread: 77
> 2007/11/23 20:22:36 [debug] 12635#0: *1 readv: 1:3984
> 2007/11/23 20:22:36 [debug] 12635#0: *1 readv() not ready (11: Resource 
> temporarily unavailable)
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe recv chain: -2
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe buf free s:0 t:1 f:0 
> 00000000006A5A20, pos 00000000006A5A43, size: 77 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe write downstream: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe write busy: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe write: out:0000000000000000, f:0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe read upstream: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe buf free s:0 t:1 f:0 
> 00000000006A5A20, pos 00000000006A5A43, size: 77 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 event timer: 13, old: 1195849416015, 
> new: 1195849416033
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream dummy handler
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream process upstream
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe read upstream: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 readv: 1:3984
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe recv chain: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe buf free s:0 t:1 f:0 
> 00000000006A5A20, pos 00000000006A5A43, size: 77 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 input buf #0 00000000006A5A43
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 01
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 06
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 01
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record length: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi closed stdout
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 01
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 03
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 01
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 08
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record byte: 00
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi record length: 8
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http fastcgi sent end request
> 2007/11/23 20:22:36 [debug] 12635#0: *1 input buf 00000000006A5A43 49
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe write downstream: 1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe write downstream flush in
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http output filter "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 copy filter: "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http postpone filter "/2.cgi?" 
> 00000000006A51D0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http postpone filter out "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 write old buf t:1 f:0 
> 00000000006A4FE8, pos 00000000006A4FE8, size: 122 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 write new buf t:1 f:0 
> 00000000006A5A20, pos 00000000006A5A43, size: 49 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http write filter: l:0 f:0 s:171
> 2007/11/23 20:22:36 [debug] 12635#0: *1 copy filter: 0 "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 pipe write downstream done
> 2007/11/23 20:22:36 [debug] 12635#0: *1 event timer: 13, old: 1195849416015, 
> new: 1195849416033
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream exit: 0000000000000000
> 2007/11/23 20:22:36 [debug] 12635#0: *1 finalize http upstream request: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 finalize http fastcgi request
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free rr peer 1 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 close http upstream connection: 13
> 2007/11/23 20:22:36 [debug] 12635#0: *1 event timer del: 13: 1195849416015
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http upstream temp fd: -1
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http output filter "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 copy filter: "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http postpone filter "/2.cgi?" 
> 000078C4FF826790
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http postpone filter out "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 write old buf t:1 f:0 
> 00000000006A4FE8, pos 00000000006A4FE8, size: 122 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 write old buf t:1 f:0 
> 00000000006A5A20, pos 00000000006A5A43, size: 49 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 write new buf t:0 f:0 
> 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http write filter: l:1 f:0 s:171
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http write filter limit 1048576
> 2007/11/23 20:22:36 [debug] 12635#0: *1 writev: 171
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http write filter 0000000000000000
> 2007/11/23 20:22:36 [debug] 12635#0: *1 copy filter: 0 "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http finalize request: 0, "/2.cgi?"
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http close request
> 2007/11/23 20:22:36 [debug] 12635#0: *1 http log handler
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006A5A20
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006ADD60, unused: 0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006A4A10, unused: 1880
> 2007/11/23 20:22:36 [debug] 12635#0: *1 close http connection: 10
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006B6ED0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006B69E0
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006A03F0, unused: 8
> 2007/11/23 20:22:36 [debug] 12635#0: *1 free: 00000000006A06B0, unused: 112


-- 
Игорь Сысоев
http://sysoev.ru
References:
- wget keep-alive
  - From: Alex Vorona
Prev by Date: IBM GPFS
Next by Date: Re: Вопрос по баллансировке
Previous by thread: Re: wget keep-alive
Next by thread: IBM GPFS
Index(es):
- Date
- Thread