Nginx-ru mailing list archive (nginx-ru@sysoev.ru)
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
problem: query get too long time.
- To: nginx-ru@xxxxxxxxx
- Subject: problem: query get too long time.
- From: Andrey <deepmindster@xxxxxxxxx>
- Date: Wed, 18 Apr 2007 12:07:33 +0400
- Dkim-signature: a=rsa-sha1; c=relaxed/relaxed; d=gmail.com; s=beta; h=domainkey-signature:received:received:subject:from:to:content-type:date:message-id:mime-version:x-mailer; b=hypIsuHcbTXO0BUznBqMNgJhPXs6uZSDRkq5AAFmkd6IGAz6cq6anQnLIKhteiTfVGXN/pz1nViSyXP8bcQg+KuddFCqRL9TUDfATV9MLlpzpWCJ8EduqqXlCYIwlPQzzj3PMWAX627a5wfks0rJMuGdipa/J6AKZHwuCsOCHIY=
- Domainkey-signature: a=rsa-sha1; c=nofws; d=gmail.com; s=beta; h=received:subject:from:to:content-type:date:message-id:mime-version:x-mailer; b=NTIo0sN4azFDqo1m3YoCSlSnQcEd3guf/q4xdZeZanMh3aYX6SEIf+K5WtplNKTVxGZFiCjI5o8slBPW40hk040kdQsxHmHrxa9z6LUIggzmIZ28tU1GnsG9RfrsnDN6DLAAPGsDWZUkN0KS1AuhENMofnsst9aDUg8Jik3dLj0=
Доброго времени суток.
Проблема в том, что запрос http://andrey:8080/test_test выполняется примерно минуту.
Конфиг и дебаг лог в аттаче.
user nginx;
worker_processes 1;
error_log /var/log/nginx/error_test.log debug;
pid /var/run/nginx_test.pid;
events {
worker_connections 1024;
}
http {
access_log /var/log/nginx/access_test.log;
include /usr/local/etc/nginx/mime.types;
default_type application/octet-stream;
sendfile on;
keepalive_timeout 65;
charset utf-8;
source_charset utf-8;
override_charset off;
server {
listen 192.168.0.20:8080;
server_name andrey;
location / {
root /srv/www/vhosts/andrey;
autoindex on;
}
location /test_test {
perl '
sub {
my $r = shift;
$r->print( "hello" );
return OK;
}
';
}
}
}
2007/04/17 20:20:18 [debug] 31196#0: bind() 192.168.0.20:8080 #8
2007/04/17 20:20:18 [notice] 31196#0: using the "epoll" event method
2007/04/17 20:20:18 [debug] 31196#0: counter: B7F75080, 1
2007/04/17 20:20:18 [notice] 31196#0: nginx/0.5.17
2007/04/17 20:20:18 [notice] 31196#0: built by gcc 4.1.0 (SUSE Linux)
2007/04/17 20:20:18 [notice] 31196#0: OS: Linux 2.6.16.13-4-default
2007/04/17 20:20:18 [notice] 31196#0: sysctl(KERN_RTSIGMAX): 0
2007/04/17 20:20:18 [notice] 31196#0: getrlimit(RLIMIT_NOFILE): 1024:1024
2007/04/17 20:20:18 [debug] 31197#0: write: 9, BFF76936, 6, 0
2007/04/17 20:20:18 [debug] 31197#0: setproctitle: "nginx: master process
/usr/local/sbin/nginx -c /usr/local/etc/nginx/nginx_test.conf"
2007/04/17 20:20:18 [notice] 31197#0: start worker processes
2007/04/17 20:20:18 [debug] 31197#0: channel 9:10
2007/04/17 20:20:18 [debug] 31198#0: malloc: 080AF2B8:6144
2007/04/17 20:20:18 [debug] 31198#0: malloc: 08119B28:81920
2007/04/17 20:20:18 [debug] 31198#0: malloc: 0812DB30:53248
2007/04/17 20:20:18 [notice] 31197#0: start worker process 31198
2007/04/17 20:20:18 [debug] 31197#0: sigsuspend
2007/04/17 20:20:18 [debug] 31198#0: malloc: 0813AB38:53248
2007/04/17 20:20:18 [debug] 31198#0: epoll add event: fd:8 op:1 ev:00000001
2007/04/17 20:20:18 [debug] 31198#0: epoll add event: fd:10 op:1 ev:00000001
2007/04/17 20:20:18 [debug] 31198#0: setproctitle: "nginx: worker process"
2007/04/17 20:20:18 [debug] 31198#0: worker cycle
2007/04/17 20:20:18 [debug] 31198#0: epoll timer: -1
2007/04/17 20:20:23 [debug] 31198#0: epoll: fd:8 ev:0001 d:08119B28
2007/04/17 20:20:23 [debug] 31198#0: accept on 192.168.0.20:8080, ready: 0
2007/04/17 20:20:23 [debug] 31198#0: malloc: 080C1B68:256
2007/04/17 20:20:23 [debug] 31198#0: *1 accept: 192.168.0.40 fd:9
2007/04/17 20:20:23 [debug] 31198#0: *1 event timer add: 9: 60000:5844454
2007/04/17 20:20:23 [debug] 31198#0: *1 epoll add event: fd:9 op:1 ev:80000001
2007/04/17 20:20:23 [debug] 31198#0: timer delta: 5384
2007/04/17 20:20:23 [debug] 31198#0: posted events 00000000
2007/04/17 20:20:23 [debug] 31198#0: worker cycle
2007/04/17 20:20:23 [debug] 31198#0: epoll timer: 60000
2007/04/17 20:20:23 [debug] 31198#0: epoll: fd:9 ev:0001 d:08119BC8
2007/04/17 20:20:23 [debug] 31198#0: *1 malloc: 080AA498:624
2007/04/17 20:20:23 [debug] 31198#0: *1 malloc: 08111990:1024
2007/04/17 20:20:23 [debug] 31198#0: *1 malloc: 080B0AC0:4096
2007/04/17 20:20:23 [debug] 31198#0: *1 http process request line
2007/04/17 20:20:23 [debug] 31198#0: *1 recv: fd:9 485 of 1024
2007/04/17 20:20:23 [debug] 31198#0: *1 http request line: "GET /test_test
HTTP/1.1"
2007/04/17 20:20:23 [debug] 31198#0: *1 http uri: "/test_test"
2007/04/17 20:20:23 [debug] 31198#0: *1 http args: ""
2007/04/17 20:20:23 [debug] 31198#0: *1 http exten: ""
2007/04/17 20:20:23 [debug] 31198#0: *1 http process request header line
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Host: andrey:8080"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "User-Agent: Mozilla/5.0
(X11; U; Linux i686; ru; rv:1.8.0.3) Gecko/20060425 SUSE/1.5.0.3-7
Firefox/1.5.0.3"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Accept:
text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Accept-Language:
ru-ru,ru;q=0.8,en-us;q=0.5,en;q=0.3"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Accept-Encoding:
gzip,deflate"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Accept-Charset:
KOI8-R,utf-8;q=0.7,*;q=0.7"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Keep-Alive: 300"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Connection: keep-alive"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header: "Cookie:
PHPSESSID=55e2dbf0efdf03b92c967df52b26b556"
2007/04/17 20:20:23 [debug] 31198#0: *1 http header done
2007/04/17 20:20:23 [debug] 31198#0: *1 event timer del: 9: 5844454
2007/04/17 20:20:23 [debug] 31198#0: *1 generic phase: 0
2007/04/17 20:20:23 [debug] 31198#0: *1 find location for "/test_test"
2007/04/17 20:20:23 [debug] 31198#0: *1 find location: "/"
2007/04/17 20:20:23 [debug] 31198#0: *1 find location: "/test_test"
2007/04/17 20:20:23 [debug] 31198#0: *1 using configuration "/test_test"
2007/04/17 20:20:23 [debug] 31198#0: *1 http cl:-1 max:1048576
2007/04/17 20:20:23 [debug] 31198#0: *1 generic phase: 2
2007/04/17 20:20:23 [debug] 31198#0: *1 post rewrite phase: 3
2007/04/17 20:20:23 [debug] 31198#0: *1 generic phase: 4
2007/04/17 20:20:23 [debug] 31198#0: *1 access phase: 5
2007/04/17 20:20:23 [debug] 31198#0: *1 access phase: 6
2007/04/17 20:20:23 [debug] 31198#0: *1 post access phase: 7
2007/04/17 20:20:23 [debug] 31198#0: *1 perl handler
2007/04/17 20:20:23 [debug] 31198#0: *1 $r->print: read-only SV: 5
2007/04/17 20:20:23 [debug] 31198#0: *1 http output filter "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 copy filter: "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 write new buf t:0 f:0 080F5930, pos
080F5930, size: 5 file: 0, size: 0
2007/04/17 20:20:23 [debug] 31198#0: *1 http write filter: l:0 f:0 s:5
2007/04/17 20:20:23 [debug] 31198#0: *1 copy filter: 0 "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 call_sv: 0
2007/04/17 20:20:23 [debug] 31198#0: *1 perl handler done: 0
2007/04/17 20:20:23 [debug] 31198#0: *1 http output filter "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 copy filter: "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 write old buf t:0 f:0 080F5930, pos
080F5930, size: 5 file: 0, size: 0
2007/04/17 20:20:23 [debug] 31198#0: *1 write new buf t:0 f:0 00000000, pos
00000000, size: 0 file: 0, size: 0
2007/04/17 20:20:23 [debug] 31198#0: *1 http write filter: l:1 f:0 s:5
2007/04/17 20:20:23 [debug] 31198#0: *1 http write filter to send 0
2007/04/17 20:20:23 [debug] 31198#0: *1 writev: 5
2007/04/17 20:20:23 [debug] 31198#0: *1 http write filter 00000000
2007/04/17 20:20:23 [debug] 31198#0: *1 copy filter: 0 "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 http finalize request: 0, "/test_test?"
2007/04/17 20:20:23 [debug] 31198#0: *1 set http keepalive handler
2007/04/17 20:20:23 [debug] 31198#0: *1 http close request
2007/04/17 20:20:23 [debug] 31198#0: *1 http log handler
2007/04/17 20:20:23 [debug] 31198#0: *1 free: 080B0AC0, unused: 2434
2007/04/17 20:20:23 [debug] 31198#0: *1 event timer add: 9: 65000:5849455
2007/04/17 20:20:23 [debug] 31198#0: *1 free: 080AA498
2007/04/17 20:20:23 [debug] 31198#0: *1 free: 08111990
2007/04/17 20:20:23 [debug] 31198#0: *1 hc free: 00000000 0
2007/04/17 20:20:23 [debug] 31198#0: *1 hc busy: 00000000 0
2007/04/17 20:20:23 [debug] 31198#0: *1 tcp_nodelay
2007/04/17 20:20:23 [debug] 31198#0: *1 http keepalive handler
2007/04/17 20:20:23 [debug] 31198#0: *1 malloc: 08111990:1024
2007/04/17 20:20:23 [debug] 31198#0: *1 recv: fd:9 -1 of 1024
2007/04/17 20:20:23 [debug] 31198#0: *1 recv() not ready (11: Resource
temporarily unavailable)
2007/04/17 20:20:23 [debug] 31198#0: timer delta: 1
2007/04/17 20:20:23 [debug] 31198#0: posted events 00000000
2007/04/17 20:20:23 [debug] 31198#0: worker cycle
2007/04/17 20:20:23 [debug] 31198#0: epoll timer: 65000
2007/04/17 20:21:28 [debug] 31198#0: timer delta: 65014
2007/04/17 20:21:28 [debug] 31198#0: *1 event timer del: 9: 5849455
2007/04/17 20:21:28 [debug] 31198#0: *1 http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *1 close http connection: 9
2007/04/17 20:21:28 [debug] 31198#0: *1 free: 08111990
2007/04/17 20:21:28 [debug] 31198#0: *1 free: 00000000
2007/04/17 20:21:28 [debug] 31198#0: *1 free: 00000000
2007/04/17 20:21:28 [debug] 31198#0: *1 free: 080C1B68, unused: 56
2007/04/17 20:21:28 [debug] 31198#0: posted events 00000000
2007/04/17 20:21:28 [debug] 31198#0: worker cycle
2007/04/17 20:21:28 [debug] 31198#0: epoll timer: -1
2007/04/17 20:21:28 [debug] 31198#0: epoll: fd:8 ev:0001 d:08119B28
2007/04/17 20:21:28 [debug] 31198#0: accept on 192.168.0.20:8080, ready: 0
2007/04/17 20:21:28 [debug] 31198#0: malloc: 080C1B68:256
2007/04/17 20:21:28 [debug] 31198#0: *2 accept: 192.168.0.40 fd:9
2007/04/17 20:21:28 [debug] 31198#0: *2 event timer add: 9: 60000:5909703
2007/04/17 20:21:28 [debug] 31198#0: *2 epoll add event: fd:9 op:1 ev:80000001
2007/04/17 20:21:28 [debug] 31198#0: timer delta: 234
2007/04/17 20:21:28 [debug] 31198#0: posted events 00000000
2007/04/17 20:21:28 [debug] 31198#0: worker cycle
2007/04/17 20:21:28 [debug] 31198#0: epoll timer: 60000
2007/04/17 20:21:28 [debug] 31198#0: epoll: fd:9 ev:0001 d:08119BC9
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 080AA498:624
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 08111990:1024
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 080B0AC0:4096
2007/04/17 20:21:28 [debug] 31198#0: *2 http process request line
2007/04/17 20:21:28 [debug] 31198#0: *2 recv: fd:9 407 of 1024
2007/04/17 20:21:28 [debug] 31198#0: *2 http request line: "GET /favicon.ico
HTTP/1.1"
2007/04/17 20:21:28 [debug] 31198#0: *2 http uri: "/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 http args: ""
2007/04/17 20:21:28 [debug] 31198#0: *2 http exten: "ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 http process request header line
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Host: andrey:8080"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "User-Agent: Mozilla/5.0
(X11; U; Linux i686; ru; rv:1.8.0.3) Gecko/20060425 SUSE/1.5.0.3-7
Firefox/1.5.0.3"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept:
image/png,*/*;q=0.5"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept-Language:
ru-ru,ru;q=0.8,en-us;q=0.5,en;q=0.3"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept-Encoding:
gzip,deflate"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept-Charset:
KOI8-R,utf-8;q=0.7,*;q=0.7"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Keep-Alive: 300"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Connection: keep-alive"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Cookie:
PHPSESSID=55e2dbf0efdf03b92c967df52b26b556"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header done
2007/04/17 20:21:28 [debug] 31198#0: *2 event timer del: 9: 5909703
2007/04/17 20:21:28 [debug] 31198#0: *2 generic phase: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 find location for "/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 find location: "/"
2007/04/17 20:21:28 [debug] 31198#0: *2 find location: "/test_test"
2007/04/17 20:21:28 [debug] 31198#0: *2 using configuration "/"
2007/04/17 20:21:28 [debug] 31198#0: *2 http cl:-1 max:1048576
2007/04/17 20:21:28 [debug] 31198#0: *2 generic phase: 2
2007/04/17 20:21:28 [debug] 31198#0: *2 post rewrite phase: 3
2007/04/17 20:21:28 [debug] 31198#0: *2 generic phase: 4
2007/04/17 20:21:28 [debug] 31198#0: *2 access phase: 5
2007/04/17 20:21:28 [debug] 31198#0: *2 access phase: 6
2007/04/17 20:21:28 [debug] 31198#0: *2 post access phase: 7
2007/04/17 20:21:28 [debug] 31198#0: *2 content phase: 8
2007/04/17 20:21:28 [debug] 31198#0: *2 content phase: 9
2007/04/17 20:21:28 [debug] 31198#0: *2 content phase: 10
2007/04/17 20:21:28 [debug] 31198#0: *2 http set discard body
2007/04/17 20:21:28 [debug] 31198#0: *2 http filename:
"/srv/www/vhosts/andrey/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 add cleanup: 080B0FC4
2007/04/17 20:21:28 [error] 31198#0: *2 open()
"/srv/www/vhosts/andrey/favicon.ico" failed (2: No such file or directory),
client: 192.168.0.40, server: andrey, URL: "/favicon.ico", host: "andrey:8080"
2007/04/17 20:21:28 [debug] 31198#0: *2 http finalize request: 404,
"/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 http special response: 404,
"/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 HTTP/1.1 404 Not Found
Server: nginx/0.5.17
Date: Tue, 17 Apr 2007 16:21:28 GMT
Content-Type: text/html
Content-Length: 169
Connection: keep-alive
2007/04/17 20:21:28 [debug] 31198#0: *2 write new buf t:1 f:0 080B1010, pos
080B1010, size: 155 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter: l:0 f:0 s:155
2007/04/17 20:21:28 [debug] 31198#0: *2 http output filter "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 copy filter: "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 write old buf t:1 f:0 080B1010, pos
080B1010, size: 155 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 write new buf t:0 f:0 00000000, pos
0809C140, size: 116 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 write new buf t:0 f:0 00000000, pos
0809BBC0, size: 53 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter: l:1 f:0 s:324
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter to send 0
2007/04/17 20:21:28 [debug] 31198#0: *2 writev: 324
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter 00000000
2007/04/17 20:21:28 [debug] 31198#0: *2 copy filter: 0 "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 http finalize request: 0,
"/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 set http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *2 http close request
2007/04/17 20:21:28 [debug] 31198#0: *2 http log handler
2007/04/17 20:21:28 [debug] 31198#0: *2 free: 080B0AC0, unused: 2148
2007/04/17 20:21:28 [debug] 31198#0: *2 event timer add: 9: 65000:5914704
2007/04/17 20:21:28 [debug] 31198#0: *2 free: 080AA498
2007/04/17 20:21:28 [debug] 31198#0: *2 free: 08111990
2007/04/17 20:21:28 [debug] 31198#0: *2 hc free: 00000000 0
2007/04/17 20:21:28 [debug] 31198#0: *2 hc busy: 00000000 0
2007/04/17 20:21:28 [debug] 31198#0: *2 tcp_nodelay
2007/04/17 20:21:28 [debug] 31198#0: *2 http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 08111990:1024
2007/04/17 20:21:28 [debug] 31198#0: *2 recv: fd:9 407 of 1024
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 080AA498:624
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 080B0AC0:4096
2007/04/17 20:21:28 [debug] 31198#0: *2 http process request line
2007/04/17 20:21:28 [debug] 31198#0: *2 http request line: "GET /favicon.ico
HTTP/1.1"
2007/04/17 20:21:28 [debug] 31198#0: *2 http uri: "/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 http args: ""
2007/04/17 20:21:28 [debug] 31198#0: *2 http exten: "ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 http process request header line
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Host: andrey:8080"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "User-Agent: Mozilla/5.0
(X11; U; Linux i686; ru; rv:1.8.0.3) Gecko/20060425 SUSE/1.5.0.3-7
Firefox/1.5.0.3"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept:
image/png,*/*;q=0.5"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept-Language:
ru-ru,ru;q=0.8,en-us;q=0.5,en;q=0.3"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept-Encoding:
gzip,deflate"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Accept-Charset:
KOI8-R,utf-8;q=0.7,*;q=0.7"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Keep-Alive: 300"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Connection: keep-alive"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header: "Cookie:
PHPSESSID=55e2dbf0efdf03b92c967df52b26b556"
2007/04/17 20:21:28 [debug] 31198#0: *2 http header done
2007/04/17 20:21:28 [debug] 31198#0: *2 event timer del: 9: 5914704
2007/04/17 20:21:28 [debug] 31198#0: *2 generic phase: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 find location for "/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 find location: "/"
2007/04/17 20:21:28 [debug] 31198#0: *2 find location: "/test_test"
2007/04/17 20:21:28 [debug] 31198#0: *2 using configuration "/"
2007/04/17 20:21:28 [debug] 31198#0: *2 http cl:-1 max:1048576
2007/04/17 20:21:28 [debug] 31198#0: *2 generic phase: 2
2007/04/17 20:21:28 [debug] 31198#0: *2 post rewrite phase: 3
2007/04/17 20:21:28 [debug] 31198#0: *2 generic phase: 4
2007/04/17 20:21:28 [debug] 31198#0: *2 access phase: 5
2007/04/17 20:21:28 [debug] 31198#0: *2 access phase: 6
2007/04/17 20:21:28 [debug] 31198#0: *2 post access phase: 7
2007/04/17 20:21:28 [debug] 31198#0: *2 content phase: 8
2007/04/17 20:21:28 [debug] 31198#0: *2 content phase: 9
2007/04/17 20:21:28 [debug] 31198#0: *2 content phase: 10
2007/04/17 20:21:28 [debug] 31198#0: *2 http set discard body
2007/04/17 20:21:28 [debug] 31198#0: *2 http filename:
"/srv/www/vhosts/andrey/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 add cleanup: 080B0FC4
2007/04/17 20:21:28 [error] 31198#0: *2 open()
"/srv/www/vhosts/andrey/favicon.ico" failed (2: No such file or directory),
client: 192.168.0.40, server: andrey, URL: "/favicon.ico", host: "andrey:8080"
2007/04/17 20:21:28 [debug] 31198#0: *2 http finalize request: 404,
"/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 http special response: 404,
"/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *2 HTTP/1.1 404 Not Found
Server: nginx/0.5.17
Date: Tue, 17 Apr 2007 16:21:28 GMT
Content-Type: text/html
Content-Length: 169
Connection: keep-alive
2007/04/17 20:21:28 [debug] 31198#0: *2 write new buf t:1 f:0 080B1010, pos
080B1010, size: 155 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter: l:0 f:0 s:155
2007/04/17 20:21:28 [debug] 31198#0: *2 http output filter "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 copy filter: "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 write old buf t:1 f:0 080B1010, pos
080B1010, size: 155 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 write new buf t:0 f:0 00000000, pos
0809C140, size: 116 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 write new buf t:0 f:0 00000000, pos
0809BBC0, size: 53 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter: l:1 f:0 s:324
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter to send 0
2007/04/17 20:21:28 [debug] 31198#0: *2 writev: 324
2007/04/17 20:21:28 [debug] 31198#0: *2 http write filter 00000000
2007/04/17 20:21:28 [debug] 31198#0: *2 copy filter: 0 "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 http finalize request: 0,
"/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *2 set http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *2 http close request
2007/04/17 20:21:28 [debug] 31198#0: *2 http log handler
2007/04/17 20:21:28 [debug] 31198#0: *2 free: 080B0AC0, unused: 2148
2007/04/17 20:21:28 [debug] 31198#0: *2 event timer add: 9: 65000:5914704
2007/04/17 20:21:28 [debug] 31198#0: *2 free: 080AA498
2007/04/17 20:21:28 [debug] 31198#0: *2 free: 08111990
2007/04/17 20:21:28 [debug] 31198#0: *2 hc free: 00000000 0
2007/04/17 20:21:28 [debug] 31198#0: *2 hc busy: 00000000 0
2007/04/17 20:21:28 [debug] 31198#0: *2 http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *2 malloc: 08111990:1024
2007/04/17 20:21:28 [debug] 31198#0: *2 recv: fd:9 -1 of 1024
2007/04/17 20:21:28 [debug] 31198#0: *2 recv() not ready (11: Resource
temporarily unavailable)
2007/04/17 20:21:28 [debug] 31198#0: timer delta: 1
2007/04/17 20:21:28 [debug] 31198#0: posted events 00000000
2007/04/17 20:21:28 [debug] 31198#0: worker cycle
2007/04/17 20:21:28 [debug] 31198#0: epoll timer: 65000
2007/04/17 20:21:28 [debug] 31198#0: epoll: fd:8 ev:0001 d:08119B28
2007/04/17 20:21:28 [debug] 31198#0: accept on 192.168.0.20:8080, ready: 0
2007/04/17 20:21:28 [debug] 31198#0: malloc: 080AA498:256
2007/04/17 20:21:28 [debug] 31198#0: *3 accept: 192.168.0.40 fd:12
2007/04/17 20:21:28 [debug] 31198#0: *3 event timer add: 12: 60000:5909716
2007/04/17 20:21:28 [debug] 31198#0: *3 epoll add event: fd:12 op:1 ev:80000001
2007/04/17 20:21:28 [debug] 31198#0: timer delta: 12
2007/04/17 20:21:28 [debug] 31198#0: posted events 00000000
2007/04/17 20:21:28 [debug] 31198#0: worker cycle
2007/04/17 20:21:28 [debug] 31198#0: epoll timer: 60000
2007/04/17 20:21:28 [debug] 31198#0: epoll: fd:12 ev:0001 d:08119C18
2007/04/17 20:21:28 [debug] 31198#0: *3 malloc: 08111D98:624
2007/04/17 20:21:28 [debug] 31198#0: *3 malloc: 080D3BF8:1024
2007/04/17 20:21:28 [debug] 31198#0: *3 malloc: 080B0AC0:4096
2007/04/17 20:21:28 [debug] 31198#0: *3 http process request line
2007/04/17 20:21:28 [debug] 31198#0: *3 recv: fd:12 407 of 1024
2007/04/17 20:21:28 [debug] 31198#0: *3 http request line: "GET /favicon.ico
HTTP/1.1"
2007/04/17 20:21:28 [debug] 31198#0: *3 http uri: "/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *3 http args: ""
2007/04/17 20:21:28 [debug] 31198#0: *3 http exten: "ico"
2007/04/17 20:21:28 [debug] 31198#0: *3 http process request header line
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Host: andrey:8080"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "User-Agent: Mozilla/5.0
(X11; U; Linux i686; ru; rv:1.8.0.3) Gecko/20060425 SUSE/1.5.0.3-7
Firefox/1.5.0.3"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Accept:
image/png,*/*;q=0.5"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Accept-Language:
ru-ru,ru;q=0.8,en-us;q=0.5,en;q=0.3"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Accept-Encoding:
gzip,deflate"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Accept-Charset:
KOI8-R,utf-8;q=0.7,*;q=0.7"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Keep-Alive: 300"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Connection: keep-alive"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header: "Cookie:
PHPSESSID=55e2dbf0efdf03b92c967df52b26b556"
2007/04/17 20:21:28 [debug] 31198#0: *3 http header done
2007/04/17 20:21:28 [debug] 31198#0: *3 event timer del: 12: 5909716
2007/04/17 20:21:28 [debug] 31198#0: *3 generic phase: 0
2007/04/17 20:21:28 [debug] 31198#0: *3 find location for "/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *3 find location: "/"
2007/04/17 20:21:28 [debug] 31198#0: *3 find location: "/test_test"
2007/04/17 20:21:28 [debug] 31198#0: *3 using configuration "/"
2007/04/17 20:21:28 [debug] 31198#0: *3 http cl:-1 max:1048576
2007/04/17 20:21:28 [debug] 31198#0: *3 generic phase: 2
2007/04/17 20:21:28 [debug] 31198#0: *3 post rewrite phase: 3
2007/04/17 20:21:28 [debug] 31198#0: *3 generic phase: 4
2007/04/17 20:21:28 [debug] 31198#0: *3 access phase: 5
2007/04/17 20:21:28 [debug] 31198#0: *3 access phase: 6
2007/04/17 20:21:28 [debug] 31198#0: *3 post access phase: 7
2007/04/17 20:21:28 [debug] 31198#0: *3 content phase: 8
2007/04/17 20:21:28 [debug] 31198#0: *3 content phase: 9
2007/04/17 20:21:28 [debug] 31198#0: *3 content phase: 10
2007/04/17 20:21:28 [debug] 31198#0: *3 http set discard body
2007/04/17 20:21:28 [debug] 31198#0: *3 http filename:
"/srv/www/vhosts/andrey/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *3 add cleanup: 080B0FC4
2007/04/17 20:21:28 [error] 31198#0: *3 open()
"/srv/www/vhosts/andrey/favicon.ico" failed (2: No such file or directory),
client: 192.168.0.40, server: andrey, URL: "/favicon.ico", host: "andrey:8080"
2007/04/17 20:21:28 [debug] 31198#0: *3 http finalize request: 404,
"/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *3 http special response: 404,
"/favicon.ico"
2007/04/17 20:21:28 [debug] 31198#0: *3 HTTP/1.1 404 Not Found
Server: nginx/0.5.17
Date: Tue, 17 Apr 2007 16:21:28 GMT
Content-Type: text/html
Content-Length: 169
Connection: keep-alive
2007/04/17 20:21:28 [debug] 31198#0: *3 write new buf t:1 f:0 080B1010, pos
080B1010, size: 155 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *3 http write filter: l:0 f:0 s:155
2007/04/17 20:21:28 [debug] 31198#0: *3 http output filter "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *3 copy filter: "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *3 write old buf t:1 f:0 080B1010, pos
080B1010, size: 155 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *3 write new buf t:0 f:0 00000000, pos
0809C140, size: 116 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *3 write new buf t:0 f:0 00000000, pos
0809BBC0, size: 53 file: 0, size: 0
2007/04/17 20:21:28 [debug] 31198#0: *3 http write filter: l:1 f:0 s:324
2007/04/17 20:21:28 [debug] 31198#0: *3 http write filter to send 0
2007/04/17 20:21:28 [debug] 31198#0: *3 writev: 324
2007/04/17 20:21:28 [debug] 31198#0: *3 http write filter 00000000
2007/04/17 20:21:28 [debug] 31198#0: *3 copy filter: 0 "/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *3 http finalize request: 0,
"/favicon.ico?"
2007/04/17 20:21:28 [debug] 31198#0: *3 set http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *3 http close request
2007/04/17 20:21:28 [debug] 31198#0: *3 http log handler
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 080B0AC0, unused: 2148
2007/04/17 20:21:28 [debug] 31198#0: *3 event timer add: 12: 65000:5914716
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 08111D98
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 080D3BF8
2007/04/17 20:21:28 [debug] 31198#0: *3 hc free: 00000000 0
2007/04/17 20:21:28 [debug] 31198#0: *3 hc busy: 00000000 0
2007/04/17 20:21:28 [debug] 31198#0: *3 tcp_nodelay
2007/04/17 20:21:28 [debug] 31198#0: *3 http keepalive handler
2007/04/17 20:21:28 [debug] 31198#0: *3 malloc: 080D3BF8:1024
2007/04/17 20:21:28 [debug] 31198#0: *3 recv: fd:12 0 of 1024
2007/04/17 20:21:28 [info] 31198#0: *3 client 192.168.0.40 closed keepalive
connection
2007/04/17 20:21:28 [debug] 31198#0: *3 close http connection: 12
2007/04/17 20:21:28 [debug] 31198#0: *3 event timer del: 12: 5914716
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 080D3BF8
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 00000000
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 00000000
2007/04/17 20:21:28 [debug] 31198#0: *3 free: 080AA498, unused: 56
2007/04/17 20:21:28 [debug] 31198#0: timer delta: 0
2007/04/17 20:21:28 [debug] 31198#0: posted events 00000000
2007/04/17 20:21:28 [debug] 31198#0: worker cycle
2007/04/17 20:21:28 [debug] 31198#0: epoll timer: 64988
2007/04/17 20:22:33 [debug] 31198#0: timer delta: 64993
2007/04/17 20:22:33 [debug] 31198#0: *2 event timer del: 9: 5914704
2007/04/17 20:22:33 [debug] 31198#0: *2 http keepalive handler
2007/04/17 20:22:33 [debug] 31198#0: *2 close http connection: 9
2007/04/17 20:22:33 [debug] 31198#0: *2 free: 08111990
2007/04/17 20:22:33 [debug] 31198#0: *2 free: 00000000
2007/04/17 20:22:33 [debug] 31198#0: *2 free: 00000000
2007/04/17 20:22:33 [debug] 31198#0: *2 free: 00000000
2007/04/17 20:22:33 [debug] 31198#0: *2 free: 00000000
2007/04/17 20:22:33 [debug] 31198#0: *2 free: 080C1B68, unused: 40
2007/04/17 20:22:33 [debug] 31198#0: posted events 00000000
2007/04/17 20:22:33 [debug] 31198#0: worker cycle
2007/04/17 20:22:33 [debug] 31198#0: epoll timer: -1
2007/04/17 20:26:56 [notice] 31197#0: signal 2 (SIGINT) received, exiting
2007/04/17 20:26:56 [debug] 31197#0: wake up
2007/04/17 20:26:56 [debug] 31197#0: child: 0 31198 e:0 t:0 d:0 r:1 j:0
2007/04/17 20:26:56 [debug] 31197#0: temination cycle: 100
2007/04/17 20:26:56 [debug] 31197#0: sigsuspend
2007/04/17 20:26:56 [debug] 31198#0: epoll: fd:10 ev:0001 d:08119B78
2007/04/17 20:26:56 [debug] 31198#0: channel handler
2007/04/17 20:26:56 [debug] 31198#0: channel: 16
2007/04/17 20:26:56 [debug] 31198#0: channel command: 4
2007/04/17 20:26:56 [debug] 31198#0: timer delta: 262964
2007/04/17 20:26:56 [debug] 31198#0: posted events 00000000
2007/04/17 20:26:56 [notice] 31198#0: exiting
2007/04/17 20:26:56 [debug] 31198#0: flush files
2007/04/17 20:26:56 [notice] 31197#0: signal 17 (SIGCHLD) received
2007/04/17 20:26:56 [notice] 31197#0: worker process 31198 exited with code 0
2007/04/17 20:26:56 [debug] 31197#0: wake up
2007/04/17 20:26:56 [debug] 31197#0: reap childs
2007/04/17 20:26:56 [debug] 31197#0: child: 0 31198 e:1 t:1 d:0 r:1 j:0
2007/04/17 20:26:56 [notice] 31197#0: exit
|
