Re: Анонс: статья "Подводные камни при использовании кэширования в nginx"

Slava Kokorin slava.kokorin at gmail.com
Fri Oct 16 16:23:15 MSD 2009


С горем пополам сделал работюащий конфиг.
Но не работает как ожидается.

Судя по логу в nginx кэш смотрит, но ответ туда не кладёт (или я что то
неправильно готовлю.)

Вот кусок конфига:

fastcgi_cache_path /var/cache/nginx levels= keys_zone=wholepage:50m;

server {
  listen       8088;

  location = /cached/index.php {
        fastcgi_pass   127.0.0.1:9000;
        fastcgi_param  SCRIPT_FILENAME  $root/index.php;
        include        fastcgi_params;

        access_log   /var/log/nginx/access_8088_cached.log;

        fastcgi_cache wholepage;
        fastcgi_cache_valid 200 301 302 304 5m;
        fastcgi_cache_key "$request_method|$host|$request_uri";
        fastcgi_hide_header "Set-Cookie";
        fastcgi_ignore_headers "Cache-Control" "Expires";
    }

    location ~ \.php$ {
        fastcgi_pass   127.0.0.1:9000;
        fastcgi_index  index.php;
        fastcgi_param  SCRIPT_FILENAME  $root$fastcgi_script_name;
        include        fastcgi_params;
        fastcgi_connect_timeout 75;

        if ($arg_action ~ dlattach) {
            rewrite /index.php /cached/index.php last;
        }

    }

}

Вот кусок дебаг лога:

2009/10/16 15:55:37 [debug] 21943#0: *107326 accept: 195.62.48.10 fd:72
2009/10/16 15:55:37 [debug] 21943#0: *107326 event timer add: 72:
60000:1563746832
2009/10/16 15:55:37 [debug] 21943#0: *107326 epoll add event: fd:72 op:1
ev:80000001
2009/10/16 15:55:37 [debug] 21943#0: *107326 post event 08BA3A58
2009/10/16 15:55:37 [debug] 21943#0: *107326 delete posted event 08BA3A58
2009/10/16 15:55:37 [debug] 21943#0: *107326 malloc: 08BC8420:672
2009/10/16 15:55:37 [debug] 21943#0: *107326 malloc: 08BC86C8:1024
2009/10/16 15:55:37 [debug] 21943#0: *107326 malloc: 08BC8AD0:4096
2009/10/16 15:55:37 [debug] 21943#0: *107326 http process request line
2009/10/16 15:55:37 [debug] 21943#0: *107326 recv: fd:72 725 of 1024
2009/10/16 15:55:37 [debug] 21943#0: *107326 http request line: "GET
/index.php?action=dlattach;topic=92136.0;attach=678826;image HTTP/1.1"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http uri: "/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http args:
"action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http exten: "php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http process request header
line
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Host:
hostname.tld:8088"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "User-Agent:
Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.1.3) Gecko/20090824
Firefox/3.5.
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Accept:
text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Accept-Language:
en-us,en;q=0.7,ru;q=0.3"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Accept-Encoding:
gzip,deflate"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Accept-Charset:
ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Keep-Alive: 300"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Connection:
keep-alive"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header: "Cache-Control:
max-age=0"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http header done
2009/10/16 15:55:37 [debug] 21943#0: *107326 event timer del: 72: 1563746832
2009/10/16 15:55:37 [debug] 21943#0: *107326 generic phase: 0
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script value:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script set $root
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script regex:
"^/sitemap.xml$"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: "xdebug"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location:
"googlehostedservice.html"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: ~
"\.(jpg|jpeg|xml|gif|css|js|txt|doc|png|ico|zip|rar|mp3|swf|exe)$"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: ~ "\.php$"
2009/10/16 15:55:37 [debug] 21943#0: *107326 using configuration "\.php$"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:55:37 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script regex: "dlattach"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script if
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script regex: "/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script regex end
2009/10/16 15:55:37 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:55:37 [debug] 21943#0: *107326 uri changes: 11
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:55:37 [debug] 21943#0: *107326 test location:
"cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 using configuration
"=/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:55:37 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:55:37 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:55:37 [debug] 21943#0: *107326 generic phase: 4
2009/10/16 15:55:37 [debug] 21943#0: *107326 generic phase: 5
2009/10/16 15:55:37 [debug] 21943#0: *107326 access phase: 6
2009/10/16 15:55:37 [debug] 21943#0: *107326 access phase: 7
2009/10/16 15:55:37 [debug] 21943#0: *107326 post access phase: 8
2009/10/16 15:55:37 [debug] 21943#0: *107326 http init upstream, client
timer: 0
2009/10/16 15:55:37 [debug] 21943#0: *107326 epoll add event: fd:72 op:3
ev:80000005
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "GET"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "|"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "hostname.tld"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "|"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http cache key:
"GET|hostname.tld|/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 add cleanup: 08BC9604
2009/10/16 15:55:37 [debug] 21943#0: *107326 http file cache exists: 0 e:0
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream cache: -5
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:55:37 [debug] 21943#0: *107326 malloc: 08BC9AD8:4096
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"SCRIPT_FILENAME"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param:
"SCRIPT_FILENAME: /usr/local/www/hostname.tld/www/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"QUERY_STRING"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "QUERY_STRING:
action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"REQUEST_METHOD"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "GET"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "REQUEST_METHOD:
GET"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"CONTENT_TYPE"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "CONTENT_TYPE: "
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"CONTENT_LENGTH"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "CONTENT_LENGTH:
"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "SCRIPT_NAME"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "SCRIPT_NAME:
/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "REQUEST_URI"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "REQUEST_URI:
/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"DOCUMENT_URI"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "DOCUMENT_URI:
/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"DOCUMENT_ROOT"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "DOCUMENT_ROOT:
/usr/local/www/hostname.tld/www"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"SERVER_PROTOCOL"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "HTTP/1.1"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param:
"SERVER_PROTOCOL: HTTP/1.1"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"GATEWAY_INTERFACECGI/1.1"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param:
"GATEWAY_INTERFACE: CGI/1.1"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"SERVER_SOFTWARE"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "nginx/"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "0.7.62"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param:
"SERVER_SOFTWARE: nginx/0.7.62"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "REMOTE_ADDR"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "195.62.48.10"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "REMOTE_ADDR:
195.62.48.10"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "REMOTE_PORT"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "65522"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "REMOTE_PORT:
65522"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "SERVER_ADDR"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var:
"192.168.0.265"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "SERVER_ADDR:
192.168.0.265"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "SERVER_PORT"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "8088"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "SERVER_PORT:
8088"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy: "SERVER_NAME"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script var: "hostname.tld"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param: "SERVER_NAME:
hostname.tld"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http script copy:
"REDIRECT_STATUS200"
2009/10/16 15:55:37 [debug] 21943#0: *107326 fastcgi param:
"REDIRECT_STATUS: 200"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http cleanup add: 08BC96E8
2009/10/16 15:55:37 [debug] 21943#0: *107326 get rr peer, try: 1
2009/10/16 15:55:37 [debug] 21943#0: *107326 socket 73
2009/10/16 15:55:37 [debug] 21943#0: *107326 epoll add connection: fd:73
ev:80000005
2009/10/16 15:55:37 [debug] 21943#0: *107326 connect to 127.0.0.1:9000,
fd:73 #107327
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream connect: -2
2009/10/16 15:55:37 [debug] 21943#0: *107326 event timer add: 73:
60000:1563746833
2009/10/16 15:55:37 [debug] 21943#0: *107326 post event 08BB0A60
2009/10/16 15:55:37 [debug] 21943#0: *107326 post event 08BB0A94
2009/10/16 15:55:37 [debug] 21943#0: *107326 delete posted event 08BB0A94
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream send request
handler
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream send request
2009/10/16 15:55:37 [debug] 21943#0: *107326 chain writer buf fl:0 s:1288
2009/10/16 15:55:37 [debug] 21943#0: *107326 chain writer in: 08BC9704
2009/10/16 15:55:37 [debug] 21943#0: *107326 writev: 1288
2009/10/16 15:55:37 [debug] 21943#0: *107326 chain writer out: 00000000
2009/10/16 15:55:37 [debug] 21943#0: *107326 event timer del: 73: 1563746833
2009/10/16 15:55:37 [debug] 21943#0: *107326 event timer add: 73:
60000:1563746834
2009/10/16 15:55:37 [debug] 21943#0: *107326 delete posted event 08BB0A60
2009/10/16 15:55:37 [debug] 21943#0: *107326 http run request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream check client,
write event:1, "/cached/index.php"
2009/10/16 15:55:37 [debug] 21943#0: *107326 http upstream recv(): -1 (11:
Resource temporarily unavailable)
2009/10/16 15:55:41 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http upstream process header
2009/10/16 15:55:41 [debug] 21943#0: *107326 malloc: 08BC5398:4096
2009/10/16 15:55:41 [debug] 21943#0: *107326 recv: fd:73 296 of 3988
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 06
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 00
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 0C
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 04
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record byte: 00
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi record length: 268
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"X-Powered-By: PHP/5.2.8"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header: "Pragma:
no-cache"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"Content-Encoding: none"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header: "Expires:
Sat, 16 Oct 2010 11:55:40 GMT"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"Accept-Ranges: bytes"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"Content-Type: image/jpeg"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"Cache-Control: max-age=31536000, private"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"Content-Length: 57368"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header:
"X-Accel-Redirect: /attachments/67/88/26.file"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi parser: 1
2009/10/16 15:55:41 [debug] 21943#0: *107326 http fastcgi header done
2009/10/16 15:55:41 [debug] 21943#0: *107326 finalize http upstream request:
-5
2009/10/16 15:55:41 [debug] 21943#0: *107326 finalize http fastcgi request
2009/10/16 15:55:41 [debug] 21943#0: *107326 free rr peer 1 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 close http upstream connection:
73
2009/10/16 15:55:41 [debug] 21943#0: *107326 event timer del: 73: 1563746834
2009/10/16 15:55:41 [debug] 21943#0: *107326 http upstream cache fd: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http file cache free
2009/10/16 15:55:41 [debug] 21943#0: *107326 internal redirect:
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 generic phase: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http script value:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http script set $root
2009/10/16 15:55:41 [debug] 21943#0: *107326 http script regex:
"^/sitemap.xml$"
2009/10/16 15:55:41 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:55:41 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:55:41 [debug] 21943#0: *107326 test location:
"cached/index.php"
2009/10/16 15:55:41 [debug] 21943#0: *107326 test location: "attachments"
2009/10/16 15:55:41 [debug] 21943#0: *107326 test location: ~
"\.(jpg|jpeg|xml|gif|css|js|txt|doc|png|ico|zip|rar|mp3|swf|exe)$"
2009/10/16 15:55:41 [debug] 21943#0: *107326 test location: ~ "\.php$"
2009/10/16 15:55:41 [debug] 21943#0: *107326 using configuration
"/attachments"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:55:41 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:55:41 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:55:41 [debug] 21943#0: *107326 generic phase: 4
2009/10/16 15:55:41 [debug] 21943#0: *107326 generic phase: 5
2009/10/16 15:55:41 [debug] 21943#0: *107326 access phase: 6
2009/10/16 15:55:41 [debug] 21943#0: *107326 access phase: 7
2009/10/16 15:55:41 [debug] 21943#0: *107326 post access phase: 8
2009/10/16 15:55:41 [debug] 21943#0: *107326 content phase: 9
2009/10/16 15:55:41 [debug] 21943#0: *107326 content phase: 10
2009/10/16 15:55:41 [debug] 21943#0: *107326 content phase: 11
2009/10/16 15:55:41 [debug] 21943#0: *107326 content phase: 12
2009/10/16 15:55:41 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http filename:
"/usr/local/www/hostname.tld/www/attachments/67/88/26.file"
2009/10/16 15:55:41 [debug] 21943#0: *107326 add cleanup: 08BC9FF0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http static fd: 53
2009/10/16 15:55:41 [debug] 21943#0: *107326 http set discard body
2009/10/16 15:55:41 [debug] 21943#0: *107326 HTTP/1.1 200 OK
2009/10/16 15:55:41 [debug] 21943#0: *107326 write new buf t:1 f:0 08BCA100,
pos 08BCA100, size: 323 file: 0, size: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter: l:0 f:0
s:323
2009/10/16 15:55:41 [debug] 21943#0: *107326 http output filter
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 copy filter:
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http postpone filter
"/attachments/67/88/26.file?" BFB38338
2009/10/16 15:55:41 [debug] 21943#0: *107326 write old buf t:1 f:0 08BCA100,
pos 08BCA100, size: 323 file: 0, size: 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 write new buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 0, size: 57368
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter: l:1 f:0
s:57691
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter limit 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 tcp_nopush
2009/10/16 15:55:41 [debug] 21943#0: *107326 writev: 323
2009/10/16 15:55:41 [debug] 21943#0: *107326 sendfile: @0 57368
2009/10/16 15:55:41 [debug] 21943#0: *107326 sendfile: 37325, @0 37325:57368
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter 08BCA28C
2009/10/16 15:55:41 [debug] 21943#0: *107326 copy filter: -2
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http finalize request: -2,
"/attachments/67/88/26.file?" 1
2009/10/16 15:55:41 [debug] 21943#0: *107326 event timer add: 72:
60000:1563750732
2009/10/16 15:55:41 [debug] 21943#0: *107326 http run request:
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http writer handler:
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http output filter
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 copy filter:
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http postpone filter
"/attachments/67/88/26.file?" 00000000
2009/10/16 15:55:41 [debug] 21943#0: *107326 write old buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 37325, size: 20043
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter: l:1 f:0
s:20043
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter limit 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 sendfile: @37325 20043
2009/10/16 15:55:41 [debug] 21943#0: *107326 sendfile: 20043, @37325
20043:20043
2009/10/16 15:55:41 [debug] 21943#0: *107326 http write filter 00000000
2009/10/16 15:55:41 [debug] 21943#0: *107326 copy filter: 0
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http writer output filter: 0,
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http writer done:
"/attachments/67/88/26.file?"
2009/10/16 15:55:41 [debug] 21943#0: *107326 http finalize request: 0,
"/attachments/67/88/26.file?" 1
2009/10/16 15:55:41 [debug] 21943#0: *107326 event timer del: 72: 1563750732
2009/10/16 15:55:41 [debug] 21943#0: *107326 set http keepalive handler
2009/10/16 15:55:41 [debug] 21943#0: *107326 http close request
2009/10/16 15:55:41 [debug] 21943#0: *107326 http log handler
2009/10/16 15:55:41 [debug] 21943#0: *107326 run cleanup: 08BC9FF0
2009/10/16 15:55:41 [debug] 21943#0: *107326 file cleanup: fd:53
2009/10/16 15:55:41 [debug] 21943#0: *107326 run cleanup: 08BC9604
2009/10/16 15:55:41 [debug] 21943#0: *107326 free: 08BC5398
2009/10/16 15:55:41 [debug] 21943#0: *107326 free: 08BC8AD0, unused: 2
2009/10/16 15:55:41 [debug] 21943#0: *107326 free: 08BC9AD8, unused: 1853
2009/10/16 15:55:41 [debug] 21943#0: *107326 event timer add: 72:
65000:1563755980
2009/10/16 15:55:41 [debug] 21943#0: *107326 free: 08BC8420
2009/10/16 15:55:41 [debug] 21943#0: *107326 free: 08BC86C8
2009/10/16 15:55:41 [debug] 21943#0: *107326 hc free: 00000000 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 hc busy: 00000000 0
2009/10/16 15:55:41 [debug] 21943#0: *107326 post event 08BA3A58
2009/10/16 15:55:41 [debug] 21943#0: *107326 delete posted event 08BA3A58
2009/10/16 15:55:41 [debug] 21943#0: *107326 http keepalive handler
2009/10/16 15:55:41 [debug] 21943#0: *107326 malloc: 08C14100:1024
2009/10/16 15:55:41 [debug] 21943#0: *107326 recv: fd:72 -1 of 1024
2009/10/16 15:55:41 [debug] 21943#0: *107326 recv() not ready (11: Resource
temporarily unavailable)
2009/10/16 15:56:34 [debug] 21943#0: *107326 http keepalive handler
2009/10/16 15:56:34 [debug] 21943#0: *107326 recv: fd:72 742 of 1024
2009/10/16 15:56:34 [debug] 21943#0: *107326 malloc: 08BF17F8:672
2009/10/16 15:56:34 [debug] 21943#0: *107326 malloc: 08C05C40:4096
2009/10/16 15:56:34 [debug] 21943#0: *107326 http process request line
2009/10/16 15:56:34 [debug] 21943#0: *107326 http request line: "GET
/index.php?action=dlattach;topic=92136.0;attach=678826;image HTTP/1.1"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http uri: "/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http args:
"action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http exten: "php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http process request header
line
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Host:
hostname.tld:8088"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "User-Agent:
Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.1.3) Gecko/20090824
Firefox/3.5.
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Accept:
text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Accept:
text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Accept-Language:
en-us,en;q=0.7,ru;q=0.3"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Accept-Encoding:
gzip,deflate"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Accept-Charset:
ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Keep-Alive: 300"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Connection:
keep-alive"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Pragma: no-cache"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header: "Cache-Control:
no-cache"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http header done
2009/10/16 15:56:34 [debug] 21943#0: *107326 event timer del: 72: 1563755980
2009/10/16 15:56:34 [debug] 21943#0: *107326 generic phase: 0
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script value:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script set $root
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script regex:
"^/sitemap.xml$"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: "xdebug"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location:
"googlehostedservice.html"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: ~
"\.(jpg|jpeg|xml|gif|css|js|txt|doc|png|ico|zip|rar|mp3|swf|exe)$"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: ~ "\.php$"
2009/10/16 15:56:34 [debug] 21943#0: *107326 using configuration "\.php$"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:56:34 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script regex: "dlattach"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script if
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script regex: "/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script regex end
2009/10/16 15:56:34 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:56:34 [debug] 21943#0: *107326 uri changes: 11
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:56:34 [debug] 21943#0: *107326 test location:
"cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 using configuration
"=/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:56:34 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:56:34 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:56:34 [debug] 21943#0: *107326 generic phase: 4
2009/10/16 15:56:34 [debug] 21943#0: *107326 generic phase: 5
2009/10/16 15:56:34 [debug] 21943#0: *107326 access phase: 6
2009/10/16 15:56:34 [debug] 21943#0: *107326 access phase: 7
2009/10/16 15:56:34 [debug] 21943#0: *107326 post access phase: 8
2009/10/16 15:56:34 [debug] 21943#0: *107326 http init upstream, client
timer: 0
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "GET"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "|"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "hostname.tld"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "|"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http cache key:
"GET|hostname.tld|/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 add cleanup: 08C0677C
2009/10/16 15:56:34 [debug] 21943#0: *107326 http file cache exists: 0 e:0
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream cache: -5
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:34 [debug] 21943#0: *107326 malloc: 08C37AB0:4096
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"SCRIPT_FILENAME"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param:
"SCRIPT_FILENAME: /usr/local/www/hostname.tld/www/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"QUERY_STRING"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "QUERY_STRING:
action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"REQUEST_METHOD"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "GET"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "REQUEST_METHOD:
GET"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"CONTENT_TYPE"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "CONTENT_TYPE: "
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"CONTENT_LENGTH"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "CONTENT_LENGTH:
"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "SCRIPT_NAME"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "SCRIPT_NAME:
/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "REQUEST_URI"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "REQUEST_URI:
/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"DOCUMENT_URI"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "DOCUMENT_URI:
/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"DOCUMENT_ROOT"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "DOCUMENT_ROOT:
/usr/local/www/hostname.tld/www"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"SERVER_PROTOCOL"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "HTTP/1.1"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param:
"SERVER_PROTOCOL: HTTP/1.1"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"GATEWAY_INTERFACECGI/1.1"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param:
"GATEWAY_INTERFACE: CGI/1.1"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"SERVER_SOFTWARE"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "nginx/"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "0.7.62"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param:
"SERVER_SOFTWARE: nginx/0.7.62"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "REMOTE_ADDR"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "195.62.48.10"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "REMOTE_ADDR:
195.62.48.10"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "REMOTE_PORT"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "65522"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "REMOTE_PORT:
65522"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "SERVER_ADDR"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var:
"192.168.0.265"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "SERVER_ADDR:
192.168.0.265"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "SERVER_PORT"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "8088"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "SERVER_PORT:
8088"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy: "SERVER_NAME"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script var: "hostname.tld"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param: "SERVER_NAME:
hostname.tld"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http script copy:
"REDIRECT_STATUS200"
2009/10/16 15:56:34 [debug] 21943#0: *107326 fastcgi param:
"REDIRECT_STATUS: 200"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http cleanup add: 08C06860
2009/10/16 15:56:34 [debug] 21943#0: *107326 get rr peer, try: 1
2009/10/16 15:56:34 [debug] 21943#0: *107326 socket 198
2009/10/16 15:56:34 [debug] 21943#0: *107326 epoll add connection: fd:198
ev:80000005
2009/10/16 15:56:34 [debug] 21943#0: *107326 connect to 127.0.0.1:9000,
fd:198 #111619
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream connect: -2
2009/10/16 15:56:34 [debug] 21943#0: *107326 event timer add: 198:
60000:1563804182
2009/10/16 15:56:34 [debug] 21943#0: *107326 http run request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream check client,
write event:1, "/cached/index.php"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream recv(): -1 (11:
Resource temporarily unavailable)
2009/10/16 15:56:34 [debug] 21943#0: *107326 post event 08BB2A78
2009/10/16 15:56:34 [debug] 21943#0: *107326 delete posted event 08BB2A78
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream send request
handler
2009/10/16 15:56:34 [debug] 21943#0: *107326 http upstream send request
2009/10/16 15:56:34 [debug] 21943#0: *107326 chain writer buf fl:0 s:1304
2009/10/16 15:56:34 [debug] 21943#0: *107326 chain writer in: 08C0687C
2009/10/16 15:56:34 [debug] 21943#0: *107326 writev: 1304
2009/10/16 15:56:34 [debug] 21943#0: *107326 chain writer out: 00000000
2009/10/16 15:56:34 [debug] 21943#0: *107326 event timer del: 198:
1563804182
2009/10/16 15:56:34 [debug] 21943#0: *107326 event timer add: 198:
60000:1563804182
2009/10/16 15:56:36 [debug] 21943#0: *107326 post event 08BA5A70
2009/10/16 15:56:36 [debug] 21943#0: *107326 post event 08BB2A78
2009/10/16 15:56:36 [debug] 21943#0: *107326 delete posted event 08BB2A78
2009/10/16 15:56:36 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http upstream dummy handler
2009/10/16 15:56:36 [debug] 21943#0: *107326 delete posted event 08BA5A70
2009/10/16 15:56:36 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678826;image"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http upstream process header
2009/10/16 15:56:36 [debug] 21943#0: *107326 malloc: 08C616A8:4096
2009/10/16 15:56:36 [debug] 21943#0: *107326 recv: fd:198 296 of 3988
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 06
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 00
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 0C
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 04
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record byte: 00
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi record length: 268
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"X-Powered-By: PHP/5.2.8"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header: "Pragma:
no-cache"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"Content-Encoding: none"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header: "Expires:
Sat, 16 Oct 2010 11:56:36 GMT"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"Accept-Ranges: bytes"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"Content-Type: image/jpeg"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"Cache-Control: max-age=31536000, private"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"Content-Length: 57368"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header:
"X-Accel-Redirect: /attachments/67/88/26.file"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi parser: 1
2009/10/16 15:56:36 [debug] 21943#0: *107326 http fastcgi header done
2009/10/16 15:56:36 [debug] 21943#0: *107326 finalize http upstream request:
-5
2009/10/16 15:56:36 [debug] 21943#0: *107326 finalize http fastcgi request
2009/10/16 15:56:36 [debug] 21943#0: *107326 free rr peer 1 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 close http upstream connection:
198
2009/10/16 15:56:36 [debug] 21943#0: *107326 event timer del: 198:
1563804182
2009/10/16 15:56:36 [debug] 21943#0: *107326 http upstream cache fd: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http file cache free
2009/10/16 15:56:36 [debug] 21943#0: *107326 internal redirect:
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 generic phase: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http script value:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http script set $root
2009/10/16 15:56:36 [debug] 21943#0: *107326 http script regex:
"^/sitemap.xml$"
2009/10/16 15:56:36 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:56:36 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:56:36 [debug] 21943#0: *107326 test location:
"cached/index.php"
2009/10/16 15:56:36 [debug] 21943#0: *107326 test location: "attachments"
2009/10/16 15:56:36 [debug] 21943#0: *107326 test location: ~
"\.(jpg|jpeg|xml|gif|css|js|txt|doc|png|ico|zip|rar|mp3|swf|exe)$"
2009/10/16 15:56:36 [debug] 21943#0: *107326 test location: ~ "\.php$"
2009/10/16 15:56:36 [debug] 21943#0: *107326 using configuration
"/attachments"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:56:36 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:56:36 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:56:36 [debug] 21943#0: *107326 generic phase: 4
2009/10/16 15:56:36 [debug] 21943#0: *107326 generic phase: 5
2009/10/16 15:56:36 [debug] 21943#0: *107326 access phase: 6
2009/10/16 15:56:36 [debug] 21943#0: *107326 access phase: 7
2009/10/16 15:56:36 [debug] 21943#0: *107326 post access phase: 8
2009/10/16 15:56:36 [debug] 21943#0: *107326 content phase: 9
2009/10/16 15:56:36 [debug] 21943#0: *107326 content phase: 10
2009/10/16 15:56:36 [debug] 21943#0: *107326 content phase: 11
2009/10/16 15:56:36 [debug] 21943#0: *107326 content phase: 12
2009/10/16 15:56:36 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http filename:
"/usr/local/www/hostname.tld/www/attachments/67/88/26.file"
2009/10/16 15:56:36 [debug] 21943#0: *107326 add cleanup: 08C06C0C
2009/10/16 15:56:36 [debug] 21943#0: *107326 http static fd: 198
2009/10/16 15:56:36 [debug] 21943#0: *107326 http set discard body
2009/10/16 15:56:36 [debug] 21943#0: *107326 HTTP/1.1 200 OK
2009/10/16 15:56:36 [debug] 21943#0: *107326 write new buf t:1 f:0 08C38100,
pos 08C38100, size: 323 file: 0, size: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter: l:0 f:0
s:323
2009/10/16 15:56:36 [debug] 21943#0: *107326 http output filter
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 copy filter:
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http postpone filter
"/attachments/67/88/26.file?" BFB38358
2009/10/16 15:56:36 [debug] 21943#0: *107326 write old buf t:1 f:0 08C38100,
pos 08C38100, size: 323 file: 0, size: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 write new buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 0, size: 57368
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter: l:1 f:0
s:57691
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter limit 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 tcp_nopush
2009/10/16 15:56:36 [debug] 21943#0: *107326 writev: 323
2009/10/16 15:56:36 [debug] 21943#0: *107326 sendfile: @0 57368
2009/10/16 15:56:36 [debug] 21943#0: *107326 sendfile: 37325, @0 37325:57368
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter 08C06C38
2009/10/16 15:56:36 [debug] 21943#0: *107326 copy filter: -2
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http finalize request: -2,
"/attachments/67/88/26.file?" 1
2009/10/16 15:56:36 [debug] 21943#0: *107326 event timer add: 72:
60000:1563806105
2009/10/16 15:56:36 [debug] 21943#0: *107326 post event 08BB0A60
2009/10/16 15:56:36 [debug] 21943#0: *107326 delete posted event 08BB0A60
2009/10/16 15:56:36 [debug] 21943#0: *107326 http run request:
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http writer handler:
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http output filter
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 copy filter:
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http postpone filter
"/attachments/67/88/26.file?" 00000000
2009/10/16 15:56:36 [debug] 21943#0: *107326 write old buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 37325, size: 20043
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter: l:1 f:0
s:20043
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter limit 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 sendfile: @37325 20043
2009/10/16 15:56:36 [debug] 21943#0: *107326 sendfile: 20043, @37325
20043:20043
2009/10/16 15:56:36 [debug] 21943#0: *107326 http write filter 00000000
2009/10/16 15:56:36 [debug] 21943#0: *107326 copy filter: 0
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http writer output filter: 0,
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http writer done:
"/attachments/67/88/26.file?"
2009/10/16 15:56:36 [debug] 21943#0: *107326 http finalize request: 0,
"/attachments/67/88/26.file?" 1
2009/10/16 15:56:36 [debug] 21943#0: *107326 event timer del: 72: 1563806105
2009/10/16 15:56:36 [debug] 21943#0: *107326 set http keepalive handler
2009/10/16 15:56:36 [debug] 21943#0: *107326 http close request
2009/10/16 15:56:36 [debug] 21943#0: *107326 http log handler
2009/10/16 15:56:36 [debug] 21943#0: *107326 run cleanup: 08C06C0C
2009/10/16 15:56:36 [debug] 21943#0: *107326 file cleanup: fd:198
2009/10/16 15:56:36 [debug] 21943#0: *107326 run cleanup: 08C0677C
2009/10/16 15:56:36 [debug] 21943#0: *107326 free: 08C616A8
2009/10/16 15:56:36 [debug] 21943#0: *107326 free: 08C05C40, unused: 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 free: 08C37AB0, unused: 1829
2009/10/16 15:56:36 [debug] 21943#0: *107326 event timer add: 72:
65000:1563811411
2009/10/16 15:56:36 [debug] 21943#0: *107326 free: 08BF17F8
2009/10/16 15:56:36 [debug] 21943#0: *107326 free: 08C14100
2009/10/16 15:56:36 [debug] 21943#0: *107326 hc free: 00000000 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 hc busy: 00000000 0
2009/10/16 15:56:36 [debug] 21943#0: *107326 post event 08BA3A58
2009/10/16 15:56:36 [debug] 21943#0: *107326 delete posted event 08BA3A58
2009/10/16 15:56:36 [debug] 21943#0: *107326 http keepalive handler
2009/10/16 15:56:36 [debug] 21943#0: *107326 malloc: 08C7E730:1024
2009/10/16 15:56:36 [debug] 21943#0: *107326 recv: fd:72 -1 of 1024
2009/10/16 15:56:36 [debug] 21943#0: *107326 recv() not ready (11: Resource
temporarily unavailable)
2009/10/16 15:56:58 [debug] 21943#0: *107326 http keepalive handler
2009/10/16 15:56:58 [debug] 21943#0: *107326 recv: fd:72 699 of 1024
2009/10/16 15:56:58 [debug] 21943#0: *107326 malloc: 08BED990:672
2009/10/16 15:56:58 [debug] 21943#0: *107326 malloc: 08BDF6F0:4096
2009/10/16 15:56:58 [debug] 21943#0: *107326 http process request line
2009/10/16 15:56:58 [debug] 21943#0: *107326 http request line: "GET
/index.php?action=dlattach;topic=92136.0;attach=678824;image HTTP/1.1"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http uri: "/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http args:
"action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http exten: "php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http process request header
line
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Host:
hostname.tld:8088"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "User-Agent:
Mozilla/5.0 (Windows; U; Windows NT 5.1; en-US; rv:1.9.1.3) Gecko/20090824
Firefox/3.5.
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Accept:
text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Accept-Language:
en-us,en;q=0.7,ru;q=0.3"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Accept-Encoding:
gzip,deflate"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Accept-Charset:
ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Keep-Alive: 300"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header: "Connection:
keep-alive"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http header done
2009/10/16 15:56:58 [debug] 21943#0: *107326 event timer del: 72: 1563811411
2009/10/16 15:56:58 [debug] 21943#0: *107326 generic phase: 0
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script value:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script set $root
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script regex:
"^/sitemap.xml$"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: "xdebug"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location:
"googlehostedservice.html"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: ~
"\.(jpg|jpeg|xml|gif|css|js|txt|doc|png|ico|zip|rar|mp3|swf|exe)$"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: ~ "\.php$"
2009/10/16 15:56:58 [debug] 21943#0: *107326 using configuration "\.php$"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:56:58 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script regex: "dlattach"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script if
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script regex: "/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script regex end
2009/10/16 15:56:58 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:56:58 [debug] 21943#0: *107326 uri changes: 11
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:56:58 [debug] 21943#0: *107326 test location:
"cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 using configuration
"=/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:56:58 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:56:58 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:56:58 [debug] 21943#0: *107326 generic phase: 4
2009/10/16 15:56:58 [debug] 21943#0: *107326 generic phase: 5
2009/10/16 15:56:58 [debug] 21943#0: *107326 access phase: 6
2009/10/16 15:56:58 [debug] 21943#0: *107326 access phase: 7
2009/10/16 15:56:58 [debug] 21943#0: *107326 post access phase: 8
2009/10/16 15:56:58 [debug] 21943#0: *107326 http init upstream, client
timer: 0
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "GET"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "|"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "hostname.tld"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "|"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http cache key:
"GET|hostname.tld|/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 add cleanup: 08BE0218
2009/10/16 15:56:58 [debug] 21943#0: *107326 http file cache exists: -5 e:0
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream cache: -5
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:58 [debug] 21943#0: *107326 malloc: 08CAD428:4096
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"SCRIPT_FILENAME"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param:
"SCRIPT_FILENAME: /usr/local/www/hostname.tld/www/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"QUERY_STRING"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "QUERY_STRING:
action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"REQUEST_METHOD"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "GET"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "REQUEST_METHOD:
GET"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"CONTENT_TYPE"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "CONTENT_TYPE: "
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"CONTENT_LENGTH"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "CONTENT_LENGTH:
"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "SCRIPT_NAME"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "SCRIPT_NAME:
/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "REQUEST_URI"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "REQUEST_URI:
/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"DOCUMENT_URI"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "DOCUMENT_URI:
/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"DOCUMENT_ROOT"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "DOCUMENT_ROOT:
/usr/local/www/hostname.tld/www"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"SERVER_PROTOCOL"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "HTTP/1.1"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param:
"SERVER_PROTOCOL: HTTP/1.1"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"GATEWAY_INTERFACECGI/1.1"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param:
"GATEWAY_INTERFACE: CGI/1.1"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"SERVER_SOFTWARE"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "nginx/"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "0.7.62"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param:
"SERVER_SOFTWARE: nginx/0.7.62"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "REMOTE_ADDR"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "195.62.48.10"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "REMOTE_ADDR:
195.62.48.10"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "REMOTE_PORT"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "65522"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "REMOTE_PORT:
65522"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "SERVER_ADDR"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var:
"192.168.0.265"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "SERVER_ADDR:
192.168.0.265"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "SERVER_PORT"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "8088"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "SERVER_PORT:
8088"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy: "SERVER_NAME"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script var: "hostname.tld"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param: "SERVER_NAME:
hostname.tld"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http script copy:
"REDIRECT_STATUS200"
2009/10/16 15:56:58 [debug] 21943#0: *107326 fastcgi param:
"REDIRECT_STATUS: 200"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http cleanup add: 08BE02FC
2009/10/16 15:56:58 [debug] 21943#0: *107326 get rr peer, try: 1
2009/10/16 15:56:58 [debug] 21943#0: *107326 socket 105
2009/10/16 15:56:58 [debug] 21943#0: *107326 epoll add connection: fd:105
ev:80000005
2009/10/16 15:56:58 [debug] 21943#0: *107326 connect to 127.0.0.1:9000,
fd:105 #113280
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream connect: -2
2009/10/16 15:56:58 [debug] 21943#0: *107326 event timer add: 105:
60000:1563828474
2009/10/16 15:56:58 [debug] 21943#0: *107326 http run request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream check client,
write event:1, "/cached/index.php"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream recv(): -1 (11:
Resource temporarily unavailable)
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream send request
handler
2009/10/16 15:56:58 [debug] 21943#0: *107326 http upstream send request
2009/10/16 15:56:58 [debug] 21943#0: *107326 chain writer buf fl:0 s:1256
2009/10/16 15:56:58 [debug] 21943#0: *107326 chain writer in: 08BE0318
2009/10/16 15:56:58 [debug] 21943#0: *107326 writev: 1256
2009/10/16 15:56:58 [debug] 21943#0: *107326 chain writer out: 00000000
2009/10/16 15:56:58 [debug] 21943#0: *107326 event timer del: 105:
1563828474
2009/10/16 15:56:58 [debug] 21943#0: *107326 event timer add: 105:
60000:1563828475
2009/10/16 15:57:12 [debug] 21943#0: *107326 post event 08BA74A4
2009/10/16 15:57:12 [debug] 21943#0: *107326 post event 08BB44AC
2009/10/16 15:57:12 [debug] 21943#0: *107326 delete posted event 08BB44AC
2009/10/16 15:57:12 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http upstream dummy handler
2009/10/16 15:57:12 [debug] 21943#0: *107326 delete posted event 08BA74A4
2009/10/16 15:57:12 [debug] 21943#0: *107326 http upstream request:
"/cached/index.php?action=dlattach;topic=92136.0;attach=678824;image"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http upstream process header
2009/10/16 15:57:12 [debug] 21943#0: *107326 malloc: 08B41B88:4096
2009/10/16 15:57:12 [debug] 21943#0: *107326 recv: fd:105 296 of 3988
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 06
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 00
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 01
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 0C
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 04
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record byte: 00
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi record length: 268
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"X-Powered-By: PHP/5.2.8"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header: "Pragma:
no-cache"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"Content-Encoding: none"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header: "Expires:
Sat, 16 Oct 2010 11:57:11 GMT"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"Accept-Ranges: bytes"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"Content-Type: image/jpeg"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"Cache-Control: max-age=31536000, private"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"Content-Length: 72075"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header:
"X-Accel-Redirect: /attachments/67/88/24.file"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi parser: 1
2009/10/16 15:57:12 [debug] 21943#0: *107326 http fastcgi header done
2009/10/16 15:57:12 [debug] 21943#0: *107326 finalize http upstream request:
-5
2009/10/16 15:57:12 [debug] 21943#0: *107326 finalize http fastcgi request
2009/10/16 15:57:12 [debug] 21943#0: *107326 free rr peer 1 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 close http upstream connection:
105
2009/10/16 15:57:12 [debug] 21943#0: *107326 event timer del: 105:
1563828475
2009/10/16 15:57:12 [debug] 21943#0: *107326 http upstream cache fd: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http file cache free
2009/10/16 15:57:12 [debug] 21943#0: *107326 internal redirect:
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 generic phase: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http script value:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http script set $root
2009/10/16 15:57:12 [debug] 21943#0: *107326 http script regex:
"^/sitemap.xml$"
2009/10/16 15:57:12 [debug] 21943#0: *107326 test location: "/"
2009/10/16 15:57:12 [debug] 21943#0: *107326 test location: "gallery"
2009/10/16 15:57:12 [debug] 21943#0: *107326 test location:
"cached/index.php"
2009/10/16 15:57:12 [debug] 21943#0: *107326 test location: "attachments"
2009/10/16 15:57:12 [debug] 21943#0: *107326 test location: ~
"\.(jpg|jpeg|xml|gif|css|js|txt|doc|png|ico|zip|rar|mp3|swf|exe)$"
2009/10/16 15:57:12 [debug] 21943#0: *107326 test location: ~ "\.php$"
2009/10/16 15:57:12 [debug] 21943#0: *107326 using configuration
"/attachments"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http cl:-1 max:20971520
2009/10/16 15:57:12 [debug] 21943#0: *107326 generic phase: 2
2009/10/16 15:57:12 [debug] 21943#0: *107326 post rewrite phase: 3
2009/10/16 15:57:12 [debug] 21943#0: *107326 generic phase: 4
2009/10/16 15:57:12 [debug] 21943#0: *107326 generic phase: 5
2009/10/16 15:57:12 [debug] 21943#0: *107326 access phase: 6
2009/10/16 15:57:12 [debug] 21943#0: *107326 access phase: 7
2009/10/16 15:57:12 [debug] 21943#0: *107326 post access phase: 8
2009/10/16 15:57:12 [debug] 21943#0: *107326 content phase: 9
2009/10/16 15:57:12 [debug] 21943#0: *107326 content phase: 10
2009/10/16 15:57:12 [debug] 21943#0: *107326 content phase: 11
2009/10/16 15:57:12 [debug] 21943#0: *107326 content phase: 12
2009/10/16 15:57:12 [debug] 21943#0: *107326 http script var:
"/usr/local/www/hostname.tld/www"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http filename:
"/usr/local/www/hostname.tld/www/attachments/67/88/24.file"
2009/10/16 15:57:12 [debug] 21943#0: *107326 add cleanup: 08BE06E4
2009/10/16 15:57:12 [debug] 21943#0: *107326 http static fd: 105
2009/10/16 15:57:12 [debug] 21943#0: *107326 http set discard body
2009/10/16 15:57:12 [debug] 21943#0: *107326 HTTP/1.1 200 OK
2009/10/16 15:57:12 [debug] 21943#0: *107326 write new buf t:1 f:0 08CADA24,
pos 08CADA24, size: 323 file: 0, size: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter: l:0 f:0
s:323
2009/10/16 15:57:12 [debug] 21943#0: *107326 http output filter
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 copy filter:
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http postpone filter
"/attachments/67/88/24.file?" BFB38358
2009/10/16 15:57:12 [debug] 21943#0: *107326 write old buf t:1 f:0 08CADA24,
pos 08CADA24, size: 323 file: 0, size: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 write new buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 0, size: 72075
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter: l:1 f:0
s:72398
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter limit 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 tcp_nopush
2009/10/16 15:57:12 [debug] 21943#0: *107326 writev: 323
2009/10/16 15:57:12 [debug] 21943#0: *107326 sendfile: @0 72075
2009/10/16 15:57:12 [debug] 21943#0: *107326 sendfile: 70629, @0 70629:72075
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter 08CADBB0
2009/10/16 15:57:12 [debug] 21943#0: *107326 copy filter: -2
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http finalize request: -2,
"/attachments/67/88/24.file?" 1
2009/10/16 15:57:12 [debug] 21943#0: *107326 event timer add: 72:
60000:1563841718
2009/10/16 15:57:12 [debug] 21943#0: *107326 post event 08BB0A60
2009/10/16 15:57:12 [debug] 21943#0: *107326 delete posted event 08BB0A60
2009/10/16 15:57:12 [debug] 21943#0: *107326 http run request:
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http writer handler:
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http output filter
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 copy filter:
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http postpone filter
"/attachments/67/88/24.file?" 00000000
2009/10/16 15:57:12 [debug] 21943#0: *107326 write old buf t:0 f:1 00000000,
pos 00000000, size: 0 file: 70629, size: 1446
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter: l:1 f:0
s:1446
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter limit 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 sendfile: @70629 1446
2009/10/16 15:57:12 [debug] 21943#0: *107326 sendfile: 1446, @70629
1446:1446
2009/10/16 15:57:12 [debug] 21943#0: *107326 http write filter 00000000
2009/10/16 15:57:12 [debug] 21943#0: *107326 copy filter: 0
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http writer output filter: 0,
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http writer done:
"/attachments/67/88/24.file?"
2009/10/16 15:57:12 [debug] 21943#0: *107326 http finalize request: 0,
"/attachments/67/88/24.file?" 1
2009/10/16 15:57:12 [debug] 21943#0: *107326 event timer del: 72: 1563841718
2009/10/16 15:57:12 [debug] 21943#0: *107326 set http keepalive handler
2009/10/16 15:57:12 [debug] 21943#0: *107326 http close request
2009/10/16 15:57:12 [debug] 21943#0: *107326 http log handler
2009/10/16 15:57:12 [debug] 21943#0: *107326 run cleanup: 08BE06E4
2009/10/16 15:57:12 [debug] 21943#0: *107326 file cleanup: fd:105
2009/10/16 15:57:12 [debug] 21943#0: *107326 run cleanup: 08BE0218
2009/10/16 15:57:12 [debug] 21943#0: *107326 free: 08B41B88
2009/10/16 15:57:12 [debug] 21943#0: *107326 free: 08BDF6F0, unused: 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 free: 08CAD428, unused: 1897
2009/10/16 15:57:12 [debug] 21943#0: *107326 event timer add: 72:
65000:1563847247
2009/10/16 15:57:12 [debug] 21943#0: *107326 free: 08BED990
2009/10/16 15:57:12 [debug] 21943#0: *107326 free: 08C7E730
2009/10/16 15:57:12 [debug] 21943#0: *107326 hc free: 00000000 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 hc busy: 00000000 0
2009/10/16 15:57:12 [debug] 21943#0: *107326 post event 08BA3A58
2009/10/16 15:57:12 [debug] 21943#0: *107326 delete posted event 08BA3A58
2009/10/16 15:57:12 [debug] 21943#0: *107326 http keepalive handler
2009/10/16 15:57:12 [debug] 21943#0: *107326 malloc: 08C20CF8:1024
2009/10/16 15:57:12 [debug] 21943#0: *107326 recv: fd:72 -1 of 1024
2009/10/16 15:57:12 [debug] 21943#0: *107326 recv() not ready (11: Resource
temporarily unavailable)
2009/10/16 15:58:17 [debug] 21943#0: *107326 event timer del: 72: 1563847247
2009/10/16 15:58:17 [debug] 21943#0: *107326 http keepalive handler
2009/10/16 15:58:17 [debug] 21943#0: *107326 close http connection: 72
2009/10/16 15:58:17 [debug] 21943#0: *107326 free: 08C20CF8
2009/10/16 15:58:17 [debug] 21943#0: *107326 free: 00000000
2009/10/16 15:58:17 [debug] 21943#0: *107326 free: 08BC8318, unused: 40

