Nginx-0.7.28

Changes with nginx 0.7.28 22 Dec
2008

*) Change: in memory allocation in the ngx_http_gzip_filter_module.

*) Change: the default "gzip_buffers" directive values have been
   changed to 32 4k or 16 8k from 4 4k/8k.

Nginx 0.7.28 for Windows is now available: http://cli.gs/n0728

Kevin W.

Igor S. wrote:

Changes with nginx 0.7.28 22 Dec
2008

*) Change: in memory allocation in the ngx_http_gzip_filter_module.

*) Change: the default "gzip_buffers" directive values have been
   changed to 32 4k or 16 8k from 4 4k/8k.

I focus on “nginx gzip” for a few times and I’m excited when You
released 0.7.28 & changed on gzip.But…but when I used 0.7.28 a minite
ago,I got the same error logs like before.Please see below:

2008/12/24 13:55:33 [notice] 476#0: using the “select” event method
2008/12/24 13:55:33 [notice] 476#0: nginx/0.7.28
2008/12/24 13:55:33 [notice] 476#0: built by gcc 3.4.4 (cygming special,
gdc 0.12, using dmd 0.125)
2008/12/24 13:55:33 [notice] 476#0: getrlimit(RLIMIT_NOFILE):
256:4294967295
2008/12/24 13:55:33 [notice] 3288#0: start worker processes
2008/12/24 13:55:33 [notice] 3288#0: start worker process 2488
2008/12/24 13:55:33 [notice] 3288#0: signal 23 (SIGIO) received
2008/12/24 13:56:54 [alert] 2488#0: *2 gzip filter failed to use
preallocated memory: 16384 of 8192 while sending response to client,
client: 127.0.0.1, server: localhost, request: “GET /cn.yahoo.html
HTTP/1.1”, host: “localhost”
2008/12/24 13:56:54 [alert] 2488#0: *2 gzip filter failed to use
preallocated memory: 16384 of 8192 while sending response to client,
client: 127.0.0.1, server: localhost, request: “GET /cn.yahoo.html
HTTP/1.1”, host: “localhost”
2008/12/24 13:56:54 [alert] 2488#0: *2 gzip filter failed to use
preallocated memory: 16384 of 8192 while sending response to client,
client: 127.0.0.1, server: localhost, request: “GET /cn.yahoo.html
HTTP/1.1”, host: “localhost”
2008/12/24 13:56:54 [alert] 2488#0: *2 gzip filter failed to use
preallocated memory: 16384 of 8192 while sending response to client,
client: 127.0.0.1, server: localhost, request: “GET /cn.yahoo.html
HTTP/1.1”, host: “localhost”

On Wed, Dec 24, 2008 at 07:32:23AM +0100, Tiger Lee wrote:

released 0.7.28 & changed on gzip.But…but when I used 0.7.28 a minite
2008/12/24 13:55:33 [notice] 3288#0: signal 23 (SIGIO) received
client: 127.0.0.1, server: localhost, request: “GET /cn.yahoo.html
HTTP/1.1”, host: “localhost”
2008/12/24 13:56:54 [alert] 2488#0: *2 gzip filter failed to use
preallocated memory: 16384 of 8192 while sending response to client,
client: 127.0.0.1, server: localhost, request: “GET /cn.yahoo.html
HTTP/1.1”, host: “localhost”

As I understand this is cygwin build ?
Could you create debug log of the request ?

Tanks for your quick response.

Yes,it’s a cygwin build.
debug log of the request ? Do you mean error.log or access.log ?
Those error log informaition I posted upsters are just debug logs.I use
“error_log logs/error.log debug 4;” in my nginx.conf.

Here are my gzip configure:

gzip on;
gzip_min_length 1k;
gzip_proxied expired no-cache no-store private auth no_last_modified
no_etag;
gzip_buffers 16 8k;
gzip_http_version 1.0;
gzip_comp_level 9;
gzip_window 8k;
gzip_hash 16k;
gzip_types text/plain application/x-javascript text/css application/xml;
gzip_vary on;
gzip_disable “MSIE [1-6].”;

