2008/05/15 15:23:35 [debug] 19368#0: bind() 192.168.24.88:80 #5 2008/05/15 15:23:35 [notice] 19368#0: using the "epoll" event method 2008/05/15 15:23:35 [debug] 19368#0: counter: B7FFF080, 1 2008/05/15 15:23:35 [notice] 19368#0: nginx/0.6.31 2008/05/15 15:23:35 [notice] 19368#0: built by gcc 3.4.6 20060404 (Red Hat 3.4.6-3) 2008/05/15 15:23:35 [notice] 19368#0: OS: Linux 2.6.9-5.ELsmp 2008/05/15 15:23:35 [notice] 19368#0: sysctl(KERN_RTSIGMAX): 0 2008/05/15 15:23:35 [notice] 19368#0: getrlimit(RLIMIT_NOFILE): 16384:16384 2008/05/15 15:23:35 [debug] 19369#0: write: 6, BFEE28F0, 6, 0 2008/05/15 15:23:35 [debug] 19369#0: setproctitle: "nginx: master process /usr/local/nginx-0.6.31/sbin/nginx" 2008/05/15 15:23:35 [notice] 19369#0: start worker processes 2008/05/15 15:23:35 [debug] 19369#0: channel 6:7 2008/05/15 15:23:35 [debug] 19370#0: malloc: 08835FE0:6144 2008/05/15 15:23:35 [debug] 19370#0: malloc: B7FB7008:163840 2008/05/15 15:23:35 [debug] 19370#0: malloc: 08844138:106496 2008/05/15 15:23:35 [debug] 19370#0: malloc: 0885E140:106496 2008/05/15 15:23:35 [notice] 19369#0: start worker process 19370 2008/05/15 15:23:35 [debug] 19369#0: channel 8:9 2008/05/15 15:23:35 [debug] 19370#0: epoll add event: fd:7 op:1 ev:00000001 2008/05/15 15:23:35 [debug] 19370#0: setproctitle: "nginx: worker process" 2008/05/15 15:23:35 [debug] 19370#0: worker cycle 2008/05/15 15:23:35 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:35 [debug] 19370#0: epoll add event: fd:5 op:1 ev:00000001 2008/05/15 15:23:35 [debug] 19370#0: epoll timer: -1 2008/05/15 15:23:35 [debug] 19371#0: malloc: 08835FE0:6144 2008/05/15 15:23:35 [debug] 19371#0: malloc: B7FB7008:163840 2008/05/15 15:23:35 [debug] 19371#0: malloc: 08844138:106496 2008/05/15 15:23:35 [debug] 19371#0: malloc: 0885E140:106496 2008/05/15 15:23:35 [debug] 19371#0: epoll add event: fd:9 op:1 ev:00000001 2008/05/15 15:23:35 [notice] 19369#0: start worker process 19371 2008/05/15 15:23:35 [debug] 19371#0: setproctitle: "nginx: worker process" 2008/05/15 15:23:35 [debug] 19369#0: pass channel s:1 pid:19371 fd:8 to s:0 pid:19370 fd:6 2008/05/15 15:23:35 [debug] 19371#0: worker cycle 2008/05/15 15:23:35 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:35 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:35 [debug] 19369#0: sigsuspend 2008/05/15 15:23:35 [debug] 19370#0: epoll: fd:7 ev:0001 d:B7FB7058 2008/05/15 15:23:35 [debug] 19370#0: post event 0884416C 2008/05/15 15:23:35 [debug] 19370#0: timer delta: 4 2008/05/15 15:23:35 [debug] 19370#0: posted events 0884416C 2008/05/15 15:23:35 [debug] 19370#0: posted event 0884416C 2008/05/15 15:23:35 [debug] 19370#0: delete posted event 0884416C 2008/05/15 15:23:35 [debug] 19370#0: channel handler 2008/05/15 15:23:35 [debug] 19370#0: channel: 16 2008/05/15 15:23:35 [debug] 19370#0: channel command: 1 2008/05/15 15:23:35 [debug] 19370#0: get channel s:1 pid:19371 fd:6 2008/05/15 15:23:35 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:35 [debug] 19370#0: worker cycle 2008/05/15 15:23:35 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:35 [debug] 19370#0: epoll timer: -1 2008/05/15 15:23:35 [debug] 19371#0: timer delta: 503 2008/05/15 15:23:35 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:35 [debug] 19371#0: worker cycle 2008/05/15 15:23:35 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:35 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:36 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:36 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:36 [debug] 19371#0: worker cycle 2008/05/15 15:23:36 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:36 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:36 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:36 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:36 [debug] 19371#0: worker cycle 2008/05/15 15:23:36 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:36 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:37 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:37 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:37 [debug] 19371#0: worker cycle 2008/05/15 15:23:37 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:37 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:5 ev:0001 d:B7FB7008 2008/05/15 15:23:37 [debug] 19370#0: post event 08844138 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 2073 2008/05/15 15:23:37 [debug] 19370#0: posted event 08844138 2008/05/15 15:23:37 [debug] 19370#0: delete posted event 08844138 2008/05/15 15:23:37 [debug] 19370#0: accept on 192.168.24.88:80, ready: 0 2008/05/15 15:23:37 [debug] 19370#0: malloc: 08831690:256 2008/05/15 15:23:37 [debug] 19370#0: *1 accept: 192.168.24.121 fd:9 2008/05/15 15:23:37 [debug] 19370#0: *1 event timer add: 9: 60000:3975667325 2008/05/15 15:23:37 [debug] 19370#0: *1 epoll add event: fd:9 op:1 ev:80000001 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: posted events 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: 60000 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:9 ev:0001 d:B7FB70A8 2008/05/15 15:23:37 [debug] 19370#0: *1 post event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 0 2008/05/15 15:23:37 [debug] 19370#0: posted events 088441A0 2008/05/15 15:23:37 [debug] 19370#0: posted event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *1 delete posted event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *1 malloc: 088377E8:632 2008/05/15 15:23:37 [debug] 19370#0: *1 malloc: 08837A68:1024 2008/05/15 15:23:37 [debug] 19370#0: *1 malloc: 08837E70:4096 2008/05/15 15:23:37 [debug] 19370#0: *1 http process request line 2008/05/15 15:23:37 [debug] 19370#0: *1 recv: fd:9 759 of 1024 2008/05/15 15:23:37 [debug] 19370#0: *1 http request line: "POST /blah HTTP/1.1" 2008/05/15 15:23:37 [debug] 19370#0: *1 http uri: "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http args: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http exten: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http process request header line 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "User-Agent: Mozilla/5.0 (Macintosh; U; PPC Mac OS X; en-US) AppleWebKit/522+ (KHTML, like Gecko, Safari/522) OmniWeb/v613.0.93354" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Content-Type: application/x-www-form-urlencoded" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Referer: http://server.local/form.html" 2008/05/15 15:23:37 [debug] 19370#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" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Accept-Language: en, ja;q=0.95, fr;q=0.89, de;q=0.84, es;q=0.79, it;q=0.74, pt;q=0.68, pt-pt;q=0.63, nl;q=0.58, sv;q=0.53, nb;q=0.47, da;q=0.42, fi;q=0.37, ru;q=0.32, pl;q=0.26, zh-hans;q=0.21, zh-hant;q=0.16, ko;q=0.11" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Accept-Encoding: gzip, deflate" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Content-Length: 10" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Connection: keep-alive" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header: "Host: server.local" 2008/05/15 15:23:37 [debug] 19370#0: *1 http header done 2008/05/15 15:23:37 [debug] 19370#0: *1 event timer del: 9: 3975667325 2008/05/15 15:23:37 [debug] 19370#0: *1 generic phase: 0 2008/05/15 15:23:37 [debug] 19370#0: *1 find location for "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 find location: "/" 2008/05/15 15:23:37 [debug] 19370#0: *1 find location: = "/50x.html" 2008/05/15 15:23:37 [debug] 19370#0: *1 find location: ~ "\.php.*$" 2008/05/15 15:23:37 [debug] 19370#0: *1 using configuration "/" 2008/05/15 15:23:37 [debug] 19370#0: *1 http cl:10 max:1048576 2008/05/15 15:23:37 [debug] 19370#0: *1 generic phase: 2 2008/05/15 15:23:37 [debug] 19370#0: *1 post rewrite phase: 3 2008/05/15 15:23:37 [debug] 19370#0: *1 generic phase: 4 2008/05/15 15:23:37 [debug] 19370#0: *1 access phase: 5 2008/05/15 15:23:37 [debug] 19370#0: *1 access phase: 6 2008/05/15 15:23:37 [debug] 19370#0: *1 post access phase: 7 2008/05/15 15:23:37 [debug] 19370#0: *1 content phase: 8 2008/05/15 15:23:37 [debug] 19370#0: *1 content phase: 9 2008/05/15 15:23:37 [debug] 19370#0: *1 content phase: 10 2008/05/15 15:23:37 [debug] 19370#0: *1 http finalize request: 405, "/blah?" 2008/05/15 15:23:37 [debug] 19370#0: *1 http special response: 405, "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http set discard body 2008/05/15 15:23:37 [debug] 19370#0: *1 named location: @phpapp "/blah?" 2008/05/15 15:23:37 [debug] 19370#0: *1 generic phase: 2 2008/05/15 15:23:37 [debug] 19370#0: *1 post rewrite phase: 3 2008/05/15 15:23:37 [debug] 19370#0: *1 generic phase: 4 2008/05/15 15:23:37 [debug] 19370#0: *1 access phase: 5 2008/05/15 15:23:37 [debug] 19370#0: *1 access phase: 6 2008/05/15 15:23:37 [debug] 19370#0: *1 post access phase: 7 2008/05/15 15:23:37 [debug] 19370#0: *1 http init upstream, client timer: 0 2008/05/15 15:23:37 [debug] 19370#0: *1 epoll add event: fd:9 op:3 ev:80000005 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SCRIPT_FILENAME: /www/nginx/server.local/public/test.php" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SCRIPT_URL: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "QUERY_STRING: " 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "REQUEST_METHOD: POST" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "CONTENT_TYPE: application/x-www-form-urlencoded" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "CONTENT_LENGTH: 10" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SCRIPT_NAME: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "REQUEST_URI: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "DOCUMENT_URI: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "DOCUMENT_ROOT: /www/nginx/server.local/public" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SERVER_PROTOCOL: HTTP/1.1" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "GATEWAY_INTERFACE: CGI/1.1" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SERVER_SOFTWARE: nginx/0.6.31" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "REMOTE_ADDR: 192.168.24.121" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "REMOTE_PORT: 60829" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SERVER_ADDR: 192.168.24.88" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SERVER_PORT: 80" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "SERVER_NAME: server.local" 2008/05/15 15:23:37 [debug] 19370#0: *1 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *1 fastcgi param: "REDIRECT_STATUS: 200" 2008/05/15 15:23:37 [debug] 19370#0: *1 http cleanup add: 08838C5C 2008/05/15 15:23:37 [debug] 19370#0: *1 get rr peer, try: 1 2008/05/15 15:23:37 [debug] 19370#0: *1 socket 10 2008/05/15 15:23:37 [debug] 19370#0: *1 epoll add connection: fd:10 ev:80000005 2008/05/15 15:23:37 [debug] 19370#0: *1 connect to 127.0.0.1:9000, fd:10 #2 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream connect: -2 2008/05/15 15:23:37 [debug] 19370#0: *1 event timer add: 10: 60000:3975667325 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: 60000 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:10 ev:0004 d:B7FB70F8 2008/05/15 15:23:37 [debug] 19370#0: *1 post event 0885E1DC 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:9 ev:0004 d:B7FB70A8 2008/05/15 15:23:37 [debug] 19370#0: *1 post event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 1 2008/05/15 15:23:37 [debug] 19370#0: posted events 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: posted event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: *1 delete posted event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream check client, write event:1, "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream recv(): -1 (11: Resource temporarily unavailable) 2008/05/15 15:23:37 [debug] 19370#0: posted event 0885E1DC 2008/05/15 15:23:37 [debug] 19370#0: *1 delete posted event 0885E1DC 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream send request handler 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream send request 2008/05/15 15:23:37 [debug] 19370#0: *1 chain writer buf fl:0 s:1400 2008/05/15 15:23:37 [debug] 19370#0: *1 chain writer in: 08838C78 2008/05/15 15:23:37 [debug] 19370#0: *1 writev: 1400 2008/05/15 15:23:37 [debug] 19370#0: *1 chain writer out: 00000000 2008/05/15 15:23:37 [debug] 19370#0: *1 event timer del: 10: 3975667325 2008/05/15 15:23:37 [debug] 19370#0: *1 event timer add: 10: 60000:3975667326 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: 60000 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:9 ev:0005 d:B7FB70A8 2008/05/15 15:23:37 [debug] 19370#0: *1 post event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *1 post event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 326 2008/05/15 15:23:37 [debug] 19370#0: posted events 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: posted event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: *1 delete posted event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream check client, write event:1, "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream recv(): 0 (11: Resource temporarily unavailable) 2008/05/15 15:23:37 [debug] 19370#0: posted event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *1 delete posted event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream check client, write event:0, "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *1 http upstream recv(): 0 (11: Resource temporarily unavailable) 2008/05/15 15:23:37 [info] 19370#0: *1 client closed prematurely connection, so upstream connection is closed too while sending request to upstream, client: 192.168.24.121, server: localhost, request: "POST /blah HTTP/1.1", upstream: "fastcgi://127.0.0.1:9000", host: "server.local", referrer: "http://server.local/form.html" 2008/05/15 15:23:37 [debug] 19370#0: *1 finalize http upstream request: 499 2008/05/15 15:23:37 [debug] 19370#0: *1 finalize http fastcgi request 2008/05/15 15:23:37 [debug] 19370#0: *1 free rr peer 1 0 2008/05/15 15:23:37 [debug] 19370#0: *1 close http upstream connection: 10 2008/05/15 15:23:37 [debug] 19370#0: *1 event timer del: 10: 3975667326 2008/05/15 15:23:37 [debug] 19370#0: *1 http finalize request: 499, "/blah?" 2008/05/15 15:23:37 [debug] 19370#0: *1 http close request 2008/05/15 15:23:37 [debug] 19370#0: *1 http log handler 2008/05/15 15:23:37 [debug] 19370#0: *1 free: 08837E70, unused: 209 2008/05/15 15:23:37 [debug] 19370#0: *1 close http connection: 9 2008/05/15 15:23:37 [debug] 19370#0: *1 free: 08837A68 2008/05/15 15:23:37 [debug] 19370#0: *1 free: 088377E8 2008/05/15 15:23:37 [debug] 19370#0: *1 free: 08831690, unused: 64 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: -1 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:5 ev:0001 d:B7FB7008 2008/05/15 15:23:37 [debug] 19370#0: post event 08844138 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 21 2008/05/15 15:23:37 [debug] 19370#0: posted event 08844138 2008/05/15 15:23:37 [debug] 19370#0: delete posted event 08844138 2008/05/15 15:23:37 [debug] 19370#0: accept on 192.168.24.88:80, ready: 0 2008/05/15 15:23:37 [debug] 19370#0: malloc: 08831690:256 2008/05/15 15:23:37 [debug] 19370#0: *3 accept: 192.168.24.121 fd:9 2008/05/15 15:23:37 [debug] 19370#0: *3 event timer add: 9: 60000:3975667673 2008/05/15 15:23:37 [debug] 19370#0: *3 epoll add event: fd:9 op:1 ev:80000001 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: posted events 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: 60000 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:9 ev:0001 d:B7FB70A9 2008/05/15 15:23:37 [debug] 19370#0: *3 post event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 0 2008/05/15 15:23:37 [debug] 19370#0: posted events 088441A0 2008/05/15 15:23:37 [debug] 19370#0: posted event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *3 delete posted event 088441A0 2008/05/15 15:23:37 [debug] 19370#0: *3 malloc: 088377E8:632 2008/05/15 15:23:37 [debug] 19370#0: *3 malloc: 08837A68:1024 2008/05/15 15:23:37 [debug] 19370#0: *3 malloc: 08837E70:4096 2008/05/15 15:23:37 [debug] 19370#0: *3 http process request line 2008/05/15 15:23:37 [debug] 19370#0: *3 recv: fd:9 759 of 1024 2008/05/15 15:23:37 [debug] 19370#0: *3 http request line: "POST /blah HTTP/1.1" 2008/05/15 15:23:37 [debug] 19370#0: *3 http uri: "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http args: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http exten: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http process request header line 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "User-Agent: Mozilla/5.0 (Macintosh; U; PPC Mac OS X; en-US) AppleWebKit/522+ (KHTML, like Gecko, Safari/522) OmniWeb/v613.0.93354" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Content-Type: application/x-www-form-urlencoded" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Referer: http://server.local/form.html" 2008/05/15 15:23:37 [debug] 19370#0: *3 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" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Accept-Language: en, ja;q=0.95, fr;q=0.89, de;q=0.84, es;q=0.79, it;q=0.74, pt;q=0.68, pt-pt;q=0.63, nl;q=0.58, sv;q=0.53, nb;q=0.47, da;q=0.42, fi;q=0.37, ru;q=0.32, pl;q=0.26, zh-hans;q=0.21, zh-hant;q=0.16, ko;q=0.11" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Accept-Encoding: gzip, deflate" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Content-Length: 10" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Connection: keep-alive" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header: "Host: server.local" 2008/05/15 15:23:37 [debug] 19370#0: *3 http header done 2008/05/15 15:23:37 [debug] 19370#0: *3 event timer del: 9: 3975667673 2008/05/15 15:23:37 [debug] 19370#0: *3 generic phase: 0 2008/05/15 15:23:37 [debug] 19370#0: *3 find location for "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 find location: "/" 2008/05/15 15:23:37 [debug] 19370#0: *3 find location: = "/50x.html" 2008/05/15 15:23:37 [debug] 19370#0: *3 find location: ~ "\.php.*$" 2008/05/15 15:23:37 [debug] 19370#0: *3 using configuration "/" 2008/05/15 15:23:37 [debug] 19370#0: *3 http cl:10 max:1048576 2008/05/15 15:23:37 [debug] 19370#0: *3 generic phase: 2 2008/05/15 15:23:37 [debug] 19370#0: *3 post rewrite phase: 3 2008/05/15 15:23:37 [debug] 19370#0: *3 generic phase: 4 2008/05/15 15:23:37 [debug] 19370#0: *3 access phase: 5 2008/05/15 15:23:37 [debug] 19370#0: *3 access phase: 6 2008/05/15 15:23:37 [debug] 19370#0: *3 post access phase: 7 2008/05/15 15:23:37 [debug] 19370#0: *3 content phase: 8 2008/05/15 15:23:37 [debug] 19370#0: *3 content phase: 9 2008/05/15 15:23:37 [debug] 19370#0: *3 content phase: 10 2008/05/15 15:23:37 [debug] 19370#0: *3 http finalize request: 405, "/blah?" 2008/05/15 15:23:37 [debug] 19370#0: *3 http special response: 405, "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http set discard body 2008/05/15 15:23:37 [debug] 19370#0: *3 named location: @phpapp "/blah?" 2008/05/15 15:23:37 [debug] 19370#0: *3 generic phase: 2 2008/05/15 15:23:37 [debug] 19370#0: *3 post rewrite phase: 3 2008/05/15 15:23:37 [debug] 19370#0: *3 generic phase: 4 2008/05/15 15:23:37 [debug] 19370#0: *3 access phase: 5 2008/05/15 15:23:37 [debug] 19370#0: *3 access phase: 6 2008/05/15 15:23:37 [debug] 19370#0: *3 post access phase: 7 2008/05/15 15:23:37 [debug] 19370#0: *3 http init upstream, client timer: 0 2008/05/15 15:23:37 [debug] 19370#0: *3 epoll add event: fd:9 op:3 ev:80000005 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SCRIPT_FILENAME: /www/nginx/server.local/public/test.php" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SCRIPT_URL: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "QUERY_STRING: " 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "REQUEST_METHOD: POST" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "CONTENT_TYPE: application/x-www-form-urlencoded" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "CONTENT_LENGTH: 10" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SCRIPT_NAME: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "REQUEST_URI: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "DOCUMENT_URI: /blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "DOCUMENT_ROOT: /www/nginx/server.local/public" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SERVER_PROTOCOL: HTTP/1.1" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "GATEWAY_INTERFACE: CGI/1.1" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SERVER_SOFTWARE: nginx/0.6.31" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "REMOTE_ADDR: 192.168.24.121" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "REMOTE_PORT: 60830" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SERVER_ADDR: 192.168.24.88" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SERVER_PORT: 80" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script var: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "SERVER_NAME: server.local" 2008/05/15 15:23:37 [debug] 19370#0: *3 http script copy: "" 2008/05/15 15:23:37 [debug] 19370#0: *3 fastcgi param: "REDIRECT_STATUS: 200" 2008/05/15 15:23:37 [debug] 19370#0: *3 http cleanup add: 08838C5C 2008/05/15 15:23:37 [debug] 19370#0: *3 get rr peer, try: 1 2008/05/15 15:23:37 [debug] 19370#0: *3 socket 10 2008/05/15 15:23:37 [debug] 19370#0: *3 epoll add connection: fd:10 ev:80000005 2008/05/15 15:23:37 [debug] 19370#0: *3 connect to 127.0.0.1:9000, fd:10 #4 2008/05/15 15:23:37 [debug] 19370#0: *3 http upstream connect: -2 2008/05/15 15:23:37 [debug] 19370#0: *3 event timer add: 10: 60000:3975667673 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: 60000 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:10 ev:0004 d:B7FB70F9 2008/05/15 15:23:37 [debug] 19370#0: *3 post event 0885E1DC 2008/05/15 15:23:37 [debug] 19370#0: epoll: fd:9 ev:0004 d:B7FB70A9 2008/05/15 15:23:37 [debug] 19370#0: *3 post event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: timer delta: 1 2008/05/15 15:23:37 [debug] 19370#0: posted events 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: posted event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: *3 delete posted event 0885E1A8 2008/05/15 15:23:37 [debug] 19370#0: *3 http upstream check client, write event:1, "/blah" 2008/05/15 15:23:37 [debug] 19370#0: *3 http upstream recv(): -1 (11: Resource temporarily unavailable) 2008/05/15 15:23:37 [debug] 19370#0: posted event 0885E1DC 2008/05/15 15:23:37 [debug] 19370#0: *3 delete posted event 0885E1DC 2008/05/15 15:23:37 [debug] 19370#0: *3 http upstream send request handler 2008/05/15 15:23:37 [debug] 19370#0: *3 http upstream send request 2008/05/15 15:23:37 [debug] 19370#0: *3 chain writer buf fl:0 s:1400 2008/05/15 15:23:37 [debug] 19370#0: *3 chain writer in: 08838C78 2008/05/15 15:23:37 [debug] 19370#0: *3 writev: 1400 2008/05/15 15:23:37 [debug] 19370#0: *3 chain writer out: 00000000 2008/05/15 15:23:37 [debug] 19370#0: *3 event timer del: 10: 3975667673 2008/05/15 15:23:37 [debug] 19370#0: *3 event timer add: 10: 60000:3975667674 2008/05/15 15:23:37 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:37 [debug] 19370#0: worker cycle 2008/05/15 15:23:37 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:37 [debug] 19370#0: epoll timer: 60000 2008/05/15 15:23:37 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:37 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:37 [debug] 19371#0: worker cycle 2008/05/15 15:23:37 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:37 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:38 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:38 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:38 [debug] 19371#0: worker cycle 2008/05/15 15:23:38 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:38 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:38 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:38 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:38 [debug] 19371#0: worker cycle 2008/05/15 15:23:38 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:38 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:39 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:39 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:39 [debug] 19371#0: worker cycle 2008/05/15 15:23:39 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:39 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:39 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:39 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:39 [debug] 19371#0: worker cycle 2008/05/15 15:23:39 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:39 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:40 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:40 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:40 [debug] 19371#0: worker cycle 2008/05/15 15:23:40 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:40 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:40 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:40 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:40 [debug] 19371#0: worker cycle 2008/05/15 15:23:40 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:40 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:41 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:41 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:41 [debug] 19371#0: worker cycle 2008/05/15 15:23:41 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:41 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:41 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:41 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:41 [debug] 19371#0: worker cycle 2008/05/15 15:23:41 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:41 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:42 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:42 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:42 [debug] 19371#0: worker cycle 2008/05/15 15:23:42 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:42 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:42 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:42 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:42 [debug] 19371#0: worker cycle 2008/05/15 15:23:42 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:42 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:43 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:43 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:43 [debug] 19371#0: worker cycle 2008/05/15 15:23:43 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:43 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:43 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:43 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:43 [debug] 19371#0: worker cycle 2008/05/15 15:23:43 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:43 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:44 [debug] 19370#0: epoll: fd:9 ev:0005 d:B7FB70A9 2008/05/15 15:23:44 [debug] 19370#0: *3 post event 088441A0 2008/05/15 15:23:44 [debug] 19370#0: *3 post event 0885E1A8 2008/05/15 15:23:44 [debug] 19370#0: timer delta: 6228 2008/05/15 15:23:44 [debug] 19370#0: posted events 0885E1A8 2008/05/15 15:23:44 [debug] 19370#0: posted event 0885E1A8 2008/05/15 15:23:44 [debug] 19370#0: *3 delete posted event 0885E1A8 2008/05/15 15:23:44 [debug] 19370#0: *3 http upstream check client, write event:1, "/blah" 2008/05/15 15:23:44 [debug] 19370#0: *3 http upstream recv(): 0 (11: Resource temporarily unavailable) 2008/05/15 15:23:44 [debug] 19370#0: posted event 088441A0 2008/05/15 15:23:44 [debug] 19370#0: *3 delete posted event 088441A0 2008/05/15 15:23:44 [debug] 19370#0: *3 http upstream check client, write event:0, "/blah" 2008/05/15 15:23:44 [debug] 19370#0: *3 http upstream recv(): 0 (11: Resource temporarily unavailable) 2008/05/15 15:23:44 [info] 19370#0: *3 client closed prematurely connection, so upstream connection is closed too while sending request to upstream, client: 192.168.24.121, server: localhost, request: "POST /blah HTTP/1.1", upstream: "fastcgi://127.0.0.1:9000", host: "server.local", referrer: "http://server.local/form.html" 2008/05/15 15:23:44 [debug] 19370#0: *3 finalize http upstream request: 499 2008/05/15 15:23:44 [debug] 19370#0: *3 finalize http fastcgi request 2008/05/15 15:23:44 [debug] 19370#0: *3 free rr peer 1 0 2008/05/15 15:23:44 [debug] 19370#0: *3 close http upstream connection: 10 2008/05/15 15:23:44 [debug] 19370#0: *3 event timer del: 10: 3975667674 2008/05/15 15:23:44 [debug] 19370#0: *3 http finalize request: 499, "/blah?" 2008/05/15 15:23:44 [debug] 19370#0: *3 http close request 2008/05/15 15:23:44 [debug] 19370#0: *3 http log handler 2008/05/15 15:23:44 [debug] 19370#0: *3 free: 08837E70, unused: 209 2008/05/15 15:23:44 [debug] 19370#0: *3 close http connection: 9 2008/05/15 15:23:44 [debug] 19370#0: *3 free: 08837A68 2008/05/15 15:23:44 [debug] 19370#0: *3 free: 088377E8 2008/05/15 15:23:44 [debug] 19370#0: *3 free: 08831690, unused: 64 2008/05/15 15:23:44 [debug] 19370#0: posted event 00000000 2008/05/15 15:23:44 [debug] 19370#0: worker cycle 2008/05/15 15:23:44 [debug] 19370#0: accept mutex locked 2008/05/15 15:23:44 [debug] 19370#0: epoll timer: -1 2008/05/15 15:23:44 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:44 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:44 [debug] 19371#0: worker cycle 2008/05/15 15:23:44 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:44 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:44 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:44 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:44 [debug] 19371#0: worker cycle 2008/05/15 15:23:44 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:44 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:45 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:45 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:45 [debug] 19371#0: worker cycle 2008/05/15 15:23:45 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:45 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:45 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:45 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:45 [debug] 19371#0: worker cycle 2008/05/15 15:23:45 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:45 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:46 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:46 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:46 [debug] 19371#0: worker cycle 2008/05/15 15:23:46 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:46 [debug] 19371#0: epoll timer: 500 2008/05/15 15:23:46 [debug] 19371#0: timer delta: 500 2008/05/15 15:23:46 [debug] 19371#0: posted events 00000000 2008/05/15 15:23:46 [debug] 19371#0: worker cycle 2008/05/15 15:23:46 [debug] 19371#0: accept mutex lock failed: 0 2008/05/15 15:23:46 [debug] 19371#0: epoll timer: 500