Does Nginx honor DNS TTLs for proxy upstreams?

csg nginx-forum at nginx.us
Thu Sep 29 07:31:07 UTC 2011


Here as a follow up the debug output plus additional information:

# nginx -V
nginx: nginx version: nginx/1.0.6
nginx: configure arguments: --with-debug --prefix=/usr/share/nginx
--conf-path=/etc/nginx/nginx.conf --sbin-path=/usr/sbin/nginx
--http-log-path=/var/log/nginx/access.log
--error-log-path=/var/log/nginx/error.log --pid-path=/var/run/nginx.pid
--user=nginx --group=nginx --with-http_geoip_module
--with-http_gzip_static_module --with-http_realip_module
--with-http_secure_link_module --with-http_stub_status_module
--add-module=../chaoslawful-drizzle-nginx-module-1fc3af0
--add-module=../agentzh-echo-nginx-module-13dd12f
--add-module=../ngx-fancyindex-0.3.1
--add-module=../agentzh-headers-more-nginx-module-137855d
--add-module=../ngx_http_upstream_keepalive-2ee28064a04a
--add-module=../agentzh-memc-nginx-module-4f1952c
--add-module=../simpl-ngx_devel_kit-bc97eea
--add-module=../chaoslawful-lua-nginx-module-dd0d4d0
--add-module=../agentzh-rds-csv-nginx-module-eb697d1
--add-module=../agentzh-rds-json-nginx-module-376db1f

# cat /etc/nginx/nginx.conf
##
##  /etc/nginx/nginx.conf
##

worker_processes                        3;

events {
    worker_connections                  1024;
}

http {
    server_tokens                       off;

    include                             nginx.mime.types;
    default_type                        application/octet-stream;

    sendfile                            on;
    keepalive_timeout                   15;

    server {
        listen                          0.0.0.0:90;
        server_name                     _;

        location                        / {
            root                        html;
            index                       index.html;
        }

        access_log                      /var/log/nginx/access90.log;
        error_log                       /var/log/nginx/error90.log 
debug;
    }

    server {
        listen                          0.0.0.0:91;
        server_name                     _;

        location                        / {
            rewrite                     ^/foo/(.*)$  /$1  break;

            proxy_pass                  http://localhost:90;
            proxy_redirect              off;
        }

        access_log                      /var/log/nginx/access91.log;
        error_log                       /var/log/nginx/error91.log 
debug;
    }

    server {
        listen                          0.0.0.0:92;
        server_name                     _;

        location                        / {
            set                         $backend  "localhost:90";

            rewrite                     ^/foo/(.*)$  /$1  break;

            resolver                    127.0.0.1;

            proxy_pass                  http://$backend;
            proxy_redirect              off;
        }

        access_log                      /var/log/nginx/access92.log;
        error_log                       /var/log/nginx/error92.log 
debug;
    }
}

$ curl -s -o - -D - http://localhost:92/foo/
HTTP/1.1 404 Not Found
Server: nginx
Date: Thu, 29 Sep 2011 07:21:07 GMT
Content-Type: text/html
Connection: keep-alive
Content-Length: 162

<html>
<head><title>404 Not Found</title></head>
<body bgcolor="white">
<center><h1>404 Not Found</h1></center>
<hr><center>nginx</center>
</body>
</html>

# cat access92.log
127.0.0.1 - - [29/Sep/2011:09:21:07 +0200] "GET /foo/ HTTP/1.1" 404 162
"-" "curl/7.15.5 (i686-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b
zlib/1.2.3 libidn/0.6.5"

# cat access90.log
127.0.0.1 - - [29/Sep/2011:09:21:07 +0200] "GET /foo/ HTTP/1.0" 404 162
"-" "curl/7.15.5 (i686-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b
zlib/1.2.3 libidn/0.6.5"

# cat error92.log
2011/09/29 09:21:05 [debug] 3565#0: epoll add event: fd:13 op:1
ev:00000001
2011/09/29 09:21:07 [debug] 3565#0: post event 0A15AC50
2011/09/29 09:21:07 [debug] 3565#0: delete posted event 0A15AC50
2011/09/29 09:21:07 [debug] 3565#0: accept on 0.0.0.0:92, ready: 0
2011/09/29 09:21:07 [debug] 3565#0: posix_memalign: 0A11BC80:256 @16
2011/09/29 09:21:07 [debug] 3565#0: *1 accept: 127.0.0.1 fd:17
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer add: 17:
60000:3020934938
2011/09/29 09:21:07 [debug] 3565#0: *1 epoll add event: fd:17 op:1
ev:80000001
2011/09/29 09:21:07 [debug] 3565#0: *1 post event 0A15ACB8
2011/09/29 09:21:07 [debug] 3565#0: *1 delete posted event 0A15ACB8
2011/09/29 09:21:07 [debug] 3565#0: *1 malloc: 0A124890:664
2011/09/29 09:21:07 [debug] 3565#0: *1 malloc: 0A124B30:1024
2011/09/29 09:21:07 [debug] 3565#0: *1 posix_memalign: 0A121C90:4096
@16
2011/09/29 09:21:07 [debug] 3565#0: *1 http process request line
2011/09/29 09:21:07 [debug] 3565#0: *1 recv: fd:17 158 of 1024
2011/09/29 09:21:07 [debug] 3565#0: *1 http request line: "GET /foo/
HTTP/1.1"
2011/09/29 09:21:07 [debug] 3565#0: *1 http uri: "/foo/"
2011/09/29 09:21:07 [debug] 3565#0: *1 http args: ""
2011/09/29 09:21:07 [debug] 3565#0: *1 http exten: ""
2011/09/29 09:21:07 [debug] 3565#0: *1 http process request header line
2011/09/29 09:21:07 [debug] 3565#0: *1 http header: "User-Agent:
curl/7.15.5 (i686-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b
zlib/1.2.3 libidn/0.6.5"
2011/09/29 09:21:07 [debug] 3565#0: *1 http header: "Host:
localhost:92"
2011/09/29 09:21:07 [debug] 3565#0: *1 http header: "Accept: */*"
2011/09/29 09:21:07 [debug] 3565#0: *1 http header done
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer del: 17: 3020934938
2011/09/29 09:21:07 [debug] 3565#0: *1 generic phase: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 rewrite phase: 1
2011/09/29 09:21:07 [debug] 3565#0: *1 test location: "/"
2011/09/29 09:21:07 [debug] 3565#0: *1 using configuration "/"
2011/09/29 09:21:07 [debug] 3565#0: *1 http cl:-1 max:1048576
2011/09/29 09:21:07 [debug] 3565#0: *1 rewrite phase: 3
2011/09/29 09:21:07 [debug] 3565#0: *1 http script value:
"localhost:90"
2011/09/29 09:21:07 [debug] 3565#0: *1 http script set $backend
2011/09/29 09:21:07 [debug] 3565#0: *1 http script regex: "^/foo/(.*)$"
2011/09/29 09:21:07 [notice] 3565#0: *1 "^/foo/(.*)$" matches "/foo/",
client: 127.0.0.1, server: _, request: "GET /foo/ HTTP/1.1", host:
"localhost:92"
2011/09/29 09:21:07 [debug] 3565#0: *1 http script copy: "/"
2011/09/29 09:21:07 [debug] 3565#0: *1 http script capture: ""
2011/09/29 09:21:07 [debug] 3565#0: *1 http script regex end
2011/09/29 09:21:07 [notice] 3565#0: *1 rewritten data: "/", args: "",
client: 127.0.0.1, server: _, request: "GET /foo/ HTTP/1.1", host:
"localhost:92"
2011/09/29 09:21:07 [debug] 3565#0: *1 post rewrite phase: 4
2011/09/29 09:21:07 [debug] 3565#0: *1 generic phase: 5
2011/09/29 09:21:07 [debug] 3565#0: *1 generic phase: 6
2011/09/29 09:21:07 [debug] 3565#0: *1 generic phase: 7
2011/09/29 09:21:07 [debug] 3565#0: *1 access phase: 8
2011/09/29 09:21:07 [debug] 3565#0: *1 access phase: 9
2011/09/29 09:21:07 [debug] 3565#0: *1 post access phase: 10
2011/09/29 09:21:07 [debug] 3565#0: *1 http script copy: "http://"
2011/09/29 09:21:07 [debug] 3565#0: *1 http script var: "localhost:90"
2011/09/29 09:21:07 [debug] 3565#0: *1 http init upstream, client timer:
0
2011/09/29 09:21:07 [debug] 3565#0: *1 epoll add event: fd:17 op:3
ev:80000005
2011/09/29 09:21:07 [debug] 3565#0: *1 http script copy: "Host: "
2011/09/29 09:21:07 [debug] 3565#0: *1 http script var: "localhost:90"
2011/09/29 09:21:07 [debug] 3565#0: *1 http script copy: "
"
2011/09/29 09:21:07 [debug] 3565#0: *1 http script copy: "Connection:
close
"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header: "User-Agent:
curl/7.15.5 (i686-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b
zlib/1.2.3 libidn/0.6.5"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header: "Accept: */*"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header:
"GET /foo/ HTTP/1.0
Host: localhost:90
Connection: close
User-Agent: curl/7.15.5 (i686-redhat-linux-gnu) libcurl/7.15.5
OpenSSL/0.9.8b zlib/1.2.3 libidn/0.6.5
Accept: */*

"
2011/09/29 09:21:07 [debug] 3565#0: *1 http cleanup add: 0A122630
2011/09/29 09:21:07 [debug] 3565#0: *1 get rr peer, try: 1
2011/09/29 09:21:07 [debug] 3565#0: *1 socket 18
2011/09/29 09:21:07 [debug] 3565#0: *1 epoll add connection: fd:18
ev:80000005
2011/09/29 09:21:07 [debug] 3565#0: *1 connect to 127.0.0.1:90, fd:18
#2
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream connect: -2
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer add: 18:
60000:3020934939
2011/09/29 09:21:07 [debug] 3565#0: *1 http finalize request: -4, "/?"
a:1, c:2
2011/09/29 09:21:07 [debug] 3565#0: *1 http request count:2 blk:0
2011/09/29 09:21:07 [debug] 3565#0: *1 post event 0A167CF4
2011/09/29 09:21:07 [debug] 3565#0: *1 post event 0A167CC0
2011/09/29 09:21:07 [debug] 3565#0: *1 delete posted event 0A167CC0
2011/09/29 09:21:07 [debug] 3565#0: *1 http run request: "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream check client, write
event:1, "/"
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream recv(): -1 (11:
Resource temporarily unavailable)
2011/09/29 09:21:07 [debug] 3565#0: *1 delete posted event 0A167CF4
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream request: "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream send request
handler
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream send request
2011/09/29 09:21:07 [debug] 3565#0: *1 chain writer buf fl:1 s:177
2011/09/29 09:21:07 [debug] 3565#0: *1 chain writer in: 0A12264C
2011/09/29 09:21:07 [debug] 3565#0: *1 writev: 177
2011/09/29 09:21:07 [debug] 3565#0: *1 chain writer out: 00000000
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer del: 18: 3020934939
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer add: 18:
60000:3020934939
2011/09/29 09:21:07 [debug] 3565#0: *1 post event 0A15ACEC
2011/09/29 09:21:07 [debug] 3565#0: *1 post event 0A167CF4
2011/09/29 09:21:07 [debug] 3565#0: *1 delete posted event 0A167CF4
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream request: "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream dummy handler
2011/09/29 09:21:07 [debug] 3565#0: *1 delete posted event 0A15ACEC
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream request: "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream process header
2011/09/29 09:21:07 [debug] 3565#0: *1 malloc: 0A174BF8:4096
2011/09/29 09:21:07 [debug] 3565#0: *1 recv: fd:18 305 of 4096
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy status 404 "404 Not
Found"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header: "Server:
nginx"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header: "Date: Thu, 29
Sep 2011 07:21:07 GMT"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header: "Content-Type:
text/html"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header:
"Content-Length: 162"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header: "Connection:
close"
2011/09/29 09:21:07 [debug] 3565#0: *1 http proxy header done
2011/09/29 09:21:07 [debug] 3565#0: *1 lua capture header filter, uri
"/"
2011/09/29 09:21:07 [debug] 3565#0: *1 HTTP/1.1 404 Not Found
Server: nginx
Date: Thu, 29 Sep 2011 07:21:07 GMT
Content-Type: text/html
Connection: keep-alive
Content-Length: 162

2011/09/29 09:21:07 [debug] 3565#0: *1 write new buf t:1 f:0 0A1227F8,
pos 0A1227F8, size: 148 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 http write filter: l:0 f:0 s:148
2011/09/29 09:21:07 [debug] 3565#0: *1 http cacheable: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream process upstream
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe read upstream: 1
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe preread: 162
2011/09/29 09:21:07 [debug] 3565#0: *1 readv: 1:3791
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe recv chain: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe buf free s:0 t:1 f:0
0A174BF8, pos 0A174C87, size: 162 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 input buf #0
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe write downstream: 1
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe write downstream flush in
2011/09/29 09:21:07 [debug] 3565#0: *1 http output filter "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http copy filter: "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 lua capture body filter, uri "/"
2011/09/29 09:21:07 [debug] 3565#0: *1 http postpone filter "/?"
0A122970
2011/09/29 09:21:07 [debug] 3565#0: *1 write old buf t:1 f:0 0A1227F8,
pos 0A1227F8, size: 148 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 write new buf t:1 f:0 0A174BF8,
pos 0A174C87, size: 162 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 http write filter: l:0 f:0 s:310
2011/09/29 09:21:07 [debug] 3565#0: *1 http copy filter: 0 "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 pipe write downstream done
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer: 18, old: 3020934939,
new: 3020934939
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream exit: 00000000
2011/09/29 09:21:07 [debug] 3565#0: *1 finalize http upstream request:
0
2011/09/29 09:21:07 [debug] 3565#0: *1 finalize http proxy request
2011/09/29 09:21:07 [debug] 3565#0: *1 free rr peer 1 0
2011/09/29 09:21:07 [debug] 3565#0: *1 close http upstream connection:
18
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer del: 18: 3020934939
2011/09/29 09:21:07 [debug] 3565#0: *1 reusable connection: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 http upstream temp fd: -1
2011/09/29 09:21:07 [debug] 3565#0: *1 http output filter "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http copy filter: "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 lua capture body filter, uri "/"
2011/09/29 09:21:07 [debug] 3565#0: *1 http postpone filter "/?"
BF8FAFD8
2011/09/29 09:21:07 [debug] 3565#0: *1 write old buf t:1 f:0 0A1227F8,
pos 0A1227F8, size: 148 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 write old buf t:1 f:0 0A174BF8,
pos 0A174C87, size: 162 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 write new buf t:0 f:0 00000000,
pos 00000000, size: 0 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 http write filter: l:1 f:0 s:310
2011/09/29 09:21:07 [debug] 3565#0: *1 http write filter limit 0
2011/09/29 09:21:07 [debug] 3565#0: *1 writev: 310
2011/09/29 09:21:07 [debug] 3565#0: *1 http write filter 00000000
2011/09/29 09:21:07 [debug] 3565#0: *1 http copy filter: 0 "/?"
2011/09/29 09:21:07 [debug] 3565#0: *1 http finalize request: 0, "/?"
a:1, c:1
2011/09/29 09:21:07 [debug] 3565#0: *1 set http keepalive handler
2011/09/29 09:21:07 [debug] 3565#0: *1 http close request
2011/09/29 09:21:07 [debug] 3565#0: *1 http log handler
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 0A174BF8
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 0A121C90, unused: 483
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer add: 17:
15000:3020889939
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 0A124890
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 0A124B30
2011/09/29 09:21:07 [debug] 3565#0: *1 hc free: 00000000 0
2011/09/29 09:21:07 [debug] 3565#0: *1 hc busy: 00000000 0
2011/09/29 09:21:07 [debug] 3565#0: *1 tcp_nodelay
2011/09/29 09:21:07 [debug] 3565#0: *1 reusable connection: 1
2011/09/29 09:21:07 [debug] 3565#0: *1 post event 0A15ACB8
2011/09/29 09:21:07 [debug] 3565#0: *1 delete posted event 0A15ACB8
2011/09/29 09:21:07 [debug] 3565#0: *1 http keepalive handler
2011/09/29 09:21:07 [debug] 3565#0: *1 malloc: 0A124890:1024
2011/09/29 09:21:07 [debug] 3565#0: *1 recv: fd:17 0 of 1024
2011/09/29 09:21:07 [info] 3565#0: *1 client 127.0.0.1 closed keepalive
connection
2011/09/29 09:21:07 [debug] 3565#0: *1 close http connection: 17
2011/09/29 09:21:07 [debug] 3565#0: *1 event timer del: 17: 3020889939
2011/09/29 09:21:07 [debug] 3565#0: *1 reusable connection: 0
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 0A124890
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 00000000
2011/09/29 09:21:07 [debug] 3565#0: *1 free: 0A11BC80, unused: 56

# cat error90.log
2011/09/29 09:21:05 [debug] 3565#0: epoll add event: fd:11 op:1
ev:00000001
2011/09/29 09:21:07 [debug] 3565#0: post event 0A15ABE8
2011/09/29 09:21:07 [debug] 3565#0: delete posted event 0A15ABE8
2011/09/29 09:21:07 [debug] 3565#0: accept on 0.0.0.0:90, ready: 0
2011/09/29 09:21:07 [debug] 3565#0: posix_memalign: 0A11BE10:256 @16
2011/09/29 09:21:07 [debug] 3565#0: *3 accept: 127.0.0.1 fd:19
2011/09/29 09:21:07 [debug] 3565#0: *3 event timer add: 19:
60000:3020934939
2011/09/29 09:21:07 [debug] 3565#0: *3 epoll add event: fd:19 op:1
ev:80000001
2011/09/29 09:21:07 [debug] 3565#0: *3 post event 0A15AD20
2011/09/29 09:21:07 [debug] 3565#0: *3 delete posted event 0A15AD20
2011/09/29 09:21:07 [debug] 3565#0: *3 malloc: 0A124F38:664
2011/09/29 09:21:07 [debug] 3565#0: *3 malloc: 0A122CA8:1024
2011/09/29 09:21:07 [debug] 3565#0: *3 posix_memalign: 0A1230B0:4096
@16
2011/09/29 09:21:07 [debug] 3565#0: *3 http process request line
2011/09/29 09:21:07 [debug] 3565#0: *3 recv: fd:19 177 of 1024
2011/09/29 09:21:07 [debug] 3565#0: *3 http request line: "GET /foo/
HTTP/1.0"
2011/09/29 09:21:07 [debug] 3565#0: *3 http uri: "/foo/"
2011/09/29 09:21:07 [debug] 3565#0: *3 http args: ""
2011/09/29 09:21:07 [debug] 3565#0: *3 http exten: ""
2011/09/29 09:21:07 [debug] 3565#0: *3 http process request header line
2011/09/29 09:21:07 [debug] 3565#0: *3 http header: "Host:
localhost:90"
2011/09/29 09:21:07 [debug] 3565#0: *3 http header: "Connection: close"
2011/09/29 09:21:07 [debug] 3565#0: *3 http header: "User-Agent:
curl/7.15.5 (i686-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b
zlib/1.2.3 libidn/0.6.5"
2011/09/29 09:21:07 [debug] 3565#0: *3 http header: "Accept: */*"
2011/09/29 09:21:07 [debug] 3565#0: *3 http header done
2011/09/29 09:21:07 [debug] 3565#0: *3 event timer del: 19: 3020934939
2011/09/29 09:21:07 [debug] 3565#0: *3 generic phase: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 rewrite phase: 1
2011/09/29 09:21:07 [debug] 3565#0: *3 test location: "/"
2011/09/29 09:21:07 [debug] 3565#0: *3 using configuration "/"
2011/09/29 09:21:07 [debug] 3565#0: *3 http cl:-1 max:1048576
2011/09/29 09:21:07 [debug] 3565#0: *3 rewrite phase: 3
2011/09/29 09:21:07 [debug] 3565#0: *3 post rewrite phase: 4
2011/09/29 09:21:07 [debug] 3565#0: *3 generic phase: 5
2011/09/29 09:21:07 [debug] 3565#0: *3 generic phase: 6
2011/09/29 09:21:07 [debug] 3565#0: *3 generic phase: 7
2011/09/29 09:21:07 [debug] 3565#0: *3 access phase: 8
2011/09/29 09:21:07 [debug] 3565#0: *3 access phase: 9
2011/09/29 09:21:07 [debug] 3565#0: *3 post access phase: 10
2011/09/29 09:21:07 [debug] 3565#0: *3 content phase: 11
2011/09/29 09:21:07 [debug] 3565#0: *3 open index
"/usr/share/nginx/html/foo/index.html"
2011/09/29 09:21:07 [debug] 3565#0: *3 stat()
"/usr/share/nginx/html/foo/index.html" failed (2: No such file or
directory)
2011/09/29 09:21:07 [debug] 3565#0: *3 http index check dir:
"/usr/share/nginx/html/foo"
2011/09/29 09:21:07 [error] 3565#0: *3
"/usr/share/nginx/html/foo/index.html" is not found (2: No such file or
directory), client: 127.0.0.1, server: _, request: "GET /foo/ HTTP/1.0",
host: "localhost:90"
2011/09/29 09:21:07 [debug] 3565#0: *3 http finalize request: 404,
"/foo/?" a:1, c:1
2011/09/29 09:21:07 [debug] 3565#0: *3 http special response: 404,
"/foo/?"
2011/09/29 09:21:07 [debug] 3565#0: *3 http set discard body
2011/09/29 09:21:07 [debug] 3565#0: *3 lua capture header filter, uri
"/foo/"
2011/09/29 09:21:07 [debug] 3565#0: *3 HTTP/1.1 404 Not Found
Server: nginx
Date: Thu, 29 Sep 2011 07:21:07 GMT
Content-Type: text/html
Content-Length: 162
Connection: close

2011/09/29 09:21:07 [debug] 3565#0: *3 write new buf t:1 f:0 0A12362C,
pos 0A12362C, size: 143 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 http write filter: l:0 f:0 s:143
2011/09/29 09:21:07 [debug] 3565#0: *3 http output filter "/foo/?"
2011/09/29 09:21:07 [debug] 3565#0: *3 http copy filter: "/foo/?"
2011/09/29 09:21:07 [debug] 3565#0: *3 lua capture body filter, uri
"/foo/"
2011/09/29 09:21:07 [debug] 3565#0: *3 http postpone filter "/foo/?"
0A123778
2011/09/29 09:21:07 [debug] 3565#0: *3 write old buf t:1 f:0 0A12362C,
pos 0A12362C, size: 143 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 write new buf t:0 f:0 00000000,
pos 08116EE0, size: 116 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 write new buf t:0 f:0 00000000,
pos 08116920, size: 46 file: 0, size: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 http write filter: l:1 f:0 s:305
2011/09/29 09:21:07 [debug] 3565#0: *3 http write filter limit 0
2011/09/29 09:21:07 [debug] 3565#0: *3 writev: 305
2011/09/29 09:21:07 [debug] 3565#0: *3 http write filter 00000000
2011/09/29 09:21:07 [debug] 3565#0: *3 http copy filter: 0 "/foo/?"
2011/09/29 09:21:07 [debug] 3565#0: *3 http finalize request: 0,
"/foo/?" a:1, c:1
2011/09/29 09:21:07 [debug] 3565#0: *3 event timer add: 19:
5000:3020879939
2011/09/29 09:21:07 [debug] 3565#0: *3 http lingering close handler
2011/09/29 09:21:07 [debug] 3565#0: *3 recv: fd:19 -1 of 4096
2011/09/29 09:21:07 [debug] 3565#0: *3 recv() not ready (11: Resource
temporarily unavailable)
2011/09/29 09:21:07 [debug] 3565#0: *3 lingering read: -2
2011/09/29 09:21:07 [debug] 3565#0: *3 event timer: 19, old: 3020879939,
new: 3020879939
2011/09/29 09:21:07 [debug] 3565#0: *3 post event 0A15AD20
2011/09/29 09:21:07 [debug] 3565#0: *3 delete posted event 0A15AD20
2011/09/29 09:21:07 [debug] 3565#0: *3 http lingering close handler
2011/09/29 09:21:07 [debug] 3565#0: *3 recv: fd:19 0 of 4096
2011/09/29 09:21:07 [debug] 3565#0: *3 lingering read: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 http request count:1 blk:0
2011/09/29 09:21:07 [debug] 3565#0: *3 http close request
2011/09/29 09:21:07 [debug] 3565#0: *3 http log handler
2011/09/29 09:21:07 [debug] 3565#0: *3 free: 0A1230B0, unused: 2143
2011/09/29 09:21:07 [debug] 3565#0: *3 close http connection: 19
2011/09/29 09:21:07 [debug] 3565#0: *3 event timer del: 19: 3020879939
2011/09/29 09:21:07 [debug] 3565#0: *3 reusable connection: 0
2011/09/29 09:21:07 [debug] 3565#0: *3 free: 0A122CA8
2011/09/29 09:21:07 [debug] 3565#0: *3 free: 0A124F38
2011/09/29 09:21:07 [debug] 3565#0: *3 free: 0A11BE10, unused: 56

Any advice how to get rid of the 'foo/" in the proxied request would be
highly welcome.

Posted at Nginx Forum: http://forum.nginx.org/read.php?2,215830,216005#msg-216005



More information about the nginx mailing list