2010/03/09 20:17:42 [debug] 751#0: post event 000000000078ED30
2010/03/09 20:17:42 [debug] 751#0: delete posted event 000000000078ED30
2010/03/09 20:17:42 [debug] 751#0: accept on 0.0.0.0:80, ready: 0
2010/03/09 20:17:42 [debug] 751#0: posix_memalign: 00000000006C34E0:256 @16
2010/03/09 20:17:42 [debug] 751#0: *97 accept: 62.147.138.134 fd:8
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 8: 600000:1268162862662
2010/03/09 20:17:42 [debug] 751#0: *97 epoll add event: fd:8 op:1 ev:80000001
2010/03/09 20:17:42 [debug] 751#0: *97 post event 000000000078EE00
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 000000000078EE00
2010/03/09 20:17:42 [debug] 751#0: *97 malloc: 00000000006D08F0:1256
2010/03/09 20:17:42 [debug] 751#0: *97 posix_memalign: 00000000006C37C0:256 @16
2010/03/09 20:17:42 [debug] 751#0: *97 malloc: 000000000078A910:1024
2010/03/09 20:17:42 [debug] 751#0: *97 posix_memalign: 00000000006D0DE0:4096 @16
2010/03/09 20:17:42 [debug] 751#0: *97 http process request line
2010/03/09 20:17:42 [debug] 751#0: *97 recv: fd:8 123 of 1024
2010/03/09 20:17:42 [debug] 751#0: *97 http request line: "GET /test/ HTTP/1.1"
2010/03/09 20:17:42 [debug] 751#0: *97 http uri: "/test/"
2010/03/09 20:17:42 [debug] 751#0: *97 http args: ""
2010/03/09 20:17:42 [debug] 751#0: *97 http exten: ""
2010/03/09 20:17:42 [debug] 751#0: *97 http process request header line
2010/03/09 20:17:42 [debug] 751#0: *97 http header: "TE: deflate,gzip;q=0.3"
2010/03/09 20:17:42 [debug] 751#0: *97 http header: "Connection: TE, close"
2010/03/09 20:17:42 [debug] 751#0: *97 http header: "Host: i20.etigris.com"
2010/03/09 20:17:42 [debug] 751#0: *97 http header: "User-Agent: lwp-request/2.07"
2010/03/09 20:17:42 [debug] 751#0: *97 http header done
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 8: 1268162862662
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 0
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 1
2010/03/09 20:17:42 [debug] 751#0: *97 http script var
2010/03/09 20:17:42 [debug] 751#0: *97 http script var: "GET"
2010/03/09 20:17:42 [debug] 751#0: *97 http script regex: "POST"
2010/03/09 20:17:42 [notice] 751#0: *97 "POST" does not match "GET", client: 62.147.138.134, server: localhost, request: "GET /test/ HTTP/1.1", host: "i20.etigris.com"
2010/03/09 20:17:42 [debug] 751#0: *97 http script if
2010/03/09 20:17:42 [debug] 751#0: *97 http script if: false
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "/"
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "region"
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "ssi"
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "ville"
2010/03/09 20:17:42 [debug] 751#0: *97 using configuration "/"
2010/03/09 20:17:42 [debug] 751#0: *97 http cl:-1 max:1048576
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 3
2010/03/09 20:17:42 [debug] 751#0: *97 http script complex value
2010/03/09 20:17:42 [debug] 751#0: *97 http script var: "/test/"
2010/03/09 20:17:42 [debug] 751#0: *97 http script set $memcached_key
2010/03/09 20:17:42 [debug] 751#0: *97 post rewrite phase: 4
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 5
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 6
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 7
2010/03/09 20:17:42 [debug] 751#0: *97 access phase: 8
2010/03/09 20:17:42 [debug] 751#0: *97 access phase: 9
2010/03/09 20:17:42 [debug] 751#0: *97 post access phase: 10
2010/03/09 20:17:42 [debug] 751#0: *97 http set discard body
2010/03/09 20:17:42 [debug] 751#0: *97 http init upstream, client timer: 0
2010/03/09 20:17:42 [debug] 751#0: *97 epoll add event: fd:8 op:3 ev:80000005
2010/03/09 20:17:42 [debug] 751#0: *97 http memcached request: "/test/"
2010/03/09 20:17:42 [debug] 751#0: *97 posix_memalign: 00000000006C7AE0:4096 @16
2010/03/09 20:17:42 [debug] 751#0: *97 http cleanup add: 00000000006D1DC8
2010/03/09 20:17:42 [debug] 751#0: *97 get rr peer, try: 1
2010/03/09 20:17:42 [debug] 751#0: *97 socket 9
2010/03/09 20:17:42 [debug] 751#0: *97 epoll add connection: fd:9 ev:80000005
2010/03/09 20:17:42 [debug] 751#0: *97 connect to 127.0.0.1:11211, fd:9 #98
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream connect: -2
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 9: 1000000:1268163262730
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: -4, "/test/?" a:1, c:2
2010/03/09 20:17:42 [debug] 751#0: *97 http request count:2 blk:0
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E10
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream send request handler
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream send request
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer buf fl:0 s:12
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer in: 00000000006C7B58
2010/03/09 20:17:42 [debug] 751#0: *97 writev: 12
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer out: 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 9: 1268163262730
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 9: 1000000:1268163262730
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E10
2010/03/09 20:17:42 [debug] 751#0: *97 http run request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream check client, write event:1, "/test/"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream recv(): -1 (11: Resource temporarily unavailable)
2010/03/09 20:17:42 [debug] 751#0: *97 post event 000000000078EE68
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream dummy handler
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 000000000078EE68
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream process header
2010/03/09 20:17:42 [debug] 751#0: *97 malloc: 00000000006C8AF0:4096
2010/03/09 20:17:42 [debug] 751#0: *97 recv: fd:9 5 of 4096
2010/03/09 20:17:42 [debug] 751#0: *97 memcached: "END"
2010/03/09 20:17:42 [info] 751#0: *97 key: "/test/" was not found by memcached while reading response header from upstream, client: 62.147.138.134, server: localhost, request: "GET /test/ HTTP/1.1", upstream: "memcached://127.0.0.1:11211", host: "i20.etigris.com"
2010/03/09 20:17:42 [debug] 751#0: *97 finalize http upstream request: 404
2010/03/09 20:17:42 [debug] 751#0: *97 finalize http memcached request
2010/03/09 20:17:42 [debug] 751#0: *97 free rr peer 1 0
2010/03/09 20:17:42 [debug] 751#0: *97 close http upstream connection: 9
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 9: 1268163262730
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: 404, "/test/?" a:1, c:1
2010/03/09 20:17:42 [debug] 751#0: *97 http special response: 404, "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "@python"
2010/03/09 20:17:42 [debug] 751#0: *97 using location: @python "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 3
2010/03/09 20:17:42 [debug] 751#0: *97 post rewrite phase: 4
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 5
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 6
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 7
2010/03/09 20:17:42 [debug] 751#0: *97 access phase: 8
2010/03/09 20:17:42 [debug] 751#0: *97 access phase: 9
2010/03/09 20:17:42 [debug] 751#0: *97 post access phase: 10
2010/03/09 20:17:42 [debug] 751#0: *97 http init upstream, client timer: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http script copy: "Host: "
2010/03/09 20:17:42 [debug] 751#0: *97 http script var: "i20.etigris.com"
2010/03/09 20:17:42 [debug] 751#0: *97 http script copy: "
"
2010/03/09 20:17:42 [debug] 751#0: *97 http script copy: "Connection: close
"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "TE: deflate,gzip;q=0.3"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "User-Agent: lwp-request/2.07"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header:
"GET /test/ HTTP/1.0
Host: i20.etigris.com
Connection: close
TE: deflate,gzip;q=0.3
User-Agent: lwp-request/2.07

"
2010/03/09 20:17:42 [debug] 751#0: *97 http cleanup add: 00000000006C8328
2010/03/09 20:17:42 [debug] 751#0: *97 get rr peer, try: 1
2010/03/09 20:17:42 [debug] 751#0: *97 socket 9
2010/03/09 20:17:42 [debug] 751#0: *97 epoll add connection: fd:9 ev:80000005
2010/03/09 20:17:42 [debug] 751#0: *97 connect to 0.0.0.0:8080, fd:9 #99
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream connect: -2
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 9: 60000:1268162322730
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: -4, "/test/?" a:1, c:3
2010/03/09 20:17:42 [debug] 751#0: *97 http request count:3 blk:0
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: -4, "/test/?" a:1, c:2
2010/03/09 20:17:42 [debug] 751#0: *97 http request count:2 blk:0
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream send request handler
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream send request
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer buf fl:1 s:119
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer in: 00000000006C8440
2010/03/09 20:17:42 [debug] 751#0: *97 writev: 119
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer out: 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 9: 1268162322730
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 9: 60000:1268162322731
2010/03/09 20:17:42 [debug] 751#0: *97 post event 000000000078EE68
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream dummy handler
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 000000000078EE68
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream process header
2010/03/09 20:17:42 [debug] 751#0: *97 malloc: 00000000006C9B00:4096
2010/03/09 20:17:42 [debug] 751#0: *97 recv: fd:9 221 of 4096
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy status 200 "200 OK"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Server: gunicorn/0.6.2"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Date: Tue, 09 Mar 2010 19:17:42 GMT"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Status: 200 OK"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Connection: close"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Content-Length: 46"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Content-Type: text/html; charset=UTF-8"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header done
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter header
2010/03/09 20:17:42 [debug] 751#0: *97 HTTP/1.1 200 OK
Server: nginx/0.8.34
Date: Tue, 09 Mar 2010 19:17:42 GMT
Content-Type: text/html; charset=UTF-8
Transfer-Encoding: chunked
Connection: close
Status: 200 OK

