nginx-0.8.1
Volkov Oleg
nginx at teratelecom.ru
Thu Jun 11 23:02:59 MSD 2009
В Чтв, 11/06/2009 в 21:30 +0400, Igor Sysoev пишет:
> В новом патче в режиме отладки ещё пишется inode, можно сделать отладочный
> лог ?
Вот один из запросов, снятый через несколько секунд после "поломки".
Воркеров - 1.
2009/06/11 22:29:41 [debug] 28280#0: *26232 accept: 62.148.157.153
fd:1749
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer add: 1749:
21000:3499453584
2009/06/11 22:29:41 [debug] 28280#0: *26232 epoll add event: fd:1749
op:1 ev:80000001
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 12EA5C58:656
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 11CD0020:1024
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 13598310:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 http process request line
2009/06/11 22:29:41 [debug] 28280#0: *26232 recv: fd:1749 590 of 1024
2009/06/11 22:29:41 [debug] 28280#0: *26232 http request line: "GET ...
HTTP/1.1"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http uri: "..."
2009/06/11 22:29:41 [debug] 28280#0: *26232 http args: ""
2009/06/11 22:29:41 [debug] 28280#0: *26232 http exten: "html"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http process request header
line
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header: "Accept: */*"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header:
"Accept-Language: ru"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header: "UA-CPU: x86"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header:
"Accept-Encoding: gzip, deflate"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header: "User-Agent:
Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 5.1; WebMoney
Advisor; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 1.1.4322)"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header: "Host: HOST"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header: "Connection:
Keep-Alive"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header:
"If-Modified-Since: Thu, 11 Jun 2009 17:34:16 GMT"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header: "Cookie:
__utma=98314076.1639713026.1202644236.1221232343.1229196557.91;
__utma=247571994.3543999080904679400.1216643394.1244741181.1244741734.489; __utmz=247571994.1233173641.283.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http header done
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer del: 1749:
3499453584
2009/06/11 22:29:41 [debug] 28280#0: *26232 generic phase: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 test location: "/503.html"
2009/06/11 22:29:41 [debug] 28280#0: *26232 test location: ~
"(^/.htaccess.*|^/user.html|admin\/(admin.php.*)$)"
2009/06/11 22:29:41 [debug] 28280#0: *26232 test location: ~
"^(.+\.(php|php3|html)|.*/)$"
2009/06/11 22:29:41 [debug] 28280#0: *26232 using configuration
"^(.+\.(php|php3|html)|.*/)$"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http cl:-1 max:10485760
2009/06/11 22:29:41 [debug] 28280#0: *26232 generic phase: 2
2009/06/11 22:29:41 [debug] 28280#0: *26232 post rewrite phase: 3
2009/06/11 22:29:41 [debug] 28280#0: *26232 generic phase: 4
2009/06/11 22:29:41 [debug] 28280#0: *26232 generic phase: 5
2009/06/11 22:29:41 [debug] 28280#0: *26232 add cleanup: 135988F4
2009/06/11 22:29:41 [debug] 28280#0: *26232 limit zone: 949CA69E 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 access phase: 6
2009/06/11 22:29:41 [debug] 28280#0: *26232 access phase: 7
2009/06/11 22:29:41 [debug] 28280#0: *26232 post access phase: 8
2009/06/11 22:29:41 [debug] 28280#0: *26232 http init upstream, client
timer: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 epoll add event: fd:1749
op:3 ev:80000005
2009/06/11 22:29:41 [debug] 28280#0: *26232 perl variable handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 perl variable done
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script var: "HOST"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script var: "..."
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy: "?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script var: ""
2009/06/11 22:29:41 [debug] 28280#0: *26232 http cache key: "HOST...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 add cleanup: 13598D04
2009/06/11 22:29:41 [debug] 28280#0: *26232 http file cache exists: 0
e:1 98E0440
2009/06/11 22:29:41 [debug] 28280#0: *26232 add cleanup: 13598D54
2009/06/11 22:29:41 [debug] 28280#0: *26232 uniq: 98E0440 98D5B75
2009/06/11 22:29:41 [debug] 28280#0: *26232 cached open
file: /var/tmp/nginx/proxy_cache/7/4c/d834b44900b7d1770f6819308056b4c7,
fd:1310, c:1, e:0, u:315
2009/06/11 22:29:41 [debug] 28280#0: *26232 http file cache fd: 1310
2009/06/11 22:29:41 [debug] 28280#0: *26232 read: 1310, 13598DA4, 325, 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 http file cache expired: 3
1244744978 1244744981
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream cache: 3
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy: "Host:
HOST
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy:
"X-Forwarded-For: "
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script var:
"62.148.157.153"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy: "
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy:
"X-Real-IP: "
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script var:
"62.148.157.153"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy: "
2009/06/11 22:29:41 [debug] 28280#0: *26232 http script copy:
"Connection: close
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header: "Accept:
*/*"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"Accept-Language: ru"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header: "UA-CPU:
x86"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"Accept-Encoding: gzip, deflate"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"User-Agent: Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 5.1; WebMoney
Advisor; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 1.1.4322)"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header: "Cookie:
__utma=98314076.1639713026.1202644236.1221232343.1229196557.91;
__utma=247571994.3543999080904679400.1216643394.1244741181.1244741734.489; __utmz=247571994.1233173641.283.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
2009/06/11 22:29:41 [debug] 28280#0: *26232 http cleanup add: 135991B0
2009/06/11 22:29:41 [debug] 28280#0: *26232 get ip hash peer, try: 2
2009/06/11 22:29:41 [debug] 28280#0: *26232 get ip hash peer, hash: 0
0001
2009/06/11 22:29:41 [debug] 28280#0: *26232 socket 3184
2009/06/11 22:29:41 [debug] 28280#0: *26232 epoll add connection:
fd:3184 ev:80000005
2009/06/11 22:29:41 [debug] 28280#0: *26232 connect to 95.129.248.69:80,
fd:3184 #26234
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream connect: -2
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer add: 3184:
10000:3499442590
2009/06/11 22:29:41 [debug] 28280#0: *26232 http run request: "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream check client,
write event:1, "..."
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream recv(): -1
(11: Resource temporarily unavailable)
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream request:
"...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream send request
handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream send request
2009/06/11 22:29:41 [debug] 28280#0: *26232 chain writer buf fl:1 s:595
2009/06/11 22:29:41 [debug] 28280#0: *26232 chain writer in: 135991D8
2009/06/11 22:29:41 [debug] 28280#0: *26232 writev: 595
2009/06/11 22:29:41 [debug] 28280#0: *26232 chain writer out: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer del: 3184:
3499442590
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer add: 3184:
65000:3499497591
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream request:
"...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream process header
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 134507A0:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 recv: fd:3184 2896 of 4024
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy status 200 "200
OK"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header: "Date:
Thu, 11 Jun 2009 18:29:41 GMT"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header: "Server:
Apache"
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 13DF1640:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"X-Powered-By: PHP/5.2.8-pl2-gentoo"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"Last-Modified: Thu, 11 Jun 2009 18:29:41 GMT"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header: "Expires:
Thu, 11 Jun 2009 18:34:41 GMT"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"Connection: close"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header:
"Content-Type: text/html; charset=UTF-8"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http proxy header done
2009/06/11 22:29:41 [debug] 28280#0: *26232 http ims:1244741656
lm:1244744981
2009/06/11 22:29:41 [debug] 28280#0: *26232 parse header: "Cookie:
__utma=98314076.1639713026.1202644236.1221232343.1229196557.91;
__utma=247571994.3543999080904679400.1216643394.1244741181.1244741734.489; __utmz=247571994.1233173641.283.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2009/06/11 22:29:41 [debug] 28280#0: *26232 uid cookie:
"stat_uid=X4H4WkoxTRWUNm54AyoOAg==; path=/"
2009/06/11 22:29:41 [debug] 28280#0: *26232 HTTP/1.1 200 OK
2009/06/11 22:29:41 [debug] 28280#0: *26232 write new buf t:1 f:0
13DF1828, pos 13DF1828, size: 394 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 http write filter: l:0 f:0
s:394
2009/06/11 22:29:41 [debug] 28280#0: *26232 http file cache set header
2009/06/11 22:29:41 [debug] 28280#0: *26232 http cacheable: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream process
upstream
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe read upstream: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe preread: 2643
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 1:1128
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: 1128
2009/06/11 22:29:41 [debug] 28280#0: *26232 input buf #0
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 12E45770:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 1:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: 320
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 1:3776
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv() not ready (11:
Resource temporarily unavailable)
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: -2
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf in s:1 t:1 f:0
134507A0, pos 134508E5, size: 3771 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12E45770, pos 12E45770, size: 320 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 add cleanup: 13DF1B40
2009/06/11 22:29:41 [debug] 28280#0: *26232 hashed
path: /var/tmp/nginx/proxy/0/47/0171236470
2009/06/11 22:29:41 [debug] 28280#0: *26232 temp fd:3413
2009/06/11 22:29:41 [debug] 28280#0: *26232 write: 3413, 134507A0, 4096,
0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write downstream: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write busy: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write: out:13DF1AD4,
f:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 http output filter "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 1274F808:32768
2009/06/11 22:29:41 [debug] 28280#0: *26232 read: 3413, 1274F808, 3771,
325
2009/06/11 22:29:41 [debug] 28280#0: *26232 http postpone filter "...?"
13DF1BE4
2009/06/11 22:29:41 [debug] 28280#0: *26232 http gzip filter
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 13E612D0:270336
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip alloc: n:1 s:5824
a:8192 p:13E612D0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip alloc: n:32768 s:2
a:65536 p:13E632D0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip alloc: n:32768 s:2
a:65536 p:13E732D0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip alloc: n:32768 s:2
a:65536 p:13E832D0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip alloc: n:16384 s:4
a:65536 p:13E932D0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 13DF1BF4
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
ni:1274F808 ai:3771
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 1211E280:8192
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate in: ni:1274F808
no:1211E280 ai:3771 ao:8192 fl:0 redo:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate out: ni:127506C3
no:1211E280 ai:0 ao:8192 rc:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
pos:1274F808
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: 0 "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write busy: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write: out:00000000,
f:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe read upstream: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12E45770, pos 12E45770, size: 320 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
134507A0, pos 134507A0, size: 0 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer: 3184, old:
3499497591, new: 3499497623
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream request:
"...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream dummy handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream request:
"...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream process
upstream
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe read upstream: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 2:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: 7872
2009/06/11 22:29:41 [debug] 28280#0: *26232 input buf #1
2009/06/11 22:29:41 [debug] 28280#0: *26232 input buf #2
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 12D50168:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 1:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: 66
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 1:4030
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv() not ready (11:
Resource temporarily unavailable)
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: -2
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf in s:1 t:1 f:0
12E45770, pos 12E45770, size: 4096 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf in s:1 t:1 f:0
134507A0, pos 134507A0, size: 4096 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12D50168, pos 12D50168, size: 66 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write downstream: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write busy: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write: out:13DF1AD4,
f:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 http output filter "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 read: 3413, 1274F808, 4096,
4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 http postpone filter "...?"
13DF1BE4
2009/06/11 22:29:41 [debug] 28280#0: *26232 http gzip filter
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 13DF1CC8
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
ni:1274F808 ai:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate in: ni:1274F808
no:1211E280 ai:4096 ao:8192 fl:0 redo:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate out: ni:12750808
no:1211E280 ai:0 ao:8192 rc:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
pos:1274F808
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 read: 3413, 1274F808, 4096,
8192
2009/06/11 22:29:41 [debug] 28280#0: *26232 http postpone filter "...?"
13DF1BE4
2009/06/11 22:29:41 [debug] 28280#0: *26232 http gzip filter
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 13DF1CD0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
ni:1274F808 ai:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate in: ni:1274F808
no:1211E280 ai:4096 ao:8192 fl:0 redo:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate out: ni:12750808
no:1211E280 ai:0 ao:8192 rc:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
pos:1274F808
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: 0 "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write busy: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write: out:00000000,
f:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe read upstream: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12D50168, pos 12D50168, size: 66 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12E45770, pos 12E45770, size: 0 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
134507A0, pos 134507A0, size: 0 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer: 3184, old:
3499497591, new: 3499497624
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream request:
"...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream dummy handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream request:
"...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream process
upstream
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe read upstream: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 readv: 3:4096
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe recv chain: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12D50168, pos 12D50168, size: 66 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
12E45770, pos 12E45770, size: 0 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe buf free s:0 t:1 f:0
134507A0, pos 134507A0, size: 0 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 input buf #3
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 12E45770
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 134507A0
2009/06/11 22:29:41 [debug] 28280#0: *26232 write: 3413, 12D50168, 66,
12288
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write downstream: 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write downstream flush
out
2009/06/11 22:29:41 [debug] 28280#0: *26232 http output filter "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 read: 3413, 1274F808, 66,
12288
2009/06/11 22:29:41 [debug] 28280#0: *26232 http postpone filter "...?"
13DF1BE4
2009/06/11 22:29:41 [debug] 28280#0: *26232 http gzip filter
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 13DF1CE8
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
ni:1274F808 ai:66
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate in: ni:1274F808
no:1211E280 ai:66 ao:8192 fl:0 redo:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate out: ni:1274F84A
no:1211E280 ai:0 ao:8192 rc:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1BA8
pos:1274F808
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: 0 "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 pipe write downstream done
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer: 3184, old:
3499497591, new: 3499497625
2009/06/11 22:29:41 [debug] 28280#0: *26232 http file cache update
2009/06/11 22:29:41 [debug] 28280#0: *26232 http file cache rename:
"/var/tmp/nginx/proxy/0/47/0171236470" to
"/var/tmp/nginx/proxy_cache/7/4c/d834b44900b7d1770f6819308056b4c7"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream exit: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 finalize http upstream
request: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 finalize http proxy request
2009/06/11 22:29:41 [debug] 28280#0: *26232 free rr peer 2 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 close http upstream
connection: 3184
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer del: 3184:
3499497591
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream temp fd: 3413
2009/06/11 22:29:41 [debug] 28280#0: *26232 http upstream cache fd: -1
2009/06/11 22:29:41 [debug] 28280#0: *26232 http output filter "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http postpone filter "...?"
5AD7EA98
2009/06/11 22:29:41 [debug] 28280#0: *26232 http gzip filter
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in: 13DF1D24
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1CF0
ni:00000000 ai:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate in: ni:00000000
no:1211E280 ai:0 ao:8192 fl:4 redo:0
2009/06/11 22:29:41 [debug] 28280#0: *26232 deflate out: ni:00000000
no:1211ECDA ai:0 ao:5542 rc:1
2009/06/11 22:29:41 [debug] 28280#0: *26232 gzip in_buf:13DF1CF0
pos:00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 13E612D0
2009/06/11 22:29:41 [debug] 28280#0: *26232 http chunk: 10
2009/06/11 22:29:41 [debug] 28280#0: *26232 http chunk: 2658
2009/06/11 22:29:41 [debug] 28280#0: *26232 write old buf t:1 f:0
13DF1828, pos 13DF1828, size: 394 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 write new buf t:1 f:0
00000000, pos 13DF1DB4, size: 5 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 write new buf t:0 f:0
00000000, pos 11C3AC28, size: 10 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 write new buf t:1 f:0
1211E280, pos 1211E280, size: 2658 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 write new buf t:0 f:0
00000000, pos 11C2ED4D, size: 7 file: 0, size: 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 http write filter: l:1 f:1
s:3074
2009/06/11 22:29:41 [debug] 28280#0: *26232 http write filter limit 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 writev: 3074
2009/06/11 22:29:41 [debug] 28280#0: *26232 http write filter 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 copy filter: 0 "...?"
2009/06/11 22:29:41 [debug] 28280#0: *26232 http finalize request: 0,
"...?" 1
2009/06/11 22:29:41 [debug] 28280#0: *26232 set http keepalive handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 http close request
2009/06/11 22:29:41 [debug] 28280#0: *26232 http log handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 run cleanup: 13DF1B40
2009/06/11 22:29:41 [debug] 28280#0: *26232 file cleanup: fd:3413
2009/06/11 22:29:41 [debug] 28280#0: *26232 run cleanup: 13598D54
2009/06/11 22:29:41 [debug] 28280#0: *26232 close cached open
file: /var/tmp/nginx/proxy_cache/7/4c/d834b44900b7d1770f6819308056b4c7,
fd:1310, c:0, u:315, 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 run cleanup: 13598D04
2009/06/11 22:29:41 [debug] 28280#0: *26232 run cleanup: 135988F4
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 12D50168
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 1211E280
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 1274F808
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 00000000
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 13598310, unused: 3
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 13DF1640, unused: 1496
2009/06/11 22:29:41 [debug] 28280#0: *26232 event timer add: 1749:
75000:3499507625
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 12EA5C58
2009/06/11 22:29:41 [debug] 28280#0: *26232 free: 11CD0020
2009/06/11 22:29:41 [debug] 28280#0: *26232 hc free: 00000000 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 hc busy: 00000000 0
2009/06/11 22:29:41 [debug] 28280#0: *26232 tcp_nodelay
2009/06/11 22:29:41 [debug] 28280#0: *26232 post event 4CABB690
2009/06/11 22:29:41 [debug] 28280#0: *26232 delete posted event 4CABB690
2009/06/11 22:29:41 [debug] 28280#0: *26232 http keepalive handler
2009/06/11 22:29:41 [debug] 28280#0: *26232 malloc: 127A4F88:1024
2009/06/11 22:29:41 [debug] 28280#0: *26232 recv: fd:1749 -1 of 1024
2009/06/11 22:29:41 [debug] 28280#0: *26232 recv() not ready (11:
Resource temporarily unavailable)
2009/06/11 22:29:41 [debug] 28280#0: *26232 http keepalive handler
--
С уважением,
Волков Олег
More information about the nginx-ru
mailing list