[2025-05-19T09:45:28.108Z] Running test hotspot_tier1_serviceability_0 ... [2025-05-19T09:45:28.108Z] =============================================== [2025-05-19T09:45:28.108Z] hotspot_tier1_serviceability_0 Start Time: Mon May 19 09:45:27 2025 Epoch Time (ms): 1747647927987 [2025-05-19T09:45:28.108Z] variation: NoOptions [2025-05-19T09:45:28.108Z] JVM_OPTIONS: [2025-05-19T09:45:28.108Z] { \ [2025-05-19T09:45:28.108Z] echo ""; echo "TEST SETUP:"; \ [2025-05-19T09:45:28.108Z] echo "Nothing to be done for setup."; \ [2025-05-19T09:45:28.108Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/hotspot_tier1_serviceability_0"; \ [2025-05-19T09:45:28.108Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/hotspot_tier1_serviceability_0"; \ [2025-05-19T09:45:28.108Z] echo ""; echo "TESTING:"; \ [2025-05-19T09:45:28.108Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-05-19T09:45:28.108Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:1 -nativepath:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/hotspot/jtreg/native" -vmoptions:"-Xmx512m " \ [2025-05-19T09:45:28.108Z] -w ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/hotspot_tier1_serviceability_0"/work" \ [2025-05-19T09:45:28.108Z] -r ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/hotspot_tier1_serviceability_0"/report" \ [2025-05-19T09:45:28.108Z] -jdk:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image" \ [2025-05-19T09:45:28.108Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../openjdk/openjdk-jdk/test/hotspot/jtreg/ProblemList.txt" \ [2025-05-19T09:45:28.108Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk25.txt" \ [2025-05-19T09:45:28.108Z] \ [2025-05-19T09:45:28.108Z] \ [2025-05-19T09:45:28.108Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../openjdk/openjdk-jdk/test/hotspot/jtreg:tier1_serviceability"; \ [2025-05-19T09:45:28.108Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "hotspot_tier1_serviceability_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "hotspot_tier1_serviceability_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-19T09:45:28.108Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-19T09:45:28.108Z] echo "Nothing to be done for teardown."; \ [2025-05-19T09:45:28.108Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/TestTargetResult"; [2025-05-19T09:45:28.108Z] [2025-05-19T09:45:28.108Z] TEST SETUP: [2025-05-19T09:45:28.108Z] Nothing to be done for setup. [2025-05-19T09:45:28.891Z] [2025-05-19T09:45:28.891Z] TESTING: [2025-05-19T09:45:28.891Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/hotspot_tier1_serviceability_0/work" not found: creating [2025-05-19T09:45:28.891Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/hotspot_tier1_serviceability_0/report" not found: creating [2025-05-19T09:45:34.530Z] XML output with verification to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work [2025-05-19T10:06:49.114Z] -------------------------------------------------- [2025-05-19T10:06:49.114Z] TEST: serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java [2025-05-19T10:06:49.114Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image [2025-05-19T10:06:49.114Z] [2025-05-19T10:06:49.114Z] ACTION: build -- Passed. Build successful [2025-05-19T10:06:49.114Z] REASON: Named class compiled on demand [2025-05-19T10:06:49.114Z] TIME: 0.476 seconds [2025-05-19T10:06:49.114Z] messages: [2025-05-19T10:06:49.114Z] command: build UnmountedVThreadNativeMethodAtTop [2025-05-19T10:06:49.114Z] reason: Named class compiled on demand [2025-05-19T10:06:49.114Z] started: Mon May 19 09:50:43 GMT 2025 [2025-05-19T10:06:49.114Z] Test directory: [2025-05-19T10:06:49.114Z] compile: UnmountedVThreadNativeMethodAtTop [2025-05-19T10:06:49.114Z] finished: Mon May 19 09:50:43 GMT 2025 [2025-05-19T10:06:49.114Z] elapsed time (seconds): 0.476 [2025-05-19T10:06:49.114Z] [2025-05-19T10:06:49.114Z] ACTION: compile -- Passed. Compilation successful [2025-05-19T10:06:49.114Z] REASON: .class file out of date or does not exist [2025-05-19T10:06:49.114Z] TIME: 0.476 seconds [2025-05-19T10:06:49.114Z] messages: [2025-05-19T10:06:49.114Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java [2025-05-19T10:06:49.114Z] reason: .class file out of date or does not exist [2025-05-19T10:06:49.114Z] started: Mon May 19 09:50:43 GMT 2025 [2025-05-19T10:06:49.114Z] Additional options from @modules: --add-modules jdk.management [2025-05-19T10:06:49.114Z] Mode: agentvm [2025-05-19T10:06:49.114Z] Agent id: 1 [2025-05-19T10:06:49.114Z] Process id: 27591012 [2025-05-19T10:06:49.114Z] finished: Mon May 19 09:50:43 GMT 2025 [2025-05-19T10:06:49.114Z] elapsed time (seconds): 0.476 [2025-05-19T10:06:49.114Z] configuration: [2025-05-19T10:06:49.114Z] Boot Layer (javac runtime environment) [2025-05-19T10:06:49.114Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-19T10:06:49.114Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-19T10:06:49.114Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/patches/java.base [2025-05-19T10:06:49.114Z] [2025-05-19T10:06:49.114Z] javac compilation environment [2025-05-19T10:06:49.114Z] add modules: jdk.management [2025-05-19T10:06:49.114Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump [2025-05-19T10:06:49.114Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib [2025-05-19T10:06:49.114Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump [2025-05-19T10:06:49.114Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d [2025-05-19T10:06:49.114Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib [2025-05-19T10:06:49.114Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar [2025-05-19T10:06:49.114Z] [2025-05-19T10:06:49.114Z] rerun: [2025-05-19T10:06:49.114Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/scratch && \ [2025-05-19T10:06:49.114Z] DISPLAY=unix:0 \ [2025-05-19T10:06:49.114Z] HOME=/home/jenkins \ [2025-05-19T10:06:49.114Z] LANG=C \ [2025-05-19T10:06:49.114Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-19T10:06:49.114Z] TZ=UTC0 \ [2025-05-19T10:06:49.114Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/javac \ [2025-05-19T10:06:49.114Z] -J-ea \ [2025-05-19T10:06:49.114Z] -J-esa \ [2025-05-19T10:06:49.114Z] -J-Xmx512m \ [2025-05-19T10:06:49.114Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m' \ [2025-05-19T10:06:49.114Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2025-05-19T10:06:49.115Z] -J-Dtest.compiler.opts= \ [2025-05-19T10:06:49.115Z] -J-Dtest.java.opts= \ [2025-05-19T10:06:49.115Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T10:06:49.115Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T10:06:49.115Z] -J-Dtest.timeout.factor=8.0 \ [2025-05-19T10:06:49.115Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-05-19T10:06:49.115Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg \ [2025-05-19T10:06:49.115Z] -J-Dtest.name=serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java \ [2025-05-19T10:06:49.115Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-19T10:06:49.115Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java \ [2025-05-19T10:06:49.115Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump \ [2025-05-19T10:06:49.115Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-05-19T10:06:49.115Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d \ [2025-05-19T10:06:49.115Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib \ [2025-05-19T10:06:49.115Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib \ [2025-05-19T10:06:49.115Z] -J-Dtest.modules=jdk.management \ [2025-05-19T10:06:49.115Z] --add-modules jdk.management \ [2025-05-19T10:06:49.115Z] -d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d \ [2025-05-19T10:06:49.115Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-05-19T10:06:49.115Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] ACTION: junit -- Error. Program `/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java' timed out (timeout set to 960000ms, elapsed time including timeout handling was 960576ms). [2025-05-19T10:06:49.115Z] REASON: User specified action: run junit/othervm --enable-native-access=ALL-UNNAMED UnmountedVThreadNativeMethodAtTop [2025-05-19T10:06:49.115Z] TIME: 960.596 seconds [2025-05-19T10:06:49.115Z] messages: [2025-05-19T10:06:49.115Z] command: junit --enable-native-access=ALL-UNNAMED UnmountedVThreadNativeMethodAtTop [2025-05-19T10:06:49.115Z] reason: User specified action: run junit/othervm --enable-native-access=ALL-UNNAMED UnmountedVThreadNativeMethodAtTop [2025-05-19T10:06:49.115Z] started: Mon May 19 09:50:43 GMT 2025 [2025-05-19T10:06:49.115Z] Mode: othervm [/othervm specified] [2025-05-19T10:06:49.115Z] Additional options from @modules: --add-modules jdk.management [2025-05-19T10:06:49.115Z] Process id: 17629648 [2025-05-19T10:06:49.115Z] Timeout information: [2025-05-19T10:06:49.115Z] Running jstack on process 17629648 [2025-05-19T10:06:49.115Z] 2025-05-19 10:06:44 [2025-05-19T10:06:49.115Z] Full thread dump OpenJDK 64-Bit Server VM (25-beta+23-ea mixed mode): [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] Threads class SMR info: [2025-05-19T10:06:49.115Z] _java_thread_list=0x0000000112bde380, length=13, elements={ [2025-05-19T10:06:49.115Z] 0x000000011025fae0, 0x0000000112ea4180, 0x0000000112ea7a80, 0x0000000112eab960, [2025-05-19T10:06:49.115Z] 0x0000000112ead120, 0x0000000113744d60, 0x000000011396b160, 0x0000000113de8740, [2025-05-19T10:06:49.115Z] 0x0000000115531120, 0x0000000115523a20, 0x00000001159c27e0, 0x0000000116577d20, [2025-05-19T10:06:49.115Z] 0x00000001142d31a0 [2025-05-19T10:06:49.115Z] } [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "main" #3 [258] prio=5 os_prio=57 cpu=111.17ms elapsed=960.51s tid=0x000000011025fae0 nid=258 in Object.wait() [0x000000011023c000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T10:06:49.115Z] - waiting on <0x00000000e25fff58> (a java.lang.Thread) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T10:06:49.115Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1860) [2025-05-19T10:06:49.115Z] - locked <0x00000000e25fff58> (a java.lang.Thread) [2025-05-19T10:06:49.115Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-19T10:06:49.115Z] at com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:85) [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Reference Handler" #11 [2314] daemon prio=10 os_prio=57 cpu=0.52ms elapsed=960.46s tid=0x0000000112ea4180 nid=2314 waiting on condition [0x00000001130cc000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@25-beta/Native Method) [2025-05-19T10:06:49.115Z] at java.lang.ref.Reference.processPendingReferences(java.base@25-beta/Reference.java:246) [2025-05-19T10:06:49.115Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@25-beta/Reference.java:208) [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Finalizer" #12 [2571] daemon prio=8 os_prio=57 cpu=0.12ms elapsed=960.46s tid=0x0000000112ea7a80 nid=2571 in Object.wait() [0x00000001132ec000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T10:06:49.115Z] - waiting on <0x00000000e3100630> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait(java.base@25-beta/Object.java:351) [2025-05-19T10:06:49.115Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:137) [2025-05-19T10:06:49.115Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:215) [2025-05-19T10:06:49.115Z] - locked <0x00000000e3100630> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T10:06:49.115Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@25-beta/Finalizer.java:165) [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Signal Dispatcher" #13 [2828] daemon prio=9 os_prio=57 cpu=0.17ms elapsed=960.46s tid=0x0000000112eab960 nid=2828 waiting on condition [0x0000000000000000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Service Thread" #14 [3085] daemon prio=9 os_prio=57 cpu=4.84ms elapsed=960.46s tid=0x0000000112ead120 nid=3085 runnable [0x0000000000000000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Monitor Deflation Thread" #15 [3342] daemon prio=9 os_prio=57 cpu=11.37ms elapsed=960.46s tid=0x0000000113744d60 nid=3342 runnable [0x0000000000000000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "C2 CompilerThread0" #16 [3599] daemon prio=9 os_prio=57 cpu=432.79ms elapsed=960.46s tid=0x000000011396b160 nid=3599 waiting on condition [0x0000000000000000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] No compile task [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "C1 CompilerThread0" #24 [3856] daemon prio=9 os_prio=57 cpu=272.32ms elapsed=960.46s tid=0x0000000113de8740 nid=3856 waiting on condition [0x0000000000000000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] No compile task [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Notification Thread" #28 [5141] daemon prio=9 os_prio=57 cpu=0.02ms elapsed=960.25s tid=0x0000000115531120 nid=5141 runnable [0x0000000000000000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "Common-Cleaner" #29 [5398] daemon prio=8 os_prio=57 cpu=0.40ms elapsed=960.25s tid=0x0000000115523a20 nid=5398 in Object.wait() [0x000000011598c000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T10:06:49.115Z] - waiting on <0x00000000e31008b8> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T10:06:49.115Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T10:06:49.115Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:123) [2025-05-19T10:06:49.115Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:201) [2025-05-19T10:06:49.115Z] - locked <0x00000000e31008b8> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T10:06:49.115Z] at jdk.internal.ref.CleanerImpl.run(java.base@25-beta/CleanerImpl.java:146) [2025-05-19T10:06:49.115Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T10:06:49.115Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T10:06:49.115Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-19T10:06:49.115Z] [2025-05-19T10:06:49.115Z] "MainThread" #30 [5655] prio=5 os_prio=57 cpu=9951.67ms elapsed=960.20s tid=0x00000001159c27e0 nid=5655 waiting on condition [0x0000000115bd8000] [2025-05-19T10:06:49.115Z] java.lang.Thread.State: WAITING (parking) [2025-05-19T10:06:49.115Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-19T10:06:49.116Z] - parking to wait for <0x00000000fff00020> (a java.util.concurrent.CountDownLatch$Sync) [2025-05-19T10:06:49.116Z] at java.util.concurrent.locks.LockSupport.park(java.base@25-beta/LockSupport.java:223) [2025-05-19T10:06:49.116Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(java.base@25-beta/AbstractQueuedSynchronizer.java:789) [2025-05-19T10:06:49.116Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(java.base@25-beta/AbstractQueuedSynchronizer.java:1138) [2025-05-19T10:06:49.116Z] at java.util.concurrent.CountDownLatch.await(java.base@25-beta/CountDownLatch.java:230) [2025-05-19T10:06:49.116Z] at java.lang.VirtualThread.joinNanos(java.base@25-beta/VirtualThread.java:1002) [2025-05-19T10:06:49.116Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1843) [2025-05-19T10:06:49.116Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-19T10:06:49.116Z] at UnmountedVThreadNativeMethodAtTop.VThreadBlockedAtOjectWait(UnmountedVThreadNativeMethodAtTop.java:117) [2025-05-19T10:06:49.116Z] at java.lang.invoke.LambdaForm$DMH/0x0000000680131400.invokeVirtual(java.base@25-beta/LambdaForm$DMH) [2025-05-19T10:06:49.116Z] at java.lang.invoke.LambdaForm$MH/0x0000000680131c00.invoke(java.base@25-beta/LambdaForm$MH) [2025-05-19T10:06:49.116Z] at java.lang.invoke.LambdaForm$MH/0x0000000680082000.invokeExact_MT(java.base@25-beta/LambdaForm$MH) [2025-05-19T10:06:49.116Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@25-beta/DirectMethodHandleAccessor.java:154) [2025-05-19T10:06:49.116Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@25-beta/DirectMethodHandleAccessor.java:104) [2025-05-19T10:06:49.116Z] at java.lang.reflect.Method.invoke(java.base@25-beta/Method.java:565) [2025-05-19T10:06:49.116Z] at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:766) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:86) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor$$Lambda/0x00000006800bb408.apply(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall$$Lambda/0x00000006800bb620.apply(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$$Lambda/0x00000006801346a8.apply(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$8(TestMethodTestDescriptor.java:217) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor$$Lambda/0x0000000680136310.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138) [2025-05-19T10:06:49.116Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x0000000680123ac0.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x00000006801238a0.invoke(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x0000000680123680.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService$$Lambda/0x0000000680126690.accept(Unknown Source) [2025-05-19T10:06:49.116Z] at java.util.ArrayList.forEach(java.base@25-beta/ArrayList.java:1604) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x0000000680123ac0.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x00000006801238a0.invoke(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x0000000680123680.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService$$Lambda/0x0000000680126690.accept(Unknown Source) [2025-05-19T10:06:49.116Z] at java.util.ArrayList.forEach(java.base@25-beta/ArrayList.java:1604) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x0000000680123ac0.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x00000006801238a0.invoke(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda/0x0000000680123680.execute(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) [2025-05-19T10:06:49.116Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:198) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:169) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:93) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:58) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator$$Lambda/0x000000068010e090.accept(Unknown Source) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:141) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:57) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:103) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:85) [2025-05-19T10:06:49.116Z] at org.junit.platform.launcher.core.DelegatingLauncher.execute(DelegatingLauncher.java:47) [2025-05-19T10:06:49.116Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:162) [2025-05-19T10:06:49.116Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:102) [2025-05-19T10:06:49.116Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:68) [2025-05-19T10:06:49.116Z] at java.lang.invoke.LambdaForm$DMH/0x0000000680086000.invokeStatic(java.base@25-beta/LambdaForm$DMH) [2025-05-19T10:06:49.117Z] at java.lang.invoke.LambdaForm$MH/0x0000000680088c00.invoke(java.base@25-beta/LambdaForm$MH) [2025-05-19T10:06:49.117Z] at java.lang.invoke.LambdaForm$MH/0x0000000680089000.invokeExact_MT(java.base@25-beta/LambdaForm$MH) [2025-05-19T10:06:49.117Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@25-beta/DirectMethodHandleAccessor.java:155) [2025-05-19T10:06:49.117Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@25-beta/DirectMethodHandleAccessor.java:104) [2025-05-19T10:06:49.117Z] at java.lang.reflect.Method.invoke(java.base@25-beta/Method.java:565) [2025-05-19T10:06:49.117Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-05-19T10:06:49.117Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T10:06:49.117Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T10:06:49.117Z] [2025-05-19T10:06:49.117Z] "VirtualThread-unblocker" #32 [5912] daemon prio=5 os_prio=57 cpu=0.08ms elapsed=959.36s tid=0x0000000116577d20 nid=5912 runnable [0x00000001168cc000] [2025-05-19T10:06:49.117Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.117Z] at java.lang.VirtualThread.takeVirtualThreadListToUnblock(java.base@25-beta/Native Method) [2025-05-19T10:06:49.117Z] at java.lang.VirtualThread.unblockVirtualThreads(java.base@25-beta/VirtualThread.java:1507) [2025-05-19T10:06:49.117Z] at java.lang.VirtualThread$$Lambda/0x0000000680141ec0.run(java.base@25-beta/Unknown Source) [2025-05-19T10:06:49.117Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T10:06:49.117Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T10:06:49.117Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-19T10:06:49.117Z] [2025-05-19T10:06:49.117Z] "Attach Listener" #50 [4147] daemon prio=9 os_prio=57 cpu=0.20ms elapsed=0.11s tid=0x00000001142d31a0 nid=4147 waiting on condition [0x0000000000000000] [2025-05-19T10:06:49.117Z] java.lang.Thread.State: RUNNABLE [2025-05-19T10:06:49.117Z] [2025-05-19T10:06:49.117Z] "GC Thread#11" os_prio=57 cpu=703.29ms elapsed=923.93s tid=0x00000001149f8580 nid=6450 runnable [2025-05-19T10:06:49.117Z] [2025-05-19T10:06:49.286Z] "G1 Refine#1" os_prio=57 cpu=31.80ms elapsed=924.95s tid=0x0000000114236600 nid=4913 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "G1 Conc#2" os_prio=57 cpu=665.60ms elapsed=925.05s tid=0x000000011422cfe0 nid=4656 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "G1 Conc#1" os_prio=57 cpu=672.26ms elapsed=925.05s tid=0x0000000114225b80 nid=4399 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#10" os_prio=57 cpu=723.59ms elapsed=956.43s tid=0x0000000114dc2140 nid=9512 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#9" os_prio=57 cpu=925.00ms elapsed=956.43s tid=0x0000000114b7e520 nid=9255 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#8" os_prio=57 cpu=994.57ms elapsed=956.43s tid=0x0000000114b7d9a0 nid=8998 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#7" os_prio=57 cpu=848.85ms elapsed=956.43s tid=0x0000000114b7ad60 nid=8741 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#6" os_prio=57 cpu=818.95ms elapsed=956.43s tid=0x0000000114b78120 nid=8484 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#5" os_prio=57 cpu=744.96ms elapsed=956.43s tid=0x0000000114b754e0 nid=8227 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#4" os_prio=57 cpu=844.52ms elapsed=956.43s tid=0x0000000114b728a0 nid=7970 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#3" os_prio=57 cpu=1009.94ms elapsed=956.43s tid=0x0000000114b6fc60 nid=7713 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#2" os_prio=57 cpu=821.47ms elapsed=956.43s tid=0x0000000114b6d020 nid=7456 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#1" os_prio=57 cpu=870.53ms elapsed=956.43s tid=0x0000000114b6a360 nid=7199 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "VM Thread" os_prio=57 cpu=126.01ms elapsed=960.48s tid=0x0000000112c25dc0 nid=2057 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "G1 Conc#0" os_prio=57 cpu=741.86ms elapsed=960.51s tid=0x000000011140d200 nid=1029 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "VM Periodic Task Thread" os_prio=57 cpu=56.57ms elapsed=960.50s tid=0x00000001129a6bc0 nid=1800 waiting on condition [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "G1 Service" os_prio=57 cpu=7.16ms elapsed=960.50s tid=0x0000000112646d40 nid=1543 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "G1 Refine#0" os_prio=57 cpu=232.91ms elapsed=960.50s tid=0x0000000112410380 nid=1286 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "G1 Main Marker" os_prio=57 cpu=0.49ms elapsed=960.51s tid=0x00000001111d69a0 nid=772 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] "GC Thread#0" os_prio=57 cpu=919.88ms elapsed=960.51s tid=0x0000000110f99480 nid=515 runnable [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] JNI global refs: 17, weak refs: 0 [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] --- Timeout information end. [2025-05-19T10:06:49.286Z] finished: Mon May 19 10:06:44 GMT 2025 [2025-05-19T10:06:49.286Z] elapsed time (seconds): 960.596 [2025-05-19T10:06:49.286Z] configuration: [2025-05-19T10:06:49.286Z] Boot Layer [2025-05-19T10:06:49.286Z] add modules: jdk.management [2025-05-19T10:06:49.286Z] [2025-05-19T10:06:49.286Z] STDOUT: [2025-05-19T10:06:49.286Z] Parse /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/scratch/./dump13836759568101985311.hprof ... [2025-05-19T10:06:49.286Z] Dump file created Mon May 19 09:50:44 GMT 2025 [2025-05-19T10:06:49.286Z] Resolving 255800 objects... [2025-05-19T10:06:49.286Z] Chasing references, expect 51 dots................................................... [2025-05-19T10:06:49.286Z] Eliminating duplicate references................................................... [2025-05-19T10:06:49.286Z] 1 virtual thread(s) found [2025-05-19T10:06:49.286Z] Parse /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/scratch/./dump10360677848888923676.hprof ... [2025-05-19T10:06:49.286Z] Dump file created Mon May 19 09:50:57 GMT 2025 [2025-05-19T10:06:49.286Z] Timeout signalled after 960 seconds [2025-05-19T10:06:49.286Z] STDERR: [2025-05-19T10:06:49.286Z] rerun: [2025-05-19T10:06:49.286Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/scratch && \ [2025-05-19T10:06:49.286Z] DISPLAY=unix:0 \ [2025-05-19T10:06:49.286Z] HOME=/home/jenkins \ [2025-05-19T10:06:49.286Z] LANG=C \ [2025-05-19T10:06:49.286Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-19T10:06:49.286Z] TZ=UTC0 \ [2025-05-19T10:06:49.286Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-05-19T10:06:49.286Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java \ [2025-05-19T10:06:49.286Z] -Dtest.vm.opts='-ea -esa -Xmx512m' \ [2025-05-19T10:06:49.286Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m' \ [2025-05-19T10:06:49.286Z] -Dtest.compiler.opts= \ [2025-05-19T10:06:49.286Z] -Dtest.java.opts= \ [2025-05-19T10:06:49.286Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T10:06:49.286Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T10:06:49.286Z] -Dtest.timeout.factor=8.0 \ [2025-05-19T10:06:49.286Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-05-19T10:06:49.286Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg \ [2025-05-19T10:06:49.286Z] -Dtest.name=serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java \ [2025-05-19T10:06:49.286Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-19T10:06:49.286Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java \ [2025-05-19T10:06:49.287Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump \ [2025-05-19T10:06:49.287Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-05-19T10:06:49.287Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d \ [2025-05-19T10:06:49.287Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib \ [2025-05-19T10:06:49.287Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/hotspot/jtreg/serviceability/HeapDump:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/classes/test/lib \ [2025-05-19T10:06:49.287Z] -Dtest.modules=jdk.management \ [2025-05-19T10:06:49.287Z] --add-modules jdk.management \ [2025-05-19T10:06:49.287Z] -ea \ [2025-05-19T10:06:49.287Z] -esa \ [2025-05-19T10:06:49.287Z] -Xmx512m \ [2025-05-19T10:06:49.287Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/hotspot/jtreg/native \ [2025-05-19T10:06:49.287Z] --enable-native-access=ALL-UNNAMED \ [2025-05-19T10:06:49.287Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work/serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.d/junit.0.jta serviceability/HeapDump/UnmountedVThreadNativeMethodAtTop.java UnmountedVThreadNativeMethodAtTop [2025-05-19T10:06:49.287Z] [2025-05-19T10:06:49.287Z] TEST RESULT: Error. Program `/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java' timed out (timeout set to 960000ms, elapsed time including timeout handling was 960576ms). [2025-05-19T10:06:49.287Z] -------------------------------------------------- [2025-05-19T10:19:32.142Z] Test results: passed: 294; error: 1; excluded: 9; did not meet module requirements: 10; did not meet platform requirements: 75 [2025-05-19T10:19:42.072Z] Report written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/report/html/report.html [2025-05-19T10:19:42.072Z] Results written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/hotspot_tier1_serviceability_0/work [2025-05-19T10:19:42.072Z] Error: Some tests failed or other problems occurred. [2025-05-19T10:19:42.072Z] ----------------------------------- [2025-05-19T10:19:42.072Z] hotspot_tier1_serviceability_0_FAILED [2025-05-19T10:19:42.072Z] ----------------------------------- [2025-05-19T10:19:42.072Z] [2025-05-19T10:19:42.072Z] TEST TEARDOWN: [2025-05-19T10:19:42.072Z] Nothing to be done for teardown. [2025-05-19T10:19:42.072Z] hotspot_tier1_serviceability_0 Finish Time: Mon May 19 10:19:41 2025 Epoch Time (ms): 1747649981225