Неправильные (огромные) значения $request time для FastCGI-запросов

afan nginx-forum на nginx.us
Сб Окт 1 10:08:11 UTC 2011


Имеется Windows / Nginx 1.1.4. На порту 127.0.0.1:9000
висит PHP (FastCGI).

В конфиге в секции http {...} задан
следующий формат лога:

    log_format custom '$remote_addr [$time_local] {$upstream_addr
$upstream_response_time} $request_time "$request" $status
$request_length';

Вот, что я вижу в логе:

127.0.0.1 [01/Oct/2011:13:55:33 +0400] {127.0.0.1:9000 0.015}
64424509440.4371324 "GET /activity/ HTTP/1.1" 200 462
127.0.0.1 [01/Oct/2011:13:55:33 +0400] {- -} 0.4371324 "GET
/css/style.css HTTP/1.1" 304 471
127.0.0.1 [01/Oct/2011:13:56:33 +0400] {127.0.0.1:9000 0.024}
103079215104.4371324 "GET /activity/ HTTP/1.1" 200 462
127.0.0.1 [01/Oct/2011:13:56:33 +0400] {- -} 0.4371324 "GET
/css/style.css HTTP/1.1" 304 471
127.0.0.1 [01/Oct/2011:13:57:33 +0400] {127.0.0.1:9000 0.034}
146028888064.4371324 "GET /activity/ HTTP/1.1" 200 462
127.0.0.1 [01/Oct/2011:13:57:33 +0400] {- -} 0.4371324 "GET
/css/style.css HTTP/1.1" 304 471

Как видно из лога, вместо $request_time
подставляются какие-то дикие рандомные
значения (64424509440.4371324, 103079215104.4371324, ...).
При этом как для прокси-запросов через
FastCGI, так и для прямых запросов статики
дробная часть всегда одна и та же:
0.4371324.

В чем может быть дело?

Posted at Nginx Forum: http://forum.nginx.org/read.php?21,216150,216150#msg-216150



Подробная информация о списке рассылки nginx-ru