Uploaded image for project: 'JBoss A-MQ'
  1. JBoss A-MQ
  2. ENTMQ-307 AMQP hardening
  3. ENTMQ-318

TopicSessionTest.testUnsubscribe hangs

    XMLWordPrintable

Details

    • Sub-task
    • Resolution: Done
    • Major
    • None
    • 7.1.0.fuse-046
    • None
    • None

    Description

      Stack trace is below, this is hanging at TopicSessionTest.java:148

      Full thread dump Java HotSpot(TM) 64-Bit Server VM (23.7-b01 mixed mode):

      "Attach Listener" daemon prio=5 tid=0x00007fe200048000 nid=0x7f0b waiting on condition [0x0000000000000000]
      java.lang.Thread.State: RUNNABLE

      "ActiveMQ Transport: tcp:///127.0.0.1:55053@55051" daemon prio=5 tid=0x00007fe1fd0c8000 nid=0x7e03 runnable [0x000000018647a000]
      java.lang.Thread.State: RUNNABLE
      at java.net.SocketInputStream.socketRead0(Native Method)
      at java.net.SocketInputStream.read(SocketInputStream.java:150)
      at java.net.SocketInputStream.read(SocketInputStream.java:121)
      at org.apache.activemq.transport.tcp.TcpBufferedInputStream.fill(TcpBufferedInputStream.java:50)
      at org.apache.activemq.transport.tcp.TcpTransport$2.fill(TcpTransport.java:604)
      at org.apache.activemq.transport.tcp.TcpBufferedInputStream.read(TcpBufferedInputStream.java:58)
      at org.apache.activemq.transport.tcp.TcpTransport$2.read(TcpTransport.java:589)
      at java.io.DataInputStream.readInt(DataInputStream.java:387)
      at org.apache.activemq.transport.amqp.AmqpWireFormat.unmarshal(AmqpWireFormat.java:62)
      at org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:221)
      at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:213)
      at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:196)
      at java.lang.Thread.run(Thread.java:722)

      "Thread-16" prio=5 tid=0x00007fe20083a800 nid=0x7d03 in Object.wait() [0x0000000186377000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x00000001571a4968> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at java.lang.Object.wait(Object.java:503)
        at org.apache.qpid.amqp_1_0.jms.impl.SessionImpl$Dispatcher.run(SessionImpl.java:773)
      • locked <0x00000001571a4968> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at java.lang.Thread.run(Thread.java:722)

      "Thread-15" daemon prio=5 tid=0x00007fe1fc056000 nid=0x7c03 runnable [0x0000000186274000]
      java.lang.Thread.State: RUNNABLE
      at java.net.SocketInputStream.socketRead0(Native Method)
      at java.net.SocketInputStream.read(SocketInputStream.java:150)
      at java.net.SocketInputStream.read(SocketInputStream.java:121)
      at java.net.SocketInputStream.read(SocketInputStream.java:107)
      at org.apache.qpid.amqp_1_0.client.Connection.doRead(Connection.java:337)
      at org.apache.qpid.amqp_1_0.client.Connection.access$000(Connection.java:42)
      at org.apache.qpid.amqp_1_0.client.Connection$2.run(Connection.java:243)
      at java.lang.Thread.run(Thread.java:722)

      "Thread-14" daemon prio=5 tid=0x00007fe1fc055800 nid=0x7b03 in Object.wait() [0x0000000186171000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x00000001571a4968> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$FrameOutput.getNextFrame(ConnectionHandler.java:175)
      • locked <0x00000001571a4968> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$FrameToBytesSourceAdapter.getBytes(ConnectionHandler.java:275)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$SequentialBytesSource.getBytes(ConnectionHandler.java:371)
      • locked <0x00000001571a72e0> (a org.apache.qpid.amqp_1_0.framing.ConnectionHandler$SequentialBytesSource)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$BytesOutputHandler.run(ConnectionHandler.java:404)
        at java.lang.Thread.run(Thread.java:722)

      "ActiveMQ Transport: tcp:///127.0.0.1:55052@55051" daemon prio=5 tid=0x00007fe1fc291000 nid=0x7903 runnable [0x0000000185f6b000]
      java.lang.Thread.State: RUNNABLE
      at java.net.SocketInputStream.socketRead0(Native Method)
      at java.net.SocketInputStream.read(SocketInputStream.java:150)
      at java.net.SocketInputStream.read(SocketInputStream.java:121)
      at org.apache.activemq.transport.tcp.TcpBufferedInputStream.fill(TcpBufferedInputStream.java:50)
      at org.apache.activemq.transport.tcp.TcpTransport$2.fill(TcpTransport.java:604)
      at org.apache.activemq.transport.tcp.TcpBufferedInputStream.read(TcpBufferedInputStream.java:58)
      at org.apache.activemq.transport.tcp.TcpTransport$2.read(TcpTransport.java:589)
      at java.io.DataInputStream.readInt(DataInputStream.java:387)
      at org.apache.activemq.transport.amqp.AmqpWireFormat.unmarshal(AmqpWireFormat.java:62)
      at org.apache.activemq.transport.tcp.TcpTransport.readCommand(TcpTransport.java:221)
      at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:213)
      at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:196)
      at java.lang.Thread.run(Thread.java:722)

      "Thread-13" prio=5 tid=0x00007fe1fc2e5000 nid=0x7703 in Object.wait() [0x0000000185d65000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x0000000157115990> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at java.lang.Object.wait(Object.java:503)
        at org.apache.qpid.amqp_1_0.jms.impl.SessionImpl$Dispatcher.run(SessionImpl.java:773)
      • locked <0x0000000157115990> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at java.lang.Thread.run(Thread.java:722)

      "Thread-12" daemon prio=5 tid=0x00007fe1fe183000 nid=0x7603 runnable [0x0000000185c62000]
      java.lang.Thread.State: RUNNABLE
      at java.net.SocketInputStream.socketRead0(Native Method)
      at java.net.SocketInputStream.read(SocketInputStream.java:150)
      at java.net.SocketInputStream.read(SocketInputStream.java:121)
      at java.net.SocketInputStream.read(SocketInputStream.java:107)
      at org.apache.qpid.amqp_1_0.client.Connection.doRead(Connection.java:337)
      at org.apache.qpid.amqp_1_0.client.Connection.access$000(Connection.java:42)
      at org.apache.qpid.amqp_1_0.client.Connection$2.run(Connection.java:243)
      at java.lang.Thread.run(Thread.java:722)

      "Thread-11" daemon prio=5 tid=0x00007fe1fe16e800 nid=0x7503 in Object.wait() [0x0000000185b5f000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x0000000157115990> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$FrameOutput.getNextFrame(ConnectionHandler.java:175)
      • locked <0x0000000157115990> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$FrameToBytesSourceAdapter.getBytes(ConnectionHandler.java:275)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$SequentialBytesSource.getBytes(ConnectionHandler.java:371)
      • locked <0x0000000157118308> (a org.apache.qpid.amqp_1_0.framing.ConnectionHandler$SequentialBytesSource)
        at org.apache.qpid.amqp_1_0.framing.ConnectionHandler$BytesOutputHandler.run(ConnectionHandler.java:404)
        at java.lang.Thread.run(Thread.java:722)

      "ActiveMQ Transport Server: amqp://localhost:0" daemon prio=5 tid=0x00007fe1fd357000 nid=0x7403 runnable [0x00000001857ba000]
      java.lang.Thread.State: RUNNABLE
      at java.net.PlainSocketImpl.socketAccept(Native Method)
      at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:398)
      at java.net.ServerSocket.implAccept(ServerSocket.java:522)
      at java.net.ServerSocket.accept(ServerSocket.java:490)
      at org.apache.activemq.transport.tcp.TcpTransportServer.run(TcpTransportServer.java:274)
      at java.lang.Thread.run(Thread.java:722)

      "ActiveMQ Transport Server Thread Handler: amqp://localhost:0" daemon prio=5 tid=0x00007fe1ff0b1800 nid=0x7303 waiting on condition [0x00000001856b7000]
      java.lang.Thread.State: TIMED_WAITING (parking)
      at sun.misc.Unsafe.park(Native Method)

      • parking to wait for <0x0000000156f240a0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
        at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
        at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
        at org.apache.activemq.transport.tcp.TcpTransportServer$1.run(TcpTransportServer.java:346)
        at java.lang.Thread.run(Thread.java:722)

      "ActiveMQ Broker[localhost] Scheduler" daemon prio=5 tid=0x00007fe1ff0b6000 nid=0x7203 in Object.wait() [0x0000000184e9f000]
      java.lang.Thread.State: TIMED_WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x000000015701be00> (a java.util.TaskQueue)
        at java.util.TimerThread.mainLoop(Timer.java:552)
      • locked <0x000000015701be00> (a java.util.TaskQueue)
        at java.util.TimerThread.run(Timer.java:505)

      "RMI Reaper" prio=5 tid=0x00007fe1ff84b000 nid=0x7103 in Object.wait() [0x00000001850a5000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x000000010b2e0890> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
      • locked <0x000000010b2e0890> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151)
        at sun.rmi.transport.ObjectTable$Reaper.run(ObjectTable.java:351)
        at java.lang.Thread.run(Thread.java:722)

      "RMI TCP Accept-1099" daemon prio=5 tid=0x00007fe1fd1ef800 nid=0x6f03 runnable [0x0000000184d9c000]
      java.lang.Thread.State: RUNNABLE
      at java.net.PlainSocketImpl.socketAccept(Native Method)
      at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:398)
      at java.net.ServerSocket.implAccept(ServerSocket.java:522)
      at java.net.ServerSocket.accept(ServerSocket.java:490)
      at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:387)
      at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:359)
      at java.lang.Thread.run(Thread.java:722)

      "RMI RenewClean-[172.16.30.1:55044]" daemon prio=5 tid=0x00007fe1fd353800 nid=0x5c03 in Object.wait() [0x00000001854b1000]
      java.lang.Thread.State: TIMED_WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x00000001587701f0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
      • locked <0x00000001587701f0> (a java.lang.ref.ReferenceQueue$Lock)
        at sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:535)
        at java.lang.Thread.run(Thread.java:722)

      "RMI Scheduler(0)" daemon prio=5 tid=0x00007fe1fe19a000 nid=0x5b03 waiting on condition [0x00000001853ae000]
      java.lang.Thread.State: TIMED_WAITING (parking)
      at sun.misc.Unsafe.park(Native Method)

      • parking to wait for <0x000000010b4451e0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
        at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
        at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1090)
        at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:807)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:722)

      "GC Daemon" daemon prio=5 tid=0x00007fe1fd1f2000 nid=0x5507 in Object.wait() [0x00000001851a8000]
      java.lang.Thread.State: TIMED_WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x000000010b2d0f30> (a sun.misc.GC$LatencyLock)
        at sun.misc.GC$Daemon.run(GC.java:117)
      • locked <0x000000010b2d0f30> (a sun.misc.GC$LatencyLock)

      "RMI TCP Accept-0" daemon prio=5 tid=0x00007fe1fd801000 nid=0x440b runnable [0x0000000184fa2000]
      java.lang.Thread.State: RUNNABLE
      at java.net.PlainSocketImpl.socketAccept(Native Method)
      at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:398)
      at java.net.ServerSocket.implAccept(ServerSocket.java:522)
      at java.net.ServerSocket.accept(ServerSocket.java:490)
      at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:387)
      at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:359)
      at java.lang.Thread.run(Thread.java:722)

      "Service Thread" daemon prio=5 tid=0x00007fe1fe031000 nid=0x5303 runnable [0x0000000000000000]
      java.lang.Thread.State: RUNNABLE

      "C2 CompilerThread1" daemon prio=5 tid=0x00007fe1fe030000 nid=0x5203 waiting on condition [0x0000000000000000]
      java.lang.Thread.State: RUNNABLE

      "C2 CompilerThread0" daemon prio=5 tid=0x00007fe1fe02e000 nid=0x5103 waiting on condition [0x0000000000000000]
      java.lang.Thread.State: RUNNABLE

      "Signal Dispatcher" daemon prio=5 tid=0x00007fe1fe003000 nid=0x5003 runnable [0x0000000000000000]
      java.lang.Thread.State: RUNNABLE

      "Finalizer" daemon prio=5 tid=0x00007fe1fd046800 nid=0x3f03 in Object.wait() [0x000000018409d000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x000000010b2d10e0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135)
      • locked <0x000000010b2d10e0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:177)

      "Reference Handler" daemon prio=5 tid=0x00007fe1fd045800 nid=0x3e03 in Object.wait() [0x0000000183f9a000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x000000010b2d0f10> (a java.lang.ref.Reference$Lock)
        at java.lang.Object.wait(Object.java:503)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133)
      • locked <0x000000010b2d0f10> (a java.lang.ref.Reference$Lock)

      "main" prio=5 tid=0x00007fe1fe001000 nid=0x1703 in Object.wait() [0x0000000102f25000]
      java.lang.Thread.State: WAITING (on object monitor)
      at java.lang.Object.wait(Native Method)

      • waiting on <0x00000001571a4968> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at java.lang.Object.wait(Object.java:503)
        at org.apache.qpid.amqp_1_0.client.Receiver.<init>(Receiver.java:157)
      • locked <0x00000001571a4968> (a org.apache.qpid.amqp_1_0.transport.ConnectionEndpoint)
        at org.apache.qpid.amqp_1_0.client.Receiver.<init>(Receiver.java:70)
        at org.apache.qpid.amqp_1_0.jms.impl.SessionImpl.unsubscribe(SessionImpl.java:523)
        at org.objectweb.jtests.jms.conform.session.TopicSessionTest.testUnsubscribe(TopicSessionTest.java:148)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:601)
        at junit.framework.TestCase.runTest(TestCase.java:176)
        at junit.framework.TestCase.runBare(TestCase.java:141)
        at junit.framework.TestResult$1.protect(TestResult.java:122)
        at junit.framework.TestResult.runProtected(TestResult.java:142)
        at junit.framework.TestResult.run(TestResult.java:125)
        at junit.framework.TestCase.run(TestCase.java:129)
        at junit.framework.TestSuite.runTest(TestSuite.java:255)
        at junit.framework.TestSuite.run(TestSuite.java:250)
        at junit.framework.TestSuite.runTest(TestSuite.java:255)
        at junit.framework.TestSuite.run(TestSuite.java:250)
        at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:84)
        at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264)
        at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
        at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:601)
        at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray2(ReflectionUtils.java:208)
        at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:158)
        at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:86)
        at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153)
        at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:95)

      "VM Thread" prio=5 tid=0x00007fe1fd043000 nid=0x3d03 runnable

      "GC task thread#0 (ParallelGC)" prio=5 tid=0x00007fe1fe00e000 nid=0x3503 runnable

      "GC task thread#1 (ParallelGC)" prio=5 tid=0x00007fe1fe00f000 nid=0x3603 runnable

      "GC task thread#2 (ParallelGC)" prio=5 tid=0x00007fe1fe00f800 nid=0x3703 runnable

      "GC task thread#3 (ParallelGC)" prio=5 tid=0x00007fe1fe010000 nid=0x3803 runnable

      "GC task thread#4 (ParallelGC)" prio=5 tid=0x00007fe1fe010800 nid=0x3903 runnable

      "GC task thread#5 (ParallelGC)" prio=5 tid=0x00007fe1fe011800 nid=0x3a03 runnable

      "GC task thread#6 (ParallelGC)" prio=5 tid=0x00007fe1fe012000 nid=0x3b03 runnable

      "GC task thread#7 (ParallelGC)" prio=5 tid=0x00007fe1fe012800 nid=0x3c03 runnable

      "VM Periodic Task Thread" prio=5 tid=0x00007fe1fe029800 nid=0x5403 waiting on condition

      JNI global references: 300

      Attachments

        Activity

          People

            Unassigned Unassigned
            kearls@redhat.com Kevin Earls (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            0 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: