Skip to main content

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
Re: [jetty-users] Recevied data frames different from Nginx log in HTTP/2

Thanks to tell me the way enable the log.

Sure the the protocol I use is HTTP/2. The log print in the console below:

2015-10-21 22:16:33.319:INFO::main: Logging initialized @250ms

2015-10-21 22:16:33.902:DBUG:oejh.HTTP2Session:qtp1360875712-10: Sending PrefaceFrame@6a3cebe1

2015-10-21 22:16:33.902:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Appended PrefaceFrame@6a3cebe1, frames=1

2015-10-21 22:16:33.902:DBUG:oejh.HTTP2Session:qtp1360875712-10: Sending SettingsFrame@63c8eec2,reply=false:{}

2015-10-21 22:16:33.902:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Appended SettingsFrame@63c8eec2,reply=false:{}, frames=2

2015-10-21 22:16:33.903:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Flushing HTTP2ClientSession@f6ec4f3{queueSize=2,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.903:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Gathered for write PrefaceFrame@6a3cebe1

2015-10-21 22:16:33.903:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Gathered for write SettingsFrame@63c8eec2,reply=false:{}

2015-10-21 22:16:33.904:DBUG:oejh.HTTP2Session:qtp1360875712-10: Generated PrefaceFrame@6a3cebe1

2015-10-21 22:16:33.904:DBUG:oejh.HTTP2Session:qtp1360875712-10: Generated SettingsFrame@63c8eec2,reply=false:{}

2015-10-21 22:16:33.905:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Writing 2 buffers (33 bytes) for 2 frames [PrefaceFrame@6a3cebe1, SettingsFrame@63c8eec2,reply=false:{}]

2015-10-21 22:16:33.908:DBUG:oejh.HTTP2Connection:qtp1360875712-10: HTTP2 Open HTTP2ClientConnection@22e56ec9 

2015-10-21 22:16:33.908:DBUG:oejh.HTTP2Flusher:qtp1360875712-14: Written 2 frames for [PrefaceFrame@6a3cebe1, SettingsFrame@63c8eec2,reply=false:{}]

2015-10-21 22:16:33.908:DBUG:oejh.HTTP2Connection:qtp1360875712-10: Dequeued task null

2015-10-21 22:16:33.908:DBUG:oejh.HTTP2Connection:qtp1360875712-10: Filled 40 bytes

2015-10-21 22:16:33.908:DBUG:oejh.HTTP2Flusher:qtp1360875712-14: Flushing HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.908:DBUG:oejhp.Parser:qtp1360875712-10: Parsed SETTINGS frame header

2015-10-21 22:16:33.908:DBUG:oejhp.Parser:qtp1360875712-10: Parsing SETTINGS frame

2015-10-21 22:16:33.908:DBUG:oejh.HTTP2Flusher:qtp1360875712-14: Flushed HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.909:DBUG:oejhp.SettingsBodyParser:qtp1360875712-10: setting 3=5

2015-10-21 22:16:33.909:DBUG:oejhp.SettingsBodyParser:qtp1360875712-10: setting 4=2147483647

2015-10-21 22:16:33.909:DBUG:oejhp.SettingsBodyParser:qtp1360875712-10: setting 5=16777215

2015-10-21 22:16:33.909:DBUG:oejh.HTTP2Session:qtp1360875712-10: Received SettingsFrame@2f0bea97,reply=false:{3=5, 4=2147483647, 5=16777215}

2015-10-21 22:16:33.909:DBUG:oejh.HTTP2Session:qtp1360875712-10: Update max local concurrent streams to 5

2015-10-21 22:16:33.909:DBUG:oejh.HTTP2Session:qtp1360875712-10: Update initial window size to 2147483647

2015-10-21 22:16:33.910:DBUG:oejh.HTTP2Session:qtp1360875712-10: Update max frame size to 16777215

2015-10-21 22:16:33.910:DBUG:oejh.HTTP2Session:qtp1360875712-10: Sending SettingsFrame@b11bf4a,reply=true:{}

2015-10-21 22:16:33.910:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Appended SettingsFrame@b11bf4a,reply=true:{}, frames=1

2015-10-21 22:16:33.911:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Flushing HTTP2ClientSession@f6ec4f3{queueSize=1,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.911:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Gathered for write SettingsFrame@b11bf4a,reply=true:{}

2015-10-21 22:16:33.911:DBUG:oejh.HTTP2Session:qtp1360875712-10: Generated SettingsFrame@b11bf4a,reply=true:{}

2015-10-21 22:16:33.911:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Writing 1 buffers (9 bytes) for 1 frames [SettingsFrame@b11bf4a,reply=true:{}]

2015-10-21 22:16:33.912:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Written 1 frames for [SettingsFrame@b11bf4a,reply=true:{}]

2015-10-21 22:16:33.912:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Flushing HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.912:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Flushed HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.912:DBUG:oejhp.Parser:qtp1360875712-10: Parsed SETTINGS frame

2015-10-21 22:16:33.913:DBUG:oejhp.Parser:qtp1360875712-10: Parsed WINDOW_UPDATE frame header

2015-10-21 22:16:33.913:DBUG:oejhp.Parser:qtp1360875712-10: Parsing WINDOW_UPDATE frame

2015-10-21 22:16:33.913:DBUG:oejh.HTTP2Session:qtp1360875712-10: Received WindowUpdateFrame@72a1ab87#0,delta=2147418112

2015-10-21 22:16:33.914:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Flushing HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=65525,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.914:DBUG:oejh.FlowControlStrategy:qtp1360875712-10: Updated session send window 65525 -> 2147483637 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.914:DBUG:oejh.HTTP2Flusher:qtp1360875712-10: Flushed HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=65525,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.914:DBUG:oejhp.Parser:qtp1360875712-10: Parsed WINDOW_UPDATE frame

2015-10-21 22:16:33.914:DBUG:oejh.HTTP2Connection:qtp1360875712-10: Dequeued task null

2015-10-21 22:16:33.915:DBUG:oejh.HTTP2Connection:qtp1360875712-10: Filled 9 bytes

2015-10-21 22:16:33.915:DBUG:oejhp.Parser:qtp1360875712-10: Parsed SETTINGS frame header

2015-10-21 22:16:33.915:DBUG:oejhp.Parser:qtp1360875712-10: Parsing SETTINGS frame

2015-10-21 22:16:33.915:DBUG:oejh.HTTP2Session:qtp1360875712-10: Received SettingsFrame@7b3b003c,reply=true:{}

2015-10-21 22:16:33.915:DBUG:oejhp.Parser:qtp1360875712-10: Parsed SETTINGS frame

2015-10-21 22:16:33.915:DBUG:oejh.HTTP2Connection:qtp1360875712-10: Dequeued task null

2015-10-21 22:16:33.915:DBUG:oejh.HTTP2Connection:qtp1360875712-10: Filled 0 bytes

2015-10-21 22:16:33.920:DBUG:oejh.HTTP2Session:main: Created local HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=65525,reset=false,NOT_CLOSED}

2015-10-21 22:16:33.921:DBUG:oejh.HTTP2Flusher:main: Appended HeadersFrame@1554909b#1{end=true}, frames=1

2015-10-21 22:16:33.922:DBUG:oejh.HTTP2Flusher:main: Flushing HTTP2ClientSession@f6ec4f3{queueSize=1,sendWindow=2147483637,recvWindow=65525,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.922:DBUG:oejh.HTTP2Flusher:main: Gathered for write HeadersFrame@1554909b#1{end=true}

2015-10-21 22:16:33.931:DBUG:oejh.HTTP2Session:main: Generated HeadersFrame@1554909b#1{end=true}

2015-10-21 22:16:33.932:DBUG:oejh.HTTP2Flusher:main: Writing 2 buffers (69 bytes) for 1 frames [HeadersFrame@1554909b#1{end=true}]

2015-10-21 22:16:33.932:DBUG:oejh.HTTP2Flusher:main: Written 1 frames for [HeadersFrame@1554909b#1{end=true}]

2015-10-21 22:16:33.932:DBUG:oejh.HTTP2Stream:main: Update close for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=65525,reset=false,NOT_CLOSED} close=true local=true

2015-10-21 22:16:33.932:DBUG:oejh.HTTP2Connection:qtp1360875712-12: HTTP2 onFillable HTTP2ClientConnection@22e56ec9 

2015-10-21 22:16:33.933:DBUG:oejh.HTTP2Connection:qtp1360875712-12: Dequeued task null

2015-10-21 22:16:33.933:DBUG:oejh.HTTP2Flusher:main: Flushing HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=65525,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.933:DBUG:oejh.HTTP2Flusher:main: Flushed HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=65525,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.934:DBUG:oejh.HTTP2Connection:qtp1360875712-12: Filled 8192 bytes

2015-10-21 22:16:33.934:DBUG:oejhp.Parser:qtp1360875712-12: Parsed HEADERS frame header

2015-10-21 22:16:33.934:DBUG:oejhp.Parser:qtp1360875712-12: Parsing HEADERS frame

2015-10-21 22:16:33.935:DBUG:oejhc.HTTP2ClientSession:qtp1360875712-12: Received HeadersFrame@66d607aa#1{end=false}

2015-10-21 22:16:33.935:DBUG:oejh.HTTP2Stream:qtp1360875712-12: Update close for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=65525,reset=false,LOCALLY_CLOSED} close=false local=false

2015-10-21 22:16:33.936:DBUG:oejhp.Parser:qtp1360875712-12: Parsed HEADERS frame

2015-10-21 22:16:33.936:DBUG:oejhp.Parser:qtp1360875712-12: Parsed DATA frame header

2015-10-21 22:16:33.936:DBUG:oejhp.Parser:qtp1360875712-12: Parsing DATA frame

2015-10-21 22:16:33.936:DBUG:oejh.HTTP2Session:qtp1360875712-12: Received DataFrame@3f07336b#1{length:8038,end=false}

2015-10-21 22:16:33.936:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data received, updated session recv window 65525 -> 57487 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57487,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.936:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data received, updated stream recv window 65525 -> 57487 for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57487,reset=false,LOCALLY_CLOSED}

2015-10-21 22:16:33.937:DBUG:oejh.HTTP2Stream:qtp1360875712-12: Update close for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57487,reset=false,LOCALLY_CLOSED} close=false local=false

2015-10-21 22:16:33.938:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data consumed, session recv window level 8038/32762 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57487,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.938:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data consumed, stream recv window level 8038/32762 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57487,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.938:DBUG:oejh.HTTP2Connection:qtp1360875712-12: Dequeued task null

2015-10-21 22:16:33.938:DBUG:oejh.HTTP2Connection:qtp1360875712-12: Filled 185 bytes

2015-10-21 22:16:33.938:DBUG:oejhp.Parser:qtp1360875712-12: Parsing DATA frame

2015-10-21 22:16:33.938:DBUG:oejh.HTTP2Session:qtp1360875712-12: Received DataFrame@37640b49#1{length:154,end=false}

2015-10-21 22:16:33.938:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data received, updated session recv window 57487 -> 57333 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57333,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.938:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data received, updated stream recv window 57487 -> 57333 for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57333,reset=false,LOCALLY_CLOSED}

2015-10-21 22:16:33.939:DBUG:oejh.HTTP2Stream:qtp1360875712-12: Update close for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57333,reset=false,LOCALLY_CLOSED} close=false local=false

2015-10-21 22:16:33.939:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data consumed, session recv window level 8192/32762 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57333,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.939:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data consumed, stream recv window level 8192/32762 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57333,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.939:DBUG:oejhp.Parser:qtp1360875712-12: Parsed DATA frame

2015-10-21 22:16:33.939:DBUG:oejhp.Parser:qtp1360875712-12: Parsed DATA frame header

2015-10-21 22:16:33.939:DBUG:oejhp.Parser:qtp1360875712-12: Parsing DATA frame

2015-10-21 22:16:33.939:DBUG:oejh.HTTP2Session:qtp1360875712-12: Received DataFrame@7424682c#1{length:22,end=true}

2015-10-21 22:16:33.940:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data received, updated session recv window 57333 -> 57311 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57311,streams=1,NOT_CLOSED}

2015-10-21 22:16:33.940:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data received, updated stream recv window 57333 -> 57311 for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57311,reset=false,LOCALLY_CLOSED}

2015-10-21 22:16:33.940:DBUG:oejh.HTTP2Stream:qtp1360875712-12: Update close for HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57311,reset=false,LOCALLY_CLOSED} close=true local=false

2015-10-21 22:16:33.940:DBUG:oejh.HTTP2Session:qtp1360875712-12: Removed HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57311,reset=false,CLOSED}

2015-10-21 22:16:33.940:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data consumed, session recv window level 8214/32762 for HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57311,streams=0,NOT_CLOSED}

2015-10-21 22:16:33.941:DBUG:oejh.FlowControlStrategy:qtp1360875712-12: Data consumed, ignoring update stream recv window by 22 for closed HTTP2Stream@6108b2d7#1{sendWindow=2147483647,recvWindow=57311,reset=false,CLOSED}

