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

runtime/logging/StressAsyncUL.java failed with exitValue = 134

XMLWordPrintable

    • b15
    • linux

        The following test failed in the JDK25 CI:

        runtime/logging/StressAsyncUL.java

        Here's a snippet from the log file:

        #section:driver
        ----------messages:(12/410)----------
        command: driver StressAsyncUL
        reason: User specified action: run driver StressAsyncUL
        started: Tue Jul 15 09:06:45 UTC 2025
        Mode: agentvm
        Agent id: 5
        Process id: 1304178
        Additional exports to unnamed modules from @modules: java.base/jdk.internal.misc
        Timeout signalled after 480 seconds
        Timeout information:
        --- Timeout information end.
        finished: Tue Jul 15 09:23:53 UTC 2025
        elapsed time (seconds): 1028.128
        ----------configuration:(15/1960)----------

        <snip>

        ----------System.out:(16/7052)----------
        Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-25+32-3451/linux-aarch64-debug.jdk/jdk-25/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/d2398cde-9325-49c3-b030-8961a4f0a253-S671584/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/4924c3cf-fd23-42b7-92d6-86b38c2daebe/runs/507f71dd-f77e-4c28-be68-899782bde695/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_runtime/classes/0/runtime/logging/StressAsyncUL.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-25+32-3451/src.full/open/test/hotspot/jtreg/runtime/logging:/opt/mach5/mesos/work_dir/slaves/d2398cde-9325-49c3-b030-8961a4f0a253-S671584/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/4924c3cf-fd23-42b7-92d6-86b38c2daebe/runs/507f71dd-f77e-4c28-be68-899782bde695/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_runtime/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/jtreg.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/junit-platform-console-standalone-1.11.0.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/testng-7.3.0.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/jcommander-1.82.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/guice-5.1.0.jar -Xlog:async:drop -Xlog:all=trace StressAsyncUL$InnerClass ]

        <snip>

        Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-25+32-3451/linux-aarch64-debug.jdk/jdk-25/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/d2398cde-9325-49c3-b030-8961a4f0a253-S671584/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/4924c3cf-fd23-42b7-92d6-86b38c2daebe/runs/507f71dd-f77e-4c28-be68-899782bde695/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_runtime/classes/0/runtime/logging/StressAsyncUL.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-25+32-3451/src.full/open/test/hotspot/jtreg/runtime/logging:/opt/mach5/mesos/work_dir/slaves/d2398cde-9325-49c3-b030-8961a4f0a253-S671584/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/4924c3cf-fd23-42b7-92d6-86b38c2daebe/runs/507f71dd-f77e-4c28-be68-899782bde695/testoutput/test-support/jtreg_open_test_hotspot_jtreg_tier1_runtime/classes/0/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/jtreg.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/junit-platform-console-standalone-1.11.0.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/testng-7.3.0.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/jcommander-1.82.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/7.5.1/1/bundles/jtreg-7.5.1+1.zip/jtreg/lib/guice-5.1.0.jar -Xlog:async:stall -Xlog:all=trace -XX:AsyncLogBufferSize=192 StressAsyncUL$InnerClass ]
        [2025-07-15T09:06:49.430155986Z] Gathering output for process 1311294
        [2025-07-15T09:06:49.430505948Z] Waiting for completion for process 1311294
        [2025-07-15T09:22:38.008385741Z] Waiting for completion finished for process 1311294
        ----------System.err:(684/81717)----------
         stdout: [[0.000s][trace][os,container] OSContainer::init: Initializing Container Support
        [0.000s][debug][os,container] Detected optional pids controller entry in /proc/cgroups
        [0.001s][debug][os,container] Detected cgroups hybrid or legacy hierarchy, using cgroups v1 controllers
        [0.001s][trace][os,container] Adjusting controller path for memory: /sys/fs/cgroup/memory/system.slice/mesos-slave.service
        [0.001s][trace][os,container] Path to /memory.limit_in_bytes is /sys/fs/cgroup/memory/system.slice/mesos-slave.service/memory.limit_in_bytes
        [0.001s][trace][os,container] Memory Limit is: 9223372036854771712
        [0.001s][debug][os,container] container memory limit ignored: 9223372036854771712, using host value 33310220288
        [0.001s][trace][os,container] Path to /memory.limit_in_bytes is /sys/fs/cgroup/memory/system.slice/memory.limit_in_bytes
        [0.001s][trace][os,container] Memory Limit is: 9223372036854771712
        [0.001s][debug][os,container] container memory limit ignored: 9223372036854771712, using host value 33310220288
        [0.001s][trace][os,container] Path to /memory.limit_in_bytes is /sys/fs/cgroup/memory/memory.limit_in_bytes
        [0.001s][trace][os,container] Memory Limit is: 9223372036854771712
        [0.001s][debug][os,container] container memory limit ignored: 9223372036854771712, using host value 33310220288
        [0.001s][trace][os,container] Lowest limit was: 33310220288
        [0.001s][trace][os,container] No lower limit found for memory in hierarchy /sys/fs/cgroup/memory, adjusting to original path /system.slice/mesos-slave.service
        [0.001s][trace][os,container] Adjusting controller path for cpu: /sys/fs/cgroup/cpu,cpuacct/system.slice/mesos-slave.service
        [0.001s][trace][os ] active_processor_count: using static path - configured processors: 8
        [0.001s][trace][os ] active_processor_count: sched_getaffinity processor count: 8

        <snip>

        ...
        Output overflow:
        JT Harness has limited the test output to the text
        at the beginning and the end, so that you can see how the
        test began, and how it completed.

        If you need to see more of the output from the test,
        set the system property javatest.maxOutputSize to a higher
        value. The current value is 100000
        ...

        <snip>

        [0.041s][info ][aot ] Using AOT-linked classes: false (static archive: no aot-linked classes)
        [0.041s][trace][symboltable ] Start size: 32768 (15)
        [0.041s][trace][stringtable ] Start size: 65536 (16)
        [0.041s][trace][oopstorage,ref ] VM Global: allocated 0x0000ffff900eaa40
        [0.041s][trace][membername,table ] Start size: 1024 (10)
        [0.041s][info ][startuptime ] Genesis, 0.0146434 secs
        [0.041s][info ][logging ] AsyncLogBuffer estimates memory use: 192 bytes
        [0.041s][info ][os,thread ] Thread "AsyncLog Thread" started (pthread id: 281472511656400, attributes: stacksize: 2040k, guardsize: 4k, detached).
        [0.059s][info ][os,thread ] Thread is alive (tid: 1311304, pthread id: 281472511656400).
        ];
         stderr: [Java HotSpot(TM) 64-Bit Server VM warning: dependency logging results may be inflated by VerifyDependencies
        Java HotSpot(TM) 64-Bit Server VM warning: class load cause logging will not produce output without LogClassLoadingCauseFor
        ]
         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:522)
        at StressAsyncUL.analyze_output(StressAsyncUL.java:42)
        at StressAsyncUL.main(StressAsyncUL.java:53)
        at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
        at java.base/java.lang.reflect.Method.invoke(Method.java:565)
        at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:335)
        at java.base/java.lang.Thread.run(Thread.java:1474)

        JavaTest Message: Test threw exception: java.lang.RuntimeException
        JavaTest Message: shutting down test

        result: Error. "driver" action timed out with a timeout of 480 seconds on agent 5

        There's no indication in the test's log file WHICH test execution
        failed. There are no hs_err_pid files, but there are several core
        files. This test is noisy so the output buffer has been overflowed
        so critical information may have been elided.

              cnorrbin Casper Norrbin
              dcubed Daniel Daugherty
              Votes:
              0 Vote for this issue
              Watchers:
              8 Start watching this issue

                Created:
                Updated:
                Resolved: