Nginx-ru mailing list archive (nginx-ru@sysoev.ru)
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
Re: Failed opening required или что nginx пе редает на FastCGI?
Собрал версию 0.7.61 решив не доверять версии из пакета, руками
переписал все конфиги, задал абсолютные пути, но ситуация не
изменилась.
Снифиг ни чего не дал. В дампе выданном dumpcap-ом я вижу как приходит
запрос к nginx и как он на него отвечает, но ни каких попыток
соединения с php-fpm. Хотя на сколько я помню в том же Wireshark-е
localhost адреса отснифить нельзя поэтому везде в конфиге я прописывал
реальный IP сервера.
При просмотре дампа меня вот что смутило. Несмотря на то, что через
конфиг gzip выключен, ответ от сервера все равно приходит с
Content-Encoding: gzip (смотрел через FireBug, да и по дампе видно
"Content-encoded entity body (gzip): 513 bytes -> 773 bytes"). И
второе, пакет в котором приходит 200-ый ответ от сервера приходит
битым с такой вот формулировкой: "Checksum: 0xc8af [incorrect, should
be 0x8d47 (maybe caused by "TCP checksum offload"?)]" (так Wireshark
пишет). Уж не проблемы ли это с сетевым интерейсом на сервере...
Дебаг лог получил. Конфигурация для php сейчас такая:
location ~ \.php$ {
fastcgi_pass ***:9001;
fastcgi_index index.php;
root /home/www/alekciy/site.ru;
include /usr/local/etc/nginx/fastcgi_params;
fastcgi_param SCRIPT_FILENAME
/home/www/alekciy/alekciy.ru$fastcgi_script_name;
}
В дебаглоге вижу:
2009/07/15 05:50:04 [debug] 30568#0: *1 test location: "/"
2009/07/15 05:50:04 [debug] 30568#0: *1 test location: ~ "\.php$"
2009/07/15 05:50:04 [debug] 30568#0: *1 using configuration "\.php$"
2009/07/15 05:50:04 [debug] 30568#0: *1 http cl:-1 max:1048576
2009/07/15 05:50:04 [debug] 30568#0: *1 generic phase: 2
2009/07/15 05:50:04 [debug] 30568#0: *1 post rewrite phase: 3
2009/07/15 05:50:04 [debug] 30568#0: *1 generic phase: 4
2009/07/15 05:50:04 [debug] 30568#0: *1 generic phase: 5
2009/07/15 05:50:04 [debug] 30568#0: *1 access phase: 6
2009/07/15 05:50:04 [debug] 30568#0: *1 access phase: 7
2009/07/15 05:50:04 [debug] 30568#0: *1 post access phase: 8
2009/07/15 05:50:04 [debug] 30568#0: *1 http init upstream, client timer: 0
2009/07/15 05:50:04 [debug] 30568#0: *1 epoll add event: fd:8 op:3 ev:80000005
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "QUERY_STRING"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "QUERY_STRING: "
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "REQUEST_METHOD"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "GET"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "REQUEST_METHOD: GET"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "CONTENT_TYPE"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "CONTENT_TYPE: "
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "CONTENT_LENGTH"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "CONTENT_LENGTH: "
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SCRIPT_NAME"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "SCRIPT_NAME:
/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "REQUEST_URI"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "REQUEST_URI:
/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "DOCUMENT_URI"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "DOCUMENT_URI:
/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "DOCUMENT_ROOT"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var:
"/home/www/alekciy/site.ru"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "DOCUMENT_ROOT:
/home/www/alekciy/site.ru"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SERVER_PROTOCOL"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "HTTP/1.1"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param:
"SERVER_PROTOCOL: HTTP/1.1"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy:
"GATEWAY_INTERFACECGI/1.1"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param:
"GATEWAY_INTERFACE: CGI/1.1"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SERVER_SOFTWARE"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "nginx/"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "0.7.61"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param:
"SERVER_SOFTWARE: nginx/0.7.61"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "REMOTE_ADDR"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "95.79.237.40"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "REMOTE_ADDR:
95.79.237.40"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "REMOTE_PORT"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "1098"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "REMOTE_PORT: 1098"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SERVER_ADDR"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "***"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "SERVER_ADDR: ***"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SERVER_PORT"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "80"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "SERVER_PORT: 80"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SERVER_NAME"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "site.ru"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "SERVER_NAME: site.ru"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "REDIRECT_STATUS200"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param: "REDIRECT_STATUS: 200"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy: "SCRIPT_FILENAME"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script copy:
"/home/www/alekciy/site.ru"
2009/07/15 05:50:04 [debug] 30568#0: *1 http script var: "/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 fastcgi param:
"SCRIPT_FILENAME: /home/www/alekciy/site.ru/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 http cleanup add: 080F0384
2009/07/15 05:50:04 [debug] 30568#0: *1 get rr peer, try: 1
2009/07/15 05:50:04 [debug] 30568#0: *1 socket 11
2009/07/15 05:50:04 [debug] 30568#0: *1 epoll add connection: fd:11 ev:80000005
2009/07/15 05:50:04 [debug] 30568#0: *1 connect to ***:9001, fd:11 #2
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream connect: -2
2009/07/15 05:50:04 [debug] 30568#0: *1 event timer add: 11: 60000:2082148222
2009/07/15 05:50:04 [debug] 30568#0: timer delta: 3
2009/07/15 05:50:04 [debug] 30568#0: posted events 00000000
2009/07/15 05:50:04 [debug] 30568#0: worker cycle
2009/07/15 05:50:04 [debug] 30568#0: epoll timer: 60000
2009/07/15 05:50:04 [debug] 30568#0: epoll: fd:11 ev:0004 d:080F77AC
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream request: "/php_info.php?"
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream send request handler
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream send request
2009/07/15 05:50:04 [debug] 30568#0: *1 chain writer buf fl:0 s:1120
2009/07/15 05:50:04 [debug] 30568#0: *1 chain writer in: 080F03A0
2009/07/15 05:50:04 [debug] 30568#0: *1 writev: 1120
2009/07/15 05:50:04 [debug] 30568#0: *1 chain writer out: 00000000
2009/07/15 05:50:04 [debug] 30568#0: *1 event timer del: 11: 2082148222
2009/07/15 05:50:04 [debug] 30568#0: *1 event timer add: 11: 60000:2082148222
2009/07/15 05:50:04 [debug] 30568#0: epoll: fd:8 ev:0004 d:080F7750
2009/07/15 05:50:04 [debug] 30568#0: *1 http run request: "/php_info.php?"
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream check client,
write event:1, "/php_info.php"
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream recv(): -1 (11:
Resource temporarily unavailable)
2009/07/15 05:50:04 [debug] 30568#0: timer delta: 0
2009/07/15 05:50:04 [debug] 30568#0: posted events 00000000
2009/07/15 05:50:04 [debug] 30568#0: worker cycle
2009/07/15 05:50:04 [debug] 30568#0: epoll timer: 60000
2009/07/15 05:50:04 [debug] 30568#0: epoll: fd:11 ev:0005 d:080F77AC
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream request: "/php_info.php?"
2009/07/15 05:50:04 [debug] 30568#0: *1 http upstream process header
2009/07/15 05:50:04 [debug] 30568#0: *1 malloc: 080F0690:4096
2009/07/15 05:50:04 [debug] 30568#0: *1 recv: fd:11 472 of 4096
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 01
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 07
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 00
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 01
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 00
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: B6
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 02
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 00
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record length: 182
2009/07/15 05:50:04 [error] 30568#0: *1 FastCGI sent in stderr: "PHP
Warning: Unknown: Filename cannot be empty in Unknown on line 0
PHP Fatal error: Unknown: Failed opening required ''
(include_path='.:/usr/local/lib/php') in Unknown on line 0" while
reading response header from upstream, client: 95.79.237.40, server:
site.ru, request: "GET /php_info.php HTTP/1.1", upstream:
"fastcgi://***:9001", host: "site.ru"
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 01
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 06
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 00
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 01
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 00
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: F9
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 07
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record byte: 00
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi record length: 249
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi parser: 0
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi header: "Status:
404 Not Found"
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi parser: 0
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi header:
"X-Powered-By: PHP/5.3.0"
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi parser: 0
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi header:
"Content-type: text/html"
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi parser: 1
2009/07/15 05:50:04 [debug] 30568#0: *1 http fastcgi header done
2009/07/15 05:50:04 [debug] 30568#0: *1 HTTP/1.1 404 Not Found
Часть fastcgi param не имеют инициированного значения, может дело именно в них?
14 июля 2009 г. 23:05 пользователь Gena Makhomed (gmm@xxxxxxxxx) написал:
> On Tuesday, July 14, 2009 at 16:49:25, Алексей Сундуков wrote:
>
> АС> я не могу понять, толи дело в nginx который не передает правильно
> АС> переменные среды, толи дело в php-fpm который их воспринимает не верно.
>
> это легко выяснить, посмотрев сниффером, что nginx передает backend`у.
> если nginx не выставляет корректные заголовки - можно собрать его
> с включенным режимом отладки и сделать debug log такого запроса.
> в результате ситуация с этим глюком должна несколько проясниться.
>
> ./configure --with-debug
>
> nginx.conf:
>
> events {
> debug_connection адрес;
> }
>
> PS http://www.lexa.ru/nginx-ru/msg14335.html
>
> --
> Best regards,
> Gena
>
>
>
|
