[2024-10-31T01:22:04.669Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2024-10-31T01:22:04.966Z] =============================================== [2024-10-31T01:22:05.264Z] TestJlmRemoteThreadNoAuth_1 Start Time: Thu Oct 31 01:22:04 2024 Epoch Time (ms): 1730337724993 [2024-10-31T01:22:05.264Z] variation: Mode650 [2024-10-31T01:22:05.561Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-10-31T01:22:05.561Z] { \ [2024-10-31T01:22:05.561Z] echo ""; echo "TEST SETUP:"; \ [2024-10-31T01:22:05.561Z] echo "Nothing to be done for setup."; \ [2024-10-31T01:22:05.561Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\\TKG\\output_17303343952862\\TestJlmRemoteThreadNoAuth_1"; \ [2024-10-31T01:22:05.561Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\\TKG\\output_17303343952862\\TestJlmRemoteThreadNoAuth_1"; \ [2024-10-31T01:22:05.561Z] echo ""; echo "TESTING:"; \ [2024-10-31T01:22:05.561Z] perl C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\STF;C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\aqa-systemtest""" -systemtest-prereqs="C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/../../testDependency/system_lib\\" -java-args=' -XX:-UseCompressedOops ' -results-root="C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\\TKG\\output_17303343952862\\TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2024-10-31T01:22:05.561Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\\TKG\\output_17303343952862\\TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-31T01:22:05.561Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-31T01:22:05.561Z] echo "Nothing to be done for teardown."; \ [2024-10-31T01:22:05.561Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\\TKG\\output_17303343952862\\TestTargetResult"; [2024-10-31T01:22:05.561Z] [2024-10-31T01:22:05.561Z] TEST SETUP: [2024-10-31T01:22:05.561Z] Nothing to be done for setup. [2024-10-31T01:22:05.561Z] [2024-10-31T01:22:05.561Z] TESTING: [2024-10-31T01:22:06.208Z] STF 01:22:05.915 - ========================= S T F ========================= [2024-10-31T01:22:06.208Z] systemtest-prereqs has been processed, and set to: C:/Users/jenkins/testDependency/system_libRetrieving amount of free space on drive containing C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1 [2024-10-31T01:22:06.208Z] There is 20219 Mb free [2024-10-31T01:22:06.208Z] STF 01:22:05.994 - ================== G E N E R A T I O N ================== [2024-10-31T01:22:06.208Z] STF 01:22:06.000 - Checking JVM: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image [2024-10-31T01:22:06.208Z] STF 01:22:06.000 - Starting process to generate scripts: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/../../testDependency/system_lib\/log4j/log4j-api.jar;C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth" [2024-10-31T01:22:06.208Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-31T01:22:07.748Z] GEN 01:22:07.243 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: 'C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin' [2024-10-31T01:22:07.748Z] GEN 01:22:07.305 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-10-31T01:22:07.748Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-10-31T01:22:07.748Z] GEN C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2024-10-31T01:22:07.748Z] GEN C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\\jvmtest\\system\\STF\\stf.core\\bin [2024-10-31T01:22:07.748Z] GEN C:/Users/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-10-31T01:22:07.748Z] GEN C:/Users/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-10-31T01:22:07.748Z] GEN C:/Users/jenkins/testDependency/system_lib/junit/junit.jar [2024-10-31T01:22:07.748Z] GEN 01:22:07.555 - Using Mode NoOptions. Values = '' [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - Test command summary: [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - Step Stage Command Description [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - -----+--------+-----------------+------------ [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 3 execute Monitor Wait for processes to complete [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 4 execute kill Stop LT1 process [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 7 execute Monitor Wait for processes to complete [2024-10-31T01:22:07.748Z] GEN 01:22:07.665 - 8 execute kill Stop LT2 process [2024-10-31T01:22:07.748Z] STF 01:22:07.731 - [2024-10-31T01:22:07.748Z] STF 01:22:07.731 - Script generation completed [2024-10-31T01:22:07.748Z] STF 01:22:07.731 - [2024-10-31T01:22:08.047Z] STF 01:22:07.739 - [2024-10-31T01:22:08.047Z] STF 01:22:07.739 - ======================= S E T U P ======================= [2024-10-31T01:22:08.047Z] STF 01:22:07.739 - Running setup: perl C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/setUp.pl [2024-10-31T01:22:08.345Z] STF 01:22:08.102 - SETUP stage completed [2024-10-31T01:22:08.345Z] STF 01:22:08.151 - [2024-10-31T01:22:08.345Z] STF 01:22:08.151 - ==================== E X E C U T E - ==================== [2024-10-31T01:22:08.345Z] STF 01:22:08.151 - Running execute: perl C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/execute.pl [2024-10-31T01:22:08.643Z] STF 01:22:08.524 - [2024-10-31T01:22:08.643Z] STF 01:22:08.524 - Java version [2024-10-31T01:22:08.643Z] STF 01:22:08.524 - Running: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -version [2024-10-31T01:22:08.643Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-31T01:22:08.943Z] openjdk version "21.0.6-beta" 2025-01-21 [2024-10-31T01:22:08.943Z] OpenJDK Runtime Environment Temurin-21.0.6+1-202410302002 (build 21.0.6-beta+1-ea) [2024-10-31T01:22:08.943Z] OpenJDK 64-Bit Server VM Temurin-21.0.6+1-202410302002 (build 21.0.6-beta+1-ea, mixed mode) [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - | Start background process [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - | Program: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - | Mnemonic: LT1 [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - | Echo: ECHO_OFF [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - | Expectation: NEVER [2024-10-31T01:22:08.943Z] STF 01:22:08.666 - | [2024-10-31T01:22:08.943Z] STF 01:22:08.668 - Running command: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\STF\stf.load\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\STF\stf.core\bin;C:/Users/jenkins/testDependency/system_lib/log4j/log4j-api.jar;C:/Users/jenkins/testDependency/system_lib/log4j/log4j-core.jar;C:/Users/jenkins/testDependency/system_lib/junit/junit.jar;C:/Users/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\aqa-tests\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1\20241031-012205-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:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-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-10-31T01:22:08.943Z] STF 01:22:08.668 - Redirecting stderr to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-10-31T01:22:08.943Z] STF 01:22:08.668 - Redirecting stdout to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - | Start background process [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - | Program: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - | Mnemonic: CL1 [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - | Echo: ECHO_ON [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - | Expectation: CLEAN_RUN within 30m [2024-10-31T01:22:08.943Z] STF 01:22:08.738 - | [2024-10-31T01:22:08.943Z] STF 01:22:08.739 - Running command: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;C:/Users/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-31T01:22:08.943Z] STF 01:22:08.739 - Redirecting stderr to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-10-31T01:22:08.943Z] STF 01:22:08.739 - Redirecting stdout to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-10-31T01:22:08.943Z] STF 01:22:08.747 - [2024-10-31T01:22:08.943Z] STF 01:22:08.747 - +------ Step 3 - Wait for processes to complete [2024-10-31T01:22:08.943Z] STF 01:22:08.747 - | Wait for processes to meet expectations [2024-10-31T01:22:08.943Z] STF 01:22:08.747 - | Processes: [LT1, CL1] [2024-10-31T01:22:08.943Z] STF 01:22:08.747 - | [2024-10-31T01:22:08.943Z] STF 01:22:08.747 - Monitoring processes: CL1 LT1 [2024-10-31T01:22:08.943Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-31T01:22:09.256Z] CL1 j> 2024/10/31 01:22:09.024 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-31T01:22:09.257Z] CL1 j> 2024/10/31 01:22:09.087 Attempting to connect [2024-10-31T01:22:09.555Z] CL1 j> 2024/10/31 01:22:09.383 Monitored VM not ready at Oct 31, 2024, 1:22:09?AM (attempt 1, elapsed 258ms). [2024-10-31T01:22:09.555Z] CL1 j> 2024/10/31 01:22:09.383 Waiting 5 secs and trying again... [2024-10-31T01:22:15.485Z] CL1 j> 2024/10/31 01:22:14.406 Attempting to connect [2024-10-31T01:22:17.135Z] CL1 j> 2024/10/31 01:22:15.633 Connection established! [2024-10-31T01:22:17.135Z] CL1 j> 2024/10/31 01:22:15.910 Starting to write data [2024-10-31T01:27:12.138Z] STF 01:27:08.457 - Heartbeat: Process LT1 is still running [2024-10-31T01:27:52.535Z] STF 01:27:46.004 - Monitoring Report Summary: [2024-10-31T01:27:52.535Z] STF 01:27:46.004 - o Process CL1 ended with the expected exit code (0) [2024-10-31T01:27:52.535Z] STF 01:27:46.005 - o Process LT1 is still running as expected [2024-10-31T01:27:52.535Z] STF 01:27:46.105 - [2024-10-31T01:27:52.535Z] STF 01:27:46.105 - +------ Step 4 - Stop LT1 process [2024-10-31T01:27:52.535Z] STF 01:27:46.105 - | Kill running processes [2024-10-31T01:27:52.535Z] STF 01:27:46.105 - | Processes: [LT1] [2024-10-31T01:27:52.535Z] STF 01:27:46.105 - | [2024-10-31T01:27:52.535Z] STF 01:27:46.105 - Killing processes: LT1 [2024-10-31T01:27:52.535Z] STF 01:27:46.158 - o Process clean up attempt 1 for LT1 pid 10996 [2024-10-31T01:27:52.535Z] STF 01:27:46.158 - o Process LT1 pid 10996 stop() [2024-10-31T01:27:52.535Z] STF 01:27:46.175 - o Process LT1 pid 10996 killed [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - | Start background process [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - | Program: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - | Mnemonic: LT2 [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - | Echo: ECHO_OFF [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - | Expectation: NEVER [2024-10-31T01:27:52.535Z] STF 01:27:46.176 - | [2024-10-31T01:27:52.536Z] STF 01:27:46.177 - Running command: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\STF\stf.load\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\STF\stf.core\bin;C:/Users/jenkins/testDependency/system_lib/log4j/log4j-api.jar;C:/Users/jenkins/testDependency/system_lib/log4j/log4j-core.jar;C:/Users/jenkins/testDependency/system_lib/junit/junit.jar;C:/Users/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\aqa-tests\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1\20241031-012205-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:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-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-10-31T01:27:52.536Z] STF 01:27:46.177 - Redirecting stderr to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-10-31T01:27:52.536Z] STF 01:27:46.177 - Redirecting stdout to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - | Start background process [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - | Program: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - | Mnemonic: CL2 [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - | Echo: ECHO_ON [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - | Expectation: CLEAN_RUN within 30m [2024-10-31T01:27:52.536Z] STF 01:27:46.186 - | [2024-10-31T01:27:52.536Z] STF 01:27:46.187 - Running command: C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\Users\jenkins\workspace\Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;C:/Users/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-31T01:27:52.536Z] STF 01:27:46.187 - Redirecting stderr to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-10-31T01:27:52.536Z] STF 01:27:46.187 - Redirecting stdout to C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/TKG/output_17303343952862/TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-10-31T01:27:52.536Z] STF 01:27:46.195 - [2024-10-31T01:27:52.536Z] STF 01:27:46.195 - +------ Step 7 - Wait for processes to complete [2024-10-31T01:27:52.536Z] STF 01:27:46.196 - | Wait for processes to meet expectations [2024-10-31T01:27:52.536Z] STF 01:27:46.196 - | Processes: [LT2, CL2] [2024-10-31T01:27:52.536Z] STF 01:27:46.196 - | [2024-10-31T01:27:52.536Z] STF 01:27:46.196 - Monitoring processes: CL2 LT2 [2024-10-31T01:27:52.536Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-31T01:27:52.536Z] CL2 j> 2024/10/31 01:27:46.442 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-31T01:27:52.536Z] CL2 j> 2024/10/31 01:27:46.520 Attempting to connect [2024-10-31T01:27:52.536Z] CL2 j> 2024/10/31 01:27:46.770 Monitored VM not ready at Oct 31, 2024, 1:27:46?AM (attempt 1, elapsed 222ms). [2024-10-31T01:27:52.536Z] CL2 j> 2024/10/31 01:27:46.770 Waiting 5 secs and trying again... [2024-10-31T01:27:52.536Z] CL2 j> 2024/10/31 01:27:51.833 Attempting to connect [2024-10-31T01:27:59.131Z] CL2 j> 2024/10/31 01:27:56.313 Connection established! [2024-10-31T01:28:10.499Z] CL2 j> 2024/10/31 01:28:09.266 Writing report data ... [2024-10-31T01:28:13.676Z] CL2 j> 2024/10/31 01:28:11.423 done. [2024-10-31T01:28:22.754Z] CL2 j> 2024/10/31 01:28:21.907 Writing report data ... [2024-10-31T01:28:24.008Z] CL2 j> 2024/10/31 01:28:23.126 done. [2024-10-31T01:28:34.997Z] CL2 j> 2024/10/31 01:28:33.547 Writing report data ... [2024-10-31T01:28:36.145Z] CL2 j> 2024/10/31 01:28:34.204 done. [2024-10-31T01:28:47.176Z] CL2 j> 2024/10/31 01:28:44.501 Writing report data ... [2024-10-31T01:28:47.176Z] CL2 j> 2024/10/31 01:28:45.016 done. [2024-10-31T01:28:58.079Z] CL2 j> 2024/10/31 01:28:55.297 Writing report data ... [2024-10-31T01:28:58.079Z] CL2 j> 2024/10/31 01:28:56.360 done. [2024-10-31T01:29:09.002Z] CL2 j> 2024/10/31 01:29:06.563 Writing report data ... [2024-10-31T01:29:09.352Z] CL2 j> 2024/10/31 01:29:07.485 done. [2024-10-31T01:29:20.499Z] CL2 j> 2024/10/31 01:29:17.766 Writing report data ... [2024-10-31T01:29:20.499Z] CL2 j> 2024/10/31 01:29:18.313 done. [2024-10-31T01:29:31.457Z] CL2 j> 2024/10/31 01:29:28.626 Writing report data ... [2024-10-31T01:29:31.457Z] CL2 j> 2024/10/31 01:29:29.172 done. [2024-10-31T01:29:42.492Z] CL2 j> 2024/10/31 01:29:39.344 Writing report data ... [2024-10-31T01:29:42.492Z] CL2 j> 2024/10/31 01:29:39.829 done. [2024-10-31T01:29:53.597Z] CL2 j> 2024/10/31 01:29:50.157 Writing report data ... [2024-10-31T01:29:53.597Z] CL2 j> 2024/10/31 01:29:50.672 done. [2024-10-31T01:30:04.617Z] CL2 j> 2024/10/31 01:30:00.985 Writing report data ... [2024-10-31T01:30:04.617Z] CL2 j> 2024/10/31 01:30:01.313 done. [2024-10-31T01:30:13.750Z] CL2 j> 2024/10/31 01:30:11.500 Writing report data ... [2024-10-31T01:30:13.750Z] CL2 j> 2024/10/31 01:30:11.954 done. [2024-10-31T01:30:24.732Z] CL2 j> 2024/10/31 01:30:22.188 Writing report data ... [2024-10-31T01:30:24.732Z] CL2 j> 2024/10/31 01:30:22.594 done. [2024-10-31T01:30:35.784Z] CL2 j> 2024/10/31 01:30:32.875 Writing report data ... [2024-10-31T01:30:35.784Z] CL2 j> 2024/10/31 01:30:33.875 done. [2024-10-31T01:30:46.708Z] CL2 j> 2024/10/31 01:30:44.063 Writing report data ... [2024-10-31T01:30:46.708Z] CL2 j> 2024/10/31 01:30:44.407 done. [2024-10-31T01:30:55.839Z] CL2 j> 2024/10/31 01:30:54.532 Writing report data ... [2024-10-31T01:30:56.599Z] CL2 j> 2024/10/31 01:30:55.329 done. [2024-10-31T01:31:07.679Z] CL2 j> 2024/10/31 01:31:05.547 Writing report data ... [2024-10-31T01:31:07.679Z] CL2 j> 2024/10/31 01:31:05.828 done. [2024-10-31T01:31:18.779Z] CL2 j> 2024/10/31 01:31:16.235 Writing report data ... [2024-10-31T01:31:18.779Z] CL2 j> 2024/10/31 01:31:16.610 done. [2024-10-31T01:31:29.661Z] CL2 j> 2024/10/31 01:31:26.969 Writing report data ... [2024-10-31T01:31:29.661Z] CL2 j> 2024/10/31 01:31:27.297 done. [2024-10-31T01:31:38.734Z] CL2 j> 2024/10/31 01:31:37.625 Writing report data ... [2024-10-31T01:31:39.909Z] CL2 j> 2024/10/31 01:31:37.985 done. [2024-10-31T01:31:50.962Z] CL2 j> 2024/10/31 01:31:48.375 Writing report data ... [2024-10-31T01:31:50.962Z] CL2 j> 2024/10/31 01:31:48.719 done. [2024-10-31T01:32:01.992Z] CL2 j> 2024/10/31 01:31:58.891 Writing report data ... [2024-10-31T01:32:01.992Z] CL2 j> 2024/10/31 01:31:59.313 done. [2024-10-31T01:32:09.386Z] STF 01:32:08.153 - Heartbeat: Process CL2 is still running [2024-10-31T01:32:13.234Z] CL2 j> 2024/10/31 01:32:09.953 Writing report data ... [2024-10-31T01:32:13.234Z] CL2 j> 2024/10/31 01:32:10.266 done. [2024-10-31T01:32:22.256Z] CL2 j> 2024/10/31 01:32:20.531 Writing report data ... [2024-10-31T01:32:22.991Z] CL2 j> 2024/10/31 01:32:20.938 done. [2024-10-31T01:32:34.081Z] CL2 j> 2024/10/31 01:32:31.281 Writing report data ... [2024-10-31T01:32:34.081Z] CL2 j> 2024/10/31 01:32:31.703 done. [2024-10-31T01:32:43.397Z] CL2 j> 2024/10/31 01:32:41.891 Writing report data ... [2024-10-31T01:32:43.397Z] CL2 j> 2024/10/31 01:32:42.156 done. [2024-10-31T01:32:54.372Z] CL2 j> 2024/10/31 01:32:52.516 Writing report data ... [2024-10-31T01:32:54.372Z] CL2 j> 2024/10/31 01:32:53.031 done. [2024-10-31T01:33:05.433Z] CL2 j> 2024/10/31 01:33:03.485 Writing report data ... [2024-10-31T01:33:05.847Z] CL2 j> 2024/10/31 01:33:04.485 done. [2024-10-31T01:33:16.829Z] CL2 j> 2024/10/31 01:33:14.656 Writing report data ... [2024-10-31T01:33:16.829Z] CL2 j> 2024/10/31 01:33:15.156 done. [2024-10-31T01:33:27.885Z] CL2 j> 2024/10/31 01:33:25.391 Writing report data ... [2024-10-31T01:33:27.885Z] CL2 j> 2024/10/31 01:33:26.110 done. [2024-10-31T01:33:33.913Z] STF 01:33:32.778 - Monitoring Report Summary: [2024-10-31T01:33:33.913Z] STF 01:33:32.778 - o Process CL2 ended with the expected exit code (0) [2024-10-31T01:33:33.913Z] STF 01:33:32.778 - o Process LT2 is still running as expected [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - +------ Step 8 - Stop LT2 process [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - | Kill running processes [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - | Processes: [LT2] [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - | [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - Killing processes: LT2 [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - o Process clean up attempt 1 for LT2 pid 48704 [2024-10-31T01:33:33.913Z] STF 01:33:32.780 - o Process LT2 pid 48704 stop() [2024-10-31T01:33:33.913Z] STF 01:33:32.781 - o Process LT2 pid 48704 killed [2024-10-31T01:33:33.913Z] STF 01:33:32.782 - EXECUTE stage completed [2024-10-31T01:33:33.913Z] STF 01:33:33.303 - [2024-10-31T01:33:33.913Z] STF 01:33:33.303 - ==================== T E A R D O W N ==================== [2024-10-31T01:33:33.913Z] STF 01:33:33.303 - Running teardown: perl C:/Users/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_windows_testList_0/aqa-tests/\TKG\output_17303343952862\TestJlmRemoteThreadNoAuth_1/20241031-012205-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-10-31T01:33:33.913Z] STF 01:33:33.678 - TEARDOWN stage completed [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - ===================== R E S U L T S ===================== [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - Stage results: [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - setUp: pass [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - execute: pass [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - teardown: pass [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - [2024-10-31T01:33:33.913Z] STF 01:33:33.708 - Overall result: PASSED [2024-10-31T01:33:33.913Z] ----------------------------------- [2024-10-31T01:33:33.913Z] TestJlmRemoteThreadNoAuth_1_PASSED [2024-10-31T01:33:33.913Z] ----------------------------------- [2024-10-31T01:33:33.913Z] [2024-10-31T01:33:33.913Z] TEST TEARDOWN: [2024-10-31T01:33:33.913Z] Nothing to be done for teardown. [2024-10-31T01:33:34.211Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Thu Oct 31 01:33:34 2024 Epoch Time (ms): 1730338414053