Skip to main content

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
Re: [jetty-users] WebSocket over SSL in Embedded Jetty 9

Oh, you meant to run my client with

-Dorg.eclipse.jetty.LEVEL=DEBUG -Djavax.net.debug=ssl

I am attaching the log files (now there are exceptions for some reason too).

(CC-ing you Simone in case the mailing list removes the file attachments)

Regards
Alex


On Thu, Jun 23, 2016 at 1:14 PM, Simone Bordet <sbordet@xxxxxxxxxxx> wrote:

It shows the client had a problem during the TLS handshake.

Can you please enable DEBUG logging for "org.eclipse.jetty" for the
client and *attach* the logs ?

Do you have exceptions on the server ?


C:\Users\user1\jetty-newbie\WssClient>util_win.bat wss://127.0.0.1:8443

Active code page: 65001
Picked up JAVA_TOOL_OPTIONS: -Dfile.encoding=UTF8
2016-06-23 15:41:13.527:INFO::main: Logging initialized @203ms
2016-06-23 15:41:13.558:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {SslContextFactory@58372a00(null,null),AUTO}
2016-06-23 15:41:13.558:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {org.eclipse.jetty.io.MappedByteBufferPool@4dd8dc3,POJ
O}
2016-06-23 15:41:13.573:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:13.573:DBUG:oejwc.WebSocketClient:main: Starting org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:13.589:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {org.eclipse.jetty.util.thread.ScheduledExecutorSchedu
ler@1a6c5a9e,AUTO}
2016-06-23 15:41:13.589:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {org.eclipse.jetty.util.HttpCookieStore$Empty@254989ff
,POJO}
2016-06-23 15:41:13.589:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {org.eclipse.jetty.websocket.common.WebSocketSessionFa
ctory@49c2faae,POJO}
2016-06-23 15:41:13.589:DBUG:oejuc.AbstractLifeCycle:main: starting SslContextFactory@58372a00(null,null)
2016-06-23 15:41:13.589:DBUG:oejus.SslContextFactory:main: No keystore or trust store configured.  ACCEPTING UNTRUSTED CERTIFICATES!!!!!
trigger seeding of SecureRandom
done seeding SecureRandom
Using SSLEngineImpl.
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_DH_anon_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DH_anon_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_anon_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_DH_anon_WITH_AES_256_GCM_SHA384
2016-06-23 15:41:14.073:DBUG:oejus.SslContextFactory:main: Selected Protocols [TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_DH_anon_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DH_anon_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_anon_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_DH_anon_WITH_AES_256_GCM_SHA384
2016-06-23 15:41:14.135: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_ECDH_ECDSA_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, TL
S_ECDHE_ECDSA_WITH_3DES_EDE_CBC_SHA, TLS_ECDH_ECDSA_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_CB
C_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_AE
S_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_AE
S_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_WI
TH_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_WI
TH_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, SSL_RSA_WITH_DE
S_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_D
HE_DSS_EXPORT_WITH_DES40_CBC_SHA, SSL_DH_anon_EXPORT_WITH_DES40_CBC_SHA, 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_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]
2016-06-23 15:41:14.166:DBUG:oejuc.AbstractLifeCycle:main: STARTED @845ms SslContextFactory@58372a00(null,null)
2016-06-23 15:41:14.182:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@1a6c5a9e
2016-06-23 15:41:14.182:DBUG:oejuc.AbstractLifeCycle:main: STARTED @854ms org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@1a6c5a9e
2016-06-23 15:41:14.182:DBUG:oejwc.WebSocketClient:main: Started org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:14.182:DBUG:oejuc.AbstractLifeCycle:main: STARTED @858ms org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:14.197:DBUG:oejwc.WebSocketClient:main: connect websocket de.afarber.wssclient.MyListener@20e2cbe0 to wss://127.0.0.1:8443
2016-06-23 15:41:14.213:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {WebSocketClient@1989780873{STOPPED,8<=0<=200,i=0,q=0}
,MANAGED}
2016-06-23 15:41:14.213:DBUG:oejuc.AbstractLifeCycle:main: starting WebSocketClient@1989780873{STOPPED,8<=0<=200,i=0,q=0}
2016-06-23 15:41:14.213:DBUG:oejuc.AbstractLifeCycle:main: STARTED @887ms WebSocketClient@1989780873{STARTED,8<=8<=200,i=7,q=0}
2016-06-23 15:41:14.213:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.WebSocketClient@7699a589 added {org.eclipse.jetty.websocket.client.io.ConnectionManag
er@4501b7af,MANAGED}
2016-06-23 15:41:14.229:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.websocket.client.io.ConnectionManager@4501b7af
2016-06-23 15:41:14.229:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.io.ConnectionManager@4501b7af added {org.eclipse.jetty.websocket.client.io.WebSocketC
lientSelectorManager@77caeb3e,AUTO}
2016-06-23 15:41:14.229:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.websocket.client.io.WebSocketClientSelectorManager@77caeb3e
2016-06-23 15:41:14.244:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.io.WebSocketClientSelectorManager@77caeb3e added {org.eclipse.jetty.io.ManagedSelecto
r@6a41eaa2 id=0 keys=-1 selected=-1,AUTO}
2016-06-23 15:41:14.244:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.client.io.WebSocketClientSelectorManager@77caeb3e added {org.eclipse.jetty.io.ManagedSelecto
r@7cd62f43 id=1 keys=-1 selected=-1,AUTO}
2016-06-23 15:41:14.244:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=-1 selected=-1
2016-06-23 15:41:14.260:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:14.275:DBUG:oejuc.AbstractLifeCycle:main: STARTED @941ms org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:14.275:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-11: run org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:14.275:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=-1 selected=-1
2016-06-23 15:41:14.275:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d execute
2016-06-23 15:41:14.275:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:14.275:DBUG:oejuc.AbstractLifeCycle:main: STARTED @954ms org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:14.275:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produce enter
2016-06-23 15:41:14.291:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d producing
2016-06-23 15:41:14.291:DBUG:oejuc.AbstractLifeCycle:main: STARTED @956ms org.eclipse.jetty.websocket.client.io.WebSocketClientSelectorManager@77caeb3e
2016-06-23 15:41:14.275:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-12: run org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:14.291:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-12: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@4166316 execute
2016-06-23 15:41:14.291:DBUG:oejuc.AbstractLifeCycle:main: STARTED @964ms org.eclipse.jetty.websocket.client.io.ConnectionManager@4501b7af
2016-06-23 15:41:14.291:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Selector loop waiting on select
2016-06-23 15:41:14.291:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-12: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@4166316 produce enter
2016-06-23 15:41:14.307:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-12: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@4166316 producing
2016-06-23 15:41:14.307:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Selector loop waiting on select
2016-06-23 15:41:14.307:DBUG:oejwc.WebSocketClient:main: Connect Promise: FutureCallback@6500df86{false,false,null}
2016-06-23 15:41:14.322:DBUG:oejut.QueuedThreadPool:main: queue FutureCallback@6500df86{false,false,null}
2016-06-23 15:41:14.322:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-13: run FutureCallback@6500df86{false,false,null}
2016-06-23 15:41:14.322:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-13: Queued change org.eclipse.jetty.io.ManagedSelector$Connect@73ad0028 on org.eclipse.jetty.io.Managed
Selector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:14.338:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:14.338:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-13: ran FutureCallback@6500df86{false,false,null}
2016-06-23 15:41:14.338:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Running change org.eclipse.jetty.io.ManagedSelector$Connect@73ad0028
2016-06-23 15:41:14.338:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Selector loop waiting on select
2016-06-23 15:41:14.338:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Selector loop woken up from select, 1/1 selected
2016-06-23 15:41:14.353:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Connected true java.nio.channels.SocketChannel[connected local=/127.0.0.1:57661 remote=/127.0.0.1:8
443]
2016-06-23 15:41:14.353:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produced org.eclips
e.jetty.io.ManagedSelector$1@165a9494
2016-06-23 15:41:14.353:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d dispatch
2016-06-23 15:41:14.353:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-11: queue EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d
2016-06-23 15:41:14.369:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d run org.eclipse.jet
ty.io.ManagedSelector$1@165a9494
2016-06-23 15:41:14.369:DBUG:oejwci.WebSocketClientSelectorManager:WebSocketClient@1989780873-11: newEndPoint(java.nio.channels.SocketChannel[connected local=/127.0.0.1:57661 remot
e=/127.0.0.1:8443], org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=1 selected=1, sun.nio.ch.SelectionKeyImpl@44f8702a)
2016-06-23 15:41:14.369:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-14: run EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d
2016-06-23 15:41:14.400:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d run
2016-06-23 15:41:14.400:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produce enter
2016-06-23 15:41:14.416:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d producing
2016-06-23 15:41:14.400:DBUG:oeji.AbstractEndPoint:WebSocketClient@1989780873-11: onOpen SelectChannelEndPoint@2e9d560a{/127.0.0.1:8443<->57661,Open,in,out,-,-,15/300000,null@0}{io
=0/0,kio=0,kro=8}
2016-06-23 15:41:14.416:DBUG:oeji.IdleTimeout:WebSocketClient@1989780873-11: SelectChannelEndPoint@2e9d560a{/127.0.0.1:8443<->57661,Open,in,out,-,-,31/300000,null@0}{io=0/0,kio=0,k
ro=8} idle timeout check, elapsed: 31 ms, remaining: 299969 ms
2016-06-23 15:41:14.416:DBUG:oejwci.WebSocketClientSelectorManager:WebSocketClient@1989780873-11: newConnection(java.nio.channels.SocketChannel[connected local=/127.0.0.1:57661 rem
ote=/127.0.0.1:8443],SelectChannelEndPoint@2e9d560a{/127.0.0.1:8443<->57661,Open,in,out,-,-,31/300000,null@0}{io=0/0,kio=0,kro=8},FutureCallback@6500df86{false,false,null})
2016-06-23 15:41:14.416:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-14: Selector loop waiting on select
Using SSLEngineImpl.
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDH_RSA_WITH_AES_256_GCM_SHA384
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA384
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_DHE_DSS_WITH_AES_256_CBC_SHA256
Ignoring unavailable cipher suite: TLS_DHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA
Ignoring unavailable cipher suite: TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384
2016-06-23 15:41:14.478:DBUG:oejus.SslContextFactory:WebSocketClient@1989780873-11: Customize 539458e3[SSLEngine[hostname=127.0.0.1 port=8443] SSL_NULL_WITH_NULL_NULL]
2016-06-23 15:41:14.494:DBUG:oeji.AbstractConnection:WebSocketClient@1989780873-11: onOpen SslConnection@14f4f541{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355[Dec
ryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,0/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,
in,out,-,-,109/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}]
2016-06-23 15:41:14.509:DBUG:oeji.AbstractConnection:WebSocketClient@1989780873-11: onOpen UpgradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Op
en,in,out,-,-,15/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,124/300000,SslConnection@14f4f541}{io=0/0,kio=0
,kro=8}]
2016-06-23 15:41:14.509:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-11: queue FutureCallback@5edaeb21{false,false}
2016-06-23 15:41:14.509:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-15: run FutureCallback@5edaeb21{false,false}
2016-06-23 15:41:14.509:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-11: Created SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,124/300000,
SslConnection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.525:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-15: write: WriteFlusher@2ecd4a5a{IDLE} [HeapByteBuffer@200ab02b[p=0,l=196,c=196,r=196]={<<<GET / HTTP/1.1\
r\nH...l: no-cache\r\n\r\n>>>}]
2016-06-23 15:41:14.525:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d ran org.eclipse.jet
ty.io.ManagedSelector$1@165a9494
2016-06-23 15:41:14.525:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-15: update WriteFlusher@2ecd4a5a{WRITING}:IDLE-->WRITING
2016-06-23 15:41:14.525:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-11: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produce exit
2016-06-23 15:41:14.541:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-11: ran org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=1 selected=0
2016-06-23 15:41:14.541:DBUG:oejis.SslConnection:WebSocketClient@1989780873-15: SslConnection@14f4f541{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPo
int@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,W,47/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-
,156/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] flush b[196]=474554202F20485454502F312E310D0A486F73743A20313237...6368650D0A0D0A
Allow unsafe renegotiation: false
Allow legacy hello messages: true
Is initial handshake: true
Is secure renegotiation: false
Ignoring unsupported cipher suite: TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_RSA_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_ECDH_ECDSA_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_ECDH_RSA_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_DHE_RSA_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_DHE_DSS_WITH_AES_128_CBC_SHA256 for TLSv1
Ignoring unsupported cipher suite: TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA256 for TLSv1.1
Ignoring unsupported cipher suite: TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA256 for TLSv1.1
Ignoring unsupported cipher suite: TLS_RSA_WITH_AES_128_CBC_SHA256 for TLSv1.1
Ignoring unsupported cipher suite: TLS_ECDH_ECDSA_WITH_AES_128_CBC_SHA256 for TLSv1.1
Ignoring unsupported cipher suite: TLS_ECDH_RSA_WITH_AES_128_CBC_SHA256 for TLSv1.1
Ignoring unsupported cipher suite: TLS_DHE_RSA_WITH_AES_128_CBC_SHA256 for TLSv1.1
Ignoring unsupported cipher suite: TLS_DHE_DSS_WITH_AES_128_CBC_SHA256 for TLSv1.1
%% No cached client session
*** ClientHello, TLSv1.2
RandomCookie:  GMT: 1466623482 bytes = { 220, 161, 20, 86, 110, 198, 107, 30, 187, 123, 154, 212, 125, 190, 143, 42, 125, 64, 98, 48, 120, 102, 226, 63, 89, 42, 114, 4 }
Session ID:  {}
Cipher Suites: [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_RS
A_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_ECDH_ECDSA_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_SHA25
6, 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_ECDH_ECDSA_WITH_3DES_E
DE_CBC_SHA, SSL_DHE_DSS_WITH_3DES_EDE_CBC_SHA, TLS_EMPTY_RENEGOTIATION_INFO_SCSV]
Compression Methods:  { 0 }
Extension elliptic_curves, curve names: {secp256r1, sect163k1, sect163r2, secp192r1, secp224r1, sect233k1, sect233r1, sect283k1, sect283r1, secp384r1, sect409k1, sect409r1, secp521
r1, sect571k1, sect571r1, secp160k1, secp160r1, secp160r2, sect163r1, secp192k1, sect193r1, sect193r2, secp224k1, sect239k1, secp256k1}
Extension ec_point_formats, formats: [uncompressed]
Extension signature_algorithms, signature_algorithms: SHA512withECDSA, SHA512withRSA, SHA384withECDSA, SHA384withRSA, SHA256withECDSA, SHA256withRSA, SHA224withECDSA, SHA224withRSA
, SHA1withECDSA, SHA1withRSA, SHA1withDSA, MD5withRSA
***
WebSocketClient@1989780873-15, WRITE: TLSv1.2 Handshake, length = 179
2016-06-23 15:41:14.665:DBUG:oejis.SslConnection:WebSocketClient@1989780873-15: SslConnection@14f4f541{NEED_UNWRAP,eio=-1/184,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPoint
@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,W,171/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,2
80/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] wrap Status = OK HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 184
2016-06-23 15:41:14.665:DBUG:oejis.SslConnection:WebSocketClient@1989780873-15: SslConnection@14f4f541{NEED_UNWRAP,eio=-1/184,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPoint
@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,W,171/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,2
80/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] wrap OK b[184]=16030300B3010000AF0303576BE6FADCA114566EC66B1EBB7B...03020102020101
2016-06-23 15:41:14.681:DBUG:oeji.ChannelEndPoint:WebSocketClient@1989780873-15: flushed 184 SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,296/300
000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.681:DBUG:oeji.ChannelEndPoint:WebSocketClient@1989780873-15: filled -1 SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,0/300000,
SslConnection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.681:DBUG:oeji.ChannelEndPoint:WebSocketClient@1989780873-15: ishut SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,-,16/300000,Ssl
Connection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.697:DBUG:oejis.SslConnection:WebSocketClient@1989780873-15: SslConnection@14f4f541{NEED_UNWRAP,eio=0/0,di=0} -> UpgradeConnection@4d726355[DecryptedEndPoint@4c2
2bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,W,203/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,-,16
/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] net=-1 unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 0
2016-06-23 15:41:14.697:DBUG:oejis.SslConnection:WebSocketClient@1989780873-15: SslConnection@14f4f541{NEED_UNWRAP,eio=0/0,di=0} -> UpgradeConnection@4d726355[DecryptedEndPoint@4c2
2bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,in,out,-,W,203/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,-,16
/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] filled b[0]=
WebSocketClient@1989780873-15, called closeInbound()
WebSocketClient@1989780873-15, fatal error: 80: Inbound closed before receiving peer's close_notify: possible truncation attack?
javax.net.ssl.SSLException: Inbound closed before receiving peer's close_notify: possible truncation attack?
WebSocketClient@1989780873-15, SEND TLSv1.2 ALERT:  fatal, description = internal_error
WebSocketClient@1989780873-15, WRITE: TLSv1.2 Alert, length = 2
2016-06-23 15:41:14.728:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-15: queue org.eclipse.jetty.io.ssl.SslConnection$1@7a5bf222
2016-06-23 15:41:14.728:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-16: run org.eclipse.jetty.io.ssl.SslConnection$1@7a5bf222
2016-06-23 15:41:14.728:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-16: completeWrite: WriteFlusher@2ecd4a5a{WRITING}
2016-06-23 15:41:14.728:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-16: ran org.eclipse.jetty.io.ssl.SslConnection$1@7a5bf222
2016-06-23 15:41:14.728:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-15: Flushed=false 0/196+0 WriteFlusher@2ecd4a5a{WRITING}
2016-06-23 15:41:14.728:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-15: !fully flushed WriteFlusher@2ecd4a5a{WRITING}
2016-06-23 15:41:14.728:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-15: flushed incomplete
2016-06-23 15:41:14.743:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-15: update WriteFlusher@2ecd4a5a{PENDING}:WRITING-->PENDING
2016-06-23 15:41:14.743:DBUG:oejis.SslConnection:WebSocketClient@1989780873-15: onIncompleteFlush SslConnection@14f4f541{NEED_WRAP,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355[De
cryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,P,249/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661
,Open,ISHUT,out,-,-,62/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}]
2016-06-23 15:41:14.743:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-15: queue org.eclipse.jetty.io.ssl.SslConnection$1@7a5bf222
2016-06-23 15:41:14.743:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-17: run org.eclipse.jetty.io.ssl.SslConnection$1@7a5bf222
2016-06-23 15:41:14.743:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-15: ran FutureCallback@5edaeb21{false,false}
2016-06-23 15:41:14.759:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: completeWrite: WriteFlusher@2ecd4a5a{PENDING}
2016-06-23 15:41:14.759:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: update WriteFlusher@2ecd4a5a{COMPLETING}:PENDING-->COMPLETING
2016-06-23 15:41:14.759:DBUG:oejis.SslConnection:WebSocketClient@1989780873-17: SslConnection@14f4f541{NEED_WRAP,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPoint@4c
22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,C,265/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,
-,78/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] flush b[196]=474554202F20485454502F312E310D0A486F73743A20313237...6368650D0A0D0A
2016-06-23 15:41:14.775:DBUG:oejis.SslConnection:WebSocketClient@1989780873-17: SslConnection@14f4f541{NEED_UNWRAP,eio=-1/7,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPoint@4
c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,OSHUT,-,C,281/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out
,-,-,94/300000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}] wrap Status = CLOSED HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 7
2016-06-23 15:41:14.775:DBUG:oeji.ChannelEndPoint:WebSocketClient@1989780873-17: flushed 7 SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,-,94/300
000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.775:DBUG:oeji.ChannelEndPoint:WebSocketClient@1989780873-17: oshut SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,Open,ISHUT,out,-,-,0/300000,S
slConnection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.790:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: ignored: WriteFlusher@5299068e{IDLE} java.nio.channels.ClosedChannelException
2016-06-23 15:41:14.790:DBUG:oeji.ChannelEndPoint:WebSocketClient@1989780873-17: close SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,-,15/300
000,SslConnection@14f4f541}{io=0/0,kio=0,kro=8}
2016-06-23 15:41:14.790:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-17: Queued change org.eclipse.jetty.io.ManagedSelector$2@1d63e896 on org.eclipse.jetty.io.ManagedSelect
or@6a41eaa2 id=0 keys=1 selected=0
2016-06-23 15:41:14.790:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: Flushed=false 0/196+0 WriteFlusher@2ecd4a5a{COMPLETING}
2016-06-23 15:41:14.806:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-14: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:14.806:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: !fully flushed WriteFlusher@2ecd4a5a{COMPLETING}
2016-06-23 15:41:14.806:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produced org.eclips
e.jetty.io.ManagedSelector$2@1d63e896
2016-06-23 15:41:14.806:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: flushed incomplete [HeapByteBuffer@200ab02b[p=0,l=196,c=196,r=196]={<<<GET / HTTP/1.1\r\nH...l: no-cac
he\r\n\r\n>>>}]
2016-06-23 15:41:14.806:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d dispatch
2016-06-23 15:41:14.821:DBUG:oeji.WriteFlusher:WebSocketClient@1989780873-17: update WriteFlusher@2ecd4a5a{PENDING}:COMPLETING-->PENDING
2016-06-23 15:41:14.821:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-14: queue EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d
2016-06-23 15:41:14.821:DBUG:oejis.SslConnection:WebSocketClient@1989780873-17: onIncompleteFlush SslConnection@14f4f541{NEED_UNWRAP,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355[
DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,327/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<-
>57661,CLOSED,ISHUT,OSHUT,-,-,46/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}]
2016-06-23 15:41:14.821:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-18: run EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d
2016-06-23 15:41:14.821:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-18: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d run
2016-06-23 15:41:14.837:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-18: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produce enter
2016-06-23 15:41:14.821:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d run org.eclipse.jet
ty.io.ManagedSelector$2@1d63e896
2016-06-23 15:41:14.837:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-18: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d producing
2016-06-23 15:41:14.837:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Selector loop waiting on select
2016-06-23 15:41:14.821:DBUG:oeji.AbstractConnection:WebSocketClient@1989780873-17: fillInterested SslConnection@14f4f541{NEED_UNWRAP,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355
[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,327/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<
->57661,CLOSED,ISHUT,OSHUT,-,-,46/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}]
2016-06-23 15:41:14.837:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-14: Destroyed SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,-,62
/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}
2016-06-23 15:41:14.853:DBUG:oeji.FillInterest:WebSocketClient@1989780873-17: FillInterest@7d430c2{true,AC.ReadCB@14f4f541{SslConnection@14f4f541{NEED_UNWRAP,eio=-1/-1,di=-1} -> Up
gradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,359/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{1
27.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,0/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}]}} register AC.ReadCB@14f4f541{SslConnection@14f4f541{NEED_UNWRAP,eio
=-1/-1,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,359/300000,UpgradeConnection@4d726355}->SelectChannel
EndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,0/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}]}
2016-06-23 15:41:14.853:DBUG:oejwci.UpgradeConnection:WebSocketClient@1989780873-14: Closed connection UpgradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:844
3<->57661,CLOSED,ISHUT,OSHUT,-,P,359/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,0/300000,SslConnect
ion@14f4f541}{io=0/0,kio=-1,kro=-1}]
2016-06-23 15:41:14.868:DBUG:oeji.FillInterest:WebSocketClient@1989780873-17: FillInterest@7d430c2{true,AC.ReadCB@14f4f541{SslConnection@14f4f541{NEED_UNWRAP,eio=-1/-1,di=-1} -> Up
gradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,374/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{1
27.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,15/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}]}} register AC.ReadCB@14f4f541{SslConnection@14f4f541{NEED_UNWRAP,ei
o=-1/-1,di=-1} -> UpgradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,374/300000,UpgradeConnection@4d726355}->SelectChanne
lEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,15/300000,SslConnection@14f4f541}{io=0/0,kio=-1,kro=-1}]}
2016-06-23 15:41:14.868:DBUG:oeji.AbstractConnection:WebSocketClient@1989780873-14: onClose UpgradeConnection@4d726355[DecryptedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,C
LOSED,ISHUT,OSHUT,-,P,374/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,15/300000,SslConnection@14f4f5
41}{io=0/0,kio=-1,kro=-1}]
2016-06-23 15:41:14.884:DBUG:oeji.SelectChannelEndPoint:WebSocketClient@1989780873-17: changeInterests p=false 0->1 for SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57
661,CLOSED,ISHUT,OSHUT,FI,-,31/300000,SslConnection@14f4f541}{io=0/1,kio=-1,kro=-1}
2016-06-23 15:41:14.884:DBUG:oeji.AbstractConnection:WebSocketClient@1989780873-14: onClose SslConnection@14f4f541{NEED_UNWRAP,eio=-1/-1,di=-1} -> UpgradeConnection@4d726355[Decryp
tedEndPoint@4c22bcf3{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,-,P,390/300000,UpgradeConnection@4d726355}->SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661
,CLOSED,ISHUT,OSHUT,FI,-,31/300000,SslConnection@14f4f541}{io=0/1,kio=-1,kro=-1}]
2016-06-23 15:41:14.899:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-17: Queued change SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI
,-,46/300000,SslConnection@14f4f541}{io=0/1,kio=-1,kro=-1}:runUpdateKey on org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:14.899:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d ran org.eclipse.jet
ty.io.ManagedSelector$2@1d63e896
2016-06-23 15:41:14.899:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:14.899:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-17: ran org.eclipse.jetty.io.ssl.SslConnection$1@7a5bf222
2016-06-23 15:41:14.915:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Running change SelectChannelEndPoint@2e9d560a{127.0.0.1/127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,F
I,-,62/300000,SslConnection@14f4f541}{io=0/1,kio=-1,kro=-1}:runUpdateKey
2016-06-23 15:41:14.915:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produce exit
2016-06-23 15:41:14.915:DBUG:oeji.SelectChannelEndPoint:WebSocketClient@1989780873-18: Ignoring key update for concurrently closed channel SelectChannelEndPoint@2e9d560a{127.0.0.1/
127.0.0.1:8443<->57661,CLOSED,ISHUT,OSHUT,FI,-,62/300000,SslConnection@14f4f541}{io=1/1,kio=-1,kro=-1}
2016-06-23 15:41:14.915:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-14: ran EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d
2016-06-23 15:41:14.931:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Selector loop waiting on select
2016-06-23 15:41:19.333:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:19.333:DBUG:oejwc.WebSocketClient:main: Stopping org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:19.333:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.websocket.client.io.ConnectionManager@4501b7af
2016-06-23 15:41:19.333:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.websocket.client.io.WebSocketClientSelectorManager@77caeb3e
2016-06-23 15:41:19.333:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:19.333:DBUG:oeji.ManagedSelector:main: Stopping org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:19.349:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@4cf777e8 on org.eclipse.jetty.io.ManagedSelector@7cd62f43
id=1 keys=0 selected=0
2016-06-23 15:41:19.349:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:19.349:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Running change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@4cf777e8
2016-06-23 15:41:19.349:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Closing 0 endPoints on org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:19.364:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Closed 0 endPoints on org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=0 selected=0
2016-06-23 15:41:19.364:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Selector loop waiting on select
2016-06-23 15:41:19.364:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$CloseSelector@73ad2d6 on org.eclipse.jetty.io.ManagedSelector@7cd62f43 id
=1 keys=0 selected=0
2016-06-23 15:41:19.364:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:19.364:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-12: Running change org.eclipse.jetty.io.ManagedSelector$CloseSelector@73ad2d6
2016-06-23 15:41:19.364:DBUG:oeji.ManagedSelector:main: Stopped org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=-1 selected=-1
2016-06-23 15:41:19.364:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-12: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@4166316 produced null
2016-06-23 15:41:19.380:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=-1 selected=-1
2016-06-23 15:41:19.380:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:19.380:DBUG:oeji.ManagedSelector:main: Stopping org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:19.380:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@7085bdee on org.eclipse.jetty.io.ManagedSelector@6a41eaa2
id=0 keys=0 selected=0
2016-06-23 15:41:19.380:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-12: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@4166316 produce exit
2016-06-23 15:41:19.395:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-12: ran org.eclipse.jetty.io.ManagedSelector@7cd62f43 id=1 keys=-1 selected=-1
2016-06-23 15:41:19.380:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:19.395:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Running change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@7085bdee
2016-06-23 15:41:19.395:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Closing 0 endPoints on org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:19.395:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Closed 0 endPoints on org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=0 selected=0
2016-06-23 15:41:19.411:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Selector loop waiting on select
2016-06-23 15:41:19.395:DBUG:oeji.ManagedSelector:main: Queued change org.eclipse.jetty.io.ManagedSelector$CloseSelector@1ce92674 on org.eclipse.jetty.io.ManagedSelector@6a41eaa2 i
d=0 keys=0 selected=0
2016-06-23 15:41:19.411:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:19.411:DBUG:oeji.ManagedSelector:WebSocketClient@1989780873-18: Running change org.eclipse.jetty.io.ManagedSelector$CloseSelector@1ce92674
2016-06-23 15:41:19.411:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-18: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produced null
2016-06-23 15:41:19.411:DBUG:oejuts.ExecuteProduceConsume:WebSocketClient@1989780873-18: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d produce exit
2016-06-23 15:41:19.427:DBUG:oejut.QueuedThreadPool:WebSocketClient@1989780873-18: ran EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@3dc1769d
2016-06-23 15:41:19.411:DBUG:oeji.ManagedSelector:main: Stopped org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=-1 selected=-1
2016-06-23 15:41:19.427:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.io.ManagedSelector@6a41eaa2 id=0 keys=-1 selected=-1
2016-06-23 15:41:19.427:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.websocket.client.io.WebSocketClientSelectorManager@77caeb3e
2016-06-23 15:41:19.427:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.websocket.client.io.ConnectionManager@4501b7af
2016-06-23 15:41:19.427:DBUG:oejuc.AbstractLifeCycle:main: stopping WebSocketClient@1989780873{STARTED,8<=8<=200,i=8,q=0}
2016-06-23 15:41:19.442:DBUG:oejuc.AbstractLifeCycle:main: STOPPED WebSocketClient@1989780873{STOPPED,8<=8<=200,i=0,q=0}
2016-06-23 15:41:19.442:DBUG:oejuc.AbstractLifeCycle:main: stopping org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@1a6c5a9e
2016-06-23 15:41:19.442:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@1a6c5a9e
2016-06-23 15:41:19.442:DBUG:oejuc.AbstractLifeCycle:main: stopping SslContextFactory@58372a00(null,null)
2016-06-23 15:41:19.442:DBUG:oejuc.AbstractLifeCycle:main: STOPPED SslContextFactory@58372a00(null,null)
2016-06-23 15:41:19.442:DBUG:oejwc.WebSocketClient:main: Stopped org.eclipse.jetty.websocket.client.WebSocketClient@7699a589
2016-06-23 15:41:19.458:DBUG:oejuc.AbstractLifeCycle:main: STOPPED org.eclipse.jetty.websocket.client.WebSocketClient@7699a589