Please notice I’m using gzip_window & gzip_hash.I tried many times to
change the value of those arguments.It’s no matter of gzip_buffers and
other arguments but gzip_window & gzip_hash.When I changed with
different value combination of these two arguments I got different error
logs about gzip:

…preallocated memory: 16384 of 8192 while…
…preallocated memory: 5824 of 57344 while…
…preallocated memory: 32768 of 8192 while…
…preallocated memory: 65536 of 8192 while…
…preallocated memory: 5824 of 14336 while…
…preallocated memory: 5824 of 49152 while…

btw:I compiled nginx-0.7.28 with Cygwin under Windows XP professional.

On Wed, Dec 24, 2008 at 08:26:53AM +0100, Tiger Lee wrote:

Tanks for your quick response.

Yes,it’s a cygwin build.
debug log of the request ? Do you mean error.log or access.log ?
Those error log informaition I posted upsters are just debug logs.I use
“error_log logs/error.log debug 4;” in my nginx.conf.

-error_log logs/error.log debug 4;
+error_log logs/error.log debug;

You also need to build nginx --with-debug.

Igor S. wrote:

On Wed, Dec 24, 2008 at 08:26:53AM +0100, Tiger Lee wrote:

Tanks for your quick response.

Yes,it’s a cygwin build.
debug log of the request ? Do you mean error.log or access.log ?
Those error log informaition I posted upsters are just debug logs.I use
“error_log logs/error.log debug 4;” in my nginx.conf.

-error_log logs/error.log debug 4;
+error_log logs/error.log debug;

You also need to build nginx --with-debug.

Done~ but the log file is too big size.How can I post it to you?

2008/12/24 16:12:00 [debug] 3828#0: bind() 0.0.0.0:80 #5
2008/12/24 16:12:00 [notice] 3828#0: using the “select” event method
2008/12/24 16:12:00 [debug] 3828#0: counter: 7FF90080, 1
2008/12/24 16:12:00 [notice] 3828#0: nginx/0.7.28
2008/12/24 16:12:00 [notice] 3828#0: built by gcc 3.4.4 (cygming
special, gdc 0.12, using dmd 0.125)
2008/12/24 16:12:00 [notice] 3828#0: getrlimit(RLIMIT_NOFILE):
256:4294967295
2008/12/24 16:12:00 [debug] 3432#0: write: 6, 0022CB00, 5, 0
2008/12/24 16:12:00 [notice] 3432#0: start worker processes
2008/12/24 16:12:00 [debug] 3432#0: channel 6:7
2008/12/24 16:12:00 [notice] 3432#0: start worker process 976
2008/12/24 16:12:00 [debug] 3432#0: sigsuspend
2008/12/24 16:12:00 [debug] 976#0: malloc: 10010D70:512
eceived
2008/12/24 16:12:01 [debug] 3432#0: wake up
2008/12/24 16:12:00 [debug] 976#0: malloc: 100151A0:5632
2008/12/24 16:12:00 [debug] 976#0: malloc: 1001A270:3328
2008/12/24 16:12:00 [debug] 976#0: malloc: 1001F1C0:3328
2008/12/24 16:12:01 [debug] 3432#0: sigsuspend
2008/12/24 16:12:00 [debug] 976#0: select add event fd:5 ev:1
2008/12/24 16:12:00 [debug] 976#0: select add event fd:7 ev:1
2008/12/24 16:12:00 [debug] 976#0: worker cycle
2008/12/24 16:12:00 [debug] 976#0: change max_fd: 7
2008/12/24 16:12:00 [debug] 976#0: select event: fd:5 wr:0
2008/12/24 16:12:00 [debug] 976#0: select event: fd:7 wr:0
2008/12/24 16:12:00 [debug] 976#0: max_fd: 7
2008/12/24 16:12:00 [debug] 976#0: select timer: -1
2008/12/24 16:12:00 [debug] 976#0: select read fd_set: 000000A0

