Nginx-ru mailing list archive (nginx-ru@sysoev.ru)
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
error 40 на запросах с "%u041A"
Попался 1 странный клиент у которого uri запросы выглядит как
http://domain.name/admin/statistic/index/name/%u041A%u0443%u0437%u044F%20
%u0432%u0430%u0440%u0435%u0436%u043A%u0438/
на который nginx рапортует
400 Bad Request
nginx/1.0.0
error_log ничего не помог понять почему выдаётся 400 ошибка.
В аццес-логе лишь
[05/May/2011:16:03:49 +0400] "GET
/admin/statistic/index/name/%u041A%u0443%u0437%u044F%20%u0432%u0430%u0440 %u0435%u0436%u043A%u0438%u043D/
HTTP/1.1" 400 173 "-" "-"
nginx стандартный из дебиана
nginx -V
nginx: nginx version: nginx/1.0.0
nginx: TLS SNI support enabled
nginx: configure arguments: --conf-path=/etc/nginx/nginx.conf
--error-log-path=/var/log/nginx/error.log
--http-client-body-temp-path=/var/lib/nginx/body
--http-fastcgi-temp-path=/var/lib/nginx/fastcgi
--http-log-path=/var/log/nginx/access.log
--http-proxy-temp-path=/var/lib/nginx/proxy
--http-scgi-temp-path=/var/lib/nginx/scgi
--http-uwsgi-temp-path=/var/lib/nginx/uwsgi
--lock-path=/var/lock/nginx.lock --pid-path=/var/run/nginx.pid
--with-debug --with-http_addition_module --with-http_dav_module
--with-http_geoip_module --with-http_gzip_static_module
--with-http_image_filter_module --with-http_realip_module
--with-http_stub_status_module --with-http_ssl_module
--with-http_sub_module --with-http_xslt_module --with-ipv6
--with-sha1=/usr/include/openssl --with-md5=/usr/include/openssl
--with-mail --with-mail_ssl_module
--add-module=/var/www/home/stalker/src/nginx/nginx-1.0.0/debian/modules/nginx-echo
--add-module=/var/www/home/stalker/src/nginx/nginx-1.0.0/debian/modules/nginx-upstream-fair
2011/05/05 17:02:00 [debug] 21212#0: *94818 event timer del: 31: 1304600580890
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 rewrite phase: 1
2011/05/05 17:02:00 [debug] 21212#0: *94818 test location: "/"
2011/05/05 17:02:00 [debug] 21212#0: *94818 test location: ~
"^.+\.(jpg|jpeg|gif|png|bmp|svg|js|css|mp3|ogg|mpe?g|avi|mov|zip|gz|bz2?|rar|mkv|ico|exe|deb|rpm|7z)$"
2011/05/05 17:02:00 [debug] 21212#0: *94818 using configuration
"^.+\.(jpg|jpeg|gif|png|bmp|svg|js|css|mp3|ogg|mpe?g|avi|mov|zip|gz|bz2?|rar|mkv|ico|exe|deb|rpm|7z)$"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http cl:-1 max:314572800
2011/05/05 17:02:00 [debug] 21212#0: *94818 rewrite phase: 3
2011/05/05 17:02:00 [debug] 21212#0: *94818 post rewrite phase: 4
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 5
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 6
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 7
2011/05/05 17:02:00 [debug] 21212#0: *94818 access phase: 8
2011/05/05 17:02:00 [debug] 21212#0: *94818 access phase: 9
2011/05/05 17:02:00 [debug] 21212#0: *94818 post access phase: 10
2011/05/05 17:02:00 [debug] 21212#0: *94818 try files phase: 11
2011/05/05 17:02:00 [debug] 21212#0: *94818 content phase: 12
2011/05/05 17:02:00 [debug] 21212#0: *94818 content phase: 13
2011/05/05 17:02:00 [debug] 21212#0: *94818 content phase: 14
2011/05/05 17:02:00 [debug] 21212#0: *94818 content phase: 15
2011/05/05 17:02:00 [debug] 21212#0: *94818 content phase: 16
2011/05/05 17:02:00 [debug] 21212#0: *94818 http filename:
"/home/hosting_goodwill2/projects/version1/htdocs/favicon.ico"
2011/05/05 17:02:00 [debug] 21212#0: *94818 add cleanup: 0000000002C0A850
2011/05/05 17:02:00 [error] 21212#0: *94818 open()
"/home/hosting_goodwill2/projects/version1/htdocs/favicon.ico" failed (2: No
such file or directory), client: 91.144.144.41, server:
version1.goodwill2.locum.ru, request: "GET /favicon.ico HTTP/1.1", host:
"eostrovsky.ru"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http finalize request: 404,
"/favicon.ico?" a:1, c:1
2011/05/05 17:02:00 [debug] 21212#0: *94818 http special response: 404,
"/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 test location: "@fallback"
2011/05/05 17:02:00 [debug] 21212#0: *94818 using location: @fallback
"/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 rewrite phase: 3
2011/05/05 17:02:00 [debug] 21212#0: *94818 post rewrite phase: 4
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 5
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 6
2011/05/05 17:02:00 [debug] 21212#0: *94818 generic phase: 7
2011/05/05 17:02:00 [debug] 21212#0: *94818 access phase: 8
2011/05/05 17:02:00 [debug] 21212#0: *94818 access phase: 9
2011/05/05 17:02:00 [debug] 21212#0: *94818 post access phase: 10
2011/05/05 17:02:00 [debug] 21212#0: *94818 try files phase: 11
2011/05/05 17:02:00 [debug] 21212#0: *94818 http init upstream, client timer: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 epoll add event: fd:31 op:3
ev:80000005
2011/05/05 17:02:00 [debug] 21212#0: *94818 posix_memalign:
000000000225D730:4096 @16
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script copy: "Host: "
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script var: "eostrovsky.ru"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script copy: "
"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script copy: "X-Forwarded-For:
"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script var: "91.144.144.41"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script copy: "
"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http script copy: "Connection: close
"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Accept: */*"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "User-Agent:
Mozilla/5.0 (Windows NT 5.1) AppleWebKit/534.24 (KHTML, like Gecko)
Chrome/11.0.696.60 Safari/534.24"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header:
"Accept-Encoding: gzip,deflate,sdch"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header:
"Accept-Language: ru-RU,ru;q=0.8,en-US;q=0.6,en;q=0.4"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Accept-Charset:
windows-1251,utf-8;q=0.7,*;q=0.3"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header:
"GET /favicon.ico HTTP/1.0
Host: eostrovsky.ru
X-Forwarded-For: 91.144.144.41
Connection: close
Accept: */*
User-Agent: Mozilla/5.0 (Windows NT 5.1) AppleWebKit/534.24 (KHTML, like Gecko)
Chrome/11.0.696.60 Safari/534.24
Accept-Encoding: gzip,deflate,sdch
Accept-Language: ru-RU,ru;q=0.8,en-US;q=0.6,en;q=0.4
Accept-Charset: windows-1251,utf-8;q=0.7,*;q=0.3
"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http cleanup add: 000000000225D930
2011/05/05 17:02:00 [debug] 21212#0: *94818 get rr peer, try: 1
2011/05/05 17:02:00 [debug] 21212#0: *94818 socket 36
2011/05/05 17:02:00 [debug] 21212#0: *94818 epoll add connection: fd:36
ev:80000005
2011/05/05 17:02:00 [debug] 21212#0: *94818 connect to 127.0.0.1:80, fd:36
#94819
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream connect: -2
2011/05/05 17:02:00 [debug] 21212#0: *94818 event timer add: 36:
300000:1304600820890
2011/05/05 17:02:00 [debug] 21212#0: *94818 http finalize request: -4,
"/favicon.ico?" a:1, c:3
2011/05/05 17:02:00 [debug] 21212#0: *94818 http request count:3 blk:0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http finalize request: -4,
"/favicon.ico?" a:1, c:2
2011/05/05 17:02:00 [debug] 21212#0: *94818 http request count:2 blk:0
2011/05/05 17:02:00 [debug] 21212#0: *94818 post event 00007FEC0AD00CA8
2011/05/05 17:02:00 [debug] 21212#0: *94818 post event 00007FEC0AD01530
2011/05/05 17:02:00 [debug] 21212#0: *94818 delete posted event 00007FEC0AD01530
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream request:
"/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream send request handler
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream send request
2011/05/05 17:02:00 [debug] 21212#0: *94818 chain writer buf fl:1 s:368
2011/05/05 17:02:00 [debug] 21212#0: *94818 chain writer in: 000000000225D968
2011/05/05 17:02:00 [debug] 21212#0: *94818 writev: 368
2011/05/05 17:02:00 [debug] 21212#0: *94818 chain writer out: 0000000000000000
2011/05/05 17:02:00 [debug] 21212#0: *94818 event timer del: 36: 1304600820890
2011/05/05 17:02:00 [debug] 21212#0: *94818 event timer add: 36:
300000:1304600820890
2011/05/05 17:02:00 [debug] 21212#0: *94818 delete posted event 00007FEC0AD00CA8
2011/05/05 17:02:00 [debug] 21212#0: *94818 http run request: "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream check client, write
event:1, "/favicon.ico"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream recv(): -1 (11:
Resource temporarily unavailable)
2011/05/05 17:02:00 [debug] 21212#0: *94818 post event 00007FEC0B042530
2011/05/05 17:02:00 [debug] 21212#0: *94818 post event 00007FEC0AD01530
2011/05/05 17:02:00 [debug] 21212#0: *94818 delete posted event 00007FEC0AD01530
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream request:
"/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream dummy handler
2011/05/05 17:02:00 [debug] 21212#0: *94818 delete posted event 00007FEC0B042530
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream request:
"/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream process header
2011/05/05 17:02:00 [debug] 21212#0: *94818 malloc: 0000000003633290:32768
2011/05/05 17:02:00 [debug] 21212#0: *94818 recv: fd:36 1152 of 32768
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy status 404 "404 Not
Found"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Date: Thu, 05
May 2011 13:02:00 GMT"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Server:
Apache/2.2.16 (Debian) mod_wsgi/3.3 Python/2.6.6 Phusion_Passenger/3.0.5
mod_perl/2.0.4 Perl/v5.10.1"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "X-Powered-By:
PHP/5.3.3-7+squeeze1"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Vary:
Accept-Encoding"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header:
"Content-Encoding: gzip"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Content-Length:
811"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Connection:
close"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header: "Content-Type:
text/html; charset=iso-8859-1"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http proxy header done
2011/05/05 17:02:00 [debug] 21212#0: *94818 xslt filter header
2011/05/05 17:02:00 [debug] 21212#0: *94818 HTTP/1.1 404 Not Found
Server: nginx/1.0.0
Date: Thu, 05 May 2011 13:02:00 GMT
Content-Type: text/html; charset=iso-8859-1
Connection: close
X-Powered-By: PHP/5.3.3-7+squeeze1
Vary: Accept-Encoding
Content-Encoding: gzip
Content-Length: 811
2011/05/05 17:02:00 [debug] 21212#0: *94818 write new buf t:1 f:0
000000000225DCE0, pos 000000000225DCE0, size: 252 file: 0, size: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http write filter: l:0 f:0 s:252
2011/05/05 17:02:00 [debug] 21212#0: *94818 http upstream process non buffered
downstream
2011/05/05 17:02:00 [debug] 21212#0: *94818 http output filter "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http copy filter: "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 image filter
2011/05/05 17:02:00 [debug] 21212#0: *94818 xslt filter body
2011/05/05 17:02:00 [debug] 21212#0: *94818 http postpone filter
"/favicon.ico?" 000000000225DDF0
2011/05/05 17:02:00 [debug] 21212#0: *94818 write old buf t:1 f:0
000000000225DCE0, pos 000000000225DCE0, size: 252 file: 0, size: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 write new buf t:0 f:0
0000000000000000, pos 00000000036333E5, size: 811 file: 0, size: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http write filter: l:0 f:1 s:1063
2011/05/05 17:02:00 [debug] 21212#0: *94818 http write filter limit 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 writev: 1063
2011/05/05 17:02:00 [debug] 21212#0: *94818 http write filter 0000000000000000
2011/05/05 17:02:00 [debug] 21212#0: *94818 http copy filter: 0 "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 finalize http upstream request: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 finalize http proxy request
2011/05/05 17:02:00 [debug] 21212#0: *94818 free rr peer 1 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 close http upstream connection: 36
2011/05/05 17:02:00 [debug] 21212#0: *94818 event timer del: 36: 1304600820890
2011/05/05 17:02:00 [debug] 21212#0: *94818 reusable connection: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http output filter "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http copy filter: "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 image filter
2011/05/05 17:02:00 [debug] 21212#0: *94818 xslt filter body
2011/05/05 17:02:00 [debug] 21212#0: *94818 http postpone filter
"/favicon.ico?" 00007FFF098FCFA0
2011/05/05 17:02:00 [debug] 21212#0: *94818 write new buf t:0 f:0
0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http write filter: l:1 f:0 s:0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http copy filter: 0 "/favicon.ico?"
2011/05/05 17:02:00 [debug] 21212#0: *94818 http finalize request: 0,
"/favicon.ico?" a:1, c:1
2011/05/05 17:02:00 [debug] 21212#0: *94818 http request count:1 blk:0
2011/05/05 17:02:00 [debug] 21212#0: *94818 http close request
2011/05/05 17:02:00 [debug] 21212#0: *94818 http log handler
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 0000000003633290
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 0000000002C09DC0, unused: 8
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 000000000225D730, unused: 2072
2011/05/05 17:02:00 [debug] 21212#0: *94818 close http connection: 31
2011/05/05 17:02:00 [debug] 21212#0: *94818 reusable connection: 0
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 00000000007FCB90
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 00000000007FC670
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 000000000354CE10, unused: 8
2011/05/05 17:02:00 [debug] 21212#0: *94818 free: 000000000354CF20, unused: 128
_______________________________________________
nginx-ru mailing list
nginx-ru@xxxxxxxxx
http://nginx.org/mailman/listinfo/nginx-ru
|