While investigating JDK-8345147 I ran jdk.jfr.api.consumer.streaming.TestJVMCrash locally (macOS 14.7) and got timeout errors.

ACTION: main -- Error. Program `/Users/gerard/Work/bugs/8345147/jdk/./build/xcode/build/jdk/bin/java' timed out (timeout set to 120000ms, elapsed time including timeout handling was 120276ms).
REASON: User specified action: run main/othervm -Dsun.tools.attach.attachTimeout=100000 jdk.jfr.api.consumer.streaming.TestJVMCrash
TIME: 120.288 seconds
messages:
command: main -Dsun.tools.attach.attachTimeout=100000 jdk.jfr.api.consumer.streaming.TestJVMCrash
reason: User specified action: run main/othervm -Dsun.tools.attach.attachTimeout=100000 jdk.jfr.api.consumer.streaming.TestJVMCrash
started: Tue Dec 03 16:16:06 CST 2024
Mode: othervm [/othervm specified]
Additional options from @modules: --add-modules jdk.jfr,jdk.attach,java.base --add-exports java.base/jdk.internal.misc=ALL-UNNAMED
Timeout information:
Running jstack on process 56091
2024-12-03 16:18:07
Full thread dump OpenJDK 64-Bit Server VM (24-internal-adhoc.gerard.jdk mixed mode, sharing):

Threads class SMR info:
_java_thread_list=0x0000600003f21020, length=13, elements={
0x000000012a808200, 0x000000012a00f000, 0x000000012a00f800, 0x000000012a05ce00,
0x000000012a05d600, 0x000000012a05de00, 0x000000012a05e600, 0x000000012a837000,
0x000000012980ec00, 0x000000012f010200, 0x000000012f027c00, 0x000000012f011c00,
0x000000012a82f400
}

"main" #3 [9475] prio=5 os_prio=31 cpu=46.37ms elapsed=120.24s tid=0x000000012a808200 nid=9475 in Object.wait() [0x000000016d7ae000]
   java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait0(java.base@24-internal/Native Method)
- waiting on <0x00000005e3a91410> (a java.lang.Thread)
at java.lang.Object.wait(java.base@24-internal/Object.java:389)
at java.lang.Thread.join(java.base@24-internal/Thread.java:1860)
- locked <0x00000005e3a91410> (a java.lang.Thread)
at java.lang.Thread.join(java.base@24-internal/Thread.java:1936)
at com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:85)

"Reference Handler" #11 [23811] daemon prio=10 os_prio=31 cpu=0.06ms elapsed=120.22s tid=0x000000012a00f000 nid=23811 waiting on condition [0x000000016e926000]
   java.lang.Thread.State: RUNNABLE
at java.lang.ref.Reference.waitForReferencePendingList(java.base@24-internal/Native Method)
at java.lang.ref.Reference.processPendingReferences(java.base@24-internal/Reference.java:246)
at java.lang.ref.Reference$ReferenceHandler.run(java.base@24-internal/Reference.java:208)

"Finalizer" #12 [24067] daemon prio=8 os_prio=31 cpu=0.04ms elapsed=120.22s tid=0x000000012a00f800 nid=24067 in Object.wait() [0x000000016eb32000]
   java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait0(java.base@24-internal/Native Method)
- waiting on <0x00000005e3802340> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.Object.wait(java.base@24-internal/Object.java:389)
at java.lang.Object.wait(java.base@24-internal/Object.java:351)
at java.lang.ref.ReferenceQueue.remove0(java.base@24-internal/ReferenceQueue.java:138)
at java.lang.ref.ReferenceQueue.remove(java.base@24-internal/ReferenceQueue.java:229)
- locked <0x00000005e3802340> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.Finalizer$FinalizerThread.run(java.base@24-internal/Finalizer.java:165)

"Signal Dispatcher" #13 [28163] daemon prio=9 os_prio=31 cpu=0.10ms elapsed=120.22s tid=0x000000012a05ce00 nid=28163 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Service Thread" #14 [24835] daemon prio=9 os_prio=31 cpu=3.22ms elapsed=120.22s tid=0x000000012a05d600 nid=24835 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Monitor Deflation Thread" #15 [25347] daemon prio=9 os_prio=31 cpu=10.93ms elapsed=120.22s tid=0x000000012a05de00 nid=25347 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" #16 [25603] daemon prio=9 os_prio=31 cpu=20.34ms elapsed=120.22s tid=0x000000012a05e600 nid=25603 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"C1 CompilerThread0" #19 [25859] daemon prio=9 os_prio=31 cpu=47.01ms elapsed=120.22s tid=0x000000012a837000 nid=25859 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"Common-Cleaner" #20 [27139] daemon prio=8 os_prio=31 cpu=0.19ms elapsed=120.21s tid=0x000000012980ec00 nid=27139 in Object.wait() [0x000000016f77a000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
at java.lang.Object.wait0(java.base@24-internal/Native Method)
- waiting on <0x00000005e3859230> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.Object.wait(java.base@24-internal/Object.java:389)
at java.lang.ref.ReferenceQueue.remove0(java.base@24-internal/ReferenceQueue.java:124)
at java.lang.ref.ReferenceQueue.remove(java.base@24-internal/ReferenceQueue.java:215)
- locked <0x00000005e3859230> (a java.lang.ref.ReferenceQueue$Lock)
at jdk.internal.ref.CleanerImpl.run(java.base@24-internal/CleanerImpl.java:140)
at java.lang.Thread.runWith(java.base@24-internal/Thread.java:1460)
at java.lang.Thread.run(java.base@24-internal/Thread.java:1447)
at jdk.internal.misc.InnocuousThread.run(java.base@24-internal/InnocuousThread.java:149)

"Notification Thread" #21 [26627] daemon prio=9 os_prio=31 cpu=0.02ms elapsed=120.20s tid=0x000000012f010200 nid=26627 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"MainThread" #22 [43267] prio=5 os_prio=31 cpu=68.69ms elapsed=120.19s tid=0x000000012f027c00 nid=43267 waiting on condition [0x000000016fd9e000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
at java.lang.Thread.sleepNanos0(java.base@24-internal/Native Method)
at java.lang.Thread.sleepNanos(java.base@24-internal/Thread.java:482)
at java.lang.Thread.sleep(java.base@24-internal/Thread.java:513)
at sun.tools.attach.VirtualMachineImpl.<init>(jdk.attach@24-internal/VirtualMachineImpl.java:85)
at sun.tools.attach.AttachProviderImpl.attachVirtualMachine(jdk.attach@24-internal/AttachProviderImpl.java:56)
at com.sun.tools.attach.VirtualMachine.attach(jdk.attach@24-internal/VirtualMachine.java:201)
at jdk.test.lib.jfr.StreamingUtils.getJfrRepository(StreamingUtils.java:52)
at jdk.jfr.api.consumer.streaming.TestProcess.getRepository(TestProcess.java:99)
at jdk.jfr.api.consumer.streaming.TestJVMCrash.main(TestJVMCrash.java:48)
at java.lang.invoke.LambdaForm$DMH/0x00000001414063a8.invokeStatic(java.base@24-internal/LambdaForm$DMH)
at java.lang.invoke.LambdaForm$MH/0x0000000141408bd8.invoke(java.base@24-internal/LambdaForm$MH)
at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@24-internal/Invokers$Holder)
at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@24-internal/DirectMethodHandleAccessor.java:155)
at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@24-internal/DirectMethodHandleAccessor.java:104)
at java.lang.reflect.Method.invoke(java.base@24-internal/Method.java:565)
at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138)
at java.lang.Thread.runWith(java.base@24-internal/Thread.java:1460)
at java.lang.Thread.run(java.base@24-internal/Thread.java:1447)

"process reaper" #23 [43011] daemon prio=10 os_prio=31 cpu=1.50ms elapsed=120.17s tid=0x000000012f011c00 nid=43011 waiting on condition [0x000000016fdde000]
   java.lang.Thread.State: TIMED_WAITING (parking)
at jdk.internal.misc.Unsafe.park(java.base@24-internal/Native Method)
- parking to wait for <0x00000005e3c8a790> (a java.util.concurrent.SynchronousQueue$Transferer)
at java.util.concurrent.locks.LockSupport.parkNanos(java.base@24-internal/LockSupport.java:408)
at java.util.concurrent.LinkedTransferQueue$DualNode.await(java.base@24-internal/LinkedTransferQueue.java:452)
at java.util.concurrent.SynchronousQueue$Transferer.xferLifo(java.base@24-internal/SynchronousQueue.java:194)
at java.util.concurrent.SynchronousQueue.xfer(java.base@24-internal/SynchronousQueue.java:235)
at java.util.concurrent.SynchronousQueue.poll(java.base@24-internal/SynchronousQueue.java:338)
at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@24-internal/ThreadPoolExecutor.java:1020)
at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@24-internal/ThreadPoolExecutor.java:1081)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@24-internal/ThreadPoolExecutor.java:619)
at java.lang.Thread.runWith(java.base@24-internal/Thread.java:1460)
at java.lang.Thread.run(java.base@24-internal/Thread.java:1447)
at jdk.internal.misc.InnocuousThread.run(java.base@24-internal/InnocuousThread.java:149)

"Attach Listener" #30 [34063] daemon prio=9 os_prio=31 cpu=0.77ms elapsed=0.11s tid=0x000000012a82f400 nid=34063 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"VM Thread" os_prio=31 cpu=0.39ms elapsed=120.23s tid=0x000000012940a790 nid=20227 runnable

"VM Periodic Task Thread" os_prio=31 cpu=55.04ms elapsed=120.23s tid=0x0000000129309780 nid=17411 waiting on condition

"G1 Service" os_prio=31 cpu=6.24ms elapsed=120.24s tid=0x0000000129307c40 nid=16899 runnable

"G1 Refine#0" os_prio=31 cpu=0.02ms elapsed=120.24s tid=0x000000012a051600 nid=21507 runnable

"G1 Conc#0" os_prio=31 cpu=0.01ms elapsed=120.24s tid=0x0000000129305450 nid=16387 runnable

"G1 Main Marker" os_prio=31 cpu=0.02ms elapsed=120.24s tid=0x0000000129407420 nid=12803 runnable

"GC Thread#0" os_prio=31 cpu=0.02ms elapsed=120.24s tid=0x0000000129406c70 nid=12547 runnable

JNI global refs: 9, weak refs: 0

--- Timeout information end.
finished: Tue Dec 03 16:18:07 CST 2024
elapsed time (seconds): 120.288
configuration:
Boot Layer
  add modules: jdk.jfr jdk.attach java.base
  add exports: java.base/jdk.internal.misc ALL-UNNAMED

STDOUT:
Command line: [/Users/gerard/Work/bugs/8345147/jdk/./build/xcode/build/jdk/bin/java -cp /Users/gerard/Work/bugs/8345147/jdk/JTwork/classes/jdk/jfr/api/consumer/streaming/TestJVMCrash.d:/Users/gerard/Work/bugs/8345147/jdk/test/jdk/jdk/jfr/api/consumer/streaming:/Users/gerard/Work/bugs/8345147/jdk/JTwork/classes/test/lib:/Users/gerard/Work/bugs/8345147/jdk/test/lib:/Users/gerard/Work/bugs/8345147/jdk/JTwork/classes/test/jdk:/Users/gerard/Work/bugs/8345147/jdk/test/jdk:/Users/gerard/Work/tests/jtreg/lib/javatest.jar:/Users/gerard/Work/tests/jtreg/lib/jtreg.jar --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:StartFlightRecording:settings=none -XX:-CreateCoredumpOnCrash jdk.jfr.api.consumer.streaming.TestProcess /Users/gerard/Work/bugs/8345147/jdk/JTwork/scratch/action-1733264167074 ]
[crash-application-1]:/Users/gerard/Work/bugs/8345147/jdk/./build/xcode/build/jdk/bin/java -cp /Users/gerard/Work/bugs/8345147/jdk/JTwork/classes/jdk/jfr/api/consumer/streaming/TestJVMCrash.d:/Users/gerard/Work/bugs/8345147/jdk/test/jdk/jdk/jfr/api/consumer/streaming:/Users/gerard/Work/bugs/8345147/jdk/JTwork/classes/test/lib:/Users/gerard/Work/bugs/8345147/jdk/test/lib:/Users/gerard/Work/bugs/8345147/jdk/JTwork/classes/test/jdk:/Users/gerard/Work/bugs/8345147/jdk/test/jdk:/Users/gerard/Work/tests/jtreg/lib/javatest.jar:/Users/gerard/Work/tests/jtreg/lib/jtreg.jar --add-exports java.base/jdk.internal.misc=ALL-UNNAMED -XX:StartFlightRecording:settings=none -XX:-CreateCoredumpOnCrash jdk.jfr.api.consumer.streaming.TestProcess /Users/gerard/Work/bugs/8345147/jdk/JTwork/scratch/action-1733264167074
Attach failed: No such process
Retrying...
Exception: Process (pid = 56092) is no longer alive, exit value = 131
Stderr:
Stdout:

# ll /cores
total 25639192
-r-------- 1 gerard wheel 4.6G Dec 3 16:16 core.56092
-r-------- 1 gerard wheel 3.8G Dec 3 16:17 core.56109
-r-------- 1 gerard wheel 3.8G Dec 3 16:17 core.56122
# lldb --core /cores/core.56092
(lldb) target create --core "/cores/core.56092"
Core file '/cores/core.56092' (arm64) was loaded.
(lldb) thread backtrace all
warning: could not execute support code to read Objective-C class data in the process. This may reduce the quality of type information available.

warning: libjvm.dylib was compiled with optimization - stepping may behave oddly; variables may not be available.
* thread #1
  * frame #0: 0x00000001815f0dd4 libsystem_kernel.dylib`mach_msg2_trap + 8
    frame #1: 0x00000001816035c4 libsystem_kernel.dylib`mach_msg2_internal + 80
    frame #2: 0x00000001815f99a4 libsystem_kernel.dylib`mach_msg_overwrite + 476
    frame #3: 0x00000001815f1158 libsystem_kernel.dylib`mach_msg + 24
    frame #4: 0x0000000181711680 CoreFoundation`__CFRunLoopServiceMachPort + 160
    frame #5: 0x000000018170ff44 CoreFoundation`__CFRunLoopRun + 1208
    frame #6: 0x000000018170f434 CoreFoundation`CFRunLoopRunSpecific + 608
    frame #7: 0x0000000103478f9c libjli.dylib`CreateExecutionEnvironment [inlined] ParkEventLoop at java_md_macosx.m:288:18 [opt]
    frame #8: 0x0000000103478f28 libjli.dylib`CreateExecutionEnvironment [inlined] MacOSXStartup(argc=9, argv=0x0000600002ec0050) at java_md_macosx.m:324:5 [opt]
    frame #9: 0x0000000103478ee4 libjli.dylib`CreateExecutionEnvironment(pargc=0x000000016ce1a498, pargv=<unavailable>, jdkroot="/Users/gerard/Work/bugs/8345147/jdk/build/xcode/build/jdk", so_jdkroot=1024, jvmpath="/Users/gerard/Work/bugs/8345147/jdk/build/xcode/build/jdk/lib/server/libjvm.dylib", so_jvmpath=<unavailable>, jvmcfg="/Users/gerard/Work/bugs/8345147/jdk/build/xcode/build/jdk/lib/jvm.cfg", so_jvmcfg=1024) at java_md_macosx.m:371:5 [opt]
    frame #10: 0x0000000103474a40 libjli.dylib`JLI_Launch(argc=9, argv=0x0000600002ec0320, jargc=0, jargv=0x0000000000000000, appclassc=0, appclassv=0x0000000000000000, fullversion=<unavailable>, dotversion=<unavailable>, pname="java", lname="openjdk", javaargs=<unavailable>, cpwildcard=<unavailable>, javaw=<unavailable>, ergo=0) at java.c:273:5 [opt]
    frame #11: 0x0000000102fe7b90 java`main(argc=<unavailable>, argv=<unavailable>) at main.c:184:12 [opt]
    frame #12: 0x00000001812a7154 dyld`start + 2476
  thread #2
    frame #0: 0x00000001815f2b8c libsystem_kernel.dylib`__ulock_wait + 8
    frame #1: 0x000000018163448c libsystem_pthread.dylib`_pthread_join + 608
    frame #2: 0x000000010347971c libjli.dylib`CallJavaMainInNewThread(stack_size=2097152, args=0x000000016cea1de0) at java_md_macosx.m:714:9 [opt]
    frame #3: 0x0000000103478300 libjli.dylib`ContinueInNewThread(ifn=0x000000016cea1ea8, threadStackSize=<unavailable>, argc=1, argv=0x0000600002ec4360, mode=1, what="jdk.jfr.api.consumer.streaming.TestProcess", ret=0) at java.c:2329:16 [opt]
    frame #4: 0x0000000103479948 libjli.dylib`JVMInit(ifn=<unavailable>, threadStackSize=<unavailable>, argc=<unavailable>, argv=<unavailable>, mode=<unavailable>, what=<unavailable>, ret=<unavailable>) at java_md_macosx.m:927:16 [opt] [artificial]
    frame #5: 0x0000000103475bc4 libjli.dylib`JLI_Launch(argc=<unavailable>, argv=<unavailable>, jargc=<unavailable>, jargv=<unavailable>, appclassc=<unavailable>, appclassv=<unavailable>, fullversion=<unavailable>, dotversion=<unavailable>, pname="java", lname="openjdk", javaargs=<unavailable>, cpwildcard=<unavailable>, javaw=<unavailable>, ergo=0) at java.c:330:12 [opt]
    frame #6: 0x0000000102fe7b90 java`main(argc=<unavailable>, argv=<unavailable>) at main.c:184:12 [opt]
    frame #7: 0x0000000103479ff8 libjli.dylib`apple_main(arg=0x000000016ce1a3e0) at java_md_macosx.m:274:10 [opt]
    frame #8: 0x0000000181631f94 libsystem_pthread.dylib`_pthread_start + 136
  thread #3
    frame #0: 0x000000010517a72c libjvm.dylib`JVMCIGlobals::check_jvmci_supported_gc() at jvmci_globals.cpp:242:1 [opt]
    frame #1: 0x0000000105130d24 libjvm.dylib`CompilerConfig::ergo_initialize() at compilerDefinitions.cpp:577:3 [opt]
    frame #2: 0x0000000104bd681c libjvm.dylib`Arguments::apply_ergo() at arguments.cpp:3715:3 [opt]
    frame #3: 0x0000000104c25fcc libjvm.dylib`Threads::create_vm(args=0x000000016d0aaf48, canTryAgain=0x000000016d0aaecf) at threads.cpp:477:22 [opt]
    frame #4: 0x0000000104cfe3f0 libjvm.dylib`::JNI_CreateJavaVM(JavaVM **, void **, void *) [inlined] JNI_CreateJavaVM_inner(vm=0x000000016d0aaf40, penv=0x000000016d0aaf38, args=0x000000016d0aaf48) at jni.cpp:3590:12 [opt]
    frame #5: 0x0000000104cfe3a0 libjvm.dylib`JNI_CreateJavaVM(vm=0x000000016d0aaf40, penv=0x000000016d0aaf38, args=0x000000016d0aaf48) at jni.cpp:3681:14 [opt]
    frame #6: 0x0000000103476470 libjli.dylib`JavaMain [inlined] InitializeJVM(pvm=0x000000016d0aaf40, penv=0x000000016d0aaf38, ifn=<unavailable>) at java.c:1495:9 [opt]
    frame #7: 0x00000001034763b8 libjli.dylib`JavaMain(_args=<unavailable>) at java.c:494:10 [opt]
    frame #8: 0x0000000103479764 libjli.dylib`ThreadJavaMain(args=<unavailable>) at java_md_macosx.m:679:29 [opt]
    frame #9: 0x0000000181631f94 libsystem_pthread.dylib`_pthread_start + 136
(lldb) quit
# lldb --core /cores/core.56109
(lldb) target create --core "/cores/core.56109"
Core file '/cores/core.56109' (arm64) was loaded.
(lldb) thread backtrace all
* thread #1
  * frame #0: 0x0000000104840b70 dyld`_dyld_start
(lldb) quit
# lldb --core /cores/core.56122
(lldb) target create --core "/cores/core.56122"
Core file '/cores/core.56122' (arm64) was loaded.
(lldb) thread backtrace all
* thread #1
  * frame #0: 0x0000000104cb8b70 dyld`_dyld_start
(lldb)