Jakub Scholz created QPIDJMS-90:
-----------------------------------

             Summary: Received empty frames are not logged 
                 Key: QPIDJMS-90
                 URL: https://issues.apache.org/jira/browse/QPIDJMS-90
             Project: Qpid JMS
          Issue Type: Bug
          Components: qpid-jms-client
    Affects Versions: 0.3.0
            Reporter: Jakub Scholz
            Priority: Minor


When idle timeout is enabled, the client and broker are using empty frames to 
keep the connection alive. However, when logging of frames is enabled, only the 
sent empty frames seem to be logged - the received seem to never appear in the 
log:
2015-07-24T00:04:18.489+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:04:18.489+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:04:18.489+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000
2015-07-24T00:04:18.491+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:04:48.493+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:04:48.493+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:04:48.493+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000
2015-07-24T00:04:48.496+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:05:18.500+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:05:18.500+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:05:18.500+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000
2015-07-24T00:05:18.502+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:05:48.437+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:05:48.504+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:05:48.504+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:05:48.504+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000
2015-07-24T00:06:18.510+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:06:18.511+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:06:18.511+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000
2015-07-24T00:06:18.513+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:06:48.437+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:06:48.514+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:06:48.514+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:06:48.514+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000
2015-07-24T00:07:18.438+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - New data read: 8 bytes 
incoming: UnpooledHeapByteBuf(ridx: 0, widx: 8, cap: 65536)
2015-07-24T00:07:18.517+0200 TRACE org.apache.qpid.jms.provider.amqp.FRAMES - 
SENT: null
2015-07-24T00:07:18.517+0200 TRACE 
org.apache.qpid.jms.transports.netty.NettyTcpTransport - Attempted write of: 8 
bytes
2015-07-24T00:07:18.517+0200 TRACE 
org.apache.qpid.jms.provider.amqp.AmqpProvider - IdleTimeoutCheck rescheduling 
with delay: 30000

It would be great if both sent and received empty frames can be logged.

This problem seems to appear both in 0.3.0 as well as in the latest 
0.4.0-SNAPSHOT.



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@qpid.apache.org
For additional commands, e-mail: dev-h...@qpid.apache.org

Reply via email to