уф. всё.

16 октября 2009 г. 14:18 пользователь Igor Sysoev <is at rambler-co.ru>написал:

> On Fri, Oct 16, 2009 at 01:58:16PM +0400, Maxim Dounin wrote:
>
> > Hello!
> >
> > On Fri, Oct 16, 2009 at 12:55:11PM +0400, Igor Sysoev wrote:
> >
> > > On Fri, Oct 16, 2009 at 12:34:41PM +0400, Slava Kokorin wrote:
> > >
> > > > Спасибо за статью!
> > > >
> > > > Хочу решить такюу задачу - кэшировать ответы с X-Accel-Redirect, но
> только
> > > > средствами nginx, без вмешательства в код backend.
> > > >
> > > > В связи с этим есть вопрос - что будет закешировано  при такой схеме
> - ответ
> > > > от бэкенда или то, что пойдёт уже клиенту?
> > >
> > > Должно быть закэшировано и то, и другое: отдельно ответ с XAR и
> отдельно
> > > ответ, полученный через XAR. Обработка должна быть такая - берём
> > > закэшированный ответ с XAR, делаем XAR, снова берём закэшированный
> ответ,
> > > отдаём клиенту.
> >
> > "должно быть" == планируется сделать?
> >
> > Потому что сейчас ответы с XAR не кешируются (если только nginx'у
> > не сказано игнорировать XAR), ибо internal redirect происходит
> > раньше, чем должен был бы проапдейтится кеш.
>
> Планировалось. Если не работает, буду лечить.
>
>
> --
> Игорь Сысоев
> http://sysoev.ru
>
>


-- 
Regards,
Slava
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://nginx.org/pipermail/nginx-ru/attachments/20091016/ce293167/attachment.html>


More information about the nginx-ru mailing list