Directory permissions behavior changed?

mike mike503 at gmail.com
Fri Aug 8 11:58:37 MSD 2008


Yeah - I've been able to reproduce this.

I get a 500 internal server error.

My config is this:

        server {
                listen 80;
                server_name foo.com;
                index index.php index.html;
                root /home/mike/web/foo.com/;
                include /etc/nginx/defaults.conf;
                include /etc/nginx/expires.conf;
                location ~ \.php {
                        fastcgi_pass 127.0.0.1:11000;
                        fastcgi_index index.php;
                }
        }

/home/mike/web/foo.com has permissions 0711.

The index file right now is index.html.

If I hit foo.com/  - I get a 500 internal server error.
2008/08/08 00:35:47 [crit] 16866#0: *471953 open()
"/home/mike/web/foo.com" failed (13: Permission denied), client:
70.12.8.24, server: foo.com, request: "GET / HTTP/1.1", host:
"foo.com"

If I hit foo.com/index.html - I get a normal response (the file contents)

If I rename index.html to index.php, it works fine.

So it appears that it tries to do a directory listing, if the first
file in the "index" line is not there. Shouldn't it just do

if ( file #1 exists ) {
 load that
} elseif (file #2 exists ) {
 load that
} elseif (file #N exists ) {
 load that
} elseif ( directory listings are enabled ) {
  show dir listings
} else {
  throw directory listing access denied 403 or whatever
}

I believe this is a minor bug in how it handles this scenario... it
definately created an issue for my client. It shouldn't require a
directory list if you've explicitly defined the files you want
searched in the "index" config...

It's probably in ngx_http_index_module.c

This is where the issue occurs: it only looks for a single index.php,
then it tries to do a normal index scan it looks like... it ignores
the other parameters to the "index" config option. According to here
it should support multiple in the specified order, so I'm not out of
my mind :)
http://wiki.codemongers.com/NginxHttpIndexModule

