[2025-03-31T03:53:09.220Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-03-31T03:53:09.531Z] =============================================== [2025-03-31T03:53:09.531Z] TestJlmRemoteThreadNoAuth_1 Start Time: Mon Mar 31 03:53:09 2025 Epoch Time (ms): 1743393189368 [2025-03-31T03:53:09.531Z] variation: Mode650 [2025-03-31T03:53:09.867Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-03-31T03:53:09.867Z] { \ [2025-03-31T03:53:09.867Z] echo ""; echo "TEST SETUP:"; \ [2025-03-31T03:53:09.867Z] echo "Nothing to be done for setup."; \ [2025-03-31T03:53:09.867Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17433896414981\\TestJlmRemoteThreadNoAuth_1"; \ [2025-03-31T03:53:09.867Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17433896414981\\TestJlmRemoteThreadNoAuth_1"; \ [2025-03-31T03:53:09.867Z] echo ""; echo "TESTING:"; \ [2025-03-31T03:53:09.867Z] perl C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\STF;C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\aqa-systemtest""" -systemtest-prereqs="c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\\" -java-args=' -XX:-UseCompressedOops ' -results-root="C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17433896414981\\TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-03-31T03:53:09.868Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17433896414981\\TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-31T03:53:09.868Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-31T03:53:09.868Z] echo "Nothing to be done for teardown."; \ [2025-03-31T03:53:09.868Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17433896414981\\TestTargetResult"; [2025-03-31T03:53:09.868Z] [2025-03-31T03:53:09.868Z] TEST SETUP: [2025-03-31T03:53:09.868Z] Nothing to be done for setup. [2025-03-31T03:53:09.868Z] [2025-03-31T03:53:09.868Z] TESTING: [2025-03-31T03:53:10.194Z] STF 03:53:09.848 - ========================= S T F ========================= [2025-03-31T03:53:10.194Z] systemtest-prereqs has been processed, and set to: c:/jenkins/testDependency/system_libRetrieving amount of free space on drive containing C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1 [2025-03-31T03:53:10.194Z] There is 107583 Mb free [2025-03-31T03:53:10.194Z] STF 03:53:09.909 - ================== G E N E R A T I O N ================== [2025-03-31T03:53:10.194Z] STF 03:53:09.911 - Checking JVM: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image [2025-03-31T03:53:10.194Z] STF 03:53:09.912 - Starting process to generate scripts: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\/asm/asm.jar;c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\/asm/asm-commons.jar;c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\/log4j/log4j-api.jar;c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth" [2025-03-31T03:53:11.794Z] GEN 03:53:11.391 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: 'C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin' [2025-03-31T03:53:11.794Z] GEN 03:53:11.445 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-03-31T03:53:11.794Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-03-31T03:53:11.794Z] GEN C:\\jenkins\\workspace\\Test_openjdk11_hs_sanity.system_x86-64_windows\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2025-03-31T03:53:11.794Z] GEN C:\\jenkins\\workspace\\Test_openjdk11_hs_sanity.system_x86-64_windows\\jvmtest\\system\\STF\\stf.core\\bin [2025-03-31T03:53:11.794Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-03-31T03:53:11.794Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-03-31T03:53:11.794Z] GEN c:/jenkins/testDependency/system_lib/junit/junit.jar [2025-03-31T03:53:12.120Z] GEN 03:53:11.939 - Using Mode NoOptions. Values = '' [2025-03-31T03:53:12.445Z] GEN 03:53:12.280 - [2025-03-31T03:53:12.445Z] GEN 03:53:12.281 - Test command summary: [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - Step Stage Command Description [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - -----+--------+-----------------+------------ [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 3 execute Monitor Wait for processes to complete [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 4 execute kill Stop LT1 process [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 7 execute Monitor Wait for processes to complete [2025-03-31T03:53:12.445Z] GEN 03:53:12.282 - 8 execute kill Stop LT2 process [2025-03-31T03:53:12.445Z] STF 03:53:12.325 - [2025-03-31T03:53:12.445Z] STF 03:53:12.325 - Script generation completed [2025-03-31T03:53:12.445Z] STF 03:53:12.325 - [2025-03-31T03:53:12.445Z] STF 03:53:12.331 - [2025-03-31T03:53:12.445Z] STF 03:53:12.332 - ======================= S E T U P ======================= [2025-03-31T03:53:12.445Z] STF 03:53:12.332 - Running setup: perl C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/setUp.pl [2025-03-31T03:53:12.774Z] STF 03:53:12.479 - SETUP stage completed [2025-03-31T03:53:12.774Z] STF 03:53:12.495 - [2025-03-31T03:53:12.774Z] STF 03:53:12.495 - ==================== E X E C U T E - ==================== [2025-03-31T03:53:12.774Z] STF 03:53:12.495 - Running execute: perl C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/execute.pl [2025-03-31T03:53:12.774Z] STF 03:53:12.640 - [2025-03-31T03:53:12.774Z] STF 03:53:12.640 - Java version [2025-03-31T03:53:12.774Z] STF 03:53:12.640 - Running: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -version [2025-03-31T03:53:13.105Z] openjdk version "11.0.27-beta" 2025-04-15 [2025-03-31T03:53:13.106Z] OpenJDK Runtime Environment Temurin-11.0.27+5-202503302009 (build 11.0.27-beta+5-ea) [2025-03-31T03:53:13.106Z] OpenJDK 64-Bit Server VM Temurin-11.0.27+5-202503302009 (build 11.0.27-beta+5-ea, mixed mode) [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - | Start background process [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - | Program: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - | Mnemonic: LT1 [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - | Echo: ECHO_OFF [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - | Expectation: NEVER [2025-03-31T03:53:13.106Z] STF 03:53:12.778 - | [2025-03-31T03:53:13.106Z] STF 03:53:12.779 - Running command: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -javaagent:C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\STF\stf.core\bin;c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar;c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar;c:/jenkins/testDependency/system_lib/asm/asm.jar;c:/jenkins/testDependency/system_lib/asm/asm-commons.jar;c:/jenkins/testDependency/system_lib/junit/junit.jar;c:/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\aqa-tests\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1\20250331-035309-TestJlmRemoteThreadNoAuth\results -resultsPrefix 1.LT1. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-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-03-31T03:53:13.106Z] STF 03:53:12.779 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-03-31T03:53:13.106Z] STF 03:53:12.779 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - | Start background process [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - | Program: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - | Mnemonic: CL1 [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - | Echo: ECHO_ON [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - | Expectation: CLEAN_RUN within 30m [2025-03-31T03:53:13.106Z] STF 03:53:12.811 - | [2025-03-31T03:53:13.106Z] STF 03:53:12.812 - Running command: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;c:/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-03-31T03:53:13.106Z] STF 03:53:12.812 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-03-31T03:53:13.106Z] STF 03:53:12.812 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-03-31T03:53:13.106Z] STF 03:53:12.818 - [2025-03-31T03:53:13.106Z] STF 03:53:12.818 - +------ Step 3 - Wait for processes to complete [2025-03-31T03:53:13.106Z] STF 03:53:12.818 - | Wait for processes to meet expectations [2025-03-31T03:53:13.106Z] STF 03:53:12.818 - | Processes: [LT1, CL1] [2025-03-31T03:53:13.106Z] STF 03:53:12.818 - | [2025-03-31T03:53:13.106Z] STF 03:53:12.818 - Monitoring processes: CL1 LT1 [2025-03-31T03:53:13.795Z] CL1 j> 2025/03/31 03:53:13.145 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-03-31T03:53:13.795Z] CL1 j> 2025/03/31 03:53:13.333 Attempting to connect [2025-03-31T03:53:14.123Z] CL1 j> 2025/03/31 03:53:13.768 Monitored VM not ready at Mar 31, 2025, 3:53:13 AM (attempt 1, elapsed 413ms). [2025-03-31T03:53:14.123Z] CL1 j> 2025/03/31 03:53:13.768 Waiting 5 secs and trying again... [2025-03-31T03:53:34.950Z] CL1 j> 2025/03/31 03:53:20.095 Attempting to connect [2025-03-31T03:53:37.529Z] CL1 j> 2025/03/31 03:53:27.790 Connection established! [2025-03-31T03:53:37.530Z] CL1 j> 2025/03/31 03:53:30.050 Starting to write data [2025-03-31T03:58:23.587Z] STF 03:58:12.883 - Heartbeat: Process LT1 is still running [2025-03-31T03:59:23.394Z] STF 03:59:14.822 - Monitoring Report Summary: [2025-03-31T03:59:23.394Z] STF 03:59:14.822 - o Process CL1 ended with the expected exit code (0) [2025-03-31T03:59:23.394Z] STF 03:59:14.822 - o Process LT1 is still running as expected [2025-03-31T03:59:23.394Z] STF 03:59:14.921 - [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - +------ Step 4 - Stop LT1 process [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - | Kill running processes [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - | Processes: [LT1] [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - | [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - Killing processes: LT1 [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - o Process clean up attempt 1 for LT1 pid 36140 [2025-03-31T03:59:23.394Z] STF 03:59:14.922 - o Process LT1 pid 36140 stop() [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - o Process LT1 pid 36140 killed [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - | Start background process [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - | Program: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - | Mnemonic: LT2 [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - | Echo: ECHO_OFF [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - | Expectation: NEVER [2025-03-31T03:59:23.394Z] STF 03:59:14.956 - | [2025-03-31T03:59:23.394Z] STF 03:59:14.957 - Running command: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -javaagent:C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\STF\stf.core\bin;c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar;c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar;c:/jenkins/testDependency/system_lib/asm/asm.jar;c:/jenkins/testDependency/system_lib/asm/asm-commons.jar;c:/jenkins/testDependency/system_lib/junit/junit.jar;c:/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\aqa-tests\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1\20250331-035309-TestJlmRemoteThreadNoAuth\results -resultsPrefix 5.LT2. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-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-03-31T03:59:23.394Z] STF 03:59:14.957 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-03-31T03:59:23.394Z] STF 03:59:14.957 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - | Start background process [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - | Program: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - | Mnemonic: CL2 [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - | Echo: ECHO_ON [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - | Expectation: CLEAN_RUN within 30m [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - | [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - Running command: c:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk11_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;c:/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-03-31T03:59:23.394Z] STF 03:59:14.964 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17433896414981/TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-03-31T03:59:23.394Z] STF 03:59:14.970 - [2025-03-31T03:59:23.394Z] STF 03:59:14.970 - +------ Step 7 - Wait for processes to complete [2025-03-31T03:59:23.394Z] STF 03:59:14.970 - | Wait for processes to meet expectations [2025-03-31T03:59:23.394Z] STF 03:59:14.970 - | Processes: [LT2, CL2] [2025-03-31T03:59:23.394Z] STF 03:59:14.970 - | [2025-03-31T03:59:23.394Z] STF 03:59:14.970 - Monitoring processes: CL2 LT2 [2025-03-31T03:59:23.394Z] CL2 j> 2025/03/31 03:59:15.310 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-03-31T03:59:23.394Z] CL2 j> 2025/03/31 03:59:15.515 Attempting to connect [2025-03-31T03:59:23.394Z] CL2 j> 2025/03/31 03:59:15.850 Monitored VM not ready at Mar 31, 2025, 3:59:15 AM (attempt 1, elapsed 314ms). [2025-03-31T03:59:23.394Z] CL2 j> 2025/03/31 03:59:15.850 Waiting 5 secs and trying again... [2025-03-31T03:59:29.560Z] CL2 j> 2025/03/31 03:59:21.045 Attempting to connect [2025-03-31T03:59:39.972Z] CL2 j> 2025/03/31 03:59:28.651 Connection established! [2025-03-31T03:59:51.180Z] CL2 j> 2025/03/31 03:59:43.409 Writing report data ... [2025-03-31T03:59:51.180Z] CL2 j> 2025/03/31 03:59:44.859 done. [2025-03-31T04:00:08.368Z] CL2 j> 2025/03/31 03:59:57.286 Writing report data ... [2025-03-31T04:00:08.368Z] CL2 j> 2025/03/31 03:59:59.718 done. [2025-03-31T04:00:17.894Z] CL2 j> 2025/03/31 04:00:10.269 Writing report data ... [2025-03-31T04:00:17.894Z] CL2 j> 2025/03/31 04:00:10.678 done. [2025-03-31T04:00:23.848Z] CL2 j> 2025/03/31 04:00:20.837 Writing report data ... [2025-03-31T04:00:26.856Z] CL2 j> 2025/03/31 04:00:21.164 done. [2025-03-31T04:00:33.816Z] CL2 j> 2025/03/31 04:00:32.619 Writing report data ... [2025-03-31T04:00:44.737Z] CL2 j> 2025/03/31 04:00:33.361 done. [2025-03-31T04:00:48.524Z] CL2 j> 2025/03/31 04:00:44.764 Writing report data ... [2025-03-31T04:00:54.598Z] CL2 j> 2025/03/31 04:00:45.121 done. [2025-03-31T04:01:05.388Z] CL2 j> 2025/03/31 04:00:55.819 Writing report data ... [2025-03-31T04:01:05.388Z] CL2 j> 2025/03/31 04:00:56.046 done. [2025-03-31T04:01:16.274Z] CL2 j> 2025/03/31 04:01:06.771 Writing report data ... [2025-03-31T04:01:16.274Z] CL2 j> 2025/03/31 04:01:07.401 done. [2025-03-31T04:01:25.195Z] CL2 j> 2025/03/31 04:01:18.265 Writing report data ... [2025-03-31T04:01:25.195Z] CL2 j> 2025/03/31 04:01:18.471 done. [2025-03-31T04:01:34.030Z] CL2 j> 2025/03/31 04:01:29.886 Writing report data ... [2025-03-31T04:01:34.030Z] CL2 j> 2025/03/31 04:01:30.115 done. [2025-03-31T04:01:44.888Z] CL2 j> 2025/03/31 04:01:40.971 Writing report data ... [2025-03-31T04:01:44.888Z] CL2 j> 2025/03/31 04:01:41.199 done. [2025-03-31T04:02:00.696Z] CL2 j> 2025/03/31 04:01:51.515 Writing report data ... [2025-03-31T04:02:00.696Z] CL2 j> 2025/03/31 04:01:51.776 done. [2025-03-31T04:02:06.591Z] CL2 j> 2025/03/31 04:02:02.341 Writing report data ... [2025-03-31T04:02:14.063Z] CL2 j> 2025/03/31 04:02:02.699 done. [2025-03-31T04:02:18.271Z] CL2 j> 2025/03/31 04:02:14.584 Writing report data ... [2025-03-31T04:02:18.271Z] CL2 j> 2025/03/31 04:02:14.834 done. [2025-03-31T04:02:32.367Z] CL2 j> 2025/03/31 04:02:25.428 Writing report data ... [2025-03-31T04:02:32.367Z] CL2 j> 2025/03/31 04:02:25.743 done. [2025-03-31T04:02:44.879Z] CL2 j> 2025/03/31 04:02:36.178 Writing report data ... [2025-03-31T04:02:47.273Z] CL2 j> 2025/03/31 04:02:36.437 done. [2025-03-31T04:02:55.826Z] CL2 j> 2025/03/31 04:02:48.548 Writing report data ... [2025-03-31T04:02:58.680Z] CL2 j> 2025/03/31 04:02:48.991 done. [2025-03-31T04:03:05.779Z] CL2 j> 2025/03/31 04:02:59.778 Writing report data ... [2025-03-31T04:03:10.590Z] CL2 j> 2025/03/31 04:03:00.035 done. [2025-03-31T04:03:13.490Z] CL2 j> 2025/03/31 04:03:10.079 Writing report data ... [2025-03-31T04:03:22.352Z] CL2 j> 2025/03/31 04:03:10.333 done. [2025-03-31T04:03:22.352Z] STF 04:03:14.903 - Heartbeat: Process CL2 is still running [2025-03-31T04:03:28.222Z] CL2 j> 2025/03/31 04:03:22.563 Writing report data ... [2025-03-31T04:03:34.107Z] CL2 j> 2025/03/31 04:03:22.980 done. [2025-03-31T04:03:35.307Z] CL2 j> 2025/03/31 04:03:33.023 Writing report data ... [2025-03-31T04:03:35.307Z] CL2 j> 2025/03/31 04:03:33.272 done. [2025-03-31T04:03:54.380Z] CL2 j> 2025/03/31 04:03:44.463 Writing report data ... [2025-03-31T04:03:54.380Z] CL2 j> 2025/03/31 04:03:44.643 done. [2025-03-31T04:04:05.131Z] CL2 j> 2025/03/31 04:03:58.022 Writing report data ... [2025-03-31T04:04:09.855Z] CL2 j> 2025/03/31 04:03:58.331 done. [2025-03-31T04:04:18.251Z] CL2 j> 2025/03/31 04:04:10.968 Writing report data ... [2025-03-31T04:04:20.492Z] CL2 j> 2025/03/31 04:04:11.208 done. [2025-03-31T04:04:26.335Z] CL2 j> 2025/03/31 04:04:21.589 Writing report data ... [2025-03-31T04:04:26.335Z] CL2 j> 2025/03/31 04:04:21.774 done. [2025-03-31T04:04:39.438Z] CL2 j> 2025/03/31 04:04:32.834 Writing report data ... [2025-03-31T04:04:43.221Z] CL2 j> 2025/03/31 04:04:33.059 done. [2025-03-31T04:04:50.598Z] CL2 j> 2025/03/31 04:04:44.577 Writing report data ... [2025-03-31T04:04:53.554Z] CL2 j> 2025/03/31 04:04:44.775 done. [2025-03-31T04:04:59.437Z] CL2 j> 2025/03/31 04:04:55.258 Writing report data ... [2025-03-31T04:04:59.437Z] CL2 j> 2025/03/31 04:04:55.501 done. [2025-03-31T04:05:12.554Z] CL2 j> 2025/03/31 04:05:06.120 Writing report data ... [2025-03-31T04:05:12.554Z] CL2 j> 2025/03/31 04:05:06.356 done. [2025-03-31T04:05:21.963Z] CL2 j> 2025/03/31 04:05:16.897 Writing report data ... [2025-03-31T04:05:21.963Z] CL2 j> 2025/03/31 04:05:17.100 done. [2025-03-31T04:05:21.963Z] STF 04:05:21.573 - Monitoring Report Summary: [2025-03-31T04:05:21.963Z] STF 04:05:21.573 - o Process CL2 ended with the expected exit code (0) [2025-03-31T04:05:21.963Z] STF 04:05:21.573 - o Process LT2 is still running as expected [2025-03-31T04:05:21.963Z] STF 04:05:21.699 - [2025-03-31T04:05:21.963Z] STF 04:05:21.699 - +------ Step 8 - Stop LT2 process [2025-03-31T04:05:21.963Z] STF 04:05:21.699 - | Kill running processes [2025-03-31T04:05:21.963Z] STF 04:05:21.700 - | Processes: [LT2] [2025-03-31T04:05:21.964Z] STF 04:05:21.700 - | [2025-03-31T04:05:21.964Z] STF 04:05:21.700 - Killing processes: LT2 [2025-03-31T04:05:21.964Z] STF 04:05:21.700 - o Process clean up attempt 1 for LT2 pid 39380 [2025-03-31T04:05:21.964Z] STF 04:05:21.700 - o Process LT2 pid 39380 stop() [2025-03-31T04:05:21.964Z] STF 04:05:21.790 - o Process LT2 pid 39380 killed [2025-03-31T04:05:21.964Z] STF 04:05:21.791 - EXECUTE stage completed [2025-03-31T04:05:22.635Z] STF 04:05:22.323 - [2025-03-31T04:05:22.635Z] STF 04:05:22.323 - ==================== T E A R D O W N ==================== [2025-03-31T04:05:22.635Z] STF 04:05:22.323 - Running teardown: perl C:/jenkins/workspace/Test_openjdk11_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17433896414981\TestJlmRemoteThreadNoAuth_1/20250331-035309-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-03-31T04:05:22.635Z] STF 04:05:22.449 - TEARDOWN stage completed [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - ===================== R E S U L T S ===================== [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - Stage results: [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - setUp: pass [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - execute: pass [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - teardown: pass [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - [2025-03-31T04:05:22.635Z] STF 04:05:22.465 - Overall result: PASSED [2025-03-31T04:05:22.635Z] ----------------------------------- [2025-03-31T04:05:22.635Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-03-31T04:05:22.635Z] ----------------------------------- [2025-03-31T04:05:22.635Z] [2025-03-31T04:05:22.635Z] TEST TEARDOWN: [2025-03-31T04:05:22.635Z] Nothing to be done for teardown. [2025-03-31T04:05:22.956Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Mon Mar 31 04:05:22 2025 Epoch Time (ms): 1743393922632