2008/12/24 16:15:15 [debug] 976#0: select ready 1
2008/12/24 16:15:15 [debug] 976#0: select read 5
2008/12/24 16:15:15 [debug] 976#0: post event 1001A270
2008/12/24 16:15:15 [debug] 976#0: timer delta: 194694
2008/12/24 16:15:15 [debug] 976#0: posted event 1001A270
2008/12/24 16:15:15 [debug] 976#0: delete posted event 1001A270
2008/12/24 16:15:15 [debug] 976#0: accept on 0.0.0.0:80, ready: 0
2008/12/24 16:15:15 [debug] 976#0: malloc: 10010F78:256
2008/12/24 16:15:15 [debug] 976#0: *1 accept: 127.0.0.1 fd:6
2008/12/24 16:15:15 [debug] 976#0: *1 event timer add: 6:
60000:1745928977
2008/12/24 16:15:15 [debug] 976#0: *1 select add event fd:6 ev:1
2008/12/24 16:15:15 [debug] 976#0: posted event 00000000
2008/12/24 16:15:15 [debug] 976#0: posted events 00000000
2008/12/24 16:15:15 [debug] 976#0: worker cycle
2008/12/24 16:15:15 [debug] 976#0: select event: fd:5 wr:0
2008/12/24 16:15:15 [debug] 976#0: select event: fd:7 wr:0
2008/12/24 16:15:15 [debug] 976#0: select event: fd:6 wr:0
2008/12/24 16:15:15 [debug] 976#0: max_fd: 7
2008/12/24 16:15:15 [debug] 976#0: select timer: 60000
2008/12/24 16:15:15 [debug] 976#0: select read fd_set: 000000E0
2008/12/24 16:15:15 [debug] 976#0: select ready 1
2008/12/24 16:15:15 [debug] 976#0: select read 6
2008/12/24 16:15:15 [debug] 976#0: *1 post event 1001A2D8
2008/12/24 16:15:15 [debug] 976#0: timer delta: 4
2008/12/24 16:15:15 [debug] 976#0: posted events 1001A2D8
2008/12/24 16:15:15 [debug] 976#0: posted event 1001A2D8
2008/12/24 16:15:15 [debug] 976#0: *1 delete posted event 1001A2D8
2008/12/24 16:15:15 [debug] 976#0: *1 malloc: 1001FEC8:664
2008/12/24 16:15:15 [debug] 976#0: *1 malloc: 100167A8:1024
2008/12/24 16:15:15 [debug] 976#0: *1 malloc: 10016BB0:4096
2008/12/24 16:15:15 [debug] 976#0: *1 http process request line
2008/12/24 16:15:15 [debug] 976#0: *1 recv: fd:6 690 of 1024
2008/12/24 16:15:15 [debug] 976#0: *1 http request line: “GET /
HTTP/1.1”
2008/12/24 16:15:15 [debug] 976#0: *1 http uri: “/”
2008/12/24 16:15:15 [debug] 976#0: *1 http args: “”
2008/12/24 16:15:15 [debug] 976#0: *1 http exten: “”
2008/12/24 16:15:15 [debug] 976#0: *1 http process request header line
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “Accept: image/gif,
image/x-xbitmap, image/jpeg, image/pjpeg, application/x-shockwave-flash,
application/vnd.ms-excel, application/vnd.ms-powerpoint,
application/msword, /
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “Accept-Language:
zh-cn”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “UA-CPU: x86”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “Accept-Encoding:
gzip, deflate”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “If-Modified-Since:
Wed, 24 Dec 2008 03:27:12 GMT”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “User-Agent:
Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 5.1; .NET CLR 2.0.50727;
TheWorld)”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “Host: localhost”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “Connection:
Keep-Alive”
2008/12/24 16:15:15 [debug] 976#0: *1 http header: “Cookie:
sycms_admin_menu=setting%7Cmake%7Cimport%7Clocalize%7Cmedia_add;
AJSTAT_ok_times=2;
CN_FP_TAB=todaytabs%3Dtodaytabscon%2C%2Copen%2Cend%7Cschtabs%3Dschtabscon%2C%2Copen%2Cend%7Ccdntabs%3Dcdntabscon%2C%2Copen%2Cend;
zs_popupmsg=20081124”
2008/12/24 16:15:15 [debug] 976#0: *1 http header done
2008/12/24 16:15:15 [debug] 976#0: *1 event timer del: 6: 1745928977
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 0
2008/12/24 16:15:15 [debug] 976#0: *1 test location: “/”
2008/12/24 16:15:15 [debug] 976#0: *1 using configuration “/”
2008/12/24 16:15:15 [debug] 976#0: *1 http cl:-1 max:1048576
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 2
2008/12/24 16:15:15 [debug] 976#0: *1 post rewrite phase: 3
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 4
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 5
2008/12/24 16:15:15 [debug] 976#0: *1 access phase: 6
2008/12/24 16:15:15 [debug] 976#0: *1 access phase: 7
2008/12/24 16:15:15 [debug] 976#0: *1 post access phase: 8
2008/12/24 16:15:15 [debug] 976#0: *1 content phase: 9
2008/12/24 16:15:15 [debug] 976#0: *1 open index
“/usr/local/nginx/html/index.html”
2008/12/24 16:15:15 [debug] 976#0: *1 add cleanup: 100170CC
2008/12/24 16:15:15 [debug] 976#0: *1 internal redirect: “/index.html?”
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 0
2008/12/24 16:15:15 [debug] 976#0: *1 test location: “/”
2008/12/24 16:15:15 [debug] 976#0: *1 test location: “50x.html”
2008/12/24 16:15:15 [debug] 976#0: *1 using configuration “/”
2008/12/24 16:15:15 [debug] 976#0: *1 http cl:-1 max:1048576
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 2
2008/12/24 16:15:15 [debug] 976#0: *1 post rewrite phase: 3
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 4
2008/12/24 16:15:15 [debug] 976#0: *1 generic phase: 5
2008/12/24 16:15:15 [debug] 976#0: *1 access phase: 6
2008/12/24 16:15:15 [debug] 976#0: *1 access phase: 7
2008/12/24 16:15:15 [debug] 976#0: *1 post access phase: 8
2008/12/24 16:15:15 [debug] 976#0: *1 content phase: 9
2008/12/24 16:15:15 [debug] 976#0: *1 content phase: 10
2008/12/24 16:15:15 [debug] 976#0: *1 content phase: 11
2008/12/24 16:15:15 [debug] 976#0: *1 http filename:
“/usr/local/nginx/html/index.html”
2008/12/24 16:15:15 [debug] 976#0: *1 add cleanup: 10017108
2008/12/24 16:15:15 [debug] 976#0: *1 http static fd: 9
2008/12/24 16:15:15 [debug] 976#0: *1 http set discard body
2008/12/24 16:15:15 [debug] 976#0: *1 http ims:1230089232 lm:1230089232
2008/12/24 16:15:15 [debug] 976#0: *1 HTTP/1.1 304 Not Modified

Server: nginx/0.7.28

Date: Wed, 24 Dec 2008 08:15:15 GMT

Last-Modified: Wed, 24 Dec 2008 03:27:12 GMT

Connection: keep-alive

2008/12/24 16:15:15 [debug] 976#0: *1 write new buf t:1 f:0 10017218,
pos 10017218, size: 158 file: 0, size: 0
2008/12/24 16:15:15 [debug] 976#0: *1 http write filter: l:1 f:0 s:158
2008/12/24 16:15:15 [debug] 976#0: *1 http write filter limit 0
2008/12/24 16:15:15 [debug] 976#0: *1 writev: 158
2008/12/24 16:15:15 [debug] 976#0: *1 http write filter 00000000
2008/12/24 16:15:15 [debug] 976#0: *1 http finalize request: 0,
“/index.html?” 1
2008/12/24 16:15:15 [debug] 976#0: *1 set http keepalive handler
2008/12/24 16:15:15 [debug] 976#0: *1 http close request
2008/12/24 16:15:15 [debug] 976#0: *1 http log handler
2008/12/24 16:15:15 [debug] 976#0: *1 run cleanup: 10017108
2008/12/24 16:15:15 [debug] 976#0: *1 file cleanup: fd:9
2008/12/24 16:15:15 [debug] 976#0: *1 run cleanup: 100170CC
2008/12/24 16:15:15 [debug] 976#0: *1 file cleanup: fd:8
2008/12/24 16:15:15 [debug] 976#0: *1 free: 10016BB0, unused: 2116
2008/12/24 16:15:15 [debug] 976#0: *1 event timer add: 6:
65000:1745933981
2008/12/24 16:15:15 [debug] 976#0: *1 free: 1001FEC8
2008/12/24 16:15:15 [debug] 976#0: *1 free: 100167A8
2008/12/24 16:15:15 [debug] 976#0: *1 hc free: 00000000 0
2008/12/24 16:15:15 [debug] 976#0: *1 hc busy: 00000000 0
2008/12/24 16:15:15 [debug] 976#0: *1 tcp_nodelay
2008/12/24 16:15:15 [debug] 976#0: posted event 00000000
2008/12/24 16:15:15 [debug] 976#0: worker cycle
2008/12/24 16:15:15 [debug] 976#0: select event: fd:5 wr:0
2008/12/24 16:15:15 [debug] 976#0: select event: fd:7 wr:0
2008/12/24 16:15:15 [debug] 976#0: select event: fd:6 wr:0
2008/12/24 16:15:15 [debug] 976#0: max_fd: 7
2008/12/24 16:15:15 [debug] 976#0: select timer: 65000
2008/12/24 16:15:15 [debug] 976#0: select read fd_set: 000000E0

2008/12/24 16:15:17 [debug] 976#0: select ready 1
2008/12/24 16:15:17 [debug] 976#0: select read 6
2008/12/24 16:15:17 [debug] 976#0: *1 post event 1001A2D8
2008/12/24 16:15:17 [debug] 976#0: timer delta: 1493
2008/12/24 16:15:17 [debug] 976#0: posted events 1001A2D8
2008/12/24 16:15:17 [debug] 976#0: posted event 1001A2D8
2008/12/24 16:15:17 [debug] 976#0: *1 delete posted event 1001A2D8
2008/12/24 16:15:17 [debug] 976#0: *1 http keepalive handler
2008/12/24 16:15:17 [debug] 976#0: *1 malloc: 100167A8:1024
2008/12/24 16:15:17 [debug] 976#0: *1 recv: fd:6 529 of 1024
2008/12/24 16:15:17 [debug] 976#0: *1 malloc: 1001FEC8:664
2008/12/24 16:15:17 [debug] 976#0: *1 malloc: 10016BB0:4096
2008/12/24 16:15:17 [debug] 976#0: *1 http process request line
2008/12/24 16:15:17 [debug] 976#0: *1 http request line: “GET /
HTTP/1.1”
2008/12/24 16:15:17 [debug] 976#0: *1 http uri: “/”
2008/12/24 16:15:17 [debug] 976#0: *1 http args: “”
2008/12/24 16:15:17 [debug] 976#0: *1 http exten: “”
2008/12/24 16:15:17 [debug] 976#0: *1 http process request header line
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “Accept: /
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “Accept-Language:
zh-cn”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “UA-CPU: x86”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “Accept-Encoding:
gzip, deflate”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “If-Modified-Since:
Wed, 24 Dec 2008 03:27:12 GMT”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “User-Agent:
Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 5.1; .NET CLR 2.0.50727;
TheWorld)”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “Host: localhost”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “Connection:
Keep-Alive”
2008/12/24 16:15:17 [debug] 976#0: *1 http header: “Cookie:
sycms_admin_menu=setting%7Cmake%7Cimport%7Clocalize%7Cmedia_add;
AJSTAT_ok_times=2;
CN_FP_TAB=todaytabs%3Dtodaytabscon%2C%2Copen%2Cend%7Cschtabs%3Dschtabscon%2C%2Copen%2Cend%7Ccdntabs%3Dcdntabscon%2C%2Copen%2Cend;
zs_popupmsg=20081124”
2008/12/24 16:15:17 [debug] 976#0: *1 http header done
2008/12/24 16:15:17 [debug] 976#0: *1 event timer del: 6: 1745933981
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 0
2008/12/24 16:15:17 [debug] 976#0: *1 test location: “/”
2008/12/24 16:15:17 [debug] 976#0: *1 using configuration “/”
2008/12/24 16:15:17 [debug] 976#0: *1 http cl:-1 max:1048576
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 2
2008/12/24 16:15:17 [debug] 976#0: *1 post rewrite phase: 3
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 4
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 5
2008/12/24 16:15:17 [debug] 976#0: *1 access phase: 6
2008/12/24 16:15:17 [debug] 976#0: *1 access phase: 7
2008/12/24 16:15:17 [debug] 976#0: *1 post access phase: 8
2008/12/24 16:15:17 [debug] 976#0: *1 content phase: 9
2008/12/24 16:15:17 [debug] 976#0: *1 open index
“/usr/local/nginx/html/index.html”
2008/12/24 16:15:17 [debug] 976#0: *1 add cleanup: 100170CC
2008/12/24 16:15:17 [debug] 976#0: *1 internal redirect: “/index.html?”
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 0
2008/12/24 16:15:17 [debug] 976#0: *1 test location: “/”
2008/12/24 16:15:17 [debug] 976#0: *1 test location: “50x.html”
2008/12/24 16:15:17 [debug] 976#0: *1 using configuration “/”
2008/12/24 16:15:17 [debug] 976#0: *1 http cl:-1 max:1048576
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 2
2008/12/24 16:15:17 [debug] 976#0: *1 post rewrite phase: 3
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 4
2008/12/24 16:15:17 [debug] 976#0: *1 generic phase: 5
2008/12/24 16:15:17 [debug] 976#0: *1 access phase: 6
2008/12/24 16:15:17 [debug] 976#0: *1 access phase: 7
2008/12/24 16:15:17 [debug] 976#0: *1 post access phase: 8
2008/12/24 16:15:17 [debug] 976#0: *1 content phase: 9
2008/12/24 16:15:17 [debug] 976#0: *1 content phase: 10
2008/12/24 16:15:17 [debug] 976#0: *1 content phase: 11
2008/12/24 16:15:17 [debug] 976#0: *1 http filename:
“/usr/local/nginx/html/index.html”
2008/12/24 16:15:17 [debug] 976#0: *1 add cleanup: 10017108
2008/12/24 16:15:17 [debug] 976#0: *1 http static fd: 9
2008/12/24 16:15:17 [debug] 976#0: *1 http set discard body
2008/12/24 16:15:17 [debug] 976#0: *1 http ims:1230089232 lm:1230089232
2008/12/24 16:15:17 [debug] 976#0: *1 HTTP/1.1 304 Not Modified

Server: nginx/0.7.28

Date: Wed, 24 Dec 2008 08:15:17 GMT

Last-Modified: Wed, 24 Dec 2008 03:27:12 GMT

Connection: keep-alive

2008/12/24 16:15:17 [debug] 976#0: *1 write new buf t:1 f:0 10017218,
pos 10017218, size: 158 file: 0, size: 0
2008/12/24 16:15:17 [debug] 976#0: *1 http write filter: l:1 f:0 s:158
2008/12/24 16:15:17 [debug] 976#0: *1 http write filter limit 0
2008/12/24 16:15:17 [debug] 976#0: *1 writev: 158
2008/12/24 16:15:17 [debug] 976#0: *1 http write filter 00000000
2008/12/24 16:15:17 [debug] 976#0: *1 http finalize request: 0,
“/index.html?” 1
2008/12/24 16:15:17 [debug] 976#0: *1 set http keepalive handler
2008/12/24 16:15:17 [debug] 976#0: *1 http close request
2008/12/24 16:15:17 [debug] 976#0: *1 http log handler
2008/12/24 16:15:17 [debug] 976#0: *1 run cleanup: 10017108
2008/12/24 16:15:17 [debug] 976#0: *1 file cleanup: fd:9
2008/12/24 16:15:17 [debug] 976#0: *1 run cleanup: 100170CC
2008/12/24 16:15:17 [debug] 976#0: *1 file cleanup: fd:8
2008/12/24 16:15:17 [debug] 976#0: *1 free: 10016BB0, unused: 2116
2008/12/24 16:15:17 [debug] 976#0: *1 event timer add: 6:
65000:1745935474
2008/12/24 16:15:17 [debug] 976#0: *1 free: 1001FEC8
2008/12/24 16:15:17 [debug] 976#0: *1 free: 100167A8
2008/12/24 16:15:17 [debug] 976#0: *1 hc free: 00000000 0
2008/12/24 16:15:17 [debug] 976#0: *1 hc busy: 00000000 0
2008/12/24 16:15:17 [debug] 976#0: posted event 00000000
2008/12/24 16:15:17 [debug] 976#0: worker cycle
2008/12/24 16:15:17 [debug] 976#0: select event: fd:5 wr:0
2008/12/24 16:15:17 [debug] 976#0: select event: fd:7 wr:0
2008/12/24 16:15:17 [debug] 976#0: select event: fd:6 wr:0
2008/12/24 16:15:17 [debug] 976#0: max_fd: 7
2008/12/24 16:15:17 [debug] 976#0: select timer: 65000
2008/12/24 16:15:17 [debug] 976#0: select read fd_set: 000000E0

