activemq-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Jiri Danek (JIRA)" <j...@apache.org>
Subject [jira] [Updated] (ARTEMIS-1193) [extra-tests] StartStopDeadlockTest#testDeadlock gets stuck
Date Tue, 30 May 2017 13:06:04 GMT

     [ https://issues.apache.org/jira/browse/ARTEMIS-1193?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]

Jiri Danek updated ARTEMIS-1193:
--------------------------------
    Labels: tests  (was: )

> [extra-tests] StartStopDeadlockTest#testDeadlock gets stuck
> -----------------------------------------------------------
>
>                 Key: ARTEMIS-1193
>                 URL: https://issues.apache.org/jira/browse/ARTEMIS-1193
>             Project: ActiveMQ Artemis
>          Issue Type: Bug
>          Components: Broker
>    Affects Versions: 2.2.0
>            Reporter: Jiri Danek
>              Labels: tests
>
> after it got stuck, I issued {{kill -3}}, see log below
> {noformat}
> [main] 13:50:04,306 INFO  [org.apache.activemq.artemis.core.server] #*#*# Starting test:
testDeadlock()...
> #test testDeadlock
> [main] 13:50:04,414 INFO  [org.apache.activemq.artemis.core.server] AMQ221000: live Message
Broker is starting with configuration Broker Configuration (clustered=false,journalDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/journal0-L,bindingsDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/bindings0-L,largeMessagesDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/large-msg0-L,pagingDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/page0-L)
> [main] 13:50:04,415 INFO  [org.apache.activemq.artemis.core.server] AMQ221006: Waiting
to obtain live lock
> [main] 13:50:04,415 INFO  [org.apache.activemq.artemis.core.server] AMQ221013: Using
NIO Journal
> [main] 13:50:04,415 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol
module found: [artemis-server]. Adding protocol support for: CORE
> [main] 13:50:04,416 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol
module found: [artemis-amqp-protocol]. Adding protocol support for: AMQP
> [main] 13:50:04,417 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol
module found: [artemis-stomp-protocol]. Adding protocol support for: STOMP
> [main] 13:50:04,417 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol
module found: [artemis-openwire-protocol]. Adding protocol support for: OPENWIRE
> [main] 13:50:04,417 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol
module found: [artemis-mqtt-protocol]. Adding protocol support for: MQTT
> [main] 13:50:04,417 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol
module found: [artemis-hornetq-protocol]. Adding protocol support for: HORNETQ
> [main] 13:50:04,419 INFO  [org.apache.activemq.artemis.core.server] AMQ221034: Waiting
indefinitely to obtain live lock
> [main] 13:50:04,419 INFO  [org.apache.activemq.artemis.core.server] AMQ221035: Live Server
Obtained live lock
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(CoreProtocolManager(server=ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31),
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.core.protocol.mqtt.MQTTProtocolManager@189b5fb1,
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.protocol.amqp.broker.ProtonProtocolManager@783ec989,
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.core.protocol.stomp.StompProtocolManager@1ddd3478,
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.core.protocol.openwire.OpenWireProtocolManager@f973499,
{})
> [main] 13:50:04,425 INFO  [org.apache.activemq.artemis.core.server] AMQ221020: Started
EPOLL Acceptor at localhost:61616 for protocols [CORE,MQTT,AMQP,STOMP,HORNETQ,OPENWIRE]
> [main] 13:50:04,426 INFO  [org.apache.activemq.artemis.core.server] AMQ221007: Server
is now live
> [main] 13:50:04,426 INFO  [org.apache.activemq.artemis.core.server] AMQ221001: Apache
ActiveMQ Artemis Message Broker version 2.2.0-SNAPSHOT [localhost, nodeID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]

> [main] 13:50:04,426 INFO  [org.apache.activemq.artemis.core.server] AMQ221000: backup
Message Broker is starting with configuration Broker Configuration (clustered=false,journalDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/journal0-L,bindingsDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/bindings0-L,largeMessagesDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/large-msg0-L,pagingDirectory=/root/workspace/peline_jdanek_artemis_junit-MXKODGBZMK2IRSU3ZGP3WXI5HYEVJ64OU2VN7HHODGYVOJ5FA7IQ/tests/extra-tests/./target/tmp/junit5157438289239255150/page0-L)
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,427 INFO  [org.apache.activemq.artemis.core.server] AMQ221032: Waiting to become
backup node
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,427 INFO  [org.apache.activemq.artemis.core.server] AMQ221033: ** got backup lock
> Crashing....
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,429 INFO  [org.apache.activemq.artemis.core.server] AMQ221013: Using NIO Journal
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,430 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol module found:
[artemis-server]. Adding protocol support for: CORE
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,431 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol module found:
[artemis-amqp-protocol]. Adding protocol support for: AMQP
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,431 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol module found:
[artemis-stomp-protocol]. Adding protocol support for: STOMP
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,431 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol module found:
[artemis-openwire-protocol]. Adding protocol support for: OPENWIRE
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,431 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol module found:
[artemis-mqtt-protocol]. Adding protocol support for: MQTT
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,433 INFO  [org.apache.activemq.artemis.core.server] AMQ221043: Protocol module found:
[artemis-hornetq-protocol]. Adding protocol support for: HORNETQ
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,433 INFO  [org.apache.activemq.artemis.core.server] AMQ221109: Apache ActiveMQ Artemis
Backup Server version 2.2.0-SNAPSHOT [147cda9b-43ce-11e7-89a8-fa163e5a2b31] started, waiting
live to fail before it gets active
> [tStart] 13:50:04,436 INFO  [org.apache.activemq.artemis.core.server] AMQ221002: Apache
ActiveMQ Artemis Message Broker version 2.2.0-SNAPSHOT [147cda9b-43ce-11e7-89a8-fa163e5a2b31]
stopped, uptime 0.023 seconds
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(CoreProtocolManager(server=ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31),
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.core.protocol.mqtt.MQTTProtocolManager@59215ea0,
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.protocol.amqp.broker.ProtonProtocolManager@1955f8a,
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.core.protocol.stomp.StompProtocolManager@3e807662,
{})
> [org.apache.commons.beanutils.BeanUtils] : BeanUtils.populate(org.apache.activemq.artemis.core.protocol.openwire.OpenWireProtocolManager@59fa2c95,
{})
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,946 INFO  [org.apache.activemq.artemis.core.server] AMQ221020: Started EPOLL Acceptor
at localhost:61616 for protocols [CORE,MQTT,AMQP,STOMP,HORNETQ,OPENWIRE]
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,946 INFO  [org.apache.activemq.artemis.core.server] AMQ221010: Backup Server is now
live
> [AMQ119000: Activation for server ActiveMQServerImpl::serverUUID=147cda9b-43ce-11e7-89a8-fa163e5a2b31]
13:50:04,946 ERROR [org.apache.activemq.artemis.core.server] AMQ224000: Failure in initialisation:
java.lang.NullPointerException
> 	at org.apache.activemq.artemis.core.server.impl.SharedStoreBackupActivation$FailbackChecker.<init>(SharedStoreBackupActivation.java:193)
[:]
> 	at org.apache.activemq.artemis.core.server.impl.SharedStoreBackupActivation.startFailbackChecker(SharedStoreBackupActivation.java:185)
[:]
> 	at org.apache.activemq.artemis.core.server.impl.SharedStoreBackupActivation.run(SharedStoreBackupActivation.java:118)
[:]
> 	at org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$ActivationThread.run(ActiveMQServerImpl.java:2796)
[:]
> 2017-05-29 02:28:13
> Full thread dump OpenJDK 64-Bit Server VM (25.131-b12 mixed mode):
> "Thread-0 (ActiveMQ-server-org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl$3@2a0eb8ad)"
#3407 prio=5 os_prio=0 tid=0x00007f665800b800 nid=0x5d58 waiting on condition [0x00007f66656f3000]
>    java.lang.Thread.State: TIMED_WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770eeac50> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
> 	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
> 	at java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:467)
> 	at org.apache.activemq.artemis.utils.ActiveMQThreadPoolExecutor$ThreadPoolQueue.poll(ActiveMQThreadPoolExecutor.java:124)
> 	at org.apache.activemq.artemis.utils.ActiveMQThreadPoolExecutor$ThreadPoolQueue.poll(ActiveMQThreadPoolExecutor.java:44)
> 	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:748)
> "Thread-4 (ActiveMQ-scheduled-threads)" #3406 prio=5 os_prio=0 tid=0x00007f6628003800
nid=0x5d57 waiting on condition [0x00007f66b6dd0000]
>    java.lang.Thread.State: WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770eeb620> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
> 	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
> 	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:748)
> "Thread-3 (ActiveMQ-scheduled-threads)" #3405 prio=5 os_prio=0 tid=0x00007f66d4007000
nid=0x5d56 waiting on condition [0x00007f666c6f4000]
>    java.lang.Thread.State: WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770eeb620> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
> 	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
> 	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:748)
> "Thread-0 (activemq-netty-threads)" #3403 daemon prio=5 os_prio=0 tid=0x00007f66c408c000
nid=0x5d54 runnable [0x00007f660138e000]
>    java.lang.Thread.State: RUNNABLE
> 	at io.netty.channel.epoll.Native.epollWait0(Native Method)
> 	at io.netty.channel.epoll.Native.epollWait(Native.java:117)
> 	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:223)
> 	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:247)
> 	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:858)
> 	at java.lang.Thread.run(Thread.java:748)
> "Thread-2 (ActiveMQ-scheduled-threads)" #3402 prio=5 os_prio=0 tid=0x00007f66c403a800
nid=0x5d53 waiting on condition [0x00007f666c2f0000]
>    java.lang.Thread.State: WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770eeb620> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
> 	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
> 	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:748)
> "Thread-1 (ActiveMQ-scheduled-threads)" #3401 prio=5 os_prio=0 tid=0x00007f66c4039800
nid=0x5d52 waiting on condition [0x00007f66b65ca000]
>    java.lang.Thread.State: WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770eeb620> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
> 	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1088)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
> 	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:748)
> "activemq-failure-check-thread" #3400 prio=5 os_prio=0 tid=0x00007f66c4039000 nid=0x5d51
waiting on condition [0x00007f6665dfa000]
>    java.lang.Thread.State: TIMED_WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x000000077194eb40> (a java.util.concurrent.CountDownLatch$Sync)
> 	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
> 	at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
> 	at org.apache.activemq.artemis.core.remoting.server.impl.RemotingServiceImpl$FailureCheckAndFlushThread.run(RemotingServiceImpl.java:730)
> "Thread-0 (ActiveMQ-scheduled-threads)" #3376 prio=5 os_prio=0 tid=0x00007f66c4064000
nid=0x5d39 waiting on condition [0x00007f66654f1000]
>    java.lang.Thread.State: TIMED_WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770eeb620> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
> 	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
> 	at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
> 	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> 	at java.lang.Thread.run(Thread.java:748)
> "activemq-buffer-timeout" #3375 prio=5 os_prio=0 tid=0x00007f66c4061000 nid=0x5d38 waiting
on condition [0x00007f666ccfa000]
>    java.lang.Thread.State: WAITING (parking)
> 	at sun.misc.Unsafe.park(Native Method)
> 	- parking to wait for  <0x0000000770ef89e8> (a java.util.concurrent.Semaphore$NonfairSync)
> 	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:997)
> 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1304)
> 	at java.util.concurrent.Semaphore.acquire(Semaphore.java:312)
> 	at org.apache.activemq.artemis.core.io.buffer.TimedBuffer.wait(TimedBuffer.java:434)
> 	at org.apache.activemq.artemis.core.io.buffer.TimedBuffer.access$800(TimedBuffer.java:37)
> 	at org.apache.activemq.artemis.core.io.buffer.TimedBuffer$CheckTimer.run(TimedBuffer.java:404)
> 	at java.lang.Thread.run(Thread.java:748)
> "tStop" #3372 prio=5 os_prio=0 tid=0x00007f6736f57800 nid=0x5d35 in Object.wait() [0x00007f66f81d2000]
>    java.lang.Thread.State: WAITING (on object monitor)
> 	at java.lang.Object.wait(Native Method)
> 	at java.lang.Object.wait(Object.java:502)
> 	at org.jboss.byteman.rule.helper.Helper.signalWake(Helper.java:474)
> 	- locked <0x0000000770f3c930> (a org.jboss.byteman.synchronization.Waiter)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:498)
> 	at org.jboss.byteman.rule.expression.MethodExpression.interpret(MethodExpression.java:342)
> 	at org.jboss.byteman.rule.Action.interpret(Action.java:144)
> 	at org.jboss.byteman.rule.helper.InterpretedHelper.fire(InterpretedHelper.java:169)
> 	at org.jboss.byteman.rule.helper.InterpretedHelper.execute0(InterpretedHelper.java:137)
> 	at org.jboss.byteman.rule.helper.InterpretedHelper.execute(InterpretedHelper.java:100)
> 	at org.jboss.byteman.rule.Rule.execute(Rule.java:684)
> 	at org.jboss.byteman.rule.Rule.execute(Rule.java:653)
> 	at org.apache.activemq.artemis.jms.server.impl.JMSServerManagerImpl.stop(JMSServerManagerImpl.java)
> 	at org.apache.activemq.artemis.tests.extras.byteman.StartStopDeadlockTest$2.run(StartStopDeadlockTest.java:109)
> "threadDeathWatcher-2-1" #27 daemon prio=1 os_prio=0 tid=0x00007f6735171800 nid=0x5023
waiting on condition [0x00007f66b6ccf000]
>    java.lang.Thread.State: TIMED_WAITING (sleeping)
> 	at java.lang.Thread.sleep(Native Method)
> 	at io.netty.util.ThreadDeathWatcher$Watcher.run(ThreadDeathWatcher.java:152)
> 	at io.netty.util.concurrent.DefaultThreadFactory$DefaultRunnableDecorator.run(DefaultThreadFactory.java:144)
> 	at java.lang.Thread.run(Thread.java:748)
> "Thread-0" #11 daemon prio=9 os_prio=0 tid=0x00007f66c0044000 nid=0x5015 runnable [0x00007f671c23f000]
>    java.lang.Thread.State: RUNNABLE
> 	at java.net.PlainSocketImpl.socketAccept(Native Method)
> 	at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
> 	at java.net.ServerSocket.implAccept(ServerSocket.java:545)
> 	at java.net.ServerSocket.accept(ServerSocket.java:513)
> 	at org.jboss.byteman.agent.TransformListener.run(TransformListener.java:133)
> "Attach Listener" #10 daemon prio=9 os_prio=0 tid=0x00007f66e0001000 nid=0x5014 runnable
[0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "Service Thread" #9 daemon prio=9 os_prio=0 tid=0x00007f67340f1800 nid=0x5012 runnable
[0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "C1 CompilerThread3" #8 daemon prio=9 os_prio=0 tid=0x00007f67340e4800 nid=0x5011 waiting
on condition [0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "C2 CompilerThread2" #7 daemon prio=9 os_prio=0 tid=0x00007f67340e2800 nid=0x5010 waiting
on condition [0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "C2 CompilerThread1" #6 daemon prio=9 os_prio=0 tid=0x00007f67340e0800 nid=0x500f waiting
on condition [0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "C2 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0x00007f67340d3000 nid=0x500e waiting
on condition [0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0x00007f67340d1000 nid=0x500d waiting
on condition [0x0000000000000000]
>    java.lang.Thread.State: RUNNABLE
> "Finalizer" #3 daemon prio=8 os_prio=0 tid=0x00007f67340a6800 nid=0x500c in Object.wait()
[0x00007f671d238000]
>    java.lang.Thread.State: WAITING (on object monitor)
> 	at java.lang.Object.wait(Native Method)
> 	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
> 	- locked <0x00000006cac70690> (a java.lang.ref.ReferenceQueue$Lock)
> 	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164)
> 	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209)
> "Reference Handler" #2 daemon prio=10 os_prio=0 tid=0x00007f67340a2000 nid=0x500b in
Object.wait() [0x00007f671d339000]
>    java.lang.Thread.State: WAITING (on object monitor)
> 	at java.lang.Object.wait(Native Method)
> 	at java.lang.Object.wait(Object.java:502)
> 	at java.lang.ref.Reference.tryHandlePending(Reference.java:191)
> 	- locked <0x00000006cac87000> (a java.lang.ref.Reference$Lock)
> 	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)
> "main" #1 prio=5 os_prio=0 tid=0x00007f6734014000 nid=0x5001 in Object.wait() [0x00007f673bb66000]
>    java.lang.Thread.State: WAITING (on object monitor)
> 	at java.lang.Object.wait(Native Method)
> 	at java.lang.Thread.join(Thread.java:1252)
> 	- locked <0x0000000770db2ab0> (a org.apache.activemq.artemis.tests.extras.byteman.StartStopDeadlockTest$2)
> 	at java.lang.Thread.join(Thread.java:1326)
> 	at org.apache.activemq.artemis.tests.extras.byteman.StartStopDeadlockTest.testDeadlock(StartStopDeadlockTest.java:123)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 	at java.lang.reflect.Method.invoke(Method.java:498)
> 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
> 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
> 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
> 	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
> 	at org.jboss.byteman.contrib.bmunit.BMUnitRunner$9.evaluate(BMUnitRunner.java:364)
> 	at org.jboss.byteman.contrib.bmunit.BMUnitRunner$6.evaluate(BMUnitRunner.java:266)
> 	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
> 	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
> 	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:48)
> 	at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
> 	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:48)
> 	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:48)
> 	at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
> 	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
> 	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
> 	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
> 	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
> 	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
> 	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
> 	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
> 	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
> 	at org.jboss.byteman.contrib.bmunit.BMUnitRunner$1.evaluate(BMUnitRunner.java:100)
> 	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
> 	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:283)
> 	at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:173)
> 	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153)
> 	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:128)
> 	at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:203)
> 	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:155)
> 	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103)
> "VM Thread" os_prio=0 tid=0x00007f6734098800 nid=0x500a runnable 
> "GC task thread#0 (ParallelGC)" os_prio=0 tid=0x00007f6734029000 nid=0x5002 runnable

