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

ZGC: SIGSEGV in "JFR Recorder Thread"

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Unresolved
    • Icon: P3 P3
    • 25
    • 22, 23
    • hotspot
    • jfr
    • x86_64
    • linux

      The following test failed in the JDK22 CI:

      applications/runthese/RunThese8H.java

      Nothing really useful in the test's log file:

      [stress.process.err] WARNING: Please consider reporting this to the maintainers of javasoft.sqe.jck.lib.SecurityTestRunner
      [stress.process.err] WARNING: System::setSecurityManager will be removed in a future release
       stdout: [];
       stderr: [jfr summary: file is empty '/opt/mach5/mesos/work_dir/slaves/0db9c48f-6638-40d0-9a4b-bd9cc7533eb8-S9687/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/61b77f01-4eed-4a53-acf9-53a9df0f707a/runs/da47b6f1-7784-4ef1-9101-909e55de2200/testoutput/test-support/jtreg_closed_test_hotspot_jtreg_applications_runthese_RunThese8H_java/scratch/0/jfr-files/external/ks_external14562815993429333601.jfr'
      ]
       exitValue = 1

      Failed to parse file /opt/mach5/mesos/work_dir/slaves/0db9c48f-6638-40d0-9a4b-bd9cc7533eb8-S9687/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/61b77f01-4eed-4a53-acf9-53a9df0f707a/runs/da47b6f1-7784-4ef1-9101-909e55de2200/testoutput/test-support/jtreg_closed_test_hotspot_jtreg_applications_runthese_RunThese8H_java/scratch/0/perfmon-files/Perfmon.1702064952039.out
      Cannot parse null string
      Unexpected exception Connection reset during communication. Check process module status.
      [Fri Dec 08 19:50:22 UTC 2023] (1702065022222) Picker module is about to shutdown
      Picker module expected time before shutdown for: Jcmd: 30s
      Picker module expected time before shutdown for: Jfr: 3m 20s
      Picker module expected time before shutdown for: Jstat: 5m
      Picker module expected time before shutdown for: Monitor: 1m
      Picker module expected time before shutdown for: NMT: 1m
      Picker module expected time before shutdown for: Perfmon: 5m
      Picker module finished at [Fri Dec 08 19:50:22 UTC 2023]: Jstat
      Picker module finished at [Fri Dec 08 19:50:22 UTC 2023]: NMT
      Picker module finished at [Fri Dec 08 19:50:22 UTC 2023]: Monitor
      Picker module finished at [Fri Dec 08 19:50:22 UTC 2023]: Jcmd
      Picker module finished at [Fri Dec 08 19:50:22 UTC 2023]: Perfmon
      Picker module finished at [Fri Dec 08 19:50:22 UTC 2023]: Jfr
      [Fri Dec 08 19:50:22 UTC 2023] (1702065022227) Picker module has been shutdown
      [Fri Dec 08 19:50:22 UTC 2023] (1702065022227) Stress process is about to shutdown
      Going to request to stop or kill stress process: 3735
      WARNING: The process 3735 has already finished.
      [Fri Dec 08 19:50:22 UTC 2023] (1702065022229) Stress process has been shutdown
      [Fri Dec 08 19:50:22 UTC 2023] Execution finished.
      ----------rerun:(42/8084)*----------

      <snip>

      result: Failed. Unexpected exit from test [exit code: 134]

      Here's snippets from the hs_err_pid file:

      # SIGSEGV (0xb) at pc=0x00007fd720196e33, pid=3735, tid=3797
      #
      # JRE version: Java(TM) SE Runtime Environment (22.0+27) (build 22-ea+27-2262)
      # Java VM: Java HotSpot(TM) 64-Bit Server VM (22-ea+27-2262, mixed mode, sharing, tiered, compressed class ptrs, z gc, linux-amd64)
      # Problematic frame:
      #
      [error occurred during error reporting (printing problematic frame), id 0xb, SIGSEGV (0xb) at pc=0x00007fd73623ca21]
      # Core dump will be written. Default location: Core dumps may be processed with "/opt/core.sh %p" (or dumping to /opt/mach5/mesos/work_dir/slaves/0db9c48f-6638-40d0-9a4b-bd9cc7533eb8-S9687/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/61b77f01-4eed-4a53-acf9-53a9df0f707a/runs/da47b6f1-7784-4ef1-9101-909e55de2200/testoutput/test-support/jtreg_closed_test_hotspot_jtreg_applications_runthese_RunThese8H_java/scratch/0/core.3735)
      #
      # JFR recording file will be written. Location: /opt/mach5/mesos/work_dir/slaves/0db9c48f-6638-40d0-9a4b-bd9cc7533eb8-S9687/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/61b77f01-4eed-4a53-acf9-53a9df0f707a/runs/da47b6f1-7784-4ef1-9101-909e55de2200/testoutput/test-support/jtreg_closed_test_hotspot_jtreg_applications_runthese_RunThese8H_java/scratch/0/hs_err_pid3735.jfr

      <snip>

      --------------- T H R E A D ---------------

      Current thread (0x00007fd234d603c0): JavaThread "JFR Recorder Thread" daemon [_thread_in_vm, id=3797, stack(0x00007fd279dff000,0x00007fd279eff000) (1024K)]

      Stack: [0x00007fd279dff000,0x00007fd279eff000], sp=0x00007fd279efd7d8, free space=1017k
      Native frames: (J=compiled Java code, j=interpreted, Vv=VM code, C=native code)

      [error occurred during error reporting (printing native stack (with source info)), id 0xb, SIGSEGV (0xb) at pc=0x00007fd73623ca21]

      Retrying call stack printing without source information...
      Native frames: (J=compiled Java code, j=interpreted, Vv=VM code, C=native code)

      [error occurred during error reporting (retry printing native stack (no source info)), id 0xb, SIGSEGV (0xb) at pc=0x00007fd73623ca21]

      siginfo: si_signo: 11 (SIGSEGV), si_code: 1 (SEGV_MAPERR), si_addr: 0x0000000000000018

      Registers:
      RAX=0x00007fd735f5f0d5, RBX=0x00007fd279efdbf0, RCX=0x0000000000000000, RDX=0x0000000000000000
      RSP=0x00007fd279efd7d8, RBP=0x00007fd279efd7f0, RSI=0x00007fd21815fbc0, RDI=0x00007fd29219b508
      R8 =0x0000000000000000, R9 =0x0000000000ac8d74, R10=0x00000000000661e4, R11=0x0000000000000000
      R12=0x00007fd29219b508, R13=0x00007fceee79e8ce, R14=0x00007fd279efd7f8, R15=0x00007fd1c42f5460
      RIP=0x00007fd720196e33, EFLAGS=0x0000000000010246, CSGSFS=0x002b000000000033, ERR=0x0000000000000004
        TRAPNO=0x000000000000000e


      Register to memory mapping:

      RAX=0x00007fd735f5f0d5: <offset 0x00000000009890d5> in /opt/mach5/mesos/work_dir/jib-master/install/jdk-22+27-2262/linux-x64.jdk/jdk-22/lib/server/libjvm.so at 0x00007fd7355d6000
      RBX=0x00007fd279efdbf0 is pointing into the stack for thread: 0x00007fd234d603c0
      RCX=0x0 is null
      RDX=0x0 is null
      RSP=0x00007fd279efd7d8 is pointing into the stack for thread: 0x00007fd234d603c0
      RBP=0x00007fd279efd7f0 is pointing into the stack for thread: 0x00007fd234d603c0
      RSI=0x00007fd21815fbc0 into live malloced block starting at 0x00007fd21815fbc0, size 88, tag mtNMT
      [0x00007fd7361ee240]MallocSiteTable::new_entry(NativeCallStack const&, MEMFLAGS)+0x0
      [0x00007fd7361ee2d0]MallocSiteTable::lookup_or_add(NativeCallStack const&, unsigned int*, MEMFLAGS)+0x0
      [0x00007fd7361eeb00]MallocSiteTable::allocation_at(NativeCallStack const&, unsigned long, unsigned int*, MEMFLAGS)+0x0

      RDI=0x00007fd29219b508 is pointing into metadata
      R8 =0x0 is null
      R9 =0x0000000000ac8d74 is an unknown value
      R10=0x00000000000661e4 is an unknown value
      R11=0x0 is null
      R12=0x00007fd29219b508 is pointing into metadata
      R13=0x00007fceee79e8ce points into unknown readable memory: 00 00
      R14=0x00007fd279efd7f8 is pointing into the stack for thread: 0x00007fd234d603c0
      R15=0x00007fd1c42f5460 into live malloced block starting at 0x00007fd1c42f52b0, size 2096, tag mtTracing
      [0x00007fd735f56ffe]JfrTraceIdKlassQueue::renew_enqueue_buffer(Thread*, unsigned long)+0x13e
      [0x00007fd735f546a8]JfrThreadSampler::task_stacktrace(JfrSampleType, JavaThread**) [clone .constprop.1]+0x598
      [0x00007fd735f54984]JfrThreadSampler::run()+0x204
      [0x00007fd736490cbf]Thread::call_run()+0x9f

            mgronlun Markus Grönlund
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

              Created:
              Updated: