nginx 日志中$request_time记录时间为零

zoudeshun666

- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon/3339res.png HTTP/1.1" 200 8743 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "117.136.19.125" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /game/20110816/137/\x1A\x1Aqq\x1A\x1A.apk HTTP/1.0" 404 169 "-" "-" "221.179.8.83" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon_fetch/res_31312431929328.png HTTP/1.1" 200 3745 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "116.113.59.16" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon_fetch/res_41312968367031.png HTTP/1.1" 200 6367 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "124.228.57.186" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon/1313050880192_res.png HTTP/1.1" 200 6815 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "221.237.186.100" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon/1314075841265_res.png HTTP/1.1" 200 12408 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "221.237.186.100" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon/1311336043659_res.png HTTP/1.1" 200 8709 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "117.136.0.213" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /game/20110816/137/\x1A\x1Aqq\x1A\x1A.apk HTTP/1.0" 404 169 "-" "-" "221.179.8.83" "-" "0.000"
- - - [27/Aug/2011:00:00:01 +0800] "GET /resicon/3208res.png HTTP/1.1" 200 9682 "-" "Dalvik/1.2.0 (Linux; U; Android 2.2.2; ME525 Build/JDGC_2.10.0)" "221.237.186.100" "-" "0.000"

访问日志如上，配置nginx的日志分隔为：
    log_format    xxx  '$http_x_forwarded_for - $remote_user [$time_local] "$request"'
                     ' $status $body_bytes_sent "$http_referer"'
                     ' "$http_user_agent" "$remote_addr" "$upstream_response_time" "$request_time"';

各位大侠，能帮忙分析下是什么原因导致的吗？

低头、真掩饰

这个$request_time 与nginx的响应和处理时间有关系
从你截图的来看 nginx的处理的都是小图片文件，处理速度很快所以requset_time较低甚至为0，你可以测试几个大文件，就有结果呢。  呵呵