[2024-10-30T20:42:06.707Z] Running test jdk_security3_0 ... [2024-10-30T20:42:06.707Z] =============================================== [2024-10-30T20:42:06.707Z] jdk_security3_0 Start Time: Wed Oct 30 20:42:06 2024 Epoch Time (ms): 1730320926519 [2024-10-30T20:42:06.707Z] variation: Mode150 [2024-10-30T20:42:06.707Z] JVM_OPTIONS: -XX:+UseCompressedOops [2024-10-30T20:42:06.707Z] { \ [2024-10-30T20:42:06.707Z] echo ""; echo "TEST SETUP:"; \ [2024-10-30T20:42:06.707Z] echo "Nothing to be done for setup."; \ [2024-10-30T20:42:06.707Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/jdk_security3_0"; \ [2024-10-30T20:42:06.707Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/jdk_security3_0"; \ [2024-10-30T20:42:06.707Z] echo ""; echo "TESTING:"; \ [2024-10-30T20:42:06.707Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/..//bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2024-10-30T20:42:06.707Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:+UseCompressedOops " \ [2024-10-30T20:42:06.707Z] \ [2024-10-30T20:42:06.707Z] -w ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/jdk_security3_0"/work" \ [2024-10-30T20:42:06.707Z] -r ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/jdk_security3_0"/report" \ [2024-10-30T20:42:06.707Z] -jdk:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../" \ [2024-10-30T20:42:06.708Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2024-10-30T20:42:06.708Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk21.txt" \ [2024-10-30T20:42:06.708Z] \ [2024-10-30T20:42:06.708Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk21.txt" \ [2024-10-30T20:42:06.708Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_security3"; \ [2024-10-30T20:42:06.708Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_security3_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_security3_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-30T20:42:06.708Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-30T20:42:06.708Z] echo "Nothing to be done for teardown."; \ [2024-10-30T20:42:06.708Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/TestTargetResult"; [2024-10-30T20:42:06.708Z] [2024-10-30T20:42:06.708Z] TEST SETUP: [2024-10-30T20:42:06.708Z] Nothing to be done for setup. [2024-10-30T20:42:06.708Z] [2024-10-30T20:42:06.708Z] TESTING: [2024-10-30T20:42:10.085Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/jdk_security3_0/work" not found: creating [2024-10-30T20:42:10.085Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/../TKG/output_17303209259267/jdk_security3_0/report" not found: creating [2024-10-30T20:42:51.334Z] XML output with verification to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work [2024-10-30T22:45:47.529Z] -------------------------------------------------- [2024-10-30T22:45:47.529Z] TEST: javax/net/ssl/TLS/TLSMFLNTest.java [2024-10-30T22:45:47.529Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. [2024-10-30T22:45:47.529Z] [2024-10-30T22:45:47.529Z] ACTION: build -- Passed. Build successful [2024-10-30T22:45:47.529Z] REASON: Named class compiled on demand [2024-10-30T22:45:47.529Z] TIME: 6.545 seconds [2024-10-30T22:45:47.529Z] messages: [2024-10-30T22:45:47.529Z] command: build TLSMFLNTest [2024-10-30T22:45:47.529Z] reason: Named class compiled on demand [2024-10-30T22:45:47.529Z] started: Wed Oct 30 22:29:25 UTC 2024 [2024-10-30T22:45:47.529Z] Test directory: [2024-10-30T22:45:47.529Z] compile: TLSMFLNTest [2024-10-30T22:45:47.529Z] finished: Wed Oct 30 22:29:31 UTC 2024 [2024-10-30T22:45:47.529Z] elapsed time (seconds): 6.545 [2024-10-30T22:45:47.529Z] [2024-10-30T22:45:47.529Z] ACTION: compile -- Passed. Compilation successful [2024-10-30T22:45:47.529Z] REASON: .class file out of date or does not exist [2024-10-30T22:45:47.529Z] TIME: 6.545 seconds [2024-10-30T22:45:47.529Z] messages: [2024-10-30T22:45:47.529Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS/TLSMFLNTest.java [2024-10-30T22:45:47.529Z] reason: .class file out of date or does not exist [2024-10-30T22:45:47.529Z] started: Wed Oct 30 22:29:25 UTC 2024 [2024-10-30T22:45:47.529Z] Additional options from @modules: --add-modules java.security.jgss,jdk.security.auth,java.base --add-exports java.security.jgss/sun.security.jgss.krb5=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal.ccache=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal.crypto=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal.ktab=ALL-UNNAMED --add-exports java.base/sun.security.util=ALL-UNNAMED [2024-10-30T22:45:47.529Z] Mode: agentvm [2024-10-30T22:45:47.529Z] Agent id: 3 [2024-10-30T22:45:47.529Z] finished: Wed Oct 30 22:29:31 UTC 2024 [2024-10-30T22:45:47.529Z] elapsed time (seconds): 6.545 [2024-10-30T22:45:47.529Z] configuration: [2024-10-30T22:45:47.529Z] Boot Layer (javac runtime environment) [2024-10-30T22:45:47.529Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-10-30T22:45:47.529Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/patches/java.base [2024-10-30T22:45:47.529Z] [2024-10-30T22:45:47.529Z] javac compilation environment [2024-10-30T22:45:47.529Z] add modules: java.security.jgss jdk.security.auth java.base [2024-10-30T22:45:47.529Z] add exports: java.base/sun.security.util ALL-UNNAMED [2024-10-30T22:45:47.529Z] java.security.jgss/sun.security.jgss.krb5 ALL-UNNAMED [2024-10-30T22:45:47.529Z] java.security.jgss/sun.security.krb5 ALL-UNNAMED [2024-10-30T22:45:47.529Z] java.security.jgss/sun.security.krb5.internal ALL-UNNAMED [2024-10-30T22:45:47.529Z] java.security.jgss/sun.security.krb5.internal.ccache ALL-UNNAMED [2024-10-30T22:45:47.529Z] java.security.jgss/sun.security.krb5.internal.crypto ALL-UNNAMED [2024-10-30T22:45:47.529Z] java.security.jgss/sun.security.krb5.internal.ktab ALL-UNNAMED [2024-10-30T22:45:47.529Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLSCommon [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-10-30T22:45:47.529Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon [2024-10-30T22:45:47.529Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib [2024-10-30T22:45:47.529Z] [2024-10-30T22:45:47.529Z] rerun: [2024-10-30T22:45:47.529Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/scratch/0 && \ [2024-10-30T22:45:47.530Z] DISPLAY=:0 \ [2024-10-30T22:45:47.530Z] HOME=/home/jenkins \ [2024-10-30T22:45:47.530Z] LANG=C.utf8 \ [2024-10-30T22:45:47.530Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-10-30T22:45:47.530Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/javac \ [2024-10-30T22:45:47.530Z] -J-ea \ [2024-10-30T22:45:47.530Z] -J-esa \ [2024-10-30T22:45:47.530Z] -J-Xmx512m \ [2024-10-30T22:45:47.530Z] -J-XX:+UseCompressedOops \ [2024-10-30T22:45:47.530Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-10-30T22:45:47.530Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-10-30T22:45:47.530Z] -J-Dtest.compiler.opts= \ [2024-10-30T22:45:47.530Z] -J-Dtest.java.opts= \ [2024-10-30T22:45:47.530Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-30T22:45:47.530Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-30T22:45:47.530Z] -J-Dtest.timeout.factor=8.0 \ [2024-10-30T22:45:47.530Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-30T22:45:47.530Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-10-30T22:45:47.530Z] -J-Dtest.name=javax/net/ssl/TLS/TLSMFLNTest.java \ [2024-10-30T22:45:47.530Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS/TLSMFLNTest.java \ [2024-10-30T22:45:47.530Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS \ [2024-10-30T22:45:47.530Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-30T22:45:47.530Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d \ [2024-10-30T22:45:47.530Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-30T22:45:47.530Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-30T22:45:47.530Z] -J-Dtest.modules='java.security.jgss jdk.security.auth java.security.jgss/sun.security.jgss.krb5 java.security.jgss/sun.security.krb5:+open java.security.jgss/sun.security.krb5.internal:+open java.security.jgss/sun.security.krb5.internal.ccache java.security.jgss/sun.security.krb5.internal.crypto java.security.jgss/sun.security.krb5.internal.ktab java.base/sun.security.util' \ [2024-10-30T22:45:47.530Z] --add-modules java.security.jgss,jdk.security.auth,java.base \ [2024-10-30T22:45:47.530Z] --add-exports java.security.jgss/sun.security.jgss.krb5=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] --add-exports java.security.jgss/sun.security.krb5=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] --add-exports java.security.jgss/sun.security.krb5.internal=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] --add-exports java.security.jgss/sun.security.krb5.internal.ccache=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] --add-exports java.security.jgss/sun.security.krb5.internal.crypto=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] --add-exports java.security.jgss/sun.security.krb5.internal.ktab=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] --add-exports java.base/sun.security.util=ALL-UNNAMED \ [2024-10-30T22:45:47.530Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d \ [2024-10-30T22:45:47.530Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-30T22:45:47.530Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS/TLSMFLNTest.java [2024-10-30T22:45:47.530Z] direct: [2024-10-30T22:45:47.530Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto/KDC.java:1645: warning: [removal] stop() in Thread has been deprecated and marked for removal [2024-10-30T22:45:47.530Z] thread1.stop(); [2024-10-30T22:45:47.530Z] ^ [2024-10-30T22:45:47.530Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto/KDC.java:1646: warning: [removal] stop() in Thread has been deprecated and marked for removal [2024-10-30T22:45:47.530Z] thread2.stop(); [2024-10-30T22:45:47.530Z] ^ [2024-10-30T22:45:47.530Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto/KDC.java:1647: warning: [removal] stop() in Thread has been deprecated and marked for removal [2024-10-30T22:45:47.530Z] thread3.stop(); [2024-10-30T22:45:47.530Z] ^ [2024-10-30T22:45:47.530Z] Note: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto/Context.java uses or overrides a deprecated API. [2024-10-30T22:45:47.530Z] Note: Recompile with -Xlint:deprecation for details. [2024-10-30T22:45:47.530Z] Note: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto/KDC.java uses unchecked or unsafe operations. [2024-10-30T22:45:47.530Z] Note: Recompile with -Xlint:unchecked for details. [2024-10-30T22:45:47.530Z] 3 warnings [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] ACTION: main -- Error. Program `/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/java' timed out (timeout set to 960000ms, elapsed time including timeout handling was 965230ms). [2024-10-30T22:45:47.530Z] REASON: User specified action: run main/othervm -Dtest.security.protocol=TLS -Dtest.mode=norm TLSMFLNTest [2024-10-30T22:45:47.530Z] TIME: 965.48 seconds [2024-10-30T22:45:47.530Z] messages: [2024-10-30T22:45:47.530Z] command: main -Dtest.security.protocol=TLS -Dtest.mode=norm TLSMFLNTest [2024-10-30T22:45:47.530Z] reason: User specified action: run main/othervm -Dtest.security.protocol=TLS -Dtest.mode=norm TLSMFLNTest [2024-10-30T22:45:47.530Z] started: Wed Oct 30 22:29:31 UTC 2024 [2024-10-30T22:45:47.530Z] Mode: othervm [/othervm specified] [2024-10-30T22:45:47.530Z] Additional options from @modules: --add-modules java.security.jgss,jdk.security.auth,java.base --add-exports java.security.jgss/sun.security.jgss.krb5=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5=ALL-UNNAMED --add-opens java.security.jgss/sun.security.krb5=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal=ALL-UNNAMED --add-opens java.security.jgss/sun.security.krb5.internal=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal.ccache=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal.crypto=ALL-UNNAMED --add-exports java.security.jgss/sun.security.krb5.internal.ktab=ALL-UNNAMED --add-exports java.base/sun.security.util=ALL-UNNAMED [2024-10-30T22:45:47.530Z] Timeout information: [2024-10-30T22:45:47.530Z] Running jstack on process 3443484 [2024-10-30T22:45:47.530Z] 2024-10-30 22:45:36 [2024-10-30T22:45:47.530Z] Full thread dump OpenJDK 64-Bit Server VM (21.0.6-beta+1-ea mixed mode, sharing): [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] Threads class SMR info: [2024-10-30T22:45:47.530Z] _java_thread_list=0x00007179b4001af0, length=12, elements={ [2024-10-30T22:45:47.530Z] 0x0000717a5002f250, 0x0000717a500f86a0, 0x0000717a500f9c00, 0x0000717a500fb390, [2024-10-30T22:45:47.530Z] 0x0000717a500fc9c0, 0x0000717a500fdf50, 0x0000717a500ffa80, 0x0000717a50101130, [2024-10-30T22:45:47.530Z] 0x0000717a50112b40, 0x0000717a50146c80, 0x0000717a50166160, 0x00007179b4000e70 [2024-10-30T22:45:47.530Z] } [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "main" #1 [3443487] prio=5 os_prio=0 cpu=128.35ms elapsed=964.75s tid=0x0000717a5002f250 nid=3443487 in Object.wait() [0x0000717a57084000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: WAITING (on object monitor) [2024-10-30T22:45:47.530Z] at java.lang.Object.wait0(java.base@21.0.6-beta/Native Method) [2024-10-30T22:45:47.530Z] - waiting on <0x00000000e0012b68> (a java.lang.Thread) [2024-10-30T22:45:47.530Z] at java.lang.Object.wait(java.base@21.0.6-beta/Object.java:366) [2024-10-30T22:45:47.530Z] at java.lang.Thread.join(java.base@21.0.6-beta/Thread.java:2079) [2024-10-30T22:45:47.530Z] - locked <0x00000000e0012b68> (a java.lang.Thread) [2024-10-30T22:45:47.530Z] at java.lang.Thread.join(java.base@21.0.6-beta/Thread.java:2155) [2024-10-30T22:45:47.530Z] at com.sun.javatest.regtest.agent.MainWrapper.main(MainWrapper.java:85) [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Reference Handler" #9 [3443497] daemon prio=10 os_prio=0 cpu=6.86ms elapsed=963.43s tid=0x0000717a500f86a0 nid=3443497 waiting on condition [0x0000717a34e56000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.6-beta/Native Method) [2024-10-30T22:45:47.530Z] at java.lang.ref.Reference.processPendingReferences(java.base@21.0.6-beta/Reference.java:246) [2024-10-30T22:45:47.530Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.6-beta/Reference.java:208) [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Finalizer" #10 [3443498] daemon prio=8 os_prio=0 cpu=0.33ms elapsed=963.43s tid=0x0000717a500f9c00 nid=3443498 in Object.wait() [0x0000717a34d55000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: WAITING (on object monitor) [2024-10-30T22:45:47.530Z] at java.lang.Object.wait0(java.base@21.0.6-beta/Native Method) [2024-10-30T22:45:47.530Z] - waiting on <0x00000000e0012e10> (a java.lang.ref.NativeReferenceQueue$Lock) [2024-10-30T22:45:47.530Z] at java.lang.Object.wait(java.base@21.0.6-beta/Object.java:366) [2024-10-30T22:45:47.530Z] at java.lang.Object.wait(java.base@21.0.6-beta/Object.java:339) [2024-10-30T22:45:47.530Z] at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.6-beta/NativeReferenceQueue.java:48) [2024-10-30T22:45:47.530Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.6-beta/ReferenceQueue.java:158) [2024-10-30T22:45:47.530Z] at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.6-beta/NativeReferenceQueue.java:89) [2024-10-30T22:45:47.530Z] - locked <0x00000000e0012e10> (a java.lang.ref.NativeReferenceQueue$Lock) [2024-10-30T22:45:47.530Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.6-beta/Finalizer.java:173) [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Signal Dispatcher" #11 [3443499] daemon prio=9 os_prio=0 cpu=0.37ms elapsed=963.36s tid=0x0000717a500fb390 nid=3443499 waiting on condition [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Service Thread" #12 [3443500] daemon prio=9 os_prio=0 cpu=2.56ms elapsed=963.36s tid=0x0000717a500fc9c0 nid=3443500 runnable [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Monitor Deflation Thread" #13 [3443501] daemon prio=9 os_prio=0 cpu=74.98ms elapsed=963.33s tid=0x0000717a500fdf50 nid=3443501 runnable [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "C2 CompilerThread0" #14 [3443502] daemon prio=9 os_prio=0 cpu=14346.80ms elapsed=963.30s tid=0x0000717a500ffa80 nid=3443502 waiting on condition [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] No compile task [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "C1 CompilerThread0" #16 [3443503] daemon prio=9 os_prio=0 cpu=1937.60ms elapsed=963.30s tid=0x0000717a50101130 nid=3443503 waiting on condition [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] No compile task [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Common-Cleaner" #17 [3443504] daemon prio=8 os_prio=0 cpu=9.66ms elapsed=962.81s tid=0x0000717a50112b40 nid=3443504 waiting on condition [0x0000717a3467f000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: TIMED_WAITING (parking) [2024-10-30T22:45:47.530Z] at jdk.internal.misc.Unsafe.park(java.base@21.0.6-beta/Native Method) [2024-10-30T22:45:47.530Z] - parking to wait for <0x00000000e0012f38> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2024-10-30T22:45:47.530Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.6-beta/LockSupport.java:269) [2024-10-30T22:45:47.530Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.6-beta/AbstractQueuedSynchronizer.java:1852) [2024-10-30T22:45:47.530Z] at java.lang.ref.ReferenceQueue.await(java.base@21.0.6-beta/ReferenceQueue.java:71) [2024-10-30T22:45:47.530Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.6-beta/ReferenceQueue.java:143) [2024-10-30T22:45:47.530Z] at java.lang.ref.ReferenceQueue.remove(java.base@21.0.6-beta/ReferenceQueue.java:218) [2024-10-30T22:45:47.530Z] at jdk.internal.ref.CleanerImpl.run(java.base@21.0.6-beta/CleanerImpl.java:140) [2024-10-30T22:45:47.530Z] at java.lang.Thread.runWith(java.base@21.0.6-beta/Thread.java:1596) [2024-10-30T22:45:47.530Z] at java.lang.Thread.run(java.base@21.0.6-beta/Thread.java:1583) [2024-10-30T22:45:47.530Z] at jdk.internal.misc.InnocuousThread.run(java.base@21.0.6-beta/InnocuousThread.java:186) [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Notification Thread" #18 [3443505] daemon prio=9 os_prio=0 cpu=0.15ms elapsed=962.12s tid=0x0000717a50146c80 nid=3443505 runnable [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "MainThread" #19 [3443506] prio=5 os_prio=0 cpu=56657.09ms elapsed=961.61s tid=0x0000717a50166160 nid=3443506 runnable [0x0000717a3447b000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] at sun.security.provider.DigestBase.engineUpdate(java.base@21.0.6-beta/DigestBase.java:123) [2024-10-30T22:45:47.530Z] at java.security.MessageDigest$Delegate.engineUpdate(java.base@21.0.6-beta/MessageDigest.java:653) [2024-10-30T22:45:47.530Z] at java.security.MessageDigest.update(java.base@21.0.6-beta/MessageDigest.java:357) [2024-10-30T22:45:47.530Z] at com.sun.crypto.provider.HmacCore.engineDoFinal(java.base@21.0.6-beta/HmacCore.java:238) [2024-10-30T22:45:47.530Z] at javax.crypto.Mac.doFinal(java.base@21.0.6-beta/Mac.java:581) [2024-10-30T22:45:47.530Z] at javax.crypto.Mac.doFinal(java.base@21.0.6-beta/Mac.java:624) [2024-10-30T22:45:47.530Z] at com.sun.crypto.provider.PBKDF2KeyImpl.deriveKey(java.base@21.0.6-beta/PBKDF2KeyImpl.java:200) [2024-10-30T22:45:47.530Z] at com.sun.crypto.provider.PBKDF2KeyImpl.<init>(java.base@21.0.6-beta/PBKDF2KeyImpl.java:114) [2024-10-30T22:45:47.530Z] at com.sun.crypto.provider.PBKDF2Core.engineGenerateSecret(java.base@21.0.6-beta/PBKDF2Core.java:68) [2024-10-30T22:45:47.530Z] at com.sun.crypto.provider.PBES2Core.engineInit(java.base@21.0.6-beta/PBES2Core.java:158) [2024-10-30T22:45:47.530Z] at com.sun.crypto.provider.PBES2Core.engineInit(java.base@21.0.6-beta/PBES2Core.java:186) [2024-10-30T22:45:47.530Z] at javax.crypto.Cipher.implInit(java.base@21.0.6-beta/Cipher.java:880) [2024-10-30T22:45:47.530Z] at javax.crypto.Cipher.chooseProvider(java.base@21.0.6-beta/Cipher.java:934) [2024-10-30T22:45:47.530Z] - locked <0x00000000e3fe93e8> (a java.lang.Object) [2024-10-30T22:45:47.530Z] at javax.crypto.Cipher.init(java.base@21.0.6-beta/Cipher.java:1613) [2024-10-30T22:45:47.530Z] at javax.crypto.Cipher.init(java.base@21.0.6-beta/Cipher.java:1541) [2024-10-30T22:45:47.530Z] at sun.security.pkcs12.PKCS12KeyStore.lambda$engineLoad$1(java.base@21.0.6-beta/PKCS12KeyStore.java:2089) [2024-10-30T22:45:47.530Z] at sun.security.pkcs12.PKCS12KeyStore$$Lambda/0x00007179d8061188.tryOnce(java.base@21.0.6-beta/Unknown Source) [2024-10-30T22:45:47.530Z] at sun.security.pkcs12.PKCS12KeyStore$RetryWithZero.run(java.base@21.0.6-beta/PKCS12KeyStore.java:257) [2024-10-30T22:45:47.530Z] at sun.security.pkcs12.PKCS12KeyStore.engineLoad(java.base@21.0.6-beta/PKCS12KeyStore.java:2084) [2024-10-30T22:45:47.530Z] - locked <0x00000000e3fe2a98> (a sun.security.pkcs12.PKCS12KeyStore) [2024-10-30T22:45:47.530Z] at sun.security.util.KeyStoreDelegator.engineLoad(java.base@21.0.6-beta/KeyStoreDelegator.java:249) [2024-10-30T22:45:47.530Z] at java.security.KeyStore.load(java.base@21.0.6-beta/KeyStore.java:1500) [2024-10-30T22:45:47.530Z] at SSLEngineTestCase.getContext(SSLEngineTestCase.java:812) [2024-10-30T22:45:47.530Z] at MFLNTest.testOneCipher(MFLNTest.java:60) [2024-10-30T22:45:47.530Z] at SSLEngineTestCase.testSomeCiphers(SSLEngineTestCase.java:936) [2024-10-30T22:45:47.530Z] at SSLEngineTestCase.runTests(SSLEngineTestCase.java:720) [2024-10-30T22:45:47.530Z] at SSLEngineTestCase.runTests(SSLEngineTestCase.java:745) [2024-10-30T22:45:47.530Z] at MFLNTest.main(MFLNTest.java:50) [2024-10-30T22:45:47.530Z] at TLSMFLNTest.main(TLSMFLNTest.java:51) [2024-10-30T22:45:47.530Z] at java.lang.invoke.LambdaForm$DMH/0x00007179d8001800.invokeStatic(java.base@21.0.6-beta/LambdaForm$DMH) [2024-10-30T22:45:47.530Z] at java.lang.invoke.LambdaForm$MH/0x00007179d8002c00.invoke(java.base@21.0.6-beta/LambdaForm$MH) [2024-10-30T22:45:47.530Z] at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@21.0.6-beta/Invokers$Holder) [2024-10-30T22:45:47.530Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@21.0.6-beta/DirectMethodHandleAccessor.java:154) [2024-10-30T22:45:47.530Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@21.0.6-beta/DirectMethodHandleAccessor.java:103) [2024-10-30T22:45:47.530Z] at java.lang.reflect.Method.invoke(java.base@21.0.6-beta/Method.java:580) [2024-10-30T22:45:47.530Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2024-10-30T22:45:47.530Z] at java.lang.Thread.runWith(java.base@21.0.6-beta/Thread.java:1596) [2024-10-30T22:45:47.530Z] at java.lang.Thread.run(java.base@21.0.6-beta/Thread.java:1583) [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.530Z] "Attach Listener" #23 [3444994] daemon prio=9 os_prio=0 cpu=0.37ms elapsed=0.17s tid=0x00007179b4000e70 nid=3444994 waiting on condition [0x0000000000000000] [2024-10-30T22:45:47.530Z] java.lang.Thread.State: RUNNABLE [2024-10-30T22:45:47.530Z] [2024-10-30T22:45:47.531Z] "GC Thread#3" os_prio=0 cpu=31.97ms elapsed=942.25s tid=0x00007179c4007fe0 nid=3443523 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "GC Thread#2" os_prio=0 cpu=33.38ms elapsed=942.25s tid=0x00007179c40074d0 nid=3443522 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "GC Thread#1" os_prio=0 cpu=30.81ms elapsed=942.25s tid=0x00007179c40069c0 nid=3443521 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "VM Thread" os_prio=0 cpu=80.52ms elapsed=963.65s tid=0x0000717a500ed1f0 nid=3443496 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "VM Periodic Task Thread" os_prio=0 cpu=396.37ms elapsed=963.70s tid=0x0000717a500dbe70 nid=3443495 waiting on condition [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "G1 Service" os_prio=0 cpu=23.92ms elapsed=964.49s tid=0x0000717a500cafd0 nid=3443492 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "G1 Refine#0" os_prio=0 cpu=0.12ms elapsed=964.54s tid=0x0000717a500ca020 nid=3443491 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "G1 Conc#0" os_prio=0 cpu=0.09ms elapsed=964.57s tid=0x0000717a500613c0 nid=3443490 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "G1 Main Marker" os_prio=0 cpu=0.10ms elapsed=964.62s tid=0x0000717a50060420 nid=3443489 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] "GC Thread#0" os_prio=0 cpu=32.10ms elapsed=964.62s tid=0x0000717a5005ae30 nid=3443488 runnable [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] JNI global refs: 8, weak refs: 0 [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] --- Timeout information end. [2024-10-30T22:45:47.531Z] finished: Wed Oct 30 22:45:37 UTC 2024 [2024-10-30T22:45:47.531Z] elapsed time (seconds): 965.48 [2024-10-30T22:45:47.531Z] configuration: [2024-10-30T22:45:47.531Z] Boot Layer [2024-10-30T22:45:47.531Z] add modules: java.security.jgss jdk.security.auth java.base [2024-10-30T22:45:47.531Z] add exports: java.base/sun.security.util ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.jgss.krb5 ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.krb5 ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.krb5.internal ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.krb5.internal.ccache ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.krb5.internal.crypto ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.krb5.internal.ktab ALL-UNNAMED [2024-10-30T22:45:47.531Z] add opens: java.security.jgss/sun.security.krb5 ALL-UNNAMED [2024-10-30T22:45:47.531Z] java.security.jgss/sun.security.krb5.internal ALL-UNNAMED [2024-10-30T22:45:47.531Z] [2024-10-30T22:45:47.531Z] STDOUT: [2024-10-30T22:45:47.531Z] ============================================================ [2024-10-30T22:45:47.531Z] Testsing DTLS handshake with MFL = 4096 [2024-10-30T22:45:47.531Z] =============================================== [2024-10-30T22:45:47.531Z] Supported non kerberos ciphers testing [2024-10-30T22:45:47.531Z] =========================================== [2024-10-30T22:45:47.531Z] --------------------------------------- [2024-10-30T22:45:47.531Z] Testing cipher suite TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.531Z] --------------------------------------- [2024-10-30T22:45:47.531Z] ============================================= [2024-10-30T22:45:47.531Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 221 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 221 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Running delegated tasks... [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 1221 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 1221 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Running delegated tasks... [2024-10-30T22:45:47.531Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 628 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 628 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Running delegated tasks... [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 45 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 45 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 1275 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 1275 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 45 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 45 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.531Z] Handshake is completed [2024-10-30T22:45:47.531Z] Test Passed: TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.531Z] --------------------------------------- [2024-10-30T22:45:47.531Z] Testing cipher suite TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256 [2024-10-30T22:45:47.531Z] --------------------------------------- [2024-10-30T22:45:47.531Z] ============================================= [2024-10-30T22:45:47.531Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 221 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 221 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Running delegated tasks... [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 1220 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 1220 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Running delegated tasks... [2024-10-30T22:45:47.531Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 628 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 628 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Running delegated tasks... [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 45 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 45 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 1275 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 1275 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Server wrapped 45 bytes. [2024-10-30T22:45:47.531Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.531Z] Client unwrapping 45 bytes... [2024-10-30T22:45:47.531Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.531Z] Handshake is completed [2024-10-30T22:45:47.531Z] Test Passed: TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256 [2024-10-30T22:45:47.531Z] --------------------------------------- [2024-10-30T22:45:47.531Z] Testing cipher suite TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256 [2024-10-30T22:45:47.531Z] --------------------------------------- [2024-10-30T22:45:47.531Z] ============================================= [2024-10-30T22:45:47.531Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.531Z] ============================================ [2024-10-30T22:45:47.531Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.531Z] ========================== [2024-10-30T22:45:47.531Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.531Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.531Z] Client wrapped 221 bytes. [2024-10-30T22:45:47.531Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.531Z] Server unwrapping 221 bytes... [2024-10-30T22:45:47.531Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.531Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 1221 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 1221 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 627 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 627 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 37 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 37 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 1275 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 1275 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 37 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 37 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.532Z] Handshake is completed [2024-10-30T22:45:47.532Z] Test Passed: TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256 [2024-10-30T22:45:47.532Z] --------------------------------------- [2024-10-30T22:45:47.532Z] Testing cipher suite TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.532Z] --------------------------------------- [2024-10-30T22:45:47.532Z] ============================================= [2024-10-30T22:45:47.532Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 221 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 221 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 1756 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 1756 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 626 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 626 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 45 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 45 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 1626 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 1626 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 45 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 45 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.532Z] Handshake is completed [2024-10-30T22:45:47.532Z] Test Passed: TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.532Z] --------------------------------------- [2024-10-30T22:45:47.532Z] Testing cipher suite TLS_ECDHE_RSA_WITH_CHACHA20_POLY1305_SHA256 [2024-10-30T22:45:47.532Z] --------------------------------------- [2024-10-30T22:45:47.532Z] ============================================= [2024-10-30T22:45:47.532Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client wrapped 221 bytes. [2024-10-30T22:45:47.532Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Server unwrapping 221 bytes... [2024-10-30T22:45:47.532Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Server wrapped 1756 bytes. [2024-10-30T22:45:47.532Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.532Z] Client unwrapping 1756 bytes... [2024-10-30T22:45:47.532Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.532Z] ============================================ [2024-10-30T22:45:47.532Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.532Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Running delegated tasks... [2024-10-30T22:45:47.532Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.532Z] ========================== [2024-10-30T22:45:47.532Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.532Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Client wrapped 626 bytes. [2024-10-30T22:45:47.538Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.538Z] Server unwrapping 626 bytes... [2024-10-30T22:45:47.538Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.538Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Running delegated tasks... [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.538Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.538Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.538Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.538Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Client wrapped 37 bytes. [2024-10-30T22:45:47.538Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.538Z] Server unwrapping 37 bytes... [2024-10-30T22:45:47.538Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.538Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server wrapped 1626 bytes. [2024-10-30T22:45:47.538Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.538Z] Client unwrapping 1626 bytes... [2024-10-30T22:45:47.538Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.538Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.538Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.538Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server wrapped 37 bytes. [2024-10-30T22:45:47.538Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.538Z] Client unwrapping 37 bytes... [2024-10-30T22:45:47.538Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.538Z] Handshake is completed [2024-10-30T22:45:47.538Z] Test Passed: TLS_ECDHE_RSA_WITH_CHACHA20_POLY1305_SHA256 [2024-10-30T22:45:47.538Z] --------------------------------------- [2024-10-30T22:45:47.538Z] Testing cipher suite TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 [2024-10-30T22:45:47.538Z] --------------------------------------- [2024-10-30T22:45:47.538Z] ============================================= [2024-10-30T22:45:47.538Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Client wrapped 221 bytes. [2024-10-30T22:45:47.538Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.538Z] Server unwrapping 221 bytes... [2024-10-30T22:45:47.538Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.538Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Running delegated tasks... [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Server wrapped 1756 bytes. [2024-10-30T22:45:47.538Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.538Z] Client unwrapping 1756 bytes... [2024-10-30T22:45:47.538Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.538Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Running delegated tasks... [2024-10-30T22:45:47.538Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.538Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.538Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.538Z] ============================================ [2024-10-30T22:45:47.538Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.538Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 628 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 628 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 45 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 45 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 1626 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 1626 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 45 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 45 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.539Z] Handshake is completed [2024-10-30T22:45:47.539Z] Test Passed: TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 [2024-10-30T22:45:47.539Z] --------------------------------------- [2024-10-30T22:45:47.539Z] Testing cipher suite TLS_DHE_RSA_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.539Z] --------------------------------------- [2024-10-30T22:45:47.539Z] ============================================= [2024-10-30T22:45:47.539Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 215 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 215 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 2053 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 2053 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 191 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 191 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 853 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 853 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 45 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 45 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 1626 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 1626 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 9: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 45 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 45 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 10: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.539Z] Handshake is completed [2024-10-30T22:45:47.539Z] Test Passed: TLS_DHE_RSA_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.539Z] --------------------------------------- [2024-10-30T22:45:47.539Z] Testing cipher suite TLS_DHE_RSA_WITH_CHACHA20_POLY1305_SHA256 [2024-10-30T22:45:47.539Z] --------------------------------------- [2024-10-30T22:45:47.539Z] ============================================= [2024-10-30T22:45:47.539Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Client wrapped 215 bytes. [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] Server unwrapping 215 bytes... [2024-10-30T22:45:47.539Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 2053 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 2053 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Running delegated tasks... [2024-10-30T22:45:47.539Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 191 byte [2024-10-30T22:45:47.539Z] [2024-10-30T22:45:47.539Z] ... [2024-10-30T22:45:47.539Z] Output overflow: [2024-10-30T22:45:47.539Z] JT Harness has limited the test output to the text [2024-10-30T22:45:47.539Z] at the beginning and the end, so that you can see how the [2024-10-30T22:45:47.539Z] test began, and how it completed. [2024-10-30T22:45:47.539Z] [2024-10-30T22:45:47.539Z] If you need to see more of the output from the test, [2024-10-30T22:45:47.539Z] set the system property javatest.maxOutputSize to a higher [2024-10-30T22:45:47.539Z] value. The current value is 100000 [2024-10-30T22:45:47.539Z] ... [2024-10-30T22:45:47.539Z] [2024-10-30T22:45:47.539Z] ===================================== [2024-10-30T22:45:47.539Z] Handshake loop 16: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 16: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 17: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 17: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 18: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 18: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 19: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 19: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 20: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Handshake loop 20: round 2 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.539Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.539Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.539Z] Server wrapped 120 bytes. [2024-10-30T22:45:47.539Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.539Z] Client unwrapping 120 bytes... [2024-10-30T22:45:47.539Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.539Z] ============================================ [2024-10-30T22:45:47.539Z] Handshake loop 21: round 1 [2024-10-30T22:45:47.539Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 21: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 22: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 22: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 85 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 85 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 23: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.540Z] Handshake is completed [2024-10-30T22:45:47.540Z] Test Passed: TLS_RSA_WITH_AES_256_CBC_SHA256 [2024-10-30T22:45:47.540Z] --------------------------------------- [2024-10-30T22:45:47.540Z] Testing cipher suite TLS_RSA_WITH_AES_128_CBC_SHA256 [2024-10-30T22:45:47.540Z] --------------------------------------- [2024-10-30T22:45:47.540Z] ============================================= [2024-10-30T22:45:47.540Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 194 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 194 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Running delegated tasks... [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Running delegated tasks... [2024-10-30T22:45:47.540Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Running delegated tasks... [2024-10-30T22:45:47.540Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 196 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 196 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Running delegated tasks... [2024-10-30T22:45:47.540Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 9: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 10: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 10: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 11: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 11: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Running delegated tasks... [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 12: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 98 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 98 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 12: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Running delegated tasks... [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 13: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 13: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 14: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Client wrapped 85 bytes. [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] Server unwrapping 85 bytes... [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Handshake loop 14: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 15: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 15: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 16: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 16: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 17: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 17: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 18: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 18: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 19: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 19: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 20: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 20: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 120 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 120 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 21: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 21: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.540Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.540Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.540Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.540Z] ============================================ [2024-10-30T22:45:47.540Z] Handshake loop 22: round 1 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.540Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Handshake loop 22: round 2 [2024-10-30T22:45:47.540Z] ========================== [2024-10-30T22:45:47.540Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.540Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 85 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 85 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 23: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.541Z] Handshake is completed [2024-10-30T22:45:47.541Z] Test Passed: TLS_RSA_WITH_AES_128_CBC_SHA256 [2024-10-30T22:45:47.541Z] --------------------------------------- [2024-10-30T22:45:47.541Z] Testing cipher suite TLS_RSA_WITH_AES_256_CBC_SHA [2024-10-30T22:45:47.541Z] --------------------------------------- [2024-10-30T22:45:47.541Z] Timeout signalled after 960 seconds [2024-10-30T22:45:47.541Z] ============================================= [2024-10-30T22:45:47.541Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 198 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 198 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Running delegated tasks... [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Running delegated tasks... [2024-10-30T22:45:47.541Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Running delegated tasks... [2024-10-30T22:45:47.541Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 196 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 196 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Running delegated tasks... [2024-10-30T22:45:47.541Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 9: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 10: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 10: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 11: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 11: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Running delegated tasks... [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 12: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 98 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 98 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 12: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Running delegated tasks... [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 13: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 13: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 14: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Client wrapped 69 bytes. [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] Server unwrapping 69 bytes... [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Handshake loop 14: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 15: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 15: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 16: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 16: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 17: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 17: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 18: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 18: round 2 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.541Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.541Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.541Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.541Z] ============================================ [2024-10-30T22:45:47.541Z] Handshake loop 19: round 1 [2024-10-30T22:45:47.541Z] ========================== [2024-10-30T22:45:47.541Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.541Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.541Z] Handshake loop 19: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 20: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 20: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 120 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 120 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 21: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 21: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 22: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 22: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 69 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 69 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 23: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.542Z] Handshake is completed [2024-10-30T22:45:47.542Z] Test Passed: TLS_RSA_WITH_AES_256_CBC_SHA [2024-10-30T22:45:47.542Z] --------------------------------------- [2024-10-30T22:45:47.542Z] Testing cipher suite TLS_RSA_WITH_AES_128_CBC_SHA [2024-10-30T22:45:47.542Z] --------------------------------------- [2024-10-30T22:45:47.542Z] ============================================= [2024-10-30T22:45:47.542Z] Starting handshake INITIAL_HANDSHAKE [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 1: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 198 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 198 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 1: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Running delegated tasks... [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 2: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 2: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 3: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Running delegated tasks... [2024-10-30T22:45:47.542Z] Handshake loop 3: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 4: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 4: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 5: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 5: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 6: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Running delegated tasks... [2024-10-30T22:45:47.542Z] Handshake loop 6: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 7: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 7: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 196 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 196 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 8: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Running delegated tasks... [2024-10-30T22:45:47.542Z] Handshake loop 8: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 9: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 9: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 10: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 10: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 11: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 11: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Running delegated tasks... [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 12: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 99 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 99 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_TASK Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 12: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_TASK [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Running delegated tasks... [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 13: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 6 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 6 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 13: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 14: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Client wrapped 69 bytes. [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] Server unwrapping 69 bytes... [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Handshake loop 14: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 15: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 15: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 16: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 16: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 17: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 17: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 18: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 18: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 19: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 19: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server wrapped 256 bytes. [2024-10-30T22:45:47.542Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.542Z] Client unwrapping 256 bytes... [2024-10-30T22:45:47.542Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.542Z] ============================================ [2024-10-30T22:45:47.542Z] Handshake loop 20: round 1 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.542Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.542Z] Handshake loop 20: round 2 [2024-10-30T22:45:47.542Z] ========================== [2024-10-30T22:45:47.542Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.543Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.543Z] Server wrapped 120 bytes. [2024-10-30T22:45:47.543Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.543Z] Client unwrapping 120 bytes... [2024-10-30T22:45:47.543Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.543Z] ============================================ [2024-10-30T22:45:47.543Z] Handshake loop 21: round 1 [2024-10-30T22:45:47.543Z] ========================== [2024-10-30T22:45:47.543Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.543Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.543Z] Handshake loop 21: round 2 [2024-10-30T22:45:47.543Z] ========================== [2024-10-30T22:45:47.543Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.543Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.543Z] Server wrapped 6 bytes. [2024-10-30T22:45:47.543Z] Server handshake status is NEED_WRAP Result is OK [2024-10-30T22:45:47.543Z] Client unwrapping 6 bytes... [2024-10-30T22:45:47.543Z] Client handshake status is NEED_UNWRAP Result is OK [2024-10-30T22:45:47.543Z] ============================================ [2024-10-30T22:45:47.543Z] Handshake loop 22: round 1 [2024-10-30T22:45:47.543Z] ========================== [2024-10-30T22:45:47.543Z] Client handshake (wrap) status NEED_UNWRAP [2024-10-30T22:45:47.543Z] Server handshake (unwrap) status NEED_WRAP [2024-10-30T22:45:47.543Z] Handshake loop 22: round 2 [2024-10-30T22:45:47.543Z] ========================== [2024-10-30T22:45:47.543Z] Server handshake (wrap) status NEED_WRAP [2024-10-30T22:45:47.543Z] Client handshake (unwrap) status NEED_UNWRAP [2024-10-30T22:45:47.543Z] Server wrapped 69 bytes. [2024-10-30T22:45:47.543Z] Server handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.543Z] Client unwrapping 69 bytes... [2024-10-30T22:45:47.543Z] Client handshake status is NOT_HANDSHAKING Result is OK [2024-10-30T22:45:47.543Z] ============================================ [2024-10-30T22:45:47.543Z] Handshake loop 23: round 1 [2024-10-30T22:45:47.543Z] ========================== [2024-10-30T22:45:47.543Z] Client handshake (wrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.543Z] Server handshake (unwrap) status NOT_HANDSHAKING [2024-10-30T22:45:47.543Z] Handshake is completed [2024-10-30T22:45:47.543Z] Test Passed: TLS_RSA_WITH_AES_128_CBC_SHA [2024-10-30T22:45:47.543Z] --------------------------------------- [2024-10-30T22:45:47.543Z] Testing cipher suite TLS_DH_anon_WITH_AES_256_GCM_SHA384 [2024-10-30T22:45:47.543Z] --------------------------------------- [2024-10-30T22:45:47.543Z] STDERR: [2024-10-30T22:45:47.543Z] rerun: [2024-10-30T22:45:47.543Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/scratch/0 && \ [2024-10-30T22:45:47.543Z] DISPLAY=:0 \ [2024-10-30T22:45:47.543Z] HOME=/home/jenkins \ [2024-10-30T22:45:47.543Z] LANG=C.utf8 \ [2024-10-30T22:45:47.543Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-10-30T22:45:47.543Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2024-10-30T22:45:47.543Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/java \ [2024-10-30T22:45:47.543Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-10-30T22:45:47.543Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-10-30T22:45:47.543Z] -Dtest.compiler.opts= \ [2024-10-30T22:45:47.543Z] -Dtest.java.opts= \ [2024-10-30T22:45:47.543Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-30T22:45:47.543Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-30T22:45:47.543Z] -Dtest.timeout.factor=8.0 \ [2024-10-30T22:45:47.543Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-30T22:45:47.543Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-10-30T22:45:47.543Z] -Dtest.name=javax/net/ssl/TLS/TLSMFLNTest.java \ [2024-10-30T22:45:47.543Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS/TLSMFLNTest.java \ [2024-10-30T22:45:47.543Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS \ [2024-10-30T22:45:47.543Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-30T22:45:47.543Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d \ [2024-10-30T22:45:47.543Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-30T22:45:47.543Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLS/TLSMFLNTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/javax/net/ssl/TLS:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/krb5/auto:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/javax/net/ssl/TLSCommon:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-30T22:45:47.543Z] -Dtest.modules='java.security.jgss jdk.security.auth java.security.jgss/sun.security.jgss.krb5 java.security.jgss/sun.security.krb5:+open java.security.jgss/sun.security.krb5.internal:+open java.security.jgss/sun.security.krb5.internal.ccache java.security.jgss/sun.security.krb5.internal.crypto java.security.jgss/sun.security.krb5.internal.ktab java.base/sun.security.util' \ [2024-10-30T22:45:47.543Z] --add-modules java.security.jgss,jdk.security.auth,java.base \ [2024-10-30T22:45:47.543Z] --add-exports java.security.jgss/sun.security.jgss.krb5=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-exports java.security.jgss/sun.security.krb5=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-opens java.security.jgss/sun.security.krb5=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-exports java.security.jgss/sun.security.krb5.internal=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-opens java.security.jgss/sun.security.krb5.internal=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-exports java.security.jgss/sun.security.krb5.internal.ccache=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-exports java.security.jgss/sun.security.krb5.internal.crypto=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-exports java.security.jgss/sun.security.krb5.internal.ktab=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] --add-exports java.base/sun.security.util=ALL-UNNAMED \ [2024-10-30T22:45:47.543Z] -ea \ [2024-10-30T22:45:47.543Z] -esa \ [2024-10-30T22:45:47.543Z] -Xmx512m \ [2024-10-30T22:45:47.543Z] -XX:+UseCompressedOops \ [2024-10-30T22:45:47.543Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-30T22:45:47.543Z] -Dtest.security.protocol=TLS \ [2024-10-30T22:45:47.543Z] -Dtest.mode=norm \ [2024-10-30T22:45:47.543Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/javax/net/ssl/TLS/TLSMFLNTest.d/main.0.jta [2024-10-30T22:45:47.543Z] [2024-10-30T22:45:47.543Z] TEST RESULT: Error. Program `/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/java' timed out (timeout set to 960000ms, elapsed time including timeout handling was 965230ms). [2024-10-30T22:45:47.543Z] -------------------------------------------------- [2024-10-31T00:02:54.298Z] TEST: sun/security/ec/ed/EdDSATest.java [2024-10-31T00:02:54.298Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] ACTION: build -- Passed. All files up to date [2024-10-31T00:02:54.298Z] REASON: User specified action: run build jdk.test.lib.Convert [2024-10-31T00:02:54.298Z] TIME: 0.0 seconds [2024-10-31T00:02:54.298Z] messages: [2024-10-31T00:02:54.298Z] command: build jdk.test.lib.Convert [2024-10-31T00:02:54.298Z] reason: User specified action: run build jdk.test.lib.Convert [2024-10-31T00:02:54.298Z] started: Wed Oct 30 23:46:40 UTC 2024 [2024-10-31T00:02:54.298Z] finished: Wed Oct 30 23:46:40 UTC 2024 [2024-10-31T00:02:54.298Z] elapsed time (seconds): 0.0 [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] ACTION: build -- Passed. Build successful [2024-10-31T00:02:54.298Z] REASON: Named class compiled on demand [2024-10-31T00:02:54.298Z] TIME: 0.988 seconds [2024-10-31T00:02:54.298Z] messages: [2024-10-31T00:02:54.298Z] command: build EdDSATest [2024-10-31T00:02:54.298Z] reason: Named class compiled on demand [2024-10-31T00:02:54.298Z] started: Wed Oct 30 23:46:40 UTC 2024 [2024-10-31T00:02:54.298Z] Test directory: [2024-10-31T00:02:54.298Z] compile: EdDSATest [2024-10-31T00:02:54.298Z] finished: Wed Oct 30 23:46:41 UTC 2024 [2024-10-31T00:02:54.298Z] elapsed time (seconds): 0.988 [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] ACTION: compile -- Passed. Compilation successful [2024-10-31T00:02:54.298Z] REASON: .class file out of date or does not exist [2024-10-31T00:02:54.298Z] TIME: 0.958 seconds [2024-10-31T00:02:54.298Z] messages: [2024-10-31T00:02:54.298Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed/EdDSATest.java [2024-10-31T00:02:54.298Z] reason: .class file out of date or does not exist [2024-10-31T00:02:54.298Z] started: Wed Oct 30 23:46:40 UTC 2024 [2024-10-31T00:02:54.298Z] Mode: agentvm [2024-10-31T00:02:54.298Z] Agent id: 3 [2024-10-31T00:02:54.298Z] finished: Wed Oct 30 23:46:41 UTC 2024 [2024-10-31T00:02:54.298Z] elapsed time (seconds): 0.958 [2024-10-31T00:02:54.298Z] configuration: [2024-10-31T00:02:54.298Z] Boot Layer (javac runtime environment) [2024-10-31T00:02:54.298Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-10-31T00:02:54.298Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-10-31T00:02:54.298Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/patches/java.base [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] javac compilation environment [2024-10-31T00:02:54.298Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed [2024-10-31T00:02:54.298Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-10-31T00:02:54.298Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed [2024-10-31T00:02:54.298Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d [2024-10-31T00:02:54.298Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] rerun: [2024-10-31T00:02:54.298Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/scratch/0 && \ [2024-10-31T00:02:54.298Z] DISPLAY=:0 \ [2024-10-31T00:02:54.298Z] HOME=/home/jenkins \ [2024-10-31T00:02:54.298Z] LANG=C.utf8 \ [2024-10-31T00:02:54.298Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-10-31T00:02:54.298Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/javac \ [2024-10-31T00:02:54.298Z] -J-ea \ [2024-10-31T00:02:54.298Z] -J-esa \ [2024-10-31T00:02:54.298Z] -J-Xmx512m \ [2024-10-31T00:02:54.298Z] -J-XX:+UseCompressedOops \ [2024-10-31T00:02:54.298Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-10-31T00:02:54.298Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-10-31T00:02:54.298Z] -J-Dtest.compiler.opts= \ [2024-10-31T00:02:54.298Z] -J-Dtest.java.opts= \ [2024-10-31T00:02:54.298Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T00:02:54.298Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T00:02:54.298Z] -J-Dtest.timeout.factor=8.0 \ [2024-10-31T00:02:54.298Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-31T00:02:54.298Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-10-31T00:02:54.298Z] -J-Dtest.name=sun/security/ec/ed/EdDSATest.java \ [2024-10-31T00:02:54.298Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed/EdDSATest.java \ [2024-10-31T00:02:54.298Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed \ [2024-10-31T00:02:54.298Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-31T00:02:54.298Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d \ [2024-10-31T00:02:54.298Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T00:02:54.298Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T00:02:54.298Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d \ [2024-10-31T00:02:54.298Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-31T00:02:54.298Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed/EdDSATest.java [2024-10-31T00:02:54.298Z] direct: [2024-10-31T00:02:54.298Z] Note: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed/EdDSATest.java uses unchecked or unsafe operations. [2024-10-31T00:02:54.298Z] Note: Recompile with -Xlint:unchecked for details. [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] ACTION: main -- Error. Agent error: java.lang.Exception: Agent 22 timed out with a timeout of 960 seconds; check console log for any additional details [2024-10-31T00:02:54.298Z] REASON: User specified action: run main EdDSATest [2024-10-31T00:02:54.298Z] TIME: 965.33 seconds [2024-10-31T00:02:54.298Z] messages: [2024-10-31T00:02:54.298Z] command: main EdDSATest [2024-10-31T00:02:54.298Z] reason: User specified action: run main EdDSATest [2024-10-31T00:02:54.298Z] started: Wed Oct 30 23:46:41 UTC 2024 [2024-10-31T00:02:54.298Z] Mode: agentvm [2024-10-31T00:02:54.298Z] Agent id: 22 [2024-10-31T00:02:54.298Z] Timeout signalled after 960 seconds [2024-10-31T00:02:54.298Z] Timeout information: [2024-10-31T00:02:54.298Z] Running jstack on process 3454458 [2024-10-31T00:02:54.298Z] 2024-10-31 00:02:46 [2024-10-31T00:02:54.298Z] Full thread dump OpenJDK 64-Bit Server VM (21.0.6-beta+1-ea mixed mode): [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] Threads class SMR info: [2024-10-31T00:02:54.298Z] _java_thread_list=0x00007766e4001ee0, length=13, elements={ [2024-10-31T00:02:54.298Z] 0x000077673c02b650, 0x000077673c1959c0, 0x000077673c196f40, 0x000077673c1a8820, [2024-10-31T00:02:54.298Z] 0x000077673c1a9e50, 0x000077673c1ab3e0, 0x000077673c1acf10, 0x000077673c1ae570, [2024-10-31T00:02:54.298Z] 0x000077673c0d74a0, 0x000077673c25dbd0, 0x000077673c31b5f0, 0x000077673c32d910, [2024-10-31T00:02:54.298Z] 0x00007766e4000e70 [2024-10-31T00:02:54.298Z] } [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "main" #1 [3454461] prio=5 os_prio=0 cpu=529.00ms elapsed=980.43s tid=0x000077673c02b650 nid=3454461 in Object.wait() [0x0000776744f49000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: WAITING (on object monitor) [2024-10-31T00:02:54.298Z] at java.lang.Object.wait0(java.base@21.0.6-beta/Native Method) [2024-10-31T00:02:54.298Z] - waiting on <0x00000000e014a000> (a java.lang.Thread) [2024-10-31T00:02:54.298Z] at java.lang.Object.wait(java.base@21.0.6-beta/Object.java:366) [2024-10-31T00:02:54.298Z] at java.lang.Thread.join(java.base@21.0.6-beta/Thread.java:2079) [2024-10-31T00:02:54.298Z] - locked <0x00000000e014a000> (a java.lang.Thread) [2024-10-31T00:02:54.298Z] at java.lang.Thread.join(java.base@21.0.6-beta/Thread.java:2155) [2024-10-31T00:02:54.298Z] at com.sun.javatest.regtest.agent.MainActionHelper.runClass(MainActionHelper.java:219) [2024-10-31T00:02:54.298Z] at com.sun.javatest.regtest.agent.AgentServer.doMain(AgentServer.java:317) [2024-10-31T00:02:54.298Z] at com.sun.javatest.regtest.agent.AgentServer.run(AgentServer.java:242) [2024-10-31T00:02:54.298Z] at com.sun.javatest.regtest.agent.AgentServer.main(AgentServer.java:71) [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Reference Handler" #9 [3454469] daemon prio=10 os_prio=0 cpu=1.26ms elapsed=979.14s tid=0x000077673c1959c0 nid=3454469 waiting on condition [0x0000776740523000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.298Z] at java.lang.ref.Reference.waitForReferencePendingList(java.base@21.0.6-beta/Native Method) [2024-10-31T00:02:54.298Z] at java.lang.ref.Reference.processPendingReferences(java.base@21.0.6-beta/Reference.java:246) [2024-10-31T00:02:54.298Z] at java.lang.ref.Reference$ReferenceHandler.run(java.base@21.0.6-beta/Reference.java:208) [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Finalizer" #10 [3454470] daemon prio=8 os_prio=0 cpu=0.37ms elapsed=979.11s tid=0x000077673c196f40 nid=3454470 in Object.wait() [0x0000776740422000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: WAITING (on object monitor) [2024-10-31T00:02:54.298Z] at java.lang.Object.wait0(java.base@21.0.6-beta/Native Method) [2024-10-31T00:02:54.298Z] - waiting on <0x00000000e014a9e8> (a java.lang.ref.NativeReferenceQueue$Lock) [2024-10-31T00:02:54.298Z] at java.lang.Object.wait(java.base@21.0.6-beta/Object.java:366) [2024-10-31T00:02:54.298Z] at java.lang.Object.wait(java.base@21.0.6-beta/Object.java:339) [2024-10-31T00:02:54.298Z] at java.lang.ref.NativeReferenceQueue.await(java.base@21.0.6-beta/NativeReferenceQueue.java:48) [2024-10-31T00:02:54.298Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.6-beta/ReferenceQueue.java:158) [2024-10-31T00:02:54.298Z] at java.lang.ref.NativeReferenceQueue.remove(java.base@21.0.6-beta/NativeReferenceQueue.java:89) [2024-10-31T00:02:54.298Z] - locked <0x00000000e014a9e8> (a java.lang.ref.NativeReferenceQueue$Lock) [2024-10-31T00:02:54.298Z] at java.lang.ref.Finalizer$FinalizerThread.run(java.base@21.0.6-beta/Finalizer.java:173) [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Signal Dispatcher" #11 [3454471] daemon prio=9 os_prio=0 cpu=0.44ms elapsed=979.09s tid=0x000077673c1a8820 nid=3454471 waiting on condition [0x0000000000000000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Service Thread" #12 [3454472] daemon prio=9 os_prio=0 cpu=1.72ms elapsed=979.08s tid=0x000077673c1a9e50 nid=3454472 runnable [0x0000000000000000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Monitor Deflation Thread" #13 [3454473] daemon prio=9 os_prio=0 cpu=69.69ms elapsed=979.02s tid=0x000077673c1ab3e0 nid=3454473 runnable [0x0000000000000000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "C2 CompilerThread0" #14 [3454474] daemon prio=9 os_prio=0 cpu=9169.21ms elapsed=979.01s tid=0x000077673c1acf10 nid=3454474 waiting on condition [0x0000000000000000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.298Z] No compile task [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "C1 CompilerThread0" #16 [3454475] daemon prio=9 os_prio=0 cpu=891.33ms elapsed=979.00s tid=0x000077673c1ae570 nid=3454475 waiting on condition [0x0000000000000000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.298Z] No compile task [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Common-Cleaner" #17 [3454478] daemon prio=8 os_prio=0 cpu=2.85ms elapsed=978.18s tid=0x000077673c0d74a0 nid=3454478 waiting on condition [0x000077672452c000] [2024-10-31T00:02:54.298Z] java.lang.Thread.State: TIMED_WAITING (parking) [2024-10-31T00:02:54.298Z] at jdk.internal.misc.Unsafe.park(java.base@21.0.6-beta/Native Method) [2024-10-31T00:02:54.298Z] - parking to wait for <0x00000000e014b0e0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2024-10-31T00:02:54.298Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.6-beta/LockSupport.java:269) [2024-10-31T00:02:54.298Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(java.base@21.0.6-beta/AbstractQueuedSynchronizer.java:1852) [2024-10-31T00:02:54.298Z] at java.lang.ref.ReferenceQueue.await(java.base@21.0.6-beta/ReferenceQueue.java:71) [2024-10-31T00:02:54.298Z] at java.lang.ref.ReferenceQueue.remove0(java.base@21.0.6-beta/ReferenceQueue.java:143) [2024-10-31T00:02:54.298Z] at java.lang.ref.ReferenceQueue.remove(java.base@21.0.6-beta/ReferenceQueue.java:218) [2024-10-31T00:02:54.298Z] at jdk.internal.ref.CleanerImpl.run(java.base@21.0.6-beta/CleanerImpl.java:140) [2024-10-31T00:02:54.298Z] at java.lang.Thread.runWith(java.base@21.0.6-beta/Thread.java:1596) [2024-10-31T00:02:54.298Z] at java.lang.Thread.run(java.base@21.0.6-beta/Thread.java:1583) [2024-10-31T00:02:54.298Z] at jdk.internal.misc.InnocuousThread.run(java.base@21.0.6-beta/InnocuousThread.java:186) [2024-10-31T00:02:54.298Z] [2024-10-31T00:02:54.298Z] "Notification Thread" #18 [3454479] daemon prio=9 os_prio=0 cpu=0.13ms elapsed=976.25s tid=0x000077673c25dbd0 nid=3454479 runnable [0x0000000000000000] [2024-10-31T00:02:54.299Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "pool-1-thread-1" #19 [3454484] daemon prio=5 os_prio=0 cpu=6.06ms elapsed=972.35s tid=0x000077673c31b5f0 nid=3454484 waiting on condition [0x000077672432a000] [2024-10-31T00:02:54.299Z] java.lang.Thread.State: TIMED_WAITING (parking) [2024-10-31T00:02:54.299Z] at jdk.internal.misc.Unsafe.park(java.base@21.0.6-beta/Native Method) [2024-10-31T00:02:54.299Z] - parking to wait for <0x00000000e0289d20> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject) [2024-10-31T00:02:54.299Z] at java.util.concurrent.locks.LockSupport.parkNanos(java.base@21.0.6-beta/LockSupport.java:269) [2024-10-31T00:02:54.299Z] at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@21.0.6-beta/AbstractQueuedSynchronizer.java:1763) [2024-10-31T00:02:54.299Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@21.0.6-beta/ScheduledThreadPoolExecutor.java:1182) [2024-10-31T00:02:54.299Z] at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@21.0.6-beta/ScheduledThreadPoolExecutor.java:899) [2024-10-31T00:02:54.299Z] at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@21.0.6-beta/ThreadPoolExecutor.java:1070) [2024-10-31T00:02:54.299Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@21.0.6-beta/ThreadPoolExecutor.java:1130) [2024-10-31T00:02:54.299Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@21.0.6-beta/ThreadPoolExecutor.java:642) [2024-10-31T00:02:54.299Z] at java.lang.Thread.runWith(java.base@21.0.6-beta/Thread.java:1596) [2024-10-31T00:02:54.299Z] at java.lang.Thread.run(java.base@21.0.6-beta/Thread.java:1583) [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "AgentVMThread" #21 [3454495] prio=5 os_prio=0 cpu=56657.95ms elapsed=964.48s tid=0x000077673c32d910 nid=3454495 runnable [0x0000776724127000] [2024-10-31T00:02:54.299Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.299Z] at sun.security.util.math.intpoly.IntegerPolynomial448.carryReduce(java.base@21.0.6-beta/IntegerPolynomial448.java:102) [2024-10-31T00:02:54.299Z] at sun.security.util.math.intpoly.IntegerPolynomial448.mult(java.base@21.0.6-beta/IntegerPolynomial448.java:329) [2024-10-31T00:02:54.299Z] at sun.security.util.math.intpoly.IntegerPolynomial$MutableElement.setProduct(java.base@21.0.6-beta/IntegerPolynomial.java:747) [2024-10-31T00:02:54.299Z] at sun.security.util.math.intpoly.IntegerPolynomial$MutableElement.setProduct(java.base@21.0.6-beta/IntegerPolynomial.java:668) [2024-10-31T00:02:54.299Z] at sun.security.ec.ed.Ed448Operations.setDouble(jdk.crypto.ec@21.0.6-beta/Ed448Operations.java:197) [2024-10-31T00:02:54.299Z] at sun.security.ec.ed.Ed448Operations.setDouble(jdk.crypto.ec@21.0.6-beta/Ed448Operations.java:93) [2024-10-31T00:02:54.299Z] at sun.security.ec.ed.EdECOperations.setProduct(jdk.crypto.ec@21.0.6-beta/EdECOperations.java:78) [2024-10-31T00:02:54.299Z] at sun.security.ec.ed.EdDSAOperations.verify(jdk.crypto.ec@21.0.6-beta/EdDSAOperations.java:165) [2024-10-31T00:02:54.299Z] at sun.security.ec.ed.EdDSASignature.engineVerify(jdk.crypto.ec@21.0.6-beta/EdDSASignature.java:214) [2024-10-31T00:02:54.299Z] at java.security.Signature$Delegate.engineVerify(java.base@21.0.6-beta/Signature.java:1422) [2024-10-31T00:02:54.299Z] at java.security.Signature.verify(java.base@21.0.6-beta/Signature.java:790) [2024-10-31T00:02:54.299Z] at EdDSATest.signAndVerify(EdDSATest.java:251) [2024-10-31T00:02:54.299Z] at EdDSATest.testSignature(EdDSATest.java:206) [2024-10-31T00:02:54.299Z] at EdDSATest.test(EdDSATest.java:123) [2024-10-31T00:02:54.299Z] at EdDSATest.main(EdDSATest.java:91) [2024-10-31T00:02:54.299Z] at java.lang.invoke.LambdaForm$DMH/0x00000001000c0000.invokeStatic(java.base@21.0.6-beta/LambdaForm$DMH) [2024-10-31T00:02:54.299Z] at java.lang.invoke.LambdaForm$MH/0x0000000100101c00.invoke(java.base@21.0.6-beta/LambdaForm$MH) [2024-10-31T00:02:54.299Z] at java.lang.invoke.Invokers$Holder.invokeExact_MT(java.base@21.0.6-beta/Invokers$Holder) [2024-10-31T00:02:54.299Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invokeImpl(java.base@21.0.6-beta/DirectMethodHandleAccessor.java:154) [2024-10-31T00:02:54.299Z] at jdk.internal.reflect.DirectMethodHandleAccessor.invoke(java.base@21.0.6-beta/DirectMethodHandleAccessor.java:103) [2024-10-31T00:02:54.299Z] at java.lang.reflect.Method.invoke(java.base@21.0.6-beta/Method.java:580) [2024-10-31T00:02:54.299Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2024-10-31T00:02:54.299Z] at java.lang.Thread.runWith(java.base@21.0.6-beta/Thread.java:1596) [2024-10-31T00:02:54.299Z] at java.lang.Thread.run(java.base@21.0.6-beta/Thread.java:1583) [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "Attach Listener" #25 [3456075] daemon prio=9 os_prio=0 cpu=0.38ms elapsed=0.13s tid=0x00007766e4000e70 nid=3456075 waiting on condition [0x0000000000000000] [2024-10-31T00:02:54.299Z] java.lang.Thread.State: RUNNABLE [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "GC Thread#3" os_prio=0 cpu=13.02ms elapsed=958.75s tid=0x00007766f8007fa0 nid=3454505 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "GC Thread#2" os_prio=0 cpu=22.07ms elapsed=958.75s tid=0x00007766f8007490 nid=3454504 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "GC Thread#1" os_prio=0 cpu=21.11ms elapsed=958.77s tid=0x00007766f8006980 nid=3454503 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "VM Thread" os_prio=0 cpu=46.14ms elapsed=979.50s tid=0x000077673c134210 nid=3454468 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "VM Periodic Task Thread" os_prio=0 cpu=386.78ms elapsed=980.03s tid=0x000077673c0d5fd0 nid=3454467 waiting on condition [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "G1 Service" os_prio=0 cpu=24.16ms elapsed=980.08s tid=0x000077673c0c7700 nid=3454466 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "G1 Refine#0" os_prio=0 cpu=207.64ms elapsed=980.10s tid=0x000077673c0c6750 nid=3454465 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "G1 Conc#0" os_prio=0 cpu=0.06ms elapsed=980.13s tid=0x000077673c05daf0 nid=3454464 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "G1 Main Marker" os_prio=0 cpu=0.10ms elapsed=980.21s tid=0x000077673c05cb50 nid=3454463 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] "GC Thread#0" os_prio=0 cpu=16.63ms elapsed=980.21s tid=0x000077673c057560 nid=3454462 runnable [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] JNI global refs: 17, weak refs: 0 [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] --- Timeout information end. [2024-10-31T00:02:54.299Z] finished: Thu Oct 31 00:02:47 UTC 2024 [2024-10-31T00:02:54.299Z] elapsed time (seconds): 965.33 [2024-10-31T00:02:54.299Z] configuration: [2024-10-31T00:02:54.299Z] Boot Layer [2024-10-31T00:02:54.299Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2024-10-31T00:02:54.299Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/patches/java.base [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] Test Layer [2024-10-31T00:02:54.299Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] rerun: [2024-10-31T00:02:54.299Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/scratch/0 && \ [2024-10-31T00:02:54.299Z] DISPLAY=:0 \ [2024-10-31T00:02:54.299Z] HOME=/home/jenkins \ [2024-10-31T00:02:54.299Z] LANG=C.utf8 \ [2024-10-31T00:02:54.299Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-10-31T00:02:54.299Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/java \ [2024-10-31T00:02:54.299Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-10-31T00:02:54.299Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-10-31T00:02:54.299Z] -Dtest.compiler.opts= \ [2024-10-31T00:02:54.299Z] -Dtest.java.opts= \ [2024-10-31T00:02:54.299Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T00:02:54.299Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T00:02:54.299Z] -Dtest.timeout.factor=8.0 \ [2024-10-31T00:02:54.299Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-31T00:02:54.299Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-10-31T00:02:54.299Z] -Dtest.name=sun/security/ec/ed/EdDSATest.java \ [2024-10-31T00:02:54.299Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed/EdDSATest.java \ [2024-10-31T00:02:54.299Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed \ [2024-10-31T00:02:54.299Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-31T00:02:54.299Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d \ [2024-10-31T00:02:54.299Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T00:02:54.299Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T00:02:54.299Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ec/ed/EdDSATest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ec/ed:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2024-10-31T00:02:54.299Z] EdDSATest [2024-10-31T00:02:54.299Z] STDOUT: [2024-10-31T00:02:54.299Z] Case Algo:EdDSA, Param:null, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed25519, Param:null, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed448, Param:null, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:EdDSA, Param:Ed25519, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed25519, Param:Ed25519, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:1.3.101.112, Param:Ed25519, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:OID.1.3.101.112, Param:Ed25519, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed448, Param:Ed448, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:1.3.101.113, Param:Ed448, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:OID.1.3.101.113, Param:Ed448, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:EdDSA, Param:255, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed25519, Param:255, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:1.3.101.112, Param:255, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:OID.1.3.101.112, Param:255, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed448, Param:448, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:1.3.101.113, Param:448, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:OID.1.3.101.113, Param:448, Intitiate with random:true [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:EdDSA, Param:null, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed25519, Param:null, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed448, Param:null, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:EdDSA, Param:Ed25519, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed25519, Param:Ed25519, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:1.3.101.112, Param:Ed25519, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:OID.1.3.101.112, Param:Ed25519, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:Ed448, Param:Ed448, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:1.3.101.113, Param:Ed448, Intitiate with random:false [2024-10-31T00:02:54.299Z] Passed. [2024-10-31T00:02:54.299Z] Case Algo:OID.1.3.101.113, Param:Ed448, Intitiate with random:false [2024-10-31T00:02:54.299Z] [2024-10-31T00:02:54.299Z] TEST RESULT: Error. Agent error: java.lang.Exception: Agent 22 timed out with a timeout of 960 seconds; check console log for any additional details [2024-10-31T00:02:54.299Z] -------------------------------------------------- [2024-10-31T01:11:15.347Z] TEST: sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java [2024-10-31T01:11:15.347Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. [2024-10-31T01:11:15.347Z] [2024-10-31T01:11:15.347Z] ACTION: build -- Passed. Build successful [2024-10-31T01:11:15.347Z] REASON: Named class compiled on demand [2024-10-31T01:11:15.347Z] TIME: 1.74 seconds [2024-10-31T01:11:15.347Z] messages: [2024-10-31T01:11:15.347Z] command: build Symantec [2024-10-31T01:11:15.347Z] reason: Named class compiled on demand [2024-10-31T01:11:15.347Z] started: Thu Oct 31 01:11:00 UTC 2024 [2024-10-31T01:11:15.347Z] Test directory: [2024-10-31T01:11:15.347Z] compile: Symantec [2024-10-31T01:11:15.347Z] finished: Thu Oct 31 01:11:02 UTC 2024 [2024-10-31T01:11:15.347Z] elapsed time (seconds): 1.74 [2024-10-31T01:11:15.347Z] [2024-10-31T01:11:15.347Z] ACTION: compile -- Passed. Compilation successful [2024-10-31T01:11:15.347Z] REASON: .class file out of date or does not exist [2024-10-31T01:11:15.347Z] TIME: 1.724 seconds [2024-10-31T01:11:15.347Z] messages: [2024-10-31T01:11:15.347Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java [2024-10-31T01:11:15.347Z] reason: .class file out of date or does not exist [2024-10-31T01:11:15.347Z] started: Thu Oct 31 01:11:00 UTC 2024 [2024-10-31T01:11:15.348Z] Additional options from @modules: --add-modules java.base --add-exports java.base/sun.security.validator=ALL-UNNAMED [2024-10-31T01:11:15.348Z] Mode: agentvm [2024-10-31T01:11:15.348Z] Agent id: 3 [2024-10-31T01:11:15.348Z] finished: Thu Oct 31 01:11:02 UTC 2024 [2024-10-31T01:11:15.348Z] elapsed time (seconds): 1.724 [2024-10-31T01:11:15.348Z] configuration: [2024-10-31T01:11:15.348Z] Boot Layer (javac runtime environment) [2024-10-31T01:11:15.348Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-10-31T01:11:15.348Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-10-31T01:11:15.348Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/patches/java.base [2024-10-31T01:11:15.348Z] [2024-10-31T01:11:15.348Z] javac compilation environment [2024-10-31T01:11:15.348Z] add modules: java.base [2024-10-31T01:11:15.348Z] add exports: java.base/sun.security.validator ALL-UNNAMED [2024-10-31T01:11:15.348Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust [2024-10-31T01:11:15.348Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-10-31T01:11:15.348Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust [2024-10-31T01:11:15.348Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d [2024-10-31T01:11:15.348Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib [2024-10-31T01:11:15.348Z] [2024-10-31T01:11:15.348Z] rerun: [2024-10-31T01:11:15.348Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/scratch/0 && \ [2024-10-31T01:11:15.348Z] DISPLAY=:0 \ [2024-10-31T01:11:15.348Z] HOME=/home/jenkins \ [2024-10-31T01:11:15.348Z] LANG=C.utf8 \ [2024-10-31T01:11:15.348Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-10-31T01:11:15.348Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/javac \ [2024-10-31T01:11:15.348Z] -J-ea \ [2024-10-31T01:11:15.348Z] -J-esa \ [2024-10-31T01:11:15.348Z] -J-Xmx512m \ [2024-10-31T01:11:15.348Z] -J-XX:+UseCompressedOops \ [2024-10-31T01:11:15.348Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-10-31T01:11:15.348Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-10-31T01:11:15.348Z] -J-Dtest.compiler.opts= \ [2024-10-31T01:11:15.348Z] -J-Dtest.java.opts= \ [2024-10-31T01:11:15.348Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T01:11:15.348Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T01:11:15.348Z] -J-Dtest.timeout.factor=8.0 \ [2024-10-31T01:11:15.348Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-31T01:11:15.348Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-10-31T01:11:15.348Z] -J-Dtest.name=sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java \ [2024-10-31T01:11:15.348Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java \ [2024-10-31T01:11:15.348Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust \ [2024-10-31T01:11:15.348Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-31T01:11:15.348Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d \ [2024-10-31T01:11:15.348Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T01:11:15.348Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T01:11:15.348Z] -J-Dtest.modules=java.base/sun.security.validator \ [2024-10-31T01:11:15.348Z] --add-modules java.base \ [2024-10-31T01:11:15.348Z] --add-exports java.base/sun.security.validator=ALL-UNNAMED \ [2024-10-31T01:11:15.348Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d \ [2024-10-31T01:11:15.348Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-31T01:11:15.348Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java [2024-10-31T01:11:15.348Z] direct: [2024-10-31T01:11:15.348Z] Note: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust/Distrust.java uses or overrides a deprecated API. [2024-10-31T01:11:15.348Z] Note: Recompile with -Xlint:deprecation for details. [2024-10-31T01:11:15.348Z] Note: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust/Distrust.java uses unchecked or unsafe operations. [2024-10-31T01:11:15.348Z] Note: Recompile with -Xlint:unchecked for details. [2024-10-31T01:11:15.348Z] [2024-10-31T01:11:15.348Z] ACTION: main -- Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Unexpected exception: sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.348Z] REASON: User specified action: run main/othervm Symantec after policyOn invalid [2024-10-31T01:11:15.348Z] TIME: 7.783 seconds [2024-10-31T01:11:15.348Z] messages: [2024-10-31T01:11:15.348Z] command: main Symantec after policyOn invalid [2024-10-31T01:11:15.348Z] reason: User specified action: run main/othervm Symantec after policyOn invalid [2024-10-31T01:11:15.348Z] started: Thu Oct 31 01:11:02 UTC 2024 [2024-10-31T01:11:15.348Z] Mode: othervm [/othervm specified] [2024-10-31T01:11:15.348Z] Additional options from @modules: --add-modules java.base --add-exports java.base/sun.security.validator=ALL-UNNAMED [2024-10-31T01:11:15.348Z] finished: Thu Oct 31 01:11:10 UTC 2024 [2024-10-31T01:11:15.349Z] elapsed time (seconds): 7.783 [2024-10-31T01:11:15.349Z] configuration: [2024-10-31T01:11:15.349Z] Boot Layer [2024-10-31T01:11:15.349Z] add modules: java.base [2024-10-31T01:11:15.349Z] add exports: java.base/sun.security.validator ALL-UNNAMED [2024-10-31T01:11:15.349Z] [2024-10-31T01:11:15.349Z] STDOUT: [2024-10-31T01:11:15.349Z] STDERR: [2024-10-31T01:11:15.349Z] Testing geotrustprimarycag2 [2024-10-31T01:11:15.349Z] sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.349Z] at java.base/sun.security.validator.PKIXValidator.doBuild(PKIXValidator.java:388) [2024-10-31T01:11:15.349Z] at java.base/sun.security.validator.PKIXValidator.engineValidate(PKIXValidator.java:271) [2024-10-31T01:11:15.349Z] at java.base/sun.security.validator.Validator.validate(Validator.java:256) [2024-10-31T01:11:15.349Z] at java.base/sun.security.ssl.X509TrustManagerImpl.checkTrusted(X509TrustManagerImpl.java:241) [2024-10-31T01:11:15.349Z] at java.base/sun.security.ssl.X509TrustManagerImpl.checkServerTrusted(X509TrustManagerImpl.java:113) [2024-10-31T01:11:15.349Z] at Distrust.testTM(Distrust.java:125) [2024-10-31T01:11:15.349Z] at Distrust.testCertificateChain(Distrust.java:82) [2024-10-31T01:11:15.349Z] at Symantec.main(Symantec.java:77) [2024-10-31T01:11:15.349Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2024-10-31T01:11:15.349Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2024-10-31T01:11:15.349Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2024-10-31T01:11:15.349Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2024-10-31T01:11:15.349Z] Caused by: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.349Z] at java.base/sun.security.provider.certpath.SunCertPathBuilder.build(SunCertPathBuilder.java:148) [2024-10-31T01:11:15.349Z] at java.base/sun.security.provider.certpath.SunCertPathBuilder.engineBuild(SunCertPathBuilder.java:129) [2024-10-31T01:11:15.349Z] at java.base/java.security.cert.CertPathBuilder.build(CertPathBuilder.java:297) [2024-10-31T01:11:15.349Z] at java.base/sun.security.validator.PKIXValidator.doBuild(PKIXValidator.java:383) [2024-10-31T01:11:15.349Z] ... 11 more [2024-10-31T01:11:15.349Z] java.lang.RuntimeException: Unexpected exception: sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.349Z] at Distrust.testTM(Distrust.java:138) [2024-10-31T01:11:15.349Z] at Distrust.testCertificateChain(Distrust.java:82) [2024-10-31T01:11:15.349Z] at Symantec.main(Symantec.java:77) [2024-10-31T01:11:15.349Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2024-10-31T01:11:15.349Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2024-10-31T01:11:15.349Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2024-10-31T01:11:15.349Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2024-10-31T01:11:15.349Z] [2024-10-31T01:11:15.349Z] JavaTest Message: Test threw exception: java.lang.RuntimeException: Unexpected exception: sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.349Z] JavaTest Message: shutting down test [2024-10-31T01:11:15.349Z] [2024-10-31T01:11:15.349Z] STATUS:Failed.`main' threw exception: java.lang.RuntimeException: Unexpected exception: sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.349Z] rerun: [2024-10-31T01:11:15.349Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/scratch/0 && \ [2024-10-31T01:11:15.349Z] DISPLAY=:0 \ [2024-10-31T01:11:15.349Z] HOME=/home/jenkins \ [2024-10-31T01:11:15.349Z] LANG=C.utf8 \ [2024-10-31T01:11:15.349Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-10-31T01:11:15.349Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2024-10-31T01:11:15.349Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/../bin/java \ [2024-10-31T01:11:15.349Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-10-31T01:11:15.349Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-10-31T01:11:15.349Z] -Dtest.compiler.opts= \ [2024-10-31T01:11:15.349Z] -Dtest.java.opts= \ [2024-10-31T01:11:15.349Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T01:11:15.349Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/j2sdk-image/jdk-21.0.6+1/bin/.. \ [2024-10-31T01:11:15.349Z] -Dtest.timeout.factor=8.0 \ [2024-10-31T01:11:15.349Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-31T01:11:15.349Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-10-31T01:11:15.349Z] -Dtest.name=sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java \ [2024-10-31T01:11:15.349Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.java \ [2024-10-31T01:11:15.349Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust \ [2024-10-31T01:11:15.349Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-10-31T01:11:15.349Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d \ [2024-10-31T01:11:15.349Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T01:11:15.349Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/openjdk/openjdk-jdk/test/jdk/sun/security/ssl/X509TrustManagerImpl/distrust:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/classes/1/test/lib \ [2024-10-31T01:11:15.349Z] -Dtest.modules=java.base/sun.security.validator \ [2024-10-31T01:11:15.349Z] --add-modules java.base \ [2024-10-31T01:11:15.349Z] --add-exports java.base/sun.security.validator=ALL-UNNAMED \ [2024-10-31T01:11:15.349Z] -ea \ [2024-10-31T01:11:15.349Z] -esa \ [2024-10-31T01:11:15.349Z] -Xmx512m \ [2024-10-31T01:11:15.349Z] -XX:+UseCompressedOops \ [2024-10-31T01:11:15.349Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-10-31T01:11:15.349Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work/sun/security/ssl/X509TrustManagerImpl/distrust/Symantec.d/main.0.jta after policyOn invalid [2024-10-31T01:11:15.349Z] [2024-10-31T01:11:15.350Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.RuntimeException: Unexpected exception: sun.security.validator.ValidatorException: PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target [2024-10-31T01:11:15.350Z] -------------------------------------------------- [2024-10-31T03:20:19.588Z] Test results: passed: 936; failed: 1; error: 2 [2024-10-31T03:20:47.321Z] Report written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/report/html/report.html [2024-10-31T03:20:47.321Z] Results written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_x86-64_linux_testList_3/aqa-tests/TKG/output_17303209259267/jdk_security3_0/work [2024-10-31T03:20:47.321Z] Error: Some tests failed or other problems occurred. [2024-10-31T03:20:47.321Z] ----------------------------------- [2024-10-31T03:20:47.321Z] jdk_security3_0_FAILED [2024-10-31T03:20:47.321Z] ----------------------------------- [2024-10-31T03:20:47.321Z] [2024-10-31T03:20:47.321Z] TEST TEARDOWN: [2024-10-31T03:20:47.321Z] Nothing to be done for teardown. [2024-10-31T03:20:47.321Z] jdk_security3_0 Finish Time: Thu Oct 31 03:20:43 2024 Epoch Time (ms): 1730344843662