(Also if you see anything else in here that looks like a performance
hit I'd be glad to hear!) Thanks


2008/08/08 00:53:28 [debug] 24863#0: *1038 open index
"/home/mike/web/foo.com/index.php"
2008/08/08 00:53:28 [debug] 24863#0: *1038 add cleanup: 0000000000E67E48
2008/08/08 00:53:28 [debug] 24863#0: *1038 open()
"/home/mike/web/foo.com/index.php" failed (2: No such file or
directory)
2008/08/08 00:53:28 [debug] 24863#0: *1038 http index check dir:
"/home/mike/web/foo.com"
2008/08/08 00:53:28 [debug] 24863#0: *1038 add cleanup: 0000000000E67E78
2008/08/08 00:53:28 [crit] 24863#0: *1038 open()
"/home/mike/web/foo.com" failed (13: Permission denied), client:
71.70.91.12, server: foo.com, request: "GET / HTTP/1.1", host:
"foo.com"




Here's the raw logs of it working and not working.

with index.php in place (index works)

2008/08/08 00:52:22 [debug] 24862#0: *76 http keepalive handler
2008/08/08 00:52:22 [debug] 24862#0: *76 recv: fd:44 287 of 8192
2008/08/08 00:52:22 [debug] 24862#0: *76 malloc: 0000000000AF79A0:1280
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer del: 44: 1218181964644
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 1
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: "/robots.txt"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: "/favicon.ico"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: ~ "/\.ht"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: ~
"^.+.(jpg|jpeg|gif|css|png|js|ico|html)$"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: ~ "\.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 using configuration ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http cl:-1 max:263192576
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 3
2008/08/08 00:52:22 [debug] 24862#0: *76 post rewrite phase: 4
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 5
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 6
2008/08/08 00:52:22 [debug] 24862#0: *76 access phase: 7
2008/08/08 00:52:22 [debug] 24862#0: *76 access phase: 8
2008/08/08 00:52:22 [debug] 24862#0: *76 post access phase: 9
2008/08/08 00:52:22 [debug] 24862#0: *76 content phase: 10
2008/08/08 00:52:22 [debug] 24862#0: *76 open index
"/home/mike/web/foo.com/index.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 add cleanup: 0000000000A7EA88
2008/08/08 00:52:22 [debug] 24862#0: *76 internal redirect: "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 1
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: "/robots.txt"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: "/favicon.ico"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: ~ "/\.ht"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: ~
"^.+.(jpg|jpeg|gif|css|png|js|ico|html)$"
2008/08/08 00:52:22 [debug] 24862#0: *76 test location: ~ "\.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 using configuration "\.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 http cl:-1 max:263192576
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 3
2008/08/08 00:52:22 [debug] 24862#0: *76 post rewrite phase: 4
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 5
2008/08/08 00:52:22 [debug] 24862#0: *76 generic phase: 6
2008/08/08 00:52:22 [debug] 24862#0: *76 access phase: 7
2008/08/08 00:52:22 [debug] 24862#0: *76 access phase: 8
2008/08/08 00:52:22 [debug] 24862#0: *76 post access phase: 9
2008/08/08 00:52:22 [debug] 24862#0: *76 http init upstream, client timer: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 malloc: 0000000000EA4420:4096
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "QUERY_STRING: "
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "REQUEST_METHOD: GET"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "CONTENT_TYPE: "
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "CONTENT_LENGTH: "
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param:
"SCRIPT_FILENAME: /home/mike/web/foo.com/index.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "SCRIPT_NAME:
/index.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "REQUEST_URI: /"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "DOCUMENT_URI:
/index.php"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param:
"DOCUMENT_ROOT: /home/mike/web/foo.com"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param:
"SERVER_PROTOCOL: HTTP/1.1"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param:
"GATEWAY_INTERFACE: CGI/1.1"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param:
"SERVER_SOFTWARE: nginx/0.7.8"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "REMOTE_ADDR:
71.70.91.12"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "REMOTE_PORT: 1375"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "SERVER_ADDR:
10.13.220.83"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "SERVER_PORT: 80"
2008/08/08 00:52:22 [debug] 24862#0: *76 http script copy: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 http script var: ""
2008/08/08 00:52:22 [debug] 24862#0: *76 fastcgi param: "SERVER_NAME: foo.com"
2008/08/08 00:52:22 [debug] 24862#0: *76 http cleanup add: 0000000000EA4788
2008/08/08 00:52:22 [debug] 24862#0: *76 get rr peer, try: 1
2008/08/08 00:52:22 [debug] 24862#0: *76 socket 56
2008/08/08 00:52:22 [debug] 24862#0: *76 epoll add connection: fd:56 ev:80000005
2008/08/08 00:52:22 [debug] 24862#0: *76 connect to 127.0.0.1:11000, fd:56 #393
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream connect: -2
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer add: 56:
60000:1218182002683
2008/08/08 00:52:22 [debug] 24862#0: *76 http request empty handler
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream send request handler
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream send request
2008/08/08 00:52:22 [debug] 24862#0: *76 chain writer buf fl:0 s:744
2008/08/08 00:52:22 [debug] 24862#0: *76 chain writer in: 0000000000EA47C0
2008/08/08 00:52:22 [debug] 24862#0: *76 writev: 744
2008/08/08 00:52:22 [debug] 24862#0: *76 chain writer out: 0000000000000000
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer del: 56: 1218182002683
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer add: 56:
60000:1218182002684
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream process header
2008/08/08 00:52:22 [debug] 24862#0: *76 malloc: 0000000000AC6090:4096
2008/08/08 00:52:22 [debug] 24862#0: *76 recv: fd:56 64 of 4096
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 01
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 06
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 01
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 28
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record length: 40
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi parser: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi header:
"Content-type: text/html"
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi parser: 1
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi header done
2008/08/08 00:52:22 [debug] 24862#0: *76 xslt filter header
2008/08/08 00:52:22 [debug] 24862#0: *76 HTTP/1.1 200 OK
Server: nginx
Date: Fri, 08 Aug 2008 07:52:22 GMT
Content-Type: text/html
Transfer-Encoding: chunked
Connection: keep-alive
Vary: Accept-Encoding


2008/08/08 00:52:22 [debug] 24862#0: *76 write new buf t:1 f:0
0000000000EA4A18, pos 0000000000EA4A18, size: 171 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 http write filter: l:0 f:0 s:171
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream process upstream
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe read upstream: 1
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe preread: 29
2008/08/08 00:52:22 [debug] 24862#0: *76 readv: 1:4032
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe recv chain: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe buf free s:0 t:1 f:0
0000000000AC6090, pos 0000000000AC60B3, size: 29 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 input buf #0 0000000000AC60B3
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 01
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 03
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 01
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 08
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record byte: 00
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi record length: 8
2008/08/08 00:52:22 [debug] 24862#0: *76 http fastcgi sent end request
2008/08/08 00:52:22 [debug] 24862#0: *76 input buf 0000000000AC60B3 13
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe write downstream: 1
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe write downstream flush in
2008/08/08 00:52:22 [debug] 24862#0: *76 http output filter "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 copy filter: "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 xslt filter body
2008/08/08 00:52:22 [debug] 24862#0: *76 http postpone filter
"/index.php?" 0000000000EA4C30
2008/08/08 00:52:22 [debug] 24862#0: *76 http postpone filter out "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 http chunk: 13
2008/08/08 00:52:22 [debug] 24862#0: *76 write old buf t:1 f:0
0000000000EA4A18, pos 0000000000EA4A18, size: 171 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write new buf t:1 f:0
0000000000000000, pos 0000000000EA4D08, size: 3 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write new buf t:1 f:0
0000000000AC6090, pos 0000000000AC60B3, size: 13 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write new buf t:0 f:0
0000000000000000, pos 000000000050FA7D, size: 2 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 http write filter: l:0 f:0 s:189
2008/08/08 00:52:22 [debug] 24862#0: *76 copy filter: 0 "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 pipe write downstream done
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer: 56, old:
1218182002684, new: 1218182002685
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream exit: 0000000000000000
2008/08/08 00:52:22 [debug] 24862#0: *76 finalize http upstream request: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 finalize http fastcgi request
2008/08/08 00:52:22 [debug] 24862#0: *76 free rr peer 1 0
2008/08/08 00:52:22 [debug] 24862#0: *76 close http upstream connection: 56
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer del: 56: 1218182002684
2008/08/08 00:52:22 [debug] 24862#0: *76 http upstream temp fd: -1
2008/08/08 00:52:22 [debug] 24862#0: *76 http output filter "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 copy filter: "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 xslt filter body
2008/08/08 00:52:22 [debug] 24862#0: *76 http postpone filter
"/index.php?" 00007FFF45C21C80
2008/08/08 00:52:22 [debug] 24862#0: *76 http postpone filter out "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 http chunk: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write old buf t:1 f:0
0000000000EA4A18, pos 0000000000EA4A18, size: 171 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write old buf t:1 f:0
0000000000000000, pos 0000000000EA4D08, size: 3 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write old buf t:1 f:0
0000000000AC6090, pos 0000000000AC60B3, size: 13 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write old buf t:0 f:0
0000000000000000, pos 000000000050FA7D, size: 2 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 write new buf t:0 f:0
0000000000000000, pos 000000000050FA7A, size: 5 file: 0, size: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 http write filter: l:1 f:0 s:194
2008/08/08 00:52:22 [debug] 24862#0: *76 http write filter limit 0
2008/08/08 00:52:22 [debug] 24862#0: *76 writev: 194
2008/08/08 00:52:22 [debug] 24862#0: *76 http write filter 0000000000000000
2008/08/08 00:52:22 [debug] 24862#0: *76 copy filter: 0 "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 http finalize request: 0, "/index.php?"
2008/08/08 00:52:22 [debug] 24862#0: *76 set http keepalive handler
2008/08/08 00:52:22 [debug] 24862#0: *76 http close request
2008/08/08 00:52:22 [debug] 24862#0: *76 http log handler
2008/08/08 00:52:22 [debug] 24862#0: *76 run cleanup: 0000000000A7EA88
2008/08/08 00:52:22 [debug] 24862#0: *76 file cleanup: fd:37
2008/08/08 00:52:22 [debug] 24862#0: *76 free: 0000000000AC6090
2008/08/08 00:52:22 [debug] 24862#0: *76 free: 0000000000A7DF70, unused: 0
2008/08/08 00:52:22 [debug] 24862#0: *76 free: 0000000000EA4420, unused: 1488
2008/08/08 00:52:22 [debug] 24862#0: *76 event timer add: 44:
30000:1218181972685
2008/08/08 00:52:22 [debug] 24862#0: *76 free: 0000000000AF79A0
2008/08/08 00:52:22 [debug] 24862#0: *76 free: 0000000000F831E0
2008/08/08 00:52:22 [debug] 24862#0: *76 hc free: 0000000000000000 0
2008/08/08 00:52:22 [debug] 24862#0: *76 hc busy: 0000000000000000 0
2008/08/08 00:52:22 [debug] 24862#0: *76 post event 0000000000F15E90
2008/08/08 00:52:22 [debug] 24862#0: *76 delete posted event 0000000000F15E90
2008/08/08 00:52:22 [debug] 24862#0: *76 http keepalive handler
2008/08/08 00:52:22 [debug] 24862#0: *76 malloc: 0000000000F831E0:8192
2008/08/08 00:52:22 [debug] 24862#0: *76 recv: fd:44 -1 of 8192
2008/08/08 00:52:22 [debug] 24862#0: *76 recv() not ready (11:
Resource temporarily unavailable)
2008/08/08 00:52:52 [debug] 24862#0: *76 event timer del: 44: 1218181972685
2008/08/08 00:52:52 [debug] 24862#0: *76 http keepalive handler
2008/08/08 00:52:52 [debug] 24862#0: *76 close http connection: 44
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000F831E0
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000000000
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000000000
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000000000
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000000000
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000000000
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000000000
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000B13D40, unused: 0
2008/08/08 00:52:52 [debug] 24862#0: *76 free: 0000000000BC38D0, unused: 72


