Re: возврат 404 полученного от fastcgi

[Volodymyr Kostyrko]

28.07.2010 19:36, Igor Sysoev написав(ла):

> Нужен отладочный лог запроса, там видно, что пришло от fastcgi.

2010/07/29 00:18:21 [debug] 28763#0: *1 malloc: 0000000801236800:1024
2010/07/29 00:18:21 [debug] 28763#0: *1 malloc: 0000000801262000:4096
2010/07/29 00:18:21 [debug] 28763#0: *1 http process request line
2010/07/29 00:18:21 [debug] 28763#0: *1 recv: eof:0, avail:94, err:0
2010/07/29 00:18:21 [debug] 28763#0: *1 recv: fd:21 94 of 1024
2010/07/29 00:18:21 [debug] 28763#0: *1 http request line: "GET 
/index.php HTTP/1.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 http uri: "/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http args: ""
2010/07/29 00:18:21 [debug] 28763#0: *1 http exten: "php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http process request header line
2010/07/29 00:18:21 [debug] 28763#0: *1 http header: "Host: somesite"
2010/07/29 00:18:21 [debug] 28763#0: *1 http header: "User-Agent: fetch 
libfetch/2.0"
2010/07/29 00:18:21 [debug] 28763#0: *1 http header: "Connection: close"
2010/07/29 00:18:21 [debug] 28763#0: *1 http header done
2010/07/29 00:18:21 [debug] 28763#0: *1 event timer del: 21: 1280351961772
2010/07/29 00:18:21 [debug] 28763#0: *1 generic phase: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 add cleanup: 0000000801262A88
2010/07/29 00:18:21 [debug] 28763#0: *1 generic phase: 1
2010/07/29 00:18:21 [debug] 28763#0: *1 test location: ~ ".*\.php$"
2010/07/29 00:18:21 [debug] 28763#0: *1 using configuration ".*\.php$"
2010/07/29 00:18:21 [debug] 28763#0: *1 http cl:-1 max:1048576
2010/07/29 00:18:21 [debug] 28763#0: *1 generic phase: 3
2010/07/29 00:18:21 [debug] 28763#0: *1 post rewrite phase: 4
2010/07/29 00:18:21 [debug] 28763#0: *1 generic phase: 5
2010/07/29 00:18:21 [debug] 28763#0: *1 add cleanup: 0000000801262AC0
2010/07/29 00:18:21 [debug] 28763#0: *1 generic phase: 6
2010/07/29 00:18:21 [debug] 28763#0: *1 generic phase: 7
2010/07/29 00:18:21 [debug] 28763#0: *1 access phase: 8
2010/07/29 00:18:21 [debug] 28763#0: *1 access phase: 9
2010/07/29 00:18:21 [debug] 28763#0: *1 post access phase: 10
2010/07/29 00:18:21 [debug] 28763#0: *1 http init upstream, client timer: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 kevent set event: 21: ft:-2 fl:0025
2010/07/29 00:18:21 [debug] 28763#0: *1 malloc: 0000000801256000:4096
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "QUERY_STRING"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "QUERY_STRING: "
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "REQUEST_METHOD"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "GET"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "REQUEST_METHOD: GET"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "CONTENT_TYPE"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "CONTENT_TYPE: "
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "CONTENT_LENGTH"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "CONTENT_LENGTH: "
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SCRIPT_NAME"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SCRIPT_NAME: 
/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "REQUEST_URI"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "REQUEST_URI: 
/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "DOCUMENT_URI"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "DOCUMENT_URI: 
/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "DOCUMENT_ROOT"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "/home/www"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "DOCUMENT_ROOT: 
/home/www"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SERVER_PROTOCOL"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "HTTP/1.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SERVER_PROTOCOL: 
HTTP/1.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: 
"GATEWAY_INTERFACECGI/1.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: 
"GATEWAY_INTERFACE: CGI/1.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SERVER_SOFTWARE"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "nginx/"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "0.7.67"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SERVER_SOFTWARE: 
nginx/0.7.67"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "REMOTE_ADDR"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "127.0.0.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "REMOTE_ADDR: 
127.0.0.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "REMOTE_PORT"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "17865"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "REMOTE_PORT: 17865"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SERVER_ADDR"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "127.0.0.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SERVER_ADDR: 
127.0.0.1"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SERVER_PORT"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "80"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SERVER_PORT: 80"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SERVER_NAME"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "somesite"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SERVER_NAME: 
somesite"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: 
"REDIRECT_STATUS200"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "REDIRECT_STATUS: 
200"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "SCRIPT_FILENAME"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script copy: "/home/www"
2010/07/29 00:18:21 [debug] 28763#0: *1 http script var: "/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 fastcgi param: "SCRIPT_FILENAME: 
/home/www/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http cleanup add: 0000000801262FE0
2010/07/29 00:18:21 [debug] 28763#0: *1 get rr peer, try: 1
2010/07/29 00:18:21 [debug] 28763#0: *1 socket 23
2010/07/29 00:18:21 [debug] 28763#0: *1 connect to 
unix:/tmp/.fastcgi.php.www/socket, fd:23 #2
2010/07/29 00:18:21 [debug] 28763#0: *1 kevent set event: 23: ft:-1 fl:0025
2010/07/29 00:18:21 [debug] 28763#0: *1 connected
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream connect: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream send request
2010/07/29 00:18:21 [debug] 28763#0: *1 chain writer buf fl:0 s:552
2010/07/29 00:18:21 [debug] 28763#0: *1 chain writer in: 0000000801256318
2010/07/29 00:18:21 [debug] 28763#0: *1 writev: 552 of 552
2010/07/29 00:18:21 [debug] 28763#0: *1 chain writer out: 0000000000000000
2010/07/29 00:18:21 [debug] 28763#0: *1 event timer add: 23: 
60000:1280351961773
2010/07/29 00:18:21 [debug] 28763#0: *1 http run request: "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream check client, 
write event:1, "/index.php"
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream request: "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream process header
2010/07/29 00:18:21 [debug] 28763#0: *1 malloc: 0000000801257000:4096
2010/07/29 00:18:21 [debug] 28763#0: *1 recv: eof:0, avail:112, err:0
2010/07/29 00:18:21 [debug] 28763#0: *1 recv: fd:23 112 of 4096
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 01
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 06
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 01
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 58
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record length: 88
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi parser: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi header: 
"X-Powered-By: PHP/5.3.2"

Оп-ля?

2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi parser: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi header: 
"Content-type: text/html"
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi parser: 1
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi header done
2010/07/29 00:18:21 [debug] 28763#0: *1 HTTP/1.1 200 OK
Server: nginx/0.7.67
Date: Wed, 28 Jul 2010 21:18:21 GMT
Content-Type: text/html
Connection: close
X-Powered-By: PHP/5.3.2

2010/07/29 00:18:21 [debug] 28763#0: *1 write new buf t:1 f:0 
0000000801256558, pos 0000000801256558, size: 147 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http write filter: l:0 f:0 s:147
2010/07/29 00:18:21 [debug] 28763#0: *1 http cacheable: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream process upstream
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe read upstream: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe preread: 27
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe buf free s:0 t:1 f:0 
0000000801257000, pos 0000000801257055, size: 27 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe write downstream: 1
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe write busy: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe write: 
out:0000000000000000, f:0
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe read upstream: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe buf free s:0 t:1 f:0 
0000000801257000, pos 0000000801257055, size: 27 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 event timer: 23, old: 
1280351961773, new: 1280351961787
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream request: "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream process upstream
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe read upstream: 1
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe buf free s:0 t:1 f:0 
0000000801257000, pos 0000000801257055, size: 27 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 input buf #0 0000000801257055
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 01
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 03
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 01
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 08
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record byte: 00
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi record length: 8
2010/07/29 00:18:21 [debug] 28763#0: *1 http fastcgi sent end request
2010/07/29 00:18:21 [debug] 28763#0: *1 input buf 0000000801257055 11
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe write downstream: 1
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe write downstream flush in
2010/07/29 00:18:21 [debug] 28763#0: *1 http output filter "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 copy filter: "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 http postpone filter 
"/index.php?" 0000000801256740
2010/07/29 00:18:21 [debug] 28763#0: *1 write old buf t:1 f:0 
0000000801256558, pos 0000000801256558, size: 147 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 write new buf t:1 f:0 
0000000801257000, pos 0000000801257055, size: 11 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http write filter: l:0 f:0 s:158
2010/07/29 00:18:21 [debug] 28763#0: *1 copy filter: 0 "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 pipe write downstream done
2010/07/29 00:18:21 [debug] 28763#0: *1 event timer: 23, old: 
1280351961773, new: 1280351961789
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream exit: 0000000000000000
2010/07/29 00:18:21 [debug] 28763#0: *1 finalize http upstream request: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 finalize http fastcgi request
2010/07/29 00:18:21 [debug] 28763#0: *1 free rr peer 1 0
2010/07/29 00:18:21 [debug] 28763#0: *1 close http upstream connection: 23
2010/07/29 00:18:21 [debug] 28763#0: *1 event timer del: 23: 1280351961773
2010/07/29 00:18:21 [debug] 28763#0: *1 http upstream temp fd: -1
2010/07/29 00:18:21 [debug] 28763#0: *1 http output filter "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 copy filter: "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 http postpone filter 
"/index.php?" 00007FFFFFFFE800
2010/07/29 00:18:21 [debug] 28763#0: *1 write old buf t:1 f:0 
0000000801256558, pos 0000000801256558, size: 147 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 write old buf t:1 f:0 
0000000801257000, pos 0000000801257055, size: 11 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 write new buf t:0 f:0 
0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2010/07/29 00:18:21 [debug] 28763#0: *1 http write filter: l:1 f:0 s:158
2010/07/29 00:18:21 [debug] 28763#0: *1 http write filter limit 0
2010/07/29 00:18:21 [debug] 28763#0: *1 writev: 158 of 158
2010/07/29 00:18:21 [debug] 28763#0: *1 http write filter 0000000000000000
2010/07/29 00:18:21 [debug] 28763#0: *1 copy filter: 0 "/index.php?"
2010/07/29 00:18:21 [debug] 28763#0: *1 http finalize request: 0, 
"/index.php?" 1
2010/07/29 00:18:21 [debug] 28763#0: *1 http close request
2010/07/29 00:18:21 [debug] 28763#0: *1 http log handler
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 0000000801257000
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 0000000801262000, unused: 8
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 0000000801256000, unused: 1892
2010/07/29 00:18:21 [debug] 28763#0: *1 close http connection: 21
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 0000000801236800
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 00000008012A2700
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 0000000801208300, unused: 8
2010/07/29 00:18:21 [debug] 28763#0: *1 free: 0000000801208400, unused: 112

Походу да, вопрос в был FastCGI. Перешёл с php-cgi на php-fpm в связи с 
появлением версии 5.3.3 в портах - заработало.

-- 
Sphinx of black quartz judge my vow.