nginx 1.9.14 rate limiting + http/2
2016/04/13 13:45:42 [debug] 27207#0: *2 SSL_write: 13 | |
2016/04/13 13:45:42 [debug] 27207#0: *2 http2 frame sent: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:45:42 [debug] 27207#0: *2 free: 0000000001E6DC70, unused: 3320 | |
2016/04/13 13:45:42 [debug] 27207#0: *2 free: 0000000001EEF080 | |
2016/04/13 13:45:42 [debug] 27207#0: *2 reusable connection: 1 | |
2016/04/13 13:45:42 [debug] 27207#0: *2 event timer del: 9: 1460548122266 | |
2016/04/13 13:45:42 [debug] 27207#0: *2 event timer add: 9: 180000:1460548122683 | |
2016/04/13 13:45:42 [debug] 27207#0: timer delta: 417 | |
2016/04/13 13:45:42 [debug] 27207#0: worker cycle | |
2016/04/13 13:45:42 [debug] 27207#0: epoll timer: 180000 | |
2016/04/13 13:46:22 [debug] 27207#0: epoll: fd:9 ev:0001 d:0000000001E87211 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 idle handler | |
2016/04/13 13:46:22 [debug] 27207#0: *2 reusable connection: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001E6DC70:4096 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 read handler | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_read: 61 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_read: 17 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_read: -1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_get_error: 2 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 process http2 frame type:1 f:24 l:52 sid:551 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 HEADERS frame sid:551 on 0 excl:0 weight:256 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001E5CF60:1024 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001EFD740:4096 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001EFE750:4096 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 3 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 84 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 7 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 hpack encoded string length: 4 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 hpack encoded string length: 20 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http uri: "/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http args: "" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http exten: "php" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 69 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "content-length: 15" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 63 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "pragma: no-cache" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 62 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "cache-control: no-cache" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 82 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 68 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "origin: https://192.168.137.10:4430" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 81 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "upgrade-insecure-requests: 1" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 80 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "user-agent: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.112 Safari/537.36" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 67 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "content-type: application/x-www-form-urlencoded" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 70 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "referer: https://192.168.137.10:4430/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 66 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "accept-encoding: gzip, deflate, br" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 78 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http header: "accept-language: en-US,en;q=0.8,nl;q=0.6" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 77 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 76 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 75 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 74 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 73 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001F011C0:1024 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 get indexed header name: 72 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 http request line: "POST /mod_pagespeed_test/test.php HTTP/2.0" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 rewrite phase: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 test location: "/50x.html" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 test location: ~ "\.php$" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 using configuration "\.php$" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http cl:15 max:1048576 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 rewrite phase: 2 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 post rewrite phase: 3 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 generic phase: 4 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script var: "���" | |
2016/04/13 13:46:22 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:22 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:22 [debug] 27207#0: *2 limit_req[0]: -2 0.000 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script var: "localhost" | |
2016/04/13 13:46:22 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:22 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:22 [debug] 27207#0: *2 limit_req[1]: 0 0.000 | |
2016/04/13 13:46:22 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:22 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:22 [debug] 27207#0: *2 generic phase: 5 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 access phase: 6 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 access phase: 7 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 post access phase: 8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 send WINDOW_UPDATE frame sid:551, window:2147483647 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer add: 9: 60000:1460548042682 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http finalize request: -4, "/mod_pagespeed_test/test.php?" a:1, c:2 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http request count:2 blk:0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame complete pos:0000000001F0286D end:0000000001F0287E | |
2016/04/13 13:46:22 [debug] 27207#0: *2 process http2 frame type:6 f:0 l:8 sid:0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 PING frame, flags: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame complete pos:0000000001F0287E end:0000000001F0287E | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame out: 0000000001E6DF78 sid:0 bl:0 len:8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame out: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 malloc: 0000000001EEF080:16384 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL buf copy: 13 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL buf copy: 17 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL to write: 30 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_write: 30 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame sent: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame sent: 0000000001E6DF78 sid:0 bl:0 len:8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer del: 9: 1460548122683 | |
2016/04/13 13:46:22 [debug] 27207#0: timer delta: 39999 | |
2016/04/13 13:46:22 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:22 [debug] 27207#0: epoll timer: 60000 | |
2016/04/13 13:46:22 [debug] 27207#0: epoll: fd:9 ev:0001 d:0000000001E87211 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 read handler | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_read: 24 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_read: -1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_get_error: 2 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 process http2 frame type:0 f:1 l:15 sid:551 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 DATA frame | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer del: 9: 1460548042682 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http body new buf t:1 f:0 0000000001EFF518, pos 0000000001EFF518, size: 15 file: 0, size: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http init upstream, client timer: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001EF3090:4096 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script copy: "SCRIPT_FILENAME" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script var: "/home/oschaaf/code/google/mps-issue-1175//src/install/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "SCRIPT_FILENAME: /home/oschaaf/code/google/mps-issue-1175//src/install/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script copy: "QUERY_STRING" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "QUERY_STRING: " | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script copy: "REQUEST_METHOD" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script var: "POST" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "REQUEST_METHOD: POST" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script copy: "CONTENT_TYPE" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script var: "application/x-www-form-urlencoded" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "CONTENT_TYPE: application/x-www-form-urlencoded" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script copy: "CONTENT_LENGTH" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http script var: "15" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "CONTENT_LENGTH: 15" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_HOST: 192.168.137.10:4430" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_CONTENT_LENGTH: 15" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_PRAGMA: no-cache" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_CACHE_CONTROL: no-cache" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_ACCEPT: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_ORIGIN: https://192.168.137.10:4430" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_UPGRADE_INSECURE_REQUESTS: 1" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_USER_AGENT: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.112 Safari/537.36" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_CONTENT_TYPE: application/x-www-form-urlencoded" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_REFERER: https://192.168.137.10:4430/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_ACCEPT_ENCODING: gzip, deflate, br" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_ACCEPT_LANGUAGE: en-US,en;q=0.8,nl;q=0.6" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 fastcgi param: "HTTP_COOKIE: __utma=249880774.1383284618.1457435953.1457435953.1457435953.1; __utmz=249880774.1457435953.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); COMMERCE_SITE_PreviousCatalogPage=http://www.overland.com:80/default.aspx; _ga=GA1.4.1383284618.1457435953; __ar_v4=A2DMCTE7MBFGDNK5YEWLMH%3A20160307%3A6%7C3546UXGADRAB7D4T22VG7L%3A20160307%3A179%7CVINBB5DOHFDPZAD42RWWE6%3A20160307%3A179%7C6BHUC3GFKFCJLNRPPUHMNS%3A20160307%3A156%7CRDW3YUET4NBAFGEQUT65ET%3A20160307%3A17; _hp2_id.3446894088=7920717152696490.3996779594.2723900530" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http cleanup add: 0000000001EF3650 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 get rr peer, try: 1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 stream socket 10 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 epoll add connection: fd:10 ev:80002005 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 connect to 127.0.0.1:9000, fd:10 #79 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream connect: -2 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 posix_memalign: 0000000001E65AC0:128 @16 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer add: 10: 60000:1460548042683 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame complete pos:0000000001F02848 end:0000000001F02848 | |
2016/04/13 13:46:22 [debug] 27207#0: timer delta: 1 | |
2016/04/13 13:46:22 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:22 [debug] 27207#0: epoll timer: 60000 | |
2016/04/13 13:46:22 [debug] 27207#0: epoll: fd:10 ev:0004 d:0000000001E872F0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream request: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream send request handler | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream send request | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream send request body | |
2016/04/13 13:46:22 [debug] 27207#0: *2 chain writer buf fl:0 s:1376 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 chain writer buf fl:0 s:15 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 chain writer buf fl:0 s:9 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 chain writer in: 0000000001EF36B8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 writev: 1400 of 1400 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 chain writer out: 0000000000000000 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer del: 10: 1460548042683 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer add: 10: 60000:1460548042683 | |
2016/04/13 13:46:22 [debug] 27207#0: timer delta: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:22 [debug] 27207#0: epoll timer: 60000 | |
2016/04/13 13:46:22 [debug] 27207#0: epoll: fd:10 ev:2005 d:0000000001E872F0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream request: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream process header | |
2016/04/13 13:46:22 [debug] 27207#0: *2 malloc: 0000000001F42840:4096 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 recv: fd:10 528 of 4096 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 06 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: F3 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 05 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record length: 499 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi parser: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi header: "X-Powered-By: PHP/5.5.9-1ubuntu4.14" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi parser: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi header: "Content-type: text/html" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi parser: 1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi header done | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 header filter | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 output header: ":status: 200" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 output header: "server: nginx/1.9.14" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 output header: "date: Wed, 13 Apr 2016 11:46:22 GMT" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 output header: "content-type: text/html" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 output header: "x-powered-by: PHP/5.5.9-1ubuntu4.14" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2:551 create HEADERS frame 0000000001EF3B50: len:73 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http cleanup add: 0000000001EF3C38 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame out: 0000000001EF3B50 sid:551 bl:1 len:73 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL buf copy: 9 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL buf copy: 73 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2:551 HEADERS frame 0000000001EF3B50 was sent | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame sent: 0000000001EF3B50 sid:551 bl:1 len:73 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http cacheable: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream process upstream | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe read upstream: 1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe preread: 456 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 readv: 1, last:3568 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe recv chain: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe buf free s:0 t:1 f:0 0000000001F42840, pos 0000000001F42888, size: 456 file: 0, size: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe length: -1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 input buf #0 0000000001F42888 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 03 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 08 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi record length: 8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http fastcgi sent end request | |
2016/04/13 13:46:22 [debug] 27207#0: *2 input buf 0000000001F42888 435 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe write downstream: 1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe write downstream flush in | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http output filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http copy filter: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http ssi filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 saved: 0 state: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 parse: -2, looked: 0 0000000001F42888-0000000001F42A3B | |
2016/04/13 13:46:22 [debug] 27207#0: *2 saved: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 ssi out: 0000000001EF3E00 0000000001F42888 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http postpone filter "/mod_pagespeed_test/test.php?" 0000000001EF36B8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 write new buf t:1 f:0 0000000001F42840, pos 0000000001F42888, size: 435 file: 0, size: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http write filter: l:0 f:0 s:435 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http copy filter: 0 "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 pipe write downstream done | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer del: 10: 1460548042683 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream exit: 0000000000000000 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 finalize http upstream request: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 finalize http fastcgi request | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free rr peer 1 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 close http upstream connection: 10 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001E65AC0, unused: 48 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 reusable connection: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http upstream temp fd: -1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http output filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http copy filter: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http ssi filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 ssi out: 0000000001EF3EC0 0000000000000000 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http postpone filter "/mod_pagespeed_test/test.php?" 0000000001EF3F10 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 write old buf t:1 f:0 0000000001F42840, pos 0000000001F42888, size: 435 file: 0, size: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http write filter: l:1 f:0 s:435 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http write filter limit 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2:551 create DATA frame 0000000001EF3B50: len:435 flags:1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame out: 0000000001EF3B50 sid:551 bl:0 len:435 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL buf copy: 9 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL buf copy: 435 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL to write: 526 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 SSL_write: 526 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2:551 DATA frame 0000000001EF3B50 was sent | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 frame sent: 0000000001EF3B50 sid:551 bl:0 len:435 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http write filter 0000000000000000 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http copy filter: 0 "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http finalize request: 0, "/mod_pagespeed_test/test.php?" a:1, c:1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http request count:1 blk:0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 close stream 551, queued 0, processing 1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http close request | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http log handler | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001F42840 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001EFD740, unused: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001EFE750, unused: 8 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001EF3090, unused: 92 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001E5CF60, unused: 17 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001F011C0, unused: 779 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 post event 0000000001EBF120 | |
2016/04/13 13:46:22 [debug] 27207#0: timer delta: 0 | |
2016/04/13 13:46:22 [debug] 27207#0: posted event 0000000001EBF120 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 delete posted event 0000000001EBF120 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 http2 handle connection handler | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001E6DC70, unused: 3144 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 free: 0000000001EEF080 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 reusable connection: 1 | |
2016/04/13 13:46:22 [debug] 27207#0: *2 event timer add: 9: 180000:1460548162683 | |
2016/04/13 13:46:22 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:22 [debug] 27207#0: epoll timer: 180000 | |
2016/04/13 13:46:23 [debug] 27207#0: epoll: fd:9 ev:0001 d:0000000001E87211 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 idle handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 reusable connection: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001E6DC70:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 read handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_read: 61 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_read: -1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_get_error: 2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 process http2 frame type:1 f:24 l:52 sid:553 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 HEADERS frame sid:553 on 0 excl:0 weight:256 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001E5CF60:1024 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001EFD740:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001EFE750:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 3 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 84 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 7 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 hpack encoded string length: 4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 hpack encoded string length: 20 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http uri: "/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http args: "" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http exten: "php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 69 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "content-length: 15" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 63 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "pragma: no-cache" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 62 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "cache-control: no-cache" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 82 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 68 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "origin: https://192.168.137.10:4430" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 81 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "upgrade-insecure-requests: 1" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 80 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "user-agent: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.112 Safari/537.36" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 67 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "content-type: application/x-www-form-urlencoded" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 70 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "referer: https://192.168.137.10:4430/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 66 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "accept-encoding: gzip, deflate, br" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 78 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "accept-language: en-US,en;q=0.8,nl;q=0.6" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 77 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 76 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 75 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 74 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 73 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001F011C0:1024 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 72 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http request line: "POST /mod_pagespeed_test/test.php HTTP/2.0" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 rewrite phase: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 test location: "/50x.html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 test location: ~ "\.php$" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 using configuration "\.php$" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cl:15 max:1048576 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 rewrite phase: 2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 post rewrite phase: 3 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 generic phase: 4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "���" | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:23 [debug] 27207#0: *2 limit_req[0]: -2 0.606 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "localhost" | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:23 [debug] 27207#0: *2 limit_req[1]: 0 0.000 | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:23 [debug] 27207#0: *2 generic phase: 5 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 access phase: 6 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 access phase: 7 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 post access phase: 8 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 send WINDOW_UPDATE frame sid:553, window:2147483647 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer add: 9: 60000:1460548043076 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http finalize request: -4, "/mod_pagespeed_test/test.php?" a:1, c:2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http request count:2 blk:0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame complete pos:0000000001F0286D end:0000000001F0286D | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame out: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 malloc: 0000000001EEF080:16384 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 13 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL to write: 13 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_write: 13 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame sent: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer del: 9: 1460548162683 | |
2016/04/13 13:46:23 [debug] 27207#0: timer delta: 393 | |
2016/04/13 13:46:23 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:23 [debug] 27207#0: epoll timer: 60000 | |
2016/04/13 13:46:23 [debug] 27207#0: epoll: fd:9 ev:0001 d:0000000001E87211 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 read handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_read: 24 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_read: -1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_get_error: 2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 process http2 frame type:0 f:1 l:15 sid:553 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 DATA frame | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer del: 9: 1460548043076 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http body new buf t:1 f:0 0000000001EFF518, pos 0000000001EFF518, size: 15 file: 0, size: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http init upstream, client timer: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001EF3090:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script copy: "SCRIPT_FILENAME" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "/home/oschaaf/code/google/mps-issue-1175//src/install/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "SCRIPT_FILENAME: /home/oschaaf/code/google/mps-issue-1175//src/install/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script copy: "QUERY_STRING" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "QUERY_STRING: " | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script copy: "REQUEST_METHOD" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "POST" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "REQUEST_METHOD: POST" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script copy: "CONTENT_TYPE" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "application/x-www-form-urlencoded" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "CONTENT_TYPE: application/x-www-form-urlencoded" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script copy: "CONTENT_LENGTH" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "15" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "CONTENT_LENGTH: 15" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_HOST: 192.168.137.10:4430" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_CONTENT_LENGTH: 15" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_PRAGMA: no-cache" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_CACHE_CONTROL: no-cache" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_ACCEPT: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_ORIGIN: https://192.168.137.10:4430" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_UPGRADE_INSECURE_REQUESTS: 1" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_USER_AGENT: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.112 Safari/537.36" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_CONTENT_TYPE: application/x-www-form-urlencoded" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_REFERER: https://192.168.137.10:4430/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_ACCEPT_ENCODING: gzip, deflate, br" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_ACCEPT_LANGUAGE: en-US,en;q=0.8,nl;q=0.6" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 fastcgi param: "HTTP_COOKIE: __utma=249880774.1383284618.1457435953.1457435953.1457435953.1; __utmz=249880774.1457435953.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); COMMERCE_SITE_PreviousCatalogPage=http://www.overland.com:80/default.aspx; _ga=GA1.4.1383284618.1457435953; __ar_v4=A2DMCTE7MBFGDNK5YEWLMH%3A20160307%3A6%7C3546UXGADRAB7D4T22VG7L%3A20160307%3A179%7CVINBB5DOHFDPZAD42RWWE6%3A20160307%3A179%7C6BHUC3GFKFCJLNRPPUHMNS%3A20160307%3A156%7CRDW3YUET4NBAFGEQUT65ET%3A20160307%3A17; _hp2_id.3446894088=7920717152696490.3996779594.2723900530" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cleanup add: 0000000001EF3650 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 get rr peer, try: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 stream socket 10 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 epoll add connection: fd:10 ev:80002005 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 connect to 127.0.0.1:9000, fd:10 #80 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream connect: -2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001E65AC0:128 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer add: 10: 60000:1460548043077 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame complete pos:0000000001F02848 end:0000000001F02848 | |
2016/04/13 13:46:23 [debug] 27207#0: timer delta: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:23 [debug] 27207#0: epoll timer: 60000 | |
2016/04/13 13:46:23 [debug] 27207#0: epoll: fd:10 ev:0004 d:0000000001E872F1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream request: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream send request handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream send request | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream send request body | |
2016/04/13 13:46:23 [debug] 27207#0: *2 chain writer buf fl:0 s:1376 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 chain writer buf fl:0 s:15 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 chain writer buf fl:0 s:9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 chain writer in: 0000000001EF36B8 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 writev: 1400 of 1400 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 chain writer out: 0000000000000000 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer del: 10: 1460548043077 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer add: 10: 60000:1460548043078 | |
2016/04/13 13:46:23 [debug] 27207#0: timer delta: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:23 [debug] 27207#0: epoll timer: 60000 | |
2016/04/13 13:46:23 [debug] 27207#0: epoll: fd:10 ev:2005 d:0000000001E872F1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream request: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream process header | |
2016/04/13 13:46:23 [debug] 27207#0: *2 malloc: 0000000001F42840:4096 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 recv: fd:10 528 of 4096 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 06 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: F3 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 05 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record length: 499 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi parser: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi header: "X-Powered-By: PHP/5.5.9-1ubuntu4.14" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi parser: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi header: "Content-type: text/html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi parser: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi header done | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 header filter | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: ":status: 200" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "server: nginx/1.9.14" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "date: Wed, 13 Apr 2016 11:46:23 GMT" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "content-type: text/html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "x-powered-by: PHP/5.5.9-1ubuntu4.14" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:553 create HEADERS frame 0000000001EF3B50: len:73 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cleanup add: 0000000001EF3C38 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame out: 0000000001EF3B50 sid:553 bl:1 len:73 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 73 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:553 HEADERS frame 0000000001EF3B50 was sent | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame sent: 0000000001EF3B50 sid:553 bl:1 len:73 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cacheable: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream process upstream | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe read upstream: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe preread: 456 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 readv: 1, last:3568 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe recv chain: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe buf free s:0 t:1 f:0 0000000001F42840, pos 0000000001F42888, size: 456 file: 0, size: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe length: -1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 input buf #0 0000000001F42888 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 03 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 01 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 08 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record byte: 00 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi record length: 8 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http fastcgi sent end request | |
2016/04/13 13:46:23 [debug] 27207#0: *2 input buf 0000000001F42888 435 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe write downstream: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe write downstream flush in | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http output filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http copy filter: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http ssi filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 saved: 0 state: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 parse: -2, looked: 0 0000000001F42888-0000000001F42A3B | |
2016/04/13 13:46:23 [debug] 27207#0: *2 saved: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 ssi out: 0000000001EF3E00 0000000001F42888 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http postpone filter "/mod_pagespeed_test/test.php?" 0000000001EF36B8 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 write new buf t:1 f:0 0000000001F42840, pos 0000000001F42888, size: 435 file: 0, size: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter: l:0 f:0 s:435 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http copy filter: 0 "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 pipe write downstream done | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer del: 10: 1460548043078 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream exit: 0000000000000000 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 finalize http upstream request: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 finalize http fastcgi request | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free rr peer 1 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 close http upstream connection: 10 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001E65AC0, unused: 48 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 reusable connection: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http upstream temp fd: -1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http output filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http copy filter: "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http ssi filter "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 ssi out: 0000000001EF3EC0 0000000000000000 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http postpone filter "/mod_pagespeed_test/test.php?" 0000000001EF3F10 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 write old buf t:1 f:0 0000000001F42840, pos 0000000001F42888, size: 435 file: 0, size: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter: l:1 f:0 s:435 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter limit 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:553 create DATA frame 0000000001EF3B50: len:435 flags:1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame out: 0000000001EF3B50 sid:553 bl:0 len:435 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 435 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL to write: 526 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_write: 526 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:553 DATA frame 0000000001EF3B50 was sent | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame sent: 0000000001EF3B50 sid:553 bl:0 len:435 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter 0000000000000000 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http copy filter: 0 "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http finalize request: 0, "/mod_pagespeed_test/test.php?" a:1, c:1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http request count:1 blk:0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 close stream 553, queued 0, processing 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http close request | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http log handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001F42840 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EFD740, unused: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EFE750, unused: 8 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EF3090, unused: 92 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001E5CF60, unused: 17 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001F011C0, unused: 779 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 post event 0000000001EBF120 | |
2016/04/13 13:46:23 [debug] 27207#0: timer delta: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: posted event 0000000001EBF120 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 delete posted event 0000000001EBF120 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 handle connection handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001E6DC70, unused: 3320 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EEF080 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 reusable connection: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer add: 9: 180000:1460548163078 | |
2016/04/13 13:46:23 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:23 [debug] 27207#0: epoll timer: 180000 | |
2016/04/13 13:46:23 [debug] 27207#0: epoll: fd:9 ev:0001 d:0000000001E87211 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 idle handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 reusable connection: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001E6DC70:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 read handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_read: 61 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_read: -1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_get_error: 2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 process http2 frame type:1 f:24 l:52 sid:555 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 HEADERS frame sid:555 on 0 excl:0 weight:256 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001E5CF60:1024 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001EFD740:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001EFE750:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 3 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 84 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 7 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 hpack encoded string length: 4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 hpack encoded string length: 20 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http uri: "/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http args: "" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http exten: "php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 69 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "content-length: 15" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 63 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "pragma: no-cache" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 62 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "cache-control: no-cache" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 82 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 68 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "origin: https://192.168.137.10:4430" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 81 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "upgrade-insecure-requests: 1" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 80 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "user-agent: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/49.0.2623.112 Safari/537.36" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 67 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "content-type: application/x-www-form-urlencoded" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 70 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "referer: https://192.168.137.10:4430/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 66 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "accept-encoding: gzip, deflate, br" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 78 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http header: "accept-language: en-US,en;q=0.8,nl;q=0.6" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 77 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 76 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 75 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 74 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 73 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001F011C0:1024 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 get indexed header name: 72 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 http request line: "POST /mod_pagespeed_test/test.php HTTP/2.0" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 rewrite phase: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 test location: "/50x.html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 test location: ~ "\.php$" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 using configuration "\.php$" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cl:15 max:1048576 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 rewrite phase: 2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 post rewrite phase: 3 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 generic phase: 4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http script var: "���" | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx lock | |
2016/04/13 13:46:23 [debug] 27207#0: shmtx unlock | |
2016/04/13 13:46:23 [debug] 27207#0: *2 limit_req[0]: -3 1.210 | |
2016/04/13 13:46:23 [error] 27207#0: *2 limiting requests, excess: 1.210 by zone "perip", client: 192.168.137.1, server: localhost, request: "POST /mod_pagespeed_test/test.php HTTP/2.0", host: "192.168.137.10:4430", referrer: "https://192.168.137.10:4430/mod_pagespeed_test/test.php" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http finalize request: 503, "/mod_pagespeed_test/test.php?" a:1, c:1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http special response: 503, "/mod_pagespeed_test/test.php?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 internal redirect: "/50x.html?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 rewrite phase: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 test location: "/50x.html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 using configuration "=/50x.html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cl:15 max:1048576 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 rewrite phase: 2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 post rewrite phase: 3 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 generic phase: 4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 generic phase: 5 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 access phase: 6 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 access phase: 7 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 post access phase: 8 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 content phase: 9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 content phase: 10 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 content phase: 11 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http filename: "/home/oschaaf/nginx-tmpbuild/html/50x.html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 add cleanup: 0000000001EFEF18 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http static fd: 10 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 header filter | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: ":status: 503" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "server: nginx/1.9.14" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "date: Wed, 13 Apr 2016 11:46:23 GMT" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 output header: "content-type: text/html" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:555 create HEADERS frame 0000000001EFF2F8: len:49 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http cleanup add: 0000000001EFF400 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame out: 0000000001EFF2F8 sid:555 bl:1 len:49 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 malloc: 0000000001EEF080:16384 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 49 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:555 HEADERS frame 0000000001EFF2F8 was sent | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame sent: 0000000001EFF2F8 sid:555 bl:1 len:49 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http output filter "/50x.html?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http copy filter: "/50x.html?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 read: 10, 0000000001EFF4E0, 537, 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http ssi filter "/50x.html?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 saved: 0 state: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 parse: -2, looked: 0 0000000001EFF4E0-0000000001EFF6F9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 saved: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 posix_memalign: 0000000001EF3090:4096 @16 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 ssi out: 0000000001EF30B0 0000000001EFF4E0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http postpone filter "/50x.html?" 0000000001EFF720 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 write new buf t:1 f:0 0000000001EFF4E0, pos 0000000001EFF4E0, size: 537 file: 0, size: 537 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter: l:1 f:0 s:537 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter limit 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:555 create DATA frame 0000000001EFF2F8: len:537 flags:1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame out: 0000000001EFF2F8 sid:555 bl:0 len:537 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 9 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 537 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL to write: 604 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_write: 604 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2:555 DATA frame 0000000001EFF2F8 was sent | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame sent: 0000000001EFF2F8 sid:555 bl:0 len:537 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http write filter 0000000000000000 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http copy filter: 0 "/50x.html?" | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http finalize request: 0, "/50x.html?" a:1, c:2 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http request count:2 blk:0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http finalize request: -4, "/50x.html?" a:1, c:1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http request count:1 blk:0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 close stream 555, queued 0, processing 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 send RST_STREAM frame sid:555, status:0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http close request | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http log handler | |
2016/04/13 13:46:23 [debug] 27207#0: *2 run cleanup: 0000000001EFEF18 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 file cleanup: fd:10 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EFD740, unused: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EFE750, unused: 0 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EF3090, unused: 3756 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001E5CF60, unused: 17 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001F011C0, unused: 779 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame complete pos:0000000001F0286D end:0000000001F0286D | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame out: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL buf copy: 13 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL to write: 13 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 SSL_write: 13 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 http2 frame sent: 0000000001E6DEC8 sid:0 bl:0 len:4 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001E6DC70, unused: 3320 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 free: 0000000001EEF080 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 reusable connection: 1 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer del: 9: 1460548163078 | |
2016/04/13 13:46:23 [debug] 27207#0: *2 event timer add: 9: 180000:1460548163472 | |
2016/04/13 13:46:23 [debug] 27207#0: timer delta: 394 | |
2016/04/13 13:46:23 [debug] 27207#0: worker cycle | |
2016/04/13 13:46:23 [debug] 27207#0: epoll timer: 180000 |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment