[
https://issues.apache.org/jira/browse/QPID-6257?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14235310#comment-14235310
]
ASF subversion and git services commented on QPID-6257:
-------------------------------------------------------
Commit 1643208 from [email protected] in branch 'qpid/trunk'
[ https://svn.apache.org/r1643208 ]
QPID-6257: Introduce operational log for connection being dropped by the
clients or due to network issue and change the log level for SenderExceptions
into INFO/DEBUG
> [Java Broker] Excessive ERROR log entry is added into a Broker log file on
> unexpected socket close by the client
> ----------------------------------------------------------------------------------------------------------------
>
> Key: QPID-6257
> URL: https://issues.apache.org/jira/browse/QPID-6257
> Project: Qpid
> Issue Type: Bug
> Components: Java Broker
> Affects Versions: 0.30
> Reporter: Alex Rudyy
> Assignee: Alex Rudyy
> Fix For: 0.31
>
> Attachments:
> 0001-QPID-6257-Introduce-operational-log-for-connection-b.patch,
> Introduce_operational_log_for_unexpected_connection_close_and_reduce_logging_l.patch
>
>
> The org.apache.qpid.transport.SenderClosedException is logged using ERROR log
> level. The log severity should be reduced (to INFO/DEBUG ???)
> {noformat}
> 2014-11-12 11:30:48,632 DEBUG [pool-1-thread-9] (queue.QueueRunner) - Problem
> during asynchronous delivery by
> org.apache.qpid.server.queue.QueueRunner$1@7c2e85e5
> org.apache.qpid.transport.SenderClosedException: sender for socket
> /169.124.113.161:34264 is closed
> at
> org.apache.qpid.transport.network.io.IoSender.checkNotAlreadyClosed(IoSender.java:361)
> at
> org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:146)
> at
> org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:37)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.writeFrame(AMQProtocolEngine.java:724)
> at
> org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeFrame(ProtocolOutputConverterImpl.java:430)
> at
> org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDeliveryUnchanged(ProtocolOutputConverterImpl.java:215)
> at
> org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:141)
> at
> org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeMessageDelivery(ProtocolOutputConverterImpl.java:101)
> at
> org.apache.qpid.server.protocol.v0_8.output.ProtocolOutputConverterImpl.writeDeliver(ProtocolOutputConverterImpl.java:78)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine$WriteDeliverMethod.deliverToClient(AMQProtocolEngine.java:1662)
> at
> org.apache.qpid.server.protocol.v0_8.ConsumerTarget_0_8.sendToClient(ConsumerTarget_0_8.java:513)
> at
> org.apache.qpid.server.protocol.v0_8.ConsumerTarget_0_8$AckConsumer.send(ConsumerTarget_0_8.java:317)
> at
> org.apache.qpid.server.queue.QueueConsumerImpl.send(QueueConsumerImpl.java:475)
> at
> org.apache.qpid.server.queue.AbstractQueue.deliverMessage(AbstractQueue.java:1239)
> at
> org.apache.qpid.server.queue.AbstractQueue.attemptDelivery(AbstractQueue.java:2001)
> at
> org.apache.qpid.server.queue.AbstractQueue.processQueue(AbstractQueue.java:2172)
> at org.apache.qpid.server.queue.QueueRunner$1.run(QueueRunner.java:77)
> at java.security.AccessController.doPrivileged(Native Method)
> at javax.security.auth.Subject.doAs(Subject.java:356)
> at org.apache.qpid.server.queue.QueueRunner.run(QueueRunner.java:68)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.net.SocketException: Connection reset
> at
> java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:118)
> at java.net.SocketOutputStream.write(SocketOutputStream.java:159)
> at
> org.apache.qpid.transport.network.io.IoSender.run(IoSender.java:299)
> ... 1 more
> 2014-11-12 11:30:48,632 DEBUG [IoReceiver - /169.124.113.161:34264]
> (v0_8.AMQProtocolEngine) - SEND: Frame channelId: 1, bodyFrame:
> [ChannelCloseOkBodyImpl: ]
> 2014-11-12 11:30:48,635 ERROR [IoReceiver - /169.124.113.161:34264]
> (v0_8.AMQProtocolEngine) - Unexpected exception while processing frame.
> Closing connection.
> org.apache.qpid.transport.SenderClosedException: sender for socket
> /169.124.113.161:34264 is closed
> at
> org.apache.qpid.transport.network.io.IoSender.checkNotAlreadyClosed(IoSender.java:361)
> at
> org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:111)
> at
> org.apache.qpid.transport.network.io.IoSender.send(IoSender.java:37)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.writeFrame(AMQProtocolEngine.java:724)
> at
> org.apache.qpid.server.protocol.v0_8.handler.ChannelCloseHandler.methodReceived(ChannelCloseHandler.java:74)
> at
> org.apache.qpid.server.protocol.v0_8.handler.ServerMethodDispatcherImpl.dispatchChannelClose(ServerMethodDispatcherImpl.java:228)
> at
> org.apache.qpid.framing.amqp_0_9.ChannelCloseBodyImpl.execute(ChannelCloseBodyImpl.java:127)
> at
> org.apache.qpid.server.protocol.v0_8.state.AMQStateManager$1.run(AMQStateManager.java:122)
> at
> org.apache.qpid.server.protocol.v0_8.state.AMQStateManager$1.run(AMQStateManager.java:118)
> at java.security.AccessController.doPrivileged(Native Method)
> at javax.security.auth.Subject.doAs(Subject.java:415)
> at
> org.apache.qpid.server.protocol.v0_8.state.AMQStateManager.methodReceived(AMQStateManager.java:117)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.methodFrameReceived(AMQProtocolEngine.java:626)
> at
> org.apache.qpid.framing.AMQMethodBodyImpl.handle(AMQMethodBodyImpl.java:99)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.frameReceived(AMQProtocolEngine.java:477)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.dataBlockReceived(AMQProtocolEngine.java:412)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.access$1100(AMQProtocolEngine.java:89)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine$2.run(AMQProtocolEngine.java:311)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine$2.run(AMQProtocolEngine.java:283)
> at java.security.AccessController.doPrivileged(Native Method)
> at javax.security.auth.Subject.doAs(Subject.java:356)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:282)
> at
> org.apache.qpid.server.protocol.v0_8.AMQProtocolEngine.received(AMQProtocolEngine.java:89)
> at
> org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:134)
> at
> org.apache.qpid.server.protocol.MultiVersionProtocolEngine.received(MultiVersionProtocolEngine.java:50)
> at
> org.apache.qpid.transport.network.io.IoReceiver.run(IoReceiver.java:161)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.net.SocketException: Connection reset
> at
> java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:118)
> at java.net.SocketOutputStream.write(SocketOutputStream.java:159)
> at
> org.apache.qpid.transport.network.io.IoSender.run(IoSender.java:299)
> ... 1 more
> 2014-11-12 11:30:48,635 DEBUG [IoReceiver - /169.124.113.161:34264]
> (state.AMQStateManager) - State changing to CONNECTION_CLOSED from old state
> CONNECTION_OPEN
> 2014-11-12 11:30:48,636 DEBUG [IoReceiver - /169.124.113.161:34264]
> (v0_8.AMQProtocolEngine) - Frame handled in 4109 ms. Frame: Frame channelId:
> 1, bodyFrame: [ChannelCloseBodyImpl: replyCode=200, replyText=JMS client
> closing channel, classId=0, methodId=0]
> 2014-11-12 11:30:48,636 DEBUG [IoReceiver - /169.124.113.161:34264]
> (v0_8.AMQChannel) - sync() called on channel 1(42262038)
> 2014-11-12 11:30:48,636 INFO [IoReceiver - /169.124.113.161:34264]
> (connection.close) - [con:17(guest@/169.124.113.161:34264/default)]
> [con:17(guest@/169.124.113.161:34264/default)] CON-1002 : Close
> 2014-11-12 11:30:48,636 DEBUG [IoReceiver - /169.124.113.161:34264]
> (state.AMQStateManager) - State changing to CONNECTION_CLOSED
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
