JDK-8314665 : java/nio/channels/vthread/BlockingChannelOps.java timed out
  • Type: Bug
  • Component: core-libs
  • Sub-Component: java.nio
  • Affected Version: 22
  • Priority: P4
  • Status: Closed
  • Resolution: Duplicate
  • OS: windows
  • CPU: x86_64
  • Submitted: 2023-08-21
  • Updated: 2023-11-14
  • Resolved: 2023-11-14
Related Reports
Duplicate :  
Description
The following test timed out in the JDK22 CI:

java/nio/channels/vthread/BlockingChannelOps.java#no-vmcontinuations

Here's a snippet from the log file:

#section:junit
----------messages:(8/413)----------
command: junit -XX:+UnlockExperimentalVMOptions -XX:-VMContinuations BlockingChannelOps
reason: User specified action: run junit/othervm -XX:+UnlockExperimentalVMOptions -XX:-VMContinuations BlockingChannelOps 
started: Mon Aug 21 16:09:15 UTC 2023
Mode: othervm [/othervm specified]
Timeout information:
--- Timeout information end.
finished: Mon Aug 21 16:19:34 UTC 2023
elapsed time (seconds): 619.836
----------configuration:(0/0)----------
----------System.out:(913/67525)----------
-- VirtualThread[#91]/timed_waiting --
  java.base/jdk.internal.misc.Unsafe.park(Native Method)
  java.base/java.lang.ThreadBuilders$BoundVirtualThread.parkNanos(ThreadBuilders.java:448)
  java.base/java.lang.System$2.parkVirtualThread(System.java:2645)
  java.base/jdk.internal.misc.VirtualThreads.park(VirtualThreads.java:67)
  java.base/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:408)
  java.base/sun.nio.ch.Poller.pollIndirect(Poller.java:137)
  java.base/sun.nio.ch.Poller.poll(Poller.java:102)
  java.base/sun.nio.ch.Poller.poll(Poller.java:87)
  java.base/sun.nio.ch.DatagramChannelImpl.park(DatagramChannelImpl.java:494)
  java.base/sun.nio.ch.DatagramChannelImpl.tryBlockingReceive(DatagramChannelImpl.java:762)
  java.base/sun.nio.ch.DatagramChannelImpl.blockingReceive(DatagramChannelImpl.java:692)
  java.base/sun.nio.ch.DatagramSocketAdaptor.receive(DatagramSocketAdaptor.java:204)
  BlockingChannelOps.lambda$testDatagramSocketAdaptorReceive$24(BlockingChannelOps.java:530)
  jdk.test.lib.thread.VThreadRunner.lambda$run$0(VThreadRunner.java:71)
  java.base/java.lang.ThreadBuilders$BoundVirtualThread.run(ThreadBuilders.java:437)

<snip>

-- VirtualThread[#91]/timed_waiting --
  java.base/jdk.internal.misc.Unsafe.park(Native Method)
  java.base/java.lang.ThreadBuilders$BoundVirtualThread.parkNanos(ThreadBuilders.java:448)
  java.base/java.lang.System$2.parkVirtualThread(System.java:2645)
  java.base/jdk.internal.misc.VirtualThreads.park(VirtualThreads.java:67)
  java.base/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:408)
  java.base/sun.nio.ch.Poller.pollIndirect(Poller.java:137)
  java.base/sun.nio.ch.Poller.poll(Poller.java:102)
  java.base/sun.nio.ch.Poller.poll(Poller.java:87)
  java.base/sun.nio.ch.DatagramChannelImpl.park(DatagramChannelImpl.java:494)
  java.base/sun.nio.ch.DatagramChannelImpl.tryBlockingReceive(DatagramChannelImpl.java:762)
  java.base/sun.nio.ch.DatagramChannelImpl.blockingReceive(DatagramChannelImpl.java:692)
  java.base/sun.nio.ch.DatagramSocketAdaptor.receive(DatagramSocketAdaptor.java:204)
  BlockingChannelOps.lambda$testDatagramSocketAdaptorReceive$24(BlockingChannelOps.java:530)
  jdk.test.lib.thread.VThreadRunner.lambda$run$0(VThreadRunner.java:71)
  java.base/java.lang.ThreadBuilders$BoundVirtualThread.run(ThreadBuilders.java:437)
----------System.err:(69/6414)----------
STARTED    BlockingChannelOps::testPipeReadInterrupt 'testPipeReadInterrupt()'
SUCCESSFUL BlockingChannelOps::testPipeReadInterrupt 'testPipeReadInterrupt()'

<snip>

STARTED    BlockingChannelOps::testDatagramSocketAdaptorReceive2 'testDatagramSocketAdaptorReceive2()'
SUCCESSFUL BlockingChannelOps::testDatagramSocketAdaptorReceive2 'testDatagramSocketAdaptorReceive2()'
STARTED    BlockingChannelOps::testPipeReadAsyncClose 'testPipeReadAsyncClose()'
SUCCESSFUL BlockingChannelOps::testPipeReadAsyncClose 'testPipeReadAsyncClose()'
STARTED    BlockingChannelOps::testSocketChannelReadAsyncClose 'testSocketChannelReadAsyncClose()'
SUCCESSFUL BlockingChannelOps::testSocketChannelReadAsyncClose 'testSocketChannelReadAsyncClose()'

[ JUnit Containers: found 4, started 4, succeeded 4, failed 0, aborted 0, skipped 0]
[ JUnit Tests: found 32, started 32, succeeded 32, failed 0, aborted 0, skipped 0]

STATUS:Passed.
----------rerun:(45/6491)*----------

<snip>

result: Error. Program `c:\ade\mesos\work_dir\jib-master\install\jdk-22+12-836\windows-x64-debug.jdk\jdk-22\fastdebug\bin\java' timed out (timeout set to 480000ms, elapsed time including timeout handling was 619820ms).


Default timeout value of 120 seconds/2 minutes with a default timeoutFactor
of 4 means a total timeout of 480 seconds/8 minutes. The run executed
for 619.836 seconds.