2014/05/06 11:45:09 [notice] 7222#0: signal process started
2014/05/06 11:45:09 [notice] 6950#0: signal 15 (SIGTERM) received, exiting
2014/05/06 11:45:09 [notice] 6951#0: exiting
2014/05/06 11:45:09 [notice] 6951#0: exit
2014/05/06 11:45:09 [notice] 6950#0: signal 17 (SIGCHLD) received
2014/05/06 11:45:09 [notice] 6950#0: worker process 6951 exited with code 0
2014/05/06 11:45:09 [notice] 6950#0: exit
2014/05/06 11:45:17 [debug] 7223#0: bind() 0.0.0.0:6401 #6 
2014/05/06 11:45:17 [debug] 7223#0: bind() 0.0.0.0:443 #7 
2014/05/06 11:45:17 [notice] 7223#0: using the "epoll" event method
2014/05/06 11:45:17 [debug] 7223#0: counter: 00007F09AEFCA080, 1
2014/05/06 11:45:17 [notice] 7223#0: nginx/1.6.0
2014/05/06 11:45:17 [notice] 7223#0: built by gcc 4.4.7 20120313 (Red Hat 4.4.7-3) (GCC) 
2014/05/06 11:45:17 [notice] 7223#0: OS: Linux 2.6.32-279.el6.x86_64
2014/05/06 11:45:17 [notice] 7223#0: getrlimit(RLIMIT_NOFILE): 1024:4096
2014/05/06 11:45:17 [debug] 7224#0: write: 8, 00007FFF4829BB80, 5, 0
2014/05/06 11:45:17 [debug] 7224#0: setproctitle: "nginx: master process nginx.debug"
2014/05/06 11:45:17 [notice] 7224#0: start worker processes
2014/05/06 11:45:17 [debug] 7224#0: channel 3:8
2014/05/06 11:45:17 [notice] 7224#0: start worker process 7225
2014/05/06 11:45:17 [debug] 7224#0: sigsuspend
2014/05/06 11:45:17 [debug] 7225#0: eventfd: 10
2014/05/06 11:45:17 [debug] 7225#0: malloc: 0000000001B23B80:6144
2014/05/06 11:45:17 [debug] 7225#0: malloc: 00007F09AE500010:221184
2014/05/06 11:45:17 [debug] 7225#0: malloc: 0000000001B4A730:106496
2014/05/06 11:45:17 [debug] 7225#0: malloc: 0000000001B64740:106496
2014/05/06 11:45:17 [debug] 7225#0: epoll add event: fd:6 op:1 ev:00002001
2014/05/06 11:45:17 [debug] 7225#0: epoll add event: fd:7 op:1 ev:00002001
2014/05/06 11:45:17 [debug] 7225#0: epoll add event: fd:8 op:1 ev:00002001
2014/05/06 11:45:17 [debug] 7225#0: setproctitle: "nginx: worker process"
2014/05/06 11:45:17 [debug] 7225#0: worker cycle
2014/05/06 11:45:17 [debug] 7225#0: epoll timer: -1
2014/05/06 11:45:29 [debug] 7225#0: epoll: fd:7 ev:0001 d:00007F09AE5000E8
2014/05/06 11:45:29 [debug] 7225#0: accept on 0.0.0.0:443, ready: 0
2014/05/06 11:45:29 [debug] 7225#0: posix_memalign: 0000000001B430A0:256 @16
2014/05/06 11:45:29 [debug] 7225#0: *1 accept: 14.97.77.102 fd:3
2014/05/06 11:45:29 [debug] 7225#0: posix_memalign: 0000000001B188C0:256 @16
2014/05/06 11:45:29 [debug] 7225#0: *1 event timer add: 3: 60000:1399376789381
2014/05/06 11:45:29 [debug] 7225#0: *1 reusable connection: 1
2014/05/06 11:45:29 [debug] 7225#0: *1 epoll add event: fd:3 op:1 ev:80002001
2014/05/06 11:45:29 [debug] 7225#0: timer delta: 12079
2014/05/06 11:45:29 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:29 [debug] 7225#0: worker cycle
2014/05/06 11:45:29 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:45:29 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500298
2014/05/06 11:45:29 [debug] 7225#0: *1 http check ssl handshake
2014/05/06 11:45:29 [debug] 7225#0: *1 http recv(): 1
2014/05/06 11:45:29 [debug] 7225#0: *1 https ssl handshake: 0x16
2014/05/06 11:45:29 [debug] 7225#0: *1 SSL_do_handshake: -1
2014/05/06 11:45:29 [debug] 7225#0: *1 SSL_get_error: 2
2014/05/06 11:45:29 [debug] 7225#0: *1 reusable connection: 0
2014/05/06 11:45:29 [debug] 7225#0: timer delta: 207
2014/05/06 11:45:29 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:29 [debug] 7225#0: worker cycle
2014/05/06 11:45:29 [debug] 7225#0: epoll timer: 59793
2014/05/06 11:45:30 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500298
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL handshake handler: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_do_handshake: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:45:30 [debug] 7225#0: *1 reusable connection: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 http wait request handler
2014/05/06 11:45:30 [debug] 7225#0: *1 malloc: 0000000001B8C270:1024
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_read: -1
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_get_error: 2
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B8C270
2014/05/06 11:45:30 [debug] 7225#0: timer delta: 440
2014/05/06 11:45:30 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: worker cycle
2014/05/06 11:45:30 [debug] 7225#0: epoll timer: 59353
2014/05/06 11:45:30 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500298
2014/05/06 11:45:30 [debug] 7225#0: *1 http wait request handler
2014/05/06 11:45:30 [debug] 7225#0: *1 malloc: 0000000001B8C270:1024
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_read: 254
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_read: -1
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_get_error: 2
2014/05/06 11:45:30 [debug] 7225#0: *1 reusable connection: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 posix_memalign: 0000000001B25390:4096 @16
2014/05/06 11:45:30 [debug] 7225#0: *1 http process request line
2014/05/06 11:45:30 [debug] 7225#0: *1 http request line: "GET / HTTP/1.1"
2014/05/06 11:45:30 [debug] 7225#0: *1 http uri: "/"
2014/05/06 11:45:30 [debug] 7225#0: *1 http args: ""
2014/05/06 11:45:30 [debug] 7225#0: *1 http exten: ""
2014/05/06 11:45:30 [debug] 7225#0: *1 http process request header line
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "Accept: text/html, application/xhtml+xml, */*"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "Accept-Language: en-US"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "Accept-Encoding: gzip, deflate"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "Host: 168.189.9.09"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "DNT: 1"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header: "Connection: Keep-Alive"
2014/05/06 11:45:30 [debug] 7225#0: *1 http header done
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer del: 3: 1399376789381
2014/05/06 11:45:30 [debug] 7225#0: *1 generic phase: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 rewrite phase: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 test location: "/"
2014/05/06 11:45:30 [debug] 7225#0: *1 using configuration "/"
2014/05/06 11:45:30 [debug] 7225#0: *1 http cl:-1 max:1048576
2014/05/06 11:45:30 [debug] 7225#0: *1 rewrite phase: 3
2014/05/06 11:45:30 [debug] 7225#0: *1 post rewrite phase: 4
2014/05/06 11:45:30 [debug] 7225#0: *1 generic phase: 5
2014/05/06 11:45:30 [debug] 7225#0: *1 generic phase: 6
2014/05/06 11:45:30 [debug] 7225#0: *1 generic phase: 7
2014/05/06 11:45:30 [debug] 7225#0: *1 access phase: 8
2014/05/06 11:45:30 [debug] 7225#0: *1 access phase: 9
2014/05/06 11:45:30 [debug] 7225#0: *1 access phase: 10
2014/05/06 11:45:30 [debug] 7225#0: *1 post access phase: 11
2014/05/06 11:45:30 [debug] 7225#0: *1 posix_memalign: 0000000001B8CDC0:4096 @16
2014/05/06 11:45:30 [debug] 7225#0: *1 http init upstream, client timer: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 epoll add event: fd:3 op:3 ev:80002005
2014/05/06 11:45:30 [debug] 7225#0: *1 http script copy: "Host: "
2014/05/06 11:45:30 [debug] 7225#0: *1 http script var: "168.189.9.09"
2014/05/06 11:45:30 [debug] 7225#0: *1 http script copy: "
"
2014/05/06 11:45:30 [debug] 7225#0: *1 http script copy: "Connection: close
"
2014/05/06 11:45:30 [debug] 7225#0: *1 http script copy: ""
2014/05/06 11:45:30 [debug] 7225#0: *1 http script copy: ""
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Accept: text/html, application/xhtml+xml, */*"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Accept-Language: en-US"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Accept-Encoding: gzip, deflate"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "DNT: 1"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header:
"GET / HTTP/1.0
Host: 168.189.9.09
Connection: close
Accept: text/html, application/xhtml+xml, */*
Accept-Language: en-US
User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko
Accept-Encoding: gzip, deflate
DNT: 1

"
2014/05/06 11:45:30 [debug] 7225#0: *1 http cleanup add: 0000000001B8D500
2014/05/06 11:45:30 [debug] 7225#0: *1 get rr peer, try: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 socket 11
2014/05/06 11:45:30 [debug] 7225#0: *1 epoll add connection: fd:11 ev:80002005
2014/05/06 11:45:30 [debug] 7225#0: *1 connect to 168.189.9.09:80, fd:11 #2
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream connect: -2
2014/05/06 11:45:30 [debug] 7225#0: *1 posix_memalign: 0000000001B26470:128 @16
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer add: 11: 60000:1399376790436
2014/05/06 11:45:30 [debug] 7225#0: *1 http finalize request: -4, "/?" a:1, c:2
2014/05/06 11:45:30 [debug] 7225#0: *1 http request count:2 blk:0
2014/05/06 11:45:30 [debug] 7225#0: timer delta: 408
2014/05/06 11:45:30 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: worker cycle
2014/05/06 11:45:30 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:45:30 [debug] 7225#0: epoll: fd:3 ev:0004 d:00007F09AE500298
2014/05/06 11:45:30 [debug] 7225#0: *1 http run request: "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream check client, write event:1, "/"
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream recv(): -1 (11: Resource temporarily unavailable)
2014/05/06 11:45:30 [debug] 7225#0: epoll: fd:11 ev:0004 d:00007F09AE500370
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream request: "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream send request handler
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream send request
2014/05/06 11:45:30 [debug] 7225#0: *1 chain writer buf fl:1 s:249
2014/05/06 11:45:30 [debug] 7225#0: *1 chain writer in: 0000000001B8D538
2014/05/06 11:45:30 [debug] 7225#0: *1 writev: 249
2014/05/06 11:45:30 [debug] 7225#0: *1 chain writer out: 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer del: 11: 1399376790436
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer add: 11: 60000:1399376790436
2014/05/06 11:45:30 [debug] 7225#0: timer delta: 0
2014/05/06 11:45:30 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: worker cycle
2014/05/06 11:45:30 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:45:30 [debug] 7225#0: epoll: fd:11 ev:0005 d:00007F09AE500370
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream request: "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream process header
2014/05/06 11:45:30 [debug] 7225#0: *1 malloc: 0000000001B8DDD0:4096
2014/05/06 11:45:30 [debug] 7225#0: *1 recv: fd:11 4096 of 4096
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy status 200 "200 OK"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Server: Apache-Coyote/1.1"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Set-Cookie: JSESSIONID=A12E6064F1AF35E048BA37932741AF32; Path=/; HttpOnly"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Content-Type: text/html;charset=ISO-8859-1"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Content-Length: 4141"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Date: Tue, 06 May 2014 11:45:30 GMT"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header: "Connection: close"
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy header done
2014/05/06 11:45:30 [debug] 7225#0: *1 HTTP/1.1 200 OK
Server: nginx/1.6.0
Date: Tue, 06 May 2014 11:45:30 GMT
Content-Type: text/html;charset=ISO-8859-1
Content-Length: 4141
Connection: keep-alive
Set-Cookie: JSESSIONID=A12E6064F1AF35E048BA37932741AF32; Path=/; HttpOnly

2014/05/06 11:45:30 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8D838, pos 0000000001B8D838, size: 242 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter: l:0 f:0 s:242
2014/05/06 11:45:30 [debug] 7225#0: *1 http cacheable: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 http proxy filter init s:200 h:0 c:0 l:4141
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream process upstream
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe read upstream: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe preread: 3853
2014/05/06 11:45:30 [debug] 7225#0: *1 input buf #0
2014/05/06 11:45:30 [debug] 7225#0: *1 malloc: 0000000001B8EDE0:4096
2014/05/06 11:45:30 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe recv chain: 288
2014/05/06 11:45:30 [debug] 7225#0: *1 readv: 1:3808
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe recv chain: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B8DDD0, pos 0000000001B8DEC3, size: 3853 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B8EDE0, pos 0000000001B8EDE0, size: 288 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe length: 288
2014/05/06 11:45:30 [debug] 7225#0: *1 input buf #1
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe write downstream: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe write downstream flush in
2014/05/06 11:45:30 [debug] 7225#0: *1 http output filter "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http copy filter: "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http postpone filter "/?" 0000000001B8DA50
2014/05/06 11:45:30 [debug] 7225#0: *1 write old buf t:1 f:0 0000000001B8D838, pos 0000000001B8D838, size: 242 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8DDD0, pos 0000000001B8DEC3, size: 3853 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8EDE0, pos 0000000001B8EDE0, size: 288 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter: l:0 f:0 s:4383
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:30 [debug] 7225#0: *1 posix_memalign: 0000000001B8BFC0:256 @16
2014/05/06 11:45:30 [debug] 7225#0: *1 malloc: 0000000001B7E750:16384
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL buf copy: 242
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL buf copy: 3853
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL buf copy: 288
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: *1 http copy filter: -2 "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 pipe write downstream done
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer: 11, old: 1399376790436, new: 1399376790439
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream exit: 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: *1 finalize http upstream request: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 finalize http proxy request
2014/05/06 11:45:30 [debug] 7225#0: *1 free rr peer 1 0
2014/05/06 11:45:30 [debug] 7225#0: *1 close http upstream connection: 11
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B26470, unused: 48
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer del: 11: 1399376790436
2014/05/06 11:45:30 [debug] 7225#0: *1 reusable connection: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 http upstream temp fd: -1
2014/05/06 11:45:30 [debug] 7225#0: *1 http output filter "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http copy filter: "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http postpone filter "/?" 00007FFF4829B7A0
2014/05/06 11:45:30 [debug] 7225#0: *1 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter: l:1 f:0 s:0
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL to write: 4383
2014/05/06 11:45:30 [debug] 7225#0: *1 SSL_write: 4383
2014/05/06 11:45:30 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: *1 http copy filter: 0 "/?"
2014/05/06 11:45:30 [debug] 7225#0: *1 http finalize request: 0, "/?" a:1, c:1
2014/05/06 11:45:30 [debug] 7225#0: *1 set http keepalive handler
2014/05/06 11:45:30 [debug] 7225#0: *1 http close request
2014/05/06 11:45:30 [debug] 7225#0: *1 http log handler
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B8EDE0
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B8DDD0
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B25390, unused: 2
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B8CDC0, unused: 123
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B8C270
2014/05/06 11:45:30 [debug] 7225#0: *1 hc free: 0000000000000000 0
2014/05/06 11:45:30 [debug] 7225#0: *1 hc busy: 0000000000000000 0
2014/05/06 11:45:30 [debug] 7225#0: *1 free: 0000000001B7E750
2014/05/06 11:45:30 [debug] 7225#0: *1 tcp_nodelay
2014/05/06 11:45:30 [debug] 7225#0: *1 reusable connection: 1
2014/05/06 11:45:30 [debug] 7225#0: *1 event timer add: 3: 65000:1399376795439
2014/05/06 11:45:30 [debug] 7225#0: timer delta: 3
2014/05/06 11:45:30 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:30 [debug] 7225#0: worker cycle
2014/05/06 11:45:30 [debug] 7225#0: epoll timer: 65000
2014/05/06 11:45:58 [debug] 7225#0: epoll: fd:3 ev:0005 d:00007F09AE500298
2014/05/06 11:45:58 [debug] 7225#0: *1 http keepalive handler
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B8C270:1024
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL_read: 465
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL_read: -1
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL_get_error: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 reusable connection: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 posix_memalign: 0000000001B25390:4096 @16
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer del: 3: 1399376795439
2014/05/06 11:45:58 [debug] 7225#0: *1 http process request line
2014/05/06 11:45:58 [debug] 7225#0: *1 http request line: "POST /Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32 HTTP/1.1"
2014/05/06 11:45:58 [debug] 7225#0: *1 http uri: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32"
2014/05/06 11:45:58 [debug] 7225#0: *1 http args: ""
2014/05/06 11:45:58 [debug] 7225#0: *1 http exten: "do;jsessionid=A12E6064F1AF35E048BA37932741AF32"
2014/05/06 11:45:58 [debug] 7225#0: *1 http process request header line
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Accept: text/html, application/xhtml+xml, */*"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Referer: https://168.189.9.09/"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Accept-Language: en-US"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Content-Type: application/x-www-form-urlencoded"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Accept-Encoding: gzip, deflate"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Host: 168.189.9.09"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Content-Length: 33"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "DNT: 1"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Connection: Keep-Alive"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header: "Cache-Control: no-cache"
2014/05/06 11:45:58 [debug] 7225#0: *1 http header done
2014/05/06 11:45:58 [debug] 7225#0: *1 generic phase: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 rewrite phase: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 test location: "/"
2014/05/06 11:45:58 [debug] 7225#0: *1 test location: "50x.html"
2014/05/06 11:45:58 [debug] 7225#0: *1 using configuration "/"
2014/05/06 11:45:58 [debug] 7225#0: *1 http cl:33 max:1048576
2014/05/06 11:45:58 [debug] 7225#0: *1 rewrite phase: 3
2014/05/06 11:45:58 [debug] 7225#0: *1 post rewrite phase: 4
2014/05/06 11:45:58 [debug] 7225#0: *1 generic phase: 5
2014/05/06 11:45:58 [debug] 7225#0: *1 generic phase: 6
2014/05/06 11:45:58 [debug] 7225#0: *1 generic phase: 7
2014/05/06 11:45:58 [debug] 7225#0: *1 access phase: 8
2014/05/06 11:45:58 [debug] 7225#0: *1 access phase: 9
2014/05/06 11:45:58 [debug] 7225#0: *1 access phase: 10
2014/05/06 11:45:58 [debug] 7225#0: *1 post access phase: 11
2014/05/06 11:45:58 [debug] 7225#0: *1 posix_memalign: 0000000001B8CDC0:4096 @16
2014/05/06 11:45:58 [debug] 7225#0: *1 http client request body preread 33
2014/05/06 11:45:58 [debug] 7225#0: *1 http request body content length filter
2014/05/06 11:45:58 [debug] 7225#0: *1 http body new buf t:1 f:0 0000000001B8C420, pos 0000000001B8C420, size: 33 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http init upstream, client timer: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http script copy: "Host: "
2014/05/06 11:45:58 [debug] 7225#0: *1 http script var: "168.189.9.09"
2014/05/06 11:45:58 [debug] 7225#0: *1 http script copy: "
"
2014/05/06 11:45:58 [debug] 7225#0: *1 http script copy: "Connection: close
"
2014/05/06 11:45:58 [debug] 7225#0: *1 http script copy: "Content-Length: "
2014/05/06 11:45:58 [debug] 7225#0: *1 http script var: "33"
2014/05/06 11:45:58 [debug] 7225#0: *1 http script copy: "
"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Accept: text/html, application/xhtml+xml, */*"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Referer: https://168.189.9.09/"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Accept-Language: en-US"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Content-Type: application/x-www-form-urlencoded"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Accept-Encoding: gzip, deflate"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "DNT: 1"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Cache-Control: no-cache"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header:
"POST /Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32 HTTP/1.0
Host: 168.189.9.09
Connection: close
Content-Length: 33
Accept: text/html, application/xhtml+xml, */*
Referer: https://168.189.9.09/
Accept-Language: en-US
User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko
Content-Type: application/x-www-form-urlencoded
Accept-Encoding: gzip, deflate
DNT: 1
Cache-Control: no-cache

"
2014/05/06 11:45:58 [debug] 7225#0: *1 http cleanup add: 0000000001B8D6B8
2014/05/06 11:45:58 [debug] 7225#0: *1 get rr peer, try: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 socket 11
2014/05/06 11:45:58 [debug] 7225#0: *1 epoll add connection: fd:11 ev:80002005
2014/05/06 11:45:58 [debug] 7225#0: *1 connect to 168.189.9.09:80, fd:11 #3
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream connect: -2
2014/05/06 11:45:58 [debug] 7225#0: *1 posix_memalign: 0000000001B911A0:128 @16
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer add: 11: 60000:1399376818636
2014/05/06 11:45:58 [debug] 7225#0: *1 http finalize request: -4, "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" a:1, c:2
2014/05/06 11:45:58 [debug] 7225#0: *1 http request count:2 blk:0
2014/05/06 11:45:58 [debug] 7225#0: *1 http run request: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream check client, write event:1, "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32"
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream recv(): -1 (11: Resource temporarily unavailable)
2014/05/06 11:45:58 [debug] 7225#0: timer delta: 28197
2014/05/06 11:45:58 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: worker cycle
2014/05/06 11:45:58 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:45:58 [debug] 7225#0: epoll: fd:11 ev:0004 d:00007F09AE500371
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream request: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream send request handler
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream send request
2014/05/06 11:45:58 [debug] 7225#0: *1 chain writer buf fl:0 s:427
2014/05/06 11:45:58 [debug] 7225#0: *1 chain writer buf fl:1 s:33
2014/05/06 11:45:58 [debug] 7225#0: *1 chain writer in: 0000000001B8D710
2014/05/06 11:45:58 [debug] 7225#0: *1 writev: 460
2014/05/06 11:45:58 [debug] 7225#0: *1 chain writer out: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer del: 11: 1399376818636
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer add: 11: 60000:1399376818636
2014/05/06 11:45:58 [debug] 7225#0: timer delta: 0
2014/05/06 11:45:58 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: worker cycle
2014/05/06 11:45:58 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:45:58 [debug] 7225#0: epoll: fd:11 ev:0005 d:00007F09AE500371
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream request: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream process header
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B8DDD0:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 recv: fd:11 4096 of 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy status 200 "200 OK"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Server: Apache-Coyote/1.1"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Set-Cookie: JSESSIONID=8DA1F6B88842F43FB7A2F7794B51849A; Path=/; HttpOnly"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Content-Type: text/html;charset=ISO-8859-1"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Date: Tue, 06 May 2014 11:45:58 GMT"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header: "Connection: close"
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy header done
2014/05/06 11:45:58 [debug] 7225#0: *1 HTTP/1.1 200 OK
Server: nginx/1.6.0
Date: Tue, 06 May 2014 11:45:58 GMT
Content-Type: text/html;charset=ISO-8859-1
Transfer-Encoding: chunked
Connection: keep-alive
Set-Cookie: JSESSIONID=8DA1F6B88842F43FB7A2F7794B51849A; Path=/; HttpOnly

2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8DA10, pos 0000000001B8DA10, size: 248 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:0 s:248
2014/05/06 11:45:58 [debug] 7225#0: *1 http cacheable: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http proxy filter init s:200 h:0 c:0 l:-1
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream process upstream
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe read upstream: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe preread: 3875
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #0
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B8EDE0:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #1
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B8FDF0:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 posix_memalign: 0000000001B7E750:4096 @16
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #2
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B7F760:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #3
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B80770:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #4
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B81780:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #5
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B82790:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #6
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B91440:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #7
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B92450:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 1:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #8
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe downstream ready
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B8DDD0, pos 0000000001B8DEAD, size: 3875 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B8EDE0, pos 0000000001B8EDE0, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B8FDF0, pos 0000000001B8FDF0, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B7F760, pos 0000000001B7F760, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B80770, pos 0000000001B80770, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B81780, pos 0000000001B81780, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B82790, pos 0000000001B82790, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B91440, pos 0000000001B91440, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf in   s:1 t:1 f:0 0000000001B92450, pos 0000000001B92450, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe length: -1
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write downstream: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write busy: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B8DEAD 3875
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B8EDE0 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B8FDF0 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write: out:0000000001B8DC08, f:1
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 0000000001B8D6F0
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 3875
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 write old buf t:1 f:0 0000000001B8DA10, pos 0000000001B8DA10, size: 248 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7ED20, pos 0000000001B7ED20, size: 6 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8DDD0, pos 0000000001B8DEAD, size: 3875 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8EDE0, pos 0000000001B8EDE0, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000000000000, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:1 s:8227
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:58 [debug] 7225#0: *1 malloc: 0000000001B93460:16384
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 248
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 6
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 3875
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: -2 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write busy: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B8FDF0 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B7F760 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B80770 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write: out:0000000001B8DD88, f:1
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 0000000001B7ECB0
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7EDD8, pos 0000000001B7EDD8, size: 6 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B8FDF0, pos 0000000001B8FDF0, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7F760, pos 0000000001B7F760, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000001B7ED20, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:1 s:8200
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 6
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4055
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL to write: 16384
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL_write: 16384
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 41
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: -2 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write busy: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B80770 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B81780 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B82790 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write: out:0000000001B7E8C0, f:1
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 0000000001B7EDB8
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7ED20, pos 0000000001B7ED20, size: 6 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B80770, pos 0000000001B80770, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B81780, pos 0000000001B81780, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000001B7EDD8, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:1 s:8200
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 6
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: -2 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write busy: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B82790 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B91440 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B92450 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write: out:0000000001B7EA40, f:1
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 0000000001B8D700
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7EDD8, pos 0000000001B7EDD8, size: 6 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B82790, pos 0000000001B82790, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B91440, pos 0000000001B91440, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000001B7ED20, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:1 s:8200
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 6
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4039
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL to write: 16384
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL_write: 16384
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 57
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: -2 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write busy: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write buf ls:1 0000000001B92450 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write: out:0000000001B7EBC0, f:0
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 0000000001B7EBC0
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7ED20, pos 0000000001B7ED20, size: 6 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B92450, pos 0000000001B92450, size: 4096 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000001B7EDD8, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:1 s:4104
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 6
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4096
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: -2 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write busy: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write: out:0000000000000000, f:0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe read upstream: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 9:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 168
2014/05/06 11:45:58 [debug] 7225#0: *1 readv: 9:4096
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe recv chain: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B92450, pos 0000000001B92450, size: 168 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B82790, pos 0000000001B82790, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B91440, pos 0000000001B91440, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B80770, pos 0000000001B80770, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B81780, pos 0000000001B81780, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B8FDF0, pos 0000000001B8FDF0, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B7F760, pos 0000000001B7F760, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B8DDD0, pos 0000000001B8DDD0, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe buf free s:0 t:1 f:0 0000000001B8EDE0, pos 0000000001B8EDE0, size: 0 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe length: -1
2014/05/06 11:45:58 [debug] 7225#0: *1 input buf #9
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B82790
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B91440
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B80770
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B81780
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B8FDF0
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B7F760
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B8DDD0
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B8EDE0
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write downstream: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write downstream flush in
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 0000000001B7EBC0
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 168
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B7EDD8, pos 0000000001B7EDD8, size: 4 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:1 f:0 0000000001B92450, pos 0000000001B92450, size: 168 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000001B7ED20, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:0 f:0 s:174
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: 0 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 pipe write downstream done
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer: 11, old: 1399376818636, new: 1399376818647
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream exit: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 finalize http upstream request: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 finalize http proxy request
2014/05/06 11:45:58 [debug] 7225#0: *1 free rr peer 1 0
2014/05/06 11:45:58 [debug] 7225#0: *1 close http upstream connection: 11
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B911A0, unused: 48
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer del: 11: 1399376818636
2014/05/06 11:45:58 [debug] 7225#0: *1 reusable connection: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http upstream temp fd: -1
2014/05/06 11:45:58 [debug] 7225#0: *1 http output filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http postpone filter "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" 00007FFF4829B7A0
2014/05/06 11:45:58 [debug] 7225#0: *1 http chunk: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write old buf t:1 f:0 0000000001B7EDD8, pos 0000000001B7EDD8, size: 4 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write old buf t:1 f:0 0000000001B92450, pos 0000000001B92450, size: 168 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write old buf t:0 f:0 0000000001B7ED20, pos 00000000004AC03D, size: 2 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 write new buf t:0 f:0 0000000000000000, pos 00000000004AC03A, size: 5 file: 0, size: 0
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter: l:1 f:0 s:179
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter limit 0
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 4
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 168
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL buf copy: 5
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL to write: 4342
2014/05/06 11:45:58 [debug] 7225#0: *1 SSL_write: 4342
2014/05/06 11:45:58 [debug] 7225#0: *1 http write filter 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 http copy filter: 0 "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?"
2014/05/06 11:45:58 [debug] 7225#0: *1 http finalize request: 0, "/Login.do;jsessionid=A12E6064F1AF35E048BA37932741AF32?" a:1, c:1
2014/05/06 11:45:58 [debug] 7225#0: *1 set http keepalive handler
2014/05/06 11:45:58 [debug] 7225#0: *1 http close request
2014/05/06 11:45:58 [debug] 7225#0: *1 http log handler
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B92450
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B25390, unused: 2
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B8CDC0, unused: 8
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B7E750, unused: 1859
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B8C270
2014/05/06 11:45:58 [debug] 7225#0: *1 hc free: 0000000000000000 0
2014/05/06 11:45:58 [debug] 7225#0: *1 hc busy: 0000000000000000 0
2014/05/06 11:45:58 [debug] 7225#0: *1 free: 0000000001B93460
2014/05/06 11:45:58 [debug] 7225#0: *1 reusable connection: 1
2014/05/06 11:45:58 [debug] 7225#0: *1 event timer add: 3: 65000:1399376823647
2014/05/06 11:45:58 [debug] 7225#0: timer delta: 11
2014/05/06 11:45:58 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:45:58 [debug] 7225#0: worker cycle
2014/05/06 11:45:58 [debug] 7225#0: epoll timer: 65000
2014/05/06 11:46:05 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:46:05 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:46:05 [debug] 7225#0: posix_memalign: 0000000001B26B90:256 @16
2014/05/06 11:46:05 [debug] 7225#0: *4 accept: 14.97.77.102 fd:11
2014/05/06 11:46:05 [debug] 7225#0: posix_memalign: 0000000001B90F30:256 @16
2014/05/06 11:46:05 [debug] 7225#0: *4 event timer add: 11: 60000:1399376825095
2014/05/06 11:46:05 [debug] 7225#0: *4 reusable connection: 1
2014/05/06 11:46:05 [debug] 7225#0: *4 epoll add event: fd:11 op:1 ev:80002001
2014/05/06 11:46:05 [debug] 7225#0: timer delta: 6448
2014/05/06 11:46:05 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:05 [debug] 7225#0: worker cycle
2014/05/06 11:46:05 [debug] 7225#0: epoll timer: 58552
2014/05/06 11:46:05 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500370
2014/05/06 11:46:05 [debug] 7225#0: *4 http check ssl handshake
2014/05/06 11:46:05 [debug] 7225#0: *4 http recv(): 1
2014/05/06 11:46:05 [debug] 7225#0: *4 https ssl handshake: 0x16
2014/05/06 11:46:05 [debug] 7225#0: *4 SSL_do_handshake: -1
2014/05/06 11:46:05 [debug] 7225#0: *4 SSL_get_error: 2
2014/05/06 11:46:05 [debug] 7225#0: *4 reusable connection: 0
2014/05/06 11:46:05 [debug] 7225#0: timer delta: 588
2014/05/06 11:46:05 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:05 [debug] 7225#0: worker cycle
2014/05/06 11:46:05 [debug] 7225#0: epoll timer: 57964
2014/05/06 11:46:06 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500370
2014/05/06 11:46:06 [debug] 7225#0: *4 SSL handshake handler: 0
2014/05/06 11:46:06 [debug] 7225#0: *4 SSL_do_handshake: 1
2014/05/06 11:46:06 [debug] 7225#0: *4 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:46:06 [debug] 7225#0: *4 reusable connection: 1
2014/05/06 11:46:06 [debug] 7225#0: *4 http wait request handler
2014/05/06 11:46:06 [debug] 7225#0: *4 malloc: 0000000001B9F710:1024
2014/05/06 11:46:06 [debug] 7225#0: *4 SSL_read: -1
2014/05/06 11:46:06 [debug] 7225#0: *4 SSL_get_error: 2
2014/05/06 11:46:06 [debug] 7225#0: *4 free: 0000000001B9F710
2014/05/06 11:46:06 [debug] 7225#0: timer delta: 472
2014/05/06 11:46:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:06 [debug] 7225#0: worker cycle
2014/05/06 11:46:06 [debug] 7225#0: epoll timer: 57492
2014/05/06 11:46:08 [debug] 7225#0: epoll: fd:11 ev:2001 d:00007F09AE500370
2014/05/06 11:46:08 [debug] 7225#0: *4 http wait request handler
2014/05/06 11:46:08 [debug] 7225#0: *4 malloc: 0000000001B9F710:1024
2014/05/06 11:46:08 [debug] 7225#0: *4 SSL_read: 0
2014/05/06 11:46:08 [debug] 7225#0: *4 SSL_get_error: 5
2014/05/06 11:46:08 [debug] 7225#0: *4 peer shutdown SSL cleanly
2014/05/06 11:46:08 [info] 7225#0: *4 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:46:08 [debug] 7225#0: *4 close http connection: 11
2014/05/06 11:46:08 [debug] 7225#0: *4 SSL_shutdown: 1
2014/05/06 11:46:08 [debug] 7225#0: *4 event timer del: 11: 1399376825095
2014/05/06 11:46:08 [debug] 7225#0: *4 reusable connection: 0
2014/05/06 11:46:08 [debug] 7225#0: *4 free: 0000000001B9F710
2014/05/06 11:46:08 [debug] 7225#0: *4 free: 0000000001B26B90, unused: 0
2014/05/06 11:46:08 [debug] 7225#0: *4 free: 0000000001B90F30, unused: 56
2014/05/06 11:46:08 [debug] 7225#0: timer delta: 1906
2014/05/06 11:46:08 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:08 [debug] 7225#0: worker cycle
2014/05/06 11:46:08 [debug] 7225#0: epoll timer: 55586
2014/05/06 11:46:09 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:46:09 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:46:09 [debug] 7225#0: posix_memalign: 0000000001B257C0:256 @16
2014/05/06 11:46:09 [debug] 7225#0: *5 accept: 14.97.77.102 fd:11
2014/05/06 11:46:09 [debug] 7225#0: posix_memalign: 0000000001B26B90:256 @16
2014/05/06 11:46:09 [debug] 7225#0: *5 event timer add: 11: 60000:1399376829200
2014/05/06 11:46:09 [debug] 7225#0: *5 reusable connection: 1
2014/05/06 11:46:09 [debug] 7225#0: *5 epoll add event: fd:11 op:1 ev:80002001
2014/05/06 11:46:09 [debug] 7225#0: timer delta: 1139
2014/05/06 11:46:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:09 [debug] 7225#0: worker cycle
2014/05/06 11:46:09 [debug] 7225#0: epoll timer: 54447
2014/05/06 11:46:09 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500371
2014/05/06 11:46:09 [debug] 7225#0: *5 http check ssl handshake
2014/05/06 11:46:09 [debug] 7225#0: *5 http recv(): 1
2014/05/06 11:46:09 [debug] 7225#0: *5 https ssl handshake: 0x16
2014/05/06 11:46:09 [debug] 7225#0: *5 SSL_do_handshake: -1
2014/05/06 11:46:09 [debug] 7225#0: *5 SSL_get_error: 2
2014/05/06 11:46:09 [debug] 7225#0: *5 reusable connection: 0
2014/05/06 11:46:09 [debug] 7225#0: timer delta: 577
2014/05/06 11:46:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:09 [debug] 7225#0: worker cycle
2014/05/06 11:46:09 [debug] 7225#0: epoll timer: 53870
2014/05/06 11:46:17 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500371
2014/05/06 11:46:17 [debug] 7225#0: *5 SSL handshake handler: 0
2014/05/06 11:46:17 [debug] 7225#0: *5 SSL_do_handshake: 1
2014/05/06 11:46:17 [debug] 7225#0: *5 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:46:17 [debug] 7225#0: *5 reusable connection: 1
2014/05/06 11:46:17 [debug] 7225#0: *5 http wait request handler
2014/05/06 11:46:17 [debug] 7225#0: *5 malloc: 0000000001B99590:1024
2014/05/06 11:46:17 [debug] 7225#0: *5 SSL_read: -1
2014/05/06 11:46:17 [debug] 7225#0: *5 SSL_get_error: 2
2014/05/06 11:46:17 [debug] 7225#0: *5 free: 0000000001B99590
2014/05/06 11:46:17 [debug] 7225#0: timer delta: 7664
2014/05/06 11:46:17 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:17 [debug] 7225#0: worker cycle
2014/05/06 11:46:17 [debug] 7225#0: epoll timer: 46206
2014/05/06 11:46:21 [debug] 7225#0: epoll: fd:11 ev:2001 d:00007F09AE500371
2014/05/06 11:46:21 [debug] 7225#0: *5 http wait request handler
2014/05/06 11:46:21 [debug] 7225#0: *5 malloc: 0000000001B99590:1024
2014/05/06 11:46:21 [debug] 7225#0: *5 SSL_read: 0
2014/05/06 11:46:21 [debug] 7225#0: *5 SSL_get_error: 5
2014/05/06 11:46:21 [debug] 7225#0: *5 peer shutdown SSL cleanly
2014/05/06 11:46:21 [info] 7225#0: *5 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:46:21 [debug] 7225#0: *5 close http connection: 11
2014/05/06 11:46:21 [debug] 7225#0: *5 SSL_shutdown: 1
2014/05/06 11:46:21 [debug] 7225#0: *5 event timer del: 11: 1399376829200
2014/05/06 11:46:21 [debug] 7225#0: *5 reusable connection: 0
2014/05/06 11:46:21 [debug] 7225#0: *5 free: 0000000001B99590
2014/05/06 11:46:21 [debug] 7225#0: *5 free: 0000000001B257C0, unused: 0
2014/05/06 11:46:21 [debug] 7225#0: *5 free: 0000000001B26B90, unused: 56
2014/05/06 11:46:21 [debug] 7225#0: timer delta: 4295
2014/05/06 11:46:21 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:46:21 [debug] 7225#0: worker cycle
2014/05/06 11:46:21 [debug] 7225#0: epoll timer: 41911
2014/05/06 11:47:03 [debug] 7225#0: epoll: fd:3 ev:2005 d:00007F09AE500298
2014/05/06 11:47:03 [debug] 7225#0: *1 http keepalive handler
2014/05/06 11:47:03 [debug] 7225#0: *1 malloc: 0000000001B25530:1024
2014/05/06 11:47:03 [debug] 7225#0: *1 SSL_read: 0
2014/05/06 11:47:03 [debug] 7225#0: *1 SSL_get_error: 5
2014/05/06 11:47:03 [debug] 7225#0: *1 peer shutdown SSL cleanly
2014/05/06 11:47:03 [info] 7225#0: *1 client 14.97.77.102 closed keepalive connection
2014/05/06 11:47:03 [debug] 7225#0: *1 close http connection: 3
2014/05/06 11:47:03 [debug] 7225#0: *1 SSL_shutdown: 1
2014/05/06 11:47:03 [debug] 7225#0: *1 event timer del: 3: 1399376823647
2014/05/06 11:47:03 [debug] 7225#0: *1 reusable connection: 0
2014/05/06 11:47:03 [debug] 7225#0: *1 free: 0000000001B25530
2014/05/06 11:47:03 [debug] 7225#0: *1 free: 0000000000000000
2014/05/06 11:47:03 [debug] 7225#0: *1 free: 0000000001B430A0, unused: 0
2014/05/06 11:47:03 [debug] 7225#0: *1 free: 0000000001B188C0, unused: 40
2014/05/06 11:47:03 [debug] 7225#0: *1 free: 0000000001B8BFC0, unused: 144
2014/05/06 11:47:03 [debug] 7225#0: timer delta: 41510
2014/05/06 11:47:03 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:03 [debug] 7225#0: worker cycle
2014/05/06 11:47:03 [debug] 7225#0: epoll timer: -1
2014/05/06 11:47:04 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:47:04 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:47:04 [debug] 7225#0: posix_memalign: 0000000001B26830:256 @16
2014/05/06 11:47:04 [debug] 7225#0: *6 accept: 14.97.77.102 fd:3
2014/05/06 11:47:04 [debug] 7225#0: posix_memalign: 0000000001B430A0:256 @16
2014/05/06 11:47:04 [debug] 7225#0: *6 event timer add: 3: 60000:1399376884753
2014/05/06 11:47:04 [debug] 7225#0: *6 reusable connection: 1
2014/05/06 11:47:04 [debug] 7225#0: *6 epoll add event: fd:3 op:1 ev:80002001
2014/05/06 11:47:04 [debug] 7225#0: timer delta: 1507
2014/05/06 11:47:04 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:04 [debug] 7225#0: worker cycle
2014/05/06 11:47:04 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:47:04 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500299
2014/05/06 11:47:04 [debug] 7225#0: *6 http check ssl handshake
2014/05/06 11:47:04 [debug] 7225#0: *6 http recv(): 1
2014/05/06 11:47:04 [debug] 7225#0: *6 https ssl handshake: 0x16
2014/05/06 11:47:04 [debug] 7225#0: *6 SSL_do_handshake: -1
2014/05/06 11:47:04 [debug] 7225#0: *6 SSL_get_error: 2
2014/05/06 11:47:04 [debug] 7225#0: *6 reusable connection: 0
2014/05/06 11:47:04 [debug] 7225#0: timer delta: 235
2014/05/06 11:47:04 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:04 [debug] 7225#0: worker cycle
2014/05/06 11:47:04 [debug] 7225#0: epoll timer: 59765
2014/05/06 11:47:05 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:47:05 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:47:05 [debug] 7225#0: posix_memalign: 0000000001B9A720:256 @16
2014/05/06 11:47:05 [debug] 7225#0: *7 accept: 14.97.77.102 fd:11
2014/05/06 11:47:05 [debug] 7225#0: posix_memalign: 0000000001B446E0:256 @16
2014/05/06 11:47:05 [debug] 7225#0: *7 event timer add: 11: 60000:1399376885021
2014/05/06 11:47:05 [debug] 7225#0: *7 reusable connection: 1
2014/05/06 11:47:05 [debug] 7225#0: *7 epoll add event: fd:11 op:1 ev:80002001
2014/05/06 11:47:05 [debug] 7225#0: timer delta: 33
2014/05/06 11:47:05 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:05 [debug] 7225#0: worker cycle
2014/05/06 11:47:05 [debug] 7225#0: epoll timer: 59732
2014/05/06 11:47:05 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500370
2014/05/06 11:47:05 [debug] 7225#0: *7 http check ssl handshake
2014/05/06 11:47:05 [debug] 7225#0: *7 http recv(): 1
2014/05/06 11:47:05 [debug] 7225#0: *7 https ssl handshake: 0x16
2014/05/06 11:47:05 [debug] 7225#0: *7 SSL_do_handshake: -1
2014/05/06 11:47:05 [debug] 7225#0: *7 SSL_get_error: 2
2014/05/06 11:47:05 [debug] 7225#0: *7 reusable connection: 0
2014/05/06 11:47:05 [debug] 7225#0: timer delta: 95
2014/05/06 11:47:05 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:05 [debug] 7225#0: worker cycle
2014/05/06 11:47:05 [debug] 7225#0: epoll timer: 59637
2014/05/06 11:47:06 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500299
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL handshake handler: 0
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL_do_handshake: 1
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:47:06 [debug] 7225#0: *6 reusable connection: 1
2014/05/06 11:47:06 [debug] 7225#0: *6 http wait request handler
2014/05/06 11:47:06 [debug] 7225#0: *6 malloc: 0000000001B8C3C0:1024
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL_read: -1
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL_get_error: 2
2014/05/06 11:47:06 [debug] 7225#0: *6 free: 0000000001B8C3C0
2014/05/06 11:47:06 [debug] 7225#0: timer delta: 1167
2014/05/06 11:47:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:06 [debug] 7225#0: worker cycle
2014/05/06 11:47:06 [debug] 7225#0: epoll timer: 58470
2014/05/06 11:47:06 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500370
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL handshake handler: 0
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL_do_handshake: 1
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:47:06 [debug] 7225#0: *7 reusable connection: 1
2014/05/06 11:47:06 [debug] 7225#0: *7 http wait request handler
2014/05/06 11:47:06 [debug] 7225#0: *7 malloc: 0000000001B998B0:1024
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL_read: -1
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL_get_error: 2
2014/05/06 11:47:06 [debug] 7225#0: *7 free: 0000000001B998B0
2014/05/06 11:47:06 [debug] 7225#0: timer delta: 67
2014/05/06 11:47:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:06 [debug] 7225#0: worker cycle
2014/05/06 11:47:06 [debug] 7225#0: epoll timer: 58403
2014/05/06 11:47:06 [debug] 7225#0: epoll: fd:3 ev:2001 d:00007F09AE500299
2014/05/06 11:47:06 [debug] 7225#0: *6 http wait request handler
2014/05/06 11:47:06 [debug] 7225#0: *6 malloc: 0000000001B998B0:1024
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL_read: 0
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL_get_error: 5
2014/05/06 11:47:06 [debug] 7225#0: *6 peer shutdown SSL cleanly
2014/05/06 11:47:06 [info] 7225#0: *6 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:47:06 [debug] 7225#0: *6 close http connection: 3
2014/05/06 11:47:06 [debug] 7225#0: *6 SSL_shutdown: 1
2014/05/06 11:47:06 [debug] 7225#0: *6 event timer del: 3: 1399376884753
2014/05/06 11:47:06 [debug] 7225#0: *6 reusable connection: 0
2014/05/06 11:47:06 [debug] 7225#0: *6 free: 0000000001B998B0
2014/05/06 11:47:06 [debug] 7225#0: *6 free: 0000000001B26830, unused: 0
2014/05/06 11:47:06 [debug] 7225#0: *6 free: 0000000001B430A0, unused: 56
2014/05/06 11:47:06 [debug] 7225#0: timer delta: 373
2014/05/06 11:47:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:06 [debug] 7225#0: worker cycle
2014/05/06 11:47:06 [debug] 7225#0: epoll timer: 58298
2014/05/06 11:47:06 [debug] 7225#0: epoll: fd:11 ev:2001 d:00007F09AE500370
2014/05/06 11:47:06 [debug] 7225#0: *7 http wait request handler
2014/05/06 11:47:06 [debug] 7225#0: *7 malloc: 0000000001B90E20:1024
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL_read: 0
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL_get_error: 5
2014/05/06 11:47:06 [debug] 7225#0: *7 peer shutdown SSL cleanly
2014/05/06 11:47:06 [info] 7225#0: *7 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:47:06 [debug] 7225#0: *7 close http connection: 11
2014/05/06 11:47:06 [debug] 7225#0: *7 SSL_shutdown: 1
2014/05/06 11:47:06 [debug] 7225#0: *7 event timer del: 11: 1399376885021
2014/05/06 11:47:06 [debug] 7225#0: *7 reusable connection: 0
2014/05/06 11:47:06 [debug] 7225#0: *7 free: 0000000001B90E20
2014/05/06 11:47:06 [debug] 7225#0: *7 free: 0000000001B9A720, unused: 0
2014/05/06 11:47:06 [debug] 7225#0: *7 free: 0000000001B446E0, unused: 56
2014/05/06 11:47:06 [debug] 7225#0: timer delta: 46
2014/05/06 11:47:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:06 [debug] 7225#0: worker cycle
2014/05/06 11:47:06 [debug] 7225#0: epoll timer: -1
2014/05/06 11:47:09 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:47:09 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:47:09 [debug] 7225#0: posix_memalign: 0000000001B430A0:256 @16
2014/05/06 11:47:09 [debug] 7225#0: *8 accept: 14.97.77.102 fd:3
2014/05/06 11:47:09 [debug] 7225#0: posix_memalign: 0000000001B188C0:256 @16
2014/05/06 11:47:09 [debug] 7225#0: *8 event timer add: 3: 60000:1399376889109
2014/05/06 11:47:09 [debug] 7225#0: *8 reusable connection: 1
2014/05/06 11:47:09 [debug] 7225#0: *8 epoll add event: fd:3 op:1 ev:80002001
2014/05/06 11:47:09 [debug] 7225#0: timer delta: 2340
2014/05/06 11:47:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:09 [debug] 7225#0: worker cycle
2014/05/06 11:47:09 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:47:09 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500371
2014/05/06 11:47:09 [debug] 7225#0: *8 http check ssl handshake
2014/05/06 11:47:09 [debug] 7225#0: *8 http recv(): 1
2014/05/06 11:47:09 [debug] 7225#0: *8 https ssl handshake: 0x16
2014/05/06 11:47:09 [debug] 7225#0: *8 SSL_do_handshake: -1
2014/05/06 11:47:09 [debug] 7225#0: *8 SSL_get_error: 2
2014/05/06 11:47:09 [debug] 7225#0: *8 reusable connection: 0
2014/05/06 11:47:09 [debug] 7225#0: timer delta: 234
2014/05/06 11:47:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:09 [debug] 7225#0: worker cycle
2014/05/06 11:47:09 [debug] 7225#0: epoll timer: 59766
2014/05/06 11:47:09 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:47:09 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:47:09 [debug] 7225#0: posix_memalign: 0000000001B446E0:256 @16
2014/05/06 11:47:09 [debug] 7225#0: *9 accept: 14.97.77.102 fd:11
2014/05/06 11:47:09 [debug] 7225#0: posix_memalign: 0000000001B215D0:256 @16
2014/05/06 11:47:09 [debug] 7225#0: *9 event timer add: 11: 60000:1399376889367
2014/05/06 11:47:09 [debug] 7225#0: *9 reusable connection: 1
2014/05/06 11:47:09 [debug] 7225#0: *9 epoll add event: fd:11 op:1 ev:80002001
2014/05/06 11:47:09 [debug] 7225#0: timer delta: 24
2014/05/06 11:47:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:09 [debug] 7225#0: worker cycle
2014/05/06 11:47:09 [debug] 7225#0: epoll timer: 59742
2014/05/06 11:47:09 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500298
2014/05/06 11:47:09 [debug] 7225#0: *9 http check ssl handshake
2014/05/06 11:47:09 [debug] 7225#0: *9 http recv(): 1
2014/05/06 11:47:09 [debug] 7225#0: *9 https ssl handshake: 0x16
2014/05/06 11:47:09 [debug] 7225#0: *9 SSL_do_handshake: -1
2014/05/06 11:47:09 [debug] 7225#0: *9 SSL_get_error: 2
2014/05/06 11:47:09 [debug] 7225#0: *9 reusable connection: 0
2014/05/06 11:47:09 [debug] 7225#0: timer delta: 61
2014/05/06 11:47:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:09 [debug] 7225#0: worker cycle
2014/05/06 11:47:09 [debug] 7225#0: epoll timer: 59681
2014/05/06 11:47:10 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500371
2014/05/06 11:47:10 [debug] 7225#0: *8 SSL handshake handler: 0
2014/05/06 11:47:10 [debug] 7225#0: *8 SSL_do_handshake: 1
2014/05/06 11:47:10 [debug] 7225#0: *8 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:47:10 [debug] 7225#0: *8 reusable connection: 1
2014/05/06 11:47:10 [debug] 7225#0: *8 http wait request handler
2014/05/06 11:47:10 [debug] 7225#0: *8 malloc: 0000000001B8C380:1024
2014/05/06 11:47:10 [debug] 7225#0: *8 SSL_read: -1
2014/05/06 11:47:10 [debug] 7225#0: *8 SSL_get_error: 2
2014/05/06 11:47:10 [debug] 7225#0: *8 free: 0000000001B8C380
2014/05/06 11:47:10 [debug] 7225#0: timer delta: 1436
2014/05/06 11:47:10 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:10 [debug] 7225#0: worker cycle
2014/05/06 11:47:10 [debug] 7225#0: epoll timer: 58245
2014/05/06 11:47:11 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500298
2014/05/06 11:47:11 [debug] 7225#0: *9 SSL handshake handler: 0
2014/05/06 11:47:11 [debug] 7225#0: *9 SSL_do_handshake: 1
2014/05/06 11:47:11 [debug] 7225#0: *9 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:47:11 [debug] 7225#0: *9 reusable connection: 1
2014/05/06 11:47:11 [debug] 7225#0: *9 http wait request handler
2014/05/06 11:47:11 [debug] 7225#0: *9 malloc: 0000000001B996E0:1024
2014/05/06 11:47:11 [debug] 7225#0: *9 SSL_read: -1
2014/05/06 11:47:11 [debug] 7225#0: *9 SSL_get_error: 2
2014/05/06 11:47:11 [debug] 7225#0: *9 free: 0000000001B996E0
2014/05/06 11:47:11 [debug] 7225#0: timer delta: 152
2014/05/06 11:47:11 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:11 [debug] 7225#0: worker cycle
2014/05/06 11:47:11 [debug] 7225#0: epoll timer: 58093
2014/05/06 11:47:12 [debug] 7225#0: epoll: fd:3 ev:2001 d:00007F09AE500371
2014/05/06 11:47:12 [debug] 7225#0: *8 http wait request handler
2014/05/06 11:47:12 [debug] 7225#0: *8 malloc: 0000000001B996E0:1024
2014/05/06 11:47:12 [debug] 7225#0: *8 SSL_read: 0
2014/05/06 11:47:12 [debug] 7225#0: *8 SSL_get_error: 5
2014/05/06 11:47:12 [debug] 7225#0: *8 peer shutdown SSL cleanly
2014/05/06 11:47:12 [info] 7225#0: *8 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:47:12 [debug] 7225#0: *8 close http connection: 3
2014/05/06 11:47:12 [debug] 7225#0: *8 SSL_shutdown: 1
2014/05/06 11:47:12 [debug] 7225#0: *8 event timer del: 3: 1399376889109
2014/05/06 11:47:12 [debug] 7225#0: *8 reusable connection: 0
2014/05/06 11:47:12 [debug] 7225#0: *8 free: 0000000001B996E0
2014/05/06 11:47:12 [debug] 7225#0: *8 free: 0000000001B430A0, unused: 0
2014/05/06 11:47:12 [debug] 7225#0: *8 free: 0000000001B188C0, unused: 56
2014/05/06 11:47:12 [debug] 7225#0: timer delta: 1367
2014/05/06 11:47:12 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:12 [debug] 7225#0: worker cycle
2014/05/06 11:47:12 [debug] 7225#0: epoll timer: 56984
2014/05/06 11:47:12 [debug] 7225#0: epoll: fd:11 ev:2001 d:00007F09AE500298
2014/05/06 11:47:12 [debug] 7225#0: *9 http wait request handler
2014/05/06 11:47:12 [debug] 7225#0: *9 malloc: 0000000001B447F0:1024
2014/05/06 11:47:12 [debug] 7225#0: *9 SSL_read: 0
2014/05/06 11:47:12 [debug] 7225#0: *9 SSL_get_error: 5
2014/05/06 11:47:12 [debug] 7225#0: *9 peer shutdown SSL cleanly
2014/05/06 11:47:12 [info] 7225#0: *9 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:47:12 [debug] 7225#0: *9 close http connection: 11
2014/05/06 11:47:12 [debug] 7225#0: *9 SSL_shutdown: 1
2014/05/06 11:47:12 [debug] 7225#0: *9 event timer del: 11: 1399376889367
2014/05/06 11:47:12 [debug] 7225#0: *9 reusable connection: 0
2014/05/06 11:47:12 [debug] 7225#0: *9 free: 0000000001B447F0
2014/05/06 11:47:12 [debug] 7225#0: *9 free: 0000000001B446E0, unused: 0
2014/05/06 11:47:12 [debug] 7225#0: *9 free: 0000000001B215D0, unused: 56
2014/05/06 11:47:12 [debug] 7225#0: timer delta: 30
2014/05/06 11:47:12 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:47:12 [debug] 7225#0: worker cycle
2014/05/06 11:47:12 [debug] 7225#0: epoll timer: -1
2014/05/06 11:48:06 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:48:06 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:48:06 [debug] 7225#0: posix_memalign: 0000000001B25530:256 @16
2014/05/06 11:48:06 [debug] 7225#0: *10 accept: 14.97.77.102 fd:3
2014/05/06 11:48:06 [debug] 7225#0: posix_memalign: 0000000001B188C0:256 @16
2014/05/06 11:48:06 [debug] 7225#0: *10 event timer add: 3: 60000:1399376946736
2014/05/06 11:48:06 [debug] 7225#0: *10 reusable connection: 1
2014/05/06 11:48:06 [debug] 7225#0: *10 epoll add event: fd:3 op:1 ev:80002001
2014/05/06 11:48:06 [debug] 7225#0: timer delta: 54323
2014/05/06 11:48:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:06 [debug] 7225#0: worker cycle
2014/05/06 11:48:06 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:48:06 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:48:06 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:48:06 [debug] 7225#0: posix_memalign: 0000000001B18B80:256 @16
2014/05/06 11:48:06 [debug] 7225#0: *11 accept: 14.97.77.102 fd:11
2014/05/06 11:48:06 [debug] 7225#0: posix_memalign: 0000000001B215D0:256 @16
2014/05/06 11:48:06 [debug] 7225#0: *11 event timer add: 11: 60000:1399376946852
2014/05/06 11:48:06 [debug] 7225#0: *11 reusable connection: 1
2014/05/06 11:48:06 [debug] 7225#0: *11 epoll add event: fd:11 op:1 ev:80002001
2014/05/06 11:48:06 [debug] 7225#0: timer delta: 116
2014/05/06 11:48:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:06 [debug] 7225#0: worker cycle
2014/05/06 11:48:06 [debug] 7225#0: epoll timer: 59884
2014/05/06 11:48:06 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500299
2014/05/06 11:48:06 [debug] 7225#0: *10 http check ssl handshake
2014/05/06 11:48:06 [debug] 7225#0: *10 http recv(): 1
2014/05/06 11:48:06 [debug] 7225#0: *10 https ssl handshake: 0x16
2014/05/06 11:48:06 [debug] 7225#0: *10 SSL_do_handshake: -1
2014/05/06 11:48:06 [debug] 7225#0: *10 SSL_get_error: 2
2014/05/06 11:48:06 [debug] 7225#0: *10 reusable connection: 0
2014/05/06 11:48:06 [debug] 7225#0: timer delta: 105
2014/05/06 11:48:06 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:06 [debug] 7225#0: worker cycle
2014/05/06 11:48:06 [debug] 7225#0: epoll timer: 59779
2014/05/06 11:48:07 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500370
2014/05/06 11:48:07 [debug] 7225#0: *11 http check ssl handshake
2014/05/06 11:48:07 [debug] 7225#0: *11 http recv(): 1
2014/05/06 11:48:07 [debug] 7225#0: *11 https ssl handshake: 0x16
2014/05/06 11:48:07 [debug] 7225#0: *11 SSL_do_handshake: -1
2014/05/06 11:48:07 [debug] 7225#0: *11 SSL_get_error: 2
2014/05/06 11:48:07 [debug] 7225#0: *11 reusable connection: 0
2014/05/06 11:48:07 [debug] 7225#0: timer delta: 53
2014/05/06 11:48:07 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:07 [debug] 7225#0: worker cycle
2014/05/06 11:48:07 [debug] 7225#0: epoll timer: 59726
2014/05/06 11:48:09 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500299
2014/05/06 11:48:09 [debug] 7225#0: *10 SSL handshake handler: 0
2014/05/06 11:48:09 [debug] 7225#0: *10 SSL_do_handshake: 1
2014/05/06 11:48:09 [debug] 7225#0: *10 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:48:09 [debug] 7225#0: *10 reusable connection: 1
2014/05/06 11:48:09 [debug] 7225#0: *10 http wait request handler
2014/05/06 11:48:09 [debug] 7225#0: *10 malloc: 0000000001B8C380:1024
2014/05/06 11:48:09 [debug] 7225#0: *10 SSL_read: -1
2014/05/06 11:48:09 [debug] 7225#0: *10 SSL_get_error: 2
2014/05/06 11:48:09 [debug] 7225#0: *10 free: 0000000001B8C380
2014/05/06 11:48:09 [debug] 7225#0: timer delta: 2781
2014/05/06 11:48:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:09 [debug] 7225#0: worker cycle
2014/05/06 11:48:09 [debug] 7225#0: epoll timer: 56945
2014/05/06 11:48:09 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500370
2014/05/06 11:48:09 [debug] 7225#0: *11 SSL handshake handler: 0
2014/05/06 11:48:09 [debug] 7225#0: *11 SSL_do_handshake: 1
2014/05/06 11:48:09 [debug] 7225#0: *11 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:48:09 [debug] 7225#0: *11 reusable connection: 1
2014/05/06 11:48:09 [debug] 7225#0: *11 http wait request handler
2014/05/06 11:48:09 [debug] 7225#0: *11 malloc: 0000000001B99640:1024
2014/05/06 11:48:09 [debug] 7225#0: *11 SSL_read: -1
2014/05/06 11:48:09 [debug] 7225#0: *11 SSL_get_error: 2
2014/05/06 11:48:09 [debug] 7225#0: *11 free: 0000000001B99640
2014/05/06 11:48:09 [debug] 7225#0: timer delta: 72
2014/05/06 11:48:09 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:09 [debug] 7225#0: worker cycle
2014/05/06 11:48:09 [debug] 7225#0: epoll timer: 56873
2014/05/06 11:48:12 [debug] 7225#0: epoll: fd:3 ev:2001 d:00007F09AE500299
2014/05/06 11:48:12 [debug] 7225#0: *10 http wait request handler
2014/05/06 11:48:12 [debug] 7225#0: *10 malloc: 0000000001B99640:1024
2014/05/06 11:48:12 [debug] 7225#0: *10 SSL_read: 0
2014/05/06 11:48:12 [debug] 7225#0: *10 SSL_get_error: 5
2014/05/06 11:48:12 [debug] 7225#0: *10 peer shutdown SSL cleanly
2014/05/06 11:48:12 [info] 7225#0: *10 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:48:12 [debug] 7225#0: *10 close http connection: 3
2014/05/06 11:48:12 [debug] 7225#0: *10 SSL_shutdown: 1
2014/05/06 11:48:12 [debug] 7225#0: *10 event timer del: 3: 1399376946736
2014/05/06 11:48:12 [debug] 7225#0: *10 reusable connection: 0
2014/05/06 11:48:12 [debug] 7225#0: *10 free: 0000000001B99640
2014/05/06 11:48:12 [debug] 7225#0: *10 free: 0000000001B25530, unused: 0
2014/05/06 11:48:12 [debug] 7225#0: *10 free: 0000000001B188C0, unused: 56
2014/05/06 11:48:12 [debug] 7225#0: timer delta: 2454
2014/05/06 11:48:12 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:12 [debug] 7225#0: worker cycle
2014/05/06 11:48:12 [debug] 7225#0: epoll timer: 54535
2014/05/06 11:48:12 [debug] 7225#0: epoll: fd:11 ev:2001 d:00007F09AE500370
2014/05/06 11:48:12 [debug] 7225#0: *11 http wait request handler
2014/05/06 11:48:12 [debug] 7225#0: *11 malloc: 0000000001B26800:1024
2014/05/06 11:48:12 [debug] 7225#0: *11 SSL_read: 0
2014/05/06 11:48:12 [debug] 7225#0: *11 SSL_get_error: 5
2014/05/06 11:48:12 [debug] 7225#0: *11 peer shutdown SSL cleanly
2014/05/06 11:48:12 [info] 7225#0: *11 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:48:12 [debug] 7225#0: *11 close http connection: 11
2014/05/06 11:48:12 [debug] 7225#0: *11 SSL_shutdown: 1
2014/05/06 11:48:12 [debug] 7225#0: *11 event timer del: 11: 1399376946852
2014/05/06 11:48:12 [debug] 7225#0: *11 reusable connection: 0
2014/05/06 11:48:12 [debug] 7225#0: *11 free: 0000000001B26800
2014/05/06 11:48:12 [debug] 7225#0: *11 free: 0000000001B18B80, unused: 0
2014/05/06 11:48:12 [debug] 7225#0: *11 free: 0000000001B215D0, unused: 56
2014/05/06 11:48:12 [debug] 7225#0: timer delta: 11
2014/05/06 11:48:12 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:12 [debug] 7225#0: worker cycle
2014/05/06 11:48:12 [debug] 7225#0: epoll timer: -1
2014/05/06 11:48:13 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:48:13 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:48:13 [debug] 7225#0: posix_memalign: 0000000001B25530:256 @16
2014/05/06 11:48:13 [debug] 7225#0: *12 accept: 14.97.77.102 fd:3
2014/05/06 11:48:13 [debug] 7225#0: posix_memalign: 0000000001B221B0:256 @16
2014/05/06 11:48:13 [debug] 7225#0: *12 event timer add: 3: 60000:1399376953981
2014/05/06 11:48:13 [debug] 7225#0: *12 reusable connection: 1
2014/05/06 11:48:13 [debug] 7225#0: *12 epoll add event: fd:3 op:1 ev:80002001
2014/05/06 11:48:13 [debug] 7225#0: timer delta: 1653
2014/05/06 11:48:13 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:13 [debug] 7225#0: worker cycle
2014/05/06 11:48:13 [debug] 7225#0: epoll timer: 60000
2014/05/06 11:48:14 [debug] 7225#0: epoll: fd:6 ev:0001 d:00007F09AE500010
2014/05/06 11:48:14 [debug] 7225#0: accept on 0.0.0.0:6401, ready: 0
2014/05/06 11:48:14 [debug] 7225#0: posix_memalign: 0000000001B215D0:256 @16
2014/05/06 11:48:14 [debug] 7225#0: *13 accept: 14.97.77.102 fd:11
2014/05/06 11:48:14 [debug] 7225#0: posix_memalign: 0000000001B9AA10:256 @16
2014/05/06 11:48:14 [debug] 7225#0: *13 event timer add: 11: 60000:1399376954039
2014/05/06 11:48:14 [debug] 7225#0: *13 reusable connection: 1
2014/05/06 11:48:14 [debug] 7225#0: *13 epoll add event: fd:11 op:1 ev:80002001
2014/05/06 11:48:14 [debug] 7225#0: timer delta: 58
2014/05/06 11:48:14 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:14 [debug] 7225#0: worker cycle
2014/05/06 11:48:14 [debug] 7225#0: epoll timer: 59942
2014/05/06 11:48:14 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500298
2014/05/06 11:48:14 [debug] 7225#0: *13 http check ssl handshake
2014/05/06 11:48:14 [debug] 7225#0: *13 http recv(): 1
2014/05/06 11:48:14 [debug] 7225#0: *13 https ssl handshake: 0x16
2014/05/06 11:48:14 [debug] 7225#0: *13 SSL_do_handshake: -1
2014/05/06 11:48:14 [debug] 7225#0: *13 SSL_get_error: 2
2014/05/06 11:48:14 [debug] 7225#0: *13 reusable connection: 0
2014/05/06 11:48:14 [debug] 7225#0: timer delta: 500
2014/05/06 11:48:14 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:14 [debug] 7225#0: worker cycle
2014/05/06 11:48:14 [debug] 7225#0: epoll timer: 59442
2014/05/06 11:48:14 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500371
2014/05/06 11:48:14 [debug] 7225#0: *12 http check ssl handshake
2014/05/06 11:48:14 [debug] 7225#0: *12 http recv(): 1
2014/05/06 11:48:14 [debug] 7225#0: *12 https ssl handshake: 0x16
2014/05/06 11:48:14 [debug] 7225#0: *12 SSL_do_handshake: -1
2014/05/06 11:48:14 [debug] 7225#0: *12 SSL_get_error: 2
2014/05/06 11:48:14 [debug] 7225#0: *12 reusable connection: 0
2014/05/06 11:48:14 [debug] 7225#0: timer delta: 456
2014/05/06 11:48:14 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:14 [debug] 7225#0: worker cycle
2014/05/06 11:48:14 [debug] 7225#0: epoll timer: 58986
2014/05/06 11:48:19 [debug] 7225#0: epoll: fd:11 ev:0001 d:00007F09AE500298
2014/05/06 11:48:19 [debug] 7225#0: *13 SSL handshake handler: 0
2014/05/06 11:48:19 [debug] 7225#0: *13 SSL_do_handshake: 1
2014/05/06 11:48:19 [debug] 7225#0: *13 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:48:19 [debug] 7225#0: *13 reusable connection: 1
2014/05/06 11:48:19 [debug] 7225#0: *13 http wait request handler
2014/05/06 11:48:19 [debug] 7225#0: *13 malloc: 0000000001B8C270:1024
2014/05/06 11:48:19 [debug] 7225#0: *13 SSL_read: -1
2014/05/06 11:48:19 [debug] 7225#0: *13 SSL_get_error: 2
2014/05/06 11:48:19 [debug] 7225#0: *13 free: 0000000001B8C270
2014/05/06 11:48:19 [debug] 7225#0: timer delta: 4224
2014/05/06 11:48:19 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:19 [debug] 7225#0: worker cycle
2014/05/06 11:48:19 [debug] 7225#0: epoll timer: 54762
2014/05/06 11:48:20 [debug] 7225#0: epoll: fd:3 ev:0001 d:00007F09AE500371
2014/05/06 11:48:20 [debug] 7225#0: *12 SSL handshake handler: 0
2014/05/06 11:48:20 [debug] 7225#0: *12 SSL_do_handshake: 1
2014/05/06 11:48:20 [debug] 7225#0: *12 SSL: TLSv1.2, cipher: "AES128-SHA256 TLSv1.2 Kx=RSA Au=RSA Enc=AES(128) Mac=SHA256"
2014/05/06 11:48:20 [debug] 7225#0: *12 reusable connection: 1
2014/05/06 11:48:20 [debug] 7225#0: *12 http wait request handler
2014/05/06 11:48:20 [debug] 7225#0: *12 malloc: 0000000001B99890:1024
2014/05/06 11:48:20 [debug] 7225#0: *12 SSL_read: -1
2014/05/06 11:48:20 [debug] 7225#0: *12 SSL_get_error: 2
2014/05/06 11:48:20 [debug] 7225#0: *12 free: 0000000001B99890
2014/05/06 11:48:20 [debug] 7225#0: timer delta: 950
2014/05/06 11:48:20 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:20 [debug] 7225#0: worker cycle
2014/05/06 11:48:20 [debug] 7225#0: epoll timer: 53812
2014/05/06 11:48:22 [debug] 7225#0: epoll: fd:11 ev:2001 d:00007F09AE500298
2014/05/06 11:48:22 [debug] 7225#0: *13 http wait request handler
2014/05/06 11:48:22 [debug] 7225#0: *13 malloc: 0000000001B99890:1024
2014/05/06 11:48:22 [debug] 7225#0: *13 SSL_read: 0
2014/05/06 11:48:22 [debug] 7225#0: *13 SSL_get_error: 5
2014/05/06 11:48:22 [debug] 7225#0: *13 peer shutdown SSL cleanly
2014/05/06 11:48:22 [info] 7225#0: *13 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:48:22 [debug] 7225#0: *13 close http connection: 11
2014/05/06 11:48:22 [debug] 7225#0: *13 SSL_shutdown: 1
2014/05/06 11:48:22 [debug] 7225#0: *13 event timer del: 11: 1399376954039
2014/05/06 11:48:22 [debug] 7225#0: *13 reusable connection: 0
2014/05/06 11:48:22 [debug] 7225#0: *13 free: 0000000001B99890
2014/05/06 11:48:22 [debug] 7225#0: *13 free: 0000000001B215D0, unused: 0
2014/05/06 11:48:22 [debug] 7225#0: *13 free: 0000000001B9AA10, unused: 56
2014/05/06 11:48:22 [debug] 7225#0: timer delta: 1964
2014/05/06 11:48:22 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:22 [debug] 7225#0: worker cycle
2014/05/06 11:48:22 [debug] 7225#0: epoll timer: 51848
2014/05/06 11:48:22 [debug] 7225#0: epoll: fd:3 ev:2001 d:00007F09AE500371
2014/05/06 11:48:22 [debug] 7225#0: *12 http wait request handler
2014/05/06 11:48:22 [debug] 7225#0: *12 malloc: 0000000001B25A60:1024
2014/05/06 11:48:22 [debug] 7225#0: *12 SSL_read: 0
2014/05/06 11:48:22 [debug] 7225#0: *12 SSL_get_error: 5
2014/05/06 11:48:22 [debug] 7225#0: *12 peer shutdown SSL cleanly
2014/05/06 11:48:22 [info] 7225#0: *12 client closed connection while waiting for request, client: 14.97.77.102, server: 0.0.0.0:6401
2014/05/06 11:48:22 [debug] 7225#0: *12 close http connection: 3
2014/05/06 11:48:22 [debug] 7225#0: *12 SSL_shutdown: 1
2014/05/06 11:48:22 [debug] 7225#0: *12 event timer del: 3: 1399376953981
2014/05/06 11:48:22 [debug] 7225#0: *12 reusable connection: 0
2014/05/06 11:48:22 [debug] 7225#0: *12 free: 0000000001B25A60
2014/05/06 11:48:22 [debug] 7225#0: *12 free: 0000000001B25530, unused: 0
2014/05/06 11:48:22 [debug] 7225#0: *12 free: 0000000001B221B0, unused: 56
2014/05/06 11:48:22 [debug] 7225#0: timer delta: 56
2014/05/06 11:48:22 [debug] 7225#0: posted events 0000000000000000
2014/05/06 11:48:22 [debug] 7225#0: worker cycle
2014/05/06 11:48:22 [debug] 7225#0: epoll timer: -1