[2025-09-04T06:19:01.846Z] Running test jdk_io_1 ... [2025-09-04T06:19:01.846Z] =============================================== [2025-09-04T06:19:01.846Z] jdk_io_1 Start Time: Thu Sep 4 06:18:59 2025 Epoch Time (ms): 1756966739502 [2025-09-04T06:19:01.846Z] variation: Mode650 [2025-09-04T06:19:01.846Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-09-04T06:19:01.846Z] { \ [2025-09-04T06:19:01.846Z] echo ""; echo "TEST SETUP:"; \ [2025-09-04T06:19:01.846Z] echo "Nothing to be done for setup."; \ [2025-09-04T06:19:01.846Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/jdk_io_1"; \ [2025-09-04T06:19:01.846Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/jdk_io_1"; \ [2025-09-04T06:19:01.846Z] echo ""; echo "TESTING:"; \ [2025-09-04T06:19:01.846Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-09-04T06:19:01.846Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:16 -xml:verify -k:'!headful' -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:-UseCompressedOops -Djava.awt.headless=true" \ [2025-09-04T06:19:01.846Z] \ [2025-09-04T06:19:01.846Z] -w ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/jdk_io_1"/work" \ [2025-09-04T06:19:01.846Z] -r ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/jdk_io_1"/report" \ [2025-09-04T06:19:01.846Z] -jdk:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image" \ [2025-09-04T06:19:01.846Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-09-04T06:19:01.846Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk21.txt" \ [2025-09-04T06:19:01.846Z] \ [2025-09-04T06:19:01.846Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk21.txt" \ [2025-09-04T06:19:01.846Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_io"; \ [2025-09-04T06:19:01.846Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_io_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_io_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-04T06:19:01.846Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-04T06:19:01.846Z] echo "Nothing to be done for teardown."; \ [2025-09-04T06:19:01.846Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/TestTargetResult"; [2025-09-04T06:19:01.847Z] [2025-09-04T06:19:01.847Z] TEST SETUP: [2025-09-04T06:19:01.847Z] Nothing to be done for setup. [2025-09-04T06:19:01.847Z] [2025-09-04T06:19:01.847Z] TESTING: [2025-09-04T06:19:01.847Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/jdk_io_1/work" not found: creating [2025-09-04T06:19:01.847Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/../TKG/output_17569569005823/jdk_io_1/report" not found: creating [2025-09-04T06:19:29.555Z] XML output with verification to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work [2025-09-04T06:55:36.319Z] -------------------------------------------------- [2025-09-04T06:55:36.319Z] TEST: java/io/PushbackReader/ReadCloseRaceNPE.java [2025-09-04T06:55:36.319Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image [2025-09-04T06:55:36.319Z] [2025-09-04T06:55:36.319Z] ACTION: build -- Passed. Build successful [2025-09-04T06:55:36.319Z] REASON: Named class compiled on demand [2025-09-04T06:55:36.319Z] TIME: 0.401 seconds [2025-09-04T06:55:36.319Z] messages: [2025-09-04T06:55:36.319Z] command: build ReadCloseRaceNPE [2025-09-04T06:55:36.319Z] reason: Named class compiled on demand [2025-09-04T06:55:36.319Z] started: Thu Sep 04 06:23:27 UTC 2025 [2025-09-04T06:55:36.319Z] Test directory: [2025-09-04T06:55:36.319Z] compile: ReadCloseRaceNPE [2025-09-04T06:55:36.319Z] finished: Thu Sep 04 06:23:28 UTC 2025 [2025-09-04T06:55:36.319Z] elapsed time (seconds): 0.401 [2025-09-04T06:55:36.319Z] [2025-09-04T06:55:36.319Z] ACTION: compile -- Passed. Compilation successful [2025-09-04T06:55:36.319Z] REASON: .class file out of date or does not exist [2025-09-04T06:55:36.319Z] TIME: 0.391 seconds [2025-09-04T06:55:36.319Z] messages: [2025-09-04T06:55:36.319Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader/ReadCloseRaceNPE.java [2025-09-04T06:55:36.319Z] reason: .class file out of date or does not exist [2025-09-04T06:55:36.319Z] started: Thu Sep 04 06:23:27 UTC 2025 [2025-09-04T06:55:36.319Z] Mode: agentvm [2025-09-04T06:55:36.319Z] Agent id: 1 [2025-09-04T06:55:36.319Z] finished: Thu Sep 04 06:23:28 UTC 2025 [2025-09-04T06:55:36.319Z] elapsed time (seconds): 0.391 [2025-09-04T06:55:36.319Z] configuration: [2025-09-04T06:55:36.319Z] Boot Layer (javac runtime environment) [2025-09-04T06:55:36.319Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-09-04T06:55:36.319Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-09-04T06:55:36.319Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/patches/java.base [2025-09-04T06:55:36.319Z] [2025-09-04T06:55:36.319Z] javac compilation environment [2025-09-04T06:55:36.319Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader [2025-09-04T06:55:36.319Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader [2025-09-04T06:55:36.319Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d [2025-09-04T06:55:36.319Z] [2025-09-04T06:55:36.319Z] rerun: [2025-09-04T06:55:36.319Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/scratch/1 && \ [2025-09-04T06:55:36.319Z] DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1001/bus \ [2025-09-04T06:55:36.319Z] DISPLAY=:0 \ [2025-09-04T06:55:36.319Z] HOME=/home/jenkins \ [2025-09-04T06:55:36.319Z] LANG=en_US.UTF-8 \ [2025-09-04T06:55:36.319Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-09-04T06:55:36.319Z] XDG_RUNTIME_DIR=/run/user/1001 \ [2025-09-04T06:55:36.319Z] XDG_SESSION_CLASS=user \ [2025-09-04T06:55:36.319Z] XDG_SESSION_ID=15 \ [2025-09-04T06:55:36.319Z] XDG_SESSION_TYPE=tty \ [2025-09-04T06:55:36.319Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image/bin/javac \ [2025-09-04T06:55:36.319Z] -J-ea \ [2025-09-04T06:55:36.319Z] -J-esa \ [2025-09-04T06:55:36.319Z] -J-Xmx512m \ [2025-09-04T06:55:36.319Z] -J-XX:-UseCompressedOops \ [2025-09-04T06:55:36.319Z] -J-Djava.awt.headless=true \ [2025-09-04T06:55:36.319Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops -Djava.awt.headless=true' \ [2025-09-04T06:55:36.319Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops -J-Djava.awt.headless=true' \ [2025-09-04T06:55:36.319Z] -J-Dtest.compiler.opts= \ [2025-09-04T06:55:36.319Z] -J-Dtest.java.opts= \ [2025-09-04T06:55:36.319Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image \ [2025-09-04T06:55:36.319Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image \ [2025-09-04T06:55:36.319Z] -J-Dtest.timeout.factor=16.0 \ [2025-09-04T06:55:36.319Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-09-04T06:55:36.319Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-09-04T06:55:36.319Z] -J-Dtest.name=java/io/PushbackReader/ReadCloseRaceNPE.java \ [2025-09-04T06:55:36.319Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader/ReadCloseRaceNPE.java \ [2025-09-04T06:55:36.319Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.319Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.319Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d \ [2025-09-04T06:55:36.319Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d \ [2025-09-04T06:55:36.319Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.319Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d \ [2025-09-04T06:55:36.319Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.320Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader/ReadCloseRaceNPE.java [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] ACTION: main -- Error. Agent error: java.lang.Exception: Agent 4 timed out with a timeout of 1920 seconds; check console log for any additional details [2025-09-04T06:55:36.320Z] REASON: Assumed action based on file name: run main ReadCloseRaceNPE [2025-09-04T06:55:36.320Z] TIME: 1921.5 seconds [2025-09-04T06:55:36.320Z] messages: [2025-09-04T06:55:36.320Z] command: main ReadCloseRaceNPE [2025-09-04T06:55:36.320Z] reason: Assumed action based on file name: run main ReadCloseRaceNPE [2025-09-04T06:55:36.320Z] started: Thu Sep 04 06:23:28 UTC 2025 [2025-09-04T06:55:36.320Z] Mode: agentvm [2025-09-04T06:55:36.320Z] Agent id: 4 [2025-09-04T06:55:36.320Z] Timeout signalled after 1920 seconds [2025-09-04T06:55:36.320Z] Timeout information: [2025-09-04T06:55:36.320Z] Running jstack on process 3417407 [2025-09-04T06:55:36.320Z] 2025-09-04 06:55:29 [2025-09-04T06:55:36.320Z] Full thread dump OpenJDK 64-Bit Server VM (21.0.9-beta+6-ea mixed mode): [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] Threads class SMR info: [2025-09-04T06:55:36.320Z] _java_thread_list=0x0000003f70002030, length=14, elements={ [2025-09-04T06:55:36.320Z] 0x0000003fd402bc40, 0x0000003fd41dc390, 0x0000003fd41dd910, 0x0000003fd41ef210, [2025-09-04T06:55:36.320Z] 0x0000003fd41f0770, 0x0000003fd41f1d00, 0x0000003fd41f3830, 0x0000003fd41f4e90, [2025-09-04T06:55:36.320Z] 0x0000003fd4268cd0, 0x0000003fd42e4330, 0x0000003fd4380540, 0x0000003fd43f4d40, [2025-09-04T06:55:36.320Z] 0x0000003f1405b110, 0x0000003f70000ff0 [2025-09-04T06:55:36.320Z] } [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "main" #1 [3417410] prio=5 os_prio=0 cpu=3621.76ms elapsed=2153.09s tid=0x0000003fd402bc40 nid=3417410 in Object.wait() [0x0000003fd9e84000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: WAITING (on object monitor) [2025-09-04T06:55:36.320Z] at java.lang.Object.wait0(java.base@21.0.9-beta/Native Method) [2025-09-04T06:55:36.320Z] - waiting on <no object reference available> [2025-09-04T06:55:36.320Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:366) [2025-09-04T06:55:36.320Z] at java.lang.Thread.join(java.base@21.0.9-beta/Thread.java:2079) [2025-09-04T06:55:36.320Z] - locked <0x0000003fa7e00000> (a java.lang.Thread) [2025-09-04T06:55:36.320Z] at java.lang.Thread.join(java.base@21.0.9-beta/Thread.java:2155) [2025-09-04T06:55:36.320Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219) [2025-09-04T06:55:36.320Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:317) [2025-09-04T06:55:36.320Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:242) [2025-09-04T06:55:36.320Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Reference Handler" #9 [3417420] daemon prio=10 os_prio=0 cpu=10.11ms elapsed=2152.76s tid=0x0000003fd41dc390 nid=3417420 waiting on condition [0x0000003f8d7bc000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.9-beta/Native Method) [2025-09-04T06:55:36.320Z] at java.lang.ref.Reference.processPendingReferences(java.base@21.0.9-beta/Reference.java:246) [2025-09-04T06:55:36.320Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.9-beta/Reference.java:208) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Finalizer" #10 [3417421] daemon prio=8 os_prio=0 cpu=1.32ms elapsed=2152.76s tid=0x0000003fd41dd910 nid=3417421 in Object.wait() [0x0000003f8d5bc000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: WAITING (on object monitor) [2025-09-04T06:55:36.320Z] at java.lang.Object.wait0(java.base@21.0.9-beta/Native Method) [2025-09-04T06:55:36.320Z] - waiting on <0x0000003f9c9f42e0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-09-04T06:55:36.320Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:366) [2025-09-04T06:55:36.320Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:339) [2025-09-04T06:55:36.320Z] at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.9-beta/NativeReferenceQueue.java:48) [2025-09-04T06:55:36.320Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.9-beta/ReferenceQueue.java:158) [2025-09-04T06:55:36.320Z] at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.9-beta/NativeReferenceQueue.java:89) [2025-09-04T06:55:36.320Z] - locked <0x0000003f9c9f42e0> (a java.lang.ref.NativeReferenceQueue$Lock) [2025-09-04T06:55:36.320Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.9-beta/Finalizer.java:173) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Signal Dispatcher" #11 [3417422] daemon prio=9 os_prio=0 cpu=0.90ms elapsed=2152.75s tid=0x0000003fd41ef210 nid=3417422 waiting on condition [0x0000000000000000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Service Thread" #12 [3417423] daemon prio=9 os_prio=0 cpu=48.48ms elapsed=2152.75s tid=0x0000003fd41f0770 nid=3417423 runnable [0x0000000000000000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Monitor Deflation Thread" #13 [3417424] daemon prio=9 os_prio=0 cpu=1081.74ms elapsed=2152.75s tid=0x0000003fd41f1d00 nid=3417424 runnable [0x0000000000000000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "C2 CompilerThread0" #14 [3417425] daemon prio=9 os_prio=0 cpu=16299.93ms elapsed=2152.75s tid=0x0000003fd41f3830 nid=3417425 waiting on condition [0x0000000000000000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] No compile task [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "C1 CompilerThread0" #16 [3417426] daemon prio=9 os_prio=0 cpu=6726.24ms elapsed=2152.74s tid=0x0000003fd41f4e90 nid=3417426 waiting on condition [0x0000000000000000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] No compile task [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Common-Cleaner" #17 [3417430] daemon prio=8 os_prio=0 cpu=20.79ms elapsed=2152.22s tid=0x0000003fd4268cd0 nid=3417430 waiting on condition [0x0000003f8c9bb000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-09-04T06:55:36.320Z] at jdk.internal.misc.Unsafe.park(java.base@21.0.9-beta/Native Method) [2025-09-04T06:55:36.320Z] - parking to wait for <0x0000003f9c9f4948> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-09-04T06:55:36.320Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.9-beta/LockSupport.java:269) [2025-09-04T06:55:36.320Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.9-beta/AbstractQueuedSynchronizer.java:1886) [2025-09-04T06:55:36.320Z] at java.lang.ref.ReferenceQueue.await(java.base@21.0.9-beta/ReferenceQueue.java:71) [2025-09-04T06:55:36.320Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.9-beta/ReferenceQueue.java:143) [2025-09-04T06:55:36.320Z] at java.lang.ref.ReferenceQueue.remove(java.base@21.0.9-beta/ReferenceQueue.java:218) [2025-09-04T06:55:36.320Z] at jdk.internal.ref.CleanerImpl.run(java.base@21.0.9-beta/CleanerImpl.java:140) [2025-09-04T06:55:36.320Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:55:36.320Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:55:36.320Z] at jdk.internal.misc.InnocuousThread.run(java.base@21.0.9-beta/InnocuousThread.java:186) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Notification Thread" #18 [3417434] daemon prio=9 os_prio=0 cpu=0.40ms elapsed=2151.59s tid=0x0000003fd42e4330 nid=3417434 runnable [0x0000000000000000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "pool-1-thread-1" #19 [3417438] daemon prio=5 os_prio=0 cpu=82.84ms elapsed=2149.77s tid=0x0000003fd4380540 nid=3417438 waiting on condition [0x0000003f8c5bb000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-09-04T06:55:36.320Z] at jdk.internal.misc.Unsafe.park(java.base@21.0.9-beta/Native Method) [2025-09-04T06:55:36.320Z] - parking to wait for <0x0000003f9c9f4d78> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-09-04T06:55:36.320Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.9-beta/LockSupport.java:269) [2025-09-04T06:55:36.320Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@21.0.9-beta/AbstractQueuedSynchronizer.java:1797) [2025-09-04T06:55:36.320Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@21.0.9-beta/ScheduledThreadPoolExecutor.java:1182) [2025-09-04T06:55:36.320Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@21.0.9-beta/ScheduledThreadPoolExecutor.java:899) [2025-09-04T06:55:36.320Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@21.0.9-beta/ThreadPoolExecutor.java:1070) [2025-09-04T06:55:36.320Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.9-beta/ThreadPoolExecutor.java:1130) [2025-09-04T06:55:36.320Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.9-beta/ThreadPoolExecutor.java:642) [2025-09-04T06:55:36.320Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:55:36.320Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "AgentVMThread" #153 [3421247] prio=5 os_prio=0 cpu=12.03ms elapsed=1921.06s tid=0x0000003fd43f4d40 nid=3421247 in Object.wait() [0x0000003f4abfa000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: WAITING (on object monitor) [2025-09-04T06:55:36.320Z] at java.lang.Object.wait0(java.base@21.0.9-beta/Native Method) [2025-09-04T06:55:36.320Z] - waiting on <no object reference available> [2025-09-04T06:55:36.320Z] at java.lang.Object.wait(java.base@21.0.9-beta/Object.java:366) [2025-09-04T06:55:36.320Z] at java.lang.Thread.join(java.base@21.0.9-beta/Thread.java:2079) [2025-09-04T06:55:36.320Z] - locked <0x0000003fb7d82ff0> (a java.lang.Thread) [2025-09-04T06:55:36.320Z] at java.lang.Thread.join(java.base@21.0.9-beta/Thread.java:2155) [2025-09-04T06:55:36.320Z] at ReadCloseRaceNPE.testReader(ReadCloseRaceNPE.java:88) [2025-09-04T06:55:36.320Z] at ReadCloseRaceNPE.main(ReadCloseRaceNPE.java:108) [2025-09-04T06:55:36.320Z] at java.lang.invoke.LambdaForm$DMH/0x00000000800c0000.invokeStatic(java.base@21.0.9-beta/LambdaForm$DMH) [2025-09-04T06:55:36.320Z] at java.lang.invoke.LambdaForm$MH/0x0000000080141800.invoke(java.base@21.0.9-beta/LambdaForm$MH) [2025-09-04T06:55:36.320Z] at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@21.0.9-beta/Invokers$Holder) [2025-09-04T06:55:36.320Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@21.0.9-beta/DirectMethodHandleAccessor.java:154) [2025-09-04T06:55:36.320Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@21.0.9-beta/DirectMethodHandleAccessor.java:103) [2025-09-04T06:55:36.320Z] at java.lang.reflect.Method.invoke(java.base@21.0.9-beta/Method.java:580) [2025-09-04T06:55:36.320Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2025-09-04T06:55:36.320Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:55:36.320Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.320Z] "Thread-117" #157 [3421256] prio=5 os_prio=0 cpu=1509.46ms elapsed=1918.02s tid=0x0000003f1405b110 nid=3421256 waiting for monitor entry [0x0000003f4adfb000] [2025-09-04T06:55:36.320Z] java.lang.Thread.State: BLOCKED (on object monitor) [2025-09-04T06:55:36.320Z] at java.io.StringReader.close(java.base@21.0.9-beta/StringReader.java:209) [2025-09-04T06:55:36.320Z] - waiting to lock <0x0000003fac950060> (a java.io.StringReader) [2025-09-04T06:55:36.320Z] at java.io.FilterReader.close(java.base@21.0.9-beta/FilterReader.java:122) [2025-09-04T06:55:36.320Z] at java.io.PushbackReader.close(java.base@21.0.9-beta/PushbackReader.java:238) [2025-09-04T06:55:36.320Z] - locked <0x0000003fac950060> (a java.io.StringReader) [2025-09-04T06:55:36.320Z] at ReadCloseRaceNPE.lambda$testReader$1(ReadCloseRaceNPE.java:73) [2025-09-04T06:55:36.320Z] at ReadCloseRaceNPE$$Lambda/0x0000000080391650.run(Unknown Source) [2025-09-04T06:55:36.320Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:55:36.320Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:55:36.320Z] [2025-09-04T06:55:36.321Z] "Attach Listener" #158 [3425625] daemon prio=9 os_prio=0 cpu=1.04ms elapsed=0.10s tid=0x0000003f70000ff0 nid=3425625 waiting on condition [0x0000000000000000] [2025-09-04T06:55:36.321Z] java.lang.Thread.State: RUNNABLE [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "GC Thread#3" os_prio=0 cpu=209.97ms elapsed=2121.35s tid=0x0000003f74007f10 nid=3417632 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "GC Thread#2" os_prio=0 cpu=189.39ms elapsed=2121.36s tid=0x0000003f74007400 nid=3417631 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "GC Thread#1" os_prio=0 cpu=182.71ms elapsed=2121.37s tid=0x0000003f740068f0 nid=3417630 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "VM Thread" os_prio=0 cpu=327.78ms elapsed=2152.94s tid=0x0000003fd417c5f0 nid=3417418 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "VM Periodic Task Thread" os_prio=0 cpu=5202.74ms elapsed=2153.07s tid=0x0000003fd411e640 nid=3417417 waiting on condition [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "G1 Service" os_prio=0 cpu=366.73ms elapsed=2153.07s tid=0x0000003fd41107a0 nid=3417416 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "G1 Refine#0" os_prio=0 cpu=3226.23ms elapsed=2153.07s tid=0x0000003fd410f7f0 nid=3417415 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "G1 Conc#0" os_prio=0 cpu=93.36ms elapsed=2153.08s tid=0x0000003fd405d2f0 nid=3417414 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "G1 Main Marker" os_prio=0 cpu=3.42ms elapsed=2153.08s tid=0x0000003fd405c350 nid=3417413 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] "GC Thread#0" os_prio=0 cpu=157.52ms elapsed=2153.08s tid=0x0000003fd4056af0 nid=3417412 runnable [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] JNI global refs: 16, weak refs: 0 [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] Found one Java-level deadlock: [2025-09-04T06:55:36.321Z] ============================= [2025-09-04T06:55:36.321Z] "Thread-117": [2025-09-04T06:55:36.321Z] waiting to lock monitor 0x0000003f505a3140 (object 0x0000003fac950060, a java.io.StringReader), [2025-09-04T06:55:36.321Z] which is held by UNKNOWN_owner_addr=0x0000003f14048140 [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] Java stack information for the threads listed above: [2025-09-04T06:55:36.321Z] =================================================== [2025-09-04T06:55:36.321Z] "Thread-117": [2025-09-04T06:55:36.321Z] at java.io.StringReader.close(java.base@21.0.9-beta/StringReader.java:209) [2025-09-04T06:55:36.321Z] - waiting to lock <0x0000003fac950060> (a java.io.StringReader) [2025-09-04T06:55:36.321Z] at java.io.FilterReader.close(java.base@21.0.9-beta/FilterReader.java:122) [2025-09-04T06:55:36.321Z] at java.io.PushbackReader.close(java.base@21.0.9-beta/PushbackReader.java:238) [2025-09-04T06:55:36.321Z] - locked <0x0000003fac950060> (a java.io.StringReader) [2025-09-04T06:55:36.321Z] at ReadCloseRaceNPE.lambda$testReader$1(ReadCloseRaceNPE.java:73) [2025-09-04T06:55:36.321Z] at ReadCloseRaceNPE$$Lambda/0x0000000080391650.run(Unknown Source) [2025-09-04T06:55:36.321Z] at java.lang.Thread.runWith(java.base@21.0.9-beta/Thread.java:1596) [2025-09-04T06:55:36.321Z] at java.lang.Thread.run(java.base@21.0.9-beta/Thread.java:1583) [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] Found 1 deadlock. [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] --- Timeout information end. [2025-09-04T06:55:36.321Z] finished: Thu Sep 04 06:55:29 UTC 2025 [2025-09-04T06:55:36.321Z] elapsed time (seconds): 1921.5 [2025-09-04T06:55:36.321Z] configuration: [2025-09-04T06:55:36.321Z] Boot Layer [2025-09-04T06:55:36.321Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-09-04T06:55:36.321Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/patches/java.base [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] Test Layer [2025-09-04T06:55:36.321Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] rerun: [2025-09-04T06:55:36.321Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/scratch/1 && \ [2025-09-04T06:55:36.321Z] DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1001/bus \ [2025-09-04T06:55:36.321Z] DISPLAY=:0 \ [2025-09-04T06:55:36.321Z] HOME=/home/jenkins \ [2025-09-04T06:55:36.321Z] LANG=en_US.UTF-8 \ [2025-09-04T06:55:36.321Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-09-04T06:55:36.321Z] XDG_RUNTIME_DIR=/run/user/1001 \ [2025-09-04T06:55:36.321Z] XDG_SESSION_CLASS=user \ [2025-09-04T06:55:36.321Z] XDG_SESSION_ID=15 \ [2025-09-04T06:55:36.321Z] XDG_SESSION_TYPE=tty \ [2025-09-04T06:55:36.321Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image/bin/java \ [2025-09-04T06:55:36.321Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:-UseCompressedOops -Djava.awt.headless=true' \ [2025-09-04T06:55:36.321Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:-UseCompressedOops -J-Djava.awt.headless=true' \ [2025-09-04T06:55:36.321Z] -Dtest.compiler.opts= \ [2025-09-04T06:55:36.321Z] -Dtest.java.opts= \ [2025-09-04T06:55:36.321Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image \ [2025-09-04T06:55:36.321Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/j2sdk-image \ [2025-09-04T06:55:36.321Z] -Dtest.timeout.factor=16.0 \ [2025-09-04T06:55:36.321Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-09-04T06:55:36.321Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-09-04T06:55:36.321Z] -Dtest.name=java/io/PushbackReader/ReadCloseRaceNPE.java \ [2025-09-04T06:55:36.321Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader/ReadCloseRaceNPE.java \ [2025-09-04T06:55:36.321Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.321Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.321Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d \ [2025-09-04T06:55:36.321Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d \ [2025-09-04T06:55:36.321Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader \ [2025-09-04T06:55:36.321Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work/classes/0/java/io/PushbackReader/ReadCloseRaceNPE.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/io/PushbackReader:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-09-04T06:55:36.321Z] ReadCloseRaceNPE [2025-09-04T06:55:36.321Z] [2025-09-04T06:55:36.321Z] TEST RESULT: Error. Agent error: java.lang.Exception: Agent 4 timed out with a timeout of 1920 seconds; check console log for any additional details [2025-09-04T06:55:36.321Z] -------------------------------------------------- [2025-09-04T06:55:36.321Z] Test results: passed: 423; error: 1 [2025-09-04T06:56:25.132Z] Report written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/report/html/report.html [2025-09-04T06:56:25.132Z] Results written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_riscv64_linux_testList_5/aqa-tests/TKG/output_17569569005823/jdk_io_1/work [2025-09-04T06:56:25.132Z] Error: Some tests failed or other problems occurred. [2025-09-04T06:56:25.132Z] ----------------------------------- [2025-09-04T06:56:25.132Z] jdk_io_1_FAILED [2025-09-04T06:56:25.132Z] ----------------------------------- [2025-09-04T06:56:25.132Z] [2025-09-04T06:56:25.132Z] TEST TEARDOWN: [2025-09-04T06:56:25.133Z] Nothing to be done for teardown. [2025-09-04T06:56:25.133Z] jdk_io_1 Finish Time: Thu Sep 4 06:56:23 2025 Epoch Time (ms): 1756968983718