Uploaded image for project: 'JDK'
  1. JDK
  2. JDK-8315544

java/nio/channels/vthread/BlockingChannelOps.java timed out with ZGC

    XMLWordPrintable

Details

    • x86_64
    • windows

    Description

      The following test timed out in the JDK22 CI:

      java/nio/channels/vthread/BlockingChannelOps.java#direct-register

      Here's a snippet from the log file:

      #section:junit
      ----------messages:(8/353)----------
      command: junit -Djdk.useDirectRegister BlockingChannelOps
      reason: User specified action: run junit/othervm -Djdk.useDirectRegister BlockingChannelOps
      started: Fri Sep 01 09:53:08 UTC 2023
      Mode: othervm [/othervm specified]
      Timeout information:
      --- Timeout information end.
      finished: Fri Sep 01 10:03:31 UTC 2023
      elapsed time (seconds): 622.704
      ----------configuration:(0/0)----------
      ----------System.out:(871/62503)----------
      -- VirtualThread[#106]/waiting --
        java.base/java.lang.VirtualThread.parkNanos(VirtualThread.java:621)
        java.base/java.lang.System$2.parkVirtualThread(System.java:2649)
        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.pollDirect(Poller.java:116)
        java.base/sun.nio.ch.Poller.poll(Poller.java:100)
        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.VirtualThread.run(VirtualThread.java:309)

      <snip>

      -- VirtualThread[#106]/waiting --
        java.base/java.lang.VirtualThread.parkNanos(VirtualThread.java:621)
        java.base/java.lang.System$2.parkVirtualThread(System.java:2649)
        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.pollDirect(Poller.java:116)
        java.base/sun.nio.ch.Poller.poll(Poller.java:100)
        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.VirtualThread.run(VirtualThread.java:309)
      ----------System.err:(69/6414)----------
      STARTED BlockingChannelOps::testPipeReadInterrupt 'testPipeReadInterrupt()'
      SUCCESSFUL BlockingChannelOps::testPipeReadInterrupt 'testPipeReadInterrupt()'
      STARTED BlockingChannelOps::testServerSocketChannelAccept1 'testServerSocketChannelAccept1()'
      SUCCESSFUL BlockingChannelOps::testServerSocketChannelAccept1 'testServerSocketChannelAccept1()'
      STARTED BlockingChannelOps::testServerSocketChannelAccept2 'testServerSocketChannelAccept2()'
      SUCCESSFUL BlockingChannelOps::testServerSocketChannelAccept2 'testServerSocketChannelAccept2()'
      STARTED BlockingChannelOps::testServerSocketChannelAcceptAsyncClose 'testServerSocketChannelAcceptAsyncClose()'
      SUCCESSFUL BlockingChannelOps::testServerSocketChannelAcceptAsyncClose 'testServerSocketChannelAcceptAsyncClose()'
      STARTED BlockingChannelOps::testSocketChannelRead 'testSocketChannelRead()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelRead 'testSocketChannelRead()'
      STARTED BlockingChannelOps::testSocketChannelReadInterrupt 'testSocketChannelReadInterrupt()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelReadInterrupt 'testSocketChannelReadInterrupt()'
      STARTED BlockingChannelOps::testSocketChannelAdaptorAccept1 'testSocketChannelAdaptorAccept1()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelAdaptorAccept1 'testSocketChannelAdaptorAccept1()'
      STARTED BlockingChannelOps::testSocketChannelAdaptorAccept2 'testSocketChannelAdaptorAccept2()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelAdaptorAccept2 'testSocketChannelAdaptorAccept2()'
      STARTED BlockingChannelOps::testServerSocketChannelAcceptInterrupt 'testServerSocketChannelAcceptInterrupt()'
      SUCCESSFUL BlockingChannelOps::testServerSocketChannelAcceptInterrupt 'testServerSocketChannelAcceptInterrupt()'
      STARTED BlockingChannelOps::testPipeWriteAsyncClose 'testPipeWriteAsyncClose()'
      SUCCESSFUL BlockingChannelOps::testPipeWriteAsyncClose 'testPipeWriteAsyncClose()'
      STARTED BlockingChannelOps::testPipeReadWrite1 'testPipeReadWrite1()'
      SUCCESSFUL BlockingChannelOps::testPipeReadWrite1 'testPipeReadWrite1()'
      STARTED BlockingChannelOps::testPipeReadWrite2 'testPipeReadWrite2()'
      SUCCESSFUL BlockingChannelOps::testPipeReadWrite2 'testPipeReadWrite2()'
      STARTED BlockingChannelOps::testPipeReadWrite3 'testPipeReadWrite3()'
      SUCCESSFUL BlockingChannelOps::testPipeReadWrite3 'testPipeReadWrite3()'
      STARTED BlockingChannelOps::testSocketChannelWrite 'testSocketChannelWrite()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelWrite 'testSocketChannelWrite()'
      STARTED BlockingChannelOps::testDatagramSocketAdaptorReceiveInterrupt1 'testDatagramSocketAdaptorReceiveInterrupt1()'
      SUCCESSFUL BlockingChannelOps::testDatagramSocketAdaptorReceiveInterrupt1 'testDatagramSocketAdaptorReceiveInterrupt1()'
      STARTED BlockingChannelOps::testDatagramSocketAdaptorReceiveInterrupt2 'testDatagramSocketAdaptorReceiveInterrupt2()'
      SUCCESSFUL BlockingChannelOps::testDatagramSocketAdaptorReceiveInterrupt2 'testDatagramSocketAdaptorReceiveInterrupt2()'
      STARTED BlockingChannelOps::testDatagramSocketAdaptorReceiveAsyncClose1 'testDatagramSocketAdaptorReceiveAsyncClose1()'
      SUCCESSFUL BlockingChannelOps::testDatagramSocketAdaptorReceiveAsyncClose1 'testDatagramSocketAdaptorReceiveAsyncClose1()'
      STARTED BlockingChannelOps::testDatagramSocketAdaptorReceiveAsyncClose2 'testDatagramSocketAdaptorReceiveAsyncClose2()'
      SUCCESSFUL BlockingChannelOps::testDatagramSocketAdaptorReceiveAsyncClose2 'testDatagramSocketAdaptorReceiveAsyncClose2()'
      STARTED BlockingChannelOps::testSocketChannelReadWrite1 'testSocketChannelReadWrite1()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelReadWrite1 'testSocketChannelReadWrite1()'
      STARTED BlockingChannelOps::testSocketChannelWriteAsyncClose 'testSocketChannelWriteAsyncClose()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelWriteAsyncClose 'testSocketChannelWriteAsyncClose()'
      STARTED BlockingChannelOps::testSocketAdaptorRead1 'testSocketAdaptorRead1()'
      SUCCESSFUL BlockingChannelOps::testSocketAdaptorRead1 'testSocketAdaptorRead1()'
      STARTED BlockingChannelOps::testSocketAdaptorRead2 'testSocketAdaptorRead2()'
      SUCCESSFUL BlockingChannelOps::testSocketAdaptorRead2 'testSocketAdaptorRead2()'
      STARTED BlockingChannelOps::testDatagramChannelReceiveAsyncClose 'testDatagramChannelReceiveAsyncClose()'
      SUCCESSFUL BlockingChannelOps::testDatagramChannelReceiveAsyncClose 'testDatagramChannelReceiveAsyncClose()'
      STARTED BlockingChannelOps::testDatagramChannelReceiveInterrupt 'testDatagramChannelReceiveInterrupt()'
      SUCCESSFUL BlockingChannelOps::testDatagramChannelReceiveInterrupt 'testDatagramChannelReceiveInterrupt()'
      STARTED BlockingChannelOps::testDatagramChannelSendReceive1 'testDatagramChannelSendReceive1()'
      SUCCESSFUL BlockingChannelOps::testDatagramChannelSendReceive1 'testDatagramChannelSendReceive1()'
      STARTED BlockingChannelOps::testDatagramChannelSendReceive2 'testDatagramChannelSendReceive2()'
      SUCCESSFUL BlockingChannelOps::testDatagramChannelSendReceive2 'testDatagramChannelSendReceive2()'
      STARTED BlockingChannelOps::testPipeWriteInterrupt 'testPipeWriteInterrupt()'
      SUCCESSFUL BlockingChannelOps::testPipeWriteInterrupt 'testPipeWriteInterrupt()'
      STARTED BlockingChannelOps::testSocketChannelWriteInterrupt 'testSocketChannelWriteInterrupt()'
      SUCCESSFUL BlockingChannelOps::testSocketChannelWriteInterrupt 'testSocketChannelWriteInterrupt()'
      STARTED BlockingChannelOps::testDatagramSocketAdaptorReceive1 'testDatagramSocketAdaptorReceive1()'
      SUCCESSFUL BlockingChannelOps::testDatagramSocketAdaptorReceive1 'testDatagramSocketAdaptorReceive1()'
      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/6493)*----------

      <snip>

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


      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 622.704 seconds. The test did manage to pass while the timeout handler
      was running.

      Attachments

        Issue Links

          Activity

            People

              djelinski Daniel Jelinski
              dcubed Daniel Daugherty
              Votes:
              0 Vote for this issue
              Watchers:
              6 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: