TestJlmRemoteThreadAuth_1

[2025-11-21T14:59:38.148Z] Running test TestJlmRemoteThreadAuth_1 ... [2025-11-21T14:59:38.148Z] =============================================== [2025-11-21T14:59:38.148Z] TestJlmRemoteThreadAuth_1 Start Time: Fri Nov 21 14:59:37 2025 Epoch Time (ms): 1763737177763 [2025-11-21T14:59:38.148Z] variation: Mode650 [2025-11-21T14:59:38.148Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-11-21T14:59:38.148Z] { \ [2025-11-21T14:59:38.148Z] echo ""; echo "TEST SETUP:"; \ [2025-11-21T14:59:38.148Z] echo "Nothing to be done for setup."; \ [2025-11-21T14:59:38.148Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1"; \ [2025-11-21T14:59:38.148Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1"; \ [2025-11-21T14:59:38.148Z] echo ""; echo "TESTING:"; \ [2025-11-21T14:59:38.149Z] perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/../../externalDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1" -test=TestJlmRemoteThreadAuth; \ [2025-11-21T14:59:38.149Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-21T14:59:38.149Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-21T14:59:38.149Z] echo "Nothing to be done for teardown."; \ [2025-11-21T14:59:38.149Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestTargetResult"; [2025-11-21T14:59:38.149Z] [2025-11-21T14:59:38.149Z] TEST SETUP: [2025-11-21T14:59:38.149Z] Nothing to be done for setup. [2025-11-21T14:59:38.149Z] [2025-11-21T14:59:38.149Z] TESTING: [2025-11-21T14:59:38.149Z] STF 14:59:37.867 - ========================= S T F ========================= [2025-11-21T14:59:38.149Z] 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_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1 [2025-11-21T14:59:38.149Z] There is 83459 Mb free [2025-11-21T14:59:38.149Z] STF 14:59:37.875 - ================== G E N E R A T I O N ================== [2025-11-21T14:59:38.149Z] STF 14:59:37.877 - Checking JVM: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image [2025-11-21T14:59:38.149Z] STF 14:59:37.877 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/../../externalDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/../../externalDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/../../externalDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/../../externalDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth" [2025-11-21T14:59:38.149Z] GEN [0.006s][warning][cds] Archived non-system classes are disabled because the java.system.class.loader property is specified (value = "net.adoptopenjdk.stf.runner.StfClassLoader"). To use archived non-system classes, this property must not be set [2025-11-21T14:59:39.406Z] GEN 14:59:39.130 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-11-21T14:59:39.406Z] GEN 14:59:39.147 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadAuth' [2025-11-21T14:59:39.406Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-11-21T14:59:39.406Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-11-21T14:59:39.406Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/STF/stf.core/bin [2025-11-21T14:59:39.406Z] GEN /home/jenkins/externalDependency/system_lib/log4j/log4j-api.jar [2025-11-21T14:59:39.406Z] GEN /home/jenkins/externalDependency/system_lib/log4j/log4j-core.jar [2025-11-21T14:59:39.406Z] GEN /home/jenkins/externalDependency/system_lib/junit/junit.jar [2025-11-21T14:59:39.406Z] GEN 14:59:39.309 - Using Mode NoOptions. Values = '' [2025-11-21T14:59:39.877Z] GEN 14:59:39.429 - [2025-11-21T14:59:39.877Z] GEN 14:59:39.430 - Test command summary: [2025-11-21T14:59:39.877Z] GEN 14:59:39.430 - Step Stage Command Description [2025-11-21T14:59:39.877Z] GEN 14:59:39.430 - -----+--------+-----------------+------------ [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 1 setUp cp Copying password file to temp [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 2 setUp chmod Restricting file permission of jmxremote.passsword to 600 [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 3 execute Run java Running ThreadProfiler Proxy test Server Process(with security) [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 4 execute Run java Running Monitoring Client with proxy connection(with security) [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 5 execute Monitor Wait for the processes to complete [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 6 execute kill Stop LT1 process [2025-11-21T14:59:39.877Z] GEN 14:59:39.431 - 7 execute Run java Running ThreadProfiler Server test Server Process(with security) [2025-11-21T14:59:39.877Z] GEN 14:59:39.432 - 8 execute Run java Run the Monitoring Client with server-connection(with security) [2025-11-21T14:59:39.877Z] GEN 14:59:39.432 - 9 execute Monitor Wait for processes to complete [2025-11-21T14:59:39.877Z] GEN 14:59:39.432 - 10 execute kill Stop LT2 process [2025-11-21T14:59:39.877Z] STF 14:59:39.470 - [2025-11-21T14:59:39.877Z] STF 14:59:39.470 - Script generation completed [2025-11-21T14:59:39.877Z] STF 14:59:39.470 - [2025-11-21T14:59:39.877Z] STF 14:59:39.471 - [2025-11-21T14:59:39.877Z] STF 14:59:39.471 - ======================= S E T U P ======================= [2025-11-21T14:59:39.877Z] STF 14:59:39.471 - Running setup: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/setUp.pl [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - +------ Step 1 - Copying password file to temp [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | Copy a file to another directory [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | Source file: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/jmxremote.password [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | Dest dir: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tmp [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - +------ Step 2 - Restricting file permission of jmxremote.passsword to 600 [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | Change file permission [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | targetFile: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tmp/jmxremote.password [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | modeBits: 600 [2025-11-21T14:59:39.877Z] STF 14:59:39.558 - | [2025-11-21T14:59:39.877Z] STF 14:59:39.562 - SETUP stage completed [2025-11-21T14:59:39.877Z] STF 14:59:39.565 - [2025-11-21T14:59:39.877Z] STF 14:59:39.565 - ==================== E X E C U T E - ==================== [2025-11-21T14:59:39.877Z] STF 14:59:39.565 - Running execute: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/execute.pl [2025-11-21T14:59:39.877Z] STF 14:59:39.651 - [2025-11-21T14:59:39.877Z] STF 14:59:39.652 - Java version [2025-11-21T14:59:39.877Z] STF 14:59:39.652 - Running: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -version [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - +------ Step 3 - Running ThreadProfiler Proxy test Server Process(with security) [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - | Start background process [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - | Mnemonic: LT1 [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - | Echo: ECHO_OFF [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - | Expectation: NEVER [2025-11-21T14:59:39.877Z] STF 14:59:39.692 - | [2025-11-21T14:59:39.878Z] STF 14:59:39.692 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/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_aarch64_linux/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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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 [2025-11-21T14:59:39.878Z] STF 14:59:39.692 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/3.LT1.stderr [2025-11-21T14:59:39.878Z] STF 14:59:39.692 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/3.LT1.stdout [2025-11-21T14:59:39.878Z] openjdk version "25.0.1" 2025-10-21 LTS [2025-11-21T14:59:39.878Z] OpenJDK Runtime Environment Temurin-25.0.1+8 (build 25.0.1+8-LTS) [2025-11-21T14:59:39.878Z] OpenJDK 64-Bit Server VM Temurin-25.0.1+8 (build 25.0.1+8-LTS, mixed mode, sharing) [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - +------ Step 4 - Running Monitoring Client with proxy connection(with security) [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - | Start background process [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - | Mnemonic: CL1 [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - | Echo: ECHO_ON [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - | Expectation: CLEAN_RUN within 30m [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - | [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/sthd_proxy.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/sthd_proxy.csv auth controlRole control1 localhost 1234 [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/4.CL1.stderr [2025-11-21T14:59:39.878Z] STF 14:59:39.705 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/4.CL1.stdout [2025-11-21T14:59:39.878Z] STF 14:59:39.708 - [2025-11-21T14:59:39.878Z] STF 14:59:39.708 - +------ Step 5 - Wait for the processes to complete [2025-11-21T14:59:39.878Z] STF 14:59:39.708 - | Wait for processes to meet expectations [2025-11-21T14:59:39.878Z] STF 14:59:39.708 - | Processes: [LT1, CL1] [2025-11-21T14:59:39.878Z] STF 14:59:39.708 - | [2025-11-21T14:59:39.878Z] STF 14:59:39.708 - Monitoring processes: CL1 LT1 [2025-11-21T14:59:40.256Z] CL1 j> 2025/11/21 14:59:39.910 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-11-21T14:59:40.256Z] CL1 j> 2025/11/21 14:59:40.013 Attempting to connect [2025-11-21T14:59:40.256Z] CL1 j> 2025/11/21 14:59:40.163 Monitored VM not ready at Nov 21, 2025, 2:59:40 PM (attempt 1, elapsed 129ms). [2025-11-21T14:59:40.256Z] CL1 j> 2025/11/21 14:59:40.164 Waiting 5 secs and trying again... [2025-11-21T14:59:45.565Z] CL1 j> 2025/11/21 14:59:45.174 Attempting to connect [2025-11-21T14:59:50.088Z] CL1 j> 2025/11/21 14:59:49.634 Connection established! [2025-11-21T14:59:50.576Z] CL1 j> 2025/11/21 14:59:50.068 Starting to write data [2025-11-21T15:04:49.130Z] STF 15:04:39.504 - Heartbeat: Process LT1 is still running [2025-11-21T15:08:31.729Z] STF 15:08:28.531 - Monitoring Report Summary: [2025-11-21T15:08:31.729Z] STF 15:08:28.531 - o Process CL1 ended with the expected exit code (0) [2025-11-21T15:08:31.729Z] STF 15:08:28.531 - o Process LT1 is still running as expected [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - +------ Step 6 - Stop LT1 process [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - | Kill running processes [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - | Processes: [LT1] [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - | [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - Killing processes: LT1 [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - o Process clean up attempt 1 for LT1 pid 18356 [2025-11-21T15:08:31.729Z] STF 15:08:28.532 - o Process LT1 pid 18356 stop() [2025-11-21T15:08:40.250Z] STF 15:08:38.683 - o Process LT1 pid 18356 terminate() [2025-11-21T15:08:40.250Z] STF 15:08:39.683 - o Process LT1 pid 18356 killed [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - +------ Step 7 - Running ThreadProfiler Server test Server Process(with security) [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - | Start background process [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - | Mnemonic: LT2 [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - | Echo: ECHO_OFF [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - | Expectation: NEVER [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - | [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/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_aarch64_linux/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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-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 [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/7.LT2.stderr [2025-11-21T15:08:40.250Z] STF 15:08:39.684 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/7.LT2.stdout [2025-11-21T15:08:40.250Z] STF 15:08:39.686 - [2025-11-21T15:08:40.250Z] STF 15:08:39.687 - +------ Step 8 - Run the Monitoring Client with server-connection(with security) [2025-11-21T15:08:40.250Z] STF 15:08:39.687 - | Start background process [2025-11-21T15:08:40.250Z] STF 15:08:39.687 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java [2025-11-21T15:08:40.250Z] STF 15:08:39.687 - | Mnemonic: CL2 [2025-11-21T15:08:40.251Z] STF 15:08:39.687 - | Echo: ECHO_ON [2025-11-21T15:08:40.251Z] STF 15:08:39.687 - | Expectation: CLEAN_RUN within 30m [2025-11-21T15:08:40.251Z] STF 15:08:39.687 - | [2025-11-21T15:08:40.251Z] STF 15:08:39.687 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/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_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/sthd_server.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/sthd_server.csv auth controlRole control1 localhost 1234 [2025-11-21T15:08:40.251Z] STF 15:08:39.687 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/8.CL2.stderr [2025-11-21T15:08:40.251Z] STF 15:08:39.687 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/results/8.CL2.stdout [2025-11-21T15:08:40.251Z] STF 15:08:39.690 - [2025-11-21T15:08:40.251Z] STF 15:08:39.690 - +------ Step 9 - Wait for processes to complete [2025-11-21T15:08:40.251Z] STF 15:08:39.690 - | Wait for processes to meet expectations [2025-11-21T15:08:40.251Z] STF 15:08:39.690 - | Processes: [LT2, CL2] [2025-11-21T15:08:40.251Z] STF 15:08:39.690 - | [2025-11-21T15:08:40.251Z] STF 15:08:39.690 - Monitoring processes: CL2 LT2 [2025-11-21T15:08:40.635Z] CL2 j> 2025/11/21 15:08:39.881 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-11-21T15:08:40.635Z] CL2 j> 2025/11/21 15:08:39.997 Attempting to connect [2025-11-21T15:08:40.635Z] CL2 j> 2025/11/21 15:08:40.151 Monitored VM not ready at Nov 21, 2025, 3:08:40 PM (attempt 1, elapsed 130ms). [2025-11-21T15:08:40.635Z] CL2 j> 2025/11/21 15:08:40.152 Waiting 5 secs and trying again... [2025-11-21T15:08:46.129Z] CL2 j> 2025/11/21 15:08:45.154 Attempting to connect [2025-11-21T15:08:49.859Z] CL2 j> 2025/11/21 15:08:49.388 Connection established! [2025-11-21T15:09:04.215Z] CL2 j> 2025/11/21 15:09:01.593 Writing report data ... [2025-11-21T15:09:34.110Z] CL2 j> 2025/11/21 15:09:30.628 done. [2025-11-21T15:09:39.860Z] STF 15:09:39.024 - Heartbeat: Process CL2 is still running [2025-11-21T15:09:42.642Z] CL2 j> 2025/11/21 15:09:41.463 Writing report data ... [2025-11-21T15:10:03.724Z] CL2 j> 2025/11/21 15:10:00.933 done. [2025-11-21T15:10:13.960Z] CL2 j> 2025/11/21 15:10:12.543 Writing report data ... [2025-11-21T15:10:34.670Z] CL2 j> 2025/11/21 15:10:33.843 done. [2025-11-21T15:10:45.006Z] CL2 j> 2025/11/21 15:10:44.683 Writing report data ... [2025-11-21T15:11:09.920Z] CL2 j> 2025/11/21 15:11:08.013 done. [2025-11-21T15:11:20.230Z] CL2 j> 2025/11/21 15:11:18.923 Writing report data ... [2025-11-21T15:11:37.653Z] CL2 j> 2025/11/21 15:11:35.944 done. [2025-11-21T15:11:47.711Z] CL2 j> 2025/11/21 15:11:46.633 Writing report data ... [2025-11-21T15:12:05.240Z] CL2 j> 2025/11/21 15:12:02.144 done. [2025-11-21T15:12:13.550Z] CL2 j> 2025/11/21 15:12:12.739 Writing report data ... [2025-11-21T15:12:32.305Z] CL2 j> 2025/11/21 15:12:29.296 done. [2025-11-21T15:12:42.243Z] CL2 j> 2025/11/21 15:12:40.443 Writing report data ... [2025-11-21T15:12:59.572Z] CL2 j> 2025/11/21 15:12:57.803 done. [2025-11-21T15:13:09.828Z] CL2 j> 2025/11/21 15:13:08.414 Writing report data ... [2025-11-21T15:13:27.042Z] CL2 j> 2025/11/21 15:13:25.647 done. [2025-11-21T15:13:39.150Z] CL2 j> 2025/11/21 15:13:36.617 Writing report data ... [2025-11-21T15:13:56.758Z] CL2 j> 2025/11/21 15:13:56.100 done. [2025-11-21T15:14:08.949Z] CL2 j> 2025/11/21 15:14:07.373 Writing report data ... [2025-11-21T15:14:26.523Z] CL2 j> 2025/11/21 15:14:23.273 done. [2025-11-21T15:14:36.588Z] CL2 j> 2025/11/21 15:14:34.524 Writing report data ... [2025-11-21T15:14:40.140Z] STF 15:14:39.312 - Heartbeat: Process CL2 is still running [2025-11-21T15:14:55.127Z] CL2 j> 2025/11/21 15:14:53.264 done. [2025-11-21T15:15:05.485Z] CL2 j> 2025/11/21 15:15:04.248 Writing report data ... [2025-11-21T15:15:26.330Z] CL2 j> 2025/11/21 15:15:24.673 done. [2025-11-21T15:15:38.510Z] CL2 j> 2025/11/21 15:15:36.053 Writing report data ... [2025-11-21T15:15:56.148Z] CL2 j> 2025/11/21 15:15:53.805 done. [2025-11-21T15:16:06.538Z] CL2 j> 2025/11/21 15:16:05.043 Writing report data ... [2025-11-21T15:16:18.548Z] CL2 j> 2025/11/21 15:16:17.962 done. [2025-11-21T15:16:30.886Z] CL2 j> 2025/11/21 15:16:29.263 Writing report data ... [2025-11-21T15:16:48.140Z] CL2 j> 2025/11/21 15:16:47.554 done. [2025-11-21T15:17:00.489Z] CL2 j> 2025/11/21 15:16:58.507 Writing report data ... [2025-11-21T15:17:21.309Z] CL2 j> 2025/11/21 15:17:17.273 done. [2025-11-21T15:17:29.909Z] CL2 j> 2025/11/21 15:17:28.796 Writing report data ... [2025-11-21T15:17:44.021Z] CL2 j> 2025/11/21 15:17:42.869 done. [2025-11-21T15:17:54.441Z] CL2 j> 2025/11/21 15:17:53.231 Writing report data ... [2025-11-21T15:18:09.430Z] CL2 j> 2025/11/21 15:18:07.433 done. [2025-11-21T15:18:20.680Z] CL2 j> 2025/11/21 15:18:17.723 Writing report data ... [2025-11-21T15:18:39.928Z] CL2 j> 2025/11/21 15:18:33.399 done. [2025-11-21T15:18:48.261Z] CL2 j> 2025/11/21 15:18:43.945 Writing report data ... [2025-11-21T15:19:01.622Z] CL2 j> 2025/11/21 15:19:00.773 done. [2025-11-21T15:19:13.790Z] CL2 j> 2025/11/21 15:19:11.693 Writing report data ... [2025-11-21T15:19:26.190Z] CL2 j> 2025/11/21 15:19:24.788 done. [2025-11-21T15:19:38.429Z] CL2 j> 2025/11/21 15:19:37.063 Writing report data ... [2025-11-21T15:19:40.408Z] STF 15:19:39.396 - Heartbeat: Process CL2 is still running [2025-11-21T15:19:55.020Z] CL2 j> 2025/11/21 15:19:54.183 done. [2025-11-21T15:20:07.090Z] CL2 j> 2025/11/21 15:20:05.822 Writing report data ... [2025-11-21T15:20:21.773Z] CL2 j> 2025/11/21 15:20:19.973 done. [2025-11-21T15:20:32.015Z] CL2 j> 2025/11/21 15:20:31.093 Writing report data ... [2025-11-21T15:20:46.505Z] CL2 j> 2025/11/21 15:20:45.104 done. [2025-11-21T15:20:56.730Z] CL2 j> 2025/11/21 15:20:55.673 Writing report data ... [2025-11-21T15:21:14.619Z] CL2 j> 2025/11/21 15:21:13.664 done. [2025-11-21T15:21:26.721Z] CL2 j> 2025/11/21 15:21:24.833 Writing report data ... [2025-11-21T15:21:47.640Z] CL2 j> 2025/11/21 15:21:44.593 done. [2025-11-21T15:21:56.028Z] CL2 j> 2025/11/21 15:21:55.130 Writing report data ... [2025-11-21T15:22:10.960Z] CL2 j> 2025/11/21 15:22:08.016 done. [2025-11-21T15:22:20.759Z] CL2 j> 2025/11/21 15:22:18.975 Writing report data ... [2025-11-21T15:22:37.919Z] CL2 j> 2025/11/21 15:22:35.627 done. [2025-11-21T15:22:47.980Z] CL2 j> 2025/11/21 15:22:46.292 Writing report data ... [2025-11-21T15:22:58.397Z] CL2 j> 2025/11/21 15:22:57.689 done. [2025-11-21T15:22:59.295Z] STF 15:22:59.047 - Monitoring Report Summary: [2025-11-21T15:22:59.295Z] STF 15:22:59.047 - o Process CL2 ended with the expected exit code (0) [2025-11-21T15:22:59.295Z] STF 15:22:59.047 - o Process LT2 is still running as expected [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - +------ Step 10 - Stop LT2 process [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - | Kill running processes [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - | Processes: [LT2] [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - | [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - Killing processes: LT2 [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - o Process clean up attempt 1 for LT2 pid 19556 [2025-11-21T15:22:59.295Z] STF 15:22:59.048 - o Process LT2 pid 19556 stop() [2025-11-21T15:23:11.267Z] STF 15:23:09.133 - o Process LT2 pid 19556 terminate() [2025-11-21T15:23:11.267Z] STF 15:23:10.133 - o Process LT2 pid 19556 killed [2025-11-21T15:23:11.267Z] STF 15:23:10.134 - EXECUTE stage completed [2025-11-21T15:23:11.267Z] STF 15:23:10.527 - [2025-11-21T15:23:11.267Z] STF 15:23:10.527 - ==================== T E A R D O W N ==================== [2025-11-21T15:23:11.267Z] STF 15:23:10.527 - Running teardown: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17637296871227/TestJlmRemoteThreadAuth_1/20251121-145937-TestJlmRemoteThreadAuth/tearDown.pl [2025-11-21T15:23:11.267Z] STF 15:23:10.612 - TEARDOWN stage completed [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - ===================== R E S U L T S ===================== [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - Stage results: [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - setUp: pass [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - execute: pass [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - teardown: pass [2025-11-21T15:23:11.267Z] STF 15:23:10.615 - [2025-11-21T15:23:11.267Z] STF 15:23:10.616 - Overall result: PASSED [2025-11-21T15:23:11.267Z] ----------------------------------- [2025-11-21T15:23:11.267Z] TestJlmRemoteThreadAuth_1_PASSED [2025-11-21T15:23:11.267Z] ----------------------------------- [2025-11-21T15:23:11.267Z] [2025-11-21T15:23:11.267Z] TEST TEARDOWN: [2025-11-21T15:23:11.267Z] Nothing to be done for teardown. [2025-11-21T15:23:11.267Z] TestJlmRemoteThreadAuth_1 Finish Time: Fri Nov 21 15:23:10 2025 Epoch Time (ms): 1763738590643