[2025-07-16T06:12:32.651Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-07-16T06:12:32.651Z] =============================================== [2025-07-16T06:12:32.651Z] TestJlmRemoteThreadNoAuth_1 Start Time: Wed Jul 16 06:12:32 2025 Epoch Time (ms): 1752646352208 [2025-07-16T06:12:32.651Z] variation: Mode650 [2025-07-16T06:12:32.651Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-07-16T06:12:32.651Z] { \ [2025-07-16T06:12:32.651Z] echo ""; echo "TEST SETUP:"; \ [2025-07-16T06:12:32.651Z] echo "Nothing to be done for setup."; \ [2025-07-16T06:12:32.651Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1"; \ [2025-07-16T06:12:32.651Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1"; \ [2025-07-16T06:12:32.651Z] echo ""; echo "TESTING:"; \ [2025-07-16T06:12:32.651Z] perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-07-16T06:12:32.651Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-07-16T06:12:32.651Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-07-16T06:12:32.651Z] echo "Nothing to be done for teardown."; \ [2025-07-16T06:12:32.651Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestTargetResult"; [2025-07-16T06:12:32.651Z] [2025-07-16T06:12:32.651Z] TEST SETUP: [2025-07-16T06:12:32.651Z] Nothing to be done for setup. [2025-07-16T06:12:32.651Z] [2025-07-16T06:12:32.651Z] TESTING: [2025-07-16T06:12:33.451Z] STF 06:12:32.681 - ========================= S T F ========================= [2025-07-16T06:12:33.451Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1 [2025-07-16T06:12:33.451Z] There is 88782 Mb free [2025-07-16T06:12:33.451Z] STF 06:12:32.704 - ================== G E N E R A T I O N ================== [2025-07-16T06:12:33.451Z] STF 06:12:32.706 - Checking JVM: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image [2025-07-16T06:12:33.451Z] STF 06:12:32.706 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth" [2025-07-16T06:12:33.451Z] GEN stderr OpenJDK 64-Bit Server VM warning: 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-07-16T06:12:39.093Z] GEN 06:12:37.909 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-07-16T06:12:39.093Z] GEN 06:12:37.967 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-07-16T06:12:39.093Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-07-16T06:12:39.093Z] GEN /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-07-16T06:12:39.093Z] GEN /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/bin [2025-07-16T06:12:39.093Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-07-16T06:12:39.093Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-07-16T06:12:39.093Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-07-16T06:12:39.093Z] GEN 06:12:38.880 - Using Mode NoOptions. Values = '' [2025-07-16T06:12:39.894Z] GEN 06:12:39.748 - [2025-07-16T06:12:39.894Z] GEN 06:12:39.749 - Test command summary: [2025-07-16T06:12:39.894Z] GEN 06:12:39.780 - Step Stage Command Description [2025-07-16T06:12:39.894Z] GEN 06:12:39.781 - -----+--------+-----------------+------------ [2025-07-16T06:12:39.894Z] GEN 06:12:39.781 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-07-16T06:12:39.894Z] GEN 06:12:39.781 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-07-16T06:12:39.894Z] GEN 06:12:39.782 - 3 execute Monitor Wait for processes to complete [2025-07-16T06:12:39.894Z] GEN 06:12:39.782 - 4 execute kill Stop LT1 process [2025-07-16T06:12:39.894Z] GEN 06:12:39.782 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-07-16T06:12:39.894Z] GEN 06:12:39.782 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-07-16T06:12:39.894Z] GEN 06:12:39.782 - 7 execute Monitor Wait for processes to complete [2025-07-16T06:12:39.894Z] GEN 06:12:39.782 - 8 execute kill Stop LT2 process [2025-07-16T06:12:40.674Z] STF 06:12:39.946 - [2025-07-16T06:12:40.674Z] STF 06:12:39.947 - Script generation completed [2025-07-16T06:12:40.674Z] STF 06:12:39.947 - [2025-07-16T06:12:40.674Z] STF 06:12:39.948 - [2025-07-16T06:12:40.674Z] STF 06:12:39.949 - ======================= S E T U P ======================= [2025-07-16T06:12:40.674Z] STF 06:12:39.949 - Running setup: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/setUp.pl [2025-07-16T06:12:40.674Z] STF 06:12:40.244 - SETUP stage completed [2025-07-16T06:12:40.674Z] STF 06:12:40.261 - [2025-07-16T06:12:40.674Z] STF 06:12:40.261 - ==================== E X E C U T E - ==================== [2025-07-16T06:12:40.674Z] STF 06:12:40.261 - Running execute: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/execute.pl [2025-07-16T06:12:40.674Z] STF 06:12:40.549 - [2025-07-16T06:12:40.674Z] STF 06:12:40.549 - Java version [2025-07-16T06:12:40.674Z] STF 06:12:40.549 - Running: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -version [2025-07-16T06:12:41.493Z] openjdk version "17.0.16" 2025-07-15 [2025-07-16T06:12:41.493Z] OpenJDK Runtime Environment Temurin-17.0.16+8 (build 17.0.16+8) [2025-07-16T06:12:41.493Z] OpenJDK 64-Bit Server VM Temurin-17.0.16+8 (build 17.0.16+8, mixed mode, sharing) [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - | Start background process [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - | Mnemonic: LT1 [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - | Echo: ECHO_OFF [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - | Expectation: NEVER [2025-07-16T06:12:41.493Z] STF 06:12:40.805 - | [2025-07-16T06:12:41.493Z] STF 06:12:40.806 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/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_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results -resultsPrefix 1.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_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/1.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-07-16T06:12:41.493Z] STF 06:12:40.806 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-07-16T06:12:41.493Z] STF 06:12:40.806 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - | Start background process [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - | Mnemonic: CL1 [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - | Echo: ECHO_ON [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - | Expectation: CLEAN_RUN within 30m [2025-07-16T06:12:41.493Z] STF 06:12:40.868 - | [2025-07-16T06:12:41.493Z] STF 06:12:40.872 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/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_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-07-16T06:12:41.493Z] STF 06:12:40.872 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-07-16T06:12:41.493Z] STF 06:12:40.872 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-07-16T06:12:41.493Z] STF 06:12:40.874 - [2025-07-16T06:12:41.493Z] STF 06:12:40.874 - +------ Step 3 - Wait for processes to complete [2025-07-16T06:12:41.493Z] STF 06:12:40.874 - | Wait for processes to meet expectations [2025-07-16T06:12:41.493Z] STF 06:12:40.874 - | Processes: [LT1, CL1] [2025-07-16T06:12:41.493Z] STF 06:12:40.874 - | [2025-07-16T06:12:41.493Z] STF 06:12:40.874 - Monitoring processes: CL1 LT1 [2025-07-16T06:12:44.023Z] CL1 j> 2025/07/16 06:12:42.316 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-07-16T06:12:44.023Z] CL1 j> 2025/07/16 06:12:43.024 Attempting to connect [2025-07-16T06:12:44.819Z] CL1 j> 2025/07/16 06:12:44.199 Monitored VM not ready at Jul 16, 2025, 6:12:44 AM (attempt 1, elapsed 976ms). [2025-07-16T06:12:44.819Z] CL1 j> 2025/07/16 06:12:44.199 Waiting 5 secs and trying again... [2025-07-16T06:12:50.523Z] CL1 j> 2025/07/16 06:12:49.208 Attempting to connect [2025-07-16T06:12:51.300Z] CL1 j> 2025/07/16 06:12:50.736 Connection established! [2025-07-16T06:12:52.080Z] CL1 j> 2025/07/16 06:12:51.687 Starting to write data [2025-07-16T06:17:50.778Z] STF 06:17:40.325 - Heartbeat: Process CL1 is still running [2025-07-16T06:22:48.065Z] STF 06:22:40.248 - Heartbeat: Process CL1 is still running [2025-07-16T06:26:27.219Z] STF 06:26:22.633 - Monitoring Report Summary: [2025-07-16T06:26:27.219Z] STF 06:26:22.634 - o Process CL1 ended with the expected exit code (0) [2025-07-16T06:26:27.219Z] STF 06:26:22.634 - o Process LT1 is still running as expected [2025-07-16T06:26:27.219Z] STF 06:26:22.634 - [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - +------ Step 4 - Stop LT1 process [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - | Kill running processes [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - | Processes: [LT1] [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - | [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - Killing processes: LT1 [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - o Process clean up attempt 1 for LT1 pid 880245 [2025-07-16T06:26:27.219Z] STF 06:26:22.635 - o Process LT1 pid 880245 stop() [2025-07-16T06:26:34.411Z] STF 06:26:32.928 - o Process LT1 pid 880245 terminate() [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - o Process LT1 pid 880245 killed [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - | Start background process [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - | Mnemonic: LT2 [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - | Echo: ECHO_OFF [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - | Expectation: NEVER [2025-07-16T06:26:35.225Z] STF 06:26:33.932 - | [2025-07-16T06:26:35.226Z] STF 06:26:33.933 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/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_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results -resultsPrefix 5.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_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/5.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-07-16T06:26:35.226Z] STF 06:26:33.933 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-07-16T06:26:35.226Z] STF 06:26:33.933 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - | Start background process [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - | Mnemonic: CL2 [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - | Echo: ECHO_ON [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - | Expectation: CLEAN_RUN within 30m [2025-07-16T06:26:35.226Z] STF 06:26:33.935 - | [2025-07-16T06:26:35.226Z] STF 06:26:33.939 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/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_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-07-16T06:26:35.226Z] STF 06:26:33.939 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-07-16T06:26:35.226Z] STF 06:26:33.940 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-07-16T06:26:35.226Z] STF 06:26:33.941 - [2025-07-16T06:26:35.226Z] STF 06:26:33.941 - +------ Step 7 - Wait for processes to complete [2025-07-16T06:26:35.226Z] STF 06:26:33.954 - | Wait for processes to meet expectations [2025-07-16T06:26:35.226Z] STF 06:26:33.954 - | Processes: [LT2, CL2] [2025-07-16T06:26:35.226Z] STF 06:26:33.954 - | [2025-07-16T06:26:35.226Z] STF 06:26:33.954 - Monitoring processes: CL2 LT2 [2025-07-16T06:26:35.990Z] CL2 j> 2025/07/16 06:26:34.962 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-07-16T06:26:35.990Z] CL2 j> 2025/07/16 06:26:35.451 Attempting to connect [2025-07-16T06:26:36.772Z] CL2 j> 2025/07/16 06:26:36.364 Monitored VM not ready at Jul 16, 2025, 6:26:36 AM (attempt 1, elapsed 689ms). [2025-07-16T06:26:36.772Z] CL2 j> 2025/07/16 06:26:36.364 Waiting 5 secs and trying again... [2025-07-16T06:26:42.463Z] CL2 j> 2025/07/16 06:26:41.369 Attempting to connect [2025-07-16T06:26:43.257Z] CL2 j> 2025/07/16 06:26:42.823 Connection established! [2025-07-16T06:27:00.051Z] CL2 j> 2025/07/16 06:26:57.064 Writing report data ... [2025-07-16T06:27:43.339Z] STF 06:27:40.377 - Heartbeat: Process LT2 is still running [2025-07-16T06:27:50.503Z] CL2 j> 2025/07/16 06:27:49.286 done. [2025-07-16T06:28:02.728Z] CL2 j> 2025/07/16 06:28:01.304 Writing report data ... [2025-07-16T06:28:38.900Z] CL2 j> 2025/07/16 06:28:36.084 done. [2025-07-16T06:28:49.327Z] CL2 j> 2025/07/16 06:28:47.417 Writing report data ... [2025-07-16T06:29:25.480Z] CL2 j> 2025/07/16 06:29:21.967 done. [2025-07-16T06:29:34.706Z] CL2 j> 2025/07/16 06:29:33.695 Writing report data ... [2025-07-16T06:30:05.543Z] CL2 j> 2025/07/16 06:30:02.922 done. [2025-07-16T06:30:15.815Z] CL2 j> 2025/07/16 06:30:14.586 Writing report data ... [2025-07-16T06:30:52.029Z] CL2 j> 2025/07/16 06:30:47.442 done. [2025-07-16T06:30:59.322Z] CL2 j> 2025/07/16 06:30:58.403 Writing report data ... [2025-07-16T06:31:30.214Z] CL2 j> 2025/07/16 06:31:25.892 done. [2025-07-16T06:31:38.857Z] CL2 j> 2025/07/16 06:31:37.230 Writing report data ... [2025-07-16T06:32:10.252Z] CL2 j> 2025/07/16 06:32:08.474 done. [2025-07-16T06:32:22.437Z] CL2 j> 2025/07/16 06:32:19.795 Writing report data ... [2025-07-16T06:32:42.104Z] STF 06:32:40.528 - Heartbeat: Process LT2 is still running [2025-07-16T06:32:54.421Z] CL2 j> 2025/07/16 06:32:53.660 done. [2025-07-16T06:33:06.805Z] CL2 j> 2025/07/16 06:33:05.091 Writing report data ... [2025-07-16T06:33:29.442Z] CL2 j> 2025/07/16 06:33:25.715 done. [2025-07-16T06:33:38.238Z] CL2 j> 2025/07/16 06:33:37.008 Writing report data ... [2025-07-16T06:34:10.014Z] CL2 j> 2025/07/16 06:34:06.777 done. [2025-07-16T06:34:18.812Z] CL2 j> 2025/07/16 06:34:17.450 Writing report data ... [2025-07-16T06:34:49.684Z] CL2 j> 2025/07/16 06:34:45.231 done. [2025-07-16T06:34:58.512Z] CL2 j> 2025/07/16 06:34:56.863 Writing report data ... [2025-07-16T06:35:24.978Z] CL2 j> 2025/07/16 06:35:24.247 done. [2025-07-16T06:35:37.282Z] CL2 j> 2025/07/16 06:35:35.239 Writing report data ... [2025-07-16T06:35:53.884Z] CL2 j> 2025/07/16 06:35:53.016 done. [2025-07-16T06:36:05.394Z] CL2 j> 2025/07/16 06:36:03.941 Writing report data ... [2025-07-16T06:36:31.953Z] CL2 j> 2025/07/16 06:36:28.707 done. [2025-07-16T06:36:40.795Z] CL2 j> 2025/07/16 06:36:39.784 Writing report data ... [2025-07-16T06:37:03.464Z] CL2 j> 2025/07/16 06:37:02.381 done. [2025-07-16T06:37:15.374Z] CL2 j> 2025/07/16 06:37:13.434 Writing report data ... [2025-07-16T06:37:42.448Z] STF 06:37:40.032 - Heartbeat: Process LT2 is still running [2025-07-16T06:37:42.448Z] CL2 j> 2025/07/16 06:37:39.690 done. [2025-07-16T06:37:51.171Z] CL2 j> 2025/07/16 06:37:50.437 Writing report data ... [2025-07-16T06:38:18.229Z] CL2 j> 2025/07/16 06:38:17.432 done. [2025-07-16T06:38:30.778Z] CL2 j> 2025/07/16 06:38:29.423 Writing report data ... [2025-07-16T06:38:57.300Z] CL2 j> 2025/07/16 06:38:55.650 done. [2025-07-16T06:39:09.522Z] CL2 j> 2025/07/16 06:39:06.965 Writing report data ... [2025-07-16T06:39:40.783Z] CL2 j> 2025/07/16 06:39:36.203 done. [2025-07-16T06:39:49.637Z] CL2 j> 2025/07/16 06:39:48.693 Writing report data ... [2025-07-16T06:40:13.580Z] CL2 j> 2025/07/16 06:40:10.858 done. [2025-07-16T06:40:24.557Z] CL2 j> 2025/07/16 06:40:22.183 Writing report data ... [2025-07-16T06:40:48.017Z] CL2 j> 2025/07/16 06:40:46.326 done. [2025-07-16T06:40:58.720Z] CL2 j> 2025/07/16 06:40:57.132 Writing report data ... [2025-07-16T06:41:22.089Z] CL2 j> 2025/07/16 06:41:20.552 done. [2025-07-16T06:41:33.640Z] CL2 j> 2025/07/16 06:41:32.229 Writing report data ... [2025-07-16T06:41:57.164Z] CL2 j> 2025/07/16 06:41:54.229 done. [2025-07-16T06:42:06.407Z] CL2 j> 2025/07/16 06:42:04.929 Writing report data ... [2025-07-16T06:42:30.132Z] CL2 j> 2025/07/16 06:42:28.717 done. [2025-07-16T06:42:41.306Z] STF 06:42:40.163 - Heartbeat: Process LT2 is still running [2025-07-16T06:42:41.306Z] CL2 j> 2025/07/16 06:42:40.326 Writing report data ... [2025-07-16T06:43:08.949Z] CL2 j> 2025/07/16 06:43:06.724 done. [2025-07-16T06:43:19.071Z] CL2 j> 2025/07/16 06:43:17.549 Writing report data ... [2025-07-16T06:43:36.576Z] CL2 j> 2025/07/16 06:43:35.010 done. [2025-07-16T06:43:47.732Z] CL2 j> 2025/07/16 06:43:45.464 Writing report data ... [2025-07-16T06:44:05.003Z] CL2 j> 2025/07/16 06:44:02.955 done. [2025-07-16T06:44:14.369Z] CL2 j> 2025/07/16 06:44:13.596 Writing report data ... [2025-07-16T06:44:34.893Z] CL2 j> 2025/07/16 06:44:33.189 done. [2025-07-16T06:44:46.420Z] CL2 j> 2025/07/16 06:44:44.086 Writing report data ... [2025-07-16T06:45:03.579Z] CL2 j> 2025/07/16 06:45:02.715 done. [2025-07-16T06:45:14.348Z] CL2 j> 2025/07/16 06:45:13.324 Writing report data ... [2025-07-16T06:45:42.181Z] CL2 j> 2025/07/16 06:45:40.530 done. [2025-07-16T06:45:43.082Z] STF 06:45:42.245 - Monitoring Report Summary: [2025-07-16T06:45:43.082Z] STF 06:45:42.245 - o Process CL2 ended with the expected exit code (0) [2025-07-16T06:45:43.082Z] STF 06:45:42.245 - o Process LT2 is still running as expected [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - +------ Step 8 - Stop LT2 process [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - | Kill running processes [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - | Processes: [LT2] [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - | [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - Killing processes: LT2 [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - o Process clean up attempt 1 for LT2 pid 880892 [2025-07-16T06:45:43.082Z] STF 06:45:42.265 - o Process LT2 pid 880892 stop() [2025-07-16T06:45:52.603Z] STF 06:45:52.462 - o Process LT2 pid 880892 terminate() [2025-07-16T06:45:54.194Z] STF 06:45:53.465 - o Process LT2 pid 880892 killed [2025-07-16T06:45:54.194Z] STF 06:45:53.465 - EXECUTE stage completed [2025-07-16T06:45:54.194Z] STF 06:45:53.511 - [2025-07-16T06:45:54.194Z] STF 06:45:53.511 - ==================== T E A R D O W N ==================== [2025-07-16T06:45:54.194Z] STF 06:45:53.511 - Running teardown: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17526346571094/TestJlmRemoteThreadNoAuth_1/20250716-061232-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-07-16T06:45:54.998Z] STF 06:45:54.138 - TEARDOWN stage completed [2025-07-16T06:45:54.998Z] STF 06:45:54.168 - [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - ===================== R E S U L T S ===================== [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - Stage results: [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - setUp: pass [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - execute: pass [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - teardown: pass [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - [2025-07-16T06:45:54.998Z] STF 06:45:54.175 - Overall result: PASSED [2025-07-16T06:45:54.998Z] ----------------------------------- [2025-07-16T06:45:54.998Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-07-16T06:45:54.998Z] ----------------------------------- [2025-07-16T06:45:54.998Z] [2025-07-16T06:45:54.998Z] TEST TEARDOWN: [2025-07-16T06:45:54.998Z] Nothing to be done for teardown. [2025-07-16T06:45:54.998Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Wed Jul 16 06:45:54 2025 Epoch Time (ms): 1752648354331