with index.html (throws a 500 server error)


2008/08/08 00:53:28 [debug] 24863#0: *1038 event timer del: 17: 1218182068211
2008/08/08 00:53:28 [debug] 24863#0: *1038 generic phase: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 generic phase: 1
2008/08/08 00:53:28 [debug] 24863#0: *1038 test location: "/robots.txt"
2008/08/08 00:53:28 [debug] 24863#0: *1038 test location: "/favicon.ico"
2008/08/08 00:53:28 [debug] 24863#0: *1038 test location: ~ "/\.ht"
2008/08/08 00:53:28 [debug] 24863#0: *1038 test location: ~
"^.+.(jpg|jpeg|gif|css|png|js|ico|html)$"
2008/08/08 00:53:28 [debug] 24863#0: *1038 test location: ~ "\.php"
2008/08/08 00:53:28 [debug] 24863#0: *1038 using configuration ""
2008/08/08 00:53:28 [debug] 24863#0: *1038 http cl:-1 max:263192576
2008/08/08 00:53:28 [debug] 24863#0: *1038 generic phase: 3
2008/08/08 00:53:28 [debug] 24863#0: *1038 post rewrite phase: 4
2008/08/08 00:53:28 [debug] 24863#0: *1038 generic phase: 5
2008/08/08 00:53:28 [debug] 24863#0: *1038 generic phase: 6
2008/08/08 00:53:28 [debug] 24863#0: *1038 access phase: 7
2008/08/08 00:53:28 [debug] 24863#0: *1038 access phase: 8
2008/08/08 00:53:28 [debug] 24863#0: *1038 post access phase: 9
2008/08/08 00:53:28 [debug] 24863#0: *1038 content phase: 10
2008/08/08 00:53:28 [debug] 24863#0: *1038 open index
"/home/mike/web/foo.com/index.php"
2008/08/08 00:53:28 [debug] 24863#0: *1038 add cleanup: 0000000000E67E48
2008/08/08 00:53:28 [debug] 24863#0: *1038 open()
"/home/mike/web/foo.com/index.php" failed (2: No such file or
directory)
2008/08/08 00:53:28 [debug] 24863#0: *1038 http index check dir:
"/home/mike/web/foo.com"
2008/08/08 00:53:28 [debug] 24863#0: *1038 add cleanup: 0000000000E67E78
2008/08/08 00:53:28 [crit] 24863#0: *1038 open()
"/home/mike/web/foo.com" failed (13: Permission denied), client:
71.70.91.12, server: foo.com, request: "GET / HTTP/1.1", host:
"foo.com"
2008/08/08 00:53:28 [debug] 24863#0: *1038 http finalize request: 500, "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 http special response: 500, "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 http set discard body
2008/08/08 00:53:28 [debug] 24863#0: *1038 xslt filter header
2008/08/08 00:53:28 [debug] 24863#0: *1038 HTTP/1.1 500 Internal Server Error
Server: nginx
Date: Fri, 08 Aug 2008 07:53:28 GMT
Content-Type: text/html
Content-Length: 546
Connection: close