NetBeans: JPDA Listening Start...
JPDA Address: XXX:57643
Port:57643
cd C:\Users\user1\jetty-newbie\WssEmbedded; "JAVA_HOME=C:\\Program Files\\Java\\jdk1.8.0_66" cmd /c "\"\"C:\\Program Files\\NetBeans 8.0.2\\java\\maven\\bin\\mvn.bat\" -Dexec.args=\"-Xdebug -Xrunjdwp:transport=dt_socket,server=n,address=57643 -classpath %classpath de.afarber.wssembedded.MyHandler\" -Dexec.executable=\"C:\\Program Files\\Java\\jdk1.8.0_66\\bin\\java.exe\" -Djpda.listen=true -Djpda.address=57643 -Dmaven.ext.class.path=C:\\Users\\user1\\AppData\\Roaming\\NetBeans\\8.0.2\\maven-nblib\\netbeans-eventspy.jar --debug --debug org.codehaus.mojo:exec-maven-plugin:1.2.1:exec\""
Running NetBeans Compile On Save execution. Phase execution is skipped and output directories of dependency projects (with Compile on Save turned on) will be used instead of their jar artifacts.
Apache Maven 3.0.5 (r01de14724cdef164cd33c7c8c2fe155faf9602da; 2013-02-19 14:51:28+0100)
Maven home: C:\Program Files\NetBeans 8.0.2\java\maven
Java version: 1.8.0_66, vendor: Oracle Corporation
Java home: C:\Program Files\Java\jdk1.8.0_66\jre
Default locale: en_US, platform encoding: UTF8
OS name: "windows 7", version: "6.1", arch: "amd64", family: "dos"
Populating class realm maven.ext
  Included C:\Users\user1\AppData\Roaming\NetBeans\8.0.2\maven-nblib\netbeans-eventspy.jar
