[2023-04-19T13:44:29.061Z] Running test OAuthTest_0 ... [2023-04-19T13:44:29.061Z] =============================================== [2023-04-19T13:44:29.690Z] OAuthTest_0 Start Time: Wed Apr 19 00:19:55 2023 Epoch Time (ms): 1681881595245 [2023-04-19T13:44:29.690Z] variation: NoOptions [2023-04-19T13:44:29.690Z] JVM_OPTIONS: [2023-04-19T13:44:29.690Z] { \ [2023-04-19T13:44:29.690Z] echo ""; echo "TEST SETUP:"; \ [2023-04-19T13:44:29.690Z] echo "Nothing to be done for setup."; \ [2023-04-19T13:44:29.690Z] mkdir -p "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0"; \ [2023-04-19T13:44:29.690Z] cd "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0"; \ [2023-04-19T13:44:29.690Z] echo ""; echo "TESTING:"; \ [2023-04-19T13:44:29.690Z] perl /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/system/security/..//STF/stf.core/scripts/stf.pl -test-root="/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/system/security/..//STF;/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/system/security/..//aqa-systemtest""" -systemtest-prereqs="/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/system/security/..//systemtest_prereqs" -java-args=' ' -results-root="/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0" -test=OAuthTest; if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "OAuthTest_0""_PASSED"; echo "-----------------------------------"; cd /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/..; rm -f -r "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0"; else echo "-----------------------------------"; echo "OAuthTest_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-19T13:44:29.690Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-19T13:44:29.690Z] echo "Nothing to be done for teardown."; \ [2023-04-19T13:44:29.690Z] } 2>&1 | tee -a "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/TestTargetResult"; [2023-04-19T13:44:29.690Z] [2023-04-19T13:44:29.690Z] TEST SETUP: [2023-04-19T13:44:29.690Z] Nothing to be done for setup. [2023-04-19T13:44:29.690Z] [2023-04-19T13:44:29.690Z] TESTING: [2023-04-19T13:44:30.321Z] STF 00:19:55.815 - ========================= S T F ========================= [2023-04-19T13:44:30.321Z] systemtest-prereqs has been processed, and set to: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/systemtest_prereqsRetrieving amount of free space on drive containing /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0 [2023-04-19T13:44:30.321Z] There is 50858 Mb free [2023-04-19T13:44:30.321Z] STF 00:19:55.916 - ================== G E N E R A T I O N ================== [2023-04-19T13:44:30.321Z] STF 00:19:55.925 - Checking JVM: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image [2023-04-19T13:44:30.321Z] STF 00:19:55.926 - Starting process to generate scripts: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/system/security/..//systemtest_prereqs/log4j/log4j-api.jar:/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../../jvmtest/system/security/..//systemtest_prereqs/log4j/log4j-core.jar:/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/stf_parameters.properties, , /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest" [2023-04-19T13:44:36.236Z] GEN 00:20:02.071 - Found test. Project: 'openjdk.test.security' class: 'OAuthTest.class' Dir: '/export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/bin' [2023-04-19T13:44:36.236Z] GEN 00:20:02.108 - Found test. Project: 'openjdk.test.security' class: 'net.adoptopenjdk.test.auth.OAuthTest' [2023-04-19T13:44:37.552Z] GEN Classpath directories used by project 'openjdk.test.security': [2023-04-19T13:44:37.552Z] GEN /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/bin [2023-04-19T13:44:37.552Z] GEN /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/STF/stf.core/bin [2023-04-19T13:44:37.552Z] GEN /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/systemtest_prereqs/log4j/log4j-api.jar [2023-04-19T13:44:37.552Z] GEN /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/systemtest_prereqs/log4j/log4j-core.jar [2023-04-19T13:44:37.552Z] GEN /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/systemtest_prereqs/junit/junit.jar [2023-04-19T13:44:37.552Z] GEN 00:20:03.274 - Using Mode NoOptions. Values = '' [2023-04-19T13:44:40.491Z] GEN SSLv3 [2023-04-19T13:44:40.491Z] GEN TLSv1 [2023-04-19T13:44:40.491Z] GEN TLSv1.3 [2023-04-19T13:44:40.491Z] GEN TLSv1.2 [2023-04-19T13:44:40.491Z] GEN TLSv1.1 [2023-04-19T13:44:40.491Z] GEN SSLv2Hello [2023-04-19T13:44:40.491Z] GEN Testing with : TLSv1.3 [2023-04-19T13:44:40.491Z] GEN 00:20:06.034 - [2023-04-19T13:44:40.491Z] GEN 00:20:06.035 - Test command summary: [2023-04-19T13:44:40.491Z] GEN 00:20:06.036 - Step Stage Command Description [2023-04-19T13:44:40.491Z] GEN 00:20:06.036 - -----+--------+-----------------+------------ [2023-04-19T13:44:40.491Z] GEN 00:20:06.037 - 1 execute Run java Run AuthCenter [2023-04-19T13:44:40.491Z] GEN 00:20:06.037 - 2 execute Run java Run Server [2023-04-19T13:44:40.491Z] GEN 00:20:06.038 - 3 execute Run java Run Client [2023-04-19T13:44:40.491Z] GEN 00:20:06.038 - 4 execute Monitor Wait for clients to complete [2023-04-19T13:44:40.491Z] GEN 00:20:06.039 - 5 execute kill Stop servers [2023-04-19T13:44:40.491Z] STF 00:20:06.212 - [2023-04-19T13:44:40.491Z] STF 00:20:06.212 - Script generation completed [2023-04-19T13:44:40.491Z] STF 00:20:06.212 - [2023-04-19T13:44:40.491Z] STF 00:20:06.216 - [2023-04-19T13:44:40.491Z] STF 00:20:06.216 - ======================= S E T U P ======================= [2023-04-19T13:44:40.491Z] STF 00:20:06.216 - Running setup: perl /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/setUp.pl [2023-04-19T13:44:41.122Z] STF 00:20:06.714 - SETUP stage completed [2023-04-19T13:44:41.122Z] STF 00:20:06.728 - [2023-04-19T13:44:41.122Z] STF 00:20:06.728 - ==================== E X E C U T E - ==================== [2023-04-19T13:44:41.122Z] STF 00:20:06.728 - Running execute: perl /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/execute.pl [2023-04-19T13:44:41.122Z] STF 00:20:07.235 - [2023-04-19T13:44:41.122Z] STF 00:20:07.235 - Java version [2023-04-19T13:44:41.122Z] STF 00:20:07.235 - Running: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java -version [2023-04-19T13:44:41.754Z] openjdk version "1.8.0_372" [2023-04-19T13:44:41.754Z] OpenJDK Runtime Environment (Temurin)(build 1.8.0_372-b07) [2023-04-19T13:44:41.754Z] OpenJDK 64-Bit Server VM (Temurin)(build 25.372-b07, mixed mode) [2023-04-19T13:44:41.754Z] STF 00:20:07.779 - [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - +------ Step 1 - Run AuthCenter [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - | Start background process [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - | Program: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - | Mnemonic: AUTH [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - | Echo: ECHO_ON [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - | Expectation: NEVER [2023-04-19T13:44:41.754Z] STF 00:20:07.780 - | [2023-04-19T13:44:41.754Z] STF 00:20:07.784 - Running command: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java -classpath /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/bin net.adoptopenjdk.test.auth.AuthCenter [2023-04-19T13:44:41.754Z] STF 00:20:07.784 - Redirecting stderr to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/1.AUTH.stderr [2023-04-19T13:44:41.754Z] STF 00:20:07.784 - Redirecting stdout to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/1.AUTH.stdout [2023-04-19T13:44:41.754Z] STF 00:20:07.862 - [2023-04-19T13:44:41.754Z] STF 00:20:07.862 - +------ Step 2 - Run Server [2023-04-19T13:44:41.754Z] STF 00:20:07.862 - | Start background process [2023-04-19T13:44:41.754Z] STF 00:20:07.862 - | Program: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java [2023-04-19T13:44:41.754Z] STF 00:20:07.863 - | Mnemonic: SER [2023-04-19T13:44:41.754Z] STF 00:20:07.863 - | Echo: ECHO_ON [2023-04-19T13:44:41.754Z] STF 00:20:07.863 - | Expectation: NEVER [2023-04-19T13:44:41.754Z] STF 00:20:07.863 - | [2023-04-19T13:44:41.754Z] STF 00:20:07.866 - Running command: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java -classpath /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/bin net.adoptopenjdk.test.auth.Server /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/src/test.security/net/adoptopenjdk/test/auth/testkeys TLSv1.3 [2023-04-19T13:44:41.754Z] STF 00:20:07.866 - Redirecting stderr to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/2.SER.stderr [2023-04-19T13:44:41.754Z] STF 00:20:07.866 - Redirecting stdout to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/2.SER.stdout [2023-04-19T13:44:42.389Z] STF 00:20:07.886 - [2023-04-19T13:44:42.389Z] STF 00:20:07.886 - +------ Step 3 - Run Client [2023-04-19T13:44:42.389Z] STF 00:20:07.886 - | Start background process [2023-04-19T13:44:42.389Z] STF 00:20:07.886 - | Program: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java [2023-04-19T13:44:42.389Z] STF 00:20:07.887 - | Mnemonic: CLI [2023-04-19T13:44:42.389Z] STF 00:20:07.887 - | Echo: ECHO_ON [2023-04-19T13:44:42.389Z] STF 00:20:07.887 - | Expectation: CLEAN_RUN within 10s [2023-04-19T13:44:42.390Z] STF 00:20:07.887 - | [2023-04-19T13:44:42.390Z] STF 00:20:07.890 - Running command: /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/openjdkbinary/j2sdk-image/bin/java -classpath /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/bin net.adoptopenjdk.test.auth.Client /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/jvmtest/system/aqa-systemtest/openjdk.test.security/src/test.security/net/adoptopenjdk/test/auth/testkeys TLSv1.3 [2023-04-19T13:44:42.390Z] STF 00:20:07.890 - Redirecting stderr to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/3.CLI.stderr [2023-04-19T13:44:42.390Z] STF 00:20:07.891 - Redirecting stdout to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/3.CLI.stdout [2023-04-19T13:44:42.390Z] STF 00:20:07.914 - [2023-04-19T13:44:42.390Z] STF 00:20:07.915 - +------ Step 4 - Wait for clients to complete [2023-04-19T13:44:42.390Z] STF 00:20:07.915 - | Wait for processes to meet expectations [2023-04-19T13:44:42.390Z] STF 00:20:07.915 - | Processes: [CLI] [2023-04-19T13:44:42.390Z] STF 00:20:07.915 - | [2023-04-19T13:44:42.390Z] STF 00:20:07.915 - Monitoring processes: CLI [2023-04-19T13:44:44.456Z] CLI log in YES! [2023-04-19T13:44:44.456Z] CLI 8889 [2023-04-19T13:44:53.355Z] STF 00:20:18.024 - **FAILED** Process CLI has timed out [2023-04-19T13:44:53.355Z] STF 00:20:18.025 - Collecting dumps for: CLI [2023-04-19T13:44:53.355Z] STF 00:20:18.025 - Sending SIG 3 to the java process to generate a javacore [2023-04-19T13:44:53.355Z] STF 00:20:18.028 - Running command: kill -3 1961 [2023-04-19T13:44:53.355Z] STF 00:20:18.028 - Redirecting stderr to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/3.CLI.kill_3.stderr [2023-04-19T13:44:53.355Z] STF 00:20:18.028 - Redirecting stdout to /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/results/3.CLI.kill_3.stdout [2023-04-19T13:44:53.355Z] STF 00:20:18.056 - Pausing for 30 seconds [2023-04-19T13:45:27.176Z] STF 00:20:48.063 - Process CLI (pid 1961) is no longer running. Abandoning dump collection. [2023-04-19T13:45:27.176Z] CLI 2023-04-19 00:20:18 [2023-04-19T13:45:27.176Z] CLI Full thread dump OpenJDK 64-Bit Server VM (25.372-b07 mixed mode): [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "Service Thread" #8 daemon prio=9 os_prio=64 tid=0x000000010037c000 nid=0xe runnable [0x0000000000000000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: RUNNABLE [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "C1 CompilerThread2" #7 daemon prio=9 os_prio=64 tid=0x0000000100355800 nid=0xd waiting on condition [0x0000000000000000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: RUNNABLE [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "C2 CompilerThread1" #6 daemon prio=9 os_prio=64 tid=0x0000000100353800 nid=0xc waiting on condition [0x0000000000000000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: RUNNABLE [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "C2 CompilerThread0" #5 daemon prio=9 os_prio=64 tid=0x000000010030c800 nid=0xb waiting on condition [0x0000000000000000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: RUNNABLE [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "Signal Dispatcher" #4 daemon prio=9 os_prio=64 tid=0x0000000100308000 nid=0xa waiting on condition [0x0000000000000000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: RUNNABLE [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "Finalizer" #3 daemon prio=8 os_prio=64 tid=0x00000001002d3000 nid=0x9 in Object.wait() [0xffffffff630fe000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: WAITING (on object monitor) [2023-04-19T13:45:27.176Z] CLI at java.lang.Object.wait(Native Method) [2023-04-19T13:45:27.176Z] CLI - waiting on <0xffffffff35988f00> (a java.lang.ref.ReferenceQueue$Lock) [2023-04-19T13:45:27.176Z] CLI at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144) [2023-04-19T13:45:27.176Z] CLI - locked <0xffffffff35988f00> (a java.lang.ref.ReferenceQueue$Lock) [2023-04-19T13:45:27.176Z] CLI at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165) [2023-04-19T13:45:27.176Z] CLI at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:188) [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "Reference Handler" #2 daemon prio=10 os_prio=64 tid=0x00000001002c9000 nid=0x8 in Object.wait() [0xffffffff632ff000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: WAITING (on object monitor) [2023-04-19T13:45:27.176Z] CLI at java.lang.Object.wait(Native Method) [2023-04-19T13:45:27.176Z] CLI - waiting on <0xffffffff35986b98> (a java.lang.ref.Reference$Lock) [2023-04-19T13:45:27.176Z] CLI at java.lang.Object.wait(Object.java:502) [2023-04-19T13:45:27.176Z] CLI at java.lang.ref.Reference.tryHandlePending(Reference.java:191) [2023-04-19T13:45:27.176Z] CLI - locked <0xffffffff35986b98> (a java.lang.ref.Reference$Lock) [2023-04-19T13:45:27.176Z] CLI at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153) [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "main" #1 prio=5 os_prio=64 tid=0x0000000100110000 nid=0x2 runnable [0xffffffff7aefd000] [2023-04-19T13:45:27.176Z] CLI java.lang.Thread.State: RUNNABLE [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs11.wrapper.PKCS11.C_OpenSession(Native Method) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs11.SessionManager.openSession(SessionManager.java:215) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs11.SessionManager.getOpSession(SessionManager.java:150) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs11.Token.getOpSession(Token.java:303) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs11.P11Digest.fetchSession(P11Digest.java:135) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs11.P11Digest.engineUpdate(P11Digest.java:216) [2023-04-19T13:45:27.176Z] CLI at java.security.MessageDigest$Delegate.engineUpdate(MessageDigest.java:601) [2023-04-19T13:45:27.176Z] CLI at java.security.MessageDigest.update(MessageDigest.java:338) [2023-04-19T13:45:27.176Z] CLI at java.security.MessageDigest.digest(MessageDigest.java:413) [2023-04-19T13:45:27.176Z] CLI at com.sun.crypto.provider.PKCS12PBECipherCore.derive(PKCS12PBECipherCore.java:118) [2023-04-19T13:45:27.176Z] CLI at com.sun.crypto.provider.PKCS12PBECipherCore.derive(PKCS12PBECipherCore.java:68) [2023-04-19T13:45:27.176Z] CLI at com.sun.crypto.provider.PKCS12PBECipherCore.implInit(PKCS12PBECipherCore.java:346) [2023-04-19T13:45:27.176Z] CLI at com.sun.crypto.provider.PKCS12PBECipherCore.implInit(PKCS12PBECipherCore.java:376) [2023-04-19T13:45:27.176Z] CLI at com.sun.crypto.provider.PKCS12PBECipherCore.implInit(PKCS12PBECipherCore.java:361) [2023-04-19T13:45:27.176Z] CLI at com.sun.crypto.provider.PKCS12PBECipherCore$PBEWithSHA1AndRC2_40.engineInit(PKCS12PBECipherCore.java:545) [2023-04-19T13:45:27.176Z] CLI at javax.crypto.Cipher.implInit(Cipher.java:813) [2023-04-19T13:45:27.176Z] CLI at javax.crypto.Cipher.chooseProvider(Cipher.java:867) [2023-04-19T13:45:27.176Z] CLI - locked <0xffffffff3681e248> (a java.lang.Object) [2023-04-19T13:45:27.176Z] CLI at javax.crypto.Cipher.init(Cipher.java:1542) [2023-04-19T13:45:27.176Z] CLI at javax.crypto.Cipher.init(Cipher.java:1473) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs12.PKCS12KeyStore.lambda$engineLoad$1(PKCS12KeyStore.java:2084) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs12.PKCS12KeyStore$$Lambda$3/1330278544.tryOnce(Unknown Source) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs12.PKCS12KeyStore$RetryWithZero.run(PKCS12KeyStore.java:278) [2023-04-19T13:45:27.176Z] CLI at sun.security.pkcs12.PKCS12KeyStore.engineLoad(PKCS12KeyStore.java:2079) [2023-04-19T13:45:27.176Z] CLI - locked <0xffffffff367ecda8> (a sun.security.pkcs12.PKCS12KeyStore) [2023-04-19T13:45:27.176Z] CLI at sun.security.provider.KeyStoreDelegator.engineLoad(KeyStoreDelegator.java:238) [2023-04-19T13:45:27.176Z] CLI at sun.security.provider.JavaKeyStore$DualFormatJKS.engineLoad(JavaKeyStore.java:71) [2023-04-19T13:45:27.176Z] CLI at java.security.KeyStore.load(KeyStore.java:1445) [2023-04-19T13:45:27.176Z] CLI at net.adoptopenjdk.test.auth.Client.getSSLContext(Client.java:85) [2023-04-19T13:45:27.176Z] CLI at net.adoptopenjdk.test.auth.Client.main(Client.java:44) [2023-04-19T13:45:27.176Z] CLI [2023-04-19T13:45:27.176Z] CLI "VM Thread" os_prio=64 tid=0x00000001002bf800 nid=0x7 runnable [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI "GC task thread#0 (ParallelGC)" os_prio=64 tid=0x0000000100122800 nid=0x3 runnable [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI "GC task thread#1 (ParallelGC)" os_prio=64 tid=0x0000000100124000 nid=0x4 runnable [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI "GC task thread#2 (ParallelGC)" os_prio=64 tid=0x0000000100125800 nid=0x5 runnable [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI "GC task thread#3 (ParallelGC)" os_prio=64 tid=0x0000000100127000 nid=0x6 runnable [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI "VM Periodic Task Thread" os_prio=64 tid=0x000000010037e000 nid=0xf waiting on condition [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI JNI global references: 327 [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] CLI Heap [2023-04-19T13:45:27.177Z] CLI PSYoungGen total 38400K, used 25371K [0xffffffff35980000, 0xffffffff38400000, 0xffffffff60400000) [2023-04-19T13:45:27.177Z] CLI eden space 33280K, 76% used [0xffffffff35980000,0xffffffff37246fe0,0xffffffff37a00000) [2023-04-19T13:45:27.177Z] CLI from space 5120K, 0% used [0xffffffff37f00000,0xffffffff37f00000,0xffffffff38400000) [2023-04-19T13:45:27.177Z] CLI to space 5120K, 0% used [0xffffffff37a00000,0xffffffff37a00000,0xffffffff37f00000) [2023-04-19T13:45:27.177Z] CLI ParOldGen total 87552K, used 0K [0xfffffffee0400000, 0xfffffffee5980000, 0xffffffff35980000) [2023-04-19T13:45:27.177Z] CLI object space 87552K, 0% used [0xfffffffee0400000,0xfffffffee0400000,0xfffffffee5980000) [2023-04-19T13:45:27.177Z] CLI Metaspace used 8130K, capacity 8346K, committed 8448K, reserved 1056768K [2023-04-19T13:45:27.177Z] CLI class space used 874K, capacity 966K, committed 1024K, reserved 1048576K [2023-04-19T13:45:27.177Z] CLI [2023-04-19T13:45:27.177Z] STF 00:20:48.073 - Monitoring Report Summary: [2023-04-19T13:45:27.177Z] STF 00:20:48.073 - o Process CLI has timed out [2023-04-19T13:45:27.177Z] STF 00:20:48.075 - Killing processes: AUTH CLI SER [2023-04-19T13:45:27.177Z] STF 00:20:48.075 - o Process CLI pid 1961 is not running [2023-04-19T13:45:27.177Z] STF 00:20:48.075 - o Process clean up attempt 1 for AUTH pid 1959 [2023-04-19T13:45:27.177Z] STF 00:20:48.076 - o Process AUTH pid 1959 stop() [2023-04-19T13:45:33.051Z] STF 00:20:58.078 - o Process AUTH pid 1959 terminate() [2023-04-19T13:45:33.052Z] STF 00:20:59.079 - o Process AUTH pid 1959 killed [2023-04-19T13:45:33.052Z] STF 00:20:59.080 - o Process clean up attempt 1 for SER pid 1960 [2023-04-19T13:45:33.052Z] STF 00:20:59.081 - o Process SER pid 1960 stop() [2023-04-19T13:45:43.303Z] STF 00:21:09.083 - o Process SER pid 1960 terminate() [2023-04-19T13:45:44.613Z] STF 00:21:10.084 - o Process SER pid 1960 killed [2023-04-19T13:45:44.614Z] **FAILED** at step 4 (Wait for clients to complete). Expected return value=0 Actual=1 at /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/execute.pl line 171. [2023-04-19T13:45:44.614Z] STF 00:21:10.270 - **FAILED** execute script failed. Expected return value=0 Actual=1 [2023-04-19T13:45:44.614Z] STF 00:21:10.270 - [2023-04-19T13:45:44.614Z] STF 00:21:10.271 - ==================== T E A R D O W N ==================== [2023-04-19T13:45:44.614Z] STF 00:21:10.271 - Running teardown: perl /export/home/jenkins/workspace/Test_openjdk8_hs_extended.system_sparcv9_solaris/aqa-tests/TKG/../TKG/output_16818788718031/OAuthTest_0/20230419-001955-OAuthTest/tearDown.pl [2023-04-19T13:45:45.245Z] STF 00:21:10.783 - TEARDOWN stage completed [2023-04-19T13:45:45.245Z] STF 00:21:10.807 - [2023-04-19T13:45:45.245Z] STF 00:21:10.807 - ===================== R E S U L T S ===================== [2023-04-19T13:45:45.245Z] STF 00:21:10.807 - Stage results: [2023-04-19T13:45:45.245Z] STF 00:21:10.808 - setUp: pass [2023-04-19T13:45:45.245Z] STF 00:21:10.808 - execute: *fail* [2023-04-19T13:45:45.245Z] STF 00:21:10.808 - teardown: pass [2023-04-19T13:45:45.245Z] STF 00:21:10.808 - [2023-04-19T13:45:45.245Z] STF 00:21:10.808 - Overall result: **FAILED** [2023-04-19T13:45:45.245Z] ----------------------------------- [2023-04-19T13:45:45.245Z] OAuthTest_0_FAILED [2023-04-19T13:45:45.245Z] ----------------------------------- [2023-04-19T13:45:45.245Z] [2023-04-19T13:45:45.245Z] TEST TEARDOWN: [2023-04-19T13:45:45.245Z] Nothing to be done for teardown. [2023-04-19T13:45:45.245Z] OAuthTest_0 Finish Time: Wed Apr 19 00:21:10 2023 Epoch Time (ms): 1681881670931