gistfile1.txt

2010/09/09 13:26:00 [debug] 19323#0: epoll: fd:3 ev:0005 d:09CE7DF0
2010/09/09 13:26:00 [debug] 19323#0: *2905 http keepalive handler
2010/09/09 13:26:00 [debug] 19323#0: *2905 recv: fd:3 752 of 1024
2010/09/09 13:26:00 [debug] 19323#0: *2905 malloc: 09CD93F0:676
2010/09/09 13:26:00 [debug] 19323#0: *2905 malloc: 09CD9698:4096
2010/09/09 13:26:00 [debug] 19323#0: *2905 http process request line
2010/09/09 13:26:00 [debug] 19323#0: *2905 http request line: "POST /peers HTTP/1.0"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http uri: "/peers"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http args: ""
2010/09/09 13:26:00 [debug] 19323#0: *2905 http exten: ""
2010/09/09 13:26:00 [debug] 19323#0: *2905 http process request header line
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Host: ubuntu:3000"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "User-Agent: Mozilla/5.0 (Windows; U; Windows NT 6.1; en-GB; rv:1.9.2.9) Gecko/20100824 Firefox/3.6.9"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Accept-Language: en-gb,en;q=0.5"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Keep-Alive: 115"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Connection: Keep-Alive"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Cookie: stranger_chat.sid=f825a452a4844adf1655e0c14ac6f6bf8a51c17b2e73b73f88eabecd9e979ef827cbe577c6fd44b002a4583c916405e407f97568d570133e3969a48001389571"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Referer: http://ubuntu:3000/Main.swf/[[DYNAMIC]]/4"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Content-type: application/x-www-form-urlencoded"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header: "Content-length: 134"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http header done
2010/09/09 13:26:00 [debug] 19323#0: *2905 event timer del: 3: 4131346838
2010/09/09 13:26:00 [debug] 19323#0: *2905 generic phase: 0
2010/09/09 13:26:00 [debug] 19323#0: *2905 add cleanup: 09CD9BE4
2010/09/09 13:26:00 [debug] 19323#0: *2905 generic phase: 1
2010/09/09 13:26:00 [debug] 19323#0: *2905 test location: "/"
2010/09/09 13:26:00 [debug] 19323#0: *2905 test location: "50x.html"
2010/09/09 13:26:00 [debug] 19323#0: *2905 test location: ~ "/(peers|interest|vote|count)"
2010/09/09 13:26:00 [debug] 19323#0: *2905 using configuration "/(peers|interest|vote|count)"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http cl:134 max:1048576
2010/09/09 13:26:00 [debug] 19323#0: *2905 generic phase: 3
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script complex value
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script var: "/usr/local/nginx/html/peers"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: ""
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script file op 00000000 "/usr/local/nginx/html/peers"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script file op false
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script if
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script if: false
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script complex value
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script var: "/usr/local/nginx/html/peers"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: ""
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script file op 00000001 "/usr/local/nginx/html/peers"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script if
2010/09/09 13:26:00 [debug] 19323#0: *2905 post rewrite phase: 4
2010/09/09 13:26:00 [debug] 19323#0: *2905 generic phase: 5
2010/09/09 13:26:00 [debug] 19323#0: *2905 add cleanup: 09CD9D9C
2010/09/09 13:26:00 [debug] 19323#0: *2905 generic phase: 6
2010/09/09 13:26:00 [debug] 19323#0: *2905 generic phase: 7
2010/09/09 13:26:00 [debug] 19323#0: *2905 access phase: 8
2010/09/09 13:26:00 [debug] 19323#0: *2905 access phase: 9
2010/09/09 13:26:00 [debug] 19323#0: *2905 post access phase: 10
2010/09/09 13:26:00 [debug] 19323#0: *2905 http client request body preread 134
2010/09/09 13:26:00 [debug] 19323#0: *2905 http init upstream, client timer: 0
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: "X-Forwarded-For: "
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script var: "192.168.0.9"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: "
"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: "Host: "
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script var: "ubuntu"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: "
"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http script copy: "Connection: close
"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "User-Agent: Mozilla/5.0 (Windows; U; Windows NT 6.1; en-GB; rv:1.9.2.9) Gecko/20100824 Firefox/3.6.9"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Accept-Language: en-gb,en;q=0.5"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Cookie: stranger_chat.sid=f825a452a4844adf1655e0c14ac6f6bf8a51c17b2e73b73f88eabecd9e979ef827cbe577c6fd44b002a4583c916405e407f97568d570133e3969a48001389571"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Referer: http://ubuntu:3000/Main.swf/[[DYNAMIC]]/4"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Content-type: application/x-www-form-urlencoded"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header: "Content-length: 134"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http proxy header:
"POST /peers HTTP/1.0
X-Forwarded-For: 192.168.0.9
Host: ubuntu
Connection: close
User-Agent: Mozilla/5.0 (Windows; U; Windows NT 6.1; en-GB; rv:1.9.2.9) Gecko/20100824 Firefox/3.6.9
Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
Accept-Language: en-gb,en;q=0.5
Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7
Cookie: stranger_chat.sid=f825a452a4844adf1655e0c14ac6f6bf8a51c17b2e73b73f88eabecd9e979ef827cbe577c6fd44b002a4583c916405e407f97568d570133e3969a48001389571
Referer: http://ubuntu:3000/Main.swf/[[DYNAMIC]]/4
Content-type: application/x-www-form-urlencoded
Content-length: 134

