[2024-11-21T18:37:48.059Z] Running test TestJlmRemoteThreadNoAuth_0 ... [2024-11-21T18:37:48.059Z] =============================================== [2024-11-21T18:37:48.059Z] TestJlmRemoteThreadNoAuth_0 Start Time: Thu Nov 21 10:37:45 2024 Epoch Time (ms): 1732214265852 [2024-11-21T18:37:48.059Z] variation: Mode150 [2024-11-21T18:37:48.059Z] JVM_OPTIONS: -XX:+UseCompressedOops [2024-11-21T18:37:48.059Z] { \ [2024-11-21T18:37:48.059Z] echo ""; echo "TEST SETUP:"; \ [2024-11-21T18:37:48.059Z] echo "Nothing to be done for setup."; \ [2024-11-21T18:37:48.059Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0"; \ [2024-11-21T18:37:48.059Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0"; \ [2024-11-21T18:37:48.059Z] echo ""; echo "TESTING:"; \ [2024-11-21T18:37:48.059Z] perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/../../testDependency/system_lib/" -java-args=' -XX:+UseCompressedOops ' -results-root="/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0" -test=TestJlmRemoteThreadNoAuth; \ [2024-11-21T18:37:48.059Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-21T18:37:48.059Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-21T18:37:48.059Z] echo "Nothing to be done for teardown."; \ [2024-11-21T18:37:48.059Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestTargetResult"; [2024-11-21T18:37:48.501Z] [2024-11-21T18:37:48.502Z] TEST SETUP: [2024-11-21T18:37:48.502Z] Nothing to be done for setup. [2024-11-21T18:37:48.502Z] [2024-11-21T18:37:48.502Z] TESTING: [2024-11-21T18:37:48.502Z] STF 10:37:46.137 - ========================= S T F ========================= [2024-11-21T18:37:48.502Z] systemtest-prereqs has been processed, and set to: /Users/admin/workspace/testDependency/system_libRetrieving amount of free space on drive containing /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0 [2024-11-21T18:37:48.502Z] There is 11912 Mb free [2024-11-21T18:37:48.502Z] STF 10:37:46.154 - ================== G E N E R A T I O N ================== [2024-11-21T18:37:48.502Z] STF 10:37:46.155 - Checking JVM: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/../ [2024-11-21T18:37:48.502Z] STF 10:37:46.155 - Starting process to generate scripts: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/..//bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth" [2024-11-21T18:37:52.893Z] GEN Java lib directory does not exist: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/lib [2024-11-21T18:37:52.893Z] GEN 10:37:50.621 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2024-11-21T18:37:52.893Z] GEN 10:37:50.711 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-11-21T18:37:53.969Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-11-21T18:37:53.969Z] GEN /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2024-11-21T18:37:53.969Z] GEN /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.core/bin [2024-11-21T18:37:53.969Z] GEN /Users/admin/workspace/testDependency/system_lib/log4j/log4j-api.jar [2024-11-21T18:37:53.969Z] GEN /Users/admin/workspace/testDependency/system_lib/log4j/log4j-core.jar [2024-11-21T18:37:53.969Z] GEN /Users/admin/workspace/testDependency/system_lib/junit/junit.jar [2024-11-21T18:37:53.969Z] GEN Java lib directory does not exist: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/lib [2024-11-21T18:37:53.969Z] GEN 10:37:51.387 - Using Mode NoOptions. Values = '' [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - Test command summary: [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - Step Stage Command Description [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - -----+--------+-----------------+------------ [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 3 execute Monitor Wait for processes to complete [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 4 execute kill Stop LT1 process [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-11-21T18:37:53.969Z] GEN 10:37:51.639 - 7 execute Monitor Wait for processes to complete [2024-11-21T18:37:53.969Z] GEN 10:37:51.640 - 8 execute kill Stop LT2 process [2024-11-21T18:37:54.583Z] STF 10:37:51.902 - [2024-11-21T18:37:54.583Z] STF 10:37:51.902 - Script generation completed [2024-11-21T18:37:54.583Z] STF 10:37:51.902 - [2024-11-21T18:37:54.583Z] STF 10:37:51.902 - [2024-11-21T18:37:54.583Z] STF 10:37:51.903 - ======================= S E T U P ======================= [2024-11-21T18:37:54.583Z] STF 10:37:51.903 - Running setup: perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/setUp.pl [2024-11-21T18:37:55.213Z] STF 10:37:52.959 - SETUP stage completed [2024-11-21T18:37:55.213Z] STF 10:37:53.039 - [2024-11-21T18:37:55.213Z] STF 10:37:53.040 - ==================== E X E C U T E - ==================== [2024-11-21T18:37:55.213Z] STF 10:37:53.040 - Running execute: perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/execute.pl [2024-11-21T18:37:57.249Z] STF 10:37:54.665 - [2024-11-21T18:37:57.249Z] STF 10:37:54.665 - Java version [2024-11-21T18:37:57.249Z] STF 10:37:54.665 - Running: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java -version [2024-11-21T18:37:57.712Z] openjdk version "11.0.26-beta" 2025-01-21 [2024-11-21T18:37:57.712Z] OpenJDK Runtime Environment Temurin-11.0.26+2-202411202106 (build 11.0.26-beta+2-ea) [2024-11-21T18:37:57.712Z] OpenJDK 64-Bit Server VM Temurin-11.0.26+2-202411202106 (build 11.0.26-beta+2-ea, mixed mode) [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - | Start background process [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - | Mnemonic: LT1 [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - | Echo: ECHO_OFF [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - | Expectation: NEVER [2024-11-21T18:37:57.712Z] STF 10:37:55.150 - | [2024-11-21T18:37:57.713Z] STF 10:37:55.151 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:+UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.load/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.core/bin:/Users/admin/workspace/testDependency/system_lib/log4j/log4j-api.jar:/Users/admin/workspace/testDependency/system_lib/log4j/log4j-core.jar:/Users/admin/workspace/testDependency/system_lib/junit/junit.jar:/Users/admin/workspace/testDependency/system_lib/junit/hamcrest-core.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-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 /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-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-21T18:37:57.713Z] STF 10:37:55.152 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-11-21T18:37:57.713Z] STF 10:37:55.152 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-11-21T18:37:57.713Z] STF 10:37:55.173 - [2024-11-21T18:37:57.713Z] STF 10:37:55.173 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-11-21T18:37:57.713Z] STF 10:37:55.174 - | Start background process [2024-11-21T18:37:57.713Z] STF 10:37:55.174 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java [2024-11-21T18:37:57.713Z] STF 10:37:55.174 - | Mnemonic: CL1 [2024-11-21T18:37:57.713Z] STF 10:37:55.174 - | Echo: ECHO_ON [2024-11-21T18:37:57.713Z] STF 10:37:55.174 - | Expectation: CLEAN_RUN within 30m [2024-11-21T18:37:57.713Z] STF 10:37:55.174 - | [2024-11-21T18:37:57.713Z] STF 10:37:55.175 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/Users/admin/workspace/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-11-21T18:37:57.713Z] STF 10:37:55.175 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-11-21T18:37:57.713Z] STF 10:37:55.175 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-11-21T18:37:57.713Z] STF 10:37:55.177 - [2024-11-21T18:37:57.713Z] STF 10:37:55.177 - +------ Step 3 - Wait for processes to complete [2024-11-21T18:37:57.713Z] STF 10:37:55.177 - | Wait for processes to meet expectations [2024-11-21T18:37:57.713Z] STF 10:37:55.177 - | Processes: [LT1, CL1] [2024-11-21T18:37:57.713Z] STF 10:37:55.177 - | [2024-11-21T18:37:57.713Z] STF 10:37:55.178 - Monitoring processes: CL1 LT1 [2024-11-21T18:38:00.394Z] CL1 j> 2024/11/21 10:37:57.166 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-21T18:38:00.394Z] CL1 j> 2024/11/21 10:37:57.692 Attempting to connect [2024-11-21T18:38:00.394Z] CL1 j> 2024/11/21 10:37:58.166 Monitored VM not ready at Nov 21, 2024, 10:37:58 AM (attempt 1, elapsed 320ms). [2024-11-21T18:38:00.394Z] CL1 j> 2024/11/21 10:37:58.167 Waiting 5 secs and trying again... [2024-11-21T18:38:06.729Z] CL1 j> 2024/11/21 10:38:03.169 Attempting to connect [2024-11-21T18:38:07.901Z] CL1 j> 2024/11/21 10:38:04.926 Connection established! [2024-11-21T18:38:08.710Z] CL1 j> 2024/11/21 10:38:06.053 Starting to write data [2024-11-21T18:42:58.582Z] STF 10:42:54.400 - Heartbeat: Process CL1 is still running [2024-11-21T18:45:28.846Z] STF 10:45:13.025 - Monitoring Report Summary: [2024-11-21T18:45:28.846Z] STF 10:45:13.025 - o Process CL1 ended with the expected exit code (0) [2024-11-21T18:45:28.846Z] STF 10:45:13.025 - o Process LT1 is still running as expected [2024-11-21T18:45:28.846Z] STF 10:45:13.026 - [2024-11-21T18:45:28.846Z] STF 10:45:13.026 - +------ Step 4 - Stop LT1 process [2024-11-21T18:45:28.846Z] STF 10:45:13.026 - | Kill running processes [2024-11-21T18:45:28.847Z] STF 10:45:13.026 - | Processes: [LT1] [2024-11-21T18:45:28.847Z] STF 10:45:13.026 - | [2024-11-21T18:45:28.847Z] STF 10:45:13.026 - Killing processes: LT1 [2024-11-21T18:45:28.847Z] STF 10:45:13.026 - o Process clean up attempt 1 for LT1 pid 7624 [2024-11-21T18:45:28.847Z] STF 10:45:13.026 - o Process LT1 pid 7624 stop() [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - o Process LT1 pid 7624 killed [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - | Start background process [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - | Mnemonic: LT2 [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - | Echo: ECHO_OFF [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - | Expectation: NEVER [2024-11-21T18:45:28.847Z] STF 10:45:14.036 - | [2024-11-21T18:45:28.847Z] STF 10:45:14.037 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:+UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.load/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/STF/stf.core/bin:/Users/admin/workspace/testDependency/system_lib/log4j/log4j-api.jar:/Users/admin/workspace/testDependency/system_lib/log4j/log4j-core.jar:/Users/admin/workspace/testDependency/system_lib/junit/junit.jar:/Users/admin/workspace/testDependency/system_lib/junit/hamcrest-core.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-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 /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-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-21T18:45:28.847Z] STF 10:45:14.037 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-11-21T18:45:28.847Z] STF 10:45:14.037 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - | Start background process [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - | Mnemonic: CL2 [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - | Echo: ECHO_ON [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - | Expectation: CLEAN_RUN within 30m [2024-11-21T18:45:28.847Z] STF 10:45:14.039 - | [2024-11-21T18:45:28.847Z] STF 10:45:14.040 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/Users/admin/workspace/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-11-21T18:45:28.847Z] STF 10:45:14.040 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-11-21T18:45:28.847Z] STF 10:45:14.040 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-11-21T18:45:28.847Z] STF 10:45:14.053 - [2024-11-21T18:45:28.847Z] STF 10:45:14.053 - +------ Step 7 - Wait for processes to complete [2024-11-21T18:45:28.847Z] STF 10:45:14.053 - | Wait for processes to meet expectations [2024-11-21T18:45:28.847Z] STF 10:45:14.053 - | Processes: [LT2, CL2] [2024-11-21T18:45:28.848Z] STF 10:45:14.053 - | [2024-11-21T18:45:28.848Z] STF 10:45:14.053 - Monitoring processes: CL2 LT2 [2024-11-21T18:45:28.848Z] CL2 j> 2024/11/21 10:45:16.148 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-21T18:45:28.848Z] CL2 j> 2024/11/21 10:45:16.525 Attempting to connect [2024-11-21T18:45:28.848Z] CL2 j> 2024/11/21 10:45:17.510 Connection established! [2024-11-21T18:45:33.334Z] CL2 j> 2024/11/21 10:45:30.758 Writing report data ... [2024-11-21T18:45:47.853Z] CL2 j> 2024/11/21 10:45:45.067 done. [2024-11-21T18:45:59.619Z] CL2 j> 2024/11/21 10:45:56.165 Writing report data ... [2024-11-21T18:46:11.378Z] CL2 j> 2024/11/21 10:46:07.506 done. [2024-11-21T18:46:21.408Z] CL2 j> 2024/11/21 10:46:18.121 Writing report data ... [2024-11-21T18:46:29.254Z] CL2 j> 2024/11/21 10:46:25.206 done. [2024-11-21T18:46:39.433Z] CL2 j> 2024/11/21 10:46:35.858 Writing report data ... [2024-11-21T18:46:46.609Z] CL2 j> 2024/11/21 10:46:42.576 done. [2024-11-21T18:46:56.829Z] CL2 j> 2024/11/21 10:46:53.325 Writing report data ... [2024-11-21T18:47:03.663Z] CL2 j> 2024/11/21 10:47:00.563 done. [2024-11-21T18:47:15.469Z] CL2 j> 2024/11/21 10:47:11.156 Writing report data ... [2024-11-21T18:47:19.737Z] CL2 j> 2024/11/21 10:47:16.229 done. [2024-11-21T18:47:31.212Z] CL2 j> 2024/11/21 10:47:27.473 Writing report data ... [2024-11-21T18:47:36.708Z] CL2 j> 2024/11/21 10:47:33.908 done. [2024-11-21T18:47:48.322Z] CL2 j> 2024/11/21 10:47:44.161 Writing report data ... [2024-11-21T18:47:52.986Z] CL2 j> 2024/11/21 10:47:49.289 done. [2024-11-21T18:47:57.508Z] STF 10:47:54.288 - Heartbeat: Process LT2 is still running [2024-11-21T18:48:03.187Z] CL2 j> 2024/11/21 10:47:59.747 Writing report data ... [2024-11-21T18:48:06.400Z] CL2 j> 2024/11/21 10:48:03.468 done. [2024-11-21T18:48:18.155Z] CL2 j> 2024/11/21 10:48:14.158 Writing report data ... [2024-11-21T18:48:23.802Z] CL2 j> 2024/11/21 10:48:20.431 done. [2024-11-21T18:48:33.638Z] CL2 j> 2024/11/21 10:48:30.970 Writing report data ... [2024-11-21T18:48:45.804Z] CL2 j> 2024/11/21 10:48:40.985 done. [2024-11-21T18:48:55.518Z] CL2 j> 2024/11/21 10:48:51.766 Writing report data ... [2024-11-21T18:49:02.241Z] CL2 j> 2024/11/21 10:48:58.613 done. [2024-11-21T18:49:12.396Z] CL2 j> 2024/11/21 10:49:09.107 Writing report data ... [2024-11-21T18:49:18.361Z] CL2 j> 2024/11/21 10:49:15.590 done. [2024-11-21T18:49:29.782Z] CL2 j> 2024/11/21 10:49:26.024 Writing report data ... [2024-11-21T18:49:34.098Z] CL2 j> 2024/11/21 10:49:30.906 done. [2024-11-21T18:49:45.920Z] CL2 j> 2024/11/21 10:49:41.450 Writing report data ... [2024-11-21T18:49:50.133Z] CL2 j> 2024/11/21 10:49:46.521 done. [2024-11-21T18:50:01.427Z] CL2 j> 2024/11/21 10:49:57.117 Writing report data ... [2024-11-21T18:50:05.865Z] CL2 j> 2024/11/21 10:50:03.393 done. [2024-11-21T18:50:17.737Z] CL2 j> 2024/11/21 10:50:13.829 Writing report data ... [2024-11-21T18:50:21.164Z] CL2 j> 2024/11/21 10:50:17.770 done. [2024-11-21T18:50:32.657Z] CL2 j> 2024/11/21 10:50:28.280 Writing report data ... [2024-11-21T18:50:38.064Z] CL2 j> 2024/11/21 10:50:35.106 done. [2024-11-21T18:50:49.187Z] CL2 j> 2024/11/21 10:50:45.625 Writing report data ... [2024-11-21T18:50:54.536Z] CL2 j> 2024/11/21 10:50:51.609 done. [2024-11-21T18:51:04.902Z] CL2 j> 2024/11/21 10:51:02.126 Writing report data ... [2024-11-21T18:51:09.103Z] CL2 j> 2024/11/21 10:51:06.074 done. [2024-11-21T18:51:20.738Z] CL2 j> 2024/11/21 10:51:16.552 Writing report data ... [2024-11-21T18:51:24.867Z] CL2 j> 2024/11/21 10:51:21.437 done. [2024-11-21T18:51:36.625Z] CL2 j> 2024/11/21 10:51:32.125 Writing report data ... [2024-11-21T18:51:39.812Z] CL2 j> 2024/11/21 10:51:37.066 done. [2024-11-21T18:51:51.321Z] CL2 j> 2024/11/21 10:51:47.546 Writing report data ... [2024-11-21T18:51:53.775Z] CL2 j> 2024/11/21 10:51:50.854 done. [2024-11-21T18:52:05.382Z] CL2 j> 2024/11/21 10:52:01.289 Writing report data ... [2024-11-21T18:52:08.791Z] CL2 j> 2024/11/21 10:52:05.173 done. [2024-11-21T18:52:20.242Z] CL2 j> 2024/11/21 10:52:15.953 Writing report data ... [2024-11-21T18:52:23.047Z] CL2 j> 2024/11/21 10:52:19.827 done. [2024-11-21T18:52:34.702Z] CL2 j> 2024/11/21 10:52:30.304 Writing report data ... [2024-11-21T18:52:38.490Z] CL2 j> 2024/11/21 10:52:35.344 done. [2024-11-21T18:52:50.067Z] CL2 j> 2024/11/21 10:52:46.460 Writing report data ... [2024-11-21T18:52:53.970Z] CL2 j> 2024/11/21 10:52:51.084 done. [2024-11-21T18:52:57.434Z] STF 10:52:54.422 - Heartbeat: Process LT2 is still running [2024-11-21T18:53:04.530Z] CL2 j> 2024/11/21 10:53:01.610 Writing report data ... [2024-11-21T18:53:07.860Z] CL2 j> 2024/11/21 10:53:04.647 done. [2024-11-21T18:53:19.735Z] CL2 j> 2024/11/21 10:53:15.269 Writing report data ... [2024-11-21T18:53:23.109Z] CL2 j> 2024/11/21 10:53:19.799 done. [2024-11-21T18:53:33.025Z] CL2 j> 2024/11/21 10:53:30.254 Writing report data ... [2024-11-21T18:53:42.865Z] CL2 j> 2024/11/21 10:53:39.874 done. [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - Monitoring Report Summary: [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - o Process CL2 ended with the expected exit code (0) [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - o Process LT2 is still running as expected [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - +------ Step 8 - Stop LT2 process [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - | Kill running processes [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - | Processes: [LT2] [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - | [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - Killing processes: LT2 [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - o Process clean up attempt 1 for LT2 pid 7991 [2024-11-21T18:53:43.837Z] STF 10:53:41.121 - o Process LT2 pid 7991 stop() [2024-11-21T18:53:44.772Z] STF 10:53:42.132 - o Process LT2 pid 7991 killed [2024-11-21T18:53:44.772Z] STF 10:53:42.132 - EXECUTE stage completed [2024-11-21T18:53:44.772Z] STF 10:53:42.347 - [2024-11-21T18:53:44.772Z] STF 10:53:42.347 - ==================== T E A R D O W N ==================== [2024-11-21T18:53:44.772Z] STF 10:53:42.347 - Running teardown: perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17322093943240/TestJlmRemoteThreadNoAuth_0/20241121-103746-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-11-21T18:53:44.772Z] STF 10:53:42.522 - TEARDOWN stage completed [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - ===================== R E S U L T S ===================== [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - Stage results: [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - setUp: pass [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - execute: pass [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - teardown: pass [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - [2024-11-21T18:53:44.772Z] STF 10:53:42.536 - Overall result: PASSED [2024-11-21T18:53:44.772Z] ----------------------------------- [2024-11-21T18:53:44.772Z] TestJlmRemoteThreadNoAuth_0_PASSED [2024-11-21T18:53:44.772Z] ----------------------------------- [2024-11-21T18:53:44.772Z] [2024-11-21T18:53:44.772Z] TEST TEARDOWN: [2024-11-21T18:53:44.772Z] Nothing to be done for teardown. [2024-11-21T18:53:45.265Z] TestJlmRemoteThreadNoAuth_0 Finish Time: Thu Nov 21 10:53:42 2024 Epoch Time (ms): 1732215222729