That was it. I thought I had set it up properly, but I did not give the absolute path to the alpn-boot jar file. I took it for granted that I would see a different error if it couldn't be found. I was wrong. Giving the absolute path to the alpn-boot jar fixed the issue. Thanks Joakim!
Mike On Thu, Sep 10, 2015 at 9:40 PM, Joakim Erdfelt <[email protected]> wrote: > Did you setup your -Xbootclasspath properly for the alpn-boot jar specific > for your version of Java? > (this is a non-optional requirement for success with HTTP/2 on Java 8) > > Joakim Erdfelt / [email protected] > > On Thu, Sep 10, 2015 at 9:01 PM, Michael Ivanov <[email protected]> wrote: >> >> Hi all, >> >> Has anyone successfully run the HTTP2Client example program at >> >> https://github.com/eclipse/jetty.project/blob/master/jetty-http2/http2-client/src/test/java/org/eclipse/jetty/http2/client/Client.java >> ? Can you share your setup or any ideas for debugging the following >> issue? >> >> I am trying to run the example but I keep getting TimeoutException >> while connecting to any host which supports HTTP/2 (webtide.com, >> hghttp2.org, or google.com). I have seen a couple of posts about >> similar issues on StackOverflow and this list and tried the few >> suggestions that were given but it still does not work for me. I have >> tried http2-client-9.3.0.RC1 through 9.3.4.RC0 and always get the same >> error. >> >> See the following log with the timeout at the end (Sorry for the long >> log, this is with DEBUG level logging turned on). >> >> 2015-09-10 20:27:08.723:INFO::main: Logging initialized @168ms >> 2015-09-10 20:27:08.735:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added >> {SslContextFactory@4c873330(null,null),AUTO} >> 2015-09-10 20:27:08.736:DBUG:oejuc.AbstractLifeCycle:main: starting >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f >> 2015-09-10 20:27:08.743:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added >> {qtp558638686{STOPPED,8<=0<=200,i=0,q=0},AUTO} >> 2015-09-10 20:27:08.744:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added >> {org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@16b98e56,AUTO} >> 2015-09-10 20:27:08.745:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added >> {org.eclipse.jetty.io.MappedByteBufferPool@4f3f5b24,POJO} >> 2015-09-10 20:27:08.747:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added >> >> {org.eclipse.jetty.http2.client.HTTP2ClientConnectionFactory@1d81eb93,POJO} >> 2015-09-10 20:27:08.747:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added {[],POJO} >> 2015-09-10 20:27:08.749:DBUG:oejuc.ContainerLifeCycle:main: >> org.eclipse.jetty.http2.client.HTTP2Client@7229724f added >> >> {org.eclipse.jetty.http2.client.HTTP2Client$ClientSelectorManager@12edcd21,AUTO} >> 2015-09-10 20:27:08.749:DBUG:oejuc.AbstractLifeCycle:main: starting >> SslContextFactory@4c873330(null,null) >> 2015-09-10 20:27:09.086:DBUG:oejus.SslContextFactory:main: Selected >> Protocols [TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, >> TLSv1.1, TLSv1.2] >> 2015-09-10 20:27:09.090:DBUG:oejus.SslContextFactory:main: Selected >> Ciphers [TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA256, >> TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA256, >> TLS_RSA_WITH_AES_128_CBC_SHA256, >> TLS_ECDH_ECDSA_WITH_AES_128_CBC_SHA256, >> TLS_ECDH_RSA_WITH_AES_128_CBC_SHA256, >> TLS_DHE_RSA_WITH_AES_128_CBC_SHA256, >> TLS_DHE_DSS_WITH_AES_128_CBC_SHA256, >> TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA, >> TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA, TLS_RSA_WITH_AES_128_CBC_SHA, >> TLS_ECDH_ECDSA_WITH_AES_128_CBC_SHA, >> TLS_ECDH_RSA_WITH_AES_128_CBC_SHA, TLS_DHE_RSA_WITH_AES_128_CBC_SHA, >> TLS_DHE_DSS_WITH_AES_128_CBC_SHA, >> TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256, >> TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256, >> TLS_RSA_WITH_AES_128_GCM_SHA256, >> TLS_ECDH_ECDSA_WITH_AES_128_GCM_SHA256, >> TLS_ECDH_RSA_WITH_AES_128_GCM_SHA256, >> TLS_DHE_RSA_WITH_AES_128_GCM_SHA256, >> TLS_DHE_DSS_WITH_AES_128_GCM_SHA256, >> TLS_ECDHE_ECDSA_WITH_3DES_EDE_CBC_SHA, >> TLS_ECDHE_RSA_WITH_3DES_EDE_CBC_SHA, SSL_RSA_WITH_3DES_EDE_CBC_SHA, >> TLS_ECDH_ECDSA_WITH_3DES_EDE_CBC_SHA, >> TLS_ECDH_RSA_WITH_3DES_EDE_CBC_SHA, SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA, >> SSL_DHE_DSS_WITH_3DES_EDE_CBC_SHA, TLS_EMPTY_RENEGOTIATION_INFO_SCSV] >> of [TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA256, >> TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA256, >> TLS_RSA_WITH_AES_128_CBC_SHA256, >> TLS_ECDH_ECDSA_WITH_AES_128_CBC_SHA256, >> TLS_ECDH_RSA_WITH_AES_128_CBC_SHA256, >> TLS_DHE_RSA_WITH_AES_128_CBC_SHA256, >> TLS_DHE_DSS_WITH_AES_128_CBC_SHA256, >> TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA, >> TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA, TLS_RSA_WITH_AES_128_CBC_SHA, >> TLS_ECDH_ECDSA_WITH_AES_128_CBC_SHA, >> TLS_ECDH_RSA_WITH_AES_128_CBC_SHA, TLS_DHE_RSA_WITH_AES_128_CBC_SHA, >> TLS_DHE_DSS_WITH_AES_128_CBC_SHA, >> TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256, >> TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256, >> TLS_RSA_WITH_AES_128_GCM_SHA256, >> TLS_ECDH_ECDSA_WITH_AES_128_GCM_SHA256, >> TLS_ECDH_RSA_WITH_AES_128_GCM_SHA256, >> TLS_DHE_RSA_WITH_AES_128_GCM_SHA256, >> TLS_DHE_DSS_WITH_AES_128_GCM_SHA256, >> TLS_ECDHE_ECDSA_WITH_3DES_EDE_CBC_SHA, >> TLS_ECDHE_RSA_WITH_3DES_EDE_CBC_SHA, SSL_RSA_WITH_3DES_EDE_CBC_SHA, >> TLS_ECDH_ECDSA_WITH_3DES_EDE_CBC_SHA, >> TLS_ECDH_RSA_WITH_3DES_EDE_CBC_SHA, SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA, >> SSL_DHE_DSS_WITH_3DES_EDE_CBC_SHA, TLS_EMPTY_RENEGOTIATION_INFO_SCSV, >> TLS_DH_anon_WITH_AES_128_GCM_SHA256, >> TLS_DH_anon_WITH_AES_128_CBC_SHA256, >> TLS_ECDH_anon_WITH_AES_128_CBC_SHA, TLS_DH_anon_WITH_AES_128_CBC_SHA, >> TLS_ECDH_anon_WITH_3DES_EDE_CBC_SHA, >> SSL_DH_anon_WITH_3DES_EDE_CBC_SHA, TLS_ECDHE_ECDSA_WITH_RC4_128_SHA, >> TLS_ECDHE_RSA_WITH_RC4_128_SHA, SSL_RSA_WITH_RC4_128_SHA, >> TLS_ECDH_ECDSA_WITH_RC4_128_SHA, TLS_ECDH_RSA_WITH_RC4_128_SHA, >> SSL_RSA_WITH_RC4_128_MD5, TLS_ECDH_anon_WITH_RC4_128_SHA, >> SSL_DH_anon_WITH_RC4_128_MD5, SSL_RSA_WITH_DES_CBC_SHA, >> SSL_DHE_RSA_WITH_DES_CBC_SHA, SSL_DHE_DSS_WITH_DES_CBC_SHA, >> SSL_DH_anon_WITH_DES_CBC_SHA, SSL_RSA_EXPORT_WITH_DES40_CBC_SHA, >> SSL_DHE_RSA_EXPORT_WITH_DES40_CBC_SHA, >> SSL_DHE_DSS_EXPORT_WITH_DES40_CBC_SHA, >> SSL_DH_anon_EXPORT_WITH_DES40_CBC_SHA, SSL_RSA_EXPORT_WITH_RC4_40_MD5, >> SSL_DH_anon_EXPORT_WITH_RC4_40_MD5, TLS_RSA_WITH_NULL_SHA256, >> TLS_ECDHE_ECDSA_WITH_NULL_SHA, TLS_ECDHE_RSA_WITH_NULL_SHA, >> SSL_RSA_WITH_NULL_SHA, TLS_ECDH_ECDSA_WITH_NULL_SHA, >> TLS_ECDH_RSA_WITH_NULL_SHA, TLS_ECDH_anon_WITH_NULL_SHA, >> SSL_RSA_WITH_NULL_MD5, TLS_KRB5_WITH_3DES_EDE_CBC_SHA, >> TLS_KRB5_WITH_3DES_EDE_CBC_MD5, TLS_KRB5_WITH_RC4_128_SHA, >> TLS_KRB5_WITH_RC4_128_MD5, TLS_KRB5_WITH_DES_CBC_SHA, >> TLS_KRB5_WITH_DES_CBC_MD5, TLS_KRB5_EXPORT_WITH_DES_CBC_40_SHA, >> TLS_KRB5_EXPORT_WITH_DES_CBC_40_MD5, TLS_KRB5_EXPORT_WITH_RC4_40_SHA, >> TLS_KRB5_EXPORT_WITH_RC4_40_MD5] >> 2015-09-10 20:27:09.090:DBUG:oejuc.AbstractLifeCycle:main: STARTED >> @538ms SslContextFactory@4c873330(null,null) >> 2015-09-10 20:27:09.091:DBUG:oejuc.AbstractLifeCycle:main: starting >> qtp558638686{STOPPED,8<=0<=200,i=0,q=0} >> 2015-09-10 20:27:09.093:DBUG:oejuc.AbstractLifeCycle:main: STARTED >> @541ms qtp558638686{STARTED,8<=8<=200,i=7,q=0} >> 2015-09-10 20:27:09.093:DBUG:oejuc.AbstractLifeCycle:main: starting >> org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@16b98e56 >> 2015-09-10 20:27:09.095:DBUG:oejuc.AbstractLifeCycle:main: STARTED >> @543ms org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@16b98e56 >> 2015-09-10 20:27:09.095:DBUG:oejuc.AbstractLifeCycle:main: starting >> org.eclipse.jetty.http2.client.HTTP2Client$ClientSelectorManager@12edcd21 >> 2015-09-10 20:27:09.100:DBUG:oejuc.AbstractLifeCycle:main: starting >> org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=-1 selected=-1 >> 2015-09-10 20:27:09.105:DBUG:oejuc.AbstractLifeCycle:main: STARTED >> @553ms org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=0 >> selected=0 >> 2015-09-10 20:27:09.106:DBUG:oejut.QueuedThreadPool:main: queue >> org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=0 selected=0 >> 2015-09-10 20:27:09.106:DBUG:oejuc.AbstractLifeCycle:main: STARTED >> @554ms >> org.eclipse.jetty.http2.client.HTTP2Client$ClientSelectorManager@12edcd21 >> 2015-09-10 20:27:09.106:DBUG:oejuc.AbstractLifeCycle:main: STARTED >> @554ms org.eclipse.jetty.http2.client.HTTP2Client@7229724f >> 2015-09-10 20:27:09.106:DBUG:oejut.QueuedThreadPool:qtp558638686-9: >> run org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=0 >> selected=0 >> 2015-09-10 20:27:09.106:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> execute >> 2015-09-10 20:27:09.106:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce enter >> 2015-09-10 20:27:09.106:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> producing >> 2015-09-10 20:27:09.107:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Selector loop waiting on select >> 2015-09-10 20:27:09.126:DBUG:oeji.ManagedSelector:main: Queued change >> org.eclipse.jetty.io.ManagedSelector$Connect@1b604f19 on >> org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=0 selected=0 >> 2015-09-10 20:27:09.127:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Selector loop woken up from select, 0/0 selected >> 2015-09-10 20:27:09.128:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Running change org.eclipse.jetty.io.ManagedSelector$Connect@1b604f19 >> 2015-09-10 20:27:09.128:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Selector loop waiting on select >> 2015-09-10 20:27:09.423:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Selector loop woken up from select, 1/1 selected >> 2015-09-10 20:27:09.426:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Connected true java.nio.channels.SocketChannel[connected >> local=/192.168.1.112:61635 remote=webtide.com/107.22.210.238:443] >> 2015-09-10 20:27:09.427:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produced org.eclipse.jetty.io.ManagedSelector$1@448427fb >> 2015-09-10 20:27:09.427:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> dispatch >> 2015-09-10 20:27:09.427:DBUG:oejut.QueuedThreadPool:qtp558638686-9: >> queue EPR >> Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.427:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> run org.eclipse.jetty.io.ManagedSelector$1@448427fb >> 2015-09-10 20:27:09.427:DBUG:oejut.QueuedThreadPool:qtp558638686-11: >> run EPR >> Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.427:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> run >> 2015-09-10 20:27:09.427:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce enter >> 2015-09-10 20:27:09.427:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> producing >> 2015-09-10 20:27:09.428:DBUG:oeji.ManagedSelector:qtp558638686-11: >> Selector loop waiting on select >> 2015-09-10 20:27:09.439:DBUG:oeji.AbstractEndPoint:qtp558638686-9: >> onOpen >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,8/30000,null}{io=0/0,kio=0,kro=8} >> 2015-09-10 20:27:09.440:DBUG:oeji.IdleTimeout:qtp558638686-9: >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,8/30000,null}{io=0/0,kio=0,kro=8} >> idle timeout check, elapsed: 8 ms, remaining: 29992 ms >> 2015-09-10 20:27:09.452:DBUG:oejus.SslContextFactory:qtp558638686-9: >> Customize 429dbc69[SSLEngine[hostname=webtide.com port=443] >> SSL_NULL_WITH_NULL_NULL] >> 2015-09-10 20:27:09.459:DBUG:oeji.IdleTimeout:qtp558638686-9: >> >> DecryptedEndPoint@332ed4b9{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,1/30000,null}->SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,28/30000,null}{io=0/0,kio=0,kro=8} >> idle timeout check, elapsed: 0 ms, remaining: 30000 ms >> 2015-09-10 20:27:09.470:DBUG:oeji.AbstractConnection:qtp558638686-9: >> onOpen SslConnection@7b60cff9{NEED_WRAP,eio=-1/-1,di=-1} -> >> ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.471:DBUG:oeji.AbstractConnection:qtp558638686-9: >> onOpen ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.471:DBUG:oejis.SslConnection:qtp558638686-9: >> SslConnection@7b60cff9{NEED_WRAP,eio=-1/-1,di=-1} -> >> ALPNClientConnection@2e633158 flush b[0]= >> 2015-09-10 20:27:09.472:DBUG:oejis.SslConnection:qtp558638686-9: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/220,di=-1} -> >> ALPNClientConnection@2e633158 wrap Status = OK HandshakeStatus = >> NEED_UNWRAP bytesConsumed = 0 bytesProduced = 220 >> 2015-09-10 20:27:09.475:DBUG:oejis.SslConnection:qtp558638686-9: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/220,di=-1} -> >> ALPNClientConnection@2e633158 wrap OK >> b[220]=16030300D7010000D3030355F24A0DB3A8B8C5A4D678244E6D...6964652E636F6D >> 2015-09-10 20:27:09.477:DBUG:oeji.ChannelEndPoint:qtp558638686-9: >> flushed 220 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,45/30000,SslConnection}{io=0/0,kio=0,kro=8} >> 2015-09-10 20:27:09.478:DBUG:oeji.ChannelEndPoint:qtp558638686-9: >> filled 0 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,1/30000,SslConnection}{io=0/0,kio=0,kro=8} >> 2015-09-10 20:27:09.478:DBUG:oejis.SslConnection:qtp558638686-9: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/0,di=0} -> >> ALPNClientConnection@2e633158 net=0 unwrap Status = BUFFER_UNDERFLOW >> HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 0 >> 2015-09-10 20:27:09.479:DBUG:oejis.SslConnection:qtp558638686-9: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/0,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.479:DBUG:oejut.QueuedThreadPool:qtp558638686-9: >> queue org.eclipse.jetty.io.ssl.SslConnection$1@3c8cca4c >> 2015-09-10 20:27:09.479:DBUG:oejut.QueuedThreadPool:qtp558638686-10: >> run org.eclipse.jetty.io.ssl.SslConnection$1@3c8cca4c >> 2015-09-10 20:27:09.479:DBUG:oeji.AbstractConnection:qtp558638686-9: >> fillInterested ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.479:DBUG:oeji.WriteFlusher:qtp558638686-10: >> completeWrite: WriteFlusher@372d28e5{IDLE} >> 2015-09-10 20:27:09.479:DBUG:oejut.QueuedThreadPool:qtp558638686-10: >> ran org.eclipse.jetty.io.ssl.SslConnection$1@3c8cca4c >> 2015-09-10 20:27:09.479:DBUG:oeji.FillInterest:qtp558638686-9: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> register AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.480:DBUG:oeji.FillInterest:qtp558638686-9: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> register AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.481:DBUG:oeji.AbstractConnection:qtp558638686-9: >> fillInterested SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} -> >> ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.481:DBUG:oeji.FillInterest:qtp558638686-9: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} register >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.481:DBUG:oeji.FillInterest:qtp558638686-9: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} register >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.482:DBUG:oeji.SelectChannelEndPoint:qtp558638686-9: >> changeInterests p=false 0->1 for >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=0/1,kio=0,kro=8} >> 2015-09-10 20:27:09.482:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Queued change >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=0/1,kio=0,kro=8}:runUpdateKey >> on org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=1 >> selected=0 >> 2015-09-10 20:27:09.483:DBUG:oeji.ManagedSelector:qtp558638686-11: >> Selector loop woken up from select, 0/1 selected >> 2015-09-10 20:27:09.482:DBUG:oeji.ManagedSelector:qtp558638686-9: >> Created >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,SslConnection}{io=0/1,kio=0,kro=8} >> 2015-09-10 20:27:09.483:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> ran org.eclipse.jetty.io.ManagedSelector$1@448427fb >> 2015-09-10 20:27:09.483:DBUG:oeji.ManagedSelector:qtp558638686-11: >> Running change >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,SslConnection}{io=0/1,kio=0,kro=8}:runUpdateKey >> 2015-09-10 20:27:09.483:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-9: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce exit >> 2015-09-10 20:27:09.483:DBUG:oejut.QueuedThreadPool:qtp558638686-9: >> ran org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=1 >> selected=0 >> 2015-09-10 20:27:09.483:DBUG:oeji.SelectChannelEndPoint:qtp558638686-11: >> Key interests updated 0 -> 1 on >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,SslConnection}{io=1/1,kio=1,kro=8} >> 2015-09-10 20:27:09.483:DBUG:oeji.ManagedSelector:qtp558638686-11: >> Selector loop waiting on select >> 2015-09-10 20:27:09.583:DBUG:oeji.ManagedSelector:qtp558638686-11: >> Selector loop woken up from select, 1/1 selected >> 2015-09-10 20:27:09.584:DBUG:oeji.SelectChannelEndPoint:qtp558638686-11: >> onSelected 1->0 r=true w=false for >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,103/30000,SslConnection}{io=1/0,kio=1,kro=1} >> 2015-09-10 20:27:09.584:DBUG:oeji.SelectChannelEndPoint:qtp558638686-11: >> task >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,103/30000,SslConnection}{io=1/0,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.585:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produced >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,104/30000,SslConnection}{io=1/0,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.585:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> dispatch >> 2015-09-10 20:27:09.585:DBUG:oejut.QueuedThreadPool:qtp558638686-11: >> queue EPR >> Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.585:DBUG:oejut.QueuedThreadPool:qtp558638686-15: >> run EPR >> Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.585:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> run >> 2015-09-10 20:27:09.585:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce enter >> 2015-09-10 20:27:09.585:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> producing >> 2015-09-10 20:27:09.585:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> run >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,104/30000,SslConnection}{io=1/0,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.585:DBUG:oeji.SelectChannelEndPoint:qtp558638686-15: >> Key interests updated 1 -> 0 on >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,104/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.586:DBUG:oeji.ManagedSelector:qtp558638686-15: >> Selector loop waiting on select >> 2015-09-10 20:27:09.585:DBUG:oeji.FillInterest:qtp558638686-11: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} fillable >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.586:DBUG:oejis.SslConnection:qtp558638686-11: >> onFillable enter >> >> DecryptedEndPoint@332ed4b9{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,107/30000,ALPNClientConnection}->SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,105/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.587:DBUG:oeji.FillInterest:qtp558638686-11: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> fillable AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.587:DBUG:oeji.ChannelEndPoint:qtp558638686-11: >> filled 5839 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,106/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.588:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_TASK,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=5839 unwrap Status = OK >> HandshakeStatus = NEED_TASK bytesConsumed = 5839 bytesProduced = 0 >> 2015-09-10 20:27:09.588:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_TASK,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.627:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=5839 unwrap Status = OK >> HandshakeStatus = NEED_WRAP bytesConsumed = 0 bytesProduced = 0 >> 2015-09-10 20:27:09.627:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.627:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 flush b[0]= >> 2015-09-10 20:27:09.628:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/75,di=0} -> >> ALPNClientConnection@2e633158 wrap Status = OK HandshakeStatus = >> NEED_WRAP bytesConsumed = 0 bytesProduced = 75 >> 2015-09-10 20:27:09.628:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/75,di=0} -> >> ALPNClientConnection@2e633158 wrap OK >> b[75]=16030300461000004241044389BD090550DA82AA9C056F4AC8...622F5E562E0FAD >> 2015-09-10 20:27:09.628:DBUG:oeji.ChannelEndPoint:qtp558638686-11: >> flushed 75 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,41/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.628:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/6,di=0} -> >> ALPNClientConnection@2e633158 wrap Status = OK HandshakeStatus = >> NEED_WRAP bytesConsumed = 0 bytesProduced = 6 >> 2015-09-10 20:27:09.628:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_WRAP,eio=0/6,di=0} -> >> ALPNClientConnection@2e633158 wrap OK b[6]=140303000101 >> 2015-09-10 20:27:09.629:DBUG:oeji.ChannelEndPoint:qtp558638686-11: >> flushed 6 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,1/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.629:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/45,di=0} -> >> ALPNClientConnection@2e633158 wrap Status = OK HandshakeStatus = >> NEED_UNWRAP bytesConsumed = 0 bytesProduced = 45 >> 2015-09-10 20:27:09.629:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/45,di=0} -> >> ALPNClientConnection@2e633158 wrap OK >> b[45]=1603030028000000000000000048531B1A3A09B3C7C9CAFB2D...C6D0F449381E8C >> 2015-09-10 20:27:09.629:DBUG:oeji.ChannelEndPoint:qtp558638686-11: >> flushed 45 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,0/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.629:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=5839 unwrap Status = >> BUFFER_UNDERFLOW HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 >> bytesProduced = 0 >> 2015-09-10 20:27:09.629:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.630:DBUG:oeji.ChannelEndPoint:qtp558638686-11: >> filled 0 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,1/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.630:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=0 unwrap Status = BUFFER_UNDERFLOW >> HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 0 >> 2015-09-10 20:27:09.630:DBUG:oejis.SslConnection:qtp558638686-11: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.630:DBUG:oeji.AbstractConnection:qtp558638686-11: >> fillInterested ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.630:DBUG:oeji.FillInterest:qtp558638686-11: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> register AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.631:DBUG:oeji.FillInterest:qtp558638686-11: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> register AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.631:DBUG:oeji.AbstractConnection:qtp558638686-11: >> fillInterested SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} -> >> ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.631:DBUG:oeji.FillInterest:qtp558638686-11: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} register >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.631:DBUG:oeji.FillInterest:qtp558638686-11: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} register >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.632:DBUG:oeji.SelectChannelEndPoint:qtp558638686-11: >> changeInterests p=false 0->1 for >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=0/1,kio=0,kro=1} >> 2015-09-10 20:27:09.632:DBUG:oeji.ManagedSelector:qtp558638686-11: >> Queued change >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey >> on org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=1 >> selected=0 >> 2015-09-10 20:27:09.632:DBUG:oejis.SslConnection:qtp558638686-11: >> onFillable exit >> >> DecryptedEndPoint@332ed4b9{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,ALPNClientConnection}->SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=0/1,kio=0,kro=1} >> 2015-09-10 20:27:09.633:DBUG:oeji.ManagedSelector:qtp558638686-15: >> Selector loop woken up from select, 0/1 selected >> 2015-09-10 20:27:09.633:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> ran >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,SslConnection}{io=0/1,kio=0,kro=1}:runFillable >> 2015-09-10 20:27:09.633:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-11: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce exit >> 2015-09-10 20:27:09.633:DBUG:oejut.QueuedThreadPool:qtp558638686-11: >> ran EPR >> Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.633:DBUG:oeji.ManagedSelector:qtp558638686-15: >> Running change >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey >> 2015-09-10 20:27:09.633:DBUG:oeji.SelectChannelEndPoint:qtp558638686-15: >> Key interests updated 0 -> 1 on >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,SslConnection}{io=1/1,kio=1,kro=1} >> 2015-09-10 20:27:09.634:DBUG:oeji.ManagedSelector:qtp558638686-15: >> Selector loop waiting on select >> 2015-09-10 20:27:09.730:DBUG:oeji.ManagedSelector:qtp558638686-15: >> Selector loop woken up from select, 1/1 selected >> 2015-09-10 20:27:09.730:DBUG:oeji.SelectChannelEndPoint:qtp558638686-15: >> onSelected 1->0 r=true w=false for >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,99/30000,SslConnection}{io=1/0,kio=1,kro=1} >> 2015-09-10 20:27:09.731:DBUG:oeji.SelectChannelEndPoint:qtp558638686-15: >> task >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,100/30000,SslConnection}{io=1/0,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.731:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produced >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,100/30000,SslConnection}{io=1/0,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.731:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> dispatch >> 2015-09-10 20:27:09.731:DBUG:oejut.QueuedThreadPool:qtp558638686-15: >> queue EPR >> Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.732:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> run >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,101/30000,SslConnection}{io=1/0,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.732:DBUG:oejut.QueuedThreadPool:qtp558638686-16: >> run EPR >> Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> 2015-09-10 20:27:09.732:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-16: >> EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> run >> 2015-09-10 20:27:09.732:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-16: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce enter >> 2015-09-10 20:27:09.732:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-16: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> producing >> 2015-09-10 20:27:09.732:DBUG:oeji.FillInterest:qtp558638686-15: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} fillable >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NEED_UNWRAP,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.732:DBUG:oeji.SelectChannelEndPoint:qtp558638686-16: >> Key interests updated 1 -> 0 on >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,101/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.733:DBUG:oeji.ManagedSelector:qtp558638686-16: >> Selector loop waiting on select >> 2015-09-10 20:27:09.732:DBUG:oejis.SslConnection:qtp558638686-15: >> onFillable enter >> >> DecryptedEndPoint@332ed4b9{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,103/30000,ALPNClientConnection}->SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,102/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.733:DBUG:oeji.FillInterest:qtp558638686-15: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> fillable AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.733:DBUG:oeji.ChannelEndPoint:qtp558638686-15: >> filled 51 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,102/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.734:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=45/-1,di=0} -> >> ALPNClientConnection@2e633158 net=51 unwrap Status = OK >> HandshakeStatus = NEED_UNWRAP bytesConsumed = 6 bytesProduced = 0 >> 2015-09-10 20:27:09.734:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NEED_UNWRAP,eio=45/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.736:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=51 unwrap Status = OK >> HandshakeStatus = FINISHED bytesConsumed = 45 bytesProduced = 0 >> 2015-09-10 20:27:09.736:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.736:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 client handshook >> TLSv1.2/TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 >> 2015-09-10 20:27:09.736:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=51 unwrap Status = BUFFER_UNDERFLOW >> HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 0 bytesProduced = 0 >> 2015-09-10 20:27:09.736:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.736:DBUG:oeji.ChannelEndPoint:qtp558638686-15: >> filled 0 >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,-,-,2/30000,SslConnection}{io=0/0,kio=0,kro=1} >> 2015-09-10 20:27:09.737:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 net=0 unwrap Status = BUFFER_UNDERFLOW >> HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 0 bytesProduced = 0 >> 2015-09-10 20:27:09.737:DBUG:oejis.SslConnection:qtp558638686-15: >> SslConnection@7b60cff9{NOT_HANDSHAKING,eio=0/-1,di=0} -> >> ALPNClientConnection@2e633158 filled b[0]= >> 2015-09-10 20:27:09.737:DBUG:oeji.AbstractConnection:qtp558638686-15: >> fillInterested ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.737:DBUG:oeji.FillInterest:qtp558638686-15: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> register AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.737:DBUG:oeji.FillInterest:qtp558638686-15: >> >> FillInterest@61eb0ae6{true,AC.ReadCB@2e633158{ALPNClientConnection@2e633158}} >> register AC.ReadCB@2e633158{ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.737:DBUG:oeji.AbstractConnection:qtp558638686-15: >> fillInterested SslConnection@7b60cff9{NOT_HANDSHAKING,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158 >> 2015-09-10 20:27:09.738:DBUG:oeji.FillInterest:qtp558638686-15: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NOT_HANDSHAKING,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} register >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NOT_HANDSHAKING,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.738:DBUG:oeji.FillInterest:qtp558638686-15: >> >> FillInterest@28d452a7{true,AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NOT_HANDSHAKING,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158}} register >> AC.ReadCB@7b60cff9{SslConnection@7b60cff9{NOT_HANDSHAKING,eio=-1/-1,di=-1} >> -> ALPNClientConnection@2e633158} >> 2015-09-10 20:27:09.738:DBUG:oeji.SelectChannelEndPoint:qtp558638686-15: >> changeInterests p=false 0->1 for >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,0/30000,SslConnection}{io=0/1,kio=0,kro=1} >> 2015-09-10 20:27:09.738:DBUG:oeji.ManagedSelector:qtp558638686-15: >> Queued change >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,0/30000,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey >> on org.eclipse.jetty.io.ManagedSelector@32d992b2 id=0 keys=1 >> selected=0 >> 2015-09-10 20:27:09.739:DBUG:oeji.ManagedSelector:qtp558638686-16: >> Selector loop woken up from select, 0/1 selected >> 2015-09-10 20:27:09.739:DBUG:oeji.ManagedSelector:qtp558638686-16: >> Running change >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey >> 2015-09-10 20:27:09.739:DBUG:oejis.SslConnection:qtp558638686-15: >> onFillable exit >> >> DecryptedEndPoint@332ed4b9{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,2/30000,ALPNClientConnection}->SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=1/1,kio=0,kro=1} >> 2015-09-10 20:27:09.739:DBUG:oeji.SelectChannelEndPoint:qtp558638686-16: >> Key interests updated 0 -> 1 on >> >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=1/1,kio=1,kro=1} >> 2015-09-10 20:27:09.739:DBUG:oeji.ManagedSelector:qtp558638686-16: >> Selector loop waiting on select >> 2015-09-10 20:27:09.739:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> ran >> SelectChannelEndPoint@5bfdd059{webtide.com/107.22.210.238:443<->61635,Open,in,out,R,-,1/30000,SslConnection}{io=1/1,kio=1,kro=1}:runFillable >> 2015-09-10 20:27:09.739:DBUG:oejuts.ExecuteProduceConsume:qtp558638686-15: >> EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> produce exit >> 2015-09-10 20:27:09.739:DBUG:oejut.QueuedThreadPool:qtp558638686-15: >> ran EPR >> Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@6f1f1d7f >> Exception in thread "main" java.util.concurrent.TimeoutException >> at org.eclipse.jetty.util.FuturePromise.get(FuturePromise.java:130) >> at org.eclipse.jetty.http2.client.Client.main(Client.java:55) >> >> >> Thanks, >> >> Mike >> _______________________________________________ >> jetty-users mailing list >> [email protected] >> To change your delivery options, retrieve your password, or unsubscribe >> from this list, visit >> https://dev.eclipse.org/mailman/listinfo/jetty-users > > > > _______________________________________________ > jetty-users mailing list > [email protected] > To change your delivery options, retrieve your password, or unsubscribe from > this list, visit > https://dev.eclipse.org/mailman/listinfo/jetty-users _______________________________________________ jetty-users mailing list [email protected] To change your delivery options, retrieve your password, or unsubscribe from this list, visit https://dev.eclipse.org/mailman/listinfo/jetty-users