2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 00000000006C88C8, pos 00000000006C88C8, size: 181 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter: l:0 f:0 s:181
2010/03/09 20:17:42 [debug] 751#0: *97 http cacheable: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream process upstream
2010/03/09 20:17:42 [debug] 751#0: *97 pipe read upstream: 1
2010/03/09 20:17:42 [debug] 751#0: *97 pipe preread: 46
2010/03/09 20:17:42 [debug] 751#0: *97 readv: 1:3875
2010/03/09 20:17:42 [debug] 751#0: *97 pipe recv chain: 0
2010/03/09 20:17:42 [debug] 751#0: *97 pipe buf free s:0 t:1 f:0 00000000006C9B00, pos 00000000006C9BAF, size: 46 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 posix_memalign: 00000000006CAB10:4096 @16
2010/03/09 20:17:42 [debug] 751#0: *97 input buf #0
2010/03/09 20:17:42 [debug] 751#0: *97 pipe write downstream: 1
2010/03/09 20:17:42 [debug] 751#0: *97 pipe write downstream flush in
2010/03/09 20:17:42 [debug] 751#0: *97 http output filter "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter body
2010/03/09 20:17:42 [debug] 751#0: *97 http ssi filter "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 saved: 0 state: 0
2010/03/09 20:17:42 [debug] 751#0: *97 parse: 0, looked: 0 00000000006C9BAF-00000000006C9BB5
2010/03/09 20:17:42 [debug] 751#0: *97 saved: 0
2010/03/09 20:17:42 [debug] 751#0: *97 ssi flush
2010/03/09 20:17:42 [debug] 751#0: *97 ssi out: 00000000006CAD08 00000000006C9BAF
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter "/test/?" 00000000006CAD58
2010/03/09 20:17:42 [debug] 751#0: *97 http chunk: 6
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C88C8, pos 00000000006C88C8, size: 181 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 0000000000000000, pos 00000000006CADC8, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 00000000006C9B00, pos 00000000006C9BAF, size: 6 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter: l:0 f:0 s:192
2010/03/09 20:17:42 [debug] 751#0: *97 ssi include: "/ssi/"
2010/03/09 20:17:42 [debug] 751#0: *97 http subrequest "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 saved: 0 state: 0
2010/03/09 20:17:42 [debug] 751#0: *97 parse: -2, looked: 0 00000000006C9BD6-00000000006C9BDD
2010/03/09 20:17:42 [debug] 751#0: *97 saved: 0
2010/03/09 20:17:42 [debug] 751#0: *97 ssi out: 00000000006CB868 00000000006C9BD6
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter "/test/?" 00000000006CB8B8
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: 0 "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 pipe write downstream done
2010/03/09 20:17:42 [debug] 751#0: *97 event timer: 9, old: 1268162322731, new: 1268162322772
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream exit: 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 finalize http upstream request: 0
2010/03/09 20:17:42 [debug] 751#0: *97 finalize http proxy request
2010/03/09 20:17:42 [debug] 751#0: *97 free rr peer 1 0
2010/03/09 20:17:42 [debug] 751#0: *97 close http upstream connection: 9
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 9: 1268162322731
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream temp fd: -1
2010/03/09 20:17:42 [debug] 751#0: *97 http output filter "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter body
2010/03/09 20:17:42 [debug] 751#0: *97 http ssi filter "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 ssi out: 00000000006CB950 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter "/test/?" 00000000006CB9A0
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: 0 "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: 0, "/test/?" a:0, c:2
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 8: 600000:1268162862772
2010/03/09 20:17:42 [debug] 751#0: *97 http posted request: "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 1
2010/03/09 20:17:42 [debug] 751#0: *97 http script var
2010/03/09 20:17:42 [debug] 751#0: *97 http script var: "GET"
2010/03/09 20:17:42 [debug] 751#0: *97 http script regex: "POST"
2010/03/09 20:17:42 [notice] 751#0: *97 "POST" does not match "GET", client: 62.147.138.134, server: localhost, request: "GET /test/ HTTP/1.1", subrequest: "/ssi/", host: "i20.etigris.com"
2010/03/09 20:17:42 [debug] 751#0: *97 http script if
2010/03/09 20:17:42 [debug] 751#0: *97 http script if: false
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "/"
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "region"
2010/03/09 20:17:42 [debug] 751#0: *97 test location: "ssi"
2010/03/09 20:17:42 [debug] 751#0: *97 using configuration "/ssi"
2010/03/09 20:17:42 [debug] 751#0: *97 http cl:-1 max:1048576
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 3
2010/03/09 20:17:42 [debug] 751#0: *97 post rewrite phase: 4
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 5
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 6
2010/03/09 20:17:42 [debug] 751#0: *97 generic phase: 7
2010/03/09 20:17:42 [debug] 751#0: *97 posix_memalign: 00000000007C2D50:4096 @16
2010/03/09 20:17:42 [debug] 751#0: *97 http init upstream, client timer: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http script copy: "Host: "
2010/03/09 20:17:42 [debug] 751#0: *97 http script var: "i20.etigris.com"
2010/03/09 20:17:42 [debug] 751#0: *97 http script copy: "
"
2010/03/09 20:17:42 [debug] 751#0: *97 http script copy: "Connection: close
"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "TE: deflate,gzip;q=0.3"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "User-Agent: lwp-request/2.07"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header:
"GET /ssi/ HTTP/1.0
Host: i20.etigris.com
Connection: close
TE: deflate,gzip;q=0.3
User-Agent: lwp-request/2.07

"
2010/03/09 20:17:42 [debug] 751#0: *97 http cleanup add: 00000000007C3310
2010/03/09 20:17:42 [debug] 751#0: *97 get rr peer, try: 1
2010/03/09 20:17:42 [debug] 751#0: *97 socket 9
2010/03/09 20:17:42 [debug] 751#0: *97 epoll add connection: fd:9 ev:80000005
2010/03/09 20:17:42 [debug] 751#0: *97 connect to 0.0.0.0:8080, fd:9 #100
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream connect: -2
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 9: 60000:1268162322772
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: -4, "/ssi/?" a:1, c:3
2010/03/09 20:17:42 [debug] 751#0: *97 http request count:3 blk:0
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream send request handler
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream send request
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer buf fl:1 s:118
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer in: 00000000007C3348
2010/03/09 20:17:42 [debug] 751#0: *97 writev: 118
2010/03/09 20:17:42 [debug] 751#0: *97 chain writer out: 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 9: 1268162322772
2010/03/09 20:17:42 [debug] 751#0: *97 event timer add: 9: 60000:1268162322773
2010/03/09 20:17:42 [debug] 751#0: *97 post event 000000000078EE68
2010/03/09 20:17:42 [debug] 751#0: *97 post event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 00000000007A8E78
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream dummy handler
2010/03/09 20:17:42 [debug] 751#0: *97 delete posted event 000000000078EE68
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream request: "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream process header
2010/03/09 20:17:42 [debug] 751#0: *97 malloc: 00000000007C3D60:4096
2010/03/09 20:17:42 [debug] 751#0: *97 recv: fd:9 177 of 4096
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy status 200 "200 OK"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Server: gunicorn/0.6.2"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Date: Tue, 09 Mar 2010 19:17:42 GMT"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Status: 200 OK"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Connection: close"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Content-Length: 3"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header: "Content-Type: text/html; charset=UTF-8"
2010/03/09 20:17:42 [debug] 751#0: *97 http proxy header done
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter header
2010/03/09 20:17:42 [debug] 751#0: *97 charset: "UTF-8" > "UTF-8"
2010/03/09 20:17:42 [debug] 751#0: *97 http cacheable: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream process upstream
2010/03/09 20:17:42 [debug] 751#0: *97 pipe read upstream: 1
2010/03/09 20:17:42 [debug] 751#0: *97 pipe preread: 3
2010/03/09 20:17:42 [debug] 751#0: *97 readv: 1:3919
2010/03/09 20:17:42 [debug] 751#0: *97 pipe recv chain: 0
2010/03/09 20:17:42 [debug] 751#0: *97 pipe buf free s:0 t:1 f:0 00000000007C3D60, pos 00000000007C3E0E, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 input buf #0
2010/03/09 20:17:42 [debug] 751#0: *97 pipe write downstream: 1
2010/03/09 20:17:42 [debug] 751#0: *97 pipe write downstream flush in
2010/03/09 20:17:42 [debug] 751#0: *97 http output filter "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter body
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter "/ssi/?" 00000000007C3750
2010/03/09 20:17:42 [debug] 751#0: *97 http chunk: 3
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C88C8, pos 00000000006C88C8, size: 181 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 0000000000000000, pos 00000000006CADC8, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C9B00, pos 00000000006C9BAF, size: 6 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 0000000000000000, pos 00000000007C3828, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 00000000007C3D60, pos 00000000007C3E0E, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter: l:0 f:0 s:200
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: 0 "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 pipe write downstream done
2010/03/09 20:17:42 [debug] 751#0: *97 event timer: 9, old: 1268162322773, new: 1268162322773
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 8: 1268162862772
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream exit: 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 finalize http upstream request: 0
2010/03/09 20:17:42 [debug] 751#0: *97 finalize http proxy request
2010/03/09 20:17:42 [debug] 751#0: *97 free rr peer 1 0
2010/03/09 20:17:42 [debug] 751#0: *97 close http upstream connection: 9
2010/03/09 20:17:42 [debug] 751#0: *97 event timer del: 9: 1268162322773
2010/03/09 20:17:42 [debug] 751#0: *97 http upstream temp fd: -1
2010/03/09 20:17:42 [debug] 751#0: *97 http output filter "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter body
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter "/ssi/?" 00007FFF2491F020
2010/03/09 20:17:42 [debug] 751#0: *97 http chunk: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C88C8, pos 00000000006C88C8, size: 181 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 0000000000000000, pos 00000000006CADC8, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C9B00, pos 00000000006C9BAF, size: 6 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 0000000000000000, pos 00000000007C3828, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000007C3D60, pos 00000000007C3E0E, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter: l:0 f:0 s:200
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: 0 "/ssi/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: 0, "/ssi/?" a:1, c:2
2010/03/09 20:17:42 [debug] 751#0: *97 http wake parent request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http posted request: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http writer handler: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http output filter "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 xslt filter body
2010/03/09 20:17:42 [debug] 751#0: *97 http ssi filter "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter "/test/?" 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 http postpone filter output "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http chunk: 7
2010/03/09 20:17:42 [debug] 751#0: *97 http chunk: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C88C8, pos 00000000006C88C8, size: 181 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 0000000000000000, pos 00000000006CADC8, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000006C9B00, pos 00000000006C9BAF, size: 6 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 0000000000000000, pos 00000000007C3828, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:1 f:0 00000000007C3D60, pos 00000000007C3E0E, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:0 f:0 0000000000000000, pos 000000000047F56D, size: 2 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write old buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 0000000000000000, pos 00000000007C39B0, size: 3 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:1 f:0 00000000006C9B00, pos 00000000006C9BD6, size: 7 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 write new buf t:0 f:0 0000000000000000, pos 000000000047F568, size: 7 file: 0, size: 0
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter: l:1 f:0 s:217
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter limit 0
2010/03/09 20:17:42 [debug] 751#0: *97 writev: 217
2010/03/09 20:17:42 [debug] 751#0: *97 http write filter 0000000000000000
2010/03/09 20:17:42 [debug] 751#0: *97 http copy filter: 0 "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http writer output filter: 0, "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http writer done: "/test/?"
2010/03/09 20:17:42 [debug] 751#0: *97 http finalize request: 0, "/test/?" a:1, c:1
2010/03/09 20:17:42 [debug] 751#0: *97 http request count:1 blk:0
2010/03/09 20:17:42 [debug] 751#0: *97 http close request
2010/03/09 20:17:42 [debug] 751#0: *97 http log handler
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000007C3D60
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006C9B00
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006C8AF0
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006D0DE0, unused: 0
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006C7AE0, unused: 2
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006CAB10, unused: 2
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000007C2D50, unused: 642
2010/03/09 20:17:42 [debug] 751#0: *97 close http connection: 8
2010/03/09 20:17:42 [debug] 751#0: *97 free: 000000000078A910
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006D08F0
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006C34E0, unused: 8
2010/03/09 20:17:42 [debug] 751#0: *97 free: 00000000006C37C0, unused: 128