[2024-12-31T06:34:12.055Z] Running test TestJlmRemoteThreadNoAuth_0 ... [2024-12-31T06:34:12.395Z] =============================================== [2024-12-31T06:34:12.395Z] TestJlmRemoteThreadNoAuth_0 Start Time: Tue Dec 31 06:34:12 2024 Epoch Time (ms): 1735626852183 [2024-12-31T06:34:12.753Z] variation: Mode150 [2024-12-31T06:34:12.753Z] JVM_OPTIONS: -XX:+UseCompressedOops [2024-12-31T06:34:12.753Z] { \ [2024-12-31T06:34:12.753Z] echo ""; echo "TEST SETUP:"; \ [2024-12-31T06:34:12.753Z] echo "Nothing to be done for setup."; \ [2024-12-31T06:34:12.753Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17356240359966\\TestJlmRemoteThreadNoAuth_0"; \ [2024-12-31T06:34:12.753Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17356240359966\\TestJlmRemoteThreadNoAuth_0"; \ [2024-12-31T06:34:12.753Z] echo ""; echo "TESTING:"; \ [2024-12-31T06:34:12.753Z] perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\STF;C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\aqa-systemtest""" -systemtest-prereqs="c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\\" -java-args=' -XX:+UseCompressedOops ' -results-root="C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17356240359966\\TestJlmRemoteThreadNoAuth_0" -test=TestJlmRemoteThreadNoAuth; \ [2024-12-31T06:34:12.753Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17356240359966\\TestJlmRemoteThreadNoAuth_0"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-12-31T06:34:12.753Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-12-31T06:34:12.753Z] echo "Nothing to be done for teardown."; \ [2024-12-31T06:34:12.753Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\\TKG\\output_17356240359966\\TestTargetResult"; [2024-12-31T06:34:12.753Z] [2024-12-31T06:34:12.753Z] TEST SETUP: [2024-12-31T06:34:12.753Z] Nothing to be done for setup. [2024-12-31T06:34:12.753Z] [2024-12-31T06:34:12.753Z] TESTING: [2024-12-31T06:34:12.753Z] STF 06:34:12.707 - ========================= S T F ========================= [2024-12-31T06:34:12.753Z] systemtest-prereqs has been processed, and set to: c:/jenkins/testDependency/system_libRetrieving amount of free space on drive containing C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0 [2024-12-31T06:34:13.112Z] There is 127967 Mb free [2024-12-31T06:34:13.112Z] STF 06:34:12.761 - ================== G E N E R A T I O N ================== [2024-12-31T06:34:13.112Z] STF 06:34:12.764 - Checking JVM: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image [2024-12-31T06:34:13.112Z] STF 06:34:12.764 - Starting process to generate scripts: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\/log4j/log4j-api.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth" [2024-12-31T06:34:13.112Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-12-31T06:34:13.112Z] GEN [0.012s][warning][cds] Archived non-system classes are disabled because the java.system.class.loader property is specified (value = "net.adoptopenjdk.stf.runner.StfClassLoader"). To use archived non-system classes, this property must not be set [2024-12-31T06:34:14.326Z] GEN 06:34:13.889 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: 'C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin' [2024-12-31T06:34:14.326Z] GEN 06:34:13.938 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-12-31T06:34:14.326Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-12-31T06:34:14.327Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2024-12-31T06:34:14.327Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows\\jvmtest\\system\\STF\\stf.core\\bin [2024-12-31T06:34:14.327Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-12-31T06:34:14.327Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-12-31T06:34:14.327Z] GEN c:/jenkins/testDependency/system_lib/junit/junit.jar [2024-12-31T06:34:14.327Z] GEN 06:34:14.152 - Using Mode NoOptions. Values = '' [2024-12-31T06:34:14.680Z] GEN 06:34:14.293 - [2024-12-31T06:34:14.680Z] GEN 06:34:14.293 - Test command summary: [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - Step Stage Command Description [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - -----+--------+-----------------+------------ [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - 3 execute Monitor Wait for processes to complete [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - 4 execute kill Stop LT1 process [2024-12-31T06:34:14.680Z] GEN 06:34:14.294 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-12-31T06:34:14.680Z] GEN 06:34:14.295 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-12-31T06:34:14.680Z] GEN 06:34:14.295 - 7 execute Monitor Wait for processes to complete [2024-12-31T06:34:14.680Z] GEN 06:34:14.295 - 8 execute kill Stop LT2 process [2024-12-31T06:34:14.680Z] STF 06:34:14.346 - [2024-12-31T06:34:14.680Z] STF 06:34:14.346 - Script generation completed [2024-12-31T06:34:14.680Z] STF 06:34:14.346 - [2024-12-31T06:34:14.680Z] STF 06:34:14.348 - [2024-12-31T06:34:14.680Z] STF 06:34:14.348 - ======================= S E T U P ======================= [2024-12-31T06:34:14.680Z] STF 06:34:14.348 - Running setup: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/setUp.pl [2024-12-31T06:34:14.680Z] STF 06:34:14.484 - SETUP stage completed [2024-12-31T06:34:14.680Z] STF 06:34:14.499 - [2024-12-31T06:34:14.680Z] STF 06:34:14.499 - ==================== E X E C U T E - ==================== [2024-12-31T06:34:14.680Z] STF 06:34:14.499 - Running execute: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/execute.pl [2024-12-31T06:34:14.680Z] STF 06:34:14.635 - [2024-12-31T06:34:14.680Z] STF 06:34:14.635 - Java version [2024-12-31T06:34:14.680Z] STF 06:34:14.635 - Running: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -version [2024-12-31T06:34:15.047Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-12-31T06:34:15.047Z] openjdk version "21.0.6-beta" 2025-01-21 [2024-12-31T06:34:15.047Z] OpenJDK Runtime Environment Temurin-21.0.6+6-202412301853 (build 21.0.6-beta+6-ea) [2024-12-31T06:34:15.047Z] OpenJDK 64-Bit Server VM Temurin-21.0.6+6-202412301853 (build 21.0.6-beta+6-ea, mixed mode, sharing) [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - | Start background process [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - | Mnemonic: LT1 [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - | Echo: ECHO_OFF [2024-12-31T06:34:15.047Z] STF 06:34:14.726 - | Expectation: NEVER [2024-12-31T06:34:15.047Z] STF 06:34:14.727 - | [2024-12-31T06:34:15.048Z] STF 06:34:14.727 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:+UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk21_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/junit/junit.jar;c:/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\aqa-tests\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0\20241231-063412-TestJlmRemoteThreadNoAuth\results -resultsPrefix 1.LT1. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-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-12-31T06:34:15.048Z] STF 06:34:14.727 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-12-31T06:34:15.048Z] STF 06:34:14.727 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-12-31T06:34:15.048Z] STF 06:34:14.756 - [2024-12-31T06:34:15.048Z] STF 06:34:14.756 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-12-31T06:34:15.048Z] STF 06:34:14.756 - | Start background process [2024-12-31T06:34:15.048Z] STF 06:34:14.756 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2024-12-31T06:34:15.048Z] STF 06:34:14.756 - | Mnemonic: CL1 [2024-12-31T06:34:15.048Z] STF 06:34:14.756 - | Echo: ECHO_ON [2024-12-31T06:34:15.048Z] STF 06:34:14.757 - | Expectation: CLEAN_RUN within 30m [2024-12-31T06:34:15.048Z] STF 06:34:14.757 - | [2024-12-31T06:34:15.048Z] STF 06:34:14.757 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_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_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-12-31T06:34:15.048Z] STF 06:34:14.757 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-12-31T06:34:15.048Z] STF 06:34:14.757 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-12-31T06:34:15.048Z] STF 06:34:14.764 - [2024-12-31T06:34:15.048Z] STF 06:34:14.764 - +------ Step 3 - Wait for processes to complete [2024-12-31T06:34:15.048Z] STF 06:34:14.764 - | Wait for processes to meet expectations [2024-12-31T06:34:15.048Z] STF 06:34:14.764 - | Processes: [LT1, CL1] [2024-12-31T06:34:15.048Z] STF 06:34:14.764 - | [2024-12-31T06:34:15.048Z] STF 06:34:14.764 - Monitoring processes: CL1 LT1 [2024-12-31T06:34:15.048Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-12-31T06:34:15.388Z] CL1 j> 2024/12/31 06:34:14.963 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-12-31T06:34:15.388Z] CL1 j> 2024/12/31 06:34:15.052 Attempting to connect [2024-12-31T06:34:15.745Z] CL1 j> 2024/12/31 06:34:15.372 Monitored VM not ready at Dec 31, 2024, 6:34:15?AM (attempt 1, elapsed 295ms). [2024-12-31T06:34:15.745Z] CL1 j> 2024/12/31 06:34:15.372 Waiting 5 secs and trying again... [2024-12-31T06:34:21.754Z] CL1 j> 2024/12/31 06:34:20.502 Attempting to connect [2024-12-31T06:34:34.516Z] CL1 j> 2024/12/31 06:34:29.611 Connection established! [2024-12-31T06:34:34.516Z] CL1 j> 2024/12/31 06:34:30.350 Starting to write data [2024-12-31T06:39:18.989Z] STF 06:39:14.673 - Heartbeat: Process LT1 is still running [2024-12-31T06:40:09.730Z] STF 06:40:07.176 - Monitoring Report Summary: [2024-12-31T06:40:09.730Z] STF 06:40:07.176 - o Process CL1 ended with the expected exit code (0) [2024-12-31T06:40:09.730Z] STF 06:40:07.176 - o Process LT1 is still running as expected [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - +------ Step 4 - Stop LT1 process [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - | Kill running processes [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - | Processes: [LT1] [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - | [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - Killing processes: LT1 [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - o Process clean up attempt 1 for LT1 pid 13056 [2024-12-31T06:40:09.730Z] STF 06:40:07.177 - o Process LT1 pid 13056 stop() [2024-12-31T06:40:09.730Z] STF 06:40:07.191 - o Process LT1 pid 13056 killed [2024-12-31T06:40:09.730Z] STF 06:40:07.191 - [2024-12-31T06:40:09.730Z] STF 06:40:07.191 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-12-31T06:40:09.730Z] STF 06:40:07.191 - | Start background process [2024-12-31T06:40:09.731Z] STF 06:40:07.191 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2024-12-31T06:40:09.731Z] STF 06:40:07.191 - | Mnemonic: LT2 [2024-12-31T06:40:09.731Z] STF 06:40:07.191 - | Echo: ECHO_OFF [2024-12-31T06:40:09.731Z] STF 06:40:07.191 - | Expectation: NEVER [2024-12-31T06:40:09.731Z] STF 06:40:07.191 - | [2024-12-31T06:40:09.731Z] STF 06:40:07.191 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:+UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk21_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/junit/junit.jar;c:/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows\aqa-tests\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0\20241231-063412-TestJlmRemoteThreadNoAuth\results -resultsPrefix 5.LT2. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-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-12-31T06:40:09.731Z] STF 06:40:07.192 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-12-31T06:40:09.731Z] STF 06:40:07.192 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - | Start background process [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - | Mnemonic: CL2 [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - | Echo: ECHO_ON [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - | Expectation: CLEAN_RUN within 30m [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - | [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_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_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-12-31T06:40:09.731Z] STF 06:40:07.203 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/TKG/output_17356240359966/TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-12-31T06:40:09.731Z] STF 06:40:07.209 - [2024-12-31T06:40:09.731Z] STF 06:40:07.209 - +------ Step 7 - Wait for processes to complete [2024-12-31T06:40:09.731Z] STF 06:40:07.209 - | Wait for processes to meet expectations [2024-12-31T06:40:09.731Z] STF 06:40:07.209 - | Processes: [LT2, CL2] [2024-12-31T06:40:09.731Z] STF 06:40:07.209 - | [2024-12-31T06:40:09.731Z] STF 06:40:07.209 - Monitoring processes: CL2 LT2 [2024-12-31T06:40:09.731Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-12-31T06:40:09.731Z] CL2 j> 2024/12/31 06:40:07.473 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-12-31T06:40:09.731Z] CL2 j> 2024/12/31 06:40:07.549 Attempting to connect [2024-12-31T06:40:09.731Z] CL2 j> 2024/12/31 06:40:07.827 Monitored VM not ready at Dec 31, 2024, 6:40:07?AM (attempt 1, elapsed 252ms). [2024-12-31T06:40:09.731Z] CL2 j> 2024/12/31 06:40:07.827 Waiting 5 secs and trying again... [2024-12-31T06:40:15.213Z] CL2 j> 2024/12/31 06:40:13.093 Attempting to connect [2024-12-31T06:40:20.844Z] CL2 j> 2024/12/31 06:40:15.471 Connection established! [2024-12-31T06:40:38.568Z] CL2 j> 2024/12/31 06:40:31.129 Writing report data ... [2024-12-31T06:40:38.568Z] CL2 j> 2024/12/31 06:40:35.256 done. [2024-12-31T06:40:48.864Z] CL2 j> 2024/12/31 06:40:46.012 Writing report data ... [2024-12-31T06:40:51.804Z] CL2 j> 2024/12/31 06:40:47.098 done. [2024-12-31T06:41:02.132Z] CL2 j> 2024/12/31 06:40:58.176 Writing report data ... [2024-12-31T06:41:03.721Z] CL2 j> 2024/12/31 06:40:59.144 done. [2024-12-31T06:41:12.344Z] CL2 j> 2024/12/31 06:41:09.495 Writing report data ... [2024-12-31T06:41:12.344Z] CL2 j> 2024/12/31 06:41:10.144 done. [2024-12-31T06:41:22.738Z] CL2 j> 2024/12/31 06:41:20.336 Writing report data ... [2024-12-31T06:41:24.968Z] CL2 j> 2024/12/31 06:41:20.843 done. [2024-12-31T06:41:37.559Z] CL2 j> 2024/12/31 06:41:32.050 Writing report data ... [2024-12-31T06:41:38.572Z] CL2 j> 2024/12/31 06:41:32.502 done. [2024-12-31T06:41:45.587Z] CL2 j> 2024/12/31 06:41:42.686 Writing report data ... [2024-12-31T06:41:45.587Z] CL2 j> 2024/12/31 06:41:43.501 done. [2024-12-31T06:42:00.250Z] CL2 j> 2024/12/31 06:41:53.970 Writing report data ... [2024-12-31T06:42:01.892Z] CL2 j> 2024/12/31 06:41:54.951 done. [2024-12-31T06:42:08.997Z] CL2 j> 2024/12/31 06:42:05.661 Writing report data ... [2024-12-31T06:42:08.997Z] CL2 j> 2024/12/31 06:42:06.583 done. [2024-12-31T06:42:21.537Z] CL2 j> 2024/12/31 06:42:16.911 Writing report data ... [2024-12-31T06:42:21.537Z] CL2 j> 2024/12/31 06:42:17.584 done. [2024-12-31T06:42:30.127Z] CL2 j> 2024/12/31 06:42:27.883 Writing report data ... [2024-12-31T06:42:32.320Z] CL2 j> 2024/12/31 06:42:28.814 done. [2024-12-31T06:42:42.906Z] CL2 j> 2024/12/31 06:42:39.079 Writing report data ... [2024-12-31T06:42:42.906Z] CL2 j> 2024/12/31 06:42:39.495 done. [2024-12-31T06:42:53.292Z] CL2 j> 2024/12/31 06:42:50.001 Writing report data ... [2024-12-31T06:42:53.292Z] CL2 j> 2024/12/31 06:42:50.739 done. [2024-12-31T06:43:05.772Z] CL2 j> 2024/12/31 06:43:00.990 Writing report data ... [2024-12-31T06:43:05.772Z] CL2 j> 2024/12/31 06:43:01.368 done. [2024-12-31T06:43:18.164Z] CL2 j> 2024/12/31 06:43:12.074 Writing report data ... [2024-12-31T06:43:18.164Z] CL2 j> 2024/12/31 06:43:12.584 done. [2024-12-31T06:43:27.205Z] CL2 j> 2024/12/31 06:43:22.810 Writing report data ... [2024-12-31T06:43:27.205Z] CL2 j> 2024/12/31 06:43:23.898 done. [2024-12-31T06:43:42.099Z] CL2 j> 2024/12/31 06:43:34.175 Writing report data ... [2024-12-31T06:43:42.099Z] CL2 j> 2024/12/31 06:43:34.444 done. [2024-12-31T06:43:49.034Z] CL2 j> 2024/12/31 06:43:45.425 Writing report data ... [2024-12-31T06:43:51.981Z] CL2 j> 2024/12/31 06:43:45.806 done. [2024-12-31T06:44:00.593Z] CL2 j> 2024/12/31 06:43:56.103 Writing report data ... [2024-12-31T06:44:00.593Z] CL2 j> 2024/12/31 06:43:56.373 done. [2024-12-31T06:44:10.891Z] CL2 j> 2024/12/31 06:44:06.586 Writing report data ... [2024-12-31T06:44:10.891Z] CL2 j> 2024/12/31 06:44:07.177 done. [2024-12-31T06:44:16.603Z] STF 06:44:14.040 - Heartbeat: Process CL2 is still running [2024-12-31T06:44:23.685Z] CL2 j> 2024/12/31 06:44:17.621 Writing report data ... [2024-12-31T06:44:23.685Z] CL2 j> 2024/12/31 06:44:18.187 done. [2024-12-31T06:44:33.959Z] CL2 j> 2024/12/31 06:44:28.383 Writing report data ... [2024-12-31T06:44:33.959Z] CL2 j> 2024/12/31 06:44:29.014 done. [2024-12-31T06:44:44.249Z] CL2 j> 2024/12/31 06:44:39.612 Writing report data ... [2024-12-31T06:44:44.249Z] CL2 j> 2024/12/31 06:44:40.181 done. [2024-12-31T06:44:56.435Z] CL2 j> 2024/12/31 06:44:50.423 Writing report data ... [2024-12-31T06:44:56.435Z] CL2 j> 2024/12/31 06:44:51.234 done. [2024-12-31T06:45:06.588Z] CL2 j> 2024/12/31 06:45:01.818 Writing report data ... [2024-12-31T06:45:08.763Z] CL2 j> 2024/12/31 06:45:02.991 done. [2024-12-31T06:45:23.573Z] CL2 j> 2024/12/31 06:45:13.604 Writing report data ... [2024-12-31T06:45:23.573Z] CL2 j> 2024/12/31 06:45:14.253 done. [2024-12-31T06:45:29.352Z] CL2 j> 2024/12/31 06:45:24.774 Writing report data ... [2024-12-31T06:45:29.352Z] CL2 j> 2024/12/31 06:45:25.334 done. [2024-12-31T06:45:41.424Z] CL2 j> 2024/12/31 06:45:35.527 Writing report data ... [2024-12-31T06:45:42.947Z] CL2 j> 2024/12/31 06:45:37.194 done. [2024-12-31T06:45:51.382Z] CL2 j> 2024/12/31 06:45:47.846 Writing report data ... [2024-12-31T06:45:51.382Z] CL2 j> 2024/12/31 06:45:48.455 done. [2024-12-31T06:46:03.637Z] CL2 j> 2024/12/31 06:45:58.642 Writing report data ... [2024-12-31T06:46:03.989Z] CL2 j> 2024/12/31 06:45:59.591 done. [2024-12-31T06:46:04.347Z] STF 06:46:03.674 - Monitoring Report Summary: [2024-12-31T06:46:04.347Z] STF 06:46:03.674 - o Process CL2 ended with the expected exit code (0) [2024-12-31T06:46:04.347Z] STF 06:46:03.674 - o Process LT2 is still running as expected [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - +------ Step 8 - Stop LT2 process [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - | Kill running processes [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - | Processes: [LT2] [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - | [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - Killing processes: LT2 [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - o Process clean up attempt 1 for LT2 pid 8748 [2024-12-31T06:46:04.347Z] STF 06:46:03.675 - o Process LT2 pid 8748 stop() [2024-12-31T06:46:04.347Z] STF 06:46:03.677 - o Process LT2 pid 8748 killed [2024-12-31T06:46:04.347Z] STF 06:46:03.678 - EXECUTE stage completed [2024-12-31T06:46:04.347Z] STF 06:46:04.198 - [2024-12-31T06:46:04.347Z] STF 06:46:04.198 - ==================== T E A R D O W N ==================== [2024-12-31T06:46:04.347Z] STF 06:46:04.198 - Running teardown: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows/aqa-tests/\TKG\output_17356240359966\TestJlmRemoteThreadNoAuth_0/20241231-063412-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-12-31T06:46:04.686Z] STF 06:46:04.378 - TEARDOWN stage completed [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - ===================== R E S U L T S ===================== [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - Stage results: [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - setUp: pass [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - execute: pass [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - teardown: pass [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - [2024-12-31T06:46:04.686Z] STF 06:46:04.395 - Overall result: PASSED [2024-12-31T06:46:04.686Z] ----------------------------------- [2024-12-31T06:46:04.686Z] TestJlmRemoteThreadNoAuth_0_PASSED [2024-12-31T06:46:04.686Z] ----------------------------------- [2024-12-31T06:46:04.686Z] [2024-12-31T06:46:04.686Z] TEST TEARDOWN: [2024-12-31T06:46:04.686Z] Nothing to be done for teardown. [2024-12-31T06:46:04.686Z] TestJlmRemoteThreadNoAuth_0 Finish Time: Tue Dec 31 06:46:04 2024 Epoch Time (ms): 1735627564588