[2025-06-12T14:51:44.730Z] Running test jdk_jfr_1 ... [2025-06-12T14:51:44.730Z] =============================================== [2025-06-12T14:51:44.730Z] jdk_jfr_1 Start Time: Thu Jun 12 10:51:44 2025 Epoch Time (ms): 1749739904556 [2025-06-12T14:51:44.730Z] variation: Mode650 [2025-06-12T14:51:44.730Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-06-12T14:51:44.730Z] { \ [2025-06-12T14:51:44.730Z] echo ""; echo "TEST SETUP:"; \ [2025-06-12T14:51:44.730Z] echo "Nothing to be done for setup."; \ [2025-06-12T14:51:44.730Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/jdk_jfr_1"; \ [2025-06-12T14:51:44.730Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/jdk_jfr_1"; \ [2025-06-12T14:51:44.730Z] echo ""; echo "TESTING:"; \ [2025-06-12T14:51:44.730Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-06-12T14:51:44.730Z] -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_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx768m -XX:-UseCompressedOops " \ [2025-06-12T14:51:44.730Z] -w ""/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/jdk_jfr_1"/work" \ [2025-06-12T14:51:44.730Z] -r ""/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/jdk_jfr_1"/report" \ [2025-06-12T14:51:44.730Z] -jdk:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image" \ [2025-06-12T14:51:44.730Z] -exclude:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-06-12T14:51:44.730Z] -exclude:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk11.txt" \ [2025-06-12T14:51:44.730Z] \ [2025-06-12T14:51:44.730Z] -exclude:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk11.txt" \ [2025-06-12T14:51:44.730Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_jfr"; \ [2025-06-12T14:51:44.730Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_jfr_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_jfr_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-12T14:51:44.730Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-12T14:51:44.730Z] echo "Nothing to be done for teardown."; \ [2025-06-12T14:51:44.730Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/TestTargetResult"; [2025-06-12T14:51:44.730Z] [2025-06-12T14:51:44.730Z] TEST SETUP: [2025-06-12T14:51:44.730Z] Nothing to be done for setup. [2025-06-12T14:51:44.730Z] [2025-06-12T14:51:44.730Z] TESTING: [2025-06-12T14:51:46.434Z] Directory "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/jdk_jfr_1/work" not found: creating [2025-06-12T14:51:46.434Z] Directory "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/../TKG/output_17497317113767/jdk_jfr_1/report" not found: creating [2025-06-12T14:51:55.844Z] XML output with verification to /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work [2025-06-12T15:09:02.588Z] -------------------------------------------------- [2025-06-12T15:09:02.588Z] TEST: jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java [2025-06-12T15:09:02.588Z] TEST JDK: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image [2025-06-12T15:09:02.588Z] [2025-06-12T15:09:02.588Z] ACTION: build -- Passed. Build successful [2025-06-12T15:09:02.588Z] REASON: Named class compiled on demand [2025-06-12T15:09:02.588Z] TIME: 0.272 seconds [2025-06-12T15:09:02.588Z] messages: [2025-06-12T15:09:02.588Z] command: build jdk.jfr.event.gc.stacktrace.TestMetaspaceSerialGCAllocationPendingStackTrace [2025-06-12T15:09:02.588Z] reason: Named class compiled on demand [2025-06-12T15:09:02.588Z] started: Thu Jun 12 11:08:43 EDT 2025 [2025-06-12T15:09:02.588Z] Test directory: [2025-06-12T15:09:02.588Z] compile: jdk.jfr.event.gc.stacktrace.TestMetaspaceSerialGCAllocationPendingStackTrace [2025-06-12T15:09:02.588Z] finished: Thu Jun 12 11:08:43 EDT 2025 [2025-06-12T15:09:02.588Z] elapsed time (seconds): 0.272 [2025-06-12T15:09:02.588Z] [2025-06-12T15:09:02.588Z] ACTION: compile -- Passed. Compilation successful [2025-06-12T15:09:02.588Z] REASON: .class file out of date or does not exist [2025-06-12T15:09:02.588Z] TIME: 0.271 seconds [2025-06-12T15:09:02.588Z] messages: [2025-06-12T15:09:02.588Z] command: compile /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java [2025-06-12T15:09:02.588Z] reason: .class file out of date or does not exist [2025-06-12T15:09:02.588Z] started: Thu Jun 12 11:08:43 EDT 2025 [2025-06-12T15:09:02.588Z] Additional options from @modules: --add-modules jdk.jfr,java.management,jdk.management [2025-06-12T15:09:02.588Z] Mode: agentvm [2025-06-12T15:09:02.588Z] Agent id: 1 [2025-06-12T15:09:02.588Z] finished: Thu Jun 12 11:08:43 EDT 2025 [2025-06-12T15:09:02.588Z] elapsed time (seconds): 0.271 [2025-06-12T15:09:02.588Z] configuration: [2025-06-12T15:09:02.588Z] Boot Layer (javac runtime environment) [2025-06-12T15:09:02.588Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-06-12T15:09:02.588Z] patch: java.base /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/patches/java.base [2025-06-12T15:09:02.588Z] [2025-06-12T15:09:02.588Z] javac compilation environment [2025-06-12T15:09:02.588Z] add modules: jdk.jfr java.management jdk.management [2025-06-12T15:09:02.588Z] source path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk [2025-06-12T15:09:02.588Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk [2025-06-12T15:09:02.588Z] [2025-06-12T15:09:02.588Z] rerun: [2025-06-12T15:09:02.588Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/scratch && \ [2025-06-12T15:09:02.588Z] DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1002/bus \ [2025-06-12T15:09:02.588Z] DISPLAY=:0 \ [2025-06-12T15:09:02.588Z] HOME=/home/jenkins \ [2025-06-12T15:09:02.588Z] LANG=en_US.UTF-8 \ [2025-06-12T15:09:02.588Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-06-12T15:09:02.588Z] XDG_RUNTIME_DIR=/run/user/1002 \ [2025-06-12T15:09:02.588Z] XDG_SESSION_ID=210902 \ [2025-06-12T15:09:02.588Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image/bin/javac \ [2025-06-12T15:09:02.588Z] -J-ea \ [2025-06-12T15:09:02.588Z] -J-esa \ [2025-06-12T15:09:02.588Z] -J-Xmx768m \ [2025-06-12T15:09:02.588Z] -J-XX:-UseCompressedOops \ [2025-06-12T15:09:02.588Z] -J-Dtest.vm.opts='-ea -esa -Xmx768m -XX:-UseCompressedOops' \ [2025-06-12T15:09:02.588Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx768m -J-XX:-UseCompressedOops' \ [2025-06-12T15:09:02.588Z] -J-Dtest.compiler.opts= \ [2025-06-12T15:09:02.588Z] -J-Dtest.java.opts= \ [2025-06-12T15:09:02.588Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image \ [2025-06-12T15:09:02.588Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image \ [2025-06-12T15:09:02.588Z] -J-Dtest.timeout.factor=8.0 \ [2025-06-12T15:09:02.588Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-06-12T15:09:02.588Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-06-12T15:09:02.588Z] -J-Dtest.name=jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java \ [2025-06-12T15:09:02.588Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java \ [2025-06-12T15:09:02.588Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace \ [2025-06-12T15:09:02.588Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-06-12T15:09:02.588Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d \ [2025-06-12T15:09:02.588Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk \ [2025-06-12T15:09:02.588Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk \ [2025-06-12T15:09:02.588Z] -J-Dtest.modules='jdk.jfr java.management jdk.management' \ [2025-06-12T15:09:02.588Z] --add-modules jdk.jfr,java.management,jdk.management \ [2025-06-12T15:09:02.588Z] -d /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d \ [2025-06-12T15:09:02.588Z] -sourcepath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-06-12T15:09:02.588Z] -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java [2025-06-12T15:09:02.588Z] [2025-06-12T15:09:02.588Z] ACTION: main -- Failed. Execution failed: `main' threw exception: java.lang.NullPointerException [2025-06-12T15:09:02.588Z] REASON: User specified action: run main/othervm -XX:+UseSerialGC -Xlog:gc* -XX:MaxMetaspaceSize=64M -XX:+FlightRecorder jdk.jfr.event.gc.stacktrace.TestMetaspaceSerialGCAllocationPendingStackTrace [2025-06-12T15:09:02.588Z] TIME: 9.166 seconds [2025-06-12T15:09:02.588Z] messages: [2025-06-12T15:09:02.588Z] command: main -XX:+UseSerialGC -Xlog:gc* -XX:MaxMetaspaceSize=64M -XX:+FlightRecorder jdk.jfr.event.gc.stacktrace.TestMetaspaceSerialGCAllocationPendingStackTrace [2025-06-12T15:09:02.588Z] reason: User specified action: run main/othervm -XX:+UseSerialGC -Xlog:gc* -XX:MaxMetaspaceSize=64M -XX:+FlightRecorder jdk.jfr.event.gc.stacktrace.TestMetaspaceSerialGCAllocationPendingStackTrace [2025-06-12T15:09:02.588Z] started: Thu Jun 12 11:08:43 EDT 2025 [2025-06-12T15:09:02.588Z] Mode: othervm [/othervm specified] [2025-06-12T15:09:02.588Z] Additional options from @modules: --add-modules jdk.jfr,java.management,jdk.management [2025-06-12T15:09:02.589Z] finished: Thu Jun 12 11:08:52 EDT 2025 [2025-06-12T15:09:02.589Z] elapsed time (seconds): 9.166 [2025-06-12T15:09:02.589Z] configuration: [2025-06-12T15:09:02.589Z] Boot Layer [2025-06-12T15:09:02.589Z] add modules: jdk.jfr java.management jdk.management [2025-06-12T15:09:02.589Z] [2025-06-12T15:09:02.589Z] STDOUT: [2025-06-12T15:09:02.589Z] [0.016s][info][gc] Using Serial [2025-06-12T15:09:02.589Z] [4.596s][info][gc,start] GC(0) Pause Young (Allocation Failure) [2025-06-12T15:09:02.589Z] [4.627s][info][gc,heap ] GC(0) DefNew: 16384K->2047K(18432K) [2025-06-12T15:09:02.589Z] [4.627s][info][gc,heap ] GC(0) Tenured: 0K->2004K(40960K) [2025-06-12T15:09:02.589Z] [4.627s][info][gc,metaspace] GC(0) Metaspace: 11906K(12288K)->11906K(12288K) [2025-06-12T15:09:02.589Z] [4.627s][info][gc ] GC(0) Pause Young (Allocation Failure) 16M->3M(58M) 30.811ms [2025-06-12T15:09:02.589Z] [4.627s][info][gc,cpu ] GC(0) User=0.01s Sys=0.00s Real=0.04s [2025-06-12T15:09:02.589Z] [6.631s][info][gc,start ] GC(1) Pause Young (Allocation Failure) [2025-06-12T15:09:02.589Z] [6.640s][info][gc,heap ] GC(1) DefNew: 18431K->604K(18432K) [2025-06-12T15:09:02.589Z] [6.640s][info][gc,heap ] GC(1) Tenured: 2004K->4047K(40960K) [2025-06-12T15:09:02.589Z] [6.640s][info][gc,metaspace] GC(1) Metaspace: 13270K(13568K)->13270K(13568K) [2025-06-12T15:09:02.589Z] [6.640s][info][gc ] GC(1) Pause Young (Allocation Failure) 19M->4M(58M) 8.733ms [2025-06-12T15:09:02.589Z] [6.640s][info][gc,cpu ] GC(1) User=0.01s Sys=0.00s Real=0.01s [2025-06-12T15:09:02.589Z] [7.166s][info][gc,start ] GC(2) Pause Young (Allocation Failure) [2025-06-12T15:09:02.589Z] [7.177s][info][gc,heap ] GC(2) DefNew: 16988K->2047K(18432K) [2025-06-12T15:09:02.589Z] [7.177s][info][gc,heap ] GC(2) Tenured: 4047K->4895K(40960K) [2025-06-12T15:09:02.589Z] [7.177s][info][gc,metaspace] GC(2) Metaspace: 14754K(15360K)->14754K(15360K) [2025-06-12T15:09:02.589Z] [7.177s][info][gc ] GC(2) Pause Young (Allocation Failure) 20M->6M(58M) 11.806ms [2025-06-12T15:09:02.589Z] [7.177s][info][gc,cpu ] GC(2) User=0.01s Sys=0.00s Real=0.01s [2025-06-12T15:09:02.589Z] [7.518s][info][gc,start ] GC(3) Pause Young (Allocation Failure) [2025-06-12T15:09:02.589Z] [7.552s][info][gc,heap ] GC(3) DefNew: 18431K->2047K(18432K) [2025-06-12T15:09:02.589Z] [7.552s][info][gc,heap ] GC(3) Tenured: 4895K->7203K(40960K) [2025-06-12T15:09:02.589Z] [7.552s][info][gc,metaspace] GC(3) Metaspace: 16131K(16896K)->16131K(16896K) [2025-06-12T15:09:02.589Z] [7.552s][info][gc ] GC(3) Pause Young (Allocation Failure) 22M->9M(58M) 33.720ms [2025-06-12T15:09:02.589Z] [7.552s][info][gc,cpu ] GC(3) User=0.01s Sys=0.00s Real=0.04s [2025-06-12T15:09:02.589Z] [7.904s][info][gc,start ] GC(4) Pause Young (Allocation Failure) [2025-06-12T15:09:02.589Z] [7.915s][info][gc,heap ] GC(4) DefNew: 18431K->2047K(18432K) [2025-06-12T15:09:02.589Z] [7.915s][info][gc,heap ] GC(4) Tenured: 7203K->9513K(40960K) [2025-06-12T15:09:02.589Z] [7.915s][info][gc,metaspace] GC(4) Metaspace: 17440K(18688K)->17440K(18688K) [2025-06-12T15:09:02.589Z] [7.915s][info][gc ] GC(4) Pause Young (Allocation Failure) 25M->11M(58M) 11.114ms [2025-06-12T15:09:02.589Z] [7.915s][info][gc,cpu ] GC(4) User=0.01s Sys=0.00s Real=0.02s [2025-06-12T15:09:02.589Z] [8.248s][info][gc,start ] GC(5) Pause Young (Allocation Failure) [2025-06-12T15:09:02.589Z] [8.259s][info][gc,heap ] GC(5) DefNew: 18431K->2048K(18432K) [2025-06-12T15:09:02.589Z] [8.259s][info][gc,heap ] GC(5) Tenured: 9513K->11841K(40960K) [2025-06-12T15:09:02.589Z] [8.259s][info][gc,metaspace] GC(5) Metaspace: 18742K(20224K)->18742K(20224K) [2025-06-12T15:09:02.589Z] [8.259s][info][gc ] GC(5) Pause Young (Allocation Failure) 27M->13M(58M) 11.358ms [2025-06-12T15:09:02.589Z] [8.259s][info][gc,cpu ] GC(5) User=0.01s Sys=0.00s Real=0.01s [2025-06-12T15:09:02.589Z] [8.456s][info][gc,start ] GC(6) Pause Full (Metadata GC Threshold) [2025-06-12T15:09:02.589Z] [8.456s][info][gc,phases,start] GC(6) Phase 1: Mark live objects [2025-06-12T15:09:02.589Z] [8.483s][info][gc,phases ] GC(6) Phase 1: Mark live objects 27.636ms [2025-06-12T15:09:02.589Z] [8.483s][info][gc,phases,start] GC(6) Phase 2: Compute new object addresses [2025-06-12T15:09:02.589Z] [8.512s][info][gc,phases ] GC(6) Phase 2: Compute new object addresses 28.552ms [2025-06-12T15:09:02.589Z] [8.512s][info][gc,phases,start] GC(6) Phase 3: Adjust pointers [2025-06-12T15:09:02.589Z] [8.520s][info][gc,phases ] GC(6) Phase 3: Adjust pointers 8.305ms [2025-06-12T15:09:02.589Z] [8.520s][info][gc,phases,start] GC(6) Phase 4: Move objects [2025-06-12T15:09:02.589Z] [8.520s][info][gc,phases ] GC(6) Phase 4: Move objects 0.062ms [2025-06-12T15:09:02.589Z] [8.521s][info][gc,heap ] GC(6) DefNew: 15541K->0K(18432K) [2025-06-12T15:09:02.589Z] [8.521s][info][gc,heap ] GC(6) Tenured: 11841K->6233K(40960K) [2025-06-12T15:09:02.589Z] [8.521s][info][gc,metaspace ] GC(6) Metaspace: 19804K(21296K)->19804K(21296K) [2025-06-12T15:09:02.589Z] [8.533s][info][gc ] GC(6) Pause Full (Metadata GC Threshold) 26M->6M(58M) 77.117ms [2025-06-12T15:09:02.589Z] [8.533s][info][gc,cpu ] GC(6) User=0.06s Sys=0.00s Real=0.08s [2025-06-12T15:09:02.589Z] Allocation num: 1890 [2025-06-12T15:09:02.589Z] GC detected: 1 [2025-06-12T15:09:02.589Z] JFR GC events found: 6 [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] Heap [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] def new generation total 18496K, used 7754K [0x000003ff69a00000, 0x000003ff6ae10000, 0x000003ff79a00000) [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] eden space 16448K, 47% used [0x000003ff69a00000, 0x000003ff6a192a68, 0x000003ff6aa10000) [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] from space 2048K, 0% used [0x000003ff6aa10000, 0x000003ff6aa10000, 0x000003ff6ac10000) [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] to space 2048K, 0% used [0x000003ff6ac10000, 0x000003ff6ac10000, 0x000003ff6ae10000) [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] tenured generation total 40960K, used 6233K [0x000003ff79a00000, 0x000003ff7c200000, 0x000003ff99a00000) [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] the space 40960K, 15% used [0x000003ff79a00000, 0x000003ff7a0164d8, 0x000003ff7a016600, 0x000003ff7c200000) [2025-06-12T15:09:02.589Z] [9.082s][info][gc,heap,exit ] Metaspace used 14183K, capacity 14364K, committed 17200K, reserved 18432K [2025-06-12T15:09:02.589Z] STDERR: [2025-06-12T15:09:02.589Z] java.lang.NullPointerException [2025-06-12T15:09:02.589Z] at jdk.jfr/jdk.jfr.internal.tool.PrettyWriter.formatMethod(PrettyWriter.java:456) [2025-06-12T15:09:02.589Z] at jdk.jfr/jdk.jfr.internal.tool.PrettyWriter.printJavaFrame(PrettyWriter.java:446) [2025-06-12T15:09:02.589Z] at jdk.jfr/jdk.jfr.internal.tool.PrettyWriter.printValue(PrettyWriter.java:309) [2025-06-12T15:09:02.589Z] at jdk.jfr/jdk.jfr.internal.tool.PrettyWriter.printStackTrace(PrettyWriter.java:245) [2025-06-12T15:09:02.589Z] at jdk.jfr/jdk.jfr.internal.tool.PrettyWriter.print(PrettyWriter.java:224) [2025-06-12T15:09:02.589Z] at jdk.jfr/jdk.jfr.consumer.RecordedObject.toString(RecordedObject.java:883) [2025-06-12T15:09:02.589Z] at java.base/java.lang.String.valueOf(String.java:2951) [2025-06-12T15:09:02.589Z] at jdk.jfr.event.gc.stacktrace.AllocationStackTrace.allocAndCheck(AllocationStackTrace.java:440) [2025-06-12T15:09:02.589Z] at jdk.jfr.event.gc.stacktrace.AllocationStackTrace.testAllocEvent(AllocationStackTrace.java:391) [2025-06-12T15:09:02.589Z] at jdk.jfr.event.gc.stacktrace.AllocationStackTrace.testMetaspaceSerialGCAllocEvent(AllocationStackTrace.java:209) [2025-06-12T15:09:02.589Z] at jdk.jfr.event.gc.stacktrace.TestMetaspaceSerialGCAllocationPendingStackTrace.main(TestMetaspaceSerialGCAllocationPendingStackTrace.java:40) [2025-06-12T15:09:02.589Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [2025-06-12T15:09:02.589Z] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [2025-06-12T15:09:02.589Z] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2025-06-12T15:09:02.589Z] at java.base/java.lang.reflect.Method.invoke(Method.java:566) [2025-06-12T15:09:02.589Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-06-12T15:09:02.589Z] at java.base/java.lang.Thread.run(Thread.java:829) [2025-06-12T15:09:02.589Z] [2025-06-12T15:09:02.589Z] JavaTest Message: Test threw exception: java.lang.NullPointerException [2025-06-12T15:09:02.589Z] JavaTest Message: shutting down test [2025-06-12T15:09:02.589Z] [2025-06-12T15:09:02.589Z] STATUS:Failed.`main' threw exception: java.lang.NullPointerException [2025-06-12T15:09:02.589Z] rerun: [2025-06-12T15:09:02.589Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/scratch && \ [2025-06-12T15:09:02.589Z] DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1002/bus \ [2025-06-12T15:09:02.589Z] DISPLAY=:0 \ [2025-06-12T15:09:02.589Z] HOME=/home/jenkins \ [2025-06-12T15:09:02.589Z] LANG=en_US.UTF-8 \ [2025-06-12T15:09:02.589Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-06-12T15:09:02.589Z] XDG_RUNTIME_DIR=/run/user/1002 \ [2025-06-12T15:09:02.589Z] XDG_SESSION_ID=210902 \ [2025-06-12T15:09:02.589Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-06-12T15:09:02.589Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image/bin/java \ [2025-06-12T15:09:02.589Z] -Dtest.vm.opts='-ea -esa -Xmx768m -XX:-UseCompressedOops' \ [2025-06-12T15:09:02.589Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx768m -J-XX:-UseCompressedOops' \ [2025-06-12T15:09:02.589Z] -Dtest.compiler.opts= \ [2025-06-12T15:09:02.589Z] -Dtest.java.opts= \ [2025-06-12T15:09:02.589Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image \ [2025-06-12T15:09:02.589Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/j2sdk-image \ [2025-06-12T15:09:02.589Z] -Dtest.timeout.factor=8.0 \ [2025-06-12T15:09:02.589Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-06-12T15:09:02.589Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-06-12T15:09:02.589Z] -Dtest.name=jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java \ [2025-06-12T15:09:02.589Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.java \ [2025-06-12T15:09:02.589Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace \ [2025-06-12T15:09:02.589Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-06-12T15:09:02.589Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d \ [2025-06-12T15:09:02.589Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk \ [2025-06-12T15:09:02.589Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/openjdk/openjdk-jdk/test/jdk/jdk/jfr/event/gc/stacktrace:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/classes/test/jdk \ [2025-06-12T15:09:02.589Z] -Dtest.modules='jdk.jfr java.management jdk.management' \ [2025-06-12T15:09:02.589Z] --add-modules jdk.jfr,java.management,jdk.management \ [2025-06-12T15:09:02.589Z] -ea \ [2025-06-12T15:09:02.589Z] -esa \ [2025-06-12T15:09:02.589Z] -Xmx768m \ [2025-06-12T15:09:02.589Z] -XX:-UseCompressedOops \ [2025-06-12T15:09:02.589Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-06-12T15:09:02.589Z] -XX:+UseSerialGC \ [2025-06-12T15:09:02.589Z] -Xlog:gc* \ [2025-06-12T15:09:02.589Z] -XX:MaxMetaspaceSize=64M \ [2025-06-12T15:09:02.589Z] -XX:+FlightRecorder \ [2025-06-12T15:09:02.589Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work/jdk/jfr/event/gc/stacktrace/TestMetaspaceSerialGCAllocationPendingStackTrace.d/main.0.jta [2025-06-12T15:09:02.589Z] [2025-06-12T15:09:02.589Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.NullPointerException [2025-06-12T15:09:02.589Z] -------------------------------------------------- [2025-06-12T15:25:18.820Z] Test results: passed: 433; failed: 1 [2025-06-12T15:25:21.075Z] Report written to /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/report/html/report.html [2025-06-12T15:25:21.075Z] Results written to /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_1/aqa-tests/TKG/output_17497317113767/jdk_jfr_1/work [2025-06-12T15:25:21.075Z] Error: Some tests failed or other problems occurred. [2025-06-12T15:25:21.075Z] ----------------------------------- [2025-06-12T15:25:21.075Z] jdk_jfr_1_FAILED [2025-06-12T15:25:21.075Z] ----------------------------------- [2025-06-12T15:25:21.075Z] [2025-06-12T15:25:21.075Z] TEST TEARDOWN: [2025-06-12T15:25:21.075Z] Nothing to be done for teardown. [2025-06-12T15:25:21.075Z] jdk_jfr_1 Finish Time: Thu Jun 12 11:25:20 2025 Epoch Time (ms): 1749741920931