[2026-01-19T07:56:52.297Z] Running test TestJlmRemoteThreadAuth_1 ... [2026-01-19T07:56:52.297Z] =============================================== [2026-01-19T07:56:52.297Z] TestJlmRemoteThreadAuth_1 Start Time: Mon Jan 19 07:56:51 2026 Epoch Time (ms): 1768809411662 [2026-01-19T07:56:52.297Z] variation: Mode650 [2026-01-19T07:56:52.297Z] JVM_OPTIONS: -XX:-UseCompressedOops [2026-01-19T07:56:52.297Z] { \ [2026-01-19T07:56:52.297Z] echo ""; echo "TEST SETUP:"; \ [2026-01-19T07:56:52.297Z] echo "Nothing to be done for setup."; \ [2026-01-19T07:56:52.297Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1"; \ [2026-01-19T07:56:52.297Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1"; \ [2026-01-19T07:56:52.297Z] echo ""; echo "TESTING:"; \ [2026-01-19T07:56:52.297Z] perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/../../externalDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1" -test=TestJlmRemoteThreadAuth; \ [2026-01-19T07:56:52.297Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-19T07:56:52.297Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-19T07:56:52.297Z] echo "Nothing to be done for teardown."; \ [2026-01-19T07:56:52.297Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestTargetResult"; [2026-01-19T07:56:52.297Z] [2026-01-19T07:56:52.297Z] TEST SETUP: [2026-01-19T07:56:52.297Z] Nothing to be done for setup. [2026-01-19T07:56:52.297Z] [2026-01-19T07:56:52.297Z] TESTING: [2026-01-19T07:56:52.297Z] STF 07:56:51.775 - ========================= S T F ========================= [2026-01-19T07:56:52.297Z] systemtest-prereqs has been processed, and set to: /home/jenkins/externalDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1 [2026-01-19T07:56:52.297Z] There is 21703 Mb free [2026-01-19T07:56:52.297Z] STF 07:56:51.789 - ================== G E N E R A T I O N ================== [2026-01-19T07:56:52.297Z] STF 07:56:51.791 - Checking JVM: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image [2026-01-19T07:56:52.297Z] STF 07:56:51.791 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/../../externalDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/../../externalDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/../../externalDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/../../externalDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth" [2026-01-19T07:56:54.080Z] GEN 07:56:53.146 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2026-01-19T07:56:54.080Z] GEN 07:56:53.176 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadAuth' [2026-01-19T07:56:54.080Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2026-01-19T07:56:54.080Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2026-01-19T07:56:54.080Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/bin [2026-01-19T07:56:54.080Z] GEN /home/jenkins/externalDependency/system_lib/log4j/log4j-api.jar [2026-01-19T07:56:54.080Z] GEN /home/jenkins/externalDependency/system_lib/log4j/log4j-core.jar [2026-01-19T07:56:54.080Z] GEN /home/jenkins/externalDependency/system_lib/junit/junit.jar [2026-01-19T07:56:54.080Z] GEN 07:56:53.382 - Using Mode NoOptions. Values = '' [2026-01-19T07:56:54.080Z] GEN 07:56:53.506 - [2026-01-19T07:56:54.081Z] GEN 07:56:53.506 - Test command summary: [2026-01-19T07:56:54.081Z] GEN 07:56:53.506 - Step Stage Command Description [2026-01-19T07:56:54.081Z] GEN 07:56:53.506 - -----+--------+-----------------+------------ [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 1 setUp cp Copying password file to temp [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 2 setUp chmod Restricting file permission of jmxremote.passsword to 600 [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 3 execute Run java Running ThreadProfiler Proxy test Server Process(with security) [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 4 execute Run java Running Monitoring Client with proxy connection(with security) [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 5 execute Monitor Wait for the processes to complete [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 6 execute kill Stop LT1 process [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 7 execute Run java Running ThreadProfiler Server test Server Process(with security) [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 8 execute Run java Run the Monitoring Client with server-connection(with security) [2026-01-19T07:56:54.081Z] GEN 07:56:53.507 - 9 execute Monitor Wait for processes to complete [2026-01-19T07:56:54.081Z] GEN 07:56:53.508 - 10 execute kill Stop LT2 process [2026-01-19T07:56:54.081Z] STF 07:56:53.539 - [2026-01-19T07:56:54.081Z] STF 07:56:53.539 - Script generation completed [2026-01-19T07:56:54.081Z] STF 07:56:53.539 - [2026-01-19T07:56:54.081Z] STF 07:56:53.540 - [2026-01-19T07:56:54.081Z] STF 07:56:53.540 - ======================= S E T U P ======================= [2026-01-19T07:56:54.081Z] STF 07:56:53.540 - Running setup: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/setUp.pl [2026-01-19T07:56:54.081Z] STF 07:56:53.631 - [2026-01-19T07:56:54.081Z] STF 07:56:53.631 - +------ Step 1 - Copying password file to temp [2026-01-19T07:56:54.081Z] STF 07:56:53.631 - | Copy a file to another directory [2026-01-19T07:56:54.081Z] STF 07:56:53.631 - | Source file: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/jmxremote.password [2026-01-19T07:56:54.081Z] STF 07:56:53.631 - | Dest dir: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tmp [2026-01-19T07:56:54.081Z] STF 07:56:53.631 - | [2026-01-19T07:56:54.081Z] STF 07:56:53.632 - [2026-01-19T07:56:54.081Z] STF 07:56:53.632 - +------ Step 2 - Restricting file permission of jmxremote.passsword to 600 [2026-01-19T07:56:54.081Z] STF 07:56:53.632 - | Change file permission [2026-01-19T07:56:54.081Z] STF 07:56:53.632 - | targetFile: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tmp/jmxremote.password [2026-01-19T07:56:54.081Z] STF 07:56:53.632 - | modeBits: 600 [2026-01-19T07:56:54.081Z] STF 07:56:53.632 - | [2026-01-19T07:56:54.081Z] STF 07:56:53.641 - SETUP stage completed [2026-01-19T07:56:54.081Z] STF 07:56:53.650 - [2026-01-19T07:56:54.081Z] STF 07:56:53.650 - ==================== E X E C U T E - ==================== [2026-01-19T07:56:54.081Z] STF 07:56:53.650 - Running execute: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/execute.pl [2026-01-19T07:56:54.081Z] STF 07:56:53.741 - [2026-01-19T07:56:54.081Z] STF 07:56:53.741 - Java version [2026-01-19T07:56:54.081Z] STF 07:56:53.741 - Running: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -version [2026-01-19T07:56:55.036Z] openjdk version "25.0.3-beta" 2026-04-21 [2026-01-19T07:56:55.036Z] OpenJDK Runtime Environment Temurin-25.0.3+0-202601171247 (build 25.0.3-beta-202601171247) [2026-01-19T07:56:55.036Z] OpenJDK 64-Bit Server VM Temurin-25.0.3+0-202601171247 (build 25.0.3-beta-202601171247, mixed mode) [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - +------ Step 3 - Running ThreadProfiler Proxy test Server Process(with security) [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - | Start background process [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - | Mnemonic: LT1 [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - | Echo: ECHO_OFF [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - | Expectation: NEVER [2026-01-19T07:56:55.036Z] STF 07:56:53.868 - | [2026-01-19T07:56:55.036Z] STF 07:56:53.869 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.ssl.need.client.auth=true -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.trustStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.keyStoreType=JKS -Djavax.net.ssl.trustStoreType=JKS -Djavax.net.ssl.keyStorePassword=passphrase -Djavax.net.ssl.trustStorePassword=passphrase -Dcom.sun.management.jmxremote.password.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/bin:/home/jenkins/externalDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/externalDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/externalDependency/system_lib/asm/asm.jar:/home/jenkins/externalDependency/system_lib/asm/asm-commons.jar:/home/jenkins/externalDependency/system_lib/junit/junit.jar:/home/jenkins/externalDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results -resultsPrefix 3.LT1. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/3.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/3.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/3.LT1.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2026-01-19T07:56:55.036Z] STF 07:56:53.869 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/3.LT1.stderr [2026-01-19T07:56:55.036Z] STF 07:56:53.869 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/3.LT1.stdout [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - +------ Step 4 - Running Monitoring Client with proxy connection(with security) [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - | Start background process [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - | Mnemonic: CL1 [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - | Echo: ECHO_ON [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - | Expectation: CLEAN_RUN within 30m [2026-01-19T07:56:55.036Z] STF 07:56:53.889 - | [2026-01-19T07:56:55.036Z] STF 07:56:53.890 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -Xmx256m -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.trustStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.keyStoreType=JKS -Djavax.net.ssl.trustStoreType=JKS -Djavax.net.ssl.keyStorePassword=passphrase -Djavax.net.ssl.trustStorePassword=passphrase -Dcom.sun.management.jmxremote.password.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/externalDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/sthd_proxy.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/sthd_proxy.csv auth controlRole control1 localhost 1234 [2026-01-19T07:56:55.037Z] STF 07:56:53.890 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/4.CL1.stderr [2026-01-19T07:56:55.037Z] STF 07:56:53.890 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/4.CL1.stdout [2026-01-19T07:56:55.037Z] STF 07:56:53.896 - [2026-01-19T07:56:55.037Z] STF 07:56:53.896 - +------ Step 5 - Wait for the processes to complete [2026-01-19T07:56:55.037Z] STF 07:56:53.896 - | Wait for processes to meet expectations [2026-01-19T07:56:55.037Z] STF 07:56:53.896 - | Processes: [LT1, CL1] [2026-01-19T07:56:55.037Z] STF 07:56:53.896 - | [2026-01-19T07:56:55.037Z] STF 07:56:53.896 - Monitoring processes: CL1 LT1 [2026-01-19T07:56:55.037Z] CL1 j> 2026/01/19 07:56:54.186 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2026-01-19T07:56:55.037Z] CL1 j> 2026/01/19 07:56:54.280 Attempting to connect [2026-01-19T07:56:55.037Z] CL1 j> 2026/01/19 07:56:54.428 Monitored VM not ready at Jan 19, 2026, 7:56:54?AM (attempt 1, elapsed 120ms). [2026-01-19T07:56:55.037Z] CL1 j> 2026/01/19 07:56:54.428 Waiting 5 secs and trying again... [2026-01-19T07:57:00.778Z] CL1 j> 2026/01/19 07:56:59.429 Attempting to connect [2026-01-19T07:57:01.573Z] CL1 j> 2026/01/19 07:57:01.269 Connection established! [2026-01-19T07:57:02.358Z] CL1 j> 2026/01/19 07:57:01.555 Starting to write data [2026-01-19T08:01:58.087Z] STF 08:01:53.395 - Heartbeat: Process LT1 is still running [2026-01-19T08:02:25.426Z] STF 08:02:23.259 - Monitoring Report Summary: [2026-01-19T08:02:25.426Z] STF 08:02:23.259 - o Process CL1 ended with the expected exit code (0) [2026-01-19T08:02:25.426Z] STF 08:02:23.259 - o Process LT1 is still running as expected [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - +------ Step 6 - Stop LT1 process [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - | Kill running processes [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - | Processes: [LT1] [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - | [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - Killing processes: LT1 [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - o Process clean up attempt 1 for LT1 pid 14025000 [2026-01-19T08:02:25.426Z] STF 08:02:23.260 - o Process LT1 pid 14025000 stop() [2026-01-19T08:02:35.405Z] STF 08:02:33.262 - o Process LT1 pid 14025000 terminate() [2026-01-19T08:02:35.405Z] STF 08:02:34.262 - o Process LT1 pid 14025000 killed [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - +------ Step 7 - Running ThreadProfiler Server test Server Process(with security) [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - | Start background process [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - | Mnemonic: LT2 [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - | Echo: ECHO_OFF [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - | Expectation: NEVER [2026-01-19T08:02:35.405Z] STF 08:02:34.263 - | [2026-01-19T08:02:35.406Z] STF 08:02:34.263 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.ssl.need.client.auth=true -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.trustStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.keyStoreType=JKS -Djavax.net.ssl.trustStoreType=JKS -Djavax.net.ssl.keyStorePassword=passphrase -Djavax.net.ssl.trustStorePassword=passphrase -Dcom.sun.management.jmxremote.password.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/bin:/home/jenkins/externalDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/externalDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/externalDependency/system_lib/asm/asm.jar:/home/jenkins/externalDependency/system_lib/asm/asm-commons.jar:/home/jenkins/externalDependency/system_lib/junit/junit.jar:/home/jenkins/externalDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results -resultsPrefix 7.LT2. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/7.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/7.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/7.LT2.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2026-01-19T08:02:35.406Z] STF 08:02:34.263 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/7.LT2.stderr [2026-01-19T08:02:35.406Z] STF 08:02:34.263 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/7.LT2.stdout [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - +------ Step 8 - Run the Monitoring Client with server-connection(with security) [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - | Start background process [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - | Mnemonic: CL2 [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - | Echo: ECHO_ON [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - | Expectation: CLEAN_RUN within 30m [2026-01-19T08:02:35.406Z] STF 08:02:34.269 - | [2026-01-19T08:02:35.406Z] STF 08:02:34.270 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -Xmx256m -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.trustStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/testkeys -Djavax.net.ssl.keyStoreType=JKS -Djavax.net.ssl.trustStoreType=JKS -Djavax.net.ssl.keyStorePassword=passphrase -Djavax.net.ssl.trustStorePassword=passphrase -Dcom.sun.management.jmxremote.password.file=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/externalDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/sthd_server.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/sthd_server.csv auth controlRole control1 localhost 1234 [2026-01-19T08:02:35.406Z] STF 08:02:34.270 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/8.CL2.stderr [2026-01-19T08:02:35.406Z] STF 08:02:34.270 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/results/8.CL2.stdout [2026-01-19T08:02:35.406Z] STF 08:02:34.276 - [2026-01-19T08:02:35.406Z] STF 08:02:34.276 - +------ Step 9 - Wait for processes to complete [2026-01-19T08:02:35.406Z] STF 08:02:34.276 - | Wait for processes to meet expectations [2026-01-19T08:02:35.406Z] STF 08:02:34.276 - | Processes: [LT2, CL2] [2026-01-19T08:02:35.406Z] STF 08:02:34.276 - | [2026-01-19T08:02:35.406Z] STF 08:02:34.276 - Monitoring processes: CL2 LT2 [2026-01-19T08:02:35.406Z] CL2 j> 2026/01/19 08:02:34.917 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2026-01-19T08:02:35.406Z] CL2 j> 2026/01/19 08:02:35.153 Attempting to connect [2026-01-19T08:02:36.188Z] CL2 j> 2026/01/19 08:02:35.386 Monitored VM not ready at Jan 19, 2026, 8:02:35?AM (attempt 1, elapsed 202ms). [2026-01-19T08:02:36.188Z] CL2 j> 2026/01/19 08:02:35.387 Waiting 5 secs and trying again... [2026-01-19T08:02:41.892Z] CL2 j> 2026/01/19 08:02:40.388 Attempting to connect [2026-01-19T08:02:43.522Z] CL2 j> 2026/01/19 08:02:42.395 Connection established! [2026-01-19T08:02:55.401Z] CL2 j> 2026/01/19 08:02:53.519 Writing report data ... [2026-01-19T08:02:57.029Z] CL2 j> 2026/01/19 08:02:56.590 done. [2026-01-19T08:03:07.058Z] CL2 j> 2026/01/19 08:03:06.669 Writing report data ... [2026-01-19T08:03:08.673Z] CL2 j> 2026/01/19 08:03:08.308 done. [2026-01-19T08:03:20.256Z] CL2 j> 2026/01/19 08:03:18.373 Writing report data ... [2026-01-19T08:03:20.256Z] CL2 j> 2026/01/19 08:03:19.874 done. [2026-01-19T08:03:32.056Z] CL2 j> 2026/01/19 08:03:29.924 Writing report data ... [2026-01-19T08:03:32.056Z] CL2 j> 2026/01/19 08:03:31.207 done. [2026-01-19T08:03:42.040Z] CL2 j> 2026/01/19 08:03:41.256 Writing report data ... [2026-01-19T08:03:43.657Z] CL2 j> 2026/01/19 08:03:42.498 done. [2026-01-19T08:03:53.632Z] CL2 j> 2026/01/19 08:03:52.526 Writing report data ... [2026-01-19T08:03:54.412Z] CL2 j> 2026/01/19 08:03:53.546 done. [2026-01-19T08:04:04.542Z] CL2 j> 2026/01/19 08:04:03.578 Writing report data ... [2026-01-19T08:04:05.327Z] CL2 j> 2026/01/19 08:04:04.545 done. [2026-01-19T08:04:15.308Z] CL2 j> 2026/01/19 08:04:14.584 Writing report data ... [2026-01-19T08:04:16.099Z] CL2 j> 2026/01/19 08:04:15.516 done. [2026-01-19T08:04:27.911Z] CL2 j> 2026/01/19 08:04:25.547 Writing report data ... [2026-01-19T08:04:27.911Z] CL2 j> 2026/01/19 08:04:26.530 done. [2026-01-19T08:04:38.053Z] CL2 j> 2026/01/19 08:04:36.555 Writing report data ... [2026-01-19T08:04:38.834Z] CL2 j> 2026/01/19 08:04:37.461 done. [2026-01-19T08:04:48.890Z] CL2 j> 2026/01/19 08:04:47.504 Writing report data ... [2026-01-19T08:04:49.670Z] CL2 j> 2026/01/19 08:04:48.381 done. [2026-01-19T08:04:59.650Z] CL2 j> 2026/01/19 08:04:58.415 Writing report data ... [2026-01-19T08:05:00.431Z] CL2 j> 2026/01/19 08:04:59.345 done. [2026-01-19T08:05:10.435Z] CL2 j> 2026/01/19 08:05:09.368 Writing report data ... [2026-01-19T08:05:11.218Z] CL2 j> 2026/01/19 08:05:10.162 done. [2026-01-19T08:05:21.228Z] CL2 j> 2026/01/19 08:05:20.187 Writing report data ... [2026-01-19T08:05:22.011Z] CL2 j> 2026/01/19 08:05:21.017 done. [2026-01-19T08:05:32.230Z] CL2 j> 2026/01/19 08:05:31.056 Writing report data ... [2026-01-19T08:05:33.012Z] CL2 j> 2026/01/19 08:05:31.849 done. [2026-01-19T08:05:42.168Z] CL2 j> 2026/01/19 08:05:41.894 Writing report data ... [2026-01-19T08:05:43.787Z] CL2 j> 2026/01/19 08:05:42.917 done. [2026-01-19T08:05:53.771Z] CL2 j> 2026/01/19 08:05:52.979 Writing report data ... [2026-01-19T08:05:54.551Z] CL2 j> 2026/01/19 08:05:53.741 done. [2026-01-19T08:06:06.333Z] CL2 j> 2026/01/19 08:06:03.768 Writing report data ... [2026-01-19T08:06:06.333Z] CL2 j> 2026/01/19 08:06:04.489 done. [2026-01-19T08:06:16.310Z] CL2 j> 2026/01/19 08:06:14.519 Writing report data ... [2026-01-19T08:06:17.094Z] CL2 j> 2026/01/19 08:06:15.482 done. [2026-01-19T08:06:27.077Z] CL2 j> 2026/01/19 08:06:25.508 Writing report data ... [2026-01-19T08:06:27.858Z] CL2 j> 2026/01/19 08:06:26.477 done. [2026-01-19T08:06:37.836Z] CL2 j> 2026/01/19 08:06:36.494 Writing report data ... [2026-01-19T08:06:38.616Z] CL2 j> 2026/01/19 08:06:37.501 done. [2026-01-19T08:06:48.710Z] CL2 j> 2026/01/19 08:06:47.533 Writing report data ... [2026-01-19T08:06:49.492Z] CL2 j> 2026/01/19 08:06:48.528 done. [2026-01-19T08:06:54.017Z] STF 08:06:53.238 - Heartbeat: Process CL2 is still running [2026-01-19T08:06:59.685Z] CL2 j> 2026/01/19 08:06:58.545 Writing report data ... [2026-01-19T08:06:59.685Z] CL2 j> 2026/01/19 08:06:59.271 done. [2026-01-19T08:07:09.722Z] CL2 j> 2026/01/19 08:07:09.291 Writing report data ... [2026-01-19T08:07:11.335Z] CL2 j> 2026/01/19 08:07:10.355 done. [2026-01-19T08:07:21.964Z] CL2 j> 2026/01/19 08:07:20.388 Writing report data ... [2026-01-19T08:07:21.964Z] CL2 j> 2026/01/19 08:07:21.330 done. [2026-01-19T08:07:31.952Z] CL2 j> 2026/01/19 08:07:31.351 Writing report data ... [2026-01-19T08:07:33.564Z] CL2 j> 2026/01/19 08:07:32.215 done. [2026-01-19T08:07:43.547Z] CL2 j> 2026/01/19 08:07:42.232 Writing report data ... [2026-01-19T08:07:44.328Z] CL2 j> 2026/01/19 08:07:43.096 done. [2026-01-19T08:07:54.418Z] CL2 j> 2026/01/19 08:07:53.114 Writing report data ... [2026-01-19T08:07:55.203Z] CL2 j> 2026/01/19 08:07:53.891 done. [2026-01-19T08:08:05.188Z] CL2 j> 2026/01/19 08:08:03.912 Writing report data ... [2026-01-19T08:08:05.969Z] CL2 j> 2026/01/19 08:08:04.717 done. [2026-01-19T08:08:15.950Z] CL2 j> 2026/01/19 08:08:14.732 Writing report data ... [2026-01-19T08:08:16.732Z] CL2 j> 2026/01/19 08:08:15.686 done. [2026-01-19T08:08:17.514Z] STF 08:08:16.730 - Monitoring Report Summary: [2026-01-19T08:08:17.514Z] STF 08:08:16.730 - o Process CL2 ended with the expected exit code (0) [2026-01-19T08:08:17.514Z] STF 08:08:16.730 - o Process LT2 is still running as expected [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - +------ Step 10 - Stop LT2 process [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - | Kill running processes [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - | Processes: [LT2] [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - | [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - Killing processes: LT2 [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - o Process clean up attempt 1 for LT2 pid 21758218 [2026-01-19T08:08:17.514Z] STF 08:08:16.731 - o Process LT2 pid 21758218 stop() [2026-01-19T08:08:27.490Z] STF 08:08:26.732 - o Process LT2 pid 21758218 terminate() [2026-01-19T08:08:28.269Z] STF 08:08:27.732 - o Process LT2 pid 21758218 killed [2026-01-19T08:08:28.269Z] STF 08:08:27.732 - EXECUTE stage completed [2026-01-19T08:08:28.269Z] STF 08:08:28.080 - [2026-01-19T08:08:28.269Z] STF 08:08:28.081 - ==================== T E A R D O W N ==================== [2026-01-19T08:08:28.269Z] STF 08:08:28.081 - Running teardown: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17688031779150/TestJlmRemoteThreadAuth_1/20260119-075651-TestJlmRemoteThreadAuth/tearDown.pl [2026-01-19T08:08:28.269Z] STF 08:08:28.171 - TEARDOWN stage completed [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - ===================== R E S U L T S ===================== [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - Stage results: [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - setUp: pass [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - execute: pass [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - teardown: pass [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - [2026-01-19T08:08:28.269Z] STF 08:08:28.176 - Overall result: PASSED [2026-01-19T08:08:29.049Z] ----------------------------------- [2026-01-19T08:08:29.049Z] TestJlmRemoteThreadAuth_1_PASSED [2026-01-19T08:08:29.049Z] ----------------------------------- [2026-01-19T08:08:29.049Z] [2026-01-19T08:08:29.049Z] TEST TEARDOWN: [2026-01-19T08:08:29.049Z] Nothing to be done for teardown. [2026-01-19T08:08:29.049Z] TestJlmRemoteThreadAuth_1 Finish Time: Mon Jan 19 08:08:28 2026 Epoch Time (ms): 1768810108210