Error stacktraces are turned on.
Reading global settings from C:\Program Files\NetBeans 8.0.2\java\maven\conf\settings.xml
Reading user settings from C:\Users\user1\.m2\settings.xml
Using local repository at C:\Users\user1\.m2\repository
Using manager EnhancedLocalRepositoryManager with priority 10 for C:\Users\user1\.m2\repository
Scanning for projects...
Extension realms for project de.afarber:wss-embedded:jar:1.0-SNAPSHOT: (none)
Looking up lifecyle mappings for packaging jar from ClassRealm[maven.ext, parent: ClassRealm[plexus.core, parent: null]]
=== REACTOR BUILD PLAN ================================================
Project: de.afarber:wss-embedded:jar:1.0-SNAPSHOT
Tasks:   [org.codehaus.mojo:exec-maven-plugin:1.2.1:exec]
Style:   Regular
=======================================================================
                                                                        
------------------------------------------------------------------------
Building WssEmbedded 1.0-SNAPSHOT
------------------------------------------------------------------------
Lifecycle default -> [validate, initialize, generate-sources, process-sources, generate-resources, process-resources, compile, process-classes, generate-test-sources, process-test-sources, generate-test-resources, process-test-resources, test-compile, process-test-classes, test, prepare-package, package, pre-integration-test, integration-test, post-integration-test, verify, install, deploy]
Lifecycle clean -> [pre-clean, clean, post-clean]
Lifecycle site -> [pre-site, site, post-site, site-deploy]
=== PROJECT BUILD PLAN ================================================
Project:       de.afarber:wss-embedded:1.0-SNAPSHOT
Dependencies (collect): []
Dependencies (resolve): [test]
Repositories (dependencies): [central (http://repo.maven.apache.org/maven2, releases)]
Repositories (plugins)     : [central (http://repo.maven.apache.org/maven2, releases)]
-----------------------------------------------------------------------
Goal:          org.codehaus.mojo:exec-maven-plugin:1.2.1:exec (default-cli)
Style:         Regular
Configuration: <?xml version="1.0" encoding="UTF-8"?>
<configuration>
  <basedir default-value="${basedir}"/>
  <classpathScope default-value="runtime">${exec.classpathScope}</classpathScope>
  <commandlineArgs>${exec.args}</commandlineArgs>
  <executable>${exec.executable}</executable>
  <longClasspath default-value="false">${exec.longClasspath}</longClasspath>
  <outputFile>${exec.outputFile}</outputFile>
  <project default-value="${project}"/>
  <session default-value="${session}"/>
  <skip default-value="false">${skip}</skip>
  <sourceRoot>${sourceRoot}</sourceRoot>
  <testSourceRoot>${testSourceRoot}</testSourceRoot>
  <workingDirectory>${exec.workingdir}</workingDirectory>
</configuration>
=======================================================================
de.afarber:wss-embedded:jar:1.0-SNAPSHOT
   javax.servlet:javax.servlet-api:jar:3.1.0:compile
   org.eclipse.jetty.websocket:websocket-server:jar:9.3.10.v20160621:compile
      org.eclipse.jetty.websocket:websocket-common:jar:9.3.10.v20160621:compile
         org.eclipse.jetty:jetty-io:jar:9.3.10.v20160621:compile
      org.eclipse.jetty.websocket:websocket-client:jar:9.3.10.v20160621:compile
      org.eclipse.jetty:jetty-servlet:jar:9.3.10.v20160621:compile
         org.eclipse.jetty:jetty-security:jar:9.3.10.v20160621:compile
            org.eclipse.jetty:jetty-server:jar:9.3.10.v20160621:compile
      org.eclipse.jetty:jetty-http:jar:9.3.10.v20160621:compile
   org.eclipse.jetty.websocket:websocket-servlet:jar:9.3.10.v20160621:compile
      org.eclipse.jetty.websocket:websocket-api:jar:9.3.10.v20160621:compile
   org.eclipse.jetty:jetty-util-ajax:jar:9.3.10.v20160621:compile
      org.eclipse.jetty:jetty-util:jar:9.3.10.v20160621:compile

--- exec-maven-plugin:1.2.1:exec (default-cli) @ wss-embedded ---
Created new class realm maven.api
Importing foreign packages into class realm maven.api
  Imported: org.apache.maven.cli < maven.ext
  Imported: org.codehaus.plexus.lifecycle < maven.ext
  Imported: org.apache.maven.lifecycle < maven.ext
  Imported: org.apache.maven.repository < maven.ext
  Imported: org.codehaus.plexus.personality < maven.ext
  Imported: org.apache.maven.usability < maven.ext
  Imported: org.codehaus.plexus.configuration < maven.ext
  Imported: org.sonatype.aether.version < maven.ext
  Imported: org.sonatype.aether.* < maven.ext
  Imported: org.sonatype.aether.artifact < maven.ext
  Imported: org.apache.maven.* < maven.ext
  Imported: org.apache.maven.project < maven.ext
  Imported: org.sonatype.aether.repository < maven.ext
  Imported: org.sonatype.aether.impl < maven.ext
  Imported: org.apache.maven.exception < maven.ext
  Imported: org.apache.maven.plugin < maven.ext
  Imported: org.sonatype.aether.collection < maven.ext
  Imported: org.codehaus.plexus.* < maven.ext
  Imported: org.codehaus.plexus.logging < maven.ext
  Imported: org.apache.maven.profiles < maven.ext
  Imported: org.sonatype.aether.metadata < maven.ext
  Imported: org.sonatype.aether.spi < maven.ext
  Imported: org.codehaus.plexus.util.xml.pull.XmlPullParserException < maven.ext
  Imported: org.apache.maven.wagon.* < maven.ext
  Imported: org.sonatype.aether.graph < maven.ext
  Imported: org.apache.maven.rtinfo < maven.ext
  Imported: org.sonatype.aether.installation < maven.ext
  Imported: org.apache.maven.monitor < maven.ext
  Imported: org.sonatype.aether.transfer < maven.ext
  Imported: org.codehaus.plexus.context < maven.ext
  Imported: org.apache.maven.wagon.observers < maven.ext
  Imported: org.apache.maven.wagon.resource < maven.ext
  Imported: org.sonatype.aether.deployment < maven.ext
  Imported: org.apache.maven.model < maven.ext
  Imported: org.codehaus.plexus.util.xml.Xpp3Dom < maven.ext
  Imported: org.apache.maven.artifact < maven.ext
  Imported: org.apache.maven.toolchain < maven.ext
  Imported: org.codehaus.plexus.util.xml.pull.XmlSerializer < maven.ext
  Imported: org.apache.maven.settings < maven.ext
  Imported: org.apache.maven.wagon.authorization < maven.ext
  Imported: org.apache.maven.wagon.events < maven.ext
  Imported: org.apache.maven.wagon.authentication < maven.ext
  Imported: org.apache.maven.reporting < maven.ext
  Imported: org.apache.maven.wagon.repository < maven.ext
  Imported: org.apache.maven.configuration < maven.ext
  Imported: org.codehaus.plexus.classworlds < maven.ext
  Imported: org.codehaus.classworlds < maven.ext
  Imported: org.codehaus.plexus.util.xml.pull.XmlPullParser < maven.ext
  Imported: org.apache.maven.classrealm < maven.ext
  Imported: org.sonatype.aether.resolution < maven.ext
  Imported: org.apache.maven.execution < maven.ext
  Imported: org.apache.maven.wagon.proxy < maven.ext
  Imported: org.codehaus.plexus.container < maven.ext
  Imported: org.codehaus.plexus.component < maven.ext
Populating class realm maven.api
org.codehaus.mojo:exec-maven-plugin:jar:1.2.1:
   org.apache.maven:maven-toolchain:jar:1.0:compile
   org.apache.maven:maven-project:jar:2.0.6:compile
      org.apache.maven:maven-settings:jar:2.0.6:compile
      org.apache.maven:maven-profile:jar:2.0.6:compile
      org.apache.maven:maven-plugin-registry:jar:2.0.6:compile
   org.apache.maven:maven-model:jar:2.0.6:compile
   org.apache.maven:maven-artifact:jar:2.0.6:compile
   org.apache.maven:maven-artifact-manager:jar:2.0.6:compile
      org.apache.maven:maven-repository-metadata:jar:2.0.6:compile
   org.apache.maven:maven-core:jar:2.0.6:compile
      org.apache.maven:maven-plugin-parameter-documenter:jar:2.0.6:compile
      org.apache.maven.reporting:maven-reporting-api:jar:2.0.6:compile
         org.apache.maven.doxia:doxia-sink-api:jar:1.0-alpha-7:compile
      org.apache.maven:maven-error-diagnostics:jar:2.0.6:compile
      commons-cli:commons-cli:jar:1.0:compile
      org.apache.maven:maven-plugin-descriptor:jar:2.0.6:compile
      org.codehaus.plexus:plexus-interactivity-api:jar:1.0-alpha-4:compile
      org.apache.maven:maven-monitor:jar:2.0.6:compile
      classworlds:classworlds:jar:1.1:compile
   org.apache.maven:maven-plugin-api:jar:2.0.6:compile
   org.codehaus.plexus:plexus-utils:jar:2.0.5:compile
   org.codehaus.plexus:plexus-container-default:jar:1.0-alpha-9:compile
      junit:junit:jar:3.8.2:test (scope managed from compile) (version managed from 3.8.1)
   org.apache.commons:commons-exec:jar:1.1:compile
Created new class realm plugin>org.codehaus.mojo:exec-maven-plugin:1.2.1
Importing foreign packages into class realm plugin>org.codehaus.mojo:exec-maven-plugin:1.2.1
  Imported:  < maven.api
Populating class realm plugin>org.codehaus.mojo:exec-maven-plugin:1.2.1
  Included: org.codehaus.mojo:exec-maven-plugin:jar:1.2.1
  Included: org.apache.maven.reporting:maven-reporting-api:jar:2.0.6
  Included: org.apache.maven.doxia:doxia-sink-api:jar:1.0-alpha-7
  Included: commons-cli:commons-cli:jar:1.0
  Included: org.codehaus.plexus:plexus-interactivity-api:jar:1.0-alpha-4
  Included: org.codehaus.plexus:plexus-utils:jar:2.0.5
  Included: org.apache.commons:commons-exec:jar:1.1
  Excluded: org.apache.maven:maven-toolchain:jar:1.0
  Excluded: org.apache.maven:maven-project:jar:2.0.6
  Excluded: org.apache.maven:maven-settings:jar:2.0.6
  Excluded: org.apache.maven:maven-profile:jar:2.0.6
  Excluded: org.apache.maven:maven-plugin-registry:jar:2.0.6
  Excluded: org.apache.maven:maven-model:jar:2.0.6
  Excluded: org.apache.maven:maven-artifact:jar:2.0.6
  Excluded: org.apache.maven:maven-artifact-manager:jar:2.0.6
  Excluded: org.apache.maven:maven-repository-metadata:jar:2.0.6
  Excluded: org.apache.maven:maven-core:jar:2.0.6
  Excluded: org.apache.maven:maven-plugin-parameter-documenter:jar:2.0.6
  Excluded: org.apache.maven:maven-error-diagnostics:jar:2.0.6
  Excluded: org.apache.maven:maven-plugin-descriptor:jar:2.0.6
  Excluded: org.apache.maven:maven-monitor:jar:2.0.6
  Excluded: classworlds:classworlds:jar:1.1
  Excluded: org.apache.maven:maven-plugin-api:jar:2.0.6
  Excluded: org.codehaus.plexus:plexus-container-default:jar:1.0-alpha-9
  Excluded: junit:junit:jar:3.8.2
Configuring mojo org.codehaus.mojo:exec-maven-plugin:1.2.1:exec from plugin realm ClassRealm[plugin>org.codehaus.mojo:exec-maven-plugin:1.2.1, parent: sun.misc.Launcher$AppClassLoader@70dea4e]
Configuring mojo 'org.codehaus.mojo:exec-maven-plugin:1.2.1:exec' with basic configurator -->
  (f) basedir = C:\Users\user1\jetty-newbie\WssEmbedded
  (f) classpathScope = runtime
  (f) commandlineArgs = -Xdebug -Xrunjdwp:transport=dt_socket,server=n,address=57643 -classpath %classpath de.afarber.wssembedded.MyHandler
  (f) executable = C:\Program Files\Java\jdk1.8.0_66\bin\java.exe
  (f) longClasspath = false
  (f) project = MavenProject: de.afarber:wss-embedded:1.0-SNAPSHOT @ C:\Users\user1\jetty-newbie\WssEmbedded\pom.xml
  (f) session = org.apache.maven.execution.MavenSession@5460cf3a
  (f) skip = false
-- end configuration --
Collected project artifacts [javax.servlet:javax.servlet-api:jar:3.1.0:compile, org.eclipse.jetty.websocket:websocket-server:jar:9.3.10.v20160621:compile, org.eclipse.jetty.websocket:websocket-common:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-io:jar:9.3.10.v20160621:compile, org.eclipse.jetty.websocket:websocket-client:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-servlet:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-security:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-server:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-http:jar:9.3.10.v20160621:compile, org.eclipse.jetty.websocket:websocket-servlet:jar:9.3.10.v20160621:compile, org.eclipse.jetty.websocket:websocket-api:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-util-ajax:jar:9.3.10.v20160621:compile, org.eclipse.jetty:jetty-util:jar:9.3.10.v20160621:compile]
Collected project classpath [C:\Users\user1\jetty-newbie\WssEmbedded\target\classes]
dealing with javax.servlet:javax.servlet-api:jar:3.1.0:compile
dealing with org.eclipse.jetty.websocket:websocket-server:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty.websocket:websocket-common:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-io:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty.websocket:websocket-client:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-servlet:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-security:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-server:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-http:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty.websocket:websocket-servlet:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty.websocket:websocket-api:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-util-ajax:jar:9.3.10.v20160621:compile
dealing with org.eclipse.jetty:jetty-util:jar:9.3.10.v20160621:compile
Toolchains are ignored, 'executable' parameter is set to C:\Program Files\Java\jdk1.8.0_66\bin\java.exe
Executing command line: C:\Program Files\Java\jdk1.8.0_66\bin\java.exe -Xdebug -Xrunjdwp:transport=dt_socket,server=n,address=57643 -classpath C:\Users\user1\jetty-newbie\WssEmbedded\target\classes;C:\Users\user1\.m2\repository\javax\servlet\javax.servlet-api\3.1.0\javax.servlet-api-3.1.0.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\websocket\websocket-server\9.3.10.v20160621\websocket-server-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\websocket\websocket-common\9.3.10.v20160621\websocket-common-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-io\9.3.10.v20160621\jetty-io-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\websocket\websocket-client\9.3.10.v20160621\websocket-client-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-servlet\9.3.10.v20160621\jetty-servlet-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-security\9.3.10.v20160621\jetty-security-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-server\9.3.10.v20160621\jetty-server-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-http\9.3.10.v20160621\jetty-http-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\websocket\websocket-servlet\9.3.10.v20160621\websocket-servlet-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\websocket\websocket-api\9.3.10.v20160621\websocket-api-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-util-ajax\9.3.10.v20160621\jetty-util-ajax-9.3.10.v20160621.jar;C:\Users\user1\.m2\repository\org\eclipse\jetty\jetty-util\9.3.10.v20160621\jetty-util-9.3.10.v20160621.jar de.afarber.wssembedded.MyHandler
2016-06-23 15:41:00.606:INFO::main: Logging initialized @399ms
2016-06-23 15:41:00.638:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.Server@180bc464 added {qtp1789550256{STOPPED,8<=0<=200,i=0,q=0},AUTO}
2016-06-23 15:41:00.669:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.server.WebSocketServerFactory@7c0e2abd added {org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@7921b0a2,AUTO}
2016-06-23 15:41:00.669:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.websocket.server.WebSocketServerFactory@7c0e2abd added {org.eclipse.jetty.io.MappedByteBufferPool@48eff760,POJO}
2016-06-23 15:41:00.700:DBUG:oejuc.ContainerLifeCycle:main: de.afarber.wssembedded.MyHandler@5e3a8624 added {org.eclipse.jetty.websocket.server.WebSocketServerFactory@7c0e2abd,AUTO}
2016-06-23 15:41:00.700:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.Server@180bc464 added {de.afarber.wssembedded.MyHandler@5e3a8624,MANAGED}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: HttpConnectionFactory@6321e813[HTTP/1.1] added {HttpConfiguration@79be0360{32768/8192,8192/8192,https://:0,[]},POJO}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.server.Server@180bc464,UNMANAGED}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{null,[]}{0.0.0.0:0} added {qtp1789550256{STOPPED,8<=0<=200,i=0,q=0},AUTO}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@22a67b4,AUTO}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.io.ArrayByteBufferPool@30b8a058,POJO}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{null,[http/1.1]}{0.0.0.0:0} added {HttpConnectionFactory@6321e813[HTTP/1.1],AUTO}
2016-06-23 15:41:00.747:DBUG:oejs.AbstractConnector:main: ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{0.0.0.0:0} added HttpConnectionFactory@6321e813[HTTP/1.1]
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{0.0.0.0:0} added {org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@694e1548,MANAGED}
2016-06-23 15:41:00.747:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.Server@180bc464 added {ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{127.0.0.1:8080},AUTO}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: SslConnectionFactory@71bbf57e{SSL->HTTP/1.1} added {SslContextFactory@7f13d6e(file:///C:/Users/user1/jetty-newbie/WssEmbedded/keystore.jks,null),AUTO}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.server.Server@180bc464,UNMANAGED}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{null,[]}{0.0.0.0:0} added {qtp1789550256{STOPPED,8<=0<=200,i=0,q=0},AUTO}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@51cdd8a,AUTO}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{null,[]}{0.0.0.0:0} added {org.eclipse.jetty.io.ArrayByteBufferPool@23faf8f2,POJO}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{null,[ssl]}{0.0.0.0:0} added {SslConnectionFactory@71bbf57e{SSL->HTTP/1.1},AUTO}
2016-06-23 15:41:00.762:DBUG:oejs.AbstractConnector:main: ServerConnector@d44fc21{SSL,[ssl]}{0.0.0.0:0} added SslConnectionFactory@71bbf57e{SSL->HTTP/1.1}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{SSL,[ssl]}{0.0.0.0:0} added {org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@2d6eabae,MANAGED}
2016-06-23 15:41:00.762:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.Server@180bc464 added {ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443},AUTO}
2016-06-23 15:41:00.762:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.Server@180bc464
2016-06-23 15:41:00.762:INFO:oejs.Server:main: jetty-9.3.10.v20160621
2016-06-23 15:41:00.778:DBUG:oejsh.AbstractHandler:main: starting org.eclipse.jetty.server.Server@180bc464
2016-06-23 15:41:00.778:DBUG:oejuc.AbstractLifeCycle:main: starting qtp1789550256{STOPPED,8<=0<=200,i=0,q=0}
2016-06-23 15:41:00.778:DBUG:oejuc.AbstractLifeCycle:main: STARTED @572ms qtp1789550256{STARTED,8<=8<=200,i=7,q=0}
2016-06-23 15:41:00.778:DBUG:oejuc.AbstractLifeCycle:main: starting de.afarber.wssembedded.MyHandler@5e3a8624
2016-06-23 15:41:00.778:DBUG:oejsh.AbstractHandler:main: starting de.afarber.wssembedded.MyHandler@5e3a8624
2016-06-23 15:41:00.778:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.websocket.server.WebSocketServerFactory@7c0e2abd
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@7921b0a2
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: STARTED @578ms org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@7921b0a2
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: STARTED @578ms org.eclipse.jetty.websocket.server.WebSocketServerFactory@7c0e2abd
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: STARTED @578ms de.afarber.wssembedded.MyHandler@5e3a8624
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: starting ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{127.0.0.1:8080}
2016-06-23 15:41:00.794:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{127.0.0.1:8080} added {sun.nio.ch.ServerSocketChannelImpl[/127.0.0.1:8080],POJO}
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@22a67b4
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: STARTED @586ms org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@22a67b4
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: starting HttpConnectionFactory@6321e813[HTTP/1.1]
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: STARTED @586ms HttpConnectionFactory@6321e813[HTTP/1.1]
2016-06-23 15:41:00.794:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@694e1548
2016-06-23 15:41:00.794:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@694e1548 added {org.eclipse.jetty.io.ManagedSelector@11758f2a id=0 keys=-1 selected=-1,AUTO}
2016-06-23 15:41:00.794:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@694e1548 added {org.eclipse.jetty.io.ManagedSelector@e720b71 id=1 keys=-1 selected=-1,AUTO}
2016-06-23 15:41:00.809:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.io.ManagedSelector@11758f2a id=0 keys=-1 selected=-1
2016-06-23 15:41:00.872:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector@11758f2a id=0 keys=0 selected=0
2016-06-23 15:41:00.872:DBUG:oejuc.AbstractLifeCycle:main: STARTED @668ms org.eclipse.jetty.io.ManagedSelector@11758f2a id=0 keys=0 selected=0
2016-06-23 15:41:00.872:DBUG:oejut.QueuedThreadPool:qtp1789550256-13: run org.eclipse.jetty.io.ManagedSelector@11758f2a id=0 keys=0 selected=0
2016-06-23 15:41:00.872:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.io.ManagedSelector@e720b71 id=1 keys=-1 selected=-1
2016-06-23 15:41:00.872:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-13: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@547a30f3 execute
2016-06-23 15:41:00.872:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-13: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@547a30f3 produce enter
2016-06-23 15:41:00.872:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-13: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@547a30f3 producing
2016-06-23 15:41:00.872:DBUG:oeji.ManagedSelector:qtp1789550256-13: Selector loop waiting on select
2016-06-23 15:41:00.887:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector@e720b71 id=1 keys=0 selected=0
2016-06-23 15:41:00.887:DBUG:oejuc.AbstractLifeCycle:main: STARTED @670ms org.eclipse.jetty.io.ManagedSelector@e720b71 id=1 keys=0 selected=0
2016-06-23 15:41:00.887:DBUG:oejut.QueuedThreadPool:qtp1789550256-15: run org.eclipse.jetty.io.ManagedSelector@e720b71 id=1 keys=0 selected=0
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: STARTED @920ms org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@694e1548
2016-06-23 15:41:01.137:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-15: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@17d7315b execute
2016-06-23 15:41:01.137:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-15: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@17d7315b produce enter
2016-06-23 15:41:01.137:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-15: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@17d7315b producing
2016-06-23 15:41:01.137:DBUG:oeji.ManagedSelector:qtp1789550256-15: Selector loop waiting on select
2016-06-23 15:41:01.137:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{127.0.0.1:8080} added {acceptor-0@d6da883,POJO}
2016-06-23 15:41:01.137:DBUG:oejut.QueuedThreadPool:main: queue acceptor-0@d6da883
2016-06-23 15:41:01.137:INFO:oejs.AbstractConnector:main: Started ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{127.0.0.1:8080}
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: STARTED @927ms ServerConnector@72b6cbcc{HTTP/1.1,[http/1.1]}{127.0.0.1:8080}
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: starting ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443}
2016-06-23 15:41:01.137:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443} added {sun.nio.ch.ServerSocketChannelImpl[/127.0.0.1:8443],POJO}
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@51cdd8a
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: STARTED @931ms org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@51cdd8a
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: starting SslConnectionFactory@71bbf57e{SSL->HTTP/1.1}
2016-06-23 15:41:01.137:DBUG:oejuc.AbstractLifeCycle:main: starting SslContextFactory@7f13d6e(file:///C:/Users/user1/jetty-newbie/WssEmbedded/keystore.jks,null)
2016-06-23 15:41:01.137:DBUG:oejut.QueuedThreadPool:qtp1789550256-17: run acceptor-0@d6da883
2016-06-23 15:41:01.199:DBUG:oejus.X509:main: Certificate CN alias=key1 CN=Alexander Farber in X509@6279cee3(key1,h=[],w=[])
2016-06-23 15:41:01.199:INFO:oejus.SslContextFactory:main: x509=X509@6279cee3(key1,h=[],w=[]) for SslContextFactory@7f13d6e(file:///C:/Users/user1/jetty-newbie/WssEmbedded/keystore.jks,null)
2016-06-23 15:41:01.246:DBUG:oejus.SslContextFactory:main: managers=[Ljavax.net.ssl.KeyManager;@48524010 for SslContextFactory@7f13d6e(file:///C:/Users/user1/jetty-newbie/WssEmbedded/keystore.jks,null)
2016-06-23 15:41:01.620:DBUG:oejus.SslContextFactory:main: Selected Protocols [TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
2016-06-23 15:41:01.636: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_ECDH_ECDSA_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_ECDH_ECDSA_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, 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, 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_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]
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1422ms SslContextFactory@7f13d6e(file:///C:/Users/user1/jetty-newbie/WssEmbedded/keystore.jks,null)
2016-06-23 15:41:01.636:DBUG:oejus.SslContextFactory:main: Customize 3d34d211[SSLEngine[hostname=null port=-1] SSL_NULL_WITH_NULL_NULL]
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1424ms SslConnectionFactory@71bbf57e{SSL->HTTP/1.1}
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@2d6eabae
2016-06-23 15:41:01.636:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@2d6eabae added {org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=-1 selected=-1,AUTO}
2016-06-23 15:41:01.636:DBUG:oejuc.ContainerLifeCycle:main: org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@2d6eabae added {org.eclipse.jetty.io.ManagedSelector@4009e306 id=1 keys=-1 selected=-1,AUTO}
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=-1 selected=-1
2016-06-23 15:41:01.636:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=0 selected=0
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1427ms org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=0 selected=0
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: starting org.eclipse.jetty.io.ManagedSelector@4009e306 id=1 keys=-1 selected=-1
2016-06-23 15:41:01.636:DBUG:oejut.QueuedThreadPool:qtp1789550256-16: run org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=0 selected=0
2016-06-23 15:41:01.636:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c execute
2016-06-23 15:41:01.636:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produce enter
2016-06-23 15:41:01.636:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c producing
2016-06-23 15:41:01.636:DBUG:oeji.ManagedSelector:qtp1789550256-16: Selector loop waiting on select
2016-06-23 15:41:01.636:DBUG:oejut.QueuedThreadPool:main: queue org.eclipse.jetty.io.ManagedSelector@4009e306 id=1 keys=0 selected=0
2016-06-23 15:41:01.636:DBUG:oejut.QueuedThreadPool:qtp1789550256-14: run org.eclipse.jetty.io.ManagedSelector@4009e306 id=1 keys=0 selected=0
2016-06-23 15:41:01.636:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-14: EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@66cff2d7 execute
2016-06-23 15:41:01.636:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@66cff2d7 produce enter
2016-06-23 15:41:01.636:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-14: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@66cff2d7 producing
2016-06-23 15:41:01.636:DBUG:oeji.ManagedSelector:qtp1789550256-14: Selector loop waiting on select
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1430ms org.eclipse.jetty.io.ManagedSelector@4009e306 id=1 keys=0 selected=0
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1430ms org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@2d6eabae
2016-06-23 15:41:01.636:DBUG:oejuc.ContainerLifeCycle:main: ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443} added {acceptor-0@22fcf7ab,POJO}
2016-06-23 15:41:01.636:DBUG:oejut.QueuedThreadPool:main: queue acceptor-0@22fcf7ab
2016-06-23 15:41:01.636:INFO:oejs.AbstractConnector:main: Started ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443}
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1431ms ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443}
2016-06-23 15:41:01.636:INFO:oejs.Server:main: Started @1431ms
2016-06-23 15:41:01.636:DBUG:oejuc.AbstractLifeCycle:main: STARTED @1431ms org.eclipse.jetty.server.Server@180bc464
2016-06-23 15:41:01.636:DBUG:oejut.QueuedThreadPool:qtp1789550256-18: run acceptor-0@22fcf7ab
2016-06-23 15:41:14.322:DBUG:oeji.ManagedSelector:qtp1789550256-18-acceptor-0@22fcf7ab-ServerConnector@d44fc21{SSL,[ssl]}{127.0.0.1:8443}: Queued change org.eclipse.jetty.io.ManagedSelector$Accept@34ddeffe on org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=0 selected=0
2016-06-23 15:41:14.322:DBUG:oeji.ManagedSelector:qtp1789550256-16: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:14.322:DBUG:oeji.ManagedSelector:qtp1789550256-16: Running change org.eclipse.jetty.io.ManagedSelector$Accept@34ddeffe
2016-06-23 15:41:14.322:DBUG:oeji.ManagedSelector:qtp1789550256-16: Queued change org.eclipse.jetty.io.ManagedSelector$CreateEndPoint@2947c2c7 on org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=1 selected=0
2016-06-23 15:41:14.322:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produced org.eclipse.jetty.io.ManagedSelector$CreateEndPoint@2947c2c7
2016-06-23 15:41:14.322:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c dispatch
2016-06-23 15:41:14.322:DBUG:oejut.QueuedThreadPool:qtp1789550256-16: queue EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c
2016-06-23 15:41:14.322:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c run org.eclipse.jetty.io.ManagedSelector$CreateEndPoint@2947c2c7
2016-06-23 15:41:14.322:DBUG:oejut.QueuedThreadPool:qtp1789550256-19: run EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c
2016-06-23 15:41:14.322:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c run
2016-06-23 15:41:14.322:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produce enter
2016-06-23 15:41:14.322:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c producing
2016-06-23 15:41:14.322:DBUG:oeji.ManagedSelector:qtp1789550256-19: Selector loop waiting on select
2016-06-23 15:41:14.385:DBUG:oeji.AbstractEndPoint:qtp1789550256-16: onOpen SelectChannelEndPoint@4a9f1e5d{/127.0.0.1:57661<->8443,Open,in,out,-,-,32/30000,null@0}{io=0/0,kio=0,kro=0}
2016-06-23 15:41:14.385:DBUG:oeji.IdleTimeout:qtp1789550256-16: SelectChannelEndPoint@4a9f1e5d{/127.0.0.1:57661<->8443,Open,in,out,-,-,32/30000,null@0}{io=0/0,kio=0,kro=0} idle timeout check, elapsed: 32 ms, remaining: 29968 ms
2016-06-23 15:41:14.400:DBUG:oejus.SslContextFactory:qtp1789550256-16: Customize 62332813[SSLEngine[hostname=127.0.0.1 port=57661] SSL_NULL_WITH_NULL_NULL]
2016-06-23 15:41:14.416:DBUG:oeji.ManagedSelector:qtp1789550256-16: 
java.lang.NullPointerException
	at org.eclipse.jetty.server.SslConnectionFactory.newConnection(SslConnectionFactory.java:89)
	at org.eclipse.jetty.server.ServerConnector$ServerConnectorManager.newConnection(ServerConnector.java:517)
	at org.eclipse.jetty.io.ManagedSelector.createEndPoint(ManagedSelector.java:422)
	at org.eclipse.jetty.io.ManagedSelector.access$1600(ManagedSelector.java:56)
	at org.eclipse.jetty.io.ManagedSelector$CreateEndPoint.run(ManagedSelector.java:605)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.execute(ExecuteProduceConsume.java:100)
	at org.eclipse.jetty.io.ManagedSelector.run(ManagedSelector.java:147)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
	at java.lang.Thread.run(Thread.java:745)
2016-06-23 15:41:14.416:DBUG:oeji.ManagedSelector:qtp1789550256-16: 
java.lang.NullPointerException
	at org.eclipse.jetty.server.SslConnectionFactory.newConnection(SslConnectionFactory.java:89)
	at org.eclipse.jetty.server.ServerConnector$ServerConnectorManager.newConnection(ServerConnector.java:517)
	at org.eclipse.jetty.io.ManagedSelector.createEndPoint(ManagedSelector.java:422)
	at org.eclipse.jetty.io.ManagedSelector.access$1600(ManagedSelector.java:56)
	at org.eclipse.jetty.io.ManagedSelector$CreateEndPoint.run(ManagedSelector.java:605)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.execute(ExecuteProduceConsume.java:100)
	at org.eclipse.jetty.io.ManagedSelector.run(ManagedSelector.java:147)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
	at java.lang.Thread.run(Thread.java:745)
2016-06-23 15:41:14.416:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c ran org.eclipse.jetty.io.ManagedSelector$CreateEndPoint@2947c2c7
2016-06-23 15:41:14.416:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-16: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produce exit
2016-06-23 15:41:14.416:DBUG:oejut.QueuedThreadPool:qtp1789550256-16: ran org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=1 selected=0
2016-06-23 15:41:44.372:DBUG:oeji.IdleTimeout:Scheduler-85777802: SelectChannelEndPoint@4a9f1e5d{/127.0.0.1:57661<->8443,Open,ISHUT,OSHUT,-,-,30019/30000,null@0}{io=0/0,kio=-1,kro=-1} idle timeout check, elapsed: 30019 ms, remaining: -19 ms
2016-06-23 15:41:44.372:DBUG:oeji.IdleTimeout:Scheduler-85777802: SelectChannelEndPoint@4a9f1e5d{/127.0.0.1:57661<->8443,Open,ISHUT,OSHUT,-,-,30019/30000,null@0}{io=0/0,kio=-1,kro=-1} idle timeout expired
2016-06-23 15:41:44.372:DBUG:oeji.WriteFlusher:Scheduler-85777802: ignored: WriteFlusher@3798bc34{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 30019/30000 ms
2016-06-23 15:41:44.372:DBUG:oeji.WriteFlusher:Scheduler-85777802: ignored: WriteFlusher@3798bc34{IDLE} java.nio.channels.ClosedChannelException
2016-06-23 15:41:44.372:DBUG:oeji.ChannelEndPoint:Scheduler-85777802: close SelectChannelEndPoint@4a9f1e5d{/127.0.0.1:57661<->8443,CLOSED,ISHUT,OSHUT,-,-,30019/30000,null@0}{io=0/0,kio=-1,kro=-1}
2016-06-23 15:41:44.372:DBUG:oeji.ManagedSelector:Scheduler-85777802: Queued change org.eclipse.jetty.io.ManagedSelector$2@4d448b29 on org.eclipse.jetty.io.ManagedSelector@7dc0f706 id=0 keys=1 selected=0
2016-06-23 15:41:44.372:DBUG:oeji.ManagedSelector:qtp1789550256-19: Selector loop woken up from select, 0/0 selected
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produced org.eclipse.jetty.io.ManagedSelector$2@4d448b29
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c dispatch
2016-06-23 15:41:44.372:DBUG:oejut.QueuedThreadPool:qtp1789550256-19: queue EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c run org.eclipse.jetty.io.ManagedSelector$2@4d448b29
2016-06-23 15:41:44.372:DBUG:oejut.QueuedThreadPool:qtp1789550256-20: run EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-20: EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c run
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-20: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produce enter
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-20: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c producing
2016-06-23 15:41:44.372:DBUG:oeji.ManagedSelector:qtp1789550256-20: Selector loop waiting on select
2016-06-23 15:41:44.372:DBUG:oeji.ManagedSelector:qtp1789550256-19: Destroyed SelectChannelEndPoint@4a9f1e5d{/127.0.0.1:57661<->8443,CLOSED,ISHUT,OSHUT,-,-,30019/30000,null@0}{io=0/0,kio=-1,kro=-1}
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c ran org.eclipse.jetty.io.ManagedSelector$2@4d448b29
2016-06-23 15:41:44.372:DBUG:oejuts.ExecuteProduceConsume:qtp1789550256-19: EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c produce exit
2016-06-23 15:41:44.372:DBUG:oejut.QueuedThreadPool:qtp1789550256-19: ran EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@7e0af00c

Back to the top