https://bz.apache.org/bugzilla/show_bug.cgi?id=63855 --- Comment #5 from Konstantin J. Chernov <k.j.chernov@gmail.com> ---
Some magic is definitely happening here.
I was unable to reproduce this issue 12 hours after report. No changes were
made to tomcat or apache during this time.
I've added two attachments: ho1.txt were made during original testing, when the
issue happened.
It was made with
{code}
LogLevel ssl:debug dumpio:trace7 proxy:trace7 proxy_balancer:trace7
proxy_http:trace7
DumpIOInput on
DumpIOOutput on
{code}
In attempts to reproduce this issue, I had to make an another apache instance
with the same configuration, ho2.txt is my attempt to reproduce this issue
later with trace7 enabled.
Also, the ho3.txt is the attempt to reproduce the issue with the same settings
as I mentioned above (with dumpio turned on). You can clearly see the
difference between ho1.txt and ho3.txt.
1. In first attempt:
{code}
[2019-10-16 07:46:01.947019] [proxy:debug] [pid 16948:tid 50] [C:AHHOPGzEn2k]
[XaZoSU2Rh-cAhSIGXhDvRgAAAG8] [CLIENT_IP:64606] AH00947: connected
/service/endpoint to BACKEND_HOST_2:4005
[2019-10-16 07:46:01.947259] [dumpio:trace7] [pid 16948:tid 50] [C:AHHOPGzEn2k]
[-] [CLIENT_IP:64606] mod_dumpio: dumpio_in [readbytes-nonblocking] 466
readbytes
[2019-10-16 07:46:01.947416] [dumpio:trace7] [pid 16948:tid 50] [C:AHHOPGzEn2k]
[-] [CLIENT_IP:64606] mod_dumpio: dumpio_in - 11
[2019-10-16 07:46:01.947493] [dumpio:trace7] [pid 16948:tid 50] [C:AHHOPGzEn2k]
[-] [CLIENT_IP:64606] mod_dumpio: dumpio_in [readbytes-blocking] 466 readbytes
[2019-10-16 07:47:01.952546] [dumpio:trace7] [pid 16948:tid 50] [C:AHHOPGzEn2k]
[-] [CLIENT_IP:64606] mod_dumpio: dumpio_in - 70007
{code}
2. In last attempt:
{code}
[2019-10-16 18:15:58.654483] [proxy:debug] [pid 26661:tid 26] [C:AEBSpTmgr34]
[Xab77jMz3Hj958KCYob0FgAAABc] [CLIENT_IP:34060] AH00947: connected
/service/endpoint to BACKEND_HOST_2:4005
[2019-10-16 18:15:58.654713] [dumpio:trace7] [pid 26661:tid 26] [C:AEBSpTmgr34]
[-] [CLIENT_IP:34060] mod_dumpio: dumpio_in [readbytes-nonblocking] 466
readbytes
[2019-10-16 18:15:58.654864] [dumpio:trace7] [pid 26661:tid 26] [C:AEBSpTmgr34]
[-] [CLIENT_IP:34060] mod_dumpio: dumpio_in - 11
[2019-10-16 18:15:58.655007] [proxy:trace2] [pid 26661:tid 26] [C:-] [-] [-]
HTTP: fam 2 socket created to connect to BACKEND_HOST_2
...
{code}
I don't understand what made apache to attempt to read in blocking mode
earlier.
Beware, that sensitive data has been masked in the logs. Hope it won't make
debugging harder.
--
You are receiving this mail because:
You are the assignee for the bug.
---------------------------------------------------------------------
To unsubscribe, e-mail: bugs-unsubscribe@httpd.apache.org
For additional commands, e-mail: bugs-help@httpd.apache.org