[2025-05-19T13:48:30.127Z] Running test jdk_util_0 ... [2025-05-19T13:48:30.127Z] =============================================== [2025-05-19T13:48:30.127Z] jdk_util_0 Start Time: Mon May 19 13:48:28 2025 Epoch Time (ms): 1747662508223 [2025-05-19T13:48:30.127Z] variation: Mode150 [2025-05-19T13:48:30.127Z] JVM_OPTIONS: -XX:+UseCompressedOops [2025-05-19T13:48:30.127Z] { \ [2025-05-19T13:48:30.127Z] echo ""; echo "TEST SETUP:"; \ [2025-05-19T13:48:30.127Z] echo "Nothing to be done for setup."; \ [2025-05-19T13:48:30.127Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/jdk_util_0"; \ [2025-05-19T13:48:30.127Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/jdk_util_0"; \ [2025-05-19T13:48:30.127Z] echo ""; echo "TESTING:"; \ [2025-05-19T13:48:30.127Z] "/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-19T13:48:30.128Z] -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/jdk/jtreg/native" -vmoptions:"-Xmx1540m -XX:+UseCompressedOops " \ [2025-05-19T13:48:30.128Z] \ [2025-05-19T13:48:30.128Z] -w ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/jdk_util_0"/work" \ [2025-05-19T13:48:30.128Z] -r ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/jdk_util_0"/report" \ [2025-05-19T13:48:30.128Z] -jdk:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image" \ [2025-05-19T13:48:30.128Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-05-19T13:48:30.128Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk25.txt" \ [2025-05-19T13:48:30.128Z] \ [2025-05-19T13:48:30.128Z] \ [2025-05-19T13:48:30.128Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_util"; \ [2025-05-19T13:48:30.128Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_util_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_util_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-19T13:48:30.128Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-19T13:48:30.128Z] echo "Nothing to be done for teardown."; \ [2025-05-19T13:48:30.128Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/TestTargetResult"; [2025-05-19T13:48:30.128Z] [2025-05-19T13:48:30.128Z] TEST SETUP: [2025-05-19T13:48:30.128Z] Nothing to be done for setup. [2025-05-19T13:48:30.128Z] [2025-05-19T13:48:30.128Z] TESTING: [2025-05-19T13:48:30.128Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/jdk_util_0/work" not found: creating [2025-05-19T13:48:30.128Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/../TKG/output_17476337074843/jdk_util_0/report" not found: creating [2025-05-19T13:48:34.789Z] XML output with verification to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work [2025-05-19T14:15:46.981Z] -------------------------------------------------- [2025-05-19T14:15:46.981Z] TEST: java/util/Date/DateGregorianCalendarTest.java [2025-05-19T14:15:46.981Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image [2025-05-19T14:15:46.981Z] [2025-05-19T14:15:46.981Z] ACTION: build -- Passed. Build successful [2025-05-19T14:15:46.981Z] REASON: Named class compiled on demand [2025-05-19T14:15:46.981Z] TIME: 0.252 seconds [2025-05-19T14:15:46.981Z] messages: [2025-05-19T14:15:46.981Z] command: build DateGregorianCalendarTest [2025-05-19T14:15:46.981Z] reason: Named class compiled on demand [2025-05-19T14:15:46.981Z] started: Mon May 19 13:59:40 GMT 2025 [2025-05-19T14:15:46.981Z] Test directory: [2025-05-19T14:15:46.981Z] compile: DateGregorianCalendarTest [2025-05-19T14:15:46.981Z] finished: Mon May 19 13:59:40 GMT 2025 [2025-05-19T14:15:46.981Z] elapsed time (seconds): 0.252 [2025-05-19T14:15:46.981Z] [2025-05-19T14:15:46.981Z] ACTION: compile -- Passed. Compilation successful [2025-05-19T14:15:46.981Z] REASON: .class file out of date or does not exist [2025-05-19T14:15:46.981Z] TIME: 0.252 seconds [2025-05-19T14:15:46.981Z] messages: [2025-05-19T14:15:46.981Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date/DateGregorianCalendarTest.java [2025-05-19T14:15:46.981Z] reason: .class file out of date or does not exist [2025-05-19T14:15:46.981Z] started: Mon May 19 13:59:40 GMT 2025 [2025-05-19T14:15:46.981Z] Mode: agentvm [2025-05-19T14:15:46.981Z] Agent id: 1 [2025-05-19T14:15:46.981Z] Process id: 16581056 [2025-05-19T14:15:46.981Z] finished: Mon May 19 13:59:40 GMT 2025 [2025-05-19T14:15:46.981Z] elapsed time (seconds): 0.252 [2025-05-19T14:15:46.981Z] configuration: [2025-05-19T14:15:46.981Z] Boot Layer (javac runtime environment) [2025-05-19T14:15:46.982Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-19T14:15:46.982Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-19T14:15:46.982Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/patches/java.base [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] javac compilation environment [2025-05-19T14:15:46.982Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date [2025-05-19T14:15:46.982Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date [2025-05-19T14:15:46.982Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] rerun: [2025-05-19T14:15:46.982Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/scratch && \ [2025-05-19T14:15:46.982Z] DISPLAY=unix:0 \ [2025-05-19T14:15:46.982Z] HOME=/home/jenkins \ [2025-05-19T14:15:46.982Z] LANG=C \ [2025-05-19T14:15:46.982Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-19T14:15:46.982Z] TZ=UTC0 \ [2025-05-19T14:15:46.982Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/javac \ [2025-05-19T14:15:46.982Z] -J-ea \ [2025-05-19T14:15:46.982Z] -J-esa \ [2025-05-19T14:15:46.982Z] -J-Xmx1540m \ [2025-05-19T14:15:46.982Z] -J-XX:+UseCompressedOops \ [2025-05-19T14:15:46.982Z] -J-Dtest.vm.opts='-ea -esa -Xmx1540m -XX:+UseCompressedOops' \ [2025-05-19T14:15:46.982Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-XX:+UseCompressedOops' \ [2025-05-19T14:15:46.982Z] -J-Dtest.compiler.opts= \ [2025-05-19T14:15:46.982Z] -J-Dtest.java.opts= \ [2025-05-19T14:15:46.982Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T14:15:46.982Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T14:15:46.982Z] -J-Dtest.timeout.factor=8.0 \ [2025-05-19T14:15:46.982Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-19T14:15:46.982Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-19T14:15:46.982Z] -J-Dtest.name=java/util/Date/DateGregorianCalendarTest.java \ [2025-05-19T14:15:46.982Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-19T14:15:46.982Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date/DateGregorianCalendarTest.java \ [2025-05-19T14:15:46.982Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.982Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.982Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d \ [2025-05-19T14:15:46.982Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d \ [2025-05-19T14:15:46.982Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.982Z] -d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d \ [2025-05-19T14:15:46.982Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.982Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date/DateGregorianCalendarTest.java [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] ACTION: main -- Error. "main" action timed out with a timeout of 960 seconds on agent 5 [2025-05-19T14:15:46.982Z] REASON: User specified action: run main DateGregorianCalendarTest 15 [2025-05-19T14:15:46.982Z] TIME: 960.513 seconds [2025-05-19T14:15:46.982Z] messages: [2025-05-19T14:15:46.982Z] command: main DateGregorianCalendarTest 15 [2025-05-19T14:15:46.982Z] reason: User specified action: run main DateGregorianCalendarTest 15 [2025-05-19T14:15:46.982Z] started: Mon May 19 13:59:40 GMT 2025 [2025-05-19T14:15:46.982Z] Mode: agentvm [2025-05-19T14:15:46.982Z] Agent id: 5 [2025-05-19T14:15:46.982Z] Process id: 19267880 [2025-05-19T14:15:46.982Z] Timeout signalled after 960 seconds [2025-05-19T14:15:46.982Z] Timeout information: [2025-05-19T14:15:46.982Z] Running jstack on process 19267880 [2025-05-19T14:15:46.982Z] 2025-05-19 14:15:41 [2025-05-19T14:15:46.982Z] Full thread dump OpenJDK 64-Bit Server VM (25-beta+23-ea mixed mode): [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] Threads class SMR info: [2025-05-19T14:15:46.982Z] _java_thread_list=0x00000001142b4b80, length=14, elements={ [2025-05-19T14:15:46.982Z] 0x000000011025b2c0, 0x0000000112ec6060, 0x0000000112ec9960, 0x0000000112ecd840, [2025-05-19T14:15:46.982Z] 0x0000000112ecf000, 0x0000000113766ca0, 0x000000011398d0a0, 0x0000000113e0a680, [2025-05-19T14:15:46.982Z] 0x0000000114fd95c0, 0x0000000115d553c0, 0x0000000116065b20, 0x00000001143cb6e0, [2025-05-19T14:15:46.982Z] 0x00000001143fc560, 0x00000001142ec180 [2025-05-19T14:15:46.982Z] } [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] "main" #3 [258] prio=5 os_prio=57 cpu=284.34ms elapsed=1021.84s tid=0x000000011025b2c0 nid=258 in Object.wait() [0x000000011023c000] [2025-05-19T14:15:46.982Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T14:15:46.982Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T14:15:46.982Z] - waiting on <0x0000000096700000> (a java.lang.Thread) [2025-05-19T14:15:46.982Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T14:15:46.982Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1860) [2025-05-19T14:15:46.982Z] - locked <0x0000000096700000> (a java.lang.Thread) [2025-05-19T14:15:46.982Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-19T14:15:46.982Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219) [2025-05-19T14:15:46.982Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:319) [2025-05-19T14:15:46.982Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:244) [2025-05-19T14:15:46.982Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] "Reference Handler" #11 [2314] daemon prio=10 os_prio=57 cpu=0.72ms elapsed=1021.78s tid=0x0000000112ec6060 nid=2314 waiting on condition [0x00000001130ec000] [2025-05-19T14:15:46.982Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.982Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@25-beta/Native Method) [2025-05-19T14:15:46.982Z] at java.lang.ref.Reference.processPendingReferences(java.base@25-beta/Reference.java:246) [2025-05-19T14:15:46.982Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@25-beta/Reference.java:208) [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] "Finalizer" #12 [2571] daemon prio=8 os_prio=57 cpu=0.12ms elapsed=1021.78s tid=0x0000000112ec9960 nid=2571 in Object.wait() [0x000000011330c000] [2025-05-19T14:15:46.982Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T14:15:46.982Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T14:15:46.982Z] - waiting on <0x00000000900001e0> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T14:15:46.982Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T14:15:46.982Z] at java.lang.Object.wait(java.base@25-beta/Object.java:351) [2025-05-19T14:15:46.982Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:137) [2025-05-19T14:15:46.982Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:215) [2025-05-19T14:15:46.982Z] - locked <0x00000000900001e0> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T14:15:46.982Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@25-beta/Finalizer.java:165) [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] "Signal Dispatcher" #13 [2828] daemon prio=9 os_prio=57 cpu=0.17ms elapsed=1021.78s tid=0x0000000112ecd840 nid=2828 waiting on condition [0x0000000000000000] [2025-05-19T14:15:46.982Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] "Service Thread" #14 [3085] daemon prio=9 os_prio=57 cpu=7.51ms elapsed=1021.78s tid=0x0000000112ecf000 nid=3085 runnable [0x0000000000000000] [2025-05-19T14:15:46.982Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.982Z] "Monitor Deflation Thread" #15 [3342] daemon prio=9 os_prio=57 cpu=13.78ms elapsed=1021.78s tid=0x0000000113766ca0 nid=3342 runnable [0x0000000000000000] [2025-05-19T14:15:46.982Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.982Z] [2025-05-19T14:15:46.983Z] "C2 CompilerThread0" #16 [3599] daemon prio=9 os_prio=57 cpu=478.44ms elapsed=1021.78s tid=0x000000011398d0a0 nid=3599 waiting on condition [0x0000000000000000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.983Z] No compile task [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "C1 CompilerThread0" #24 [3856] daemon prio=9 os_prio=57 cpu=158.88ms elapsed=1021.78s tid=0x0000000113e0a680 nid=3856 waiting on condition [0x0000000000000000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.983Z] No compile task [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "Common-Cleaner" #28 [4884] daemon prio=8 os_prio=57 cpu=0.62ms elapsed=1021.66s tid=0x0000000114fd95c0 nid=4884 in Object.wait() [0x00000001151ec000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-05-19T14:15:46.983Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T14:15:46.983Z] - waiting on <0x0000000090000468> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T14:15:46.983Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T14:15:46.983Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:123) [2025-05-19T14:15:46.983Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:201) [2025-05-19T14:15:46.983Z] - locked <0x0000000090000468> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T14:15:46.983Z] at jdk.internal.ref.CleanerImpl.run(java.base@25-beta/CleanerImpl.java:146) [2025-05-19T14:15:46.983Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T14:15:46.983Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T14:15:46.983Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "Notification Thread" #29 [5398] daemon prio=9 os_prio=57 cpu=0.03ms elapsed=1021.55s tid=0x0000000115d553c0 nid=5398 runnable [0x0000000000000000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "pool-1-thread-1" #30 [5655] daemon prio=5 os_prio=57 cpu=2.89ms elapsed=1021.32s tid=0x0000000116065b20 nid=5655 waiting on condition [0x000000011627c000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-05-19T14:15:46.983Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-19T14:15:46.983Z] - parking to wait for <0x00000000900006d8> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-19T14:15:46.983Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@25-beta/LockSupport.java:271) [2025-05-19T14:15:46.983Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@25-beta/AbstractQueuedSynchronizer.java:1802) [2025-05-19T14:15:46.983Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:1166) [2025-05-19T14:15:46.983Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:883) [2025-05-19T14:15:46.983Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@25-beta/ThreadPoolExecutor.java:1016) [2025-05-19T14:15:46.983Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1076) [2025-05-19T14:15:46.983Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-19T14:15:46.983Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T14:15:46.983Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "AgentVMThread" #320 [4177] prio=5 os_prio=57 cpu=0.93ms elapsed=960.30s tid=0x00000001143cb6e0 nid=4177 in Object.wait() [0x000000011725c000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T14:15:46.983Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T14:15:46.983Z] - waiting on <0x0000000096701020> (a java.lang.Thread) [2025-05-19T14:15:46.983Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T14:15:46.983Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1860) [2025-05-19T14:15:46.983Z] - locked <0x0000000096701020> (a java.lang.Thread) [2025-05-19T14:15:46.983Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-19T14:15:46.983Z] at DateGregorianCalendarTest.main(DateGregorianCalendarTest.java:194) [2025-05-19T14:15:46.983Z] at java.lang.invoke.LambdaForm$DMH/0x0000000660047c00.invokeStatic(java.base@25-beta/LambdaForm$DMH) [2025-05-19T14:15:46.983Z] at java.lang.invoke.LambdaForm$MH/0x00000006600cf400.invoke(java.base@25-beta/LambdaForm$MH) [2025-05-19T14:15:46.983Z] at java.lang.invoke.LambdaForm$MH/0x00000006600cf800.invokeExact_MT(java.base@25-beta/LambdaForm$MH) [2025-05-19T14:15:46.983Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@25-beta/DirectMethodHandleAccessor.java:155) [2025-05-19T14:15:46.983Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@25-beta/DirectMethodHandleAccessor.java:104) [2025-05-19T14:15:46.983Z] at java.lang.reflect.Method.invoke(java.base@25-beta/Method.java:565) [2025-05-19T14:15:46.983Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:335) [2025-05-19T14:15:46.983Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T14:15:46.983Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "Thread-113" #322 [6739] prio=5 os_prio=57 cpu=564934.71ms elapsed=960.30s tid=0x00000001143fc560 nid=6739 runnable [0x000000011747c000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.983Z] at java.util.Calendar.clear(java.base@25-beta/Calendar.java:2008) [2025-05-19T14:15:46.983Z] at java.util.Date.normalize(java.base@25-beta/Date.java:1242) [2025-05-19T14:15:46.983Z] at java.util.Date.normalize(java.base@25-beta/Date.java:1204) [2025-05-19T14:15:46.983Z] at java.util.Date.getTimeImpl(java.base@25-beta/Date.java:888) [2025-05-19T14:15:46.983Z] at java.util.Date.<init>(java.base@25-beta/Date.java:252) [2025-05-19T14:15:46.983Z] at DateGregorianCalendarTest.checkTimes(DateGregorianCalendarTest.java:208) [2025-05-19T14:15:46.983Z] at DateGregorianCalendarTest$2.run(DateGregorianCalendarTest.java:108) [2025-05-19T14:15:46.983Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T14:15:46.983Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "Attach Listener" #324 [4449] daemon prio=9 os_prio=57 cpu=0.21ms elapsed=0.11s tid=0x00000001142ec180 nid=4449 waiting on condition [0x0000000000000000] [2025-05-19T14:15:46.983Z] java.lang.Thread.State: RUNNABLE [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "G1 Conc#2" os_prio=57 cpu=0.03ms elapsed=971.47s tid=0x00000001144d1d80 nid=10828 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "G1 Conc#1" os_prio=57 cpu=4.30ms elapsed=971.47s tid=0x000000011428c3a0 nid=7499 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#12" os_prio=57 cpu=2.48ms elapsed=1018.30s tid=0x00000001144c03c0 nid=10602 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#11" os_prio=57 cpu=16.52ms elapsed=1018.30s tid=0x00000001144bd980 nid=10345 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#10" os_prio=57 cpu=1.34ms elapsed=1018.30s tid=0x00000001144baf40 nid=10088 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#9" os_prio=57 cpu=7.97ms elapsed=1018.30s tid=0x00000001144b8500 nid=9831 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#8" os_prio=57 cpu=6.39ms elapsed=1018.30s tid=0x00000001144b5ac0 nid=9574 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#7" os_prio=57 cpu=7.99ms elapsed=1018.30s tid=0x00000001144b3080 nid=9317 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#6" os_prio=57 cpu=3.05ms elapsed=1018.30s tid=0x00000001144b0780 nid=9060 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#5" os_prio=57 cpu=2.99ms elapsed=1018.30s tid=0x00000001144ade80 nid=8803 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#4" os_prio=57 cpu=4.21ms elapsed=1018.30s tid=0x00000001144ab580 nid=8546 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#3" os_prio=57 cpu=3.03ms elapsed=1018.30s tid=0x00000001144a8c80 nid=8289 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#2" os_prio=57 cpu=8.75ms elapsed=1018.30s tid=0x00000001144a6380 nid=8032 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#1" os_prio=57 cpu=8.34ms elapsed=1018.30s tid=0x00000001144a3a00 nid=7775 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "VM Thread" os_prio=57 cpu=6.65ms elapsed=1021.81s tid=0x0000000112c47ce0 nid=2057 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "VM Periodic Task Thread" os_prio=57 cpu=66.16ms elapsed=1021.83s tid=0x00000001129c8880 nid=1800 waiting on condition [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "G1 Service" os_prio=57 cpu=9.72ms elapsed=1021.83s tid=0x0000000112667560 nid=1543 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "G1 Refine#0" os_prio=57 cpu=0.08ms elapsed=1021.83s tid=0x0000000112430ba0 nid=1286 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "G1 Conc#0" os_prio=57 cpu=0.18ms elapsed=1021.83s tid=0x000000011142cb20 nid=1029 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "G1 Main Marker" os_prio=57 cpu=0.23ms elapsed=1021.83s tid=0x00000001111f62c0 nid=772 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] "GC Thread#0" os_prio=57 cpu=1.11ms elapsed=1021.83s tid=0x0000000110fac7a0 nid=515 runnable [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] JNI global refs: 25, weak refs: 0 [2025-05-19T14:15:46.983Z] [2025-05-19T14:15:46.983Z] --- Timeout information end. [2025-05-19T14:15:46.983Z] finished: Mon May 19 14:15:41 GMT 2025 [2025-05-19T14:15:46.984Z] elapsed time (seconds): 960.513 [2025-05-19T14:15:46.984Z] configuration: [2025-05-19T14:15:46.984Z] Boot Layer [2025-05-19T14:15:46.984Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-05-19T14:15:46.984Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/patches/java.base [2025-05-19T14:15:46.984Z] [2025-05-19T14:15:46.984Z] Test Layer [2025-05-19T14:15:46.984Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date [2025-05-19T14:15:46.984Z] [2025-05-19T14:15:46.984Z] rerun: [2025-05-19T14:15:46.984Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/scratch && \ [2025-05-19T14:15:46.984Z] DISPLAY=unix:0 \ [2025-05-19T14:15:46.984Z] HOME=/home/jenkins \ [2025-05-19T14:15:46.984Z] LANG=C \ [2025-05-19T14:15:46.984Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-19T14:15:46.984Z] TZ=UTC0 \ [2025-05-19T14:15:46.984Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java \ [2025-05-19T14:15:46.984Z] -Dtest.vm.opts='-ea -esa -Xmx1540m -XX:+UseCompressedOops' \ [2025-05-19T14:15:46.984Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-XX:+UseCompressedOops' \ [2025-05-19T14:15:46.984Z] -Dtest.compiler.opts= \ [2025-05-19T14:15:46.984Z] -Dtest.java.opts= \ [2025-05-19T14:15:46.984Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T14:15:46.984Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T14:15:46.984Z] -Dtest.timeout.factor=8.0 \ [2025-05-19T14:15:46.984Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-19T14:15:46.984Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-19T14:15:46.984Z] -Dtest.name=java/util/Date/DateGregorianCalendarTest.java \ [2025-05-19T14:15:46.984Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-19T14:15:46.984Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date/DateGregorianCalendarTest.java \ [2025-05-19T14:15:46.984Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.984Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.984Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d \ [2025-05-19T14:15:46.984Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d \ [2025-05-19T14:15:46.984Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date \ [2025-05-19T14:15:46.984Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/Date/DateGregorianCalendarTest.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/Date:/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-19T14:15:46.984Z] DateGregorianCalendarTest 15 [2025-05-19T14:15:46.984Z] STDOUT: [2025-05-19T14:15:46.984Z] Part I (count=2124094): Passed [2025-05-19T14:15:46.984Z] Part III (count=3568013): Passed [2025-05-19T14:15:46.984Z] [2025-05-19T14:15:46.984Z] TEST RESULT: Error. "main" action timed out with a timeout of 960 seconds on agent 5 [2025-05-19T14:15:46.984Z] -------------------------------------------------- [2025-05-19T15:03:44.259Z] TEST: java/util/zip/DeInflate.java [2025-05-19T15:03:44.259Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image [2025-05-19T15:03:44.259Z] [2025-05-19T15:03:44.259Z] ACTION: build -- Passed. Build successful [2025-05-19T15:03:44.259Z] REASON: Named class compiled on demand [2025-05-19T15:03:44.259Z] TIME: 0.17 seconds [2025-05-19T15:03:44.259Z] messages: [2025-05-19T15:03:44.259Z] command: build DeInflate [2025-05-19T15:03:44.259Z] reason: Named class compiled on demand [2025-05-19T15:03:44.259Z] started: Mon May 19 14:47:30 GMT 2025 [2025-05-19T15:03:44.259Z] Test directory: [2025-05-19T15:03:44.259Z] compile: DeInflate [2025-05-19T15:03:44.259Z] finished: Mon May 19 14:47:30 GMT 2025 [2025-05-19T15:03:44.259Z] elapsed time (seconds): 0.17 [2025-05-19T15:03:44.259Z] [2025-05-19T15:03:44.259Z] ACTION: compile -- Passed. Compilation successful [2025-05-19T15:03:44.259Z] REASON: .class file out of date or does not exist [2025-05-19T15:03:44.259Z] TIME: 0.17 seconds [2025-05-19T15:03:44.259Z] messages: [2025-05-19T15:03:44.259Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip/DeInflate.java [2025-05-19T15:03:44.259Z] reason: .class file out of date or does not exist [2025-05-19T15:03:44.259Z] started: Mon May 19 14:47:30 GMT 2025 [2025-05-19T15:03:44.259Z] Mode: agentvm [2025-05-19T15:03:44.259Z] Agent id: 1 [2025-05-19T15:03:44.259Z] Process id: 16581056 [2025-05-19T15:03:44.259Z] finished: Mon May 19 14:47:30 GMT 2025 [2025-05-19T15:03:44.259Z] elapsed time (seconds): 0.17 [2025-05-19T15:03:44.259Z] configuration: [2025-05-19T15:03:44.259Z] Boot Layer (javac runtime environment) [2025-05-19T15:03:44.259Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-19T15:03:44.259Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-19T15:03:44.259Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/patches/java.base [2025-05-19T15:03:44.259Z] [2025-05-19T15:03:44.259Z] javac compilation environment [2025-05-19T15:03:44.259Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip [2025-05-19T15:03:44.259Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip [2025-05-19T15:03:44.259Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d [2025-05-19T15:03:44.259Z] [2025-05-19T15:03:44.259Z] rerun: [2025-05-19T15:03:44.259Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/scratch && \ [2025-05-19T15:03:44.259Z] DISPLAY=unix:0 \ [2025-05-19T15:03:44.259Z] HOME=/home/jenkins \ [2025-05-19T15:03:44.259Z] LANG=C \ [2025-05-19T15:03:44.259Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-19T15:03:44.259Z] TZ=UTC0 \ [2025-05-19T15:03:44.259Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/javac \ [2025-05-19T15:03:44.259Z] -J-ea \ [2025-05-19T15:03:44.259Z] -J-esa \ [2025-05-19T15:03:44.259Z] -J-Xmx1540m \ [2025-05-19T15:03:44.259Z] -J-XX:+UseCompressedOops \ [2025-05-19T15:03:44.259Z] -J-Dtest.vm.opts='-ea -esa -Xmx1540m -XX:+UseCompressedOops' \ [2025-05-19T15:03:44.259Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-XX:+UseCompressedOops' \ [2025-05-19T15:03:44.259Z] -J-Dtest.compiler.opts= \ [2025-05-19T15:03:44.259Z] -J-Dtest.java.opts= \ [2025-05-19T15:03:44.259Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T15:03:44.259Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T15:03:44.259Z] -J-Dtest.timeout.factor=8.0 \ [2025-05-19T15:03:44.259Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-19T15:03:44.259Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-19T15:03:44.259Z] -J-Dtest.name=java/util/zip/DeInflate.java \ [2025-05-19T15:03:44.259Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-19T15:03:44.259Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip/DeInflate.java \ [2025-05-19T15:03:44.259Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.260Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.260Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d \ [2025-05-19T15:03:44.260Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d \ [2025-05-19T15:03:44.260Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.260Z] -d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d \ [2025-05-19T15:03:44.260Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.260Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip/DeInflate.java [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] ACTION: main -- Error. "main" action timed out with a timeout of 960 seconds on agent 15 [2025-05-19T15:03:44.260Z] REASON: Assumed action based on file name: run main DeInflate [2025-05-19T15:03:44.260Z] TIME: 960.549 seconds [2025-05-19T15:03:44.260Z] messages: [2025-05-19T15:03:44.260Z] command: main DeInflate [2025-05-19T15:03:44.260Z] reason: Assumed action based on file name: run main DeInflate [2025-05-19T15:03:44.260Z] started: Mon May 19 14:47:30 GMT 2025 [2025-05-19T15:03:44.260Z] Mode: agentvm [2025-05-19T15:03:44.260Z] Agent id: 15 [2025-05-19T15:03:44.260Z] Process id: 12583404 [2025-05-19T15:03:44.260Z] Timeout signalled after 960 seconds [2025-05-19T15:03:44.260Z] Timeout information: [2025-05-19T15:03:44.260Z] Running jstack on process 12583404 [2025-05-19T15:03:44.260Z] 2025-05-19 15:03:31 [2025-05-19T15:03:44.260Z] Full thread dump OpenJDK 64-Bit Server VM (25-beta+23-ea mixed mode): [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] Threads class SMR info: [2025-05-19T15:03:44.260Z] _java_thread_list=0x00000001143a1060, length=13, elements={ [2025-05-19T15:03:44.260Z] 0x000000011025b2c0, 0x0000000112ec6040, 0x0000000112ec9940, 0x0000000112ecd820, [2025-05-19T15:03:44.260Z] 0x0000000112ecefe0, 0x0000000113766c80, 0x000000011398d080, 0x0000000113e0a660, [2025-05-19T15:03:44.260Z] 0x0000000114fd3e40, 0x0000000115d9ed20, 0x00000001160cc980, 0x0000000114c7fee0, [2025-05-19T15:03:44.260Z] 0x0000000114607ae0 [2025-05-19T15:03:44.260Z] } [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "main" #3 [258] prio=5 os_prio=57 cpu=353.77ms elapsed=1080.26s tid=0x000000011025b2c0 nid=258 in Object.wait() [0x000000011023c000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T15:03:44.260Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T15:03:44.260Z] - waiting on <no object reference available> [2025-05-19T15:03:44.260Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T15:03:44.260Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1860) [2025-05-19T15:03:44.260Z] - locked <0x00000000f1d01cb0> (a java.lang.Thread) [2025-05-19T15:03:44.260Z] at java.lang.Thread.join(java.base@25-beta/Thread.java:1936) [2025-05-19T15:03:44.260Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219) [2025-05-19T15:03:44.260Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:319) [2025-05-19T15:03:44.260Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:244) [2025-05-19T15:03:44.260Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Reference Handler" #11 [2314] daemon prio=10 os_prio=57 cpu=40.47ms elapsed=1080.20s tid=0x0000000112ec6040 nid=2314 waiting on condition [0x00000001130ec000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@25-beta/Native Method) [2025-05-19T15:03:44.260Z] at java.lang.ref.Reference.processPendingReferences(java.base@25-beta/Reference.java:246) [2025-05-19T15:03:44.260Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@25-beta/Reference.java:208) [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Finalizer" #12 [2571] daemon prio=8 os_prio=57 cpu=0.59ms elapsed=1080.20s tid=0x0000000112ec9940 nid=2571 in Object.wait() [0x000000011330c000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: WAITING (on object monitor) [2025-05-19T15:03:44.260Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T15:03:44.260Z] - waiting on <no object reference available> [2025-05-19T15:03:44.260Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T15:03:44.260Z] at java.lang.Object.wait(java.base@25-beta/Object.java:351) [2025-05-19T15:03:44.260Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:137) [2025-05-19T15:03:44.260Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:215) [2025-05-19T15:03:44.260Z] - locked <0x00000000900b23c8> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T15:03:44.260Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@25-beta/Finalizer.java:165) [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Signal Dispatcher" #13 [2828] daemon prio=9 os_prio=57 cpu=0.20ms elapsed=1080.20s tid=0x0000000112ecd820 nid=2828 waiting on condition [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Service Thread" #14 [3085] daemon prio=9 os_prio=57 cpu=28.73ms elapsed=1080.20s tid=0x0000000112ecefe0 nid=3085 runnable [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Monitor Deflation Thread" #15 [3342] daemon prio=9 os_prio=57 cpu=15.96ms elapsed=1080.20s tid=0x0000000113766c80 nid=3342 runnable [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "C2 CompilerThread0" #16 [3599] daemon prio=9 os_prio=57 cpu=2303.29ms elapsed=1080.20s tid=0x000000011398d080 nid=3599 waiting on condition [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] No compile task [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "C1 CompilerThread0" #24 [3856] daemon prio=9 os_prio=57 cpu=375.19ms elapsed=1080.20s tid=0x0000000113e0a660 nid=3856 waiting on condition [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] No compile task [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Common-Cleaner" #28 [4884] daemon prio=8 os_prio=57 cpu=46.86ms elapsed=1080.08s tid=0x0000000114fd3e40 nid=4884 in Object.wait() [0x000000011520c000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: TIMED_WAITING (on object monitor) [2025-05-19T15:03:44.260Z] at java.lang.Object.wait0(java.base@25-beta/Native Method) [2025-05-19T15:03:44.260Z] - waiting on <no object reference available> [2025-05-19T15:03:44.260Z] at java.lang.Object.wait(java.base@25-beta/Object.java:389) [2025-05-19T15:03:44.260Z] at java.lang.ref.ReferenceQueue.remove0(java.base@25-beta/ReferenceQueue.java:123) [2025-05-19T15:03:44.260Z] at java.lang.ref.ReferenceQueue.remove(java.base@25-beta/ReferenceQueue.java:201) [2025-05-19T15:03:44.260Z] - locked <0x00000000901c61a8> (a java.lang.ref.ReferenceQueue$Lock) [2025-05-19T15:03:44.260Z] at jdk.internal.ref.CleanerImpl.run(java.base@25-beta/CleanerImpl.java:146) [2025-05-19T15:03:44.260Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T15:03:44.260Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T15:03:44.260Z] at jdk.internal.misc.InnocuousThread.run(java.base@25-beta/InnocuousThread.java:148) [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Notification Thread" #29 [5398] daemon prio=9 os_prio=57 cpu=0.04ms elapsed=1079.99s tid=0x0000000115d9ed20 nid=5398 runnable [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "pool-1-thread-1" #30 [5143] daemon prio=5 os_prio=57 cpu=4.92ms elapsed=1079.74s tid=0x00000001160cc980 nid=5143 waiting on condition [0x00000001162dc000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: TIMED_WAITING (parking) [2025-05-19T15:03:44.260Z] at jdk.internal.misc.Unsafe.park(java.base@25-beta/Native Method) [2025-05-19T15:03:44.260Z] - parking to wait for <0x00000000902f4d00> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2025-05-19T15:03:44.260Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@25-beta/LockSupport.java:271) [2025-05-19T15:03:44.260Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@25-beta/AbstractQueuedSynchronizer.java:1802) [2025-05-19T15:03:44.260Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:1166) [2025-05-19T15:03:44.260Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@25-beta/ScheduledThreadPoolExecutor.java:883) [2025-05-19T15:03:44.260Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@25-beta/ThreadPoolExecutor.java:1016) [2025-05-19T15:03:44.260Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@25-beta/ThreadPoolExecutor.java:1076) [2025-05-19T15:03:44.260Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@25-beta/ThreadPoolExecutor.java:614) [2025-05-19T15:03:44.260Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T15:03:44.260Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "AgentVMThread" #937 [4335] prio=5 os_prio=57 cpu=565824.20ms elapsed=960.31s tid=0x0000000114c7fee0 nid=4335 runnable [0x0000000118e0c000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] at java.util.Arrays.fill(java.base@25-beta/Arrays.java:3283) [2025-05-19T15:03:44.260Z] at DeInflate.check(DeInflate.java:183) [2025-05-19T15:03:44.260Z] at DeInflate.main(DeInflate.java:319) [2025-05-19T15:03:44.260Z] at java.lang.invoke.LambdaForm$DMH/0x0000000450047c00.invokeStatic(java.base@25-beta/LambdaForm$DMH) [2025-05-19T15:03:44.260Z] at java.lang.invoke.LambdaForm$MH/0x000000045011a000.invoke(java.base@25-beta/LambdaForm$MH) [2025-05-19T15:03:44.260Z] at java.lang.invoke.LambdaForm$MH/0x000000045011a400.invokeExact_MT(java.base@25-beta/LambdaForm$MH) [2025-05-19T15:03:44.260Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@25-beta/DirectMethodHandleAccessor.java:155) [2025-05-19T15:03:44.260Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@25-beta/DirectMethodHandleAccessor.java:104) [2025-05-19T15:03:44.260Z] at java.lang.reflect.Method.invoke(java.base@25-beta/Method.java:565) [2025-05-19T15:03:44.260Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:335) [2025-05-19T15:03:44.260Z] at java.lang.Thread.runWith(java.base@25-beta/Thread.java:1460) [2025-05-19T15:03:44.260Z] at java.lang.Thread.run(java.base@25-beta/Thread.java:1447) [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "Attach Listener" #938 [8176] daemon prio=9 os_prio=57 cpu=0.24ms elapsed=0.11s tid=0x0000000114607ae0 nid=8176 waiting on condition [0x0000000000000000] [2025-05-19T15:03:44.260Z] java.lang.Thread.State: RUNNABLE [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "G1 Conc#2" os_prio=57 cpu=322.35ms elapsed=1045.15s tid=0x000000011470daa0 nid=9597 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "G1 Conc#1" os_prio=57 cpu=319.96ms elapsed=1045.15s tid=0x0000000114712780 nid=9340 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#12" os_prio=57 cpu=340.62ms elapsed=1070.48s tid=0x0000000114a19de0 nid=8775 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#11" os_prio=57 cpu=357.59ms elapsed=1073.91s tid=0x00000001144b4d00 nid=7729 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#10" os_prio=57 cpu=395.87ms elapsed=1073.92s tid=0x0000000114358980 nid=7472 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#9" os_prio=57 cpu=379.34ms elapsed=1073.92s tid=0x0000000114355b00 nid=7215 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#8" os_prio=57 cpu=356.36ms elapsed=1073.92s tid=0x0000000114352c80 nid=6958 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#7" os_prio=57 cpu=369.58ms elapsed=1073.92s tid=0x0000000114350240 nid=6701 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#6" os_prio=57 cpu=342.78ms elapsed=1073.92s tid=0x000000011434d800 nid=6444 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#5" os_prio=57 cpu=383.25ms elapsed=1073.92s tid=0x000000011434adc0 nid=6187 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#4" os_prio=57 cpu=348.87ms elapsed=1073.92s tid=0x0000000114348380 nid=5930 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#3" os_prio=57 cpu=404.46ms elapsed=1073.92s tid=0x0000000114345940 nid=5673 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#2" os_prio=57 cpu=375.51ms elapsed=1073.92s tid=0x0000000114342f00 nid=4648 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#1" os_prio=57 cpu=345.18ms elapsed=1073.92s tid=0x00000001143405e0 nid=4391 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "VM Thread" os_prio=57 cpu=182.82ms elapsed=1080.23s tid=0x0000000112c47cc0 nid=2057 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "VM Periodic Task Thread" os_prio=57 cpu=72.37ms elapsed=1080.25s tid=0x00000001129c8880 nid=1800 waiting on condition [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "G1 Service" os_prio=57 cpu=43.29ms elapsed=1080.25s tid=0x0000000112667560 nid=1543 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "G1 Refine#0" os_prio=57 cpu=849.61ms elapsed=1080.25s tid=0x0000000112430ba0 nid=1286 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "G1 Conc#0" os_prio=57 cpu=299.31ms elapsed=1080.25s tid=0x000000011142cb20 nid=1029 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "G1 Main Marker" os_prio=57 cpu=4.53ms elapsed=1080.25s tid=0x00000001111f62c0 nid=772 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] "GC Thread#0" os_prio=57 cpu=372.60ms elapsed=1080.25s tid=0x0000000110fac7a0 nid=515 runnable [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] JNI global refs: 25, weak refs: 0 [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] --- Timeout information end. [2025-05-19T15:03:44.260Z] finished: Mon May 19 15:03:31 GMT 2025 [2025-05-19T15:03:44.260Z] elapsed time (seconds): 960.549 [2025-05-19T15:03:44.260Z] configuration: [2025-05-19T15:03:44.260Z] Boot Layer [2025-05-19T15:03:44.260Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.11.0.jar [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-05-19T15:03:44.260Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/patches/java.base [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] Test Layer [2025-05-19T15:03:44.260Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip [2025-05-19T15:03:44.260Z] [2025-05-19T15:03:44.260Z] rerun: [2025-05-19T15:03:44.260Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/scratch && \ [2025-05-19T15:03:44.260Z] DISPLAY=unix:0 \ [2025-05-19T15:03:44.260Z] HOME=/home/jenkins \ [2025-05-19T15:03:44.260Z] LANG=C \ [2025-05-19T15:03:44.260Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-05-19T15:03:44.260Z] TZ=UTC0 \ [2025-05-19T15:03:44.260Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image/bin/java \ [2025-05-19T15:03:44.260Z] -Dtest.vm.opts='-ea -esa -Xmx1540m -XX:+UseCompressedOops' \ [2025-05-19T15:03:44.260Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx1540m -J-XX:+UseCompressedOops' \ [2025-05-19T15:03:44.260Z] -Dtest.compiler.opts= \ [2025-05-19T15:03:44.260Z] -Dtest.java.opts= \ [2025-05-19T15:03:44.260Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T15:03:44.260Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/j2sdk-image \ [2025-05-19T15:03:44.260Z] -Dtest.timeout.factor=8.0 \ [2025-05-19T15:03:44.260Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-05-19T15:03:44.260Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-05-19T15:03:44.260Z] -Dtest.name=java/util/zip/DeInflate.java \ [2025-05-19T15:03:44.260Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \ [2025-05-19T15:03:44.260Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip/DeInflate.java \ [2025-05-19T15:03:44.261Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.261Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.261Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d \ [2025-05-19T15:03:44.261Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d \ [2025-05-19T15:03:44.261Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip \ [2025-05-19T15:03:44.261Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work/classes/java/util/zip/DeInflate.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/util/zip:/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-19T15:03:44.261Z] DeInflate [2025-05-19T15:03:44.261Z] STDOUT: [2025-05-19T15:03:44.261Z] level:-1, strategy: 0, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 102128 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 484994 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 85607 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 335279 [2025-05-19T15:03:44.261Z] level:-1, strategy: 0, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 230175 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 148281 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 60776 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 498330 [2025-05-19T15:03:44.261Z] level:-1, strategy: 1, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 324143 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 173552 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 99217 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 439767 [2025-05-19T15:03:44.261Z] level:-1, strategy: 1, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 459905 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 276602 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 106720 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 176125 [2025-05-19T15:03:44.261Z] level:-1, strategy: 2, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 40681 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 505535 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 58255 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 164682 [2025-05-19T15:03:44.261Z] level:-1, strategy: 2, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 117075 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 389706 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 203048 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 358083 [2025-05-19T15:03:44.261Z] level:0, strategy: 0, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 138542 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 192968 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 241243 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 19470 [2025-05-19T15:03:44.261Z] level:0, strategy: 0, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 2666 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 427032 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 325892 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 362604 [2025-05-19T15:03:44.261Z] level:0, strategy: 1, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 99369 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 23046 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 439622 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 458470 [2025-05-19T15:03:44.261Z] level:0, strategy: 1, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 306270 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 342849 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 495107 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 191113 [2025-05-19T15:03:44.261Z] level:0, strategy: 2, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 149731 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 349692 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 19028 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 447553 [2025-05-19T15:03:44.261Z] level:0, strategy: 2, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 128266 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 62289 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 511313 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 347955 [2025-05-19T15:03:44.261Z] level:1, strategy: 0, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 96140 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 483395 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 398290 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 162278 [2025-05-19T15:03:44.261Z] level:1, strategy: 0, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 387074 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 442617 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 215910 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 465361 [2025-05-19T15:03:44.261Z] level:1, strategy: 1, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 207121 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 341025 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 338363 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 486937 [2025-05-19T15:03:44.261Z] level:1, strategy: 1, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 278136 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 98955 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 304812 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 372672 [2025-05-19T15:03:44.261Z] level:1, strategy: 2, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 248326 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 45635 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 21452 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 80471 [2025-05-19T15:03:44.261Z] level:1, strategy: 2, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 394483 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 111655 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 139558 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 294877 [2025-05-19T15:03:44.261Z] level:2, strategy: 0, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 167664 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 53590 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 515750 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 430448 [2025-05-19T15:03:44.261Z] level:2, strategy: 0, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 222846 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 339885 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 438536 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 364622 [2025-05-19T15:03:44.261Z] level:2, strategy: 1, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 92098 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 143639 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 81827 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 236145 [2025-05-19T15:03:44.261Z] level:2, strategy: 1, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 513734 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 152252 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 55181 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 333183 [2025-05-19T15:03:44.261Z] level:2, strategy: 2, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 100541 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 424592 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 73384 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 482343 [2025-05-19T15:03:44.261Z] level:2, strategy: 2, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 35381 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 130183 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 82055 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 51309 [2025-05-19T15:03:44.261Z] level:3, strategy: 0, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 466920 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 431553 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 81234 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 391393 [2025-05-19T15:03:44.261Z] level:3, strategy: 0, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 438849 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 486631 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 44410 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 184036 [2025-05-19T15:03:44.261Z] level:3, strategy: 1, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 358121 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 235977 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 287873 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 304753 [2025-05-19T15:03:44.261Z] level:3, strategy: 1, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 84540 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 439451 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 1718 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 395377 [2025-05-19T15:03:44.261Z] level:3, strategy: 2, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 395702 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 316601 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 76146 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 231534 [2025-05-19T15:03:44.261Z] level:3, strategy: 2, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 203606 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 316339 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 134064 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 273217 [2025-05-19T15:03:44.261Z] level:4, strategy: 0, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 370646 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 422010 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 207978 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 285531 [2025-05-19T15:03:44.261Z] level:4, strategy: 0, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 97163 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 487310 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 35189 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 417296 [2025-05-19T15:03:44.261Z] level:4, strategy: 1, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 489692 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 351045 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 227148 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 404741 [2025-05-19T15:03:44.261Z] level:4, strategy: 1, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 104484 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 409550 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 42107 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 39701 [2025-05-19T15:03:44.261Z] level:4, strategy: 2, dowrap: false [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 504982 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 138726 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 300153 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 18914 [2025-05-19T15:03:44.261Z] level:4, strategy: 2, dowrap: true [2025-05-19T15:03:44.261Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.261Z] iteration: 2 input length: 277784 [2025-05-19T15:03:44.261Z] iteration: 3 input length: 299310 [2025-05-19T15:03:44.261Z] iteration: 4 input length: 441773 [2025-05-19T15:03:44.261Z] iteration: 5 input length: 224503 [2025-05-19T15:03:44.262Z] level:5, strategy: 0, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 376603 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 232291 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 1390 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 159315 [2025-05-19T15:03:44.262Z] level:5, strategy: 0, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 339370 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 67490 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 411466 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 23171 [2025-05-19T15:03:44.262Z] level:5, strategy: 1, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 454203 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 72184 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 467396 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 201801 [2025-05-19T15:03:44.262Z] level:5, strategy: 1, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 116267 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 62152 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 118492 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 263148 [2025-05-19T15:03:44.262Z] level:5, strategy: 2, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 334165 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 93286 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 60802 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 359996 [2025-05-19T15:03:44.262Z] level:5, strategy: 2, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 487025 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 391814 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 311274 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 469853 [2025-05-19T15:03:44.262Z] level:6, strategy: 0, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 88872 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 408198 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 437027 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 120307 [2025-05-19T15:03:44.262Z] level:6, strategy: 0, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 8731 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 440738 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 384709 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 29721 [2025-05-19T15:03:44.262Z] level:6, strategy: 1, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 37191 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 366348 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 47879 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 279024 [2025-05-19T15:03:44.262Z] level:6, strategy: 1, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 161394 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 157017 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 449031 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 306074 [2025-05-19T15:03:44.262Z] level:6, strategy: 2, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 319473 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 175439 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 339918 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 308206 [2025-05-19T15:03:44.262Z] level:6, strategy: 2, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 458433 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 508178 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 244551 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 264122 [2025-05-19T15:03:44.262Z] level:7, strategy: 0, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 495878 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 111506 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 105377 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 416365 [2025-05-19T15:03:44.262Z] level:7, strategy: 0, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 130048 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 410160 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 302451 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 290277 [2025-05-19T15:03:44.262Z] level:7, strategy: 1, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 175141 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 484338 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 365479 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 464995 [2025-05-19T15:03:44.262Z] level:7, strategy: 1, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 290719 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 25529 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 497871 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 417124 [2025-05-19T15:03:44.262Z] level:7, strategy: 2, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 376724 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 421538 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 171860 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 103329 [2025-05-19T15:03:44.262Z] level:7, strategy: 2, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 484646 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 450773 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 131640 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 315487 [2025-05-19T15:03:44.262Z] level:8, strategy: 0, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 35347 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 457865 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 337692 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 501082 [2025-05-19T15:03:44.262Z] level:8, strategy: 0, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 390514 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 143271 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 174156 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 68838 [2025-05-19T15:03:44.262Z] level:8, strategy: 1, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 163656 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 196354 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 254054 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 390040 [2025-05-19T15:03:44.262Z] level:8, strategy: 1, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 151645 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 68300 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 325004 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 93193 [2025-05-19T15:03:44.262Z] level:8, strategy: 2, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 470618 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 104364 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 519202 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 320009 [2025-05-19T15:03:44.262Z] level:8, strategy: 2, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 107128 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 478256 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 470529 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 211085 [2025-05-19T15:03:44.262Z] level:9, strategy: 0, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 165003 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 125311 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 280071 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 198094 [2025-05-19T15:03:44.262Z] level:9, strategy: 0, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 212628 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 225413 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 297703 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 69953 [2025-05-19T15:03:44.262Z] level:9, strategy: 1, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 21303 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 10613 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 516162 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 477719 [2025-05-19T15:03:44.262Z] level:9, strategy: 1, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 394540 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 100562 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 114327 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 51199 [2025-05-19T15:03:44.262Z] level:9, strategy: 2, dowrap: false [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 487445 [2025-05-19T15:03:44.262Z] iteration: 3 input length: 315876 [2025-05-19T15:03:44.262Z] iteration: 4 input length: 10983 [2025-05-19T15:03:44.262Z] iteration: 5 input length: 432377 [2025-05-19T15:03:44.262Z] level:9, strategy: 2, dowrap: true [2025-05-19T15:03:44.262Z] iteration: 1 input length: 524288 [2025-05-19T15:03:44.262Z] iteration: 2 input length: 417567 [2025-05-19T15:03:44.262Z] [2025-05-19T15:03:44.262Z] TEST RESULT: Error. "main" action timed out with a timeout of 960 seconds on agent 15 [2025-05-19T15:03:44.262Z] -------------------------------------------------- [2025-05-19T15:05:48.726Z] Test results: passed: 987; error: 2; did not match keywords: 8; did not meet platform requirements: 3 [2025-05-19T15:05:50.348Z] Report written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/report/html/report.html [2025-05-19T15:05:50.348Z] Results written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_ppc64_aix/aqa-tests/TKG/output_17476337074843/jdk_util_0/work [2025-05-19T15:05:50.348Z] Error: Some tests failed or other problems occurred. [2025-05-19T15:05:50.348Z] ----------------------------------- [2025-05-19T15:05:50.348Z] jdk_util_0_FAILED [2025-05-19T15:05:50.348Z] ----------------------------------- [2025-05-19T15:05:50.348Z] [2025-05-19T15:05:50.348Z] TEST TEARDOWN: [2025-05-19T15:05:50.348Z] Nothing to be done for teardown. [2025-05-19T15:05:50.348Z] jdk_util_0 Finish Time: Mon May 19 15:05:49 2025 Epoch Time (ms): 1747667149686