[2024-11-19T07:13:29.206Z] Running test TestJlmRemoteThreadNoAuth_0 ... [2024-11-19T07:13:29.206Z] =============================================== [2024-11-19T07:13:29.206Z] TestJlmRemoteThreadNoAuth_0 Start Time: Tue Nov 19 07:13:26 2024 Epoch Time (ms): 1732000406651 [2024-11-19T07:13:29.206Z] variation: Mode150 [2024-11-19T07:13:29.206Z] JVM_OPTIONS: -XX:+UseCompressedOops [2024-11-19T07:13:29.206Z] { \ [2024-11-19T07:13:29.206Z] echo ""; echo "TEST SETUP:"; \ [2024-11-19T07:13:29.206Z] echo "Nothing to be done for setup."; \ [2024-11-19T07:13:29.206Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17319976767915\\TestJlmRemoteThreadNoAuth_0"; \ [2024-11-19T07:13:29.206Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17319976767915\\TestJlmRemoteThreadNoAuth_0"; \ [2024-11-19T07:13:29.206Z] echo ""; echo "TESTING:"; \ [2024-11-19T07:13:29.206Z] 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_17319976767915\\TestJlmRemoteThreadNoAuth_0" -test=TestJlmRemoteThreadNoAuth; \ [2024-11-19T07:13:29.206Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_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_17319976767915\\TestJlmRemoteThreadNoAuth_0"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-19T07:13:29.206Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-19T07:13:29.206Z] echo "Nothing to be done for teardown."; \ [2024-11-19T07:13:29.206Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17319976767915\\TestTargetResult"; [2024-11-19T07:13:29.206Z] [2024-11-19T07:13:29.206Z] TEST SETUP: [2024-11-19T07:13:29.206Z] Nothing to be done for setup. [2024-11-19T07:13:29.206Z] [2024-11-19T07:13:29.206Z] TESTING: [2024-11-19T07:13:29.206Z] STF 07:13:27.222 - ========================= S T F ========================= [2024-11-19T07:13:29.206Z] 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_17319976767915\TestJlmRemoteThreadNoAuth_0 [2024-11-19T07:13:29.206Z] There is 92667 Mb free [2024-11-19T07:13:29.206Z] STF 07:13:27.271 - ================== G E N E R A T I O N ================== [2024-11-19T07:13:29.206Z] STF 07:13:27.274 - Checking JVM: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image [2024-11-19T07:13:29.206Z] STF 07:13:27.274 - 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 -classpath 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_17319976767915\TestJlmRemoteThreadNoAuth_0/20241119-071327-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_17319976767915\TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth" [2024-11-19T07:13:29.206Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-19T07:13:29.206Z] GEN [0.019s][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 [2024-11-19T07:13:29.206Z] GEN Java lib directory does not exist: C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jdkbinary\lib [2024-11-19T07:13:29.206Z] GEN 07:13:28.315 - 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' [2024-11-19T07:13:29.206Z] GEN 07:13:28.356 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-11-19T07:13:29.206Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-11-19T07:13:29.206Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2024-11-19T07:13:29.206Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\STF\\stf.core\\bin [2024-11-19T07:13:29.206Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-11-19T07:13:29.206Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-11-19T07:13:29.206Z] GEN c:/jenkins/testDependency/system_lib/junit/junit.jar [2024-11-19T07:13:29.206Z] GEN Java lib directory does not exist: C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jdkbinary\lib [2024-11-19T07:13:29.206Z] GEN 07:13:28.585 - Using Mode NoOptions. Values = '' [2024-11-19T07:13:29.206Z] GEN 07:13:28.722 - [2024-11-19T07:13:29.206Z] GEN 07:13:28.722 - Test command summary: [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - Step Stage Command Description [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - -----+--------+-----------------+------------ [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - 3 execute Monitor Wait for processes to complete [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - 4 execute kill Stop LT1 process [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-11-19T07:13:29.206Z] GEN 07:13:28.723 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-11-19T07:13:29.206Z] GEN 07:13:28.724 - 7 execute Monitor Wait for processes to complete [2024-11-19T07:13:29.206Z] GEN 07:13:28.724 - 8 execute kill Stop LT2 process [2024-11-19T07:13:29.206Z] STF 07:13:28.751 - [2024-11-19T07:13:29.206Z] STF 07:13:28.751 - Script generation completed [2024-11-19T07:13:29.206Z] STF 07:13:28.751 - [2024-11-19T07:13:29.206Z] STF 07:13:28.752 - [2024-11-19T07:13:29.206Z] STF 07:13:28.752 - ======================= S E T U P ======================= [2024-11-19T07:13:29.207Z] STF 07:13:28.752 - Running setup: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17319976767915\TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/setUp.pl [2024-11-19T07:13:29.207Z] STF 07:13:28.890 - SETUP stage completed [2024-11-19T07:13:29.207Z] STF 07:13:28.901 - [2024-11-19T07:13:29.207Z] STF 07:13:28.901 - ==================== E X E C U T E - ==================== [2024-11-19T07:13:29.207Z] STF 07:13:28.901 - Running execute: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17319976767915\TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/execute.pl [2024-11-19T07:13:29.207Z] STF 07:13:29.035 - [2024-11-19T07:13:29.207Z] STF 07:13:29.035 - Java version [2024-11-19T07:13:29.207Z] STF 07:13:29.035 - Running: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -version [2024-11-19T07:13:29.207Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-19T07:13:29.207Z] openjdk version "21.0.6-beta" 2025-01-21 [2024-11-19T07:13:29.207Z] OpenJDK Runtime Environment Temurin-21.0.6+3-202411171535 (build 21.0.6-beta+3-ea) [2024-11-19T07:13:29.207Z] OpenJDK 64-Bit Server VM Temurin-21.0.6+3-202411171535 (build 21.0.6-beta+3-ea, mixed mode, sharing) [2024-11-19T07:13:29.207Z] STF 07:13:29.131 - [2024-11-19T07:13:29.207Z] STF 07:13:29.132 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-11-19T07:13:29.207Z] STF 07:13:29.132 - | Start background process [2024-11-19T07:13:29.207Z] STF 07:13:29.132 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-11-19T07:13:29.207Z] STF 07:13:29.132 - | Mnemonic: LT1 [2024-11-19T07:13:29.207Z] STF 07:13:29.132 - | Echo: ECHO_OFF [2024-11-19T07:13:29.207Z] STF 07:13:29.132 - | Expectation: NEVER [2024-11-19T07:13:29.207Z] STF 07:13:29.137 - | [2024-11-19T07:13:29.207Z] STF 07:13:29.137 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -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/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_17319976767915\TestJlmRemoteThreadNoAuth_0\20241119-071327-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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-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 [2024-11-19T07:13:29.207Z] STF 07:13:29.137 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-11-19T07:13:29.207Z] STF 07:13:29.137 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - | Start background process [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - | Mnemonic: CL1 [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - | Echo: ECHO_ON [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - | Expectation: CLEAN_RUN within 30m [2024-11-19T07:13:29.548Z] STF 07:13:29.171 - | [2024-11-19T07:13:29.549Z] STF 07:13:29.171 - 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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-11-19T07:13:29.549Z] STF 07:13:29.171 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-11-19T07:13:29.549Z] STF 07:13:29.171 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-11-19T07:13:29.549Z] STF 07:13:29.177 - [2024-11-19T07:13:29.549Z] STF 07:13:29.177 - +------ Step 3 - Wait for processes to complete [2024-11-19T07:13:29.549Z] STF 07:13:29.177 - | Wait for processes to meet expectations [2024-11-19T07:13:29.549Z] STF 07:13:29.177 - | Processes: [LT1, CL1] [2024-11-19T07:13:29.549Z] STF 07:13:29.177 - | [2024-11-19T07:13:29.549Z] STF 07:13:29.177 - Monitoring processes: CL1 LT1 [2024-11-19T07:13:29.549Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-19T07:13:29.549Z] CL1 j> 2024/11/19 07:13:29.376 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-19T07:13:29.549Z] CL1 j> 2024/11/19 07:13:29.461 Attempting to connect [2024-11-19T07:13:29.877Z] CL1 j> 2024/11/19 07:13:29.753 Monitored VM not ready at Nov 19, 2024, 7:13:29?AM (attempt 1, elapsed 266ms). [2024-11-19T07:13:29.877Z] CL1 j> 2024/11/19 07:13:29.753 Waiting 5 secs and trying again... [2024-11-19T07:13:39.490Z] CL1 j> 2024/11/19 07:13:34.971 Attempting to connect [2024-11-19T07:13:46.562Z] CL1 j> 2024/11/19 07:13:42.728 Connection established! [2024-11-19T07:13:46.562Z] CL1 j> 2024/11/19 07:13:43.098 Starting to write data [2024-11-19T07:18:32.806Z] STF 07:18:30.952 - Heartbeat: Process LT1 is still running [2024-11-19T07:19:22.605Z] STF 07:19:19.844 - Monitoring Report Summary: [2024-11-19T07:19:22.605Z] STF 07:19:19.844 - o Process CL1 ended with the expected exit code (0) [2024-11-19T07:19:22.605Z] STF 07:19:19.844 - o Process LT1 is still running as expected [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - +------ Step 4 - Stop LT1 process [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - | Kill running processes [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - | Processes: [LT1] [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - | [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - Killing processes: LT1 [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - o Process clean up attempt 1 for LT1 pid 14680 [2024-11-19T07:19:22.605Z] STF 07:19:19.845 - o Process LT1 pid 14680 stop() [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - o Process LT1 pid 14680 killed [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - | Start background process [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - | Mnemonic: LT2 [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - | Echo: ECHO_OFF [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - | Expectation: NEVER [2024-11-19T07:19:22.605Z] STF 07:19:19.846 - | [2024-11-19T07:19:22.605Z] STF 07:19:19.847 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -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/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_17319976767915\TestJlmRemoteThreadNoAuth_0\20241119-071327-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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-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 [2024-11-19T07:19:22.605Z] STF 07:19:19.847 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-11-19T07:19:22.605Z] STF 07:19:19.847 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - | Start background process [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - | Mnemonic: CL2 [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - | Echo: ECHO_ON [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - | Expectation: CLEAN_RUN within 30m [2024-11-19T07:19:22.605Z] STF 07:19:19.854 - | [2024-11-19T07:19:22.605Z] STF 07:19:19.855 - 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_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-11-19T07:19:22.605Z] STF 07:19:19.855 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-11-19T07:19:22.605Z] STF 07:19:19.855 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17319976767915/TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-11-19T07:19:22.605Z] STF 07:19:19.860 - [2024-11-19T07:19:22.605Z] STF 07:19:19.860 - +------ Step 7 - Wait for processes to complete [2024-11-19T07:19:22.605Z] STF 07:19:19.860 - | Wait for processes to meet expectations [2024-11-19T07:19:22.605Z] STF 07:19:19.860 - | Processes: [LT2, CL2] [2024-11-19T07:19:22.605Z] STF 07:19:19.860 - | [2024-11-19T07:19:22.605Z] STF 07:19:19.860 - Monitoring processes: CL2 LT2 [2024-11-19T07:19:22.605Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-19T07:19:22.605Z] CL2 j> 2024/11/19 07:19:20.076 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-19T07:19:22.605Z] CL2 j> 2024/11/19 07:19:20.156 Attempting to connect [2024-11-19T07:19:22.605Z] CL2 j> 2024/11/19 07:19:20.410 Monitored VM not ready at Nov 19, 2024, 7:19:20?AM (attempt 1, elapsed 231ms). [2024-11-19T07:19:22.605Z] CL2 j> 2024/11/19 07:19:20.410 Waiting 5 secs and trying again... [2024-11-19T07:19:29.928Z] CL2 j> 2024/11/19 07:19:25.815 Attempting to connect [2024-11-19T07:19:37.594Z] CL2 j> 2024/11/19 07:19:33.723 Connection established! [2024-11-19T07:19:48.568Z] CL2 j> 2024/11/19 07:19:44.482 Writing report data ... [2024-11-19T07:19:59.436Z] CL2 j> 2024/11/19 07:19:48.661 done. [2024-11-19T07:20:03.735Z] CL2 j> 2024/11/19 07:19:59.078 Writing report data ... [2024-11-19T07:20:03.735Z] CL2 j> 2024/11/19 07:20:00.392 done. [2024-11-19T07:20:15.537Z] CL2 j> 2024/11/19 07:20:11.102 Writing report data ... [2024-11-19T07:20:18.889Z] CL2 j> 2024/11/19 07:20:11.807 done. [2024-11-19T07:20:25.485Z] CL2 j> 2024/11/19 07:20:22.726 Writing report data ... [2024-11-19T07:20:28.933Z] CL2 j> 2024/11/19 07:20:23.467 done. [2024-11-19T07:20:38.493Z] CL2 j> 2024/11/19 07:20:33.796 Writing report data ... [2024-11-19T07:20:40.460Z] CL2 j> 2024/11/19 07:20:34.367 done. [2024-11-19T07:20:48.815Z] CL2 j> 2024/11/19 07:20:44.567 Writing report data ... [2024-11-19T07:20:48.815Z] CL2 j> 2024/11/19 07:20:44.994 done. [2024-11-19T07:21:02.771Z] CL2 j> 2024/11/19 07:20:55.232 Writing report data ... [2024-11-19T07:21:02.771Z] CL2 j> 2024/11/19 07:20:56.048 done. [2024-11-19T07:21:17.929Z] CL2 j> 2024/11/19 07:21:06.298 Writing report data ... [2024-11-19T07:21:17.929Z] CL2 j> 2024/11/19 07:21:07.014 done. [2024-11-19T07:21:24.399Z] CL2 j> 2024/11/19 07:21:17.257 Writing report data ... [2024-11-19T07:21:24.399Z] CL2 j> 2024/11/19 07:21:18.084 done. [2024-11-19T07:21:31.185Z] CL2 j> 2024/11/19 07:21:28.252 Writing report data ... [2024-11-19T07:21:31.185Z] CL2 j> 2024/11/19 07:21:28.809 done. [2024-11-19T07:21:42.814Z] CL2 j> 2024/11/19 07:21:39.231 Writing report data ... [2024-11-19T07:21:46.108Z] CL2 j> 2024/11/19 07:21:39.489 done. [2024-11-19T07:21:55.945Z] CL2 j> 2024/11/19 07:21:50.454 Writing report data ... [2024-11-19T07:21:55.945Z] CL2 j> 2024/11/19 07:21:51.768 done. [2024-11-19T07:22:05.557Z] CL2 j> 2024/11/19 07:22:02.055 Writing report data ... [2024-11-19T07:22:08.329Z] CL2 j> 2024/11/19 07:22:02.582 done. [2024-11-19T07:22:15.007Z] CL2 j> 2024/11/19 07:22:13.108 Writing report data ... [2024-11-19T07:22:17.603Z] CL2 j> 2024/11/19 07:22:13.596 done. [2024-11-19T07:22:27.405Z] CL2 j> 2024/11/19 07:22:23.832 Writing report data ... [2024-11-19T07:22:28.338Z] CL2 j> 2024/11/19 07:22:24.362 done. [2024-11-19T07:22:40.068Z] CL2 j> 2024/11/19 07:22:35.168 Writing report data ... [2024-11-19T07:22:40.068Z] CL2 j> 2024/11/19 07:22:35.704 done. [2024-11-19T07:22:49.916Z] CL2 j> 2024/11/19 07:22:46.064 Writing report data ... [2024-11-19T07:22:49.916Z] CL2 j> 2024/11/19 07:22:46.302 done. [2024-11-19T07:22:59.575Z] CL2 j> 2024/11/19 07:22:56.453 Writing report data ... [2024-11-19T07:23:01.531Z] CL2 j> 2024/11/19 07:22:56.667 done. [2024-11-19T07:23:13.208Z] CL2 j> 2024/11/19 07:23:06.879 Writing report data ... [2024-11-19T07:23:14.605Z] CL2 j> 2024/11/19 07:23:07.701 done. [2024-11-19T07:23:24.742Z] CL2 j> 2024/11/19 07:23:18.328 Writing report data ... [2024-11-19T07:23:24.742Z] CL2 j> 2024/11/19 07:23:19.185 done. [2024-11-19T07:23:32.779Z] STF 07:23:30.996 - Heartbeat: Process LT2 is still running [2024-11-19T07:23:32.779Z] CL2 j> 2024/11/19 07:23:29.888 Writing report data ... [2024-11-19T07:23:32.779Z] CL2 j> 2024/11/19 07:23:30.629 done. [2024-11-19T07:23:49.642Z] CL2 j> 2024/11/19 07:23:40.846 Writing report data ... [2024-11-19T07:23:49.642Z] CL2 j> 2024/11/19 07:23:41.207 done. [2024-11-19T07:23:52.975Z] CL2 j> 2024/11/19 07:23:52.001 Writing report data ... [2024-11-19T07:23:58.205Z] CL2 j> 2024/11/19 07:23:52.684 done. [2024-11-19T07:24:07.720Z] CL2 j> 2024/11/19 07:24:02.911 Writing report data ... [2024-11-19T07:24:10.261Z] CL2 j> 2024/11/19 07:24:03.578 done. [2024-11-19T07:24:18.117Z] CL2 j> 2024/11/19 07:24:13.776 Writing report data ... [2024-11-19T07:24:21.066Z] CL2 j> 2024/11/19 07:24:15.540 done. [2024-11-19T07:24:27.826Z] CL2 j> 2024/11/19 07:24:25.898 Writing report data ... [2024-11-19T07:24:34.931Z] CL2 j> 2024/11/19 07:24:26.513 done. [2024-11-19T07:24:40.219Z] CL2 j> 2024/11/19 07:24:36.731 Writing report data ... [2024-11-19T07:24:42.856Z] CL2 j> 2024/11/19 07:24:37.351 done. [2024-11-19T07:24:54.608Z] CL2 j> 2024/11/19 07:24:48.113 Writing report data ... [2024-11-19T07:24:54.608Z] CL2 j> 2024/11/19 07:24:48.534 done. [2024-11-19T07:25:02.504Z] CL2 j> 2024/11/19 07:24:58.777 Writing report data ... [2024-11-19T07:25:03.430Z] CL2 j> 2024/11/19 07:24:59.372 done. [2024-11-19T07:25:17.402Z] CL2 j> 2024/11/19 07:25:09.694 Writing report data ... [2024-11-19T07:25:17.402Z] CL2 j> 2024/11/19 07:25:10.094 done. [2024-11-19T07:25:17.402Z] STF 07:25:16.413 - Monitoring Report Summary: [2024-11-19T07:25:17.402Z] STF 07:25:16.413 - o Process CL2 ended with the expected exit code (0) [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - o Process LT2 is still running as expected [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - +------ Step 8 - Stop LT2 process [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - | Kill running processes [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - | Processes: [LT2] [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - | [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - Killing processes: LT2 [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - o Process clean up attempt 1 for LT2 pid 25856 [2024-11-19T07:25:17.402Z] STF 07:25:16.414 - o Process LT2 pid 25856 stop() [2024-11-19T07:25:17.402Z] STF 07:25:16.415 - o Process LT2 pid 25856 killed [2024-11-19T07:25:17.402Z] STF 07:25:16.416 - EXECUTE stage completed [2024-11-19T07:25:17.402Z] STF 07:25:16.938 - [2024-11-19T07:25:17.402Z] STF 07:25:16.938 - ==================== T E A R D O W N ==================== [2024-11-19T07:25:17.402Z] STF 07:25:16.938 - Running teardown: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17319976767915\TestJlmRemoteThreadNoAuth_0/20241119-071327-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-11-19T07:25:17.402Z] STF 07:25:17.076 - TEARDOWN stage completed [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - ===================== R E S U L T S ===================== [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - Stage results: [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - setUp: pass [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - execute: pass [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - teardown: pass [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - [2024-11-19T07:25:17.402Z] STF 07:25:17.092 - Overall result: PASSED [2024-11-19T07:25:17.402Z] ----------------------------------- [2024-11-19T07:25:17.402Z] TestJlmRemoteThreadNoAuth_0_PASSED [2024-11-19T07:25:17.402Z] ----------------------------------- [2024-11-19T07:25:17.402Z] [2024-11-19T07:25:17.402Z] TEST TEARDOWN: [2024-11-19T07:25:17.402Z] Nothing to be done for teardown. [2024-11-19T07:25:17.402Z] TestJlmRemoteThreadNoAuth_0 Finish Time: Tue Nov 19 07:25:17 2024 Epoch Time (ms): 1732001117265