[jbosstools-issues] [JBoss JIRA] (JBIDE-21596) Jetty polutes standard output

Jetty polutes standard output ----------------------------- Key: JBIDE-21596 URL: https://issues.jboss.org/browse/JBIDE-21596 Project: Tools (JBoss Tools) Issue Type: Bug Components: openshift Affects Versions: 4.3.1.Beta2 Reporter: Marián Labuda Assignee: Fred Bricon Labels: openshift_v3, respin-a Fix For: 4.3.1.Beta2 When I am running integration tests, or I have running eclipse from command line, std out is polluted with DEBUG messages from jetty. See following piece of output: {code} 16:08:10.762 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.WebSocketSession - notifyClose(1001,Idle Timeout) 16:08:10.762 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 0 entries: [] 16:08:12.689 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,R,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 300000 ms, remaining: 0 ms 16:08:12.689 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,R,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} idle timeout expired 16:08:12.689 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@417985ea{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:12.689 [WebSocketClient@1606176605-scheduler] DEBUG o.eclipse.jetty.io.AbstractEndPoint - Ignored idle endpoint SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.689 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE SslConnection@56d67c33{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{FILL_INTERESTED}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT Read Timeout - OPEN 16:08:12.690 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,R,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 300000 ms, remaining: 0 ms 16:08:12.690 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,R,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} idle timeout expired 16:08:12.690 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@5cb921f{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:12.690 [WebSocketClient@1606176605-scheduler] DEBUG o.eclipse.jetty.io.AbstractEndPoint - Ignored idle endpoint SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.events.AbstractEventDriver - incomingError(java.net.SocketTimeoutException) java.net.SocketTimeoutException: Timeout on Read at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onReadTimeout(AbstractWebSocketConnection.java:541) [org.eclipse.jetty.websocket.common_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.io.AbstractConnection.onFillInterestedFailed(AbstractConnection.java:173) [org.eclipse.jetty.io_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillInterestedFailed(AbstractWebSocketConnection.java:506) [org.eclipse.jetty.websocket.common_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.io.AbstractConnection$ReadCallback$1.run(AbstractConnection.java:582) [org.eclipse.jetty.io_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) [org.eclipse.jetty.util_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) [org.eclipse.jetty.util_9.2.13.v20150730.jar:9.2.13.v20150730] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_71] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE SslConnection@7dc15eff{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{FILL_INTERESTED}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - close(1001,Idle Timeout) 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - outgoingFrame(CLOSE[len=14,fin=true,rsv=...,masked=true], org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@6aa25d98) 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT Read Timeout - OPEN 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=1,aggregateSize=0,failure=null] queued FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@6aa25d98,OFF,null] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 1 entries: [FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@6aa25d98,OFF,null]] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] flushing 1 frames: [FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@6aa25d98,OFF,null]] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.events.AbstractEventDriver - incomingError(java.net.SocketTimeoutException) java.net.SocketTimeoutException: Timeout on Read at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onReadTimeout(AbstractWebSocketConnection.java:541) [org.eclipse.jetty.websocket.common_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.io.AbstractConnection.onFillInterestedFailed(AbstractConnection.java:173) [org.eclipse.jetty.io_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillInterestedFailed(AbstractWebSocketConnection.java:506) [org.eclipse.jetty.websocket.common_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.io.AbstractConnection$ReadCallback$1.run(AbstractConnection.java:582) [org.eclipse.jetty.io_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) [org.eclipse.jetty.util_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) [org.eclipse.jetty.util_9.2.13.v20150730.jar:9.2.13.v20150730] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_71] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@4e2fb076{IDLE} [DirectByteBuffer@5eed9acd[p=0,l=6,c=1024,r=6]={<<<\x88\x8e\n\x00\n!>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@a711ed9[p=0,l=14,c=14,r=14]={<<<\t\xE9CEfe*ucmoNt>>>}] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@4e2fb076{WRITING}:IDLE-->WRITING 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - close(1001,Idle Timeout) 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - outgoingFrame(CLOSE[len=14,fin=true,rsv=...,masked=true], org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@441f2dd5) 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush enter [java.nio.DirectByteBuffer[pos=0 lim=6 cap=1024], java.nio.HeapByteBuffer[pos=0 lim=14 cap=14]] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=1,aggregateSize=0,failure=null] queued FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@441f2dd5,OFF,null] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 1 entries: [FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@441f2dd5,OFF,null]] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] flushing 1 frames: [FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@441f2dd5,OFF,null]] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@7419d449{IDLE} [DirectByteBuffer@3978ed09[p=0,l=6,c=1024,r=6]={<<<\x88\x8e[l\x8b\xBc>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@41730bae[p=0,l=14,c=14,r=14]={<<<X\x85\xC2\xD87\t\xAb\xE82\x01\xEe\xD3.\x18>>>}] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NOT_HANDSHAKING,eio=-1/69,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} wrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 20 bytesProduced = 69 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@7419d449{WRITING}:IDLE-->WRITING 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush enter [java.nio.DirectByteBuffer[pos=0 lim=6 cap=1024], java.nio.HeapByteBuffer[pos=0 lim=14 cap=14]] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - DecryptedEndPoint@558bebbe{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,W,300001/300000,WebSocketClientConnection}->SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} OK HeapByteBuffer@97a9ca8[p=0,l=69,c=17408,r=69]={<<<\x17\x03\x03\x00@\xCd\xDac\xEd\xA4\x0c-\xD0Y\x93\x93\xB2...I\xF4\xA5\x16\xDb\xE4`\x01\xFe\x96Z\x8f<\x8f\xC2>>>\x1f/I7`\xF0\xA3D\xC0\xF8\xCeg\xF2\x995O\xDd...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00} 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NOT_HANDSHAKING,eio=-1/69,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} wrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 20 bytesProduced = 69 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 69 SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - DecryptedEndPoint@64ac2ea{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,W,300000/300000,WebSocketClientConnection}->SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,0/300000,SslConnection}{io=1,kio=1,kro=1} OK HeapByteBuffer@6fb10784[p=0,l=69,c=17408,r=69]={<<<\x17\x03\x03\x00@\x8dXV\xBf\xD4\x86%\x88F\xA0\x82\xC5...\xEa\xA1s\xB9as\xB0yG\xF1\xE8\x87\xB5F7>>>rade\r\nSec-WebSock...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00} 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NOT_HANDSHAKING,eio=-1/0,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush exit, consumed 20 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@4e2fb076{IDLE}:WRITING-->IDLE 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Local Close Confirmed CloseInfo[code=1001,reason=Idle Timeout] 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 69 SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.websocket.common.io.IOState - onAbnormalClose(CloseInfo[code=1001,reason=Idle Timeout]) 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.websocket.common.io.IOState - Notify State Listeners: CLOSED 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.websocket.common.io.IOState - WebSocketClientConnection.onConnectionStateChange(CLOSED) 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT Connection State Change: CLOSED 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NOT_HANDSHAKING,eio=-1/0,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush exit, consumed 20 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - outgoingFrame(CLOSE[len=31,fin=true,rsv=...,masked=true], org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnDisconnectCallback@5b02727b) 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@7419d449{IDLE}:WRITING-->IDLE 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Local Close Confirmed CloseInfo[code=1001,reason=Idle Timeout] 16:08:12.690 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT disconnect(both) 16:08:12.690 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,R,-,300000/300000,SslConnection}{io=1,kio=1,kro=1} idle timeout check, elapsed: 300000 ms, remaining: 0 ms 16:08:12.690 [WebSocketClient@1606176605-278] DEBUG o.e.j.websocket.common.io.IOState - onAbnormalClose(CloseInfo[code=1001,reason=Idle Timeout]) 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.websocket.common.io.IOState - Notify State Listeners: CLOSED 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Shutting down output DecryptedEndPoint@558bebbe{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,300002/300000,WebSocketClientConnection}->SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,R,-,300001/300000,SslConnection}{io=1,kio=1,kro=1} idle timeout expired 16:08:12.691 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@3ea859aa{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:12.691 [WebSocketClient@1606176605-scheduler] DEBUG o.eclipse.jetty.io.AbstractEndPoint - Ignored idle endpoint SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,300001/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE SslConnection@5e3f9e00{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{FILL_INTERESTED}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} shutdownOutput: oshut=false, ishut=false 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.websocket.common.io.IOState - WebSocketClientConnection.onConnectionStateChange(CLOSED) 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT Connection State Change: CLOSED 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} onFillInterestedFailed java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - outgoingFrame(CLOSE[len=31,fin=true,rsv=...,masked=true], org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnDisconnectCallback@b8ddf23) 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT Read Timeout - OPEN 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT disconnect(both) 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NEED_WRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush enter [java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]] 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Shutting down output DecryptedEndPoint@64ac2ea{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,300001/300000,WebSocketClientConnection}->SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NEED_UNWRAP,eio=-1/53,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} wrap Status = CLOSED HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 53 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} shutdownOutput: oshut=false, ishut=false 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 53 SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NEED_WRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush enter [java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]] 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.ChannelEndPoint - oshut SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,out,-,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/53,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} wrap Status = CLOSED HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 53 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.events.AbstractEventDriver - incomingError(java.net.SocketTimeoutException) java.net.SocketTimeoutException: Timeout on Read at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onReadTimeout(AbstractWebSocketConnection.java:541) [org.eclipse.jetty.websocket.common_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.io.AbstractConnection.onFillInterestedFailed(AbstractConnection.java:173) [org.eclipse.jetty.io_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillInterestedFailed(AbstractWebSocketConnection.java:506) [org.eclipse.jetty.websocket.common_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.io.AbstractConnection$ReadCallback$1.run(AbstractConnection.java:582) [org.eclipse.jetty.io_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) [org.eclipse.jetty.util_9.2.13.v20150730.jar:9.2.13.v20150730] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) [org.eclipse.jetty.util_9.2.13.v20150730.jar:9.2.13.v20150730] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_71] 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 53 SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.ChannelEndPoint - oshut SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,out,-,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NEED_UNWRAP,eio=-1/0,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush exit, consumed 0 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/0,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush exit, consumed 0 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - fillInterested SslConnection@56d67c33{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/9 selected 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED SslConnection@56d67c33{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/11 selected 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0 on SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - close(1001,Idle Timeout) 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 1 -> 0 for SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@31286352 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.SelectChannelEndPoint - Ignoring local interests update 1 -> 1 for SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - outgoingFrame(CLOSE[len=14,fin=true,rsv=...,masked=true], org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@67887b7f) 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - fillInterested SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=1,aggregateSize=0,failure=null] queued FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@67887b7f,OFF,null] 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@31286352 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 0 -> 1 for SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 1 entries: [FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@67887b7f,OFF,null]] 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 0 -> 1 on SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@31286352 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select 16:08:12.691 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0 on SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/9 selected 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@31286352 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0 on SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] flushing 1 frames: [FrameEntry[CLOSE[len=14,fin=true,rsv=...,masked=true],org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnCloseLocalCallback@67887b7f,OFF,null]] 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 1 -> 0 for SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Closing DecryptedEndPoint@558bebbe{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,-,-,300002/300000,WebSocketClientConnection}->SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@31286352 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Closing DecryptedEndPoint@64ac2ea{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,300001/300000,WebSocketClientConnection}->SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose DecryptedEndPoint@558bebbe{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,-,-,300002/300000,WebSocketClientConnection}->SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->FILLING SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose DecryptedEndPoint@64ac2ea{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,300001/300000,WebSocketClientConnection}->SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@56d67c33{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} shutdownOutput: oshut=true, ishut=false 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.eclipse.jetty.io.ssl.SslConnection - onFillable enter DecryptedEndPoint@64ac2ea{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,300001/300000,WebSocketClientConnection}->SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} shutdownOutput: oshut=true, ishut=false 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,CLOSED,in,OSHUT,R,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG org.eclipse.jetty.io.SelectorManager - Destroyed SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,CLOSED,ISHUT,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=-1,kro=-1} 16:08:12.691 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 1 -> 0 for SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT onClose() 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - onClose WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.692 [WebSocketClient@1606176605-330] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->IDLE SslConnection@56d67c33{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG org.eclipse.jetty.io.SelectorManager - Destroyed SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,CLOSED,ISHUT,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=-1,kro=-1} 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT onClose() 16:08:12.691 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.eclipse.jetty.io.ssl.SslConnection - onFillable exit DecryptedEndPoint@64ac2ea{10.1.2.2/10.1.2.2:8443<->35154,Open,in,OSHUT,-,-,300001/300000,WebSocketClientConnection}->SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.691 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@6eb9152f{IDLE} [DirectByteBuffer@51dba32e[p=0,l=6,c=1024,r=6]={<<<\x88\x8e\x89,e\xEd>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@4b4be514[p=0,l=14,c=14,r=14]={<<<\x8a\xC5,\x89\xE5IE\xB9\xE0A\x00\x82\xFcX>>>}] 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - onClose WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@6eb9152f{WRITING}:IDLE-->WRITING 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.jetty.io.AbstractConnection - onClose SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush enter [java.nio.DirectByteBuffer[pos=0 lim=6 cap=1024], java.nio.HeapByteBuffer[pos=0 lim=14 cap=14]] 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@519a9d51{10.1.2.2/10.1.2.2:8443<->35154,CLOSED,ISHUT,OSHUT,-,-,1/300000,SslConnection}{io=0,kio=-1,kro=-1} 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.websocket.common.io.IOState - WebSocketSession.onConnectionStateChange(CLOSED) 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.common.WebSocketSession - WebSocketClient.onSessionClosed() 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.client.WebSocketClient - Session Closed: WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@7ad37e5[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@7ad37e5[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection] 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection] 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NOT_HANDSHAKING,eio=-1/69,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} wrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 20 bytesProduced = 69 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.jetty.io.AbstractConnection - onClose SslConnection@56d67c33{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.692 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@6819c4f1 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@4d9cd3c9{10.1.2.2/10.1.2.2:8443<->35218,CLOSED,ISHUT,OSHUT,-,-,1/300000,SslConnection}{io=0,kio=-1,kro=-1} 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.websocket.common.io.IOState - WebSocketSession.onConnectionStateChange(CLOSED) 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.common.WebSocketSession - WebSocketClient.onSessionClosed() 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - DecryptedEndPoint@7bdf3083{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,W,300002/300000,WebSocketClientConnection}->SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} OK HeapByteBuffer@97a9ca8[p=0,l=69,c=17408,r=69]={<<<\x17\x03\x03\x00@\x96\x07[\x99\x86\xDf4\x14\xB2\xB5\x078...\x02\x0b\x0cY\xBcu\xC05\xB8m\xEa\xA4L\xD1c>>>\x1f/I7`\xF0\xA3D\xC0\xF8\xCeg\xF2\x995O\xDd...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00} 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@7ad37e5[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.common.WebSocketSession - notifyClose(1001,Idle Timeout) 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.client.WebSocketClient - Session Closed: WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@62a6624d[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 69 SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,1/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.692 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG o.e.jetty.io.AbstractConnection - FILLING-->IDLE SslConnection@7dc15eff{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@f85bf00{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1a310886[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@1ae809cb[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@62a6624d[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.692 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Ignoring cancelled key for channel java.nio.channels.SocketChannel[closed] 16:08:12.692 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@31286352 16:08:12.692 [WebSocketClient@1606176605-206-selector-WebSocketClientSelectorManager@38287dd2/3] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select 16:08:12.692 [WebSocketClient@1606176605-278] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 0 entries: [] 16:08:12.692 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG org.eclipse.jetty.io.SelectorManager - Ignoring cancelled key for channel java.nio.channels.SocketChannel[closed] 16:08:12.692 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@6819c4f1 16:08:12.692 [WebSocketClient@1606176605-204-selector-WebSocketClientSelectorManager@38287dd2/1] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection] 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection] 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@439e676b{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@77a1baf5[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@443e0877[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@62a6624d[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.common.WebSocketSession - notifyClose(1001,Idle Timeout) 16:08:12.692 [WebSocketClient@1606176605-365] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 0 entries: [] 16:08:12.692 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/10 selected 16:08:12.692 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0 on SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.692 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 1 -> 0 for SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.692 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@6d78da9b 16:08:12.692 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@6d78da9b 16:08:12.692 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NOT_HANDSHAKING,eio=-1/0,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush exit, consumed 20 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@6eb9152f{IDLE}:WRITING-->IDLE 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Local Close Confirmed CloseInfo[code=1001,reason=Idle Timeout] 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.websocket.common.io.IOState - onAbnormalClose(CloseInfo[code=1001,reason=Idle Timeout]) 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.websocket.common.io.IOState - Notify State Listeners: CLOSED 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.websocket.common.io.IOState - WebSocketClientConnection.onConnectionStateChange(CLOSED) 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT Connection State Change: CLOSED 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - outgoingFrame(CLOSE[len=31,fin=true,rsv=...,masked=true], org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection$OnDisconnectCallback@18ffacf7) 16:08:12.692 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT disconnect(both) 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Shutting down output DecryptedEndPoint@7bdf3083{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,300002/300000,WebSocketClientConnection}->SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} shutdownOutput: oshut=false, ishut=false 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NEED_WRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush enter [java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]] 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/53,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} wrap Status = CLOSED HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 53 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 53 SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,1/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.ChannelEndPoint - oshut SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,out,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/0,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} flush exit, consumed 0 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - fillInterested SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - IDLE-->FILL_INTERESTED SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 0 -> 1 for SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@6d78da9b 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 0/10 selected 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - Closing DecryptedEndPoint@7bdf3083{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,-,-,300003/300000,WebSocketClientConnection}->SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@6d78da9b 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 0 -> 1 on SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose DecryptedEndPoint@7bdf3083{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,-,-,300003/300000,WebSocketClientConnection}->SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=1,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop woken up from select, 1/10 selected 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 1 -> 0 on SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=1,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.SelectChannelEndPoint - Local interests updating 1 -> 0 for SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,Open,in,OSHUT,R,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.ssl.SslConnection - SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} shutdownOutput: oshut=true, ishut=false 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Queued change org.eclipse.jetty.io.SelectChannelEndPoint$1@6d78da9b 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.AbstractConnection - FILL_INTERESTED-->FILLING SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.eclipse.jetty.io.ssl.SslConnection - onFillable enter DecryptedEndPoint@7bdf3083{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,in,OSHUT,-,-,300003/300000,WebSocketClientConnection}->SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,in,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.eclipse.jetty.io.ssl.SslConnection - onFillable exit DecryptedEndPoint@7bdf3083{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,in,OSHUT,-,-,300003/300000,WebSocketClientConnection}->SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,ISHUT,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG org.eclipse.jetty.io.SelectorManager - Destroyed SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,ISHUT,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=-1,kro=-1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.c.i.AbstractWebSocketConnection - CLIENT onClose() 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG o.e.jetty.io.AbstractConnection - FILLING-->IDLE SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - onClose WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Ignoring cancelled key for channel java.nio.channels.SocketChannel[closed] 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Running change org.eclipse.jetty.io.SelectChannelEndPoint$1@6d78da9b 16:08:12.693 [WebSocketClient@1606176605-203-selector-WebSocketClientSelectorManager@38287dd2/0] DEBUG org.eclipse.jetty.io.SelectorManager - Selector loop waiting on select 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.jetty.io.AbstractConnection - onClose SslConnection@5e3f9e00{NEED_UNWRAP,eio=-1/-1,di=-1} -> WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.eclipse.jetty.io.AbstractEndPoint - onClose SelectChannelEndPoint@67181316{10.1.2.2/10.1.2.2:8443<->35214,CLOSED,ISHUT,OSHUT,-,-,0/300000,SslConnection}{io=0,kio=-1,kro=-1} 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.websocket.common.io.IOState - WebSocketSession.onConnectionStateChange(CLOSED) 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.WebSocketSession - WebSocketClient.onSessionClosed() 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.client.WebSocketClient - Session Closed: WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@4b97da4f[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@4b97da4f[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection] 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection] 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED WebSocketSession[websocket=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],behavior=CLIENT,connection=WebSocketClientConnection@6fc8932d{IDLE}{f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@17231a79[ExtensionStack,s=START,c=0,len=1274,f=null,p=WebSocketPolicy@6c0f73bc[behavior=CLIENT,maxTextMessageSize=65536,maxTextMessageBufferSize=32768,maxBinaryMessageSize=65536,maxBinaryMessageBufferSize=32768,asyncWriteTimeout=60000,idleTimeout=300000,inputBufferSize=4096]]},remote=WebSocketRemoteEndpoint@4b97da4f[batching=true],incoming=JettyListenerEventDriver[com.openshift.internal.restclient.WatchClient$WatchEndpoint],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]] 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.WebSocketSession - notifyClose(1001,Idle Timeout) 16:08:12.693 [WebSocketClient@1606176605-325] DEBUG o.e.j.w.common.io.FrameFlusher - Flusher[queueSize=0,aggregateSize=0,failure=null] processing 0 entries: [] 16:08:40.319 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@25c0071b{10.1.2.2/10.1.2.2:8443<->35146,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 300000 ms, remaining: 0 ms 16:08:40.319 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@25c0071b{10.1.2.2/10.1.2.2:8443<->35146,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} idle timeout expired 16:08:40.319 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@4811098d{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:40.319 [WebSocketClient@1606176605-scheduler] DEBUG o.eclipse.jetty.io.AbstractEndPoint - Ignored idle endpoint SelectChannelEndPoint@25c0071b{10.1.2.2/10.1.2.2:8443<->35146,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:40.321 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@449edc24{10.1.2.2/10.1.2.2:8443<->35202,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 300000 ms, remaining: 0 ms 16:08:40.321 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@449edc24{10.1.2.2/10.1.2.2:8443<->35202,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} idle timeout expired 16:08:40.321 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@45ca83b0{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms 16:08:40.321 [WebSocketClient@1606176605-scheduler] DEBUG o.eclipse.jetty.io.AbstractEndPoint - Ignored idle endpoint SelectChannelEndPoint@449edc24{10.1.2.2/10.1.2.2:8443<->35202,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} 16:08:40.322 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@582704cc{10.1.2.2/10.1.2.2:8443<->35198,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} idle timeout check, elapsed: 300000 ms, remaining: 0 ms 16:08:40.322 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.IdleTimeout - SelectChannelEndPoint@582704cc{10.1.2.2/10.1.2.2:8443<->35198,Open,in,out,-,-,300000/300000,SslConnection}{io=0,kio=0,kro=1} idle timeout expired 16:08:40.323 [WebSocketClient@1606176605-scheduler] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@1c48aa7c{IDLE} java.util.concurrent.TimeoutException: Idle timeout expired: 300000/300000 ms {code}