"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http cleanup add: 09CDA39C
2010/09/09 13:26:00 [debug] 19323#0: *2905 get rr peer, try: 2
2010/09/09 13:26:00 [debug] 19323#0: *2905 get rr peer, current: 1 1
2010/09/09 13:26:00 [debug] 19323#0: *2905 socket 4
2010/09/09 13:26:00 [debug] 19323#0: *2905 epoll add connection: fd:4 ev:80000005
2010/09/09 13:26:00 [debug] 19323#0: *2905 connect to 127.0.0.1:3030, fd:4 #2916
2010/09/09 13:26:00 [debug] 19323#0: *2905 http upstream connect: -2
2010/09/09 13:26:00 [debug] 19323#0: *2905 event timer add: 4: 60000:4131366568
2010/09/09 13:26:00 [debug] 19323#0: *2905 http run request: "/peers?"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http upstream check client, write event:1, "/peers"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http upstream recv(): -1 (11: Resource temporarily unavailable)
2010/09/09 13:26:00 [debug] 19323#0: timer delta: 23808
2010/09/09 13:26:00 [debug] 19323#0: posted events 00000000
2010/09/09 13:26:00 [debug] 19323#0: worker cycle
2010/09/09 13:26:00 [debug] 19323#0: epoll timer: 40300
2010/09/09 13:26:00 [debug] 19323#0: epoll: fd:4 ev:0004 d:09CE7FD0
2010/09/09 13:26:00 [debug] 19323#0: *2905 http upstream request: "/peers?"
2010/09/09 13:26:00 [debug] 19323#0: *2905 http upstream send request handler
2010/09/09 13:26:00 [debug] 19323#0: *2905 http upstream send request
2010/09/09 13:26:00 [debug] 19323#0: *2905 chain writer buf fl:0 s:621
2010/09/09 13:26:00 [debug] 19323#0: *2905 chain writer buf fl:1 s:134
2010/09/09 13:26:00 [debug] 19323#0: *2905 chain writer in: 09CDA3C8
2010/09/09 13:26:00 [debug] 19323#0: *2905 writev: 755
2010/09/09 13:26:00 [debug] 19323#0: *2905 chain writer out: 00000000
2010/09/09 13:26:00 [debug] 19323#0: *2905 event timer del: 4: 4131366568
2010/09/09 13:26:00 [debug] 19323#0: *2905 event timer add: 4: 90000:4131396572
2010/09/09 13:26:00 [debug] 19323#0: timer delta: 4
2010/09/09 13:26:00 [debug] 19323#0: posted events 00000000
2010/09/09 13:26:00 [debug] 19323#0: worker cycle
2010/09/09 13:26:00 [debug] 19323#0: epoll timer: 40296
2010/09/09 13:26:30 [debug] 19323#0: epoll: fd:4 ev:0005 d:09CE7FD0
2010/09/09 13:26:30 [debug] 19323#0: *2905 http upstream request: "/peers?"
2010/09/09 13:26:30 [debug] 19323#0: *2905 http upstream process header
2010/09/09 13:26:30 [debug] 19323#0: *2905 malloc: 09CD0A38:4096
2010/09/09 13:26:30 [debug] 19323#0: *2905 recv: fd:4 0 of 4096
2010/09/09 13:26:30 [error] 19323#0: *2905 upstream prematurely closed connection while reading response header from upstream, client: 192.168.0.9, server: localhost, request: "POST /peers HTTP/1.0", upstream: "http://127.0.0.1:3030/peers", host: "ubuntu:3000", referrer: "http://ubuntu:3000/Main.swf/[[DYNAMIC]]/4"
2010/09/09 13:26:30 [debug] 19323#0: *2905 http next upstream, 2
2010/09/09 13:26:30 [debug] 19323#0: *2905 free rr peer 2 4
2010/09/09 13:26:30 [debug] 19323#0: *2905 free rr peer failed: 1 -1
2010/09/09 13:26:30 [debug] 19323#0: *2905 finalize http upstream request: 502
2010/09/09 13:26:30 [debug] 19323#0: *2905 finalize http proxy request
2010/09/09 13:26:30 [debug] 19323#0: *2905 free rr peer 1 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 close http upstream connection: 4
2010/09/09 13:26:30 [debug] 19323#0: *2905 event timer del: 4: 4131396572
2010/09/09 13:26:30 [debug] 19323#0: *2905 http finalize request: 502, "/peers?" 1
2010/09/09 13:26:30 [debug] 19323#0: *2905 http special response: 502, "/peers?"
2010/09/09 13:26:30 [debug] 19323#0: *2905 internal redirect: "/50x.html?"
2010/09/09 13:26:30 [debug] 19323#0: *2905 generic phase: 1
2010/09/09 13:26:30 [debug] 19323#0: *2905 test location: "/"
2010/09/09 13:26:30 [debug] 19323#0: *2905 test location: "50x.html"
2010/09/09 13:26:30 [debug] 19323#0: *2905 using configuration "=/50x.html"
2010/09/09 13:26:30 [debug] 19323#0: *2905 http cl:134 max:1048576
2010/09/09 13:26:30 [debug] 19323#0: *2905 generic phase: 3
2010/09/09 13:26:30 [debug] 19323#0: *2905 post rewrite phase: 4
2010/09/09 13:26:30 [debug] 19323#0: *2905 generic phase: 5
2010/09/09 13:26:30 [debug] 19323#0: *2905 add cleanup: 09CDA4A0
2010/09/09 13:26:30 [debug] 19323#0: *2905 generic phase: 6
2010/09/09 13:26:30 [debug] 19323#0: *2905 generic phase: 7
2010/09/09 13:26:30 [debug] 19323#0: *2905 access phase: 8
2010/09/09 13:26:30 [debug] 19323#0: *2905 access phase: 9
2010/09/09 13:26:30 [debug] 19323#0: *2905 post access phase: 10
2010/09/09 13:26:30 [debug] 19323#0: *2905 content phase: 11
2010/09/09 13:26:30 [debug] 19323#0: *2905 content phase: 12
2010/09/09 13:26:30 [debug] 19323#0: *2905 content phase: 13
2010/09/09 13:26:30 [debug] 19323#0: *2905 content phase: 14
2010/09/09 13:26:30 [debug] 19323#0: *2905 content phase: 15
2010/09/09 13:26:30 [debug] 19323#0: *2905 http filename: "/var/www/nginx-default/50x.html"
2010/09/09 13:26:30 [debug] 19323#0: *2905 add cleanup: 09CDA4DC
2010/09/09 13:26:30 [debug] 19323#0: *2905 http static fd: 4
2010/09/09 13:26:30 [debug] 19323#0: *2905 http set discard body
2010/09/09 13:26:30 [debug] 19323#0: *2905 HTTP/1.1 502 Bad Gateway
Server: nginx/0.7.65
Date: Thu, 09 Sep 2010 11:26:30 GMT
Content-Type: text/html
Content-Length: 383
Connection: keep-alive

