[2024-09-04T23:50:39.115Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2024-09-04T23:50:39.115Z] =============================================== [2024-09-04T23:50:39.115Z] TestJlmRemoteThreadNoAuth_1 Start Time: Wed Sep 4 23:50:38 2024 Epoch Time (ms): 1725493838276 [2024-09-04T23:50:39.115Z] variation: Mode650 [2024-09-04T23:50:39.115Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-09-04T23:50:39.115Z] { \ [2024-09-04T23:50:39.115Z] echo ""; echo "TEST SETUP:"; \ [2024-09-04T23:50:39.115Z] echo "Nothing to be done for setup."; \ [2024-09-04T23:50:39.115Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1"; \ [2024-09-04T23:50:39.115Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1"; \ [2024-09-04T23:50:39.115Z] echo ""; echo "TESTING:"; \ [2024-09-04T23:50:39.115Z] perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2024-09-04T23:50:39.115Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-04T23:50:39.115Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-04T23:50:39.115Z] echo "Nothing to be done for teardown."; \ [2024-09-04T23:50:39.115Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestTargetResult"; [2024-09-04T23:50:39.115Z] [2024-09-04T23:50:39.115Z] TEST SETUP: [2024-09-04T23:50:39.115Z] Nothing to be done for setup. [2024-09-04T23:50:39.115Z] [2024-09-04T23:50:39.115Z] TESTING: [2024-09-04T23:50:39.115Z] STF 23:50:38.343 - ========================= S T F ========================= [2024-09-04T23:50:39.115Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1 [2024-09-04T23:50:39.115Z] There is 61076 Mb free [2024-09-04T23:50:39.115Z] STF 23:50:38.348 - ================== G E N E R A T I O N ================== [2024-09-04T23:50:39.115Z] STF 23:50:38.349 - Checking JVM: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/../ [2024-09-04T23:50:39.115Z] STF 23:50:38.349 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/..//bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth" [2024-09-04T23:50:39.115Z] GEN stderr OpenJDK 64-Bit Server VM warning: 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-09-04T23:50:39.115Z] GEN 23:50:38.994 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2024-09-04T23:50:39.115Z] GEN 23:50:39.003 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-09-04T23:50:39.115Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-09-04T23:50:39.115Z] GEN /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2024-09-04T23:50:39.115Z] GEN /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/bin [2024-09-04T23:50:39.115Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-09-04T23:50:39.115Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-09-04T23:50:39.115Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2024-09-04T23:50:39.496Z] GEN 23:50:39.118 - Using Mode NoOptions. Values = '' [2024-09-04T23:50:39.496Z] GEN 23:50:39.187 - [2024-09-04T23:50:39.496Z] GEN 23:50:39.187 - Test command summary: [2024-09-04T23:50:39.496Z] GEN 23:50:39.187 - Step Stage Command Description [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - -----+--------+-----------------+------------ [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 3 execute Monitor Wait for processes to complete [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 4 execute kill Stop LT1 process [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 7 execute Monitor Wait for processes to complete [2024-09-04T23:50:39.496Z] GEN 23:50:39.188 - 8 execute kill Stop LT2 process [2024-09-04T23:50:39.496Z] STF 23:50:39.212 - [2024-09-04T23:50:39.496Z] STF 23:50:39.212 - Script generation completed [2024-09-04T23:50:39.496Z] STF 23:50:39.212 - [2024-09-04T23:50:39.496Z] STF 23:50:39.212 - [2024-09-04T23:50:39.496Z] STF 23:50:39.212 - ======================= S E T U P ======================= [2024-09-04T23:50:39.496Z] STF 23:50:39.212 - Running setup: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/setUp.pl [2024-09-04T23:50:39.496Z] STF 23:50:39.267 - SETUP stage completed [2024-09-04T23:50:39.496Z] STF 23:50:39.268 - [2024-09-04T23:50:39.496Z] STF 23:50:39.268 - ==================== E X E C U T E - ==================== [2024-09-04T23:50:39.496Z] STF 23:50:39.268 - Running execute: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/execute.pl [2024-09-04T23:50:39.496Z] STF 23:50:39.321 - [2024-09-04T23:50:39.496Z] STF 23:50:39.321 - Java version [2024-09-04T23:50:39.496Z] STF 23:50:39.322 - Running: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java -version [2024-09-04T23:50:39.496Z] openjdk version "17.0.13-beta" 2024-10-15 [2024-09-04T23:50:39.496Z] OpenJDK Runtime Environment Temurin-17.0.13+6-202409042148 (build 17.0.13-beta+6-ea) [2024-09-04T23:50:39.496Z] OpenJDK 64-Bit Server VM Temurin-17.0.13+6-202409042148 (build 17.0.13-beta+6-ea, mixed mode, sharing) [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - | Start background process [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - | Mnemonic: LT1 [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - | Echo: ECHO_OFF [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - | Expectation: NEVER [2024-09-04T23:50:39.496Z] STF 23:50:39.363 - | [2024-09-04T23:50:39.496Z] STF 23:50:39.364 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-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 /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-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-09-04T23:50:39.496Z] STF 23:50:39.364 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-09-04T23:50:39.496Z] STF 23:50:39.364 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-09-04T23:50:39.496Z] STF 23:50:39.373 - [2024-09-04T23:50:39.496Z] STF 23:50:39.373 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-09-04T23:50:39.496Z] STF 23:50:39.373 - | Start background process [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - | Mnemonic: CL1 [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - | Echo: ECHO_ON [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - | Expectation: CLEAN_RUN within 30m [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - | [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-09-04T23:50:39.497Z] STF 23:50:39.373 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-09-04T23:50:39.497Z] STF 23:50:39.374 - [2024-09-04T23:50:39.497Z] STF 23:50:39.374 - +------ Step 3 - Wait for processes to complete [2024-09-04T23:50:39.497Z] STF 23:50:39.374 - | Wait for processes to meet expectations [2024-09-04T23:50:39.497Z] STF 23:50:39.374 - | Processes: [LT1, CL1] [2024-09-04T23:50:39.497Z] STF 23:50:39.374 - | [2024-09-04T23:50:39.497Z] STF 23:50:39.374 - Monitoring processes: CL1 LT1 [2024-09-04T23:50:39.870Z] CL1 j> 2024/09/04 23:50:39.485 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-09-04T23:50:39.870Z] CL1 j> 2024/09/04 23:50:39.540 Attempting to connect [2024-09-04T23:50:39.870Z] CL1 j> 2024/09/04 23:50:39.645 Monitored VM not ready at Sep 4, 2024, 11:50:39 PM (attempt 1, elapsed 85ms). [2024-09-04T23:50:39.870Z] CL1 j> 2024/09/04 23:50:39.645 Waiting 5 secs and trying again... [2024-09-04T23:50:45.152Z] CL1 j> 2024/09/04 23:50:44.651 Attempting to connect [2024-09-04T23:50:46.059Z] CL1 j> 2024/09/04 23:50:45.574 Connection established! [2024-09-04T23:50:46.527Z] CL1 j> 2024/09/04 23:50:46.041 Starting to write data [2024-09-04T23:55:43.682Z] STF 23:55:39.203 - Heartbeat: Process CL1 is still running [2024-09-04T23:56:33.376Z] STF 23:56:29.839 - Monitoring Report Summary: [2024-09-04T23:56:33.376Z] STF 23:56:29.839 - o Process CL1 ended with the expected exit code (0) [2024-09-04T23:56:33.376Z] STF 23:56:29.839 - o Process LT1 is still running as expected [2024-09-04T23:56:33.376Z] STF 23:56:29.839 - [2024-09-04T23:56:33.376Z] STF 23:56:29.839 - +------ Step 4 - Stop LT1 process [2024-09-04T23:56:33.377Z] STF 23:56:29.839 - | Kill running processes [2024-09-04T23:56:33.377Z] STF 23:56:29.839 - | Processes: [LT1] [2024-09-04T23:56:33.377Z] STF 23:56:29.839 - | [2024-09-04T23:56:33.377Z] STF 23:56:29.839 - Killing processes: LT1 [2024-09-04T23:56:33.377Z] STF 23:56:29.840 - o Process clean up attempt 1 for LT1 pid 1703032 [2024-09-04T23:56:33.377Z] STF 23:56:29.840 - o Process LT1 pid 1703032 stop() [2024-09-04T23:56:41.421Z] STF 23:56:39.898 - o Process LT1 pid 1703032 terminate() [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - o Process LT1 pid 1703032 killed [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - | Start background process [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - | Mnemonic: LT2 [2024-09-04T23:56:41.421Z] STF 23:56:40.898 - | Echo: ECHO_OFF [2024-09-04T23:56:41.421Z] STF 23:56:40.899 - | Expectation: NEVER [2024-09-04T23:56:41.421Z] STF 23:56:40.899 - | [2024-09-04T23:56:41.421Z] STF 23:56:40.899 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-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 /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-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-09-04T23:56:41.421Z] STF 23:56:40.899 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-09-04T23:56:41.421Z] STF 23:56:40.899 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - | Start background process [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - | Mnemonic: CL2 [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - | Echo: ECHO_ON [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - | Expectation: CLEAN_RUN within 30m [2024-09-04T23:56:41.421Z] STF 23:56:40.901 - | [2024-09-04T23:56:41.421Z] STF 23:56:40.902 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk-17.0.13+6/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-09-04T23:56:41.421Z] STF 23:56:40.902 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-09-04T23:56:41.421Z] STF 23:56:40.902 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-09-04T23:56:41.421Z] STF 23:56:40.903 - [2024-09-04T23:56:41.421Z] STF 23:56:40.903 - +------ Step 7 - Wait for processes to complete [2024-09-04T23:56:41.421Z] STF 23:56:40.903 - | Wait for processes to meet expectations [2024-09-04T23:56:41.421Z] STF 23:56:40.903 - | Processes: [LT2, CL2] [2024-09-04T23:56:41.421Z] STF 23:56:40.903 - | [2024-09-04T23:56:41.421Z] STF 23:56:40.903 - Monitoring processes: CL2 LT2 [2024-09-04T23:56:41.801Z] CL2 j> 2024/09/04 23:56:41.013 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-09-04T23:56:41.801Z] CL2 j> 2024/09/04 23:56:41.072 Attempting to connect [2024-09-04T23:56:41.801Z] CL2 j> 2024/09/04 23:56:41.184 Monitored VM not ready at Sep 4, 2024, 11:56:41 PM (attempt 1, elapsed 89ms). [2024-09-04T23:56:41.801Z] CL2 j> 2024/09/04 23:56:41.184 Waiting 5 secs and trying again... [2024-09-04T23:56:47.277Z] CL2 j> 2024/09/04 23:56:46.190 Attempting to connect [2024-09-04T23:56:47.277Z] CL2 j> 2024/09/04 23:56:47.017 Connection established! [2024-09-04T23:56:59.380Z] CL2 j> 2024/09/04 23:56:58.385 Writing report data ... [2024-09-04T23:57:04.735Z] CL2 j> 2024/09/04 23:57:03.564 done. [2024-09-04T23:57:14.662Z] CL2 j> 2024/09/04 23:57:13.740 Writing report data ... [2024-09-04T23:57:18.115Z] CL2 j> 2024/09/04 23:57:17.658 done. [2024-09-04T23:57:29.915Z] CL2 j> 2024/09/04 23:57:27.772 Writing report data ... [2024-09-04T23:57:32.523Z] CL2 j> 2024/09/04 23:57:31.574 done. [2024-09-04T23:57:44.342Z] CL2 j> 2024/09/04 23:57:41.954 Writing report data ... [2024-09-04T23:57:46.285Z] CL2 j> 2024/09/04 23:57:45.216 done. [2024-09-04T23:57:58.095Z] CL2 j> 2024/09/04 23:57:55.935 Writing report data ... [2024-09-04T23:58:00.784Z] CL2 j> 2024/09/04 23:57:59.241 done. [2024-09-04T23:58:10.663Z] CL2 j> 2024/09/04 23:58:09.544 Writing report data ... [2024-09-04T23:58:15.208Z] CL2 j> 2024/09/04 23:58:14.620 done. [2024-09-04T23:58:27.232Z] CL2 j> 2024/09/04 23:58:25.009 Writing report data ... [2024-09-04T23:58:29.215Z] CL2 j> 2024/09/04 23:58:28.952 done. [2024-09-04T23:58:41.082Z] CL2 j> 2024/09/04 23:58:39.222 Writing report data ... [2024-09-04T23:58:42.980Z] CL2 j> 2024/09/04 23:58:42.116 done. [2024-09-04T23:58:52.858Z] CL2 j> 2024/09/04 23:58:52.475 Writing report data ... [2024-09-04T23:58:56.319Z] CL2 j> 2024/09/04 23:58:55.556 done. [2024-09-04T23:59:08.134Z] CL2 j> 2024/09/04 23:59:05.704 Writing report data ... [2024-09-04T23:59:10.106Z] CL2 j> 2024/09/04 23:59:09.436 done. [2024-09-04T23:59:22.268Z] CL2 j> 2024/09/04 23:59:19.612 Writing report data ... [2024-09-04T23:59:25.015Z] CL2 j> 2024/09/04 23:59:23.955 done. [2024-09-04T23:59:36.913Z] CL2 j> 2024/09/04 23:59:34.359 Writing report data ... [2024-09-04T23:59:39.004Z] CL2 j> 2024/09/04 23:59:37.899 done. [2024-09-04T23:59:50.989Z] CL2 j> 2024/09/04 23:59:48.153 Writing report data ... [2024-09-04T23:59:53.682Z] CL2 j> 2024/09/04 23:59:52.386 done. [2024-09-05T00:00:03.506Z] CL2 j> 2024/09/05 00:00:02.679 Writing report data ... [2024-09-05T00:00:07.818Z] CL2 j> 2024/09/05 00:00:07.111 done. [2024-09-05T00:00:19.614Z] CL2 j> 2024/09/05 00:00:17.394 Writing report data ... [2024-09-05T00:00:21.060Z] CL2 j> 2024/09/05 00:00:20.323 done. [2024-09-05T00:00:32.931Z] CL2 j> 2024/09/05 00:00:30.509 Writing report data ... [2024-09-05T00:00:34.353Z] CL2 j> 2024/09/05 00:00:33.626 done. [2024-09-05T00:00:39.911Z] STF 00:00:39.223 - Heartbeat: Process CL2 is still running [2024-09-05T00:00:45.364Z] CL2 j> 2024/09/05 00:00:44.388 Writing report data ... [2024-09-05T00:00:48.892Z] CL2 j> 2024/09/05 00:00:47.577 done. [2024-09-05T00:00:58.697Z] CL2 j> 2024/09/05 00:00:57.821 Writing report data ... [2024-09-05T00:01:01.348Z] CL2 j> 2024/09/05 00:01:00.092 done. [2024-09-05T00:01:11.109Z] CL2 j> 2024/09/05 00:01:10.236 Writing report data ... [2024-09-05T00:01:14.597Z] CL2 j> 2024/09/05 00:01:13.549 done. [2024-09-05T00:01:24.733Z] CL2 j> 2024/09/05 00:01:23.850 Writing report data ... [2024-09-05T00:01:28.214Z] CL2 j> 2024/09/05 00:01:26.891 done. [2024-09-05T00:01:38.112Z] CL2 j> 2024/09/05 00:01:37.098 Writing report data ... [2024-09-05T00:01:41.531Z] CL2 j> 2024/09/05 00:01:40.229 done. [2024-09-05T00:01:51.489Z] CL2 j> 2024/09/05 00:01:50.522 Writing report data ... [2024-09-05T00:01:54.971Z] CL2 j> 2024/09/05 00:01:53.915 done. [2024-09-05T00:02:04.870Z] CL2 j> 2024/09/05 00:02:04.102 Writing report data ... [2024-09-05T00:02:09.213Z] CL2 j> 2024/09/05 00:02:08.171 done. [2024-09-05T00:02:21.119Z] CL2 j> 2024/09/05 00:02:18.662 Writing report data ... [2024-09-05T00:02:21.523Z] CL2 j> 2024/09/05 00:02:20.468 done. [2024-09-05T00:02:33.550Z] CL2 j> 2024/09/05 00:02:30.725 Writing report data ... [2024-09-05T00:02:34.973Z] CL2 j> 2024/09/05 00:02:34.394 done. [2024-09-05T00:02:46.924Z] CL2 j> 2024/09/05 00:02:44.697 Writing report data ... [2024-09-05T00:02:49.695Z] CL2 j> 2024/09/05 00:02:48.503 done. [2024-09-05T00:02:59.647Z] CL2 j> 2024/09/05 00:02:58.716 Writing report data ... [2024-09-05T00:03:03.140Z] CL2 j> 2024/09/05 00:03:01.499 done. [2024-09-05T00:03:13.130Z] CL2 j> 2024/09/05 00:03:11.702 Writing report data ... [2024-09-05T00:03:17.592Z] CL2 j> 2024/09/05 00:03:16.167 done. [2024-09-05T00:03:27.490Z] CL2 j> 2024/09/05 00:03:26.604 Writing report data ... [2024-09-05T00:03:30.211Z] CL2 j> 2024/09/05 00:03:29.279 done. [2024-09-05T00:03:42.139Z] CL2 j> 2024/09/05 00:03:39.549 Writing report data ... [2024-09-05T00:03:44.791Z] CL2 j> 2024/09/05 00:03:43.944 done. [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - Monitoring Report Summary: [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - o Process CL2 ended with the expected exit code (0) [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - o Process LT2 is still running as expected [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - +------ Step 8 - Stop LT2 process [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - | Kill running processes [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - | Processes: [LT2] [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - | [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - Killing processes: LT2 [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - o Process clean up attempt 1 for LT2 pid 1703446 [2024-09-05T00:03:46.171Z] STF 00:03:45.518 - o Process LT2 pid 1703446 stop() [2024-09-05T00:03:56.053Z] STF 00:03:55.590 - o Process LT2 pid 1703446 terminate() [2024-09-05T00:03:57.358Z] STF 00:03:56.590 - o Process LT2 pid 1703446 killed [2024-09-05T00:03:57.358Z] STF 00:03:56.590 - EXECUTE stage completed [2024-09-05T00:03:57.358Z] STF 00:03:56.912 - [2024-09-05T00:03:57.358Z] STF 00:03:56.912 - ==================== T E A R D O W N ==================== [2024-09-05T00:03:57.358Z] STF 00:03:56.912 - Running teardown: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17254912556877/TestJlmRemoteThreadNoAuth_1/20240904-235038-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-09-05T00:03:57.358Z] STF 00:03:56.969 - TEARDOWN stage completed [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - ===================== R E S U L T S ===================== [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - Stage results: [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - setUp: pass [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - execute: pass [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - teardown: pass [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - [2024-09-05T00:03:57.358Z] STF 00:03:56.974 - Overall result: PASSED [2024-09-05T00:03:57.358Z] ----------------------------------- [2024-09-05T00:03:57.358Z] TestJlmRemoteThreadNoAuth_1_PASSED [2024-09-05T00:03:57.358Z] ----------------------------------- [2024-09-05T00:03:57.358Z] [2024-09-05T00:03:57.358Z] TEST TEARDOWN: [2024-09-05T00:03:57.358Z] Nothing to be done for teardown. [2024-09-05T00:03:57.358Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Thu Sep 5 00:03:56 2024 Epoch Time (ms): 1725494636996