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

serviceability/sa/ClhsdbPstack.java#id0 timed out

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: Open
    • Priority: P4
    • Resolution: Unresolved
    • Affects Version/s: 17
    • Fix Version/s: tbd
    • Component/s: hotspot

      Description

      The following test timed out in the JDK17 CI:

      serviceability/sa/ClhsdbPstack.java#id0

      Here's a snippet from the log file:

      #section:main
      ----------messages:(6/218)----------
      command: main ClhsdbPstack false
      reason: User specified action: run main/othervm ClhsdbPstack false
      Mode: othervm [/othervm specified]
      Timeout information:
      --- Timeout information end.
      elapsed time (seconds): 536.581
      ----------configuration:(0/0)----------
      ----------System.out:(13/1802)----------
      Starting ClhsdbPstack test: withCore==false
      Command line: ['/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+24-2093/linux-x64-debug.jdk/jdk-17/fastdebug/bin/java' '-XX:MaxRAMPercentage=4.16667' '-Djava.io.tmpdir=/opt/mach5/mesos/work_dir/slaves/3c846bae-ce30-4a97-93ee-9fef4497ccb6-S78966/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/9ff33ce4-f668-4a8d-8fc7-00b9ce199b0e/runs/52e726e9-1dcb-433d-9e07-5ca949f34eb9/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_serviceability/tmp' '-cp' '/opt/mach5/mesos/work_dir/slaves/3c846bae-ce30-4a97-93ee-9fef4497ccb6-S78966/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/9ff33ce4-f668-4a8d-8fc7-00b9ce199b0e/runs/52e726e9-1dcb-433d-9e07-5ca949f34eb9/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_serviceability/classes/4/serviceability/sa/ClhsdbPstack_id0.d:/opt/mach5/mesos/work_dir/slaves/3c846bae-ce30-4a97-93ee-9fef4497ccb6-S78966/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/9ff33ce4-f668-4a8d-8fc7-00b9ce199b0e/runs/52e726e9-1dcb-433d-9e07-5ca949f34eb9/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_serviceability/classes/4/test/lib' 'jdk.test.lib.apps.LingeredApp' 'b5d86291-8516-4261-8b03-6fdde0813ea2.lck']
      Started LingeredApp with pid 11811
      Starting clhsdb against 11811
      [2021-05-20T21:29:06.694353078Z] Gathering output for process 11889
      Timeout refired 480 times
      [2021-05-20T21:37:46.182186232Z] Waiting for completion for process 11889
      [2021-05-20T21:37:46.182368307Z] Waiting for completion finished for process 11889
      [2021-05-20T21:37:46.273382578Z] Waiting for completion for process 11889
      [2021-05-20T21:37:46.273581364Z] Waiting for completion finished for process 11889
       LingeredApp stdout: [];
       LingeredApp stderr: []
       LingeredApp exitValue = 0
      ----------System.err:(2441/72641)----------
       stdout: [Attaching to process 11811, please wait...
      hsdb> hsdb> + verbose true
      hsdb> + pstack -v
      Deadlock Detection:

      No deadlocks found.

      ----------------- 11851 -----------------
      "SteadyStateThread" #14 prio=5 tid=0x00007fe0883f3140 nid=0x2e4b waiting for monitor entry [0x00007fe06c3f0000]
         java.lang.Thread.State: BLOCKED (on object monitor)
         JavaThread state: _thread_blocked
      0x00007fe09149fde2 __pthread_cond_timedwait + 0x132
      Locked ownable synchronizers:
          - None

      <snip>

      0x00007fe0882e9b30 ????????
      0x00007fe0882e9b30 ????????
      0x00007fe0882e9b30 ????????
      0x00007fe0882e9b30 ????????
      0x00007fe0882e9b30 ????????
      0x00007fe0882e9b30 ????????
      0x00007fe0882e9b30 ????????
      ];
       stderr: []
       exitValue = 134

      java.lang.RuntimeException: Test ERROR java.lang.RuntimeException: Expected to get exit value of [0]

      at ClhsdbPstack.main(ClhsdbPstack.java:93)
      at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
      at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      at java.base/java.lang.reflect.Method.invoke(Method.java:568)
      at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
      at java.base/java.lang.Thread.run(Thread.java:831)
      Caused by: java.lang.RuntimeException: Expected to get exit value of [0]

      at jdk.test.lib.process.OutputAnalyzer.shouldHaveExitValue(OutputAnalyzer.java:474)
      at ClhsdbLauncher.runCmd(ClhsdbLauncher.java:142)
      at ClhsdbLauncher.run(ClhsdbLauncher.java:203)
      at ClhsdbPstack.main(ClhsdbPstack.java:88)
      ... 6 more

      JavaTest Message: Test threw exception: java.lang.RuntimeException: Test ERROR java.lang.RuntimeException: Expected to get exit value of [0]

      JavaTest Message: shutting down test

      STATUS:Failed.`main' threw exception: java.lang.RuntimeException: Test ERROR java.lang.RuntimeException: Expected to get exit value of [0]
      ----------rerun:(32/6766)*----------

      There are pages of the following line:

      0x00007fe0882e9b30 ????????

      Not sure what happened with this test run, but it is strange.

        Attachments

          Activity

            People

            Assignee:
            Unassigned Unassigned
            Reporter:
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

              Dates

              Created:
              Updated: