[2025-05-29T23:52:42.992Z] Running test TestJlmRemoteThreadAuth_1 ... [2025-05-29T23:52:42.992Z] =============================================== [2025-05-29T23:52:42.992Z] TestJlmRemoteThreadAuth_1 Start Time: Thu May 29 23:52:42 2025 Epoch Time (ms): 1748562762637 [2025-05-29T23:52:42.992Z] variation: Mode650 [2025-05-29T23:52:42.992Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-05-29T23:52:42.992Z] { \ [2025-05-29T23:52:42.992Z] echo ""; echo "TEST SETUP:"; \ [2025-05-29T23:52:42.992Z] echo "Nothing to be done for setup."; \ [2025-05-29T23:52:42.992Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1"; \ [2025-05-29T23:52:42.992Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1"; \ [2025-05-29T23:52:42.992Z] echo ""; echo "TESTING:"; \ [2025-05-29T23:52:42.993Z] perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1" -test=TestJlmRemoteThreadAuth; \ [2025-05-29T23:52:42.993Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-29T23:52:42.993Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-29T23:52:42.993Z] echo "Nothing to be done for teardown."; \ [2025-05-29T23:52:42.993Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestTargetResult"; [2025-05-29T23:52:42.993Z] [2025-05-29T23:52:42.993Z] TEST SETUP: [2025-05-29T23:52:42.993Z] Nothing to be done for setup. [2025-05-29T23:52:42.993Z] [2025-05-29T23:52:42.993Z] TESTING: [2025-05-29T23:52:42.993Z] STF 23:52:42.814 - ========================= S T F ========================= [2025-05-29T23:52:42.993Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1 [2025-05-29T23:52:42.993Z] There is 135293 Mb free [2025-05-29T23:52:42.993Z] STF 23:52:42.849 - ================== G E N E R A T I O N ================== [2025-05-29T23:52:42.993Z] STF 23:52:42.850 - Checking JVM: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image [2025-05-29T23:52:42.993Z] STF 23:52:42.850 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/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_s390x_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth" [2025-05-29T23:52:43.577Z] GEN [0.028s][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-05-29T23:52:48.295Z] GEN 23:52:47.592 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-05-29T23:52:48.295Z] GEN 23:52:47.650 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadAuth' [2025-05-29T23:52:48.907Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-05-29T23:52:48.907Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-05-29T23:52:48.907Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/bin [2025-05-29T23:52:48.907Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-05-29T23:52:48.907Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-05-29T23:52:48.907Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-05-29T23:52:48.907Z] GEN 23:52:48.738 - Using Mode NoOptions. Values = '' [2025-05-29T23:52:49.467Z] GEN 23:52:49.277 - [2025-05-29T23:52:49.467Z] GEN 23:52:49.278 - Test command summary: [2025-05-29T23:52:49.467Z] GEN 23:52:49.281 - Step Stage Command Description [2025-05-29T23:52:49.467Z] GEN 23:52:49.281 - -----+--------+-----------------+------------ [2025-05-29T23:52:49.467Z] GEN 23:52:49.281 - 1 setUp cp Copying password file to temp [2025-05-29T23:52:49.467Z] GEN 23:52:49.283 - 2 setUp chmod Restricting file permission of jmxremote.passsword to 600 [2025-05-29T23:52:49.467Z] GEN 23:52:49.283 - 3 execute Run java Running ThreadProfiler Proxy test Server Process(with security) [2025-05-29T23:52:49.467Z] GEN 23:52:49.283 - 4 execute Run java Running Monitoring Client with proxy connection(with security) [2025-05-29T23:52:49.467Z] GEN 23:52:49.284 - 5 execute Monitor Wait for the processes to complete [2025-05-29T23:52:49.467Z] GEN 23:52:49.284 - 6 execute kill Stop LT1 process [2025-05-29T23:52:49.467Z] GEN 23:52:49.284 - 7 execute Run java Running ThreadProfiler Server test Server Process(with security) [2025-05-29T23:52:49.467Z] GEN 23:52:49.285 - 8 execute Run java Run the Monitoring Client with server-connection(with security) [2025-05-29T23:52:49.467Z] GEN 23:52:49.285 - 9 execute Monitor Wait for processes to complete [2025-05-29T23:52:49.468Z] GEN 23:52:49.285 - 10 execute kill Stop LT2 process [2025-05-29T23:52:50.028Z] STF 23:52:49.477 - [2025-05-29T23:52:50.028Z] STF 23:52:49.477 - Script generation completed [2025-05-29T23:52:50.028Z] STF 23:52:49.477 - [2025-05-29T23:52:50.028Z] STF 23:52:49.478 - [2025-05-29T23:52:50.028Z] STF 23:52:49.478 - ======================= S E T U P ======================= [2025-05-29T23:52:50.028Z] STF 23:52:49.478 - Running setup: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/setUp.pl [2025-05-29T23:52:50.028Z] STF 23:52:49.614 - [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - +------ Step 1 - Copying password file to temp [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | Copy a file to another directory [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | Source file: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/src/test.jlm/net/adoptopenjdk/test/jlm/jmxremote.password [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | Dest dir: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tmp [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - +------ Step 2 - Restricting file permission of jmxremote.passsword to 600 [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | Change file permission [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | targetFile: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tmp/jmxremote.password [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | modeBits: 600 [2025-05-29T23:52:50.028Z] STF 23:52:49.615 - | [2025-05-29T23:52:50.028Z] STF 23:52:49.636 - SETUP stage completed [2025-05-29T23:52:50.028Z] STF 23:52:49.642 - [2025-05-29T23:52:50.028Z] STF 23:52:49.642 - ==================== E X E C U T E - ==================== [2025-05-29T23:52:50.028Z] STF 23:52:49.642 - Running execute: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/execute.pl [2025-05-29T23:52:50.028Z] STF 23:52:49.787 - [2025-05-29T23:52:50.028Z] STF 23:52:49.787 - Java version [2025-05-29T23:52:50.028Z] STF 23:52:49.787 - Running: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -version [2025-05-29T23:52:50.599Z] openjdk version "25-beta" 2025-09-16 [2025-05-29T23:52:50.599Z] OpenJDK Runtime Environment Temurin-25+25-202505292031 (build 25-beta+25-ea) [2025-05-29T23:52:50.599Z] OpenJDK 64-Bit Server VM Temurin-25+25-202505292031 (build 25-beta+25-ea, mixed mode, sharing) [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - +------ Step 3 - Running ThreadProfiler Proxy test Server Process(with security) [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - | Start background process [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - | Mnemonic: LT1 [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - | Echo: ECHO_OFF [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - | Expectation: NEVER [2025-05-29T23:52:50.599Z] STF 23:52:50.090 - | [2025-05-29T23:52:50.599Z] STF 23:52:50.092 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/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_s390x_linux_testList_2/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_s390x_linux_testList_2/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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/asm/asm.jar:/home/jenkins/testDependency/system_lib/asm/asm-commons.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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-05-29T23:52:50.599Z] STF 23:52:50.092 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/3.LT1.stderr [2025-05-29T23:52:50.599Z] STF 23:52:50.092 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/3.LT1.stdout [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - +------ Step 4 - Running Monitoring Client with proxy connection(with security) [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - | Start background process [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - | Mnemonic: CL1 [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - | Echo: ECHO_ON [2025-05-29T23:52:50.599Z] STF 23:52:50.122 - | Expectation: CLEAN_RUN within 30m [2025-05-29T23:52:50.599Z] STF 23:52:50.123 - | [2025-05-29T23:52:50.599Z] STF 23:52:50.123 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -Xmx256m -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/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_s390x_linux_testList_2/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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/sthd_proxy.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/sthd_proxy.csv auth controlRole control1 localhost 1234 [2025-05-29T23:52:50.599Z] STF 23:52:50.123 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/4.CL1.stderr [2025-05-29T23:52:50.599Z] STF 23:52:50.123 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/4.CL1.stdout [2025-05-29T23:52:50.599Z] STF 23:52:50.124 - [2025-05-29T23:52:50.599Z] STF 23:52:50.124 - +------ Step 5 - Wait for the processes to complete [2025-05-29T23:52:50.599Z] STF 23:52:50.124 - | Wait for processes to meet expectations [2025-05-29T23:52:50.599Z] STF 23:52:50.124 - | Processes: [LT1, CL1] [2025-05-29T23:52:50.599Z] STF 23:52:50.124 - | [2025-05-29T23:52:50.599Z] STF 23:52:50.124 - Monitoring processes: CL1 LT1 [2025-05-29T23:52:55.529Z] CL1 j> 2025/05/29 23:52:51.854 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-05-29T23:52:55.529Z] CL1 j> 2025/05/29 23:52:54.309 Attempting to connect [2025-05-29T23:53:24.748Z] CL1 j> 2025/05/29 23:53:22.124 Connection established! [2025-05-29T23:53:27.897Z] CL1 j> 2025/05/29 23:53:26.769 Starting to write data [2025-05-29T23:57:50.966Z] STF 23:57:49.070 - Heartbeat: Process CL1 is still running [2025-05-30T00:02:57.377Z] STF 00:02:49.129 - Heartbeat: Process CL1 is still running [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - Monitoring Report Summary: [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - o Process CL1 ended with the expected exit code (0) [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - o Process LT1 is still running as expected [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - +------ Step 6 - Stop LT1 process [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - | Kill running processes [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - | Processes: [LT1] [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - | [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - Killing processes: LT1 [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - o Process clean up attempt 1 for LT1 pid 1827391 [2025-05-30T00:04:14.107Z] STF 00:04:04.380 - o Process LT1 pid 1827391 stop() [2025-05-30T00:04:14.724Z] STF 00:04:14.511 - o Process LT1 pid 1827391 terminate() [2025-05-30T00:04:15.926Z] STF 00:04:15.511 - o Process LT1 pid 1827391 killed [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - +------ Step 7 - Running ThreadProfiler Server test Server Process(with security) [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - | Start background process [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - | Mnemonic: LT2 [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - | Echo: ECHO_OFF [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - | Expectation: NEVER [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - | [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/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_s390x_linux_testList_2/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_s390x_linux_testList_2/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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/asm/asm.jar:/home/jenkins/testDependency/system_lib/asm/asm-commons.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-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-05-30T00:04:15.926Z] STF 00:04:15.512 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/7.LT2.stderr [2025-05-30T00:04:15.926Z] STF 00:04:15.512 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/7.LT2.stdout [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - +------ Step 8 - Run the Monitoring Client with server-connection(with security) [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - | Start background process [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - | Mnemonic: CL2 [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - | Echo: ECHO_ON [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - | Expectation: CLEAN_RUN within 30m [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - | [2025-05-30T00:04:15.926Z] STF 00:04:15.514 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -Xmx256m -Djavax.net.ssl.keyStore=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/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_s390x_linux_testList_2/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_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tmp/jmxremote.password -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/sthd_server.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/sthd_server.csv auth controlRole control1 localhost 1234 [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/8.CL2.stderr [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/results/8.CL2.stdout [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - +------ Step 9 - Wait for processes to complete [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - | Wait for processes to meet expectations [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - | Processes: [LT2, CL2] [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - | [2025-05-30T00:04:15.926Z] STF 00:04:15.515 - Monitoring processes: CL2 LT2 [2025-05-30T00:04:18.077Z] CL2 j> 2025/05/30 00:04:16.894 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-05-30T00:04:18.077Z] CL2 j> 2025/05/30 00:04:17.556 Attempting to connect [2025-05-30T00:04:30.718Z] CL2 j> 2025/05/30 00:04:28.618 Connection established! [2025-05-30T00:05:04.688Z] CL2 j> 2025/05/30 00:05:01.399 Writing report data ... [2025-05-30T00:06:09.458Z] CL2 j> 2025/05/30 00:06:03.250 done. [2025-05-30T00:06:18.759Z] CL2 j> 2025/05/30 00:06:18.359 Writing report data ... [2025-05-30T00:06:47.113Z] CL2 j> 2025/05/30 00:06:44.560 done. [2025-05-30T00:06:59.083Z] CL2 j> 2025/05/30 00:06:57.123 Writing report data ... [2025-05-30T00:07:55.737Z] CL2 j> 2025/05/30 00:07:46.969 done. [2025-05-30T00:07:55.737Z] STF 00:07:49.383 - Heartbeat: Process LT2 is still running [2025-05-30T00:07:58.630Z] CL2 j> 2025/05/30 00:07:57.942 Writing report data ... [2025-05-30T00:08:23.836Z] CL2 j> 2025/05/30 00:08:22.512 done. [2025-05-30T00:08:34.739Z] CL2 j> 2025/05/30 00:08:33.146 Writing report data ... [2025-05-30T00:08:59.208Z] CL2 j> 2025/05/30 00:08:55.831 done. [2025-05-30T00:09:08.518Z] CL2 j> 2025/05/30 00:09:07.253 Writing report data ... [2025-05-30T00:09:25.781Z] CL2 j> 2025/05/30 00:09:23.714 done. [2025-05-30T00:09:36.707Z] CL2 j> 2025/05/30 00:09:34.743 Writing report data ... [2025-05-30T00:10:00.222Z] CL2 j> 2025/05/30 00:09:58.051 done. [2025-05-30T00:10:11.174Z] CL2 j> 2025/05/30 00:10:09.101 Writing report data ... [2025-05-30T00:10:32.465Z] CL2 j> 2025/05/30 00:10:29.468 done. [2025-05-30T00:10:41.837Z] CL2 j> 2025/05/30 00:10:41.347 Writing report data ... [2025-05-30T00:11:10.789Z] CL2 j> 2025/05/30 00:11:06.132 done. [2025-05-30T00:11:20.142Z] CL2 j> 2025/05/30 00:11:18.440 Writing report data ... [2025-05-30T00:11:48.592Z] CL2 j> 2025/05/30 00:11:44.902 done. [2025-05-30T00:11:58.259Z] CL2 j> 2025/05/30 00:11:56.187 Writing report data ... [2025-05-30T00:12:18.547Z] CL2 j> 2025/05/30 00:12:14.796 done. [2025-05-30T00:12:31.063Z] CL2 j> 2025/05/30 00:12:29.093 Writing report data ... [2025-05-30T00:12:52.178Z] STF 00:12:49.404 - Heartbeat: Process LT2 is still running [2025-05-30T00:13:02.787Z] CL2 j> 2025/05/30 00:13:01.715 done. [2025-05-30T00:13:15.727Z] CL2 j> 2025/05/30 00:13:13.733 Writing report data ... [2025-05-30T00:13:44.910Z] CL2 j> 2025/05/30 00:13:40.613 done. [2025-05-30T00:13:53.687Z] CL2 j> 2025/05/30 00:13:52.391 Writing report data ... [2025-05-30T00:14:22.101Z] CL2 j> 2025/05/30 00:14:18.004 done. [2025-05-30T00:14:30.967Z] CL2 j> 2025/05/30 00:14:28.856 Writing report data ... [2025-05-30T00:14:42.932Z] CL2 j> 2025/05/30 00:14:41.498 done. [2025-05-30T00:14:55.075Z] CL2 j> 2025/05/30 00:14:53.452 Writing report data ... [2025-05-30T00:15:12.364Z] CL2 j> 2025/05/30 00:15:11.474 done. [2025-05-30T00:15:24.687Z] CL2 j> 2025/05/30 00:15:23.249 Writing report data ... [2025-05-30T00:15:44.695Z] CL2 j> 2025/05/30 00:15:41.701 done. [2025-05-30T00:15:54.903Z] CL2 j> 2025/05/30 00:15:53.363 Writing report data ... [2025-05-30T00:16:23.820Z] CL2 j> 2025/05/30 00:16:21.930 done. [2025-05-30T00:16:34.348Z] CL2 j> 2025/05/30 00:16:33.123 Writing report data ... [2025-05-30T00:17:02.499Z] CL2 j> 2025/05/30 00:16:58.235 done. [2025-05-30T00:17:10.047Z] CL2 j> 2025/05/30 00:17:09.320 Writing report data ... [2025-05-30T00:17:31.070Z] CL2 j> 2025/05/30 00:17:28.279 done. [2025-05-30T00:17:41.650Z] CL2 j> 2025/05/30 00:17:39.715 Writing report data ... [2025-05-30T00:17:49.594Z] STF 00:17:49.049 - Heartbeat: Process LT2 is still running [2025-05-30T00:18:07.147Z] CL2 j> 2025/05/30 00:18:03.850 done. [2025-05-30T00:18:16.359Z] CL2 j> 2025/05/30 00:18:14.900 Writing report data ... [2025-05-30T00:18:46.268Z] CL2 j> 2025/05/30 00:18:42.561 done. [2025-05-30T00:18:57.337Z] CL2 j> 2025/05/30 00:18:55.912 Writing report data ... [2025-05-30T00:19:37.151Z] CL2 j> 2025/05/30 00:19:36.024 done. [2025-05-30T00:19:48.534Z] CL2 j> 2025/05/30 00:19:47.574 Writing report data ... [2025-05-30T00:20:01.905Z] CL2 j> 2025/05/30 00:20:00.268 done. [2025-05-30T00:20:15.302Z] CL2 j> 2025/05/30 00:20:12.393 Writing report data ... [2025-05-30T00:20:43.211Z] CL2 j> 2025/05/30 00:20:40.703 done. [2025-05-30T00:20:52.107Z] CL2 j> 2025/05/30 00:20:51.531 Writing report data ... [2025-05-30T00:21:10.397Z] CL2 j> 2025/05/30 00:21:07.087 done. [2025-05-30T00:21:18.976Z] CL2 j> 2025/05/30 00:21:17.511 Writing report data ... [2025-05-30T00:21:26.107Z] CL2 j> 2025/05/30 00:21:24.863 done. [2025-05-30T00:21:38.354Z] CL2 j> 2025/05/30 00:21:35.578 Writing report data ... [2025-05-30T00:21:56.860Z] CL2 j> 2025/05/30 00:21:54.028 done. [2025-05-30T00:22:11.084Z] CL2 j> 2025/05/30 00:22:09.469 Writing report data ... [2025-05-30T00:22:26.207Z] CL2 j> 2025/05/30 00:22:24.180 done. [2025-05-30T00:22:36.506Z] CL2 j> 2025/05/30 00:22:35.910 Writing report data ... [2025-05-30T00:22:51.150Z] STF 00:22:49.211 - Heartbeat: Process LT2 is still running [2025-05-30T00:22:51.150Z] CL2 j> 2025/05/30 00:22:50.303 done. [2025-05-30T00:22:52.610Z] STF 00:22:51.824 - Monitoring Report Summary: [2025-05-30T00:22:52.610Z] STF 00:22:51.824 - o Process CL2 ended with the expected exit code (0) [2025-05-30T00:22:52.610Z] STF 00:22:51.824 - o Process LT2 is still running as expected [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - +------ Step 10 - Stop LT2 process [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - | Kill running processes [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - | Processes: [LT2] [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - | [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - Killing processes: LT2 [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - o Process clean up attempt 1 for LT2 pid 1827960 [2025-05-30T00:22:52.610Z] STF 00:22:51.825 - o Process LT2 pid 1827960 stop() [2025-05-30T00:23:02.374Z] STF 00:23:01.075 - o Process LT2 pid 1827960 terminate() [2025-05-30T00:23:03.608Z] STF 00:23:03.089 - o Process LT2 pid 1827960 killed [2025-05-30T00:23:03.608Z] STF 00:23:03.090 - EXECUTE stage completed [2025-05-30T00:23:03.608Z] STF 00:23:03.471 - [2025-05-30T00:23:03.608Z] STF 00:23:03.471 - ==================== T E A R D O W N ==================== [2025-05-30T00:23:03.608Z] STF 00:23:03.471 - Running teardown: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17485585158923/TestJlmRemoteThreadAuth_1/20250529-235242-TestJlmRemoteThreadAuth/tearDown.pl [2025-05-30T00:23:04.167Z] STF 00:23:03.773 - TEARDOWN stage completed [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - ===================== R E S U L T S ===================== [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - Stage results: [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - setUp: pass [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - execute: pass [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - teardown: pass [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - [2025-05-30T00:23:04.167Z] STF 00:23:03.782 - Overall result: PASSED [2025-05-30T00:23:04.167Z] ----------------------------------- [2025-05-30T00:23:04.167Z] TestJlmRemoteThreadAuth_1_PASSED [2025-05-30T00:23:04.167Z] ----------------------------------- [2025-05-30T00:23:04.167Z] [2025-05-30T00:23:04.167Z] TEST TEARDOWN: [2025-05-30T00:23:04.167Z] Nothing to be done for teardown. [2025-05-30T00:23:04.167Z] TestJlmRemoteThreadAuth_1 Finish Time: Fri May 30 00:23:04 2025 Epoch Time (ms): 1748564584018