Donal Evans created GEODE-8720:
----------------------------------
Summary: VMDumpThreadsDistributedTest >
threadDumpOfVmContainsRemoteThreads fails due to main thread state being
RUNNABLE instead of TIMED_WAITING
Key: GEODE-8720
URL: https://issues.apache.org/jira/browse/GEODE-8720
Project: Geode
Issue Type: Bug
Affects Versions: 1.14.0
Reporter: Donal Evans
{code:java}
org.apache.geode.test.dunit.tests.VMDumpThreadsDistributedTest >
threadDumpOfVmContainsRemoteThreads FAILED
java.lang.AssertionError:
Expecting:
""pool-2-thread-2" Id=35 TIMED_WAITING on
java.util.concurrent.CountDownLatch$Sync@620c8150
at sun.misc.Unsafe.park(Native Method)
- waiting on java.util.concurrent.CountDownLatch$Sync@620c8150
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.geode.test.dunit.tests.VMDumpThreadsDistributedTest.syncMethod(VMDumpThreadsDistributedTest.java:126)
- locked
org.apache.geode.test.dunit.tests.VMDumpThreadsDistributedTest@4c56d308
at
org.apache.geode.test.dunit.tests.VMDumpThreadsDistributedTest.lambda$null$2(VMDumpThreadsDistributedTest.java:101)
at
org.apache.geode.test.dunit.tests.VMDumpThreadsDistributedTest$$Lambda$47/1692578668.run(Unknown
Source)
...
Number of locked synchronizers = 1
- java.util.concurrent.ThreadPoolExecutor$Worker@e404e6b
"pool-2-thread-1" Id=33 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@e6c1144
at sun.misc.Unsafe.park(Native Method)
- waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@e6c1144
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.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
"RMI TCP Connection(1)-172.17.0.5" Id=32 RUNNABLE
at sun.management.ThreadImpl.dumpThreads0(Native Method)
at sun.management.ThreadImpl.getThreadInfo(ThreadImpl.java:448)
at org.apache.geode.test.dunit.VM.dumpThreads(VM.java:223)
at
org.apache.geode.test.dunit.tests.VMDumpThreadsDistributedTest$$Lambda$49/1028270293.call(Unknown
Source)
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)
...
Number of locked synchronizers = 1
- java.util.concurrent.ThreadPoolExecutor$Worker@75bd2774
"RMI Reaper" Id=31 WAITING on java.lang.ref.ReferenceQueue$Lock@9aaa549
at java.lang.Object.wait(Native Method)
- waiting on java.lang.ref.ReferenceQueue$Lock@9aaa549
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
at sun.rmi.transport.ObjectTable$Reaper.run(ObjectTable.java:351)
at java.lang.Thread.run(Thread.java:748)
"RMI TCP Accept-0" Id=30 RUNNABLE (in native)
at java.net.PlainSocketImpl.socketAccept(Native Method)
at
java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
at java.net.ServerSocket.implAccept(ServerSocket.java:560)
at java.net.ServerSocket.accept(ServerSocket.java:528)
at
sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:405)
at
sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:377)
at java.lang.Thread.run(Thread.java:748)
"GC Daemon" Id=29 TIMED_WAITING on sun.misc.GC$LatencyLock@731ef9e7
at java.lang.Object.wait(Native Method)
- waiting on sun.misc.GC$LatencyLock@731ef9e7
at sun.misc.GC$Daemon.run(GC.java:117)
"RMI RenewClean-[172.17.0.5:37939]" Id=28 TIMED_WAITING on
java.lang.ref.ReferenceQueue$Lock@759ef0d5
at java.lang.Object.wait(Native Method)
- waiting on java.lang.ref.ReferenceQueue$Lock@759ef0d5
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
at
sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:563)
at java.lang.Thread.run(Thread.java:748)
"RMI Scheduler(0)" Id=27 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@1b963913
at sun.misc.Unsafe.park(Native Method)
- waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@1b963913
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:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
...
"Signal Dispatcher" Id=4 RUNNABLE
"Finalizer" Id=3 WAITING on java.lang.ref.ReferenceQueue$Lock@474a57c5
at java.lang.Object.wait(Native Method)
- waiting on java.lang.ref.ReferenceQueue$Lock@474a57c5
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:216)
"Reference Handler" Id=2 WAITING on java.lang.ref.Reference$Lock@431f4f0a
at java.lang.Object.wait(Native Method)
- waiting on java.lang.ref.Reference$Lock@431f4f0a
at java.lang.Object.wait(Object.java:502)
at java.lang.ref.Reference.tryHandlePending(Reference.java:191)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)
"main" Id=1 RUNNABLE
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at java.io.BufferedInputStream.fill(BufferedInputStream.java:246)
at java.io.BufferedInputStream.read(BufferedInputStream.java:265)
- locked java.io.BufferedInputStream@410517e4
at java.io.DataInputStream.readByte(DataInputStream.java:265)
at
sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:240)
...
"
to contain pattern:
""main".*Id=1 TIMED_WAITING"
at
org.apache.geode.test.dunit.tests.VMDumpThreadsDistributedTest.threadDumpOfVmContainsRemoteThreads(VMDumpThreadsDistributedTest.java:121)
{code}
This failure was seen in [DistributedTestOpenJDK8
#629|https://concourse.apachegeode-ci.info/teams/main/pipelines/apache-develop-main/jobs/DistributedTestOpenJDK8/builds/629],
artifacts below. Two tests failed in the run; this failure was the first one,
the second one (in
AsyncInvocationTimeoutDistributedTest.get_callable_timeout_includesStackTraceAsCause())
was unrelated.
=============== Test Results URI =================
[http://files.apachegeode-ci.info/builds/apache-develop-main/1.14.0-build.0491/test-results/distributedTest/1605607613/]
=========================================
Test report artifacts from this job are available at:
[http://files.apachegeode-ci.info/builds/apache-develop-main/1.14.0-build.0491/test-artifacts/1605607613/distributedtestfiles-OpenJDK8-1.14.0-build.0491.tgz]
--
This message was sent by Atlassian Jira
(v8.3.4#803005)
