> On 7 Sep 2017, at 11:53 pm, Eric Covener <cove...@gmail.com> wrote: > >> >> I am wondering whether the use of a rewriterule with the “P” flag is the >> reason the upgrade header hasn’t been included. I wonder this because it is >> pretty widely reported to work fine when using ProxyPass to ws uri. >> > > I will have to look more later, but what's your exact httpd version? I > think if Upgrade is not preserved it implies mod_proxy_http was used > via either ProxyPass or some failure in mod_proxy_wstunnel taking over > -- so LogLevel trace8 might help.
I have attached the complete log output as a plain text file, but I think this might be the bit you are looking for (see below). It appears mod_proxy_http handled the request via the rewriterule with the ‘p’ flag. To preserve the necessary headers, how might I force the request to be handled by mod_proxy_wstunnel? Or am I looking at this all wrong? Thanks again Eric. D. [Fri Sep 08 00:09:26.808052 2017] [mpm_event:trace6] [pid 2078:tid 139884475877120] event.c(1434): connections: 2 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:09:27.078989 2017] [proxy_http:error] [pid 2078:tid 139884492662528] (70007)The timeout specified has expired: [client 119.18.39.57:53016] AH01102: error reading status line from remote server localhost:3000, referer: http://buzzer.click/ [Fri Sep 08 00:09:27.079072 2017] [proxy:error] [pid 2078:tid 139884492662528] [client 119.18.39.57:53016] AH00898: Error reading from remote server returned by /socket.io/, referer: http://buzzer.click/ [Fri Sep 08 00:09:27.601732 2017] [proxy_http:error] [pid 2078:tid 139884626945792] (70007)The timeout specified has expired: [client 119.18.39.57:53019] AH01102: error reading status line from remote server localhost:3000, referer: http://buzzer.click/ [Fri Sep 08 00:09:27.601795 2017] [proxy:error] [pid 2078:tid 139884626945792] [client 119.18.39.57:53019] AH00898: Error reading from remote server returned by /socket.io/, referer: http://buzzer.click/
[Fri Sep 08 00:03:46.126123 2017] [http2:debug] [pid 1781:tid 140494012729536] mod_http2.c(108): AH03089: initializing post config dry run [Fri Sep 08 00:03:46.134637 2017] [core:trace3] [pid 1781:tid 140494012729536] core.c(3287): Setting LogLevel for all modules to trace8 [Fri Sep 08 00:03:46.138167 2017] [http2:info] [pid 1781:tid 140494012729536] AH03090: mod_http2 (v1.10.7, feats=CHPRIO+SHA256+INVHD+DWINS, nghttp2 1.21.1), initializing... [Fri Sep 08 00:03:46.138201 2017] [http2:trace1] [pid 1781:tid 140494012729536] h2_h2.c(447): h2_h2, child_init [Fri Sep 08 00:03:46.138215 2017] [http2:warn] [pid 1781:tid 140494012729536] AH02951: mod_ssl does not seem to be enabled [Fri Sep 08 00:03:46.138253 2017] [http2:trace1] [pid 1781:tid 140494012729536] h2_switch.c(43): h2_switch init [Fri Sep 08 00:03:46.144034 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1783 (gen 0/slot 0) started [Fri Sep 08 00:03:46.144450 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1784 (gen 0/slot 1) started [Fri Sep 08 00:03:46.144775 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1785 (gen 0/slot 2) started [Fri Sep 08 00:03:46.144787 2017] [mpm_event:notice] [pid 1781:tid 140494012729536] AH00489: Apache/2.4.27 (CentOS) configured -- resuming normal operations [Fri Sep 08 00:03:46.144792 2017] [mpm_event:info] [pid 1781:tid 140494012729536] AH00490: Server built: Jul 10 2017 09:38:04 [Fri Sep 08 00:03:46.144800 2017] [core:notice] [pid 1781:tid 140494012729536] AH00094: Command line: '/usr/sbin/httpd -D FOREGROUND' [Fri Sep 08 00:03:46.144803 2017] [core:debug] [pid 1781:tid 140494012729536] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1) [Fri Sep 08 00:03:46.150218 2017] [http2:trace3] [pid 1783:tid 140494012729536] h2_conn.c(145): h2_workers: min=25 max=37, mthrpchild=25, idle_secs=600 [Fri Sep 08 00:03:46.151140 2017] [proxy:debug] [pid 1783:tid 140494012729536] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared [Fri Sep 08 00:03:46.151159 2017] [proxy:debug] [pid 1783:tid 140494012729536] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local [Fri Sep 08 00:03:46.151212 2017] [proxy:debug] [pid 1783:tid 140494012729536] proxy_util.c(1856): AH00930: initialized pool in child 1783 for (*) min=0 max=25 smax=25 [Fri Sep 08 00:03:46.151948 2017] [http2:trace3] [pid 1784:tid 140494012729536] h2_conn.c(145): h2_workers: min=25 max=37, mthrpchild=25, idle_secs=600 [Fri Sep 08 00:03:46.152925 2017] [proxy:debug] [pid 1784:tid 140494012729536] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared [Fri Sep 08 00:03:46.152943 2017] [proxy:debug] [pid 1784:tid 140494012729536] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local [Fri Sep 08 00:03:46.152994 2017] [proxy:debug] [pid 1784:tid 140494012729536] proxy_util.c(1856): AH00930: initialized pool in child 1784 for (*) min=0 max=25 smax=25 [Fri Sep 08 00:03:46.153675 2017] [http2:trace3] [pid 1785:tid 140494012729536] h2_conn.c(145): h2_workers: min=25 max=37, mthrpchild=25, idle_secs=600 [Fri Sep 08 00:03:46.154409 2017] [proxy:debug] [pid 1785:tid 140494012729536] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared [Fri Sep 08 00:03:46.154419 2017] [proxy:debug] [pid 1785:tid 140494012729536] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local [Fri Sep 08 00:03:46.154451 2017] [proxy:debug] [pid 1785:tid 140494012729536] proxy_util.c(1856): AH00930: initialized pool in child 1785 for (*) min=0 max=25 smax=25 [Fri Sep 08 00:03:46.155173 2017] [mpm_event:debug] [pid 1785:tid 140493534058240] event.c(1980): AH02471: start_threads: Using epoll [Fri Sep 08 00:03:46.155810 2017] [mpm_event:debug] [pid 1784:tid 140493534058240] event.c(1980): AH02471: start_threads: Using epoll [Fri Sep 08 00:03:46.156401 2017] [mpm_event:debug] [pid 1783:tid 140493534058240] event.c(1980): AH02471: start_threads: Using epoll [Fri Sep 08 00:03:47.159163 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:47.159252 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:47.159296 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:48.161099 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:48.161159 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:48.161176 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:49.162845 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:49.162931 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:49.245326 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 1 lingering: 0 suspended: 0) [Fri Sep 08 00:03:50.148211 2017] [mpm_event:trace5] [pid 1781:tid 140494012729536] event.c(2535): Spawning new child: slot 3 active / total daemons: 3/3 [Fri Sep 08 00:03:50.148995 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1978 (gen 0/slot 3) started [Fri Sep 08 00:03:50.149721 2017] [http2:trace3] [pid 1978:tid 140494012729536] h2_conn.c(145): h2_workers: min=25 max=37, mthrpchild=25, idle_secs=600 [Fri Sep 08 00:03:50.150664 2017] [proxy:debug] [pid 1978:tid 140494012729536] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared [Fri Sep 08 00:03:50.150683 2017] [proxy:debug] [pid 1978:tid 140494012729536] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local [Fri Sep 08 00:03:50.150730 2017] [proxy:debug] [pid 1978:tid 140494012729536] proxy_util.c(1856): AH00930: initialized pool in child 1978 for (*) min=0 max=25 smax=25 [Fri Sep 08 00:03:50.150852 2017] [mpm_event:debug] [pid 1978:tid 140493534058240] event.c(1980): AH02471: start_threads: Using epoll [Fri Sep 08 00:03:50.219154 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:50.249232 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 1 lingering: 0 suspended: 0) [Fri Sep 08 00:03:50.303570 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:51.153605 2017] [mpm_event:trace6] [pid 1978:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:51.289719 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:51.306147 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:51.311766 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:52.155488 2017] [mpm_event:trace6] [pid 1978:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:52.291489 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:52.308248 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:52.313574 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:53.157728 2017] [mpm_event:trace6] [pid 1978:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:53.293386 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:53.309999 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:53.315253 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:54.159517 2017] [mpm_event:trace6] [pid 1978:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:54.295241 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:54.311770 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:54.320898 2017] [mpm_event:trace6] [pid 1784:tid 140493245560576] event.c(1434): connections: 0 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:54.560508 2017] [core:info] [pid 1781:tid 140494012729536] AH00096: removed PID file /run/httpd/httpd.pid (pid=1781) [Fri Sep 08 00:03:54.560536 2017] [mpm_event:notice] [pid 1781:tid 140494012729536] AH00492: caught SIGWINCH, shutting down gracefully [Fri Sep 08 00:03:55.364505 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:55.364562 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:55.364581 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:55.364594 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:55.561613 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1784 (gen 0/slot 1) exited [Fri Sep 08 00:03:55.561659 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1978 (gen 0/slot 3) exited [Fri Sep 08 00:03:56.366409 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:56.366455 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:56.366573 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:56.366975 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:57.368243 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:57.368290 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:57.368535 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:57.368570 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:58.370133 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:58.370173 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:58.370188 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:58.370196 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:59.372018 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:59.372071 2017] [mpm_event:trace6] [pid 1783:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:59.372090 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:03:59.372102 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:03:59.712851 2017] [proxy_http:error] [pid 1783:tid 140493371451136] (70007)The timeout specified has expired: [client 119.18.39.57:52894] AH01102: error reading status line from remote server localhost:3000, referer: http://buzzer.click/ [Fri Sep 08 00:03:59.712929 2017] [proxy:error] [pid 1783:tid 140493371451136] [client 119.18.39.57:52894] AH00898: Error reading from remote server returned by /socket.io/, referer: http://buzzer.click/ [Fri Sep 08 00:04:00.374361 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1434): connections: 1 (clogged: 0 write-completion: 0 keep-alive: 0 lingering: 0 suspended: 0) [Fri Sep 08 00:04:00.374415 2017] [mpm_event:trace6] [pid 1785:tid 140493245560576] event.c(1439): 24/25 workers shutdown [Fri Sep 08 00:04:00.567070 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1783 (gen 0/slot 0) exited [Fri Sep 08 00:04:00.999649 2017] [proxy_http:error] [pid 1785:tid 140493253953280] (70007)The timeout specified has expired: [client 119.18.39.57:52897] AH01102: error reading status line from remote server localhost:3000, referer: http://buzzer.click/ [Fri Sep 08 00:04:00.999730 2017] [proxy:error] [pid 1785:tid 140493253953280] [client 119.18.39.57:52897] AH00898: Error reading from remote server returned by /socket.io/, referer: http://buzzer.click/ [Fri Sep 08 00:04:01.568262 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(533): mpm child 1785 (gen 0/slot 2) exited [Fri Sep 08 00:04:01.578770 2017] [core:trace4] [pid 1781:tid 140494012729536] mpm_common.c(429): end of generation 0
> > --------------------------------------------------------------------- > To unsubscribe, e-mail: users-unsubscr...@httpd.apache.org > For additional commands, e-mail: users-h...@httpd.apache.org >
--------------------------------------------------------------------- To unsubscribe, e-mail: users-unsubscr...@httpd.apache.org For additional commands, e-mail: users-h...@httpd.apache.org
