[2025-05-07T12:50:00.969Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-05-07T12:50:00.969Z] =============================================== [2025-05-07T12:50:00.969Z] TestJlmRemoteThreadNoAuth_1 Start Time: Wed May 7 08:50:00 2025 Epoch Time (ms): 1746622200783 [2025-05-07T12:50:00.969Z] variation: Mode650 [2025-05-07T12:50:00.969Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-05-07T12:50:00.969Z] { \ [2025-05-07T12:50:00.969Z] echo ""; echo "TEST SETUP:"; \ [2025-05-07T12:50:00.969Z] echo "Nothing to be done for setup."; \ [2025-05-07T12:50:00.969Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1"; \ [2025-05-07T12:50:00.969Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1"; \ [2025-05-07T12:50:00.969Z] echo ""; echo "TESTING:"; \ [2025-05-07T12:50:00.969Z] perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-05-07T12:50:00.969Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-07T12:50:00.969Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-07T12:50:00.969Z] echo "Nothing to be done for teardown."; \ [2025-05-07T12:50:00.969Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestTargetResult"; [2025-05-07T12:50:00.969Z] [2025-05-07T12:50:00.969Z] TEST SETUP: [2025-05-07T12:50:00.969Z] Nothing to be done for setup. [2025-05-07T12:50:00.969Z] [2025-05-07T12:50:00.969Z] TESTING: [2025-05-07T12:50:00.969Z] STF 08:50:00.828 - ========================= S T F ========================= [2025-05-07T12:50:00.969Z] 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_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1 [2025-05-07T12:50:01.344Z] There is 28293 Mb free [2025-05-07T12:50:01.344Z] STF 08:50:00.832 - ================== G E N E R A T I O N ================== [2025-05-07T12:50:01.344Z] STF 08:50:00.833 - Checking JVM: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/../ [2025-05-07T12:50:01.344Z] STF 08:50:00.833 - Starting process to generate scripts: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/..//bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/../../testDependency/system_lib//asm/asm.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/../../testDependency/system_lib//asm/asm-commons.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/../../testDependency/system_lib//log4j/log4j-api.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/../../testDependency/system_lib//log4j/log4j-core.jar:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth" [2025-05-07T12:50:01.743Z] GEN 08:50:01.360 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-05-07T12:50:01.743Z] GEN 08:50:01.370 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-05-07T12:50:01.743Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-05-07T12:50:01.743Z] GEN /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-05-07T12:50:01.743Z] GEN /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.core/bin [2025-05-07T12:50:01.743Z] GEN /Users/admin/workspace/testDependency/system_lib/log4j/log4j-api.jar [2025-05-07T12:50:01.743Z] GEN /Users/admin/workspace/testDependency/system_lib/log4j/log4j-core.jar [2025-05-07T12:50:01.743Z] GEN /Users/admin/workspace/testDependency/system_lib/junit/junit.jar [2025-05-07T12:50:01.743Z] GEN 08:50:01.450 - Using Mode NoOptions. Values = '' [2025-05-07T12:50:01.743Z] GEN 08:50:01.504 - [2025-05-07T12:50:01.743Z] GEN 08:50:01.504 - Test command summary: [2025-05-07T12:50:01.743Z] GEN 08:50:01.504 - Step Stage Command Description [2025-05-07T12:50:01.743Z] GEN 08:50:01.504 - -----+--------+-----------------+------------ [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 3 execute Monitor Wait for processes to complete [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 4 execute kill Stop LT1 process [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 7 execute Monitor Wait for processes to complete [2025-05-07T12:50:01.743Z] GEN 08:50:01.505 - 8 execute kill Stop LT2 process [2025-05-07T12:50:01.743Z] STF 08:50:01.558 - [2025-05-07T12:50:01.743Z] STF 08:50:01.558 - Script generation completed [2025-05-07T12:50:01.743Z] STF 08:50:01.559 - [2025-05-07T12:50:01.743Z] STF 08:50:01.559 - [2025-05-07T12:50:01.743Z] STF 08:50:01.559 - ======================= S E T U P ======================= [2025-05-07T12:50:01.743Z] STF 08:50:01.559 - Running setup: perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/setUp.pl [2025-05-07T12:50:02.117Z] STF 08:50:01.616 - SETUP stage completed [2025-05-07T12:50:02.117Z] STF 08:50:01.626 - [2025-05-07T12:50:02.117Z] STF 08:50:01.626 - ==================== E X E C U T E - ==================== [2025-05-07T12:50:02.117Z] STF 08:50:01.626 - Running execute: perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/execute.pl [2025-05-07T12:50:02.117Z] STF 08:50:01.665 - [2025-05-07T12:50:02.117Z] STF 08:50:01.665 - Java version [2025-05-07T12:50:02.117Z] STF 08:50:01.665 - Running: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java -version [2025-05-07T12:50:02.117Z] openjdk version "11.0.28-beta" 2025-07-15 [2025-05-07T12:50:02.117Z] OpenJDK Runtime Environment Temurin-11.0.28+1-202505071002 (build 11.0.28-beta+1-ea) [2025-05-07T12:50:02.118Z] OpenJDK 64-Bit Server VM Temurin-11.0.28+1-202505071002 (build 11.0.28-beta+1-ea, mixed mode) [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - | Start background process [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - | Mnemonic: LT1 [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - | Echo: ECHO_OFF [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - | Expectation: NEVER [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - | [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java -javaagent:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.load/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/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/asm/asm.jar:/Users/admin/workspace/testDependency/system_lib/asm/asm-commons.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_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-05-07T12:50:02.118Z] STF 08:50:01.734 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - | Start background process [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - | Mnemonic: CL1 [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - | Echo: ECHO_ON [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - | Expectation: CLEAN_RUN within 30m [2025-05-07T12:50:02.118Z] STF 08:50:01.739 - | [2025-05-07T12:50:02.118Z] STF 08:50:01.740 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-05-07T12:50:02.118Z] STF 08:50:01.740 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-05-07T12:50:02.118Z] STF 08:50:01.740 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-05-07T12:50:02.118Z] STF 08:50:01.741 - [2025-05-07T12:50:02.118Z] STF 08:50:01.742 - +------ Step 3 - Wait for processes to complete [2025-05-07T12:50:02.118Z] STF 08:50:01.742 - | Wait for processes to meet expectations [2025-05-07T12:50:02.118Z] STF 08:50:01.742 - | Processes: [LT1, CL1] [2025-05-07T12:50:02.118Z] STF 08:50:01.742 - | [2025-05-07T12:50:02.118Z] STF 08:50:01.742 - Monitoring processes: CL1 LT1 [2025-05-07T12:50:02.490Z] CL1 j> 2025/05/07 08:50:01.912 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-05-07T12:50:02.490Z] CL1 j> 2025/05/07 08:50:01.975 Attempting to connect [2025-05-07T12:50:02.490Z] CL1 j> 2025/05/07 08:50:02.081 Monitored VM not ready at May 7, 2025, 8:50:02 AM (attempt 1, elapsed 93ms). [2025-05-07T12:50:02.490Z] CL1 j> 2025/05/07 08:50:02.081 Waiting 5 secs and trying again... [2025-05-07T12:50:07.611Z] CL1 j> 2025/05/07 08:50:07.086 Attempting to connect [2025-05-07T12:50:07.611Z] CL1 j> 2025/05/07 08:50:07.180 Connection established! [2025-05-07T12:50:07.611Z] CL1 j> 2025/05/07 08:50:07.223 Starting to write data [2025-05-07T12:55:03.095Z] STF 08:55:01.293 - Heartbeat: Process CL1 is still running [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - Monitoring Report Summary: [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - o Process CL1 ended with the expected exit code (0) [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - o Process LT1 is still running as expected [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - +------ Step 4 - Stop LT1 process [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - | Kill running processes [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - | Processes: [LT1] [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - | [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - Killing processes: LT1 [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - o Process clean up attempt 1 for LT1 pid 6038 [2025-05-07T12:55:19.521Z] STF 08:55:19.053 - o Process LT1 pid 6038 stop() [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - o Process LT1 pid 6038 killed [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - | Start background process [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - | Mnemonic: LT2 [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - | Echo: ECHO_OFF [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - | Expectation: NEVER [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - | [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java -javaagent:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/STF/stf.load/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/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/asm/asm.jar:/Users/admin/workspace/testDependency/system_lib/asm/asm-commons.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_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-05-07T12:55:20.795Z] STF 08:55:20.061 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-05-07T12:55:20.795Z] STF 08:55:20.062 - [2025-05-07T12:55:20.795Z] STF 08:55:20.062 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-05-07T12:55:20.795Z] STF 08:55:20.062 - | Start background process [2025-05-07T12:55:20.795Z] STF 08:55:20.062 - | Program: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java [2025-05-07T12:55:20.795Z] STF 08:55:20.062 - | Mnemonic: CL2 [2025-05-07T12:55:20.795Z] STF 08:55:20.062 - | Echo: ECHO_ON [2025-05-07T12:55:20.796Z] STF 08:55:20.062 - | Expectation: CLEAN_RUN within 30m [2025-05-07T12:55:20.796Z] STF 08:55:20.062 - | [2025-05-07T12:55:20.796Z] STF 08:55:20.063 - Running command: /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/jdkbinary/j2sdk-image/Contents/Home/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/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_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-05-07T12:55:20.796Z] STF 08:55:20.063 - Redirecting stderr to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-05-07T12:55:20.796Z] STF 08:55:20.063 - Redirecting stdout to /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-05-07T12:55:20.796Z] STF 08:55:20.064 - [2025-05-07T12:55:20.796Z] STF 08:55:20.064 - +------ Step 7 - Wait for processes to complete [2025-05-07T12:55:20.796Z] STF 08:55:20.064 - | Wait for processes to meet expectations [2025-05-07T12:55:20.796Z] STF 08:55:20.064 - | Processes: [LT2, CL2] [2025-05-07T12:55:20.796Z] STF 08:55:20.064 - | [2025-05-07T12:55:20.796Z] STF 08:55:20.064 - Monitoring processes: CL2 LT2 [2025-05-07T12:55:21.174Z] CL2 j> 2025/05/07 08:55:20.188 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-05-07T12:55:21.174Z] CL2 j> 2025/05/07 08:55:20.284 Attempting to connect [2025-05-07T12:55:21.174Z] CL2 j> 2025/05/07 08:55:20.358 Monitored VM not ready at May 7, 2025, 8:55:20 AM (attempt 1, elapsed 64ms). [2025-05-07T12:55:21.174Z] CL2 j> 2025/05/07 08:55:20.358 Waiting 5 secs and trying again... [2025-05-07T12:55:26.207Z] CL2 j> 2025/05/07 08:55:25.363 Attempting to connect [2025-05-07T12:55:26.207Z] CL2 j> 2025/05/07 08:55:25.448 Connection established! [2025-05-07T12:55:37.370Z] CL2 j> 2025/05/07 08:55:35.595 Writing report data ... [2025-05-07T12:55:37.370Z] CL2 j> 2025/05/07 08:55:36.739 done. [2025-05-07T12:55:48.569Z] CL2 j> 2025/05/07 08:55:46.820 Writing report data ... [2025-05-07T12:55:48.569Z] CL2 j> 2025/05/07 08:55:47.242 done. [2025-05-07T12:55:59.721Z] CL2 j> 2025/05/07 08:55:57.309 Writing report data ... [2025-05-07T12:55:59.721Z] CL2 j> 2025/05/07 08:55:57.457 done. [2025-05-07T12:56:09.102Z] CL2 j> 2025/05/07 08:56:07.648 Writing report data ... [2025-05-07T12:56:09.102Z] CL2 j> 2025/05/07 08:56:08.045 done. [2025-05-07T12:56:20.348Z] CL2 j> 2025/05/07 08:56:18.161 Writing report data ... [2025-05-07T12:56:20.348Z] CL2 j> 2025/05/07 08:56:19.129 done. [2025-05-07T12:56:31.612Z] CL2 j> 2025/05/07 08:56:29.192 Writing report data ... [2025-05-07T12:56:31.612Z] CL2 j> 2025/05/07 08:56:29.527 done. [2025-05-07T12:56:40.826Z] CL2 j> 2025/05/07 08:56:39.621 Writing report data ... [2025-05-07T12:56:40.826Z] CL2 j> 2025/05/07 08:56:40.052 done. [2025-05-07T12:56:52.008Z] CL2 j> 2025/05/07 08:56:50.105 Writing report data ... [2025-05-07T12:56:52.008Z] CL2 j> 2025/05/07 08:56:50.241 done. [2025-05-07T12:57:01.258Z] CL2 j> 2025/05/07 08:57:00.342 Writing report data ... [2025-05-07T12:57:01.258Z] CL2 j> 2025/05/07 08:57:00.450 done. [2025-05-07T12:57:12.553Z] CL2 j> 2025/05/07 08:57:10.517 Writing report data ... [2025-05-07T12:57:12.553Z] CL2 j> 2025/05/07 08:57:10.610 done. [2025-05-07T12:57:21.736Z] CL2 j> 2025/05/07 08:57:20.667 Writing report data ... [2025-05-07T12:57:21.736Z] CL2 j> 2025/05/07 08:57:21.086 done. [2025-05-07T12:57:32.967Z] CL2 j> 2025/05/07 08:57:31.148 Writing report data ... [2025-05-07T12:57:32.967Z] CL2 j> 2025/05/07 08:57:31.369 done. [2025-05-07T12:57:42.163Z] CL2 j> 2025/05/07 08:57:41.502 Writing report data ... [2025-05-07T12:57:42.517Z] CL2 j> 2025/05/07 08:57:41.672 done. [2025-05-07T12:57:53.701Z] CL2 j> 2025/05/07 08:57:51.742 Writing report data ... [2025-05-07T12:57:53.701Z] CL2 j> 2025/05/07 08:57:51.812 done. [2025-05-07T12:58:02.906Z] CL2 j> 2025/05/07 08:58:01.873 Writing report data ... [2025-05-07T12:58:02.906Z] CL2 j> 2025/05/07 08:58:02.253 done. [2025-05-07T12:58:14.206Z] CL2 j> 2025/05/07 08:58:12.322 Writing report data ... [2025-05-07T12:58:14.206Z] CL2 j> 2025/05/07 08:58:12.483 done. [2025-05-07T12:58:23.480Z] CL2 j> 2025/05/07 08:58:22.575 Writing report data ... [2025-05-07T12:58:23.480Z] CL2 j> 2025/05/07 08:58:22.736 done. [2025-05-07T12:58:34.668Z] CL2 j> 2025/05/07 08:58:32.789 Writing report data ... [2025-05-07T12:58:34.668Z] CL2 j> 2025/05/07 08:58:32.989 done. [2025-05-07T12:58:43.868Z] CL2 j> 2025/05/07 08:58:43.057 Writing report data ... [2025-05-07T12:58:43.868Z] CL2 j> 2025/05/07 08:58:43.194 done. [2025-05-07T12:58:55.091Z] CL2 j> 2025/05/07 08:58:53.266 Writing report data ... [2025-05-07T12:58:55.091Z] CL2 j> 2025/05/07 08:58:53.496 done. [2025-05-07T12:59:06.352Z] CL2 j> 2025/05/07 08:59:03.559 Writing report data ... [2025-05-07T12:59:06.352Z] CL2 j> 2025/05/07 08:59:03.779 done. [2025-05-07T12:59:15.605Z] CL2 j> 2025/05/07 08:59:13.837 Writing report data ... [2025-05-07T12:59:15.605Z] CL2 j> 2025/05/07 08:59:14.191 done. [2025-05-07T12:59:24.840Z] CL2 j> 2025/05/07 08:59:24.260 Writing report data ... [2025-05-07T12:59:25.601Z] CL2 j> 2025/05/07 08:59:24.531 done. [2025-05-07T12:59:36.770Z] CL2 j> 2025/05/07 08:59:34.629 Writing report data ... [2025-05-07T12:59:36.770Z] CL2 j> 2025/05/07 08:59:34.846 done. [2025-05-07T12:59:45.998Z] CL2 j> 2025/05/07 08:59:44.900 Writing report data ... [2025-05-07T12:59:45.998Z] CL2 j> 2025/05/07 08:59:44.971 done. [2025-05-07T12:59:57.163Z] CL2 j> 2025/05/07 08:59:55.035 Writing report data ... [2025-05-07T12:59:57.163Z] CL2 j> 2025/05/07 08:59:55.123 done. [2025-05-07T13:00:02.181Z] STF 09:00:01.256 - Heartbeat: Process LT2 is still running [2025-05-07T13:00:06.239Z] CL2 j> 2025/05/07 09:00:05.194 Writing report data ... [2025-05-07T13:00:06.239Z] CL2 j> 2025/05/07 09:00:05.361 done. [2025-05-07T13:00:17.446Z] CL2 j> 2025/05/07 09:00:15.438 Writing report data ... [2025-05-07T13:00:17.446Z] CL2 j> 2025/05/07 09:00:15.573 done. [2025-05-07T13:00:26.643Z] CL2 j> 2025/05/07 09:00:25.632 Writing report data ... [2025-05-07T13:00:26.643Z] CL2 j> 2025/05/07 09:00:26.068 done. [2025-05-07T13:00:37.795Z] CL2 j> 2025/05/07 09:00:36.134 Writing report data ... [2025-05-07T13:00:37.795Z] CL2 j> 2025/05/07 09:00:36.312 done. [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - Monitoring Report Summary: [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - o Process CL2 ended with the expected exit code (0) [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - o Process LT2 is still running as expected [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - +------ Step 8 - Stop LT2 process [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - | Kill running processes [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - | Processes: [LT2] [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - | [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - Killing processes: LT2 [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - o Process clean up attempt 1 for LT2 pid 6269 [2025-05-07T13:00:38.150Z] STF 09:00:37.714 - o Process LT2 pid 6269 stop() [2025-05-07T13:00:39.372Z] STF 09:00:38.726 - o Process LT2 pid 6269 killed [2025-05-07T13:00:39.373Z] STF 09:00:38.727 - EXECUTE stage completed [2025-05-07T13:00:39.373Z] STF 09:00:38.993 - [2025-05-07T13:00:39.373Z] STF 09:00:38.993 - ==================== T E A R D O W N ==================== [2025-05-07T13:00:39.373Z] STF 09:00:38.993 - Running teardown: perl /Users/admin/workspace/workspace/Test_openjdk11_hs_sanity.system_aarch64_mac_testList_2/aqa-tests/TKG/../TKG/output_17466190174179/TestJlmRemoteThreadNoAuth_1/20250507-085000-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-05-07T13:00:39.373Z] STF 09:00:39.020 - TEARDOWN stage completed [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - ===================== R E S U L T S ===================== [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - Stage results: [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - setUp: pass [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - execute: pass [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - teardown: pass [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - [2025-05-07T13:00:39.373Z] STF 09:00:39.032 - Overall result: PASSED [2025-05-07T13:00:39.373Z] ----------------------------------- [2025-05-07T13:00:39.373Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-05-07T13:00:39.373Z] ----------------------------------- [2025-05-07T13:00:39.373Z] [2025-05-07T13:00:39.373Z] TEST TEARDOWN: [2025-05-07T13:00:39.373Z] Nothing to be done for teardown. [2025-05-07T13:00:39.373Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Wed May 7 09:00:39 2025 Epoch Time (ms): 1746622839049