Admin status command generates excessive logs

Solution In Progress - Updated -

Issue

Running an out-of-the-box A-MQ 6.2.0+P2 patch, when launching the below status command, a large series of logs is generated. This is particularly bad when using this admin command as a recurring health-monitoring entry point (let's say: every minute).
./admin status root

2015-11-06 16:43:24,295 | INFO  | d]-nio2-thread-1 | Nio2Session   | .sshd.common.io.nio2.Nio2Session  128 | 39 - 
org.apache.sshd.core - 0.12.0.redhat-002 | Exception handler threw exception, closing the session
java.lang.IllegalStateException: No session available
        at org.apache.sshd.common.AbstractSessionIoHandler.exceptionCaught(AbstractSessionIoHandler.java:49)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2Session.exceptionCaught(Nio2Session.java:126)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2Session.access$500(Nio2Session.java:47)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2Session$2.onFailed(Nio2Session.java:230)
        at org.apache.sshd.common.io.nio2.Nio2CompletionHandler$2.run(Nio2CompletionHandler.java:41)
        at java.security.AccessController.doPrivileged(Native Method)[:1.8.0_45]
        at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.failed(Nio2CompletionHandler.java:39)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:128)[:1.8.0_45]
        at sun.nio.ch.Invoker.invokeDirect(Invoker.java:157)[:1.8.0_45]
        at sun.nio.ch.UnixAsynchronousSocketChannelImpl.implWrite(UnixAsynchronousSocketChannelImpl.java:736)[:1.8.0_45]
        at sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:382)[:1.8.0_45]
        at sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:399)[:1.8.0_45]
        at java.nio.channels.AsynchronousSocketChannel.write(AsynchronousSocketChannel.java:577)[:1.8.0_45]
        at org.apache.sshd.common.io.nio2.Nio2Session.startWriting(Nio2Session.java:212)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2Session.write(Nio2Session.java:115)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.session.AbstractSession.doWritePacket(AbstractSession.java:508)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.session.AbstractSession.writePacket(AbstractSession.java:495)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.session.AbstractSession.sendKexInit(AbstractSession.java:856)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.server.session.ServerSession.sendKexInit(ServerSession.java:128)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.server.session.ServerSession.<init>(ServerSession.java:60)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.server.session.SessionFactory.doCreateSession(SessionFactory.java:43)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.session.AbstractSessionFactory.createSession(AbstractSessionFactory.java:38)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.AbstractSessionIoHandler.sessionCreated(AbstractSessionIoHandler.java:36)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2Acceptor$AcceptCompletionHandler.onCompleted(Nio2Acceptor.java:127)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2Acceptor$AcceptCompletionHandler.onCompleted(Nio2Acceptor.java:108)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at org.apache.sshd.common.io.nio2.Nio2CompletionHandler$1.run(Nio2CompletionHandler.java:32)
        at java.security.AccessController.doPrivileged(Native Method)[:1.8.0_45]
        at org.apache.sshd.common.io.nio2.Nio2CompletionHandler.completed(Nio2CompletionHandler.java:30)[39:org.apache.sshd.core:0.12.0.redhat-002]
        at sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:126)[:1.8.0_45]
        at sun.nio.ch.Invoker$2.run(Invoker.java:218)[:1.8.0_45]
        at sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:112)[:1.8.0_45]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_45]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_45]
        at java.lang.Thread.run(Thread.java:745)[:1.8.0_45]
Caused by: java.io.IOException: Broken pipe
        at sun.nio.ch.FileDispatcherImpl.write0(Native Method)[:1.8.0_45]
        at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:47)[:1.8.0_45]
        at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:93)[:1.8.0_45]
        at sun.nio.ch.IOUtil.write(IOUtil.java:65)[:1.8.0_45]
        at sun.nio.ch.UnixAsynchronousSocketChannelImpl.implWrite(UnixAsynchronousSocketChannelImpl.java:691)[:1.8.0_45]
        ... 24 more
2015-11-06 16:45:24,532 | INFO  | ]-timer-thread-1 | ServerSession    | d.common.session.AbstractSession 1052 | 39 - 
org.apache.sshd.core - 0.12.0.redhat-002 | Disconnecting: Session has timed out waiting for authentication after 120000 ms.

Occurs every minute as the command is used for automatic health monitoring

Environment

  • Red Hat JBoss A-MQ
    • 6.2.0, 6.1.0

Subscriber exclusive content

A Red Hat subscription provides unlimited access to our knowledgebase, tools, and much more.

Current Customers and Partners

Log in for full access

Log In

New to Red Hat?

Learn more about Red Hat subscriptions

Using a Red Hat product through a public cloud?

How to access this content