https://bz.apache.org/bugzilla/show_bug.cgi?id=61616

--- Comment #16 from Carsten Wolff <cars...@wolffcarsten.de> ---
(In reply to Yann Ylavic from comment #15)
> Created attachment 35432 [details]
> Handle POLLOUT in proxy_connect (v5)
> 
> Please use v5 instead, v4 can't work before it does not play well with
> EAGAIN.

With v5 + "File read buffer and flush threshold tuning", proxy_connect gets
stuck very early on:



[Tue Oct 17 12:55:53.597014 2017] [core:trace5] [pid 9813:tid 140438873556736]
protocol.c(645): [client ::1:44136] Request received from client: CONNECT
localhost:873 HTTP/1.0
[Tue Oct 17 12:55:53.597118 2017] [http:trace4] [pid 9813:tid 140438873556736]
http_request.c(433): [client ::1:44136] Headers received from client:
[Tue Oct 17 12:55:53.597268 2017] [authz_core:debug] [pid 9813:tid
140438873556736] mod_authz_core.c(809): [client ::1:44136] AH01626:
authorization result of Require host localhost: granted
[Tue Oct 17 12:55:53.597278 2017] [authz_core:debug] [pid 9813:tid
140438873556736] mod_authz_core.c(809): [client ::1:44136] AH01626:
authorization result of <RequireAny>: granted
[Tue Oct 17 12:55:53.597282 2017] [core:trace3] [pid 9813:tid 140438873556736]
request.c(304): [client ::1:44136] request authorized without authentication by
access_checker_ex hook: localhost:873
[Tue Oct 17 12:55:53.597291 2017] [proxy_connect:trace1] [pid 9813:tid
140438873556736] mod_proxy_connect.c(141): [client ::1:44136] canonicalising
URL localhost:873
[Tue Oct 17 12:55:53.597312 2017] [proxy:trace2] [pid 9813:tid 140438873556736]
proxy_util.c(1970): [client ::1:44136] *: found forward proxy worker for
localhost:873
[Tue Oct 17 12:55:53.597318 2017] [proxy:debug] [pid 9813:tid 140438873556736]
mod_proxy.c(1227): [client ::1:44136] AH01143: Running scheme localhost handler
(attempt 0)
[Tue Oct 17 12:55:53.597322 2017] [proxy_connect:trace1] [pid 9813:tid
140438873556736] mod_proxy_connect.c(190): [client ::1:44136] serving URL
localhost:873
[Tue Oct 17 12:55:53.597329 2017] [proxy_connect:debug] [pid 9813:tid
140438873556736] mod_proxy_connect.c(207): [client ::1:44136] AH01019:
connecting localhost:873 to localhost:873
[Tue Oct 17 12:55:53.597372 2017] [proxy_connect:trace1] [pid 9813:tid
140438873556736] mod_proxy_connect.c(233): [client ::1:44136] connecting to
remote proxy localhost on port 873
[Tue Oct 17 12:55:53.597384 2017] [proxy:trace2] [pid 9813:tid 140438873556736]
proxy_util.c(2078): [client ::1:44136] CONNECT: fam 10 socket created to
connect to localhost
[Tue Oct 17 12:55:53.597466 2017] [proxy_connect:trace3] [pid 9813:tid
140438873556736] mod_proxy_connect.c(311): [client ::1:44136] connection
complete to [::1]:873 (localhost)
[Tue Oct 17 12:55:53.597483 2017] [proxy_connect:trace1] [pid 9813:tid
140438873556736] mod_proxy_connect.c(333): [client ::1:44136] Returning 200 OK
[Tue Oct 17 12:55:53.597493 2017] [core:trace6] [pid 9813:tid 140438873556736]
core_filters.c(418): [client ::1:44136] core_output_filter: flushing because of
FLUSH bucket
[Tue Oct 17 12:55:53.597522 2017] [core:trace6] [pid 9813:tid 140438873556736]
core_filters.c(878): [client ::1:44136] writev_nonblocking: 76/76 bytes
[Tue Oct 17 12:55:53.597522 2017] [proxy_connect:trace2] [pid 9813:tid
140438873556736] mod_proxy_connect.c(356): [client ::1:44136] setting up poll()
[Tue Oct 17 12:55:53.597651 2017] [proxy:trace2] [pid 9813:tid 140438873556736]
proxy_util.c(3844): [client ::1:44136] ap_proxy_transfer_between_connections
complete
[Tue Oct 17 12:55:53.980879 2017] [proxy:debug] [pid 13857:tid 140438968014016]
proxy_util.c(1779): AH00925: initializing worker proxy:forward shared
[Tue Oct 17 12:55:53.980922 2017] [proxy:debug] [pid 13857:tid 140438968014016]
proxy_util.c(1821): AH00927: initializing worker proxy:forward local
[Tue Oct 17 12:55:53.980933 2017] [proxy:debug] [pid 13857:tid 140438968014016]
proxy_util.c(1856): AH00930: initialized pool in child 13857 for (*) min=0
max=25 smax=25



Thread 2 (Thread 0x7fba792bc700 (LWP 9815)):
#0  0x00007fba7df1b0f3 in epoll_wait () at
../sysdeps/unix/syscall-template.S:84
#1  0x00007fba7e411201 in impl_pollset_poll (pollset=0x7fba7eb93f78,
timeout=<optimized out>, num=0x7fba792b9aa4, descriptors=0x7fba792b9ab0) at
./poll/unix/epoll.c:266
#2  0x00007fba7ad29198 in proxy_connect_handler (r=0x7fba7eb920a0,
worker=<optimized out>, conf=<optimized out>, url=<optimized out>,
proxyname=<optimized out>, proxyport=<optimized out>) at
mod_proxy_connect.c:401



# netstat -pnt | grep -v :22
Active Internet connections (w/o servers)
Proto Recv-Q Send-Q Local Address           Foreign Address         State      
PID/Program name    
tcp6      14      0 ::1:35806               ::1:873                 ESTABLISHED
9813/apache2        
tcp6       0      0 ::1:44136               ::1:80                  ESTABLISHED
13855/rsync         
tcp6       0      0 ::1:873                 ::1:35806               ESTABLISHED
13856/rsync         
tcp6       0      0 ::1:80                  ::1:44136               ESTABLISHED
9813/apache2

-- 
You are receiving this mail because:
You are the assignee for the bug.
---------------------------------------------------------------------
To unsubscribe, e-mail: bugs-unsubscr...@httpd.apache.org
For additional commands, e-mail: bugs-h...@httpd.apache.org

Reply via email to