[ https://issues.apache.org/jira/browse/TS-3521?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14494423#comment-14494423 ]
Susan Hinrichs commented on TS-3521: ------------------------------------ Doing a more complete debug capture staring with a completely new HTTP/2 connection attempting to contact https://www.google.com {code} [Apr 14 12:13:11.289] Server {0x7ffff40ad700} DEBUG: (http2_seq) [HttpSessionAccept2:mainEvent 0x7fffe8018840] accepted connection from 192.168.126.130:49866 transport type = 4 [Apr 14 12:13:11.289] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] session born, netvc 0x7fffe8018840 [Apr 14 12:13:11.290] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_read_connection_preface, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_read_connection_preface, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] received connection preface [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_start_frame_read, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] receiving frame header [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] frame header length=12, type=4, flags=0x0, streamid=0 [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_complete_frame_read, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] completed frame read, 34 bytes available [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] Received SETTINGS frame. [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] setting param=4 value=131072 [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] setting param=5 value=16384 [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_start_frame_read, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] receiving frame header [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] frame header length=4, type=8, flags=0x0, streamid=0 [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_complete_frame_read, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] completed frame read, 13 bytes available [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] Received WINDOW_UPDATE frame. [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_start_frame_read, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] receiving frame header [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] frame header length=0, type=4, flags=0x1, streamid=0 [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_complete_frame_read, VC_EVENT_READ_READY] [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] completed frame read, 0 bytes available [Apr 14 12:13:11.310] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] Received SETTINGS frame. [Apr 14 12:13:28.553] Server {0x7ffff3fac700} DEBUG: (http2_seq) [HttpSessionAccept2:mainEvent 0x7fffe801a580] accepted connection from 192.168.126.130:49877 transport type = 4 [Apr 14 12:13:28.553] Server {0x7ffff3fac700} DEBUG: (http2_cs) [129] session born, netvc 0x7fffe801a580 [Apr 14 12:13:28.553] Server {0x7ffff3fac700} DEBUG: (http2_cs) [129] [&Http2ClientSession::state_read_connection_preface, VC_EVENT_READ_READY] [Apr 14 12:13:28.556] Server {0x7ffff3fac700} DEBUG: (http2_cs) [129] session closed [Apr 14 12:13:28.556] Server {0x7ffff3fac700} DEBUG: (http2_cs) [129] session destroy [Apr 14 12:14:09.504] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_start_frame_read, VC_EVENT_READ_READY] [Apr 14 12:14:09.504] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] receiving frame header [Apr 14 12:14:09.504] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] frame header length=8, type=6, flags=0x0, streamid=0 [Apr 14 12:14:09.504] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_complete_frame_read, VC_EVENT_READ_READY] [Apr 14 12:14:09.504] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] completed frame read, 8 bytes available [Apr 14 12:14:09.504] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] Received PING frame. [Apr 14 12:15:07.512] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_start_frame_read, VC_EVENT_READ_READY] [Apr 14 12:15:07.512] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] receiving frame header [Apr 14 12:15:07.512] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] frame header length=8, type=6, flags=0x0, streamid=0 [Apr 14 12:15:07.512] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] [&Http2ClientSession::state_complete_frame_read, VC_EVENT_READ_READY] [Apr 14 12:15:07.512] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] completed frame read, 8 bytes available [Apr 14 12:15:07.512] Server {0x7ffff40ad700} DEBUG: (http2_cs) [118] Received PING frame. {code} Looking at the PCAP of the connection, the server (ATS) sends some data. The client sends a SSL alert and FIN's the connection. > Several web sites don't load when HTTP/2 is enabled in ATS > ---------------------------------------------------------- > > Key: TS-3521 > URL: https://issues.apache.org/jira/browse/TS-3521 > Project: Traffic Server > Issue Type: Bug > Components: HTTP/2 > Reporter: Susan Hinrichs > > I'm running in transparent forward proxy mode. If I don't have HTTP2 > enabled, I can load the following sites from my Firefox 36.04 client running > on Win 7 > http://busey.com (which redirects to URLs under https://www.busey.com) > https://www.google.com > When I enable http2, these sites don't load. My Firefox tab stays empty (or > shows the previous site). > If I turn on debug http2, I see the following from ATS > For busey > {code} > [Apr 14 12:05:46.544] Server {0x7ffff3fac700} DEBUG: (http2_seq) > [HttpSessionAccept2:mainEvent 0x7fffe8018840] accepted connection from > 192.168.126.130:49851 transport type = 4 > [Apr 14 12:05:46.544] Server {0x7ffff3fac700} DEBUG: (http2_cs) [102] session > born, netvc 0x7fffe8018840 > [Apr 14 12:05:46.544] Server {0x7ffff3fac700} DEBUG: (http2_cs) [102] > [&Http2ClientSession::state_read_connection_preface, VC_EVENT_READ_READY] > [Apr 14 12:05:46.549] Server {0x7ffff3fac700} DEBUG: (http2_cs) [102] session > closed > [Apr 14 12:05:46.549] Server {0x7ffff3fac700} DEBUG: (http2_cs) [102] session > destroy > {code} > For https://www.google.com > {code} > [Apr 14 12:06:49.201] Server {0x7ffff3eab700} DEBUG: (http2_seq) > [HttpSessionAccept2:mainEvent 0x7fffe8018840] accepted connection from > 192.168.126.130:49852 transport type = 4 > [Apr 14 12:06:49.201] Server {0x7ffff3eab700} DEBUG: (http2_cs) [103] session > born, netvc 0x7fffe8018840 > [Apr 14 12:06:49.201] Server {0x7ffff3eab700} DEBUG: (http2_cs) [103] > [&Http2ClientSession::state_read_connection_preface, VC_EVENT_READ_READY] > [Apr 14 12:06:49.214] Server {0x7ffff3eab700} DEBUG: (http2_cs) [103] session > closed > [Apr 14 12:06:49.214] Server {0x7ffff3eab700} DEBUG: (http2_cs) [103] session > destroy > {code} -- This message was sent by Atlassian JIRA (v6.3.4#6332)