[2024-10-08T04:59:24.099Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2024-10-08T04:59:24.099Z] =============================================== [2024-10-08T04:59:24.099Z] TestJlmRemoteThreadNoAuth_1 Start Time: Tue Oct 8 05:59:23 2024 Epoch Time (ms): 1728363563898 [2024-10-08T04:59:24.099Z] variation: Mode650 [2024-10-08T04:59:24.440Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-10-08T04:59:24.440Z] { \ [2024-10-08T04:59:24.440Z] echo ""; echo "TEST SETUP:"; \ [2024-10-08T04:59:24.440Z] echo "Nothing to be done for setup."; \ [2024-10-08T04:59:24.440Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17283600726176\\TestJlmRemoteThreadNoAuth_1"; \ [2024-10-08T04:59:24.440Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17283600726176\\TestJlmRemoteThreadNoAuth_1"; \ [2024-10-08T04:59:24.440Z] echo ""; echo "TESTING:"; \ [2024-10-08T04:59:24.440Z] perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\STF;C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests///..//jvmtest\\system\\jlm/../\\aqa-systemtest""" -systemtest-prereqs="c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\\" -java-args=' -XX:-UseCompressedOops ' -results-root="C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17283600726176\\TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2024-10-08T04:59:24.440Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17283600726176\\TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-08T04:59:24.440Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-08T04:59:24.440Z] echo "Nothing to be done for teardown."; \ [2024-10-08T04:59:24.440Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\\TKG\\output_17283600726176\\TestTargetResult"; [2024-10-08T04:59:24.440Z] [2024-10-08T04:59:24.440Z] TEST SETUP: [2024-10-08T04:59:24.440Z] Nothing to be done for setup. [2024-10-08T04:59:24.440Z] [2024-10-08T04:59:24.440Z] TESTING: [2024-10-08T04:59:24.441Z] STF 05:59:24.393 - ========================= S T F ========================= [2024-10-08T04:59:24.441Z] 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_testList_0/aqa-tests/\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1 [2024-10-08T04:59:24.779Z] There is 127433 Mb free [2024-10-08T04:59:24.779Z] STF 05:59:24.449 - ================== G E N E R A T I O N ================== [2024-10-08T04:59:24.779Z] STF 05:59:24.452 - Checking JVM: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image [2024-10-08T04:59:24.779Z] STF 05:59:24.452 - Starting process to generate scripts: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/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_testList_0/../../testDependency/system_lib\/log4j/log4j-api.jar;c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth" [2024-10-08T04:59:24.779Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-08T04:59:24.779Z] GEN [0.018s][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-10-08T04:59:25.927Z] GEN 04:59:25.524 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: 'C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin' [2024-10-08T04:59:25.927Z] GEN 04:59:25.574 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-10-08T04:59:25.927Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-10-08T04:59:25.927Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2024-10-08T04:59:25.927Z] GEN C:\\jenkins\\workspace\\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\\jvmtest\\system\\STF\\stf.core\\bin [2024-10-08T04:59:25.927Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-10-08T04:59:25.927Z] GEN c:/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-10-08T04:59:25.927Z] GEN c:/jenkins/testDependency/system_lib/junit/junit.jar [2024-10-08T04:59:25.927Z] GEN 04:59:25.789 - Using Mode NoOptions. Values = '' [2024-10-08T04:59:26.262Z] GEN 04:59:25.904 - [2024-10-08T04:59:26.262Z] GEN 04:59:25.904 - Test command summary: [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - Step Stage Command Description [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - -----+--------+-----------------+------------ [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 3 execute Monitor Wait for processes to complete [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 4 execute kill Stop LT1 process [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-10-08T04:59:26.262Z] GEN 04:59:25.905 - 7 execute Monitor Wait for processes to complete [2024-10-08T04:59:26.262Z] GEN 04:59:25.906 - 8 execute kill Stop LT2 process [2024-10-08T04:59:26.262Z] STF 05:59:25.945 - [2024-10-08T04:59:26.262Z] STF 05:59:25.945 - Script generation completed [2024-10-08T04:59:26.262Z] STF 05:59:25.945 - [2024-10-08T04:59:26.262Z] STF 05:59:25.953 - [2024-10-08T04:59:26.262Z] STF 05:59:25.953 - ======================= S E T U P ======================= [2024-10-08T04:59:26.262Z] STF 05:59:25.953 - Running setup: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/setUp.pl [2024-10-08T04:59:26.262Z] STF 05:59:26.113 - SETUP stage completed [2024-10-08T04:59:26.262Z] STF 05:59:26.131 - [2024-10-08T04:59:26.262Z] STF 05:59:26.131 - ==================== E X E C U T E - ==================== [2024-10-08T04:59:26.262Z] STF 05:59:26.131 - Running execute: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/execute.pl [2024-10-08T04:59:26.604Z] STF 05:59:26.287 - [2024-10-08T04:59:26.604Z] STF 05:59:26.287 - Java version [2024-10-08T04:59:26.604Z] STF 05:59:26.287 - Running: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -version [2024-10-08T04:59:26.604Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-08T04:59:26.604Z] openjdk version "21.0.5-beta" 2024-10-15 [2024-10-08T04:59:26.604Z] OpenJDK Runtime Environment Temurin-21.0.5+9-202410072339 (build 21.0.5-beta+9-202410072339) [2024-10-08T04:59:26.604Z] OpenJDK 64-Bit Server VM Temurin-21.0.5+9-202410072339 (build 21.0.5-beta+9-202410072339, mixed mode, sharing) [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - | Start background process [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - | Mnemonic: LT1 [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - | Echo: ECHO_OFF [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - | Expectation: NEVER [2024-10-08T04:59:26.604Z] STF 05:59:26.394 - | [2024-10-08T04:59:26.605Z] STF 05:59:26.395 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\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_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\aqa-tests\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1\20241008-055924-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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2024-10-08T04:59:26.605Z] STF 05:59:26.395 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-10-08T04:59:26.605Z] STF 05:59:26.395 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - | Start background process [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - | Mnemonic: CL1 [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - | Echo: ECHO_ON [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - | Expectation: CLEAN_RUN within 30m [2024-10-08T04:59:26.605Z] STF 05:59:26.429 - | [2024-10-08T04:59:26.605Z] STF 05:59:26.430 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-08T04:59:26.605Z] STF 05:59:26.430 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-10-08T04:59:26.605Z] STF 05:59:26.430 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-10-08T04:59:26.605Z] STF 05:59:26.436 - [2024-10-08T04:59:26.605Z] STF 05:59:26.436 - +------ Step 3 - Wait for processes to complete [2024-10-08T04:59:26.605Z] STF 05:59:26.436 - | Wait for processes to meet expectations [2024-10-08T04:59:26.605Z] STF 05:59:26.436 - | Processes: [LT1, CL1] [2024-10-08T04:59:26.605Z] STF 05:59:26.436 - | [2024-10-08T04:59:26.605Z] STF 05:59:26.436 - Monitoring processes: CL1 LT1 [2024-10-08T04:59:26.605Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-08T04:59:26.960Z] CL1 j> 2024/10/08 04:59:26.642 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-08T04:59:26.960Z] CL1 j> 2024/10/08 04:59:26.723 Attempting to connect [2024-10-08T04:59:27.320Z] CL1 j> 2024/10/08 04:59:26.980 Monitored VM not ready at Oct 8, 2024, 4:59:26?AM (attempt 1, elapsed 233ms). [2024-10-08T04:59:27.320Z] CL1 j> 2024/10/08 04:59:26.980 Waiting 5 secs and trying again... [2024-10-08T04:59:36.363Z] CL1 j> 2024/10/08 04:59:32.550 Attempting to connect [2024-10-08T04:59:37.799Z] CL1 j> 2024/10/08 04:59:33.585 Connection established! [2024-10-08T04:59:44.517Z] CL1 j> 2024/10/08 04:59:39.019 Starting to write data [2024-10-08T05:04:27.883Z] STF 06:04:26.046 - Heartbeat: Process LT1 is still running [2024-10-08T05:05:28.006Z] STF 06:05:21.409 - Monitoring Report Summary: [2024-10-08T05:05:28.006Z] STF 06:05:21.410 - o Process CL1 ended with the expected exit code (0) [2024-10-08T05:05:28.006Z] STF 06:05:21.439 - o Process LT1 is still running as expected [2024-10-08T05:05:28.006Z] STF 06:05:21.488 - [2024-10-08T05:05:28.006Z] STF 06:05:21.516 - +------ Step 4 - Stop LT1 process [2024-10-08T05:05:28.006Z] STF 06:05:21.517 - | Kill running processes [2024-10-08T05:05:28.006Z] STF 06:05:21.518 - | Processes: [LT1] [2024-10-08T05:05:28.006Z] STF 06:05:21.518 - | [2024-10-08T05:05:28.006Z] STF 06:05:21.547 - Killing processes: LT1 [2024-10-08T05:05:28.006Z] STF 06:05:21.547 - o Process clean up attempt 1 for LT1 pid 1460 [2024-10-08T05:05:28.006Z] STF 06:05:21.547 - o Process LT1 pid 1460 stop() [2024-10-08T05:05:28.006Z] STF 06:05:21.548 - o Process LT1 pid 1460 killed [2024-10-08T05:05:28.006Z] STF 06:05:21.548 - [2024-10-08T05:05:28.006Z] STF 06:05:21.548 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - | Start background process [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - | Mnemonic: LT2 [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - | Echo: ECHO_OFF [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - | Expectation: NEVER [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - | [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\STF\stf.load\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\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_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\aqa-tests\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1\20241008-055924-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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-10-08T05:05:28.006Z] STF 06:05:21.549 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - | Start background process [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - | Program: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - | Mnemonic: CL2 [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - | Echo: ECHO_ON [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - | Expectation: CLEAN_RUN within 30m [2024-10-08T05:05:28.006Z] STF 06:05:21.558 - | [2024-10-08T05:05:28.007Z] STF 06:05:21.558 - Running command: c:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath C:\jenkins\workspace\Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0\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_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/thd_proxy.log C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-08T05:05:28.007Z] STF 06:05:21.558 - Redirecting stderr to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-10-08T05:05:28.007Z] STF 06:05:21.558 - Redirecting stdout to C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/TKG/output_17283600726176/TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-10-08T05:05:28.007Z] STF 06:05:21.564 - [2024-10-08T05:05:28.007Z] STF 06:05:21.564 - +------ Step 7 - Wait for processes to complete [2024-10-08T05:05:28.007Z] STF 06:05:21.564 - | Wait for processes to meet expectations [2024-10-08T05:05:28.007Z] STF 06:05:21.564 - | Processes: [LT2, CL2] [2024-10-08T05:05:28.007Z] STF 06:05:21.564 - | [2024-10-08T05:05:28.007Z] STF 06:05:21.564 - Monitoring processes: CL2 LT2 [2024-10-08T05:05:28.007Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-08T05:05:28.007Z] CL2 j> 2024/10/08 05:05:21.798 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-08T05:05:28.007Z] CL2 j> 2024/10/08 05:05:21.877 Attempting to connect [2024-10-08T05:05:28.007Z] CL2 j> 2024/10/08 05:05:22.164 Monitored VM not ready at Oct 8, 2024, 5:05:22?AM (attempt 1, elapsed 260ms). [2024-10-08T05:05:28.007Z] CL2 j> 2024/10/08 05:05:22.164 Waiting 5 secs and trying again... [2024-10-08T05:05:31.075Z] CL2 j> 2024/10/08 05:05:27.712 Attempting to connect [2024-10-08T05:05:35.825Z] CL2 j> 2024/10/08 05:05:32.076 Connection established! [2024-10-08T05:05:50.810Z] CL2 j> 2024/10/08 05:05:45.523 Writing report data ... [2024-10-08T05:05:55.127Z] CL2 j> 2024/10/08 05:05:49.967 done. [2024-10-08T05:06:05.152Z] CL2 j> 2024/10/08 05:06:00.752 Writing report data ... [2024-10-08T05:06:10.232Z] CL2 j> 2024/10/08 05:06:02.952 done. [2024-10-08T05:06:16.364Z] CL2 j> 2024/10/08 05:06:13.311 Writing report data ... [2024-10-08T05:06:19.504Z] CL2 j> 2024/10/08 05:06:14.115 done. [2024-10-08T05:06:28.075Z] CL2 j> 2024/10/08 05:06:24.703 Writing report data ... [2024-10-08T05:06:30.372Z] CL2 j> 2024/10/08 05:06:26.038 done. [2024-10-08T05:06:43.788Z] CL2 j> 2024/10/08 05:06:36.806 Writing report data ... [2024-10-08T05:06:43.788Z] CL2 j> 2024/10/08 05:06:37.997 done. [2024-10-08T05:06:52.139Z] CL2 j> 2024/10/08 05:06:48.525 Writing report data ... [2024-10-08T05:06:56.153Z] CL2 j> 2024/10/08 05:06:49.935 done. [2024-10-08T05:07:05.875Z] CL2 j> 2024/10/08 05:07:00.207 Writing report data ... [2024-10-08T05:07:06.531Z] CL2 j> 2024/10/08 05:07:00.518 done. [2024-10-08T05:07:19.424Z] CL2 j> 2024/10/08 05:07:11.275 Writing report data ... [2024-10-08T05:07:19.424Z] CL2 j> 2024/10/08 05:07:11.826 done. [2024-10-08T05:07:23.811Z] CL2 j> 2024/10/08 05:07:22.138 Writing report data ... [2024-10-08T05:07:28.597Z] CL2 j> 2024/10/08 05:07:24.603 done. [2024-10-08T05:07:38.988Z] CL2 j> 2024/10/08 05:07:34.827 Writing report data ... [2024-10-08T05:07:40.453Z] CL2 j> 2024/10/08 05:07:35.262 done. [2024-10-08T05:07:49.142Z] CL2 j> 2024/10/08 05:07:45.593 Writing report data ... [2024-10-08T05:07:52.176Z] CL2 j> 2024/10/08 05:07:46.023 done. [2024-10-08T05:08:03.348Z] CL2 j> 2024/10/08 05:07:56.537 Writing report data ... [2024-10-08T05:08:03.348Z] CL2 j> 2024/10/08 05:07:57.225 done. [2024-10-08T05:08:10.835Z] CL2 j> 2024/10/08 05:08:07.412 Writing report data ... [2024-10-08T05:08:11.988Z] CL2 j> 2024/10/08 05:08:08.041 done. [2024-10-08T05:08:24.135Z] CL2 j> 2024/10/08 05:08:18.489 Writing report data ... [2024-10-08T05:08:25.811Z] CL2 j> 2024/10/08 05:08:19.919 done. [2024-10-08T05:08:37.040Z] CL2 j> 2024/10/08 05:08:31.082 Writing report data ... [2024-10-08T05:08:37.040Z] CL2 j> 2024/10/08 05:08:31.733 done. [2024-10-08T05:08:46.801Z] CL2 j> 2024/10/08 05:08:42.421 Writing report data ... [2024-10-08T05:08:50.696Z] CL2 j> 2024/10/08 05:08:43.080 done. [2024-10-08T05:08:57.556Z] CL2 j> 2024/10/08 05:08:54.644 Writing report data ... [2024-10-08T05:09:00.512Z] CL2 j> 2024/10/08 05:08:55.315 done. [2024-10-08T05:09:09.998Z] CL2 j> 2024/10/08 05:09:05.792 Writing report data ... [2024-10-08T05:09:09.998Z] CL2 j> 2024/10/08 05:09:06.611 done. [2024-10-08T05:09:22.743Z] CL2 j> 2024/10/08 05:09:17.355 Writing report data ... [2024-10-08T05:09:23.433Z] CL2 j> 2024/10/08 05:09:18.903 done. [2024-10-08T05:09:30.222Z] STF 06:09:26.592 - Heartbeat: Process LT2 is still running [2024-10-08T05:09:34.685Z] CL2 j> 2024/10/08 05:09:29.434 Writing report data ... [2024-10-08T05:09:34.685Z] CL2 j> 2024/10/08 05:09:30.454 done. [2024-10-08T05:09:45.969Z] CL2 j> 2024/10/08 05:09:40.875 Writing report data ... [2024-10-08T05:09:47.566Z] CL2 j> 2024/10/08 05:09:41.881 done. [2024-10-08T05:09:56.419Z] CL2 j> 2024/10/08 05:09:52.543 Writing report data ... [2024-10-08T05:09:56.419Z] CL2 j> 2024/10/08 05:09:53.111 done. [2024-10-08T05:10:06.829Z] CL2 j> 2024/10/08 05:10:03.789 Writing report data ... [2024-10-08T05:10:08.829Z] CL2 j> 2024/10/08 05:10:04.543 done. [2024-10-08T05:10:21.321Z] CL2 j> 2024/10/08 05:10:15.004 Writing report data ... [2024-10-08T05:10:21.321Z] CL2 j> 2024/10/08 05:10:15.515 done. [2024-10-08T05:10:28.415Z] CL2 j> 2024/10/08 05:10:25.909 Writing report data ... [2024-10-08T05:10:31.319Z] CL2 j> 2024/10/08 05:10:26.474 done. [2024-10-08T05:10:40.674Z] CL2 j> 2024/10/08 05:10:36.927 Writing report data ... [2024-10-08T05:10:42.978Z] CL2 j> 2024/10/08 05:10:37.366 done. [2024-10-08T05:10:51.655Z] CL2 j> 2024/10/08 05:10:48.137 Writing report data ... [2024-10-08T05:10:53.061Z] CL2 j> 2024/10/08 05:10:48.960 done. [2024-10-08T05:11:03.207Z] CL2 j> 2024/10/08 05:10:59.390 Writing report data ... [2024-10-08T05:11:03.207Z] CL2 j> 2024/10/08 05:10:59.702 done. [2024-10-08T05:11:13.880Z] CL2 j> 2024/10/08 05:11:09.945 Writing report data ... [2024-10-08T05:11:15.012Z] CL2 j> 2024/10/08 05:11:10.388 done. [2024-10-08T05:11:21.937Z] CL2 j> 2024/10/08 05:11:21.043 Writing report data ... [2024-10-08T05:11:27.545Z] CL2 j> 2024/10/08 05:11:21.646 done. [2024-10-08T05:11:39.706Z] STF 06:11:38.889 - Monitoring Report Summary: [2024-10-08T05:11:39.706Z] STF 06:11:38.889 - o Process CL2 ended with the expected exit code (0) [2024-10-08T05:11:39.706Z] STF 06:11:38.889 - o Process LT2 is still running as expected [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - +------ Step 8 - Stop LT2 process [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - | Kill running processes [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - | Processes: [LT2] [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - | [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - Killing processes: LT2 [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - o Process clean up attempt 1 for LT2 pid 13236 [2024-10-08T05:11:39.706Z] STF 06:11:38.890 - o Process LT2 pid 13236 stop() [2024-10-08T05:11:39.706Z] STF 06:11:38.891 - o Process LT2 pid 13236 killed [2024-10-08T05:11:39.706Z] STF 06:11:38.891 - EXECUTE stage completed [2024-10-08T05:11:39.706Z] STF 06:11:39.402 - [2024-10-08T05:11:39.706Z] STF 06:11:39.402 - ==================== T E A R D O W N ==================== [2024-10-08T05:11:39.706Z] STF 06:11:39.402 - Running teardown: perl C:/jenkins/workspace/Test_openjdk21_hs_sanity.system_x86-64_windows_testList_0/aqa-tests/\TKG\output_17283600726176\TestJlmRemoteThreadNoAuth_1/20241008-055924-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-10-08T05:11:39.706Z] STF 06:11:39.545 - TEARDOWN stage completed [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - ===================== R E S U L T S ===================== [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - Stage results: [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - setUp: pass [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - execute: pass [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - teardown: pass [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - [2024-10-08T05:11:39.706Z] STF 06:11:39.558 - Overall result: PASSED [2024-10-08T05:11:39.706Z] ----------------------------------- [2024-10-08T05:11:39.706Z] TestJlmRemoteThreadNoAuth_1_PASSED [2024-10-08T05:11:39.706Z] ----------------------------------- [2024-10-08T05:11:39.706Z] [2024-10-08T05:11:39.706Z] TEST TEARDOWN: [2024-10-08T05:11:39.706Z] Nothing to be done for teardown. [2024-10-08T05:11:40.030Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Tue Oct 8 06:11:39 2024 Epoch Time (ms): 1728364299815