[2025-09-04T01:01:58.107Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-09-04T01:01:58.107Z] =============================================== [2025-09-04T01:01:58.107Z] TestJlmRemoteThreadNoAuth_1 Start Time: Thu Sep 4 01:01:58 2025 Epoch Time (ms): 1756947718001 [2025-09-04T01:01:58.450Z] variation: Mode650 [2025-09-04T01:01:58.450Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-09-04T01:01:58.450Z] { \ [2025-09-04T01:01:58.450Z] echo ""; echo "TEST SETUP:"; \ [2025-09-04T01:01:58.450Z] echo "Nothing to be done for setup."; \ [2025-09-04T01:01:58.450Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17569442893160\\TestJlmRemoteThreadNoAuth_1"; \ [2025-09-04T01:01:58.450Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17569442893160\\TestJlmRemoteThreadNoAuth_1"; \ [2025-09-04T01:01:58.450Z] echo ""; echo "TESTING:"; \ [2025-09-04T01:01:58.450Z] 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/../../externalDependency/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_17569442893160\\TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-09-04T01:01:58.450Z] 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_17569442893160\\TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-04T01:01:58.450Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-04T01:01:58.450Z] echo "Nothing to be done for teardown."; \ [2025-09-04T01:01:58.450Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17569442893160\\TestTargetResult"; [2025-09-04T01:01:58.450Z] [2025-09-04T01:01:58.450Z] TEST SETUP: [2025-09-04T01:01:58.450Z] Nothing to be done for setup. [2025-09-04T01:01:58.450Z] [2025-09-04T01:01:58.450Z] TESTING: [2025-09-04T01:01:58.789Z] STF 01:01:58.408 - ========================= S T F ========================= [2025-09-04T01:01:58.789Z] systemtest-prereqs has been processed, and set to: c:/jenkins/externalDependency/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_17569442893160\TestJlmRemoteThreadNoAuth_1 [2025-09-04T01:01:58.789Z] There is 123996 Mb free [2025-09-04T01:01:58.789Z] STF 01:01:58.463 - ================== G E N E R A T I O N ================== [2025-09-04T01:01:58.789Z] STF 01:01:58.465 - Checking JVM: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image [2025-09-04T01:01:58.789Z] STF 01:01:58.466 - 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/../../externalDependency/system_lib\/asm/asm.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../externalDependency/system_lib\/asm/asm-commons.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../externalDependency/system_lib\/log4j/log4j-api.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../externalDependency/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_17569442893160\TestJlmRemoteThreadNoAuth_1/20250904-010158-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_17569442893160\TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth" [2025-09-04T01:01:58.789Z] GEN [0.011s][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-09-04T01:01:58.789Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-04T01:01:59.930Z] GEN 01:01:59.486 - 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-09-04T01:01:59.930Z] GEN 01:01:59.517 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-09-04T01:01:59.930Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-09-04T01:01:59.930Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2025-09-04T01:01:59.930Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\STF\\stf.core\\bin [2025-09-04T01:01:59.930Z] GEN c:/jenkins/externalDependency/system_lib/log4j/log4j-api.jar [2025-09-04T01:01:59.930Z] GEN c:/jenkins/externalDependency/system_lib/log4j/log4j-core.jar [2025-09-04T01:01:59.930Z] GEN c:/jenkins/externalDependency/system_lib/junit/junit.jar [2025-09-04T01:01:59.930Z] GEN 01:01:59.706 - Using Mode NoOptions. Values = '' [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - Test command summary: [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - Step Stage Command Description [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - -----+--------+-----------------+------------ [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 3 execute Monitor Wait for processes to complete [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 4 execute kill Stop LT1 process [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 7 execute Monitor Wait for processes to complete [2025-09-04T01:01:59.930Z] GEN 01:01:59.847 - 8 execute kill Stop LT2 process [2025-09-04T01:02:00.269Z] STF 01:01:59.896 - [2025-09-04T01:02:00.269Z] STF 01:01:59.896 - Script generation completed [2025-09-04T01:02:00.269Z] STF 01:01:59.896 - [2025-09-04T01:02:00.269Z] STF 01:01:59.898 - [2025-09-04T01:02:00.269Z] STF 01:01:59.898 - ======================= S E T U P ======================= [2025-09-04T01:02:00.269Z] STF 01:01:59.898 - Running setup: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17569442893160\TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/setUp.pl [2025-09-04T01:02:00.269Z] STF 01:02:00.034 - SETUP stage completed [2025-09-04T01:02:00.269Z] STF 01:02:00.062 - [2025-09-04T01:02:00.269Z] STF 01:02:00.062 - ==================== E X E C U T E - ==================== [2025-09-04T01:02:00.269Z] STF 01:02:00.062 - Running execute: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17569442893160\TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/execute.pl [2025-09-04T01:02:00.269Z] STF 01:02:00.191 - [2025-09-04T01:02:00.269Z] STF 01:02:00.191 - Java version [2025-09-04T01:02:00.269Z] STF 01:02:00.191 - Running: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -version [2025-09-04T01:02:00.269Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-04T01:02:00.615Z] openjdk version "21.0.9-beta" 2025-10-21 [2025-09-04T01:02:00.615Z] OpenJDK Runtime Environment Temurin-21.0.9+6-202509031913 (build 21.0.9-beta+6-ea) [2025-09-04T01:02:00.615Z] OpenJDK 64-Bit Server VM Temurin-21.0.9+6-202509031913 (build 21.0.9-beta+6-ea, mixed mode, sharing) [2025-09-04T01:02:00.615Z] STF 01:02:00.292 - [2025-09-04T01:02:00.615Z] STF 01:02:00.292 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-09-04T01:02:00.615Z] STF 01:02:00.292 - | Start background process [2025-09-04T01:02:00.615Z] STF 01:02:00.292 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-09-04T01:02:00.615Z] STF 01:02:00.293 - | Mnemonic: LT1 [2025-09-04T01:02:00.615Z] STF 01:02:00.293 - | Echo: ECHO_OFF [2025-09-04T01:02:00.615Z] STF 01:02:00.293 - | Expectation: NEVER [2025-09-04T01:02:00.615Z] STF 01:02:00.293 - | [2025-09-04T01:02:00.615Z] STF 01:02:00.293 - 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/externalDependency/system_lib/log4j/log4j-api.jar;c:/jenkins/externalDependency/system_lib/log4j/log4j-core.jar;c:/jenkins/externalDependency/system_lib/asm/asm.jar;c:/jenkins/externalDependency/system_lib/asm/asm-commons.jar;c:/jenkins/externalDependency/system_lib/junit/junit.jar;c:/jenkins/externalDependency/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_17569442893160\TestJlmRemoteThreadNoAuth_1\20250904-010158-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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-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-09-04T01:02:00.615Z] STF 01:02:00.293 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-09-04T01:02:00.615Z] STF 01:02:00.293 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - | Start background process [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - | Mnemonic: CL1 [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - | Echo: ECHO_ON [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - | Expectation: CLEAN_RUN within 30m [2025-09-04T01:02:00.615Z] STF 01:02:00.322 - | [2025-09-04T01:02:00.615Z] STF 01:02:00.323 - 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/externalDependency/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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-09-04T01:02:00.615Z] STF 01:02:00.323 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-09-04T01:02:00.615Z] STF 01:02:00.323 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-09-04T01:02:00.615Z] STF 01:02:00.328 - [2025-09-04T01:02:00.615Z] STF 01:02:00.328 - +------ Step 3 - Wait for processes to complete [2025-09-04T01:02:00.615Z] STF 01:02:00.328 - | Wait for processes to meet expectations [2025-09-04T01:02:00.615Z] STF 01:02:00.328 - | Processes: [LT1, CL1] [2025-09-04T01:02:00.615Z] STF 01:02:00.328 - | [2025-09-04T01:02:00.615Z] STF 01:02:00.328 - Monitoring processes: CL1 LT1 [2025-09-04T01:02:00.615Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-04T01:02:00.948Z] CL1 j> 2025/09/04 01:02:00.503 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-09-04T01:02:00.948Z] CL1 j> 2025/09/04 01:02:00.581 Attempting to connect [2025-09-04T01:02:01.289Z] CL1 j> 2025/09/04 01:02:00.866 Monitored VM not ready at Sep 4, 2025, 1:02:00?AM (attempt 1, elapsed 253ms). [2025-09-04T01:02:01.289Z] CL1 j> 2025/09/04 01:02:00.866 Waiting 5 secs and trying again... [2025-09-04T01:02:09.587Z] CL1 j> 2025/09/04 01:02:06.008 Attempting to connect [2025-09-04T01:02:13.082Z] CL1 j> 2025/09/04 01:02:08.376 Connection established! [2025-09-04T01:02:13.082Z] CL1 j> 2025/09/04 01:02:08.791 Starting to write data [2025-09-04T01:07:10.713Z] STF 01:07:00.216 - Heartbeat: Process LT1 is still running [2025-09-04T01:08:00.989Z] STF 01:07:53.158 - Monitoring Report Summary: [2025-09-04T01:08:00.989Z] STF 01:07:53.160 - o Process CL1 ended with the expected exit code (0) [2025-09-04T01:08:00.989Z] STF 01:07:53.160 - o Process LT1 is still running as expected [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - +------ Step 4 - Stop LT1 process [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - | Kill running processes [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - | Processes: [LT1] [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - | [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - Killing processes: LT1 [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - o Process clean up attempt 1 for LT1 pid 7344 [2025-09-04T01:08:00.989Z] STF 01:07:53.192 - o Process LT1 pid 7344 stop() [2025-09-04T01:08:00.989Z] STF 01:07:53.193 - o Process LT1 pid 7344 killed [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - | Start background process [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - | Mnemonic: LT2 [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - | Echo: ECHO_OFF [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - | Expectation: NEVER [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - | [2025-09-04T01:08:00.989Z] STF 01:07:53.194 - 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/externalDependency/system_lib/log4j/log4j-api.jar;c:/jenkins/externalDependency/system_lib/log4j/log4j-core.jar;c:/jenkins/externalDependency/system_lib/asm/asm.jar;c:/jenkins/externalDependency/system_lib/asm/asm-commons.jar;c:/jenkins/externalDependency/system_lib/junit/junit.jar;c:/jenkins/externalDependency/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_17569442893160\TestJlmRemoteThreadNoAuth_1\20250904-010158-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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-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-09-04T01:08:00.990Z] STF 01:07:53.194 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-09-04T01:08:00.990Z] STF 01:07:53.194 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - | Start background process [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - | Mnemonic: CL2 [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - | Echo: ECHO_ON [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - | Expectation: CLEAN_RUN within 30m [2025-09-04T01:08:00.990Z] STF 01:07:53.202 - | [2025-09-04T01:08:00.990Z] STF 01:07:53.203 - 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/externalDependency/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_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-09-04T01:08:00.990Z] STF 01:07:53.203 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-09-04T01:08:00.990Z] STF 01:07:53.203 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17569442893160/TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-09-04T01:08:00.990Z] STF 01:07:53.209 - [2025-09-04T01:08:00.990Z] STF 01:07:53.209 - +------ Step 7 - Wait for processes to complete [2025-09-04T01:08:00.990Z] STF 01:07:53.209 - | Wait for processes to meet expectations [2025-09-04T01:08:00.990Z] STF 01:07:53.209 - | Processes: [LT2, CL2] [2025-09-04T01:08:00.990Z] STF 01:07:53.209 - | [2025-09-04T01:08:00.990Z] STF 01:07:53.209 - Monitoring processes: CL2 LT2 [2025-09-04T01:08:00.990Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-04T01:08:00.990Z] CL2 j> 2025/09/04 01:07:53.429 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-09-04T01:08:00.990Z] CL2 j> 2025/09/04 01:07:53.513 Attempting to connect [2025-09-04T01:08:00.990Z] CL2 j> 2025/09/04 01:07:53.898 Monitored VM not ready at Sep 4, 2025, 1:07:53?AM (attempt 1, elapsed 358ms). [2025-09-04T01:08:00.990Z] CL2 j> 2025/09/04 01:07:53.898 Waiting 5 secs and trying again... [2025-09-04T01:08:02.705Z] CL2 j> 2025/09/04 01:07:59.041 Attempting to connect [2025-09-04T01:08:05.915Z] CL2 j> 2025/09/04 01:08:03.090 Connection established! [2025-09-04T01:08:18.549Z] CL2 j> 2025/09/04 01:08:14.396 Writing report data ... [2025-09-04T01:08:22.198Z] CL2 j> 2025/09/04 01:08:17.588 done. [2025-09-04T01:08:30.680Z] CL2 j> 2025/09/04 01:08:27.874 Writing report data ... [2025-09-04T01:08:33.317Z] CL2 j> 2025/09/04 01:08:29.392 done. [2025-09-04T01:08:45.173Z] CL2 j> 2025/09/04 01:08:40.146 Writing report data ... [2025-09-04T01:08:45.173Z] CL2 j> 2025/09/04 01:08:40.654 done. [2025-09-04T01:08:54.936Z] CL2 j> 2025/09/04 01:08:51.095 Writing report data ... [2025-09-04T01:08:56.370Z] CL2 j> 2025/09/04 01:08:51.797 done. [2025-09-04T01:09:06.158Z] CL2 j> 2025/09/04 01:09:02.210 Writing report data ... [2025-09-04T01:09:06.158Z] CL2 j> 2025/09/04 01:09:02.664 done. [2025-09-04T01:09:18.382Z] CL2 j> 2025/09/04 01:09:12.874 Writing report data ... [2025-09-04T01:09:18.382Z] CL2 j> 2025/09/04 01:09:13.555 done. [2025-09-04T01:09:28.401Z] CL2 j> 2025/09/04 01:09:24.232 Writing report data ... [2025-09-04T01:09:28.401Z] CL2 j> 2025/09/04 01:09:25.496 done. [2025-09-04T01:09:40.441Z] CL2 j> 2025/09/04 01:09:35.746 Writing report data ... [2025-09-04T01:09:40.441Z] CL2 j> 2025/09/04 01:09:37.419 done. [2025-09-04T01:09:50.204Z] CL2 j> 2025/09/04 01:09:47.648 Writing report data ... [2025-09-04T01:09:50.204Z] CL2 j> 2025/09/04 01:09:48.127 done. [2025-09-04T01:10:04.546Z] CL2 j> 2025/09/04 01:09:59.233 Writing report data ... [2025-09-04T01:10:04.546Z] CL2 j> 2025/09/04 01:10:00.201 done. [2025-09-04T01:10:15.090Z] CL2 j> 2025/09/04 01:10:10.527 Writing report data ... [2025-09-04T01:10:15.090Z] CL2 j> 2025/09/04 01:10:10.967 done. [2025-09-04T01:10:23.732Z] CL2 j> 2025/09/04 01:10:21.329 Writing report data ... [2025-09-04T01:10:27.345Z] CL2 j> 2025/09/04 01:10:21.724 done. [2025-09-04T01:10:37.474Z] CL2 j> 2025/09/04 01:10:32.407 Writing report data ... [2025-09-04T01:10:37.474Z] CL2 j> 2025/09/04 01:10:32.942 done. [2025-09-04T01:10:47.400Z] CL2 j> 2025/09/04 01:10:43.257 Writing report data ... [2025-09-04T01:10:49.407Z] CL2 j> 2025/09/04 01:10:44.007 done. [2025-09-04T01:10:57.446Z] CL2 j> 2025/09/04 01:10:54.904 Writing report data ... [2025-09-04T01:10:57.446Z] CL2 j> 2025/09/04 01:10:55.714 done. [2025-09-04T01:11:07.356Z] CL2 j> 2025/09/04 01:11:06.263 Writing report data ... [2025-09-04T01:11:10.688Z] CL2 j> 2025/09/04 01:11:07.105 done. [2025-09-04T01:11:20.524Z] CL2 j> 2025/09/04 01:11:17.486 Writing report data ... [2025-09-04T01:11:21.432Z] CL2 j> 2025/09/04 01:11:18.426 done. [2025-09-04T01:11:33.189Z] CL2 j> 2025/09/04 01:11:28.667 Writing report data ... [2025-09-04T01:11:33.189Z] CL2 j> 2025/09/04 01:11:29.582 done. [2025-09-04T01:11:43.057Z] CL2 j> 2025/09/04 01:11:39.826 Writing report data ... [2025-09-04T01:11:43.057Z] CL2 j> 2025/09/04 01:11:41.164 done. [2025-09-04T01:11:57.698Z] CL2 j> 2025/09/04 01:11:51.709 Writing report data ... [2025-09-04T01:11:57.698Z] CL2 j> 2025/09/04 01:11:52.188 done. [2025-09-04T01:12:01.981Z] STF 01:12:00.055 - Heartbeat: Process LT2 is still running [2025-09-04T01:12:07.388Z] CL2 j> 2025/09/04 01:12:02.526 Writing report data ... [2025-09-04T01:12:07.388Z] CL2 j> 2025/09/04 01:12:03.092 done. [2025-09-04T01:12:16.969Z] CL2 j> 2025/09/04 01:12:13.408 Writing report data ... [2025-09-04T01:12:16.969Z] CL2 j> 2025/09/04 01:12:13.884 done. [2025-09-04T01:12:28.949Z] CL2 j> 2025/09/04 01:12:24.492 Writing report data ... [2025-09-04T01:12:28.949Z] CL2 j> 2025/09/04 01:12:24.969 done. [2025-09-04T01:12:41.070Z] CL2 j> 2025/09/04 01:12:35.235 Writing report data ... [2025-09-04T01:12:41.070Z] CL2 j> 2025/09/04 01:12:35.606 done. [2025-09-04T01:12:49.117Z] CL2 j> 2025/09/04 01:12:46.099 Writing report data ... [2025-09-04T01:12:49.117Z] CL2 j> 2025/09/04 01:12:46.638 done. [2025-09-04T01:13:03.410Z] CL2 j> 2025/09/04 01:12:57.204 Writing report data ... [2025-09-04T01:13:03.410Z] CL2 j> 2025/09/04 01:12:57.812 done. [2025-09-04T01:13:11.941Z] CL2 j> 2025/09/04 01:13:08.608 Writing report data ... [2025-09-04T01:13:12.820Z] CL2 j> 2025/09/04 01:13:09.121 done. [2025-09-04T01:13:27.097Z] CL2 j> 2025/09/04 01:13:20.008 Writing report data ... [2025-09-04T01:13:27.097Z] CL2 j> 2025/09/04 01:13:20.275 done. [2025-09-04T01:13:33.839Z] CL2 j> 2025/09/04 01:13:30.499 Writing report data ... [2025-09-04T01:13:35.937Z] CL2 j> 2025/09/04 01:13:31.082 done. [2025-09-04T01:13:48.179Z] CL2 j> 2025/09/04 01:13:41.728 Writing report data ... [2025-09-04T01:13:48.179Z] CL2 j> 2025/09/04 01:13:42.291 done. [2025-09-04T01:13:59.991Z] STF 01:13:59.510 - Monitoring Report Summary: [2025-09-04T01:13:59.991Z] STF 01:13:59.510 - o Process CL2 ended with the expected exit code (0) [2025-09-04T01:13:59.991Z] STF 01:13:59.510 - o Process LT2 is still running as expected [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - +------ Step 8 - Stop LT2 process [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - | Kill running processes [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - | Processes: [LT2] [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - | [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - Killing processes: LT2 [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - o Process clean up attempt 1 for LT2 pid 22932 [2025-09-04T01:13:59.991Z] STF 01:13:59.511 - o Process LT2 pid 22932 stop() [2025-09-04T01:13:59.991Z] STF 01:13:59.512 - o Process LT2 pid 22932 killed [2025-09-04T01:13:59.991Z] STF 01:13:59.512 - EXECUTE stage completed [2025-09-04T01:13:59.991Z] STF 01:13:59.655 - [2025-09-04T01:13:59.991Z] STF 01:13:59.655 - ==================== T E A R D O W N ==================== [2025-09-04T01:13:59.991Z] STF 01:13:59.655 - Running teardown: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17569442893160\TestJlmRemoteThreadNoAuth_1/20250904-010158-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-09-04T01:13:59.991Z] STF 01:13:59.795 - TEARDOWN stage completed [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - ===================== R E S U L T S ===================== [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - Stage results: [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - setUp: pass [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - execute: pass [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - teardown: pass [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - [2025-09-04T01:13:59.991Z] STF 01:13:59.822 - Overall result: PASSED [2025-09-04T01:13:59.991Z] ----------------------------------- [2025-09-04T01:13:59.991Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-09-04T01:13:59.991Z] ----------------------------------- [2025-09-04T01:13:59.991Z] [2025-09-04T01:13:59.991Z] TEST TEARDOWN: [2025-09-04T01:13:59.991Z] Nothing to be done for teardown. [2025-09-04T01:14:00.313Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Thu Sep 4 01:14:00 2025 Epoch Time (ms): 1756948440013