No Possible Issues Found via Git Search
jdk_foreign_0
[2026-02-13T04:02:05.168Z] Running test jdk_foreign_0 ...
[2026-02-13T04:02:05.168Z] ===============================================
[2026-02-13T04:02:05.168Z] jdk_foreign_0 Start Time: Fri Feb 13 04:02:04 2026 Epoch Time (ms): 1770955324414
[2026-02-13T04:02:05.168Z] variation: Mode150
[2026-02-13T04:02:05.168Z] JVM_OPTIONS: -XX:+UseCompressedOops
[2026-02-13T04:02:05.168Z] { \
[2026-02-13T04:02:05.168Z] echo ""; echo "TEST SETUP:"; \
[2026-02-13T04:02:05.168Z] echo "Nothing to be done for setup."; \
[2026-02-13T04:02:05.168Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/jdk_foreign_0"; \
[2026-02-13T04:02:05.168Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/jdk_foreign_0"; \
[2026-02-13T04:02:05.168Z] echo ""; echo "TESTING:"; \
[2026-02-13T04:02:05.168Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \
[2026-02-13T04:02:05.168Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -k:'!headful' -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true" \
[2026-02-13T04:02:05.168Z] \
[2026-02-13T04:02:05.168Z] -w ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/jdk_foreign_0"/work" \
[2026-02-13T04:02:05.168Z] -r ""/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/jdk_foreign_0"/report" \
[2026-02-13T04:02:05.168Z] -jdk:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image" \
[2026-02-13T04:02:05.168Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \
[2026-02-13T04:02:05.168Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk25.txt" \
[2026-02-13T04:02:05.168Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/excludes/alpine/ProblemList_openjdk25.txt" \
[2026-02-13T04:02:05.168Z] -exclude:"/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk25.txt" \
[2026-02-13T04:02:05.168Z] "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_foreign"; \
[2026-02-13T04:02:05.168Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_foreign_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_foreign_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-13T04:02:05.168Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-13T04:02:05.168Z] echo "Nothing to be done for teardown."; \
[2026-02-13T04:02:05.168Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/TestTargetResult";
[2026-02-13T04:02:05.168Z]
[2026-02-13T04:02:05.168Z] TEST SETUP:
[2026-02-13T04:02:05.168Z] Nothing to be done for setup.
[2026-02-13T04:02:05.168Z]
[2026-02-13T04:02:05.168Z] TESTING:
[2026-02-13T04:02:06.137Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/jdk_foreign_0/work" not found: creating
[2026-02-13T04:02:06.137Z] Directory "/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17709301682181/jdk_foreign_0/report" not found: creating
[2026-02-13T04:02:22.333Z] XML output with verification to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work
[2026-02-13T04:06:58.058Z] test-docker-alpine320-armv8-2 seems to be removed or offline (java.lang.InterruptedException); will wait for 5 min 0 sec for it to come back online
[2026-02-13T04:06:58.358Z] test-docker-alpine320-armv8-2 is back online
[2026-02-13T04:07:18.360Z] test-docker-alpine320-armv8-2 seems to be removed or offline (java.lang.InterruptedException); will wait for 5 min 0 sec for it to come back online
[2026-02-13T04:07:18.660Z] test-docker-alpine320-armv8-2 is back online
[2026-02-13T04:07:38.661Z] test-docker-alpine320-armv8-2 seems to be removed or offline (java.lang.InterruptedException); will wait for 5 min 0 sec for it to come back online
[2026-02-13T04:07:38.962Z] test-docker-alpine320-armv8-2 is back online
[2026-02-13T04:07:44.302Z] --------------------------------------------------
[2026-02-13T04:07:44.302Z] TEST: java/foreign/TestHandshake.java
[2026-02-13T04:07:44.302Z] TEST JDK: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image
[2026-02-13T04:07:44.302Z]
[2026-02-13T04:07:44.302Z] ACTION: build -- Passed. Build successful
[2026-02-13T04:07:44.302Z] REASON: Named class compiled on demand
[2026-02-13T04:07:44.302Z] TIME: 1.4 seconds
[2026-02-13T04:07:44.302Z] messages:
[2026-02-13T04:07:44.302Z] command: build TestHandshake
[2026-02-13T04:07:44.302Z] reason: Named class compiled on demand
[2026-02-13T04:07:44.302Z] started: Fri Feb 13 04:06:05 GMT 2026
[2026-02-13T04:07:44.302Z] Test directory:
[2026-02-13T04:07:44.302Z] compile: TestHandshake
[2026-02-13T04:07:44.302Z] finished: Fri Feb 13 04:06:07 GMT 2026
[2026-02-13T04:07:44.302Z] elapsed time (seconds): 1.4
[2026-02-13T04:07:44.302Z]
[2026-02-13T04:07:44.302Z] ACTION: compile -- Passed. Compilation successful
[2026-02-13T04:07:44.302Z] REASON: .class file out of date or does not exist
[2026-02-13T04:07:44.302Z] TIME: 1.39 seconds
[2026-02-13T04:07:44.302Z] messages:
[2026-02-13T04:07:44.302Z] command: compile /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign/TestHandshake.java
[2026-02-13T04:07:44.302Z] reason: .class file out of date or does not exist
[2026-02-13T04:07:44.302Z] started: Fri Feb 13 04:06:05 GMT 2026
[2026-02-13T04:07:44.302Z] Additional options from @modules: --add-modules java.base --add-exports java.base/jdk.internal.vm.annotation=ALL-UNNAMED --add-exports java.base/jdk.internal.misc=ALL-UNNAMED
[2026-02-13T04:07:44.302Z] Mode: agentvm
[2026-02-13T04:07:44.302Z] Agent id: 2
[2026-02-13T04:07:44.302Z] Process id: 816170
[2026-02-13T04:07:44.302Z] finished: Fri Feb 13 04:06:07 GMT 2026
[2026-02-13T04:07:44.302Z] elapsed time (seconds): 1.39
[2026-02-13T04:07:44.302Z] configuration:
[2026-02-13T04:07:44.302Z] Boot Layer (javac runtime environment)
[2026-02-13T04:07:44.302Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar
[2026-02-13T04:07:44.302Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar
[2026-02-13T04:07:44.302Z] patch: java.base /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/patches/java.base
[2026-02-13T04:07:44.302Z]
[2026-02-13T04:07:44.302Z] javac compilation environment
[2026-02-13T04:07:44.302Z] add modules: java.base
[2026-02-13T04:07:44.302Z] add exports: java.base/jdk.internal.misc ALL-UNNAMED
[2026-02-13T04:07:44.302Z] java.base/jdk.internal.vm.annotation ALL-UNNAMED
[2026-02-13T04:07:44.302Z] source path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign
[2026-02-13T04:07:44.302Z] class path: /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign
[2026-02-13T04:07:44.302Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d
[2026-02-13T04:07:44.302Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar
[2026-02-13T04:07:44.302Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar
[2026-02-13T04:07:44.302Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar
[2026-02-13T04:07:44.302Z]
[2026-02-13T04:07:44.302Z] rerun:
[2026-02-13T04:07:44.302Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/scratch/0 && \
[2026-02-13T04:07:44.302Z] DISPLAY=:0 \
[2026-02-13T04:07:44.302Z] HOME=/home/jenkins \
[2026-02-13T04:07:44.302Z] PATH=/bin:/usr/bin:/usr/sbin \
[2026-02-13T04:07:44.302Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/javac \
[2026-02-13T04:07:44.302Z] -J-ea \
[2026-02-13T04:07:44.302Z] -J-esa \
[2026-02-13T04:07:44.302Z] -J-Xmx512m \
[2026-02-13T04:07:44.302Z] -J-XX:+UseCompressedOops \
[2026-02-13T04:07:44.302Z] -J-Djava.awt.headless=true \
[2026-02-13T04:07:44.302Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \
[2026-02-13T04:07:44.302Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \
[2026-02-13T04:07:44.302Z] -J-Dtest.compiler.opts= \
[2026-02-13T04:07:44.302Z] -J-Dtest.java.opts= \
[2026-02-13T04:07:44.302Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \
[2026-02-13T04:07:44.302Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \
[2026-02-13T04:07:44.302Z] -J-Dtest.timeout.factor=8.0 \
[2026-02-13T04:07:44.302Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \
[2026-02-13T04:07:44.302Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \
[2026-02-13T04:07:44.302Z] -J-Dtest.name=java/foreign/TestHandshake.java \
[2026-02-13T04:07:44.302Z] -J-Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \
[2026-02-13T04:07:44.302Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign/TestHandshake.java \
[2026-02-13T04:07:44.302Z] -J-Dtest.main.class=TestHandshake \
[2026-02-13T04:07:44.302Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.302Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.302Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.302Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.302Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.302Z] -J-Dtest.modules='java.base/jdk.internal.vm.annotation java.base/jdk.internal.misc' \
[2026-02-13T04:07:44.302Z] --add-modules java.base \
[2026-02-13T04:07:44.302Z] --add-exports java.base/jdk.internal.vm.annotation=ALL-UNNAMED \
[2026-02-13T04:07:44.302Z] --add-exports java.base/jdk.internal.misc=ALL-UNNAMED \
[2026-02-13T04:07:44.302Z] -d /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.302Z] -sourcepath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.302Z] -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign/TestHandshake.java
[2026-02-13T04:07:44.303Z]
[2026-02-13T04:07:44.303Z] ACTION: testng -- Passed. Execution successful
[2026-02-13T04:07:44.303Z] REASON: User specified action: run testng/othervm TestHandshake
[2026-02-13T04:07:44.303Z] TIME: 12.805 seconds
[2026-02-13T04:07:44.303Z] messages:
[2026-02-13T04:07:44.303Z] command: testng TestHandshake
[2026-02-13T04:07:44.303Z] reason: User specified action: run testng/othervm TestHandshake
[2026-02-13T04:07:44.303Z] started: Fri Feb 13 04:06:07 GMT 2026
[2026-02-13T04:07:44.303Z] Mode: othervm [/othervm specified]
[2026-02-13T04:07:44.303Z] Additional options from @modules: --add-modules java.base --add-exports java.base/jdk.internal.vm.annotation=ALL-UNNAMED --add-exports java.base/jdk.internal.misc=ALL-UNNAMED
[2026-02-13T04:07:44.303Z] Process id: 818282
[2026-02-13T04:07:44.303Z] finished: Fri Feb 13 04:06:19 GMT 2026
[2026-02-13T04:07:44.303Z] elapsed time (seconds): 12.805
[2026-02-13T04:07:44.303Z] configuration:
[2026-02-13T04:07:44.303Z] Boot Layer
[2026-02-13T04:07:44.303Z] add modules: java.base
[2026-02-13T04:07:44.303Z] add exports: java.base/jdk.internal.misc ALL-UNNAMED
[2026-02-13T04:07:44.303Z] java.base/jdk.internal.vm.annotation ALL-UNNAMED
[2026-02-13T04:07:44.303Z]
[2026-02-13T04:07:44.303Z] STDOUT:
[2026-02-13T04:07:44.303Z] ITERATION 0
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 447 millis
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #1 ; elapsed (ms): 9
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 670
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 683
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 686
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 677
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 679
[2026-02-13T04:07:44.303Z] ITERATION 1
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 21 millis
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #2 ; elapsed (ms): 7
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 33
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 36
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 37
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 37
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 37
[2026-02-13T04:07:44.303Z] ITERATION 2
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 15
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 142 millis
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 442
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 442
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 443
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 445
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 442
[2026-02-13T04:07:44.303Z] ITERATION 3
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 8
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 216 millis
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 233
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 234
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 234
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 237
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 237
[2026-02-13T04:07:44.303Z] ITERATION 4
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 283 millis
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 298
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 300
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 301
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 308
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 310
[2026-02-13T04:07:44.303Z] test TestHandshake.testHandshake("SegmentAccessor", TestHandshake$$Lambda/0x0000001801071e70@9a3ce37): success [1967ms]
[2026-02-13T04:07:44.303Z] ITERATION 0
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 263 millis
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 289
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 290
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 289
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 290
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 293
[2026-02-13T04:07:44.303Z] ITERATION 1
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 233 millis
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 246
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 246
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 246
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 246
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 247
[2026-02-13T04:07:44.303Z] ITERATION 2
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 14 millis
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 31
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 31
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 34
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 31
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 36
[2026-02-13T04:07:44.303Z] ITERATION 3
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 228 millis
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 253
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 253
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 254
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 256
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 258
[2026-02-13T04:07:44.303Z] ITERATION 4
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 346 millis
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 368
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 369
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 372
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 375
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 376
[2026-02-13T04:07:44.303Z] test TestHandshake.testHandshake("SegmentCopyAccessor", TestHandshake$$Lambda/0x0000001801072098@48d81eaf): success [1238ms]
[2026-02-13T04:07:44.303Z] ITERATION 0
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 5
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 430 millis
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 453
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 454
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 458
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 459
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 463
[2026-02-13T04:07:44.303Z] ITERATION 1
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 8
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 194 millis
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 211
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 212
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 212
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 220
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 221
[2026-02-13T04:07:44.303Z] ITERATION 2
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 311 millis
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 678
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 680
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 680
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 682
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 678
[2026-02-13T04:07:44.303Z] ITERATION 3
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 5
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 265 millis
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 301
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 301
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 302
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 309
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 311
[2026-02-13T04:07:44.303Z] ITERATION 4
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 440 millis
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 460
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 461
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 461
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 466
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 467
[2026-02-13T04:07:44.303Z] test TestHandshake.testHandshake("SegmentSwappyCopyAccessor", TestHandshake$$Lambda/0x00000018010722c0@542aadc2): success [2177ms]
[2026-02-13T04:07:44.303Z] ITERATION 0
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 6
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 124 millis
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 182
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 182
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 185
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 187
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 192
[2026-02-13T04:07:44.303Z] ITERATION 1
[2026-02-13T04:07:44.303Z] Started first thread: Accessor #0 ; elapsed (ms): 16
[2026-02-13T04:07:44.303Z] Starting handshaker with delay set to 201 millis
[2026-02-13T04:07:44.303Z] Accessor #2 terminated - elapsed (ms): 267
[2026-02-13T04:07:44.303Z] Accessor #1 terminated - elapsed (ms): 268
[2026-02-13T04:07:44.303Z] Accessor #3 terminated - elapsed (ms): 270
[2026-02-13T04:07:44.303Z] Accessor #0 terminated - elapsed (ms): 275
[2026-02-13T04:07:44.303Z] Segment closed - elapsed (ms): 276
[2026-02-13T04:07:44.303Z] ITERATION 2
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 14
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 9 millis
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 73
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 73
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 73
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 91
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 93
[2026-02-13T04:07:44.304Z] ITERATION 3
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 7
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 194 millis
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 229
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 231
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 233
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 234
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 237
[2026-02-13T04:07:44.304Z] ITERATION 4
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 10
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 202 millis
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 243
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 243
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 243
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 246
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 254
[2026-02-13T04:07:44.304Z] test TestHandshake.testHandshake("SegmentMismatchAccessor", TestHandshake$$Lambda/0x00000018010724e8@50859b86): success [1079ms]
[2026-02-13T04:07:44.304Z] ITERATION 0
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 8
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 316 millis
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 356
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 356
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 358
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 361
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 362
[2026-02-13T04:07:44.304Z] ITERATION 1
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 41 millis
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 67
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 67
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 69
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 69
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 69
[2026-02-13T04:07:44.304Z] ITERATION 2
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 37 millis
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 60
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 63
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 64
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 60
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 62
[2026-02-13T04:07:44.304Z] ITERATION 3
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 347 millis
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 366
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 366
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 367
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 367
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 368
[2026-02-13T04:07:44.304Z] ITERATION 4
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 4
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 283 millis
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 614
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 614
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 614
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 614
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 616
[2026-02-13T04:07:44.304Z] test TestHandshake.testHandshake("SegmentFillAccessor", TestHandshake$$Lambda/0x0000001801072710@2a04e34a): success [1518ms]
[2026-02-13T04:07:44.304Z] ITERATION 0
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 6
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 48 millis
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 65
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 65
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 66
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 77
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 78
[2026-02-13T04:07:44.304Z] ITERATION 1
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 309 millis
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 332
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 332
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 332
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 334
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 336
[2026-02-13T04:07:44.304Z] ITERATION 2
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 7
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 78 millis
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 98
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 98
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 99
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 99
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 100
[2026-02-13T04:07:44.304Z] ITERATION 3
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 39 millis
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 50
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 50
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 52
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 52
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 53
[2026-02-13T04:07:44.304Z] ITERATION 4
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 0
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 235 millis
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 251
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 252
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 253
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 255
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 255
[2026-02-13T04:07:44.304Z] test TestHandshake.testHandshake("BufferAccessor", TestHandshake$$Lambda/0x0000001801072938@78c8f2c6): success [840ms]
[2026-02-13T04:07:44.304Z] ITERATION 0
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 7
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 13 millis
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 33
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 33
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 36
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 37
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 41
[2026-02-13T04:07:44.304Z] ITERATION 1
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 6
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 210 millis
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 227
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 229
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 229
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 231
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 236
[2026-02-13T04:07:44.304Z] ITERATION 2
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 5
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 494 millis
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 513
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 514
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 514
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 514
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 516
[2026-02-13T04:07:44.304Z] ITERATION 3
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 0
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 302 millis
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 326
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 328
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 332
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 333
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 342
[2026-02-13T04:07:44.304Z] ITERATION 4
[2026-02-13T04:07:44.304Z] Started first thread: Accessor #0 ; elapsed (ms): 7
[2026-02-13T04:07:44.304Z] Starting handshaker with delay set to 498 millis
[2026-02-13T04:07:44.304Z] Accessor #2 terminated - elapsed (ms): 534
[2026-02-13T04:07:44.304Z] Accessor #3 terminated - elapsed (ms): 534
[2026-02-13T04:07:44.304Z] Accessor #0 terminated - elapsed (ms): 538
[2026-02-13T04:07:44.304Z] Accessor #1 terminated - elapsed (ms): 538
[2026-02-13T04:07:44.304Z] Segment closed - elapsed (ms): 539
[2026-02-13T04:07:44.304Z] test TestHandshake.testHandshake("BufferHandleAccessor", TestHandshake$$Lambda/0x0000001801072b60@26411452): success [1698ms]
[2026-02-13T04:07:44.304Z]
[2026-02-13T04:07:44.304Z] ===============================================
[2026-02-13T04:07:44.304Z] java/foreign/TestHandshake.java
[2026-02-13T04:07:44.304Z] Total tests run: 7, Passes: 7, Failures: 0, Skips: 0
[2026-02-13T04:07:44.304Z] ===============================================
[2026-02-13T04:07:44.304Z]
[2026-02-13T04:07:44.304Z] STDERR:
[2026-02-13T04:07:44.304Z] STATUS:Passed.
[2026-02-13T04:07:44.304Z] rerun:
[2026-02-13T04:07:44.304Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/scratch/0 && \
[2026-02-13T04:07:44.304Z] DISPLAY=:0 \
[2026-02-13T04:07:44.304Z] HOME=/home/jenkins \
[2026-02-13T04:07:44.304Z] PATH=/bin:/usr/bin:/usr/sbin \
[2026-02-13T04:07:44.305Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar \
[2026-02-13T04:07:44.305Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/java \
[2026-02-13T04:07:44.305Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \
[2026-02-13T04:07:44.305Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \
[2026-02-13T04:07:44.305Z] -Dtest.compiler.opts= \
[2026-02-13T04:07:44.305Z] -Dtest.java.opts= \
[2026-02-13T04:07:44.305Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \
[2026-02-13T04:07:44.305Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \
[2026-02-13T04:07:44.305Z] -Dtest.timeout.factor=8.0 \
[2026-02-13T04:07:44.305Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \
[2026-02-13T04:07:44.305Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \
[2026-02-13T04:07:44.305Z] -Dtest.name=java/foreign/TestHandshake.java \
[2026-02-13T04:07:44.305Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \
[2026-02-13T04:07:44.305Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign/TestHandshake.java \
[2026-02-13T04:07:44.305Z] -Dtest.main.class=TestHandshake \
[2026-02-13T04:07:44.305Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.305Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.305Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.305Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.305Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.305Z] -Dtest.modules='java.base/jdk.internal.vm.annotation java.base/jdk.internal.misc' \
[2026-02-13T04:07:44.305Z] --add-modules java.base \
[2026-02-13T04:07:44.305Z] --add-exports java.base/jdk.internal.vm.annotation=ALL-UNNAMED \
[2026-02-13T04:07:44.305Z] --add-exports java.base/jdk.internal.misc=ALL-UNNAMED \
[2026-02-13T04:07:44.305Z] -ea \
[2026-02-13T04:07:44.305Z] -esa \
[2026-02-13T04:07:44.305Z] -Xmx512m \
[2026-02-13T04:07:44.305Z] -XX:+UseCompressedOops \
[2026-02-13T04:07:44.305Z] -Djava.awt.headless=true \
[2026-02-13T04:07:44.305Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \
[2026-02-13T04:07:44.305Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/java/foreign/TestHandshake.d/testng.0.jta java/foreign/TestHandshake.java false TestHandshake
[2026-02-13T04:07:44.305Z]
[2026-02-13T04:07:44.305Z] ACTION: build -- Passed. All files up to date
[2026-02-13T04:07:44.305Z] REASON: Named class compiled on demand
[2026-02-13T04:07:44.305Z] TIME: 0.001 seconds
[2026-02-13T04:07:44.305Z] messages:
[2026-02-13T04:07:44.305Z] command: build TestHandshake
[2026-02-13T04:07:44.305Z] reason: Named class compiled on demand
[2026-02-13T04:07:44.305Z] started: Fri Feb 13 04:06:19 GMT 2026
[2026-02-13T04:07:44.305Z] finished: Fri Feb 13 04:06:19 GMT 2026
[2026-02-13T04:07:44.305Z] elapsed time (seconds): 0.001
[2026-02-13T04:07:44.305Z]
[2026-02-13T04:07:44.305Z] ACTION: testng -- Failed. Execution failed: `main' threw exception: java.lang.Exception: config failures: 0, test failures: 1
[2026-02-13T04:07:44.305Z] REASON: User specified action: run testng/othervm -Xint TestHandshake
[2026-02-13T04:07:44.305Z] TIME: 82.932 seconds
[2026-02-13T04:07:44.305Z] messages:
[2026-02-13T04:07:44.305Z] command: testng -Xint TestHandshake
[2026-02-13T04:07:44.305Z] reason: User specified action: run testng/othervm -Xint TestHandshake
[2026-02-13T04:07:44.305Z] started: Fri Feb 13 04:06:19 GMT 2026
[2026-02-13T04:07:44.305Z] Mode: othervm [/othervm specified]
[2026-02-13T04:07:44.305Z] Additional options from @modules: --add-modules java.base --add-exports java.base/jdk.internal.vm.annotation=ALL-UNNAMED --add-exports java.base/jdk.internal.misc=ALL-UNNAMED
[2026-02-13T04:07:44.305Z] Process id: 818618
[2026-02-13T04:07:44.305Z] finished: Fri Feb 13 04:07:42 GMT 2026
[2026-02-13T04:07:44.305Z] elapsed time (seconds): 82.932
[2026-02-13T04:07:44.305Z] configuration:
[2026-02-13T04:07:44.305Z] Boot Layer
[2026-02-13T04:07:44.305Z] add modules: java.base
[2026-02-13T04:07:44.305Z] add exports: java.base/jdk.internal.misc ALL-UNNAMED
[2026-02-13T04:07:44.305Z] java.base/jdk.internal.vm.annotation ALL-UNNAMED
[2026-02-13T04:07:44.305Z]
[2026-02-13T04:07:44.305Z] STDOUT:
[2026-02-13T04:07:44.305Z] ITERATION 0
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 183 millis
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 211
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 208
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 211
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 214
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 211
[2026-02-13T04:07:44.305Z] ITERATION 1
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 133 millis
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 147
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 147
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 148
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 147
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 148
[2026-02-13T04:07:44.305Z] ITERATION 2
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 78 millis
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 91
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 91
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 91
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 95
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 100
[2026-02-13T04:07:44.305Z] ITERATION 3
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 55 millis
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 74
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 74
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 74
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 75
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 79
[2026-02-13T04:07:44.305Z] ITERATION 4
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 352 millis
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 370
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 370
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 370
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 371
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 375
[2026-02-13T04:07:44.305Z] test TestHandshake.testHandshake("SegmentAccessor", TestHandshake$$Lambda/0x00000fff01071e70@5104efe): success [1089ms]
[2026-02-13T04:07:44.305Z] ITERATION 0
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 5
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 220 millis
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 238
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 238
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 239
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 241
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 242
[2026-02-13T04:07:44.305Z] ITERATION 1
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 4
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 28 millis
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 46
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 46
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 49
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 46
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 51
[2026-02-13T04:07:44.305Z] ITERATION 2
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 4
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 381 millis
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 400
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 401
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 400
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 406
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 408
[2026-02-13T04:07:44.305Z] ITERATION 3
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 5
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 346 millis
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 383
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 383
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 383
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 384
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 390
[2026-02-13T04:07:44.305Z] ITERATION 4
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 5
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 17 millis
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 36
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 36
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 37
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 38
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 38
[2026-02-13T04:07:44.305Z] test TestHandshake.testHandshake("SegmentCopyAccessor", TestHandshake$$Lambda/0x00000fff01072098@5638757f): success [1255ms]
[2026-02-13T04:07:44.305Z] ITERATION 0
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 4
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 441 millis
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 463
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 464
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 464
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 465
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 471
[2026-02-13T04:07:44.305Z] ITERATION 1
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 3
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 43 millis
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 56
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 58
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 59
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 59
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 61
[2026-02-13T04:07:44.305Z] ITERATION 2
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 137 millis
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 159
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 159
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 163
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 164
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 165
[2026-02-13T04:07:44.305Z] ITERATION 3
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 4
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 390 millis
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 812
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 812
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 814
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 813
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 820
[2026-02-13T04:07:44.305Z] ITERATION 4
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 6
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 474 millis
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 502
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 503
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 502
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 505
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 508
[2026-02-13T04:07:44.305Z] test TestHandshake.testHandshake("SegmentSwappyCopyAccessor", TestHandshake$$Lambda/0x00000fff010722c0@738aaf13): success [2167ms]
[2026-02-13T04:07:44.305Z] ITERATION 0
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 76
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 360 millis
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 544
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 544
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 545
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 547
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 549
[2026-02-13T04:07:44.305Z] ITERATION 1
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 28
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 105 millis
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 227
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 229
[2026-02-13T04:07:44.305Z] Accessor #3 terminated - elapsed (ms): 229
[2026-02-13T04:07:44.305Z] Accessor #0 terminated - elapsed (ms): 229
[2026-02-13T04:07:44.305Z] Segment closed - elapsed (ms): 231
[2026-02-13T04:07:44.305Z] ITERATION 2
[2026-02-13T04:07:44.305Z] Started first thread: Accessor #0 ; elapsed (ms): 16
[2026-02-13T04:07:44.305Z] Starting handshaker with delay set to 478 millis
[2026-02-13T04:07:44.305Z] Accessor #1 terminated - elapsed (ms): 649
[2026-02-13T04:07:44.305Z] Accessor #2 terminated - elapsed (ms): 649
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 649
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 649
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 651
[2026-02-13T04:07:44.306Z] ITERATION 3
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 16
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 155 millis
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 227
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 227
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 227
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 228
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 231
[2026-02-13T04:07:44.306Z] ITERATION 4
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 18
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 107 millis
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 981
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 983
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 985
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 983
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 987
[2026-02-13T04:07:44.306Z] test TestHandshake.testHandshake("SegmentMismatchAccessor", TestHandshake$$Lambda/0x00000fff010724e8@2b2c1703): success [2793ms]
[2026-02-13T04:07:44.306Z] ITERATION 0
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 460 millis
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 485
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 485
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 485
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 486
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 487
[2026-02-13T04:07:44.306Z] ITERATION 1
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 44 millis
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 59
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 60
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 59
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 61
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 62
[2026-02-13T04:07:44.306Z] ITERATION 2
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 459 millis
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 474
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 474
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 474
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 475
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 477
[2026-02-13T04:07:44.306Z] ITERATION 3
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #1 ; elapsed (ms): 2
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 419 millis
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 436
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 436
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 436
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 436
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 439
[2026-02-13T04:07:44.306Z] ITERATION 4
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 0
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 14 millis
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 26
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 26
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 26
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 26
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 28
[2026-02-13T04:07:44.306Z] test TestHandshake.testHandshake("SegmentFillAccessor", TestHandshake$$Lambda/0x00000fff01072710@16b78aa7): success [1657ms]
[2026-02-13T04:07:44.306Z] ITERATION 0
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 191
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 495 millis
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 65076
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 65079
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 65079
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 65079
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 65483
[2026-02-13T04:07:44.306Z] test TestHandshake.testHandshake("BufferAccessor", TestHandshake$$Lambda/0x00000fff01072938@3c76df18): failure [68825ms]
[2026-02-13T04:07:44.306Z] java.lang.AssertionError: expected [true] but found [false]
[2026-02-13T04:07:44.306Z] at org.testng.Assert.fail(Assert.java:99)
[2026-02-13T04:07:44.306Z] at org.testng.Assert.failNotEquals(Assert.java:1037)
[2026-02-13T04:07:44.306Z] at org.testng.Assert.assertTrue(Assert.java:45)
[2026-02-13T04:07:44.306Z] at org.testng.Assert.assertTrue(Assert.java:55)
[2026-02-13T04:07:44.306Z] at TestHandshake.testHandshake(TestHandshake.java:86)
[2026-02-13T04:07:44.306Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2026-02-13T04:07:44.306Z] at java.base/java.lang.reflect.Method.invoke(Method.java:565)
[2026-02-13T04:07:44.306Z] at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:132)
[2026-02-13T04:07:44.306Z] at org.testng.internal.TestInvoker.invokeMethod(TestInvoker.java:599)
[2026-02-13T04:07:44.306Z] at org.testng.internal.TestInvoker.invokeTestMethod(TestInvoker.java:174)
[2026-02-13T04:07:44.306Z] at org.testng.internal.MethodRunner.runInSequence(MethodRunner.java:46)
[2026-02-13T04:07:44.306Z] at org.testng.internal.TestInvoker$MethodInvocationAgent.invoke(TestInvoker.java:822)
[2026-02-13T04:07:44.306Z] at org.testng.internal.TestInvoker.invokeTestMethods(TestInvoker.java:147)
[2026-02-13T04:07:44.306Z] at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:146)
[2026-02-13T04:07:44.306Z] at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:128)
[2026-02-13T04:07:44.306Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1604)
[2026-02-13T04:07:44.306Z] at org.testng.TestRunner.privateRun(TestRunner.java:764)
[2026-02-13T04:07:44.306Z] at org.testng.TestRunner.run(TestRunner.java:585)
[2026-02-13T04:07:44.306Z] at org.testng.SuiteRunner.runTest(SuiteRunner.java:384)
[2026-02-13T04:07:44.306Z] at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:378)
[2026-02-13T04:07:44.306Z] at org.testng.SuiteRunner.privateRun(SuiteRunner.java:337)
[2026-02-13T04:07:44.306Z] at org.testng.SuiteRunner.run(SuiteRunner.java:286)
[2026-02-13T04:07:44.306Z] at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:53)
[2026-02-13T04:07:44.306Z] at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:96)
[2026-02-13T04:07:44.306Z] at org.testng.TestNG.runSuitesSequentially(TestNG.java:1218)
[2026-02-13T04:07:44.306Z] at org.testng.TestNG.runSuitesLocally(TestNG.java:1140)
[2026-02-13T04:07:44.306Z] at org.testng.TestNG.runSuites(TestNG.java:1069)
[2026-02-13T04:07:44.306Z] at org.testng.TestNG.run(TestNG.java:1037)
[2026-02-13T04:07:44.306Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:107)
[2026-02-13T04:07:44.306Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:63)
[2026-02-13T04:07:44.306Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2026-02-13T04:07:44.306Z] at java.base/java.lang.reflect.Method.invoke(Method.java:565)
[2026-02-13T04:07:44.306Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138)
[2026-02-13T04:07:44.306Z] at java.base/java.lang.Thread.run(Thread.java:1474)
[2026-02-13T04:07:44.306Z] ITERATION 0
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 7
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 381 millis
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 395
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 395
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 395
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 395
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 396
[2026-02-13T04:07:44.306Z] ITERATION 1
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 0
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 304 millis
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 312
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 312
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 313
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 313
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 312
[2026-02-13T04:07:44.306Z] ITERATION 2
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 0
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 130 millis
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 141
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 142
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 142
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 142
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 143
[2026-02-13T04:07:44.306Z] ITERATION 3
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 1
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 241 millis
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 247
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 247
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 248
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 248
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 250
[2026-02-13T04:07:44.306Z] ITERATION 4
[2026-02-13T04:07:44.306Z] Started first thread: Accessor #0 ; elapsed (ms): 2
[2026-02-13T04:07:44.306Z] Starting handshaker with delay set to 122 millis
[2026-02-13T04:07:44.306Z] Accessor #3 terminated - elapsed (ms): 137
[2026-02-13T04:07:44.306Z] Accessor #1 terminated - elapsed (ms): 137
[2026-02-13T04:07:44.306Z] Accessor #0 terminated - elapsed (ms): 137
[2026-02-13T04:07:44.306Z] Accessor #2 terminated - elapsed (ms): 137
[2026-02-13T04:07:44.306Z] Segment closed - elapsed (ms): 138
[2026-02-13T04:07:44.306Z] test TestHandshake.testHandshake("BufferHandleAccessor", TestHandshake$$Lambda/0x00000fff01072b60@7a0fbd79): success [1318ms]
[2026-02-13T04:07:44.306Z]
[2026-02-13T04:07:44.306Z] ===============================================
[2026-02-13T04:07:44.306Z] java/foreign/TestHandshake.java
[2026-02-13T04:07:44.306Z] Total tests run: 7, Passes: 6, Failures: 1, Skips: 0
[2026-02-13T04:07:44.306Z] ===============================================
[2026-02-13T04:07:44.306Z]
[2026-02-13T04:07:44.306Z] STDERR:
[2026-02-13T04:07:44.306Z] java.lang.Exception: config failures: 0, test failures: 1
[2026-02-13T04:07:44.306Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:111)
[2026-02-13T04:07:44.306Z] at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:63)
[2026-02-13T04:07:44.306Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
[2026-02-13T04:07:44.306Z] at java.base/java.lang.reflect.Method.invoke(Method.java:565)
[2026-02-13T04:07:44.306Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138)
[2026-02-13T04:07:44.306Z] at java.base/java.lang.Thread.run(Thread.java:1474)
[2026-02-13T04:07:44.306Z]
[2026-02-13T04:07:44.306Z] JavaTest Message: Test threw exception: java.lang.Exception: config failures: 0, test failures: 1
[2026-02-13T04:07:44.306Z] JavaTest Message: shutting down test
[2026-02-13T04:07:44.306Z]
[2026-02-13T04:07:44.306Z] STATUS:Failed.`main' threw exception: java.lang.Exception: config failures: 0, test failures: 1
[2026-02-13T04:07:44.306Z] rerun:
[2026-02-13T04:07:44.306Z] cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/scratch/0 && \
[2026-02-13T04:07:44.306Z] DISPLAY=:0 \
[2026-02-13T04:07:44.306Z] HOME=/home/jenkins \
[2026-02-13T04:07:44.306Z] PATH=/bin:/usr/bin:/usr/sbin \
[2026-02-13T04:07:44.306Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar \
[2026-02-13T04:07:44.306Z] /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/java \
[2026-02-13T04:07:44.306Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \
[2026-02-13T04:07:44.306Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \
[2026-02-13T04:07:44.306Z] -Dtest.compiler.opts= \
[2026-02-13T04:07:44.306Z] -Dtest.java.opts= \
[2026-02-13T04:07:44.306Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \
[2026-02-13T04:07:44.306Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \
[2026-02-13T04:07:44.306Z] -Dtest.timeout.factor=8.0 \
[2026-02-13T04:07:44.306Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \
[2026-02-13T04:07:44.306Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \
[2026-02-13T04:07:44.306Z] -Dtest.name=java/foreign/TestHandshake.java \
[2026-02-13T04:07:44.306Z] -Dtest.verbose=Verbose[p=NONE,f=FULL,e=FULL,t=true,m=false] \
[2026-02-13T04:07:44.306Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign/TestHandshake.java \
[2026-02-13T04:07:44.306Z] -Dtest.main.class=TestHandshake \
[2026-02-13T04:07:44.306Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.306Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.306Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.306Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d \
[2026-02-13T04:07:44.306Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/classes/1/java/foreign/TestHandshake.d:/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/foreign \
[2026-02-13T04:07:44.306Z] -Dtest.modules='java.base/jdk.internal.vm.annotation java.base/jdk.internal.misc' \
[2026-02-13T04:07:44.306Z] --add-modules java.base \
[2026-02-13T04:07:44.306Z] --add-exports java.base/jdk.internal.vm.annotation=ALL-UNNAMED \
[2026-02-13T04:07:44.306Z] --add-exports java.base/jdk.internal.misc=ALL-UNNAMED \
[2026-02-13T04:07:44.306Z] -ea \
[2026-02-13T04:07:44.306Z] -esa \
[2026-02-13T04:07:44.306Z] -Xmx512m \
[2026-02-13T04:07:44.306Z] -XX:+UseCompressedOops \
[2026-02-13T04:07:44.306Z] -Djava.awt.headless=true \
[2026-02-13T04:07:44.306Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \
[2026-02-13T04:07:44.306Z] -Xint \
[2026-02-13T04:07:44.306Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work/java/foreign/TestHandshake.d/testng.1.jta java/foreign/TestHandshake.java false TestHandshake
[2026-02-13T04:07:44.307Z]
[2026-02-13T04:07:44.307Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.Exception: config failures: 0, test failures: 1
[2026-02-13T04:07:44.307Z] --------------------------------------------------
[2026-02-13T04:12:05.099Z] test-docker-alpine320-armv8-2 seems to be removed or offline (java.lang.InterruptedException); will wait for 5 min 0 sec for it to come back online
[2026-02-13T04:12:20.100Z] test-docker-alpine320-armv8-2 is back online
[2026-02-13T04:13:13.070Z] Test results: passed: 106; failed: 1; excluded: 1; did not meet platform requirements: 5
[2026-02-13T04:15:10.079Z] Report written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/report/html/report.html
[2026-02-13T04:15:10.079Z] Results written to /home/jenkins/workspace/Test_openjdk25_hs_sanity.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_17709301682181/jdk_foreign_0/work
[2026-02-13T04:15:10.079Z] Error: Some tests failed or other problems occurred.
[2026-02-13T04:15:10.079Z] -----------------------------------
[2026-02-13T04:15:10.079Z] jdk_foreign_0_FAILED
[2026-02-13T04:15:10.079Z] -----------------------------------
[2026-02-13T04:15:10.079Z]
[2026-02-13T04:15:10.079Z] TEST TEARDOWN:
[2026-02-13T04:15:10.079Z] Nothing to be done for teardown.
[2026-02-13T04:16:05.025Z] jdk_foreign_0 Finish Time: Fri Feb 13 04:16:01 2026 Epoch Time (ms): 1770956161930