2008/08/08 00:53:28 [debug] 24863#0: *1038 write new buf t:1 f:0
0000000000E67EF8, pos 0000000000E67EF8, size: 155 file: 0, size: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 http write filter: l:0 f:0 s:155
2008/08/08 00:53:28 [debug] 24863#0: *1038 http output filter "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 copy filter: "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 xslt filter body
2008/08/08 00:53:28 [debug] 24863#0: *1038 http postpone filter "/?"
0000000000E68110
2008/08/08 00:53:28 [debug] 24863#0: *1038 http postpone filter out "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 write old buf t:1 f:0
0000000000E67EF8, pos 0000000000E67EF8, size: 155 file: 0, size: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 write new buf t:0 f:0
0000000000000000, pos 000000000076E360, size: 140 file: 0, size: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 write new buf t:0 f:0
0000000000000000, pos 000000000076D4C0, size: 46 file: 0, size: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 write new buf t:0 f:0
0000000000000000, pos 000000000076D500, size: 360 file: 0, size: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 http write filter: l:1 f:0 s:701
2008/08/08 00:53:28 [debug] 24863#0: *1038 http write filter limit 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 writev: 701
2008/08/08 00:53:28 [debug] 24863#0: *1038 http write filter 0000000000000000
2008/08/08 00:53:28 [debug] 24863#0: *1038 copy filter: 0 "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 http finalize request: 0, "/?"
2008/08/08 00:53:28 [debug] 24863#0: *1038 http close request
2008/08/08 00:53:28 [debug] 24863#0: *1038 http log handler
2008/08/08 00:53:28 [debug] 24863#0: *1038 free: 0000000000E67320, unused: 432
2008/08/08 00:53:28 [debug] 24863#0: *1038 close http connection: 17
2008/08/08 00:53:28 [debug] 24863#0: *1038 free: 0000000000F75170
2008/08/08 00:53:28 [debug] 24863#0: *1038 free: 0000000000B123E0
2008/08/08 00:53:28 [debug] 24863#0: *1038 free: 0000000000EDAFA0, unused: 0
2008/08/08 00:53:28 [debug] 24863#0: *1038 free: 000000000096F390, unused: 152





More information about the nginx mailing list