> "GC task thread#1 (ParallelGC)" os_prio=0 tid=0x00007f673402b000 nid=0x5003 runnable

> "GC task thread#2 (ParallelGC)" os_prio=0 tid=0x00007f673402d000 nid=0x5004 runnable

> "GC task thread#3 (ParallelGC)" os_prio=0 tid=0x00007f673402e800 nid=0x5005 runnable

> "GC task thread#4 (ParallelGC)" os_prio=0 tid=0x00007f6734030800 nid=0x5006 runnable

> "GC task thread#5 (ParallelGC)" os_prio=0 tid=0x00007f6734032800 nid=0x5007 runnable

> "GC task thread#6 (ParallelGC)" os_prio=0 tid=0x00007f6734034000 nid=0x5008 runnable

> "GC task thread#7 (ParallelGC)" os_prio=0 tid=0x00007f6734036000 nid=0x5009 runnable

> "VM Periodic Task Thread" os_prio=0 tid=0x00007f67340f4000 nid=0x5013 waiting on condition

> JNI global references: 368
> Heap
> SUREFIRE-859:  PSYoungGen      total 625152K, used 92146K [0x000000076d400000, 0x0000000798f00000,
0x00000007c0000000)
> SUREFIRE-859:   eden space 543744K, 16% used [0x000000076d400000,0x0000000772dfcb90,0x000000078e700000)
> SUREFIRE-859:   from space 81408K, 0% used [0x0000000793f80000,0x0000000793f80000,0x0000000798f00000)
> SUREFIRE-859:   to   space 86016K, 0% used [0x000000078e700000,0x000000078e700000,0x0000000793b00000)
> SUREFIRE-859:  ParOldGen       total 568320K, used 336049K [0x00000006c7c00000, 0x00000006ea700000,
0x000000076d400000)
> SUREFIRE-859:   object space 568320K, 59% used [0x00000006c7c00000,0x00000006dc42c4c0,0x00000006ea700000)
> SUREFIRE-859:  Metaspace       used 32111K, capacity 32465K, committed 32896K, reserved
1079296K
> SUREFIRE-859:   class space    used 3031K, capacity 3142K, committed 3200K, reserved
1048576K
> {noformat}



--
This message was sent by Atlassian JIRA
(v6.3.15#6346)

Mime
View raw message