On 10/20/2015 09:57 PM, Andy Wang wrote: > > > On 10/20/2015 11:16 AM, Andy Wang wrote: >> >> >> On 10/20/2015 05:19 AM, Yann Ylavic wrote: >> >>> >>> mod_dumpio's traces (level TRACE7) could be helpful here, Andy? >>> >> >> I'll reconfigure to get that in a bit today. >> I'll also try with mod_proxy_ajp as well to see if the same occurs. > > > mod_proxy_ajp has the same behavior. > Here's the output from mod_dumpio - lemme know if you'd like the raw file. > I'd have to figure out how to make it > available somewhere after sanitizing a few things. > > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(164): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-HEAP): 362 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-HEAP): HTTP/1.1 200 OK\r\nDate: Tue, 20 Oct > 2015 19:53:53 GMT\r\nServer: Apache/2.4.16 > (Win64)\r\nX-Frame-Options: SAMEORIGIN\r\nExpires: Thu, 01 Jan 1970 00:00:00 > GMT\r\nCache-Control: > no-cache\r\nContent-Type: text/html;charset=UTF-8\r\nVary: > Accept-Encoding,User-Agent\r\nContent-Encoding: > gzip\r\nKeep-Alive: timeout=5, max=100\r\nConnection: > Keep-Alive\r\nTransfer-Encoding: chunked\r\n\r\n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(164): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-TRANSIENT): 4 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-TRANSIENT): 1e\r\n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): 10 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): \x1f\x8b\b > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-HEAP): 20 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-HEAP): > \x8a\x8a\x02\x02\xab\x92\xd4\xe2\x12+\x10+\x8a\x97\v > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): 2 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): \r\n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (metadata-FLUSH): 0 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(164): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-TRANSIENT): 3 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-TRANSIENT): a\r\n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-HEAP): 2 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-HEAP): \x03 > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-POOL): 8 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-POOL): \xfe\x8e\xed\xee\x12 > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): 2 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): \r\n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): 5 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (data-IMMORTAL): 0\r\n\r\n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (metadata-EOS): 0 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(164): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (metadata-EOR): 0 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(135): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in [speculative-nonblocking] 1 readbytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in (data-HEAP): 1 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in (data-HEAP): \n
This looks like there is a stray \n in the input queue that causes httpd to think that there is a pipelined request. What client did you use? > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(135): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in [getline-blocking] 0 readbytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in (data-HEAP): 1 bytes > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(100): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in (data-HEAP): \n > [Tue Oct 20 14:53:53.800924 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(135): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in [getline-blocking] 0 readbytes > [Tue Oct 20 14:53:58.801084 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(150): [client 132.253.8.198:55373] > mod_dumpio: dumpio_in - 70007 > [Tue Oct 20 14:53:58.801084 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(164): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out > [Tue Oct 20 14:53:58.801084 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (metadata-FLUSH): 0 bytes > [Tue Oct 20 14:53:58.801084 2015] [dumpio:trace7] [pid 5228:tid 2776] > mod_dumpio.c(58): [client 132.253.8.198:55373] > mod_dumpio: dumpio_out (metadata-EOC): 0 bytes > Regards Rüdiger
