You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@geode.apache.org by "Kirk Lund (Jira)" <ji...@apache.org> on 2020/11/18 19:01:00 UTC

[jira] [Updated] (GEODE-8720) VMDumpThreadsDistributedTest > threadDumpOfVmContainsRemoteThreads fails due to main thread state being RUNNABLE instead of TIMED_WAITING

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

Kirk Lund updated GEODE-8720:
-----------------------------
    Labels: TestFramework  (was: )

> 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
>            Assignee: Kirk Lund
>            Priority: Major
>              Labels: TestFramework
>
> {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)