2010/09/09 13:26:30 [debug] 19323#0: *2905 write new buf t:1 f:0 09CDA5E0, pos 09CDA5E0, size: 157 file: 0, size: 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 http write filter: l:0 f:0 s:157
2010/09/09 13:26:30 [debug] 19323#0: *2905 http output filter "/50x.html?"
2010/09/09 13:26:30 [debug] 19323#0: *2905 copy filter: "/50x.html?"
2010/09/09 13:26:30 [debug] 19323#0: *2905 malloc: 09CD1A40:4096
2010/09/09 13:26:30 [debug] 19323#0: *2905 http postpone filter "/50x.html?" BFBDC99C
2010/09/09 13:26:30 [debug] 19323#0: *2905 write old buf t:1 f:0 09CDA5E0, pos 09CDA5E0, size: 157 file: 0, size: 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 write new buf t:0 f:1 00000000, pos 00000000, size: 0 file: 0, size: 383
2010/09/09 13:26:30 [debug] 19323#0: *2905 http write filter: l:1 f:0 s:540
2010/09/09 13:26:30 [debug] 19323#0: *2905 http write filter limit 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 writev: 157
2010/09/09 13:26:30 [debug] 19323#0: *2905 sendfile: @0 383
2010/09/09 13:26:30 [debug] 19323#0: *2905 sendfile: 383, @0 383:383
2010/09/09 13:26:30 [debug] 19323#0: *2905 http write filter 00000000
2010/09/09 13:26:30 [debug] 19323#0: *2905 copy filter: 0 "/50x.html?"
2010/09/09 13:26:30 [debug] 19323#0: *2905 http finalize request: 0, "/50x.html?" 1
2010/09/09 13:26:30 [debug] 19323#0: *2905 set http keepalive handler
2010/09/09 13:26:30 [debug] 19323#0: *2905 http close request
2010/09/09 13:26:30 [debug] 19323#0: *2905 http log handler
2010/09/09 13:26:30 [debug] 19323#0: *2905 run cleanup: 09CDA4DC
2010/09/09 13:26:30 [debug] 19323#0: *2905 file cleanup: fd:4
2010/09/09 13:26:30 [debug] 19323#0: *2905 free: 09CD0A38
2010/09/09 13:26:30 [debug] 19323#0: *2905 free: 09CD9698, unused: 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 free: 09CD1A40, unused: 3796
2010/09/09 13:26:30 [debug] 19323#0: *2905 event timer add: 3: 65000:4131401574
2010/09/09 13:26:30 [debug] 19323#0: *2905 free: 09CD93F0
2010/09/09 13:26:30 [debug] 19323#0: *2905 free: 09CD8FE8
2010/09/09 13:26:30 [debug] 19323#0: *2905 hc free: 00000000 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 hc busy: 00000000 0
2010/09/09 13:26:30 [debug] 19323#0: *2905 post event 09CFFDA0
2010/09/09 13:26:30 [debug] 19323#0: timer delta: 30002
2010/09/09 13:26:30 [debug] 19323#0: posted events 09CFFDA0
2010/09/09 13:26:30 [debug] 19323#0: posted event 09CFFDA0
2010/09/09 13:26:30 [debug] 19323#0: *2905 delete posted event 09CFFDA0
2010/09/09 13:26:30 [debug] 19323#0: *2905 http keepalive handler
2010/09/09 13:26:30 [debug] 19323#0: *2905 malloc: 09CD8FE8:1024
2010/09/09 13:26:30 [debug] 19323#0: *2905 recv: fd:3 -1 of 1024
2010/09/09 13:26:30 [debug] 19323#0: *2905 recv() not ready (11: Resource temporarily unavailable)
2010/09/09 13:26:30 [debug] 19323#0: posted event 00000000
2010/09/09 13:26:30 [debug] 19323#0: worker cycle
2010/09/09 13:26:30 [debug] 19323#0: epoll timer: 10294
2010/09/09 13:26:41 [debug] 19323#0: timer delta: 10299
2010/09/09 13:26:41 [debug] 19323#0: *2913 event timer del: 13: 4131346868
2010/09/09 13:26:41 [debug] 19323#0: *2913 http keepalive handler
2010/09/09 13:26:41 [debug] 19323#0: *2913 close http connection: 13
2010/09/09 13:26:41 [debug] 19323#0: *2913 free: 09CDAE58
2010/09/09 13:26:41 [debug] 19323#0: *2913 free: 00000000
2010/09/09 13:26:41 [debug] 19323#0: *2913 free: 09CDAD50, unused: 56
2010/09/09 13:26:41 [debug] 19323#0: posted events 00000000
2010/09/09 13:26:41 [debug] 19323#0: worker cycle
2010/09/09 13:26:41 [debug] 19323#0: epoll timer: 887
2010/09/09 13:26:41 [debug] 19323#0: timer delta: 888
2010/09/09 13:26:41 [debug] 19323#0: *2908 event timer del: 6: 4131347760
2010/09/09 13:26:41 [debug] 19323#0: *2908 http keepalive handler
2010/09/09 13:26:41 [debug] 19323#0: *2908 close http connection: 6
2010/09/09 13:26:41 [debug] 19323#0: *2908 free: 09CDB260
2010/09/09 13:26:41 [debug] 19323#0: *2908 free: 00000000
2010/09/09 13:26:41 [debug] 19323#0: *2908 free: 09CCC220, unused: 56
2010/09/09 13:26:41 [debug] 19323#0: posted events 00000000
2010/09/09 13:26:41 [debug] 19323#0: worker cycle
2010/09/09 13:26:41 [debug] 19323#0: epoll timer: 53813
2010/09/09 13:27:35 [debug] 19323#0: timer delta: 53817
2010/09/09 13:27:35 [debug] 19323#0: *2905 event timer del: 3: 4131401574
2010/09/09 13:27:35 [debug] 19323#0: *2905 http keepalive handler
2010/09/09 13:27:35 [debug] 19323#0: *2905 close http connection: 3
2010/09/09 13:27:35 [debug] 19323#0: *2905 free: 09CD8FE8
2010/09/09 13:27:35 [debug] 19323#0: *2905 free: 00000000
2010/09/09 13:27:35 [debug] 19323#0: *2905 free: 09CCBFF8, unused: 56
2010/09/09 13:27:35 [debug] 19323#0: posted events 00000000
2010/09/09 13:27:35 [debug] 19323#0: worker cycle
2010/09/09 13:27:35 [debug] 19323#0: epoll timer: -1