Re: Re[2]: Постоянные обрывы коннектов
Anton Kuznetsov
maybe at arjlover.net
Tue Jul 14 23:24:48 MSD 2009
Ну раз уж взялся ковырять проблему хотел и обновиться.. Ну делать нечего,
пропатчил 0.7.61
Собственно возвращаясь к сути проблемы - на разных серверах все сильно по
разному.
Вот логи с сервера где проблему побороть не удалось.
FREEBSD 7.0-RELEASE
nginx version: nginx/0.7.61
Патч наложен.
конфиг:
limit_req_zone $binary_remote_addr zone=avi:10m rate=2r/m;
limit_req zone=avi burst=22;
Хочу чтобы нжинкс просто подвешивал все мульти-хотелки и не устраивал
перестрелку в 503.
После перезапуска с этим конфигом лог взрывается от строчек с "206 65536".
Например,
95.24.28.67 - - [14/Jul/2009:23:02:58 +0400] GET /multiki/ostrov.oshibok.avi
HTTP/1.0 1.400 ZZ 206 64877
2009/07/14 23:02:57 [debug] 89383#0: *969 accept: 95.24.28.67 fd:80
2009/07/14 23:02:57 [debug] 89383#0: *969 event timer add: 80:
30000:2057691717
2009/07/14 23:02:57 [debug] 89383#0: *969 kevent set event: 80: ft:-1
fl:0025
2009/07/14 23:02:57 [debug] 89383#0: *969 post event 284BBB7C
2009/07/14 23:02:57 [debug] 89383#0: *969 delete posted event 284BBB7C
2009/07/14 23:02:57 [debug] 89383#0: *969 malloc: 29004C00:660
2009/07/14 23:02:57 [debug] 89383#0: *969 malloc: 29005000:1024
2009/07/14 23:02:57 [debug] 89383#0: *969 malloc: 2900F000:4096
2009/07/14 23:02:57 [debug] 89383#0: *969 http process request line
2009/07/14 23:02:57 [debug] 89383#0: *969 recv: eof:0, avail:473, err:0
2009/07/14 23:02:57 [debug] 89383#0: *969 recv: fd:80 473 of 1024
2009/07/14 23:02:57 [debug] 89383#0: *969 http request line: "GET
/multiki/ostrov.oshibok.avi HTTP/1.0"
2009/07/14 23:02:57 [debug] 89383#0: *969 http uri:
"/multiki/ostrov.oshibok.avi"
2009/07/14 23:02:57 [debug] 89383#0: *969 http args: ""
2009/07/14 23:02:57 [debug] 89383#0: *969 http exten: "avi"
2009/07/14 23:02:57 [debug] 89383#0: *969 http process request header line
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "User-Agent: Download
Master"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Cookie: b=b;
__utma=24853414.223958894.1247162475.1247581104.1247592162.18;
__utmz=24853414.1247592162.18.17.utmccn=(referral)|utmcsr=film.arjlover.net|utmcct=/film/|utmcmd=referral;
__utmb=24853414; __utmc=24853414; hotlog=1"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Accept: */*"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Referer:
http://multiki.arjlover.net/info/ostrov.oshibok.avi.html"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Range:
bytes=116294291-"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Pragma: no-cache"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Cache-Control:
no-cache"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header: "Host:
inka.arjlover.net"
2009/07/14 23:02:57 [debug] 89383#0: *969 http header done
2009/07/14 23:02:57 [debug] 89383#0: *969 event timer del: 80: 2057691717
2009/07/14 23:02:57 [debug] 89383#0: *969 generic phase: 0
2009/07/14 23:02:57 [debug] 89383#0: *969 add cleanup: 2900F590
2009/07/14 23:02:57 [debug] 89383#0: *969 generic phase: 1
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: "/"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: "50x.html"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: "statn"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: "no.html"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: ~ "/php2/"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: ~ "/mrtg/.*"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: ~
"\.(html|php|pl)$"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: ~
"/(stat|session)/"
2009/07/14 23:02:57 [debug] 89383#0: *969 test location: ~
"^/(film|filmiki|multiki)/.*\.(avi|mpg|gif|jpg)$"
2009/07/14 23:02:57 [debug] 89383#0: *969 using configuration
"^/(film|filmiki|multiki)/.*\.(avi|mpg|gif|jpg)$"
2009/07/14 23:02:57 [debug] 89383#0: *969 http cl:-1 max:1048576
2009/07/14 23:02:57 [debug] 89383#0: *969 generic phase: 3
2009/07/14 23:02:57 [debug] 89383#0: *969 http script var
2009/07/14 23:02:57 [debug] 89383#0: *969 http script var: ""
2009/07/14 23:02:57 [debug] 89383#0: *969 http script if
2009/07/14 23:02:57 [debug] 89383#0: *969 http script if: false
2009/07/14 23:02:57 [debug] 89383#0: *969 http script var
2009/07/14 23:02:57 [debug] 89383#0: *969 http script var:
"/multiki/ostrov.oshibok.avi"
2009/07/14 23:02:57 [debug] 89383#0: *969 http script regex: "\.(gif|jpg)$"
2009/07/14 23:02:57 [notice] 89383#0: *969 "\.(gif|jpg)$" does not match
"/multiki/ostrov.oshibok.avi", client: 95.24.28.67, server:
inka.arjlover.net, request: "GET /multiki/ostrov.oshibok.avi HTTP/1.0",
host: "inka.arjlover.net", referrer: "
http://multiki.arjlover.net/info/ostrov.oshibok.avi.html"
2009/07/14 23:02:57 [debug] 89383#0: *969 http script if
2009/07/14 23:02:57 [debug] 89383#0: *969 http script if: false
2009/07/14 23:02:57 [debug] 89383#0: *969 post rewrite phase: 4
2009/07/14 23:02:57 [debug] 89383#0: *969 generic phase: 5
2009/07/14 23:02:57 [debug] 89383#0: *969 add cleanup: 2900F6A0
2009/07/14 23:02:57 [debug] 89383#0: *969 generic phase: 6
2009/07/14 23:02:57 [debug] 89383#0: *969 limit_req: -2 1.000
2009/07/14 23:02:57 [warn] 89383#0: *969 delaying request, excess: 1.000, by
zone "avi", client: 95.24.28.67, server: inka.arjlover.net, request: "GET
/multiki/ostrov.osh
ibok.avi HTTP/1.0", host: "inka.arjlover.net", referrer: "
http://multiki.arjlover.net/info/ostrov.oshibok.avi.html"
2009/07/14 23:02:57 [debug] 89383#0: *969 event timer add: 80:
1000:2057662719
2009/07/14 23:02:58 [debug] 89383#0: *969 event timer del: 80: 2057662719
2009/07/14 23:02:58 [debug] 89383#0: *969 http run request:
"/multiki/ostrov.oshibok.avi?"
2009/07/14 23:02:58 [debug] 89383#0: *969 limit_req delay
2009/07/14 23:02:58 [debug] 89383#0: *969 generic phase: 6
2009/07/14 23:02:58 [debug] 89383#0: *969 generic phase: 7
2009/07/14 23:02:58 [debug] 89383#0: *969 add cleanup: 2900F6BC
2009/07/14 23:02:58 [debug] 89383#0: *969 limit zone: A9BD7F57 2
2009/07/14 23:02:58 [debug] 89383#0: *969 access phase: 8
2009/07/14 23:02:58 [debug] 89383#0: *969 access phase: 9
2009/07/14 23:02:58 [debug] 89383#0: *969 post access phase: 10
2009/07/14 23:02:58 [debug] 89383#0: *969 content phase: 11
2009/07/14 23:02:58 [debug] 89383#0: *969 content phase: 12
2009/07/14 23:02:58 [debug] 89383#0: *969 content phase: 13
2009/07/14 23:02:58 [debug] 89383#0: *969 content phase: 14
2009/07/14 23:02:58 [debug] 89383#0: *969 content phase: 15
2009/07/14 23:02:58 [debug] 89383#0: *969 http filename:
"/data/multiki/ostrov.oshibok.avi"
2009/07/14 23:02:58 [debug] 89383#0: *969 add cleanup: 2900F6F4
2009/07/14 23:02:58 [debug] 89383#0: *969 http static fd: 156
2009/07/14 23:02:58 [debug] 89383#0: *969 http set discard body
2009/07/14 23:02:58 [debug] 89383#0: *969 HTTP/1.1 206 Partial Content
2009/07/14 23:02:58 [debug] 89383#0: *969 write new buf t:1 f:0 2900F890,
pos 2900F890, size: 293 file: 0, size: 0
2009/07/14 23:02:58 [debug] 89383#0: *969 http write filter: l:0 f:0 s:293
2009/07/14 23:02:58 [debug] 89383#0: *969 http output filter
"/multiki/ostrov.oshibok.avi?"
2009/07/14 23:02:58 [debug] 89383#0: *969 http range body buf: 0-232466432
2009/07/14 23:02:58 [debug] 89383#0: *969 copy filter:
"/multiki/ostrov.oshibok.avi?"
2009/07/14 23:02:58 [debug] 89383#0: *969 http postpone filter
"/multiki/ostrov.oshibok.avi?" 7FBFE910
2009/07/14 23:02:58 [debug] 89383#0: *969 write old buf t:1 f:0 2900F890,
pos 2900F890, size: 293 file: 0, size: 0
2009/07/14 23:02:58 [debug] 89383#0: *969 write new buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 116294291, size: 116172141
2009/07/14 23:02:58 [debug] 89383#0: *969 http write filter: l:1 f:0
s:116172434
2009/07/14 23:02:58 [debug] 89383#0: *969 http write filter limit 65536
2009/07/14 23:02:58 [debug] 89383#0: *969 tcp_nopush
2009/07/14 23:02:58 [debug] 89383#0: *969 sendfile() sent only 65170 bytes
(35: Resource temporarily unavailable)
2009/07/14 23:02:58 [debug] 89383#0: *969 sendfile: -1, @116294291
65170:68973
2009/07/14 23:02:58 [debug] 89383#0: *969 http write filter 2900FA08
2009/07/14 23:02:58 [debug] 89383#0: *969 copy filter: -2
"/multiki/ostrov.oshibok.avi?"
2009/07/14 23:02:58 [debug] 89383#0: *969 http finalize request: -2,
"/multiki/ostrov.oshibok.avi?" 1
2009/07/14 23:02:58 [debug] 89383#0: *969 event timer add: 80:
30000:2057692721
2009/07/14 23:02:58 [debug] 89383#0: *969 kevent set event: 80: ft:-2
fl:0025
2009/07/14 23:02:58 [debug] 89383#0: *969 http run request:
"/multiki/ostrov.oshibok.avi?"
2009/07/14 23:02:58 [debug] 89383#0: *969 http writer handler:
"/multiki/ostrov.oshibok.avi?"
2009/07/14 23:02:58 [info] 89383#0: *969 client timed out (60: Operation
timed out) while sending response to client, client: 95.24.28.67, server:
inka.arjlover.net, request: "GET /multiki/ostrov.oshibok.avi HTTP/1.0",
host: "inka.arjlover.net", referrer: "
http://multiki.arjlover.net/info/ostrov.oshibok.avi.html"
2009/07/14 23:02:58 [debug] 89383#0: *969 http finalize request: 408,
"/multiki/ostrov.oshibok.avi?" 1
2009/07/14 23:02:58 [debug] 89383#0: *969 http close request
2009/07/14 23:02:58 [debug] 89383#0: *969 http log handler
2009/07/14 23:02:58 [debug] 89383#0: *969 http geo started: 95.24.28.67
2009/07/14 23:02:58 [debug] 89383#0: *969 http geo: ZZ
2009/07/14 23:02:58 [debug] 89383#0: *969 run cleanup: 2900F6F4
2009/07/14 23:02:58 [debug] 89383#0: *969 file cleanup: fd:156
2009/07/14 23:02:58 [debug] 89383#0: *969 run cleanup: 2900F6BC
2009/07/14 23:02:58 [debug] 89383#0: *969 free: 2900F000, unused: 1390
2009/07/14 23:02:58 [debug] 89383#0: *969 close http connection: 80
2009/07/14 23:02:58 [debug] 89383#0: *969 event timer del: 80: 2057692721
2009/07/14 23:02:58 [debug] 89383#0: *969 free: 29005000
2009/07/14 23:02:58 [debug] 89383#0: *969 free: 29004C00
2009/07/14 23:02:58 [debug] 89383#0: *969 free: 284DBF00, unused: 56
Какой у него timed out?? Сервер запущен в 55 секунд, в 58 коннект уже устал?
Есть еще пара дебагов на этот айпи, где он пытается устроить долбежку и
медленно получает 503. Там вроде все верно. Непонятно что случилось с этим
"основным" коннектом.
Антон.
2009/7/14 Михаил Монашёв <postmaster at softsearch.ru>
> Здравствуйте, Антон.
>
> А зачем Вы гонитесь за последними версиями? Если всё работает, то
> делать этого не стоит.
>
> AK> Я правильно понимаю, что старый патч не накатывается на 0.8.5? :)
>
> --
>
> С уважением,
> Михаил Монашёв, SoftSearch.ru
> mailto:postmaster at softsearch.ru
> ICQ# 166233339
> http://michael.mindmix.ru/
> Без бэкапа по жизни.
>
>
>
--
Best regards,
Anton Kuznetsov.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://nginx.org/pipermail/nginx-ru/attachments/20090714/3eef9c34/attachment.html>
More information about the nginx-ru
mailing list