2015-10-21 22:16:33.941:DBUG:oejhp.Parser:qtp1360875712-12: Parsed DATA frame

2015-10-21 22:16:33.941:DBUG:oejh.HTTP2Connection:qtp1360875712-12: Dequeued task null

2015-10-21 22:16:33.941:DBUG:oejh.HTTP2Connection:qtp1360875712-12: Filled 0 bytes

2015-10-21 22:16:43.939:DBUG:oejh.HTTP2Session:main: Sending GoAwayFrame@22f71333,0/

2015-10-21 22:16:43.940:DBUG:oejh.HTTP2Session:main: Sending GoAwayFrame@22f71333,0/

2015-10-21 22:16:43.940:DBUG:oejh.HTTP2Flusher:main: Appended GoAwayFrame@22f71333,0/, frames=1

2015-10-21 22:16:43.940:DBUG:oejh.HTTP2Flusher:main: Flushing HTTP2ClientSession@f6ec4f3{queueSize=1,sendWindow=2147483637,recvWindow=57311,streams=0,LOCALLY_CLOSED}

2015-10-21 22:16:43.940:DBUG:oejh.HTTP2Flusher:main: Gathered for write GoAwayFrame@22f71333,0/

2015-10-21 22:16:43.941:DBUG:oejh.HTTP2Session:main: Generated GoAwayFrame@22f71333,0/

2015-10-21 22:16:43.941:DBUG:oejh.HTTP2Flusher:main: Writing 1 buffers (17 bytes) for 1 frames [GoAwayFrame@22f71333,0/]

2015-10-21 22:16:43.943:DBUG:oejh.HTTP2Flusher:main: Written 1 frames for [GoAwayFrame@22f71333,0/]

2015-10-21 22:16:43.945:DBUG:oejh.HTTP2Flusher:main: Flushing HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57311,streams=0,LOCALLY_CLOSED}

2015-10-21 22:16:43.945:DBUG:oejh.HTTP2Flusher:main: Flushed HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57311,streams=0,LOCALLY_CLOSED}

2015-10-21 22:16:43.946:DBUG:oejh.HTTP2Connection:qtp1360875712-15: HTTP2 onFillable HTTP2ClientConnection@22e56ec9 

2015-10-21 22:16:43.946:DBUG:oejh.HTTP2Connection:qtp1360875712-15: Dequeued task null

2015-10-21 22:16:43.948:DBUG:oejh.HTTP2Connection:qtp1360875712-15: Filled -1 bytes

2015-10-21 22:16:43.948:DBUG:oejh.HTTP2Connection:qtp1360875712-16: HTTP2 Close HTTP2ClientConnection@22e56ec9 

2015-10-21 22:16:43.948:DBUG:oejh.HTTP2Session:qtp1360875712-15: Shutting down HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57311,streams=0,LOCALLY_CLOSED}

2015-10-21 22:16:43.949:DBUG:oejh.HTTP2Session:qtp1360875712-15: Sending DisconnectFrame@6672865a

2015-10-21 22:16:43.949:DBUG:oejh.HTTP2Flusher:qtp1360875712-15: Appended DisconnectFrame@6672865a, frames=1

2015-10-21 22:16:43.949:DBUG:oejh.HTTP2Flusher:qtp1360875712-15: Flushing HTTP2ClientSession@f6ec4f3{queueSize=1,sendWindow=2147483637,recvWindow=57311,streams=0,LOCALLY_CLOSED}

2015-10-21 22:16:43.949:DBUG:oejh.HTTP2Flusher:qtp1360875712-15: Gathered for write DisconnectFrame@6672865a

2015-10-21 22:16:43.949:DBUG:oejh.HTTP2Session:qtp1360875712-15: Generated DisconnectFrame@6672865a

2015-10-21 22:16:43.949:DBUG:oejh.HTTP2Flusher:qtp1360875712-15: Writing 0 buffers (0 bytes) for 1 frames [DisconnectFrame@6672865a]

2015-10-21 22:16:43.950:DBUG:oejh.HTTP2Flusher:qtp1360875712-15: Failed

org.eclipse.jetty.io.EofException

at org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.flush(SslConnection.java:725)

at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:419)

at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:313)

at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:141)

at org.eclipse.jetty.http2.HTTP2Flusher.process(HTTP2Flusher.java:259)

at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241)

at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:224)

at org.eclipse.jetty.http2.HTTP2Session.frame(HTTP2Session.java:607)

at org.eclipse.jetty.http2.HTTP2Session.frames(HTTP2Session.java:581)

at org.eclipse.jetty.http2.HTTP2Session.control(HTTP2Session.java:567)

at org.eclipse.jetty.http2.HTTP2Session.onShutdown(HTTP2Session.java:808)

at org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer.produce(HTTP2Connection.java:181)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:162)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.execute(ExecuteProduceConsume.java:101)

at org.eclipse.jetty.http2.HTTP2Connection.onFillable(HTTP2Connection.java:96)

at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:245)

at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)

at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:192)

at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:245)

at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)

at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)

at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)

at org.eclipse.jetty.util.thread.QueuedThreadPool$1.run(QueuedThreadPool.java:572)

at java.lang.Thread.run(Thread.java:745)

Caused by: 

java.nio.channels.ClosedChannelException

at org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.flush(SslConnection.java:725)

at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:419)

at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:313)

at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:141)

at org.eclipse.jetty.http2.HTTP2Flusher.process(HTTP2Flusher.java:259)

at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241)

at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:224)

at org.eclipse.jetty.http2.HTTP2Session.frame(HTTP2Session.java:607)

at org.eclipse.jetty.http2.HTTP2Session.frames(HTTP2Session.java:581)

at org.eclipse.jetty.http2.HTTP2Session.control(HTTP2Session.java:567)

at org.eclipse.jetty.http2.HTTP2Session.onShutdown(HTTP2Session.java:808)

at org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer.produce(HTTP2Connection.java:181)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:162)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.execute(ExecuteProduceConsume.java:101)

at org.eclipse.jetty.http2.HTTP2Connection.onFillable(HTTP2Connection.java:96)

at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:245)

at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)

at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:192)

at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:245)

at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)

at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)

at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)

at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)

at org.eclipse.jetty.util.thread.QueuedThreadPool$1.run(QueuedThreadPool.java:572)

at java.lang.Thread.run(Thread.java:745)

2015-10-21 22:16:43.952:DBUG:oejh.HTTP2Flusher:qtp1360875712-15: Aborting, queued=0

2015-10-21 22:16:43.952:DBUG:oejh.HTTP2Session:qtp1360875712-15: Disconnecting HTTP2ClientSession@f6ec4f3{queueSize=0,sendWindow=2147483637,recvWindow=57311,streams=0,CLOSED}


2015-10-21 21:37 GMT+08:00 Simone Bordet <sbordet@xxxxxxxxxxx>:
Hi,

On Wed, Oct 21, 2015 at 3:30 PM, Muhui Jiang <jiangmuhui@xxxxxxxxx> wrote:
> I don't know how to open the log for all the class. I set the enablelog to
> be true in the Http2Session and Http2Flusher manually. Below is the log.

The logs show the frame being received, not sent.

What client are you using for sending ?
If you're using the Jetty HTTP2 client, then I need the client debug logs.

For the logging, just include a "jetty-logging.properties" in your
classpath with the following content:

org.eclipse.jetty.util.log.class=org.eclipse.jetty.util.log.StdErrLog
org.eclipse.jetty.http2.LEVEL=DEBUG
org.eclipse.jetty.http2.hpack.LEVEL=INFO

--
Simone Bordet
----
http://cometd.org
http://webtide.com
Developer advice, training, services and support
from the Jetty & CometD experts.
_______________________________________________
jetty-users mailing list
jetty-users@xxxxxxxxxxx
To change your delivery options, retrieve your password, or unsubscribe from this list, visit
https://dev.eclipse.org/mailman/listinfo/jetty-users


Back to the top