On Wed, Dec 24, 2008 at 09:43:41AM +0100, Tiger Lee wrote:

2008/12/24 16:12:00 [debug] 3432#0: channel 6:7
2008/12/24 16:12:00 [debug] 976#0: select add event fd:7 ev:1
2008/12/24 16:12:00 [debug] 976#0: worker cycle
2008/12/24 16:12:00 [debug] 976#0: change max_fd: 7
2008/12/24 16:12:00 [debug] 976#0: select event: fd:5 wr:0
2008/12/24 16:12:00 [debug] 976#0: select event: fd:7 wr:0
2008/12/24 16:12:00 [debug] 976#0: max_fd: 7
2008/12/24 16:12:00 [debug] 976#0: select timer: -1
2008/12/24 16:12:00 [debug] 976#0: select read fd_set: 000000A0

This is too small log.

You should set

master_process off;
daemon off;

in nginx.conf to simplify debugging.

On Wed, Dec 24, 2008 at 09:35:11AM +0100, Tiger Lee wrote:

-error_log logs/error.log debug 4;
+error_log logs/error.log debug;

You also need to build nginx --with-debug.

Done~ but the log file is too big size.How can I post it to you?

Please send it to my address: [email protected]
Have you do a single request ?

On Wed, Dec 24, 2008 at 09:45:20AM +0100, Tiger Lee wrote:

2008/12/24 16:15:17 [debug] 976#0: *1 HTTP/1.1 304 Not Modified

This request is not gzippped as it has no body.
You need to force reload.

Igor S. wrote:

On Wed, Dec 24, 2008 at 09:35:11AM +0100, Tiger Lee wrote:

-error_log logs/error.log debug 4;
+error_log logs/error.log debug;

You also need to build nginx --with-debug.

Done~ but the log file is too big size.How can I post it to you?

Please send it to my address: [email protected]
Have you do a single request ?

OK,I’ll mail with you then.
Thanks!