[2025-07-01T21:01:43.408Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-07-01T21:01:43.408Z] =============================================== [2025-07-01T21:01:43.408Z] TestJlmRemoteThreadNoAuth_1 Start Time: Tue Jul 1 21:01:43 2025 Epoch Time (ms): 1751403703337 [2025-07-01T21:01:43.738Z] variation: Mode650 [2025-07-01T21:01:43.738Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-07-01T21:01:43.738Z] { \ [2025-07-01T21:01:43.738Z] echo ""; echo "TEST SETUP:"; \ [2025-07-01T21:01:43.738Z] echo "Nothing to be done for setup."; \ [2025-07-01T21:01:43.738Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17514002587949\\TestJlmRemoteThreadNoAuth_1"; \ [2025-07-01T21:01:43.738Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17514002587949\\TestJlmRemoteThreadNoAuth_1"; \ [2025-07-01T21:01:43.738Z] echo ""; echo "TESTING:"; \ [2025-07-01T21:01:43.739Z] perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\STF;C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\aqa-systemtest""" -systemtest-prereqs="c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\\" -java-args=' -XX:-UseCompressedOops ' -results-root="C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17514002587949\\TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-07-01T21:01:43.739Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17514002587949\\TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-07-01T21:01:43.739Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-07-01T21:01:43.739Z] echo "Nothing to be done for teardown."; \ [2025-07-01T21:01:43.739Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17514002587949\\TestTargetResult"; [2025-07-01T21:01:44.067Z] [2025-07-01T21:01:44.067Z] TEST SETUP: [2025-07-01T21:01:44.067Z] Nothing to be done for setup. [2025-07-01T21:01:44.067Z] [2025-07-01T21:01:44.067Z] TESTING: [2025-07-01T21:01:44.067Z] STF 21:01:43.912 - ========================= S T F ========================= [2025-07-01T21:01:44.067Z] systemtest-prereqs has been processed, and set to: c:/jenkins/testDependency/system_libRetrieving amount of free space on drive containing C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1 [2025-07-01T21:01:44.067Z] There is 92394 Mb free [2025-07-01T21:01:44.067Z] STF 21:01:43.961 - ================== G E N E R A T I O N ================== [2025-07-01T21:01:44.067Z] STF 21:01:43.963 - Checking JVM: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image [2025-07-01T21:01:44.067Z] STF 21:01:43.964 - Starting process to generate scripts: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\/asm/asm.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\/asm/asm-commons.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\/log4j/log4j-api.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth" [2025-07-01T21:01:44.067Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-07-01T21:01:44.067Z] GEN [0.014s][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-07-01T21:01:45.183Z] GEN 21:01:44.905 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: 'C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin' [2025-07-01T21:01:45.183Z] GEN 21:01:44.943 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-07-01T21:01:45.183Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-07-01T21:01:45.183Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2025-07-01T21:01:45.183Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\STF\\stf.core\\bin [2025-07-01T21:01:45.183Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-07-01T21:01:45.183Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-07-01T21:01:45.183Z] GEN c:/jenkins/testDependency/system_lib/junit/junit.jar [2025-07-01T21:01:45.506Z] GEN 21:01:45.135 - Using Mode NoOptions. Values = '' [2025-07-01T21:01:45.506Z] GEN 21:01:45.237 - [2025-07-01T21:01:45.506Z] GEN 21:01:45.237 - Test command summary: [2025-07-01T21:01:45.506Z] GEN 21:01:45.238 - Step Stage Command Description [2025-07-01T21:01:45.506Z] GEN 21:01:45.238 - -----+--------+-----------------+------------ [2025-07-01T21:01:45.506Z] GEN 21:01:45.238 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-07-01T21:01:45.506Z] GEN 21:01:45.238 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-07-01T21:01:45.506Z] GEN 21:01:45.238 - 3 execute Monitor Wait for processes to complete [2025-07-01T21:01:45.506Z] GEN 21:01:45.238 - 4 execute kill Stop LT1 process [2025-07-01T21:01:45.506Z] GEN 21:01:45.239 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-07-01T21:01:45.506Z] GEN 21:01:45.239 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-07-01T21:01:45.506Z] GEN 21:01:45.239 - 7 execute Monitor Wait for processes to complete [2025-07-01T21:01:45.506Z] GEN 21:01:45.239 - 8 execute kill Stop LT2 process [2025-07-01T21:01:45.506Z] STF 21:01:45.279 - [2025-07-01T21:01:45.506Z] STF 21:01:45.279 - Script generation completed [2025-07-01T21:01:45.506Z] STF 21:01:45.279 - [2025-07-01T21:01:45.506Z] STF 21:01:45.281 - [2025-07-01T21:01:45.506Z] STF 21:01:45.281 - ======================= S E T U P ======================= [2025-07-01T21:01:45.506Z] STF 21:01:45.281 - Running setup: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/setUp.pl [2025-07-01T21:01:45.506Z] STF 21:01:45.422 - SETUP stage completed [2025-07-01T21:01:45.506Z] STF 21:01:45.437 - [2025-07-01T21:01:45.506Z] STF 21:01:45.437 - ==================== E X E C U T E - ==================== [2025-07-01T21:01:45.506Z] STF 21:01:45.437 - Running execute: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/execute.pl [2025-07-01T21:01:45.838Z] STF 21:01:45.570 - [2025-07-01T21:01:45.838Z] STF 21:01:45.570 - Java version [2025-07-01T21:01:45.838Z] STF 21:01:45.570 - Running: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -version [2025-07-01T21:01:45.838Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-07-01T21:01:45.838Z] openjdk version "21.0.8-beta" 2025-07-15 [2025-07-01T21:01:45.838Z] OpenJDK Runtime Environment Temurin-21.0.8+8-202507011523 (build 21.0.8-beta+8-202507011523) [2025-07-01T21:01:45.838Z] OpenJDK 64-Bit Server VM Temurin-21.0.8+8-202507011523 (build 21.0.8-beta+8-202507011523, mixed mode, sharing) [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - | Start background process [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - | Mnemonic: LT1 [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - | Echo: ECHO_OFF [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - | Expectation: NEVER [2025-07-01T21:01:45.838Z] STF 21:01:45.657 - | [2025-07-01T21:01:45.839Z] STF 21:01:45.658 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_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 C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\STF\stf.core\bin;c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar;c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar;c:/jenkins/testDependency/system_lib/asm/asm.jar;c:/jenkins/testDependency/system_lib/asm/asm-commons.jar;c:/jenkins/testDependency/system_lib/junit/junit.jar;c:/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\aqa-tests\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1\20250701-210143-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 C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-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-01T21:01:45.839Z] STF 21:01:45.658 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-07-01T21:01:45.839Z] STF 21:01:45.658 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - | Start background process [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - | Mnemonic: CL1 [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - | Echo: ECHO_ON [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - | Expectation: CLEAN_RUN within 30m [2025-07-01T21:01:45.839Z] STF 21:01:45.685 - | [2025-07-01T21:01:45.839Z] STF 21:01:45.686 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;c:/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-07-01T21:01:45.839Z] STF 21:01:45.686 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-07-01T21:01:45.839Z] STF 21:01:45.686 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-07-01T21:01:45.839Z] STF 21:01:45.691 - [2025-07-01T21:01:45.839Z] STF 21:01:45.691 - +------ Step 3 - Wait for processes to complete [2025-07-01T21:01:45.839Z] STF 21:01:45.691 - | Wait for processes to meet expectations [2025-07-01T21:01:45.839Z] STF 21:01:45.691 - | Processes: [LT1, CL1] [2025-07-01T21:01:45.839Z] STF 21:01:45.691 - | [2025-07-01T21:01:45.839Z] STF 21:01:45.691 - Monitoring processes: CL1 LT1 [2025-07-01T21:01:45.839Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-07-01T21:01:46.173Z] CL1 j> 2025/07/01 21:01:45.885 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-07-01T21:01:46.173Z] CL1 j> 2025/07/01 21:01:45.972 Attempting to connect [2025-07-01T21:01:46.577Z] CL1 j> 2025/07/01 21:01:46.233 Monitored VM not ready at Jul 1, 2025, 9:01:46?PM (attempt 1, elapsed 218ms). [2025-07-01T21:01:46.577Z] CL1 j> 2025/07/01 21:01:46.233 Waiting 5 secs and trying again... [2025-07-01T21:01:55.315Z] CL1 j> 2025/07/01 21:01:51.457 Attempting to connect [2025-07-01T21:02:00.225Z] CL1 j> 2025/07/01 21:01:55.891 Connection established! [2025-07-01T21:02:00.225Z] CL1 j> 2025/07/01 21:01:57.622 Starting to write data [2025-07-01T21:07:00.293Z] STF 21:06:45.792 - Heartbeat: Process CL1 is still running [2025-07-01T21:07:31.853Z] STF 21:07:30.802 - Monitoring Report Summary: [2025-07-01T21:07:31.853Z] STF 21:07:30.803 - o Process CL1 ended with the expected exit code (0) [2025-07-01T21:07:31.853Z] STF 21:07:30.832 - o Process LT1 is still running as expected [2025-07-01T21:07:31.853Z] STF 21:07:30.869 - [2025-07-01T21:07:31.853Z] STF 21:07:30.869 - +------ Step 4 - Stop LT1 process [2025-07-01T21:07:31.853Z] STF 21:07:30.898 - | Kill running processes [2025-07-01T21:07:31.853Z] STF 21:07:30.898 - | Processes: [LT1] [2025-07-01T21:07:31.853Z] STF 21:07:30.903 - | [2025-07-01T21:07:31.853Z] STF 21:07:30.903 - Killing processes: LT1 [2025-07-01T21:07:31.853Z] STF 21:07:30.903 - o Process clean up attempt 1 for LT1 pid 37056 [2025-07-01T21:07:31.853Z] STF 21:07:30.903 - o Process LT1 pid 37056 stop() [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - o Process LT1 pid 37056 killed [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - | Start background process [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - | Mnemonic: LT2 [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - | Echo: ECHO_OFF [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - | Expectation: NEVER [2025-07-01T21:07:31.853Z] STF 21:07:30.922 - | [2025-07-01T21:07:31.853Z] STF 21:07:30.923 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_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 C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\STF\stf.core\bin;c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar;c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar;c:/jenkins/testDependency/system_lib/asm/asm.jar;c:/jenkins/testDependency/system_lib/asm/asm-commons.jar;c:/jenkins/testDependency/system_lib/junit/junit.jar;c:/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\aqa-tests\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1\20250701-210143-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 C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-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-01T21:07:31.853Z] STF 21:07:30.923 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-07-01T21:07:31.853Z] STF 21:07:30.923 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-07-01T21:07:31.853Z] STF 21:07:30.930 - [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - | Start background process [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - | Mnemonic: CL2 [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - | Echo: ECHO_ON [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - | Expectation: CLEAN_RUN within 30m [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - | [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;c:/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-07-01T21:07:31.853Z] STF 21:07:30.931 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17514002587949/TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-07-01T21:07:31.853Z] STF 21:07:30.937 - [2025-07-01T21:07:31.853Z] STF 21:07:30.937 - +------ Step 7 - Wait for processes to complete [2025-07-01T21:07:31.853Z] STF 21:07:30.937 - | Wait for processes to meet expectations [2025-07-01T21:07:31.853Z] STF 21:07:30.937 - | Processes: [LT2, CL2] [2025-07-01T21:07:31.853Z] STF 21:07:30.937 - | [2025-07-01T21:07:31.853Z] STF 21:07:30.937 - Monitoring processes: CL2 LT2 [2025-07-01T21:07:31.853Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-07-01T21:07:31.853Z] CL2 j> 2025/07/01 21:07:31.144 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-07-01T21:07:31.853Z] CL2 j> 2025/07/01 21:07:31.220 Attempting to connect [2025-07-01T21:07:31.853Z] CL2 j> 2025/07/01 21:07:31.475 Monitored VM not ready at Jul 1, 2025, 9:07:31?PM (attempt 1, elapsed 221ms). [2025-07-01T21:07:31.853Z] CL2 j> 2025/07/01 21:07:31.475 Waiting 5 secs and trying again... [2025-07-01T21:07:39.019Z] CL2 j> 2025/07/01 21:07:36.763 Attempting to connect [2025-07-01T21:07:40.907Z] CL2 j> 2025/07/01 21:07:38.221 Connection established! [2025-07-01T21:07:59.197Z] CL2 j> 2025/07/01 21:07:52.501 Writing report data ... [2025-07-01T21:07:59.684Z] CL2 j> 2025/07/01 21:07:55.163 done. [2025-07-01T21:08:10.591Z] CL2 j> 2025/07/01 21:08:05.793 Writing report data ... [2025-07-01T21:08:10.591Z] CL2 j> 2025/07/01 21:08:06.413 done. [2025-07-01T21:08:21.953Z] CL2 j> 2025/07/01 21:08:16.778 Writing report data ... [2025-07-01T21:08:21.953Z] CL2 j> 2025/07/01 21:08:18.829 done. [2025-07-01T21:08:33.980Z] CL2 j> 2025/07/01 21:08:29.283 Writing report data ... [2025-07-01T21:08:33.980Z] CL2 j> 2025/07/01 21:08:30.562 done. [2025-07-01T21:08:45.394Z] CL2 j> 2025/07/01 21:08:41.744 Writing report data ... [2025-07-01T21:08:47.952Z] CL2 j> 2025/07/01 21:08:42.697 done. [2025-07-01T21:09:00.395Z] CL2 j> 2025/07/01 21:08:53.115 Writing report data ... [2025-07-01T21:09:00.395Z] CL2 j> 2025/07/01 21:08:53.877 done. [2025-07-01T21:09:08.178Z] CL2 j> 2025/07/01 21:09:04.342 Writing report data ... [2025-07-01T21:09:08.178Z] CL2 j> 2025/07/01 21:09:04.793 done. [2025-07-01T21:09:22.199Z] CL2 j> 2025/07/01 21:09:14.956 Writing report data ... [2025-07-01T21:09:22.199Z] CL2 j> 2025/07/01 21:09:16.016 done. [2025-07-01T21:09:32.329Z] CL2 j> 2025/07/01 21:09:26.499 Writing report data ... [2025-07-01T21:09:32.329Z] CL2 j> 2025/07/01 21:09:26.970 done. [2025-07-01T21:09:42.180Z] CL2 j> 2025/07/01 21:09:37.117 Writing report data ... [2025-07-01T21:09:42.180Z] CL2 j> 2025/07/01 21:09:37.947 done. [2025-07-01T21:09:53.254Z] CL2 j> 2025/07/01 21:09:48.131 Writing report data ... [2025-07-01T21:09:53.682Z] CL2 j> 2025/07/01 21:09:48.603 done. [2025-07-01T21:10:02.766Z] CL2 j> 2025/07/01 21:09:58.973 Writing report data ... [2025-07-01T21:10:02.766Z] CL2 j> 2025/07/01 21:09:59.399 done. [2025-07-01T21:10:13.074Z] CL2 j> 2025/07/01 21:10:09.627 Writing report data ... [2025-07-01T21:10:13.074Z] CL2 j> 2025/07/01 21:10:09.874 done. [2025-07-01T21:10:24.087Z] CL2 j> 2025/07/01 21:10:20.056 Writing report data ... [2025-07-01T21:10:24.087Z] CL2 j> 2025/07/01 21:10:20.321 done. [2025-07-01T21:10:36.592Z] CL2 j> 2025/07/01 21:10:30.707 Writing report data ... [2025-07-01T21:10:36.592Z] CL2 j> 2025/07/01 21:10:31.614 done. [2025-07-01T21:10:44.839Z] CL2 j> 2025/07/01 21:10:42.033 Writing report data ... [2025-07-01T21:10:44.839Z] CL2 j> 2025/07/01 21:10:42.341 done. [2025-07-01T21:10:56.643Z] CL2 j> 2025/07/01 21:10:53.336 Writing report data ... [2025-07-01T21:10:56.643Z] CL2 j> 2025/07/01 21:10:54.168 done. [2025-07-01T21:11:09.110Z] CL2 j> 2025/07/01 21:11:04.323 Writing report data ... [2025-07-01T21:11:09.110Z] CL2 j> 2025/07/01 21:11:04.995 done. [2025-07-01T21:11:20.433Z] CL2 j> 2025/07/01 21:11:15.270 Writing report data ... [2025-07-01T21:11:20.433Z] CL2 j> 2025/07/01 21:11:16.491 done. [2025-07-01T21:11:32.115Z] CL2 j> 2025/07/01 21:11:26.874 Writing report data ... [2025-07-01T21:11:32.115Z] CL2 j> 2025/07/01 21:11:27.847 done. [2025-07-01T21:11:40.062Z] CL2 j> 2025/07/01 21:11:38.044 Writing report data ... [2025-07-01T21:11:44.200Z] CL2 j> 2025/07/01 21:11:38.850 done. [2025-07-01T21:11:47.544Z] STF 21:11:45.185 - Heartbeat: Process CL2 is still running [2025-07-01T21:11:58.519Z] CL2 j> 2025/07/01 21:11:49.250 Writing report data ... [2025-07-01T21:11:58.519Z] CL2 j> 2025/07/01 21:11:49.648 done. [2025-07-01T21:12:04.897Z] CL2 j> 2025/07/01 21:11:59.875 Writing report data ... [2025-07-01T21:12:04.897Z] CL2 j> 2025/07/01 21:12:00.747 done. [2025-07-01T21:12:14.317Z] CL2 j> 2025/07/01 21:12:10.983 Writing report data ... [2025-07-01T21:12:14.317Z] CL2 j> 2025/07/01 21:12:11.984 done. [2025-07-01T21:12:28.242Z] CL2 j> 2025/07/01 21:12:22.244 Writing report data ... [2025-07-01T21:12:28.242Z] CL2 j> 2025/07/01 21:12:22.954 done. [2025-07-01T21:12:40.209Z] CL2 j> 2025/07/01 21:12:33.116 Writing report data ... [2025-07-01T21:12:40.209Z] CL2 j> 2025/07/01 21:12:34.277 done. [2025-07-01T21:12:52.785Z] CL2 j> 2025/07/01 21:12:45.116 Writing report data ... [2025-07-01T21:12:52.785Z] CL2 j> 2025/07/01 21:12:45.893 done. [2025-07-01T21:13:03.071Z] CL2 j> 2025/07/01 21:12:56.203 Writing report data ... [2025-07-01T21:13:03.071Z] CL2 j> 2025/07/01 21:12:56.543 done. [2025-07-01T21:13:10.030Z] CL2 j> 2025/07/01 21:13:06.743 Writing report data ... [2025-07-01T21:13:11.580Z] CL2 j> 2025/07/01 21:13:07.273 done. [2025-07-01T21:13:21.034Z] CL2 j> 2025/07/01 21:13:17.773 Writing report data ... [2025-07-01T21:13:21.034Z] CL2 j> 2025/07/01 21:13:18.164 done. [2025-07-01T21:13:26.291Z] STF 21:13:25.553 - Monitoring Report Summary: [2025-07-01T21:13:26.291Z] STF 21:13:25.622 - o Process CL2 ended with the expected exit code (0) [2025-07-01T21:13:26.291Z] STF 21:13:25.622 - o Process LT2 is still running as expected [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - +------ Step 8 - Stop LT2 process [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - | Kill running processes [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - | Processes: [LT2] [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - | [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - Killing processes: LT2 [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - o Process clean up attempt 1 for LT2 pid 20876 [2025-07-01T21:13:26.291Z] STF 21:13:25.623 - o Process LT2 pid 20876 stop() [2025-07-01T21:13:26.291Z] STF 21:13:25.624 - o Process LT2 pid 20876 killed [2025-07-01T21:13:26.291Z] STF 21:13:25.624 - EXECUTE stage completed [2025-07-01T21:13:26.291Z] STF 21:13:26.140 - [2025-07-01T21:13:26.291Z] STF 21:13:26.140 - ==================== T E A R D O W N ==================== [2025-07-01T21:13:26.291Z] STF 21:13:26.140 - Running teardown: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17514002587949\TestJlmRemoteThreadNoAuth_1/20250701-210143-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-07-01T21:13:26.603Z] STF 21:13:26.270 - TEARDOWN stage completed [2025-07-01T21:13:26.603Z] STF 21:13:26.290 - [2025-07-01T21:13:26.603Z] STF 21:13:26.290 - ===================== R E S U L T S ===================== [2025-07-01T21:13:26.603Z] STF 21:13:26.290 - Stage results: [2025-07-01T21:13:26.603Z] STF 21:13:26.290 - setUp: pass [2025-07-01T21:13:26.603Z] STF 21:13:26.290 - execute: pass [2025-07-01T21:13:26.603Z] STF 21:13:26.290 - teardown: pass [2025-07-01T21:13:26.603Z] STF 21:13:26.291 - [2025-07-01T21:13:26.603Z] STF 21:13:26.291 - Overall result: PASSED [2025-07-01T21:13:26.603Z] ----------------------------------- [2025-07-01T21:13:26.603Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-07-01T21:13:26.603Z] ----------------------------------- [2025-07-01T21:13:26.603Z] [2025-07-01T21:13:26.603Z] TEST TEARDOWN: [2025-07-01T21:13:26.603Z] Nothing to be done for teardown. [2025-07-01T21:13:26.603Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Tue Jul 1 21:13:26 2025 Epoch Time (ms): 1751404406460