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

JCmdTestDynamicDump.java timed out in VirtualMachineImpl.read()

XMLWordPrintable

    • aarch64
    • os_x

      The following test failed in the JDK20 CI:

      runtime/cds/appcds/jcmd/JCmdTestDynamicDump.java

      Here's a snippet from the log file:

      #section:main
      ----------messages:(7/527)----------
      command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI JCmdTestDynamicDump
      reason: User specified action: run main/othervm/timeout=480 -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI JCmdTestDynamicDump
      Mode: othervm [/othervm specified]
      Additional options from @modules: --add-modules jdk.jcmd --add-exports jdk.jcmd/sun.tools.common=ALL-UNNAMED --add-opens jdk.jcmd/sun.tools.common=ALL-UNNAMED
      Timeout information:
      --- Timeout information end.
      elapsed time (seconds): 2004.71
      ----------configuration:(5/160)----------
      Boot Layer
        add modules: jdk.jcmd
        add exports: jdk.jcmd/sun.tools.common ALL-UNNAMED
        add opens: jdk.jcmd/sun.tools.common ALL-UNNAMED

      ----------System.out:(22/2779)----------
      Jar file created: /System/Volumes/Data/mesos/work_dir/slaves/0c72054a-24ab-4dbb-944f-97f9341a1b96-S34753/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/7147585d-3e33-4026-878f-9db879415ed8/runs/476fc25c-21b8-4e08-bf87-ef1390477d59/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_tier2_runtime/scratch/1/test
      Jar file created: /System/Volumes/Data/mesos/work_dir/slaves/0c72054a-24ab-4dbb-944f-97f9341a1b96-S34753/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/7147585d-3e33-4026-878f-9db879415ed8/runs/476fc25c-21b8-4e08-bf87-ef1390477d59/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_tier2_runtime/scratch/1/boot

      1 Test dynamic dump with -XX:+RecordDynamicDumpInfo.

      Command line: ['/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-20+7-372/macosx-aarch64-debug.jdk/jdk-20/fastdebug/bin/java' '-cp' '/System/Volumes/Data/mesos/work_dir/slaves/0c72054a-24ab-4dbb-944f-97f9341a1b96-S34753/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/7147585d-3e33-4026-878f-9db879415ed8/runs/476fc25c-21b8-4e08-bf87-ef1390477d59/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_tier2_runtime/scratch/1/test:/System/Volumes/Data/mesos/work_dir/slaves/0c72054a-24ab-4dbb-944f-97f9341a1b96-S34753/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/7147585d-3e33-4026-878f-9db879415ed8/runs/476fc25c-21b8-4e08-bf87-ef1390477d59/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_tier2_runtime/scratch/1/boot' '-XX:+RecordDynamicDumpInfo' 'JCmdTestLingeredApp' '32004432-80bd-414a-b42a-6fd1d517f9b9.lck']
      Expected: SUCCESS
      Executing command '[/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-20+7-372/macosx-aarch64-debug.jdk/jdk-20/fastdebug/bin/jcmd, 28465, VM.cds dynamic_dump mydynamic01.jsa]'
      [2022-07-20T15:21:29.260919Z] Gathering output for process 28473
      Timeout refired 1920 times
      [2022-07-20T15:53:49.445051Z] Waiting for completion for process 28473
      [2022-07-20T15:53:49.445140Z] Waiting for completion finished for process 28473
      Output and diagnostic info for process 28473 was saved into 'pid-28473-output.log'
      [2022-07-20T15:53:49.449119Z] Waiting for completion for process 28473
      [2022-07-20T15:53:49.449168Z] Waiting for completion finished for process 28473
      Command returned with exit code 134
      [2022-07-20T15:53:49.449249Z] Waiting for completion for process 28473
      [2022-07-20T15:53:49.449284Z] Waiting for completion finished for process 28473
      [2022-07-20T15:53:49.449316Z] Waiting for completion for process 28473
      [2022-07-20T15:53:49.449340Z] Waiting for completion finished for process 28473
      [2022-07-20T15:53:49.454305Z] Waiting for completion for process 28473
      [2022-07-20T15:53:49.454348Z] Waiting for completion finished for process 28473
      ----------System.err:(21/1180)----------
       stdout: [28465:
      ];
       stderr: [Java HotSpot(TM) 64-Bit Server VM warning: outputStream::do_vsnprintf output truncated -- buffer length is 2000 bytes but 2116 bytes are needed.
      ]
       exitValue = 134

      java.lang.RuntimeException: Expected to get exit value of [0], exit value is: [134]
      at jdk.test.lib.process.OutputAnalyzer.shouldHaveExitValue(OutputAnalyzer.java:490)
      at JCmdTestDumpBase.test(JCmdTestDumpBase.java:193)
      at JCmdTestDynamicDump.test(JCmdTestDynamicDump.java:62)
      at JCmdTestDumpBase.runTest(JCmdTestDumpBase.java:62)
      at JCmdTestDynamicDump.main(JCmdTestDynamicDump.java:147)
      at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
      at java.base/java.lang.reflect.Method.invoke(Method.java:578)
      at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
      at java.base/java.lang.Thread.run(Thread.java:1589)

      JavaTest Message: Test threw exception: java.lang.RuntimeException: Expected to get exit value of [0], exit value is: [134]
      JavaTest Message: shutting down test

      STATUS:Failed.`main' threw exception: java.lang.RuntimeException: Expected to get exit value of [0], exit value is: [134]
      ----------rerun:(38/10051)*----------

      ....
      test result: Error. Program `/System/Volumes/Data/mesos/work_dir/jib-master/install/jdk-20+7-372/macosx-aarch64-debug.jdk/jdk-20/fastdebug/bin/java' timed out (timeout set to 1920000ms, elapsed time including timeout handling was 2004708ms).

            ccheung Calvin Cheung
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            7 Start watching this issue

              Created:
              Updated: