[2025-05-23T06:25:28.251Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-05-23T06:25:28.251Z] =============================================== [2025-05-23T06:25:28.251Z] TestJlmRemoteThreadNoAuth_1 Start Time: Fri May 23 06:25:27 2025 Epoch Time (ms): 1747981527529 [2025-05-23T06:25:28.251Z] variation: Mode650 [2025-05-23T06:25:28.251Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-05-23T06:25:28.251Z] { \ [2025-05-23T06:25:28.251Z] echo ""; echo "TEST SETUP:"; \ [2025-05-23T06:25:28.251Z] echo "Nothing to be done for setup."; \ [2025-05-23T06:25:28.251Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1"; \ [2025-05-23T06:25:28.251Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1"; \ [2025-05-23T06:25:28.251Z] echo ""; echo "TESTING:"; \ [2025-05-23T06:25:28.251Z] perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-05-23T06:25:28.251Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-23T06:25:28.251Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-23T06:25:28.251Z] echo "Nothing to be done for teardown."; \ [2025-05-23T06:25:28.251Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestTargetResult"; [2025-05-23T06:25:28.251Z] [2025-05-23T06:25:28.251Z] TEST SETUP: [2025-05-23T06:25:28.251Z] Nothing to be done for setup. [2025-05-23T06:25:28.251Z] [2025-05-23T06:25:28.251Z] TESTING: [2025-05-23T06:25:28.251Z] STF 06:25:27.627 - ========================= S T F ========================= [2025-05-23T06:25:28.251Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1 [2025-05-23T06:25:28.251Z] There is 67055 Mb free [2025-05-23T06:25:28.251Z] STF 06:25:27.635 - ================== G E N E R A T I O N ================== [2025-05-23T06:25:28.251Z] STF 06:25:27.636 - Checking JVM: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image [2025-05-23T06:25:28.251Z] STF 06:25:27.637 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth" [2025-05-23T06:25:28.251Z] GEN [0.013s][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 [2025-05-23T06:25:30.757Z] GEN 06:25:30.162 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-05-23T06:25:30.757Z] GEN 06:25:30.179 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-05-23T06:25:30.757Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-05-23T06:25:30.757Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-05-23T06:25:30.758Z] GEN /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.core/bin [2025-05-23T06:25:30.758Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-05-23T06:25:30.758Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-05-23T06:25:30.758Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-05-23T06:25:30.758Z] GEN 06:25:30.601 - Using Mode NoOptions. Values = '' [2025-05-23T06:25:31.553Z] GEN 06:25:30.851 - [2025-05-23T06:25:31.553Z] GEN 06:25:30.852 - Test command summary: [2025-05-23T06:25:31.553Z] GEN 06:25:30.852 - Step Stage Command Description [2025-05-23T06:25:31.553Z] GEN 06:25:30.857 - -----+--------+-----------------+------------ [2025-05-23T06:25:31.553Z] GEN 06:25:30.857 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-05-23T06:25:31.553Z] GEN 06:25:30.857 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-05-23T06:25:31.553Z] GEN 06:25:30.858 - 3 execute Monitor Wait for processes to complete [2025-05-23T06:25:31.553Z] GEN 06:25:30.859 - 4 execute kill Stop LT1 process [2025-05-23T06:25:31.553Z] GEN 06:25:30.859 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-05-23T06:25:31.553Z] GEN 06:25:30.859 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-05-23T06:25:31.553Z] GEN 06:25:30.859 - 7 execute Monitor Wait for processes to complete [2025-05-23T06:25:31.553Z] GEN 06:25:30.859 - 8 execute kill Stop LT2 process [2025-05-23T06:25:31.553Z] STF 06:25:30.897 - [2025-05-23T06:25:31.553Z] STF 06:25:30.898 - Script generation completed [2025-05-23T06:25:31.553Z] STF 06:25:30.898 - [2025-05-23T06:25:31.553Z] STF 06:25:30.898 - [2025-05-23T06:25:31.553Z] STF 06:25:30.899 - ======================= S E T U P ======================= [2025-05-23T06:25:31.553Z] STF 06:25:30.899 - Running setup: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/setUp.pl [2025-05-23T06:25:31.553Z] STF 06:25:31.031 - SETUP stage completed [2025-05-23T06:25:31.553Z] STF 06:25:31.034 - [2025-05-23T06:25:31.553Z] STF 06:25:31.036 - ==================== E X E C U T E - ==================== [2025-05-23T06:25:31.553Z] STF 06:25:31.036 - Running execute: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/execute.pl [2025-05-23T06:25:31.553Z] STF 06:25:31.172 - [2025-05-23T06:25:31.553Z] STF 06:25:31.172 - Java version [2025-05-23T06:25:31.553Z] STF 06:25:31.172 - Running: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java -version [2025-05-23T06:25:31.553Z] openjdk version "25-beta" 2025-09-16 [2025-05-23T06:25:31.553Z] OpenJDK Runtime Environment Temurin-25+24-202505222037 (build 25-beta+24-ea) [2025-05-23T06:25:31.553Z] OpenJDK 64-Bit Server VM Temurin-25+24-202505222037 (build 25-beta+24-ea, mixed mode, sharing) [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - | Start background process [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - | Mnemonic: LT1 [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - | Echo: ECHO_OFF [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - | Expectation: NEVER [2025-05-23T06:25:31.553Z] STF 06:25:31.306 - | [2025-05-23T06:25:31.553Z] STF 06:25:31.307 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-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/asm/asm.jar:/home/jenkins/testDependency/system_lib/asm/asm-commons.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-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_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2025-05-23T06:25:31.553Z] STF 06:25:31.307 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-05-23T06:25:31.553Z] STF 06:25:31.307 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - | Start background process [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - | Mnemonic: CL1 [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - | Echo: ECHO_ON [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - | Expectation: CLEAN_RUN within 30m [2025-05-23T06:25:31.553Z] STF 06:25:31.337 - | [2025-05-23T06:25:31.553Z] STF 06:25:31.338 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-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_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-05-23T06:25:31.553Z] STF 06:25:31.338 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-05-23T06:25:31.553Z] STF 06:25:31.338 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-05-23T06:25:31.553Z] STF 06:25:31.349 - [2025-05-23T06:25:31.553Z] STF 06:25:31.349 - +------ Step 3 - Wait for processes to complete [2025-05-23T06:25:31.553Z] STF 06:25:31.349 - | Wait for processes to meet expectations [2025-05-23T06:25:31.553Z] STF 06:25:31.349 - | Processes: [LT1, CL1] [2025-05-23T06:25:31.553Z] STF 06:25:31.349 - | [2025-05-23T06:25:31.553Z] STF 06:25:31.349 - Monitoring processes: CL1 LT1 [2025-05-23T06:25:32.333Z] CL1 j> 2025/05/23 06:25:31.694 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-05-23T06:25:32.333Z] CL1 j> 2025/05/23 06:25:31.977 Attempting to connect [2025-05-23T06:25:33.119Z] CL1 j> 2025/05/23 06:25:32.540 Monitored VM not ready at May 23, 2025, 6:25:32 AM (attempt 1, elapsed 481ms). [2025-05-23T06:25:33.119Z] CL1 j> 2025/05/23 06:25:32.540 Waiting 5 secs and trying again... [2025-05-23T06:25:38.850Z] CL1 j> 2025/05/23 06:25:37.561 Attempting to connect [2025-05-23T06:25:39.661Z] CL1 j> 2025/05/23 06:25:38.985 Connection established! [2025-05-23T06:25:41.345Z] CL1 j> 2025/05/23 06:25:40.535 Starting to write data [2025-05-23T06:30:44.824Z] STF 06:30:31.283 - Heartbeat: Process LT1 is still running [2025-05-23T06:34:31.194Z] STF 06:34:20.524 - Monitoring Report Summary: [2025-05-23T06:34:31.195Z] STF 06:34:20.524 - o Process CL1 ended with the expected exit code (0) [2025-05-23T06:34:31.195Z] STF 06:34:20.524 - o Process LT1 is still running as expected [2025-05-23T06:34:31.195Z] STF 06:34:20.524 - [2025-05-23T06:34:31.195Z] STF 06:34:20.524 - +------ Step 4 - Stop LT1 process [2025-05-23T06:34:31.195Z] STF 06:34:20.524 - | Kill running processes [2025-05-23T06:34:31.195Z] STF 06:34:20.524 - | Processes: [LT1] [2025-05-23T06:34:31.195Z] STF 06:34:20.525 - | [2025-05-23T06:34:31.195Z] STF 06:34:20.525 - Killing processes: LT1 [2025-05-23T06:34:31.195Z] STF 06:34:20.525 - o Process clean up attempt 1 for LT1 pid 2914780 [2025-05-23T06:34:31.195Z] STF 06:34:20.525 - o Process LT1 pid 2914780 stop() [2025-05-23T06:34:31.975Z] STF 06:34:30.573 - o Process LT1 pid 2914780 terminate() [2025-05-23T06:34:32.755Z] STF 06:34:31.574 - o Process LT1 pid 2914780 killed [2025-05-23T06:34:32.755Z] STF 06:34:31.575 - [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - | Start background process [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - | Mnemonic: LT2 [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - | Echo: ECHO_OFF [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - | Expectation: NEVER [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - | [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-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/asm/asm.jar:/home/jenkins/testDependency/system_lib/asm/asm-commons.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-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_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/util/util_exclude.xml -suite.mini-mix.threadCount 30 -suite.mini-mix.selection random -suite.mini-mix.seed -1 -suite.mini-mix.repeatCount 1 -suite.mini-mix.thinkingTime 0ms..0ms [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-05-23T06:34:32.756Z] STF 06:34:31.575 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - | Start background process [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - | Program: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - | Mnemonic: CL2 [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - | Echo: ECHO_ON [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - | Expectation: CLEAN_RUN within 30m [2025-05-23T06:34:32.756Z] STF 06:34:31.579 - | [2025-05-23T06:34:32.756Z] STF 06:34:31.584 - Running command: /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-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_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-05-23T06:34:32.756Z] STF 06:34:31.584 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-05-23T06:34:32.756Z] STF 06:34:31.584 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-05-23T06:34:32.756Z] STF 06:34:31.586 - [2025-05-23T06:34:32.756Z] STF 06:34:31.586 - +------ Step 7 - Wait for processes to complete [2025-05-23T06:34:32.756Z] STF 06:34:31.586 - | Wait for processes to meet expectations [2025-05-23T06:34:32.756Z] STF 06:34:31.586 - | Processes: [LT2, CL2] [2025-05-23T06:34:32.756Z] STF 06:34:31.586 - | [2025-05-23T06:34:32.756Z] STF 06:34:31.586 - Monitoring processes: CL2 LT2 [2025-05-23T06:34:32.756Z] CL2 j> 2025/05/23 06:34:31.864 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-05-23T06:34:32.756Z] CL2 j> 2025/05/23 06:34:32.140 Attempting to connect [2025-05-23T06:34:32.756Z] CL2 j> 2025/05/23 06:34:32.509 Monitored VM not ready at May 23, 2025, 6:34:32 AM (attempt 1, elapsed 316ms). [2025-05-23T06:34:32.756Z] CL2 j> 2025/05/23 06:34:32.510 Waiting 5 secs and trying again... [2025-05-23T06:34:38.710Z] CL2 j> 2025/05/23 06:34:37.511 Attempting to connect [2025-05-23T06:34:40.321Z] CL2 j> 2025/05/23 06:34:38.714 Connection established! [2025-05-23T06:34:55.227Z] CL2 j> 2025/05/23 06:34:54.538 Writing report data ... [2025-05-23T06:35:22.133Z] CL2 j> 2025/05/23 06:35:21.321 done. [2025-05-23T06:35:32.230Z] STF 06:35:31.309 - Heartbeat: Process LT2 is still running [2025-05-23T06:35:33.051Z] CL2 j> 2025/05/23 06:35:32.051 Writing report data ... [2025-05-23T06:35:55.933Z] CL2 j> 2025/05/23 06:35:52.834 done. [2025-05-23T06:36:04.858Z] CL2 j> 2025/05/23 06:36:03.557 Writing report data ... [2025-05-23T06:36:22.565Z] CL2 j> 2025/05/23 06:36:20.061 done. [2025-05-23T06:36:31.622Z] CL2 j> 2025/05/23 06:36:30.992 Writing report data ... [2025-05-23T06:36:48.680Z] CL2 j> 2025/05/23 06:36:47.027 done. [2025-05-23T06:36:59.432Z] CL2 j> 2025/05/23 06:36:57.753 Writing report data ... [2025-05-23T06:37:13.892Z] CL2 j> 2025/05/23 06:37:11.709 done. [2025-05-23T06:37:22.989Z] CL2 j> 2025/05/23 06:37:22.163 Writing report data ... [2025-05-23T06:37:40.018Z] CL2 j> 2025/05/23 06:37:38.799 done. [2025-05-23T06:37:50.652Z] CL2 j> 2025/05/23 06:37:49.612 Writing report data ... [2025-05-23T06:38:10.456Z] CL2 j> 2025/05/23 06:38:07.524 done. [2025-05-23T06:38:19.627Z] CL2 j> 2025/05/23 06:38:18.519 Writing report data ... [2025-05-23T06:38:39.960Z] CL2 j> 2025/05/23 06:38:38.235 done. [2025-05-23T06:38:50.798Z] CL2 j> 2025/05/23 06:38:48.636 Writing report data ... [2025-05-23T06:39:07.813Z] CL2 j> 2025/05/23 06:39:06.668 done. [2025-05-23T06:39:18.387Z] CL2 j> 2025/05/23 06:39:17.446 Writing report data ... [2025-05-23T06:39:32.843Z] CL2 j> 2025/05/23 06:39:32.382 done. [2025-05-23T06:39:43.829Z] CL2 j> 2025/05/23 06:39:43.090 Writing report data ... [2025-05-23T06:39:55.975Z] CL2 j> 2025/05/23 06:39:54.910 done. [2025-05-23T06:40:08.038Z] CL2 j> 2025/05/23 06:40:05.703 Writing report data ... [2025-05-23T06:40:22.197Z] CL2 j> 2025/05/23 06:40:21.301 done. [2025-05-23T06:40:32.352Z] STF 06:40:31.263 - Heartbeat: Process LT2 is still running [2025-05-23T06:40:33.193Z] CL2 j> 2025/05/23 06:40:32.085 Writing report data ... [2025-05-23T06:40:46.156Z] CL2 j> 2025/05/23 06:40:44.162 done. [2025-05-23T06:40:56.564Z] CL2 j> 2025/05/23 06:40:54.961 Writing report data ... [2025-05-23T06:41:19.184Z] CL2 j> 2025/05/23 06:41:13.182 done. [2025-05-23T06:41:24.433Z] CL2 j> 2025/05/23 06:41:23.671 Writing report data ... [2025-05-23T06:41:53.371Z] CL2 j> 2025/05/23 06:41:51.995 done. [2025-05-23T06:42:04.507Z] CL2 j> 2025/05/23 06:42:03.001 Writing report data ... [2025-05-23T06:42:19.007Z] CL2 j> 2025/05/23 06:42:16.911 done. [2025-05-23T06:42:28.099Z] CL2 j> 2025/05/23 06:42:27.684 Writing report data ... [2025-05-23T06:42:42.657Z] CL2 j> 2025/05/23 06:42:40.875 done. [2025-05-23T06:42:53.517Z] CL2 j> 2025/05/23 06:42:51.604 Writing report data ... [2025-05-23T06:43:08.940Z] CL2 j> 2025/05/23 06:43:08.064 done. [2025-05-23T06:43:19.981Z] CL2 j> 2025/05/23 06:43:18.687 Writing report data ... [2025-05-23T06:43:37.570Z] CL2 j> 2025/05/23 06:43:36.530 done. [2025-05-23T06:43:48.508Z] CL2 j> 2025/05/23 06:43:47.305 Writing report data ... [2025-05-23T06:44:03.533Z] CL2 j> 2025/05/23 06:44:02.637 done. [2025-05-23T06:44:15.004Z] CL2 j> 2025/05/23 06:44:13.194 Writing report data ... [2025-05-23T06:44:23.913Z] CL2 j> 2025/05/23 06:44:23.296 done. [2025-05-23T06:44:34.783Z] CL2 j> 2025/05/23 06:44:33.908 Writing report data ... [2025-05-23T06:44:47.357Z] CL2 j> 2025/05/23 06:44:45.259 done. [2025-05-23T06:44:56.544Z] CL2 j> 2025/05/23 06:44:55.747 Writing report data ... [2025-05-23T06:45:11.265Z] CL2 j> 2025/05/23 06:45:09.143 done. [2025-05-23T06:45:20.731Z] CL2 j> 2025/05/23 06:45:19.750 Writing report data ... [2025-05-23T06:45:33.017Z] STF 06:45:31.305 - Heartbeat: Process LT2 is still running [2025-05-23T06:45:33.863Z] CL2 j> 2025/05/23 06:45:32.414 done. [2025-05-23T06:45:44.393Z] CL2 j> 2025/05/23 06:45:42.853 Writing report data ... [2025-05-23T06:45:51.756Z] CL2 j> 2025/05/23 06:45:50.483 done. [2025-05-23T06:46:02.277Z] CL2 j> 2025/05/23 06:46:01.141 Writing report data ... [2025-05-23T06:46:17.117Z] CL2 j> 2025/05/23 06:46:14.581 done. [2025-05-23T06:46:26.538Z] CL2 j> 2025/05/23 06:46:24.966 Writing report data ... [2025-05-23T06:46:39.021Z] CL2 j> 2025/05/23 06:46:38.146 done. [2025-05-23T06:46:49.617Z] CL2 j> 2025/05/23 06:46:48.529 Writing report data ... [2025-05-23T06:46:58.817Z] CL2 j> 2025/05/23 06:46:57.695 done. [2025-05-23T06:47:09.496Z] CL2 j> 2025/05/23 06:47:08.087 Writing report data ... [2025-05-23T06:47:21.990Z] CL2 j> 2025/05/23 06:47:19.816 done. [2025-05-23T06:47:31.609Z] CL2 j> 2025/05/23 06:47:30.360 Writing report data ... [2025-05-23T06:47:44.177Z] CL2 j> 2025/05/23 06:47:43.419 done. [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - Monitoring Report Summary: [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - o Process CL2 ended with the expected exit code (0) [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - o Process LT2 is still running as expected [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - +------ Step 8 - Stop LT2 process [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - | Kill running processes [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - | Processes: [LT2] [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - | [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - Killing processes: LT2 [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - o Process clean up attempt 1 for LT2 pid 2915234 [2025-05-23T06:47:46.010Z] STF 06:47:45.163 - o Process LT2 pid 2915234 stop() [2025-05-23T06:47:56.627Z] STF 06:47:55.226 - o Process LT2 pid 2915234 terminate() [2025-05-23T06:47:56.627Z] STF 06:47:56.229 - o Process LT2 pid 2915234 killed [2025-05-23T06:47:56.627Z] STF 06:47:56.229 - EXECUTE stage completed [2025-05-23T06:47:56.627Z] STF 06:47:56.534 - [2025-05-23T06:47:56.627Z] STF 06:47:56.536 - ==================== T E A R D O W N ==================== [2025-05-23T06:47:56.627Z] STF 06:47:56.536 - Running teardown: perl /home/jenkins/workspace/Test_openjdk25_hs_sanity.system_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17479733554813/TestJlmRemoteThreadNoAuth_1/20250523-062527-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-05-23T06:47:57.402Z] STF 06:47:56.729 - TEARDOWN stage completed [2025-05-23T06:47:57.402Z] STF 06:47:56.733 - [2025-05-23T06:47:57.402Z] STF 06:47:56.737 - ===================== R E S U L T S ===================== [2025-05-23T06:47:57.402Z] STF 06:47:56.737 - Stage results: [2025-05-23T06:47:57.402Z] STF 06:47:56.737 - setUp: pass [2025-05-23T06:47:57.402Z] STF 06:47:56.737 - execute: pass [2025-05-23T06:47:57.402Z] STF 06:47:56.737 - teardown: pass [2025-05-23T06:47:57.402Z] STF 06:47:56.737 - [2025-05-23T06:47:57.403Z] STF 06:47:56.737 - Overall result: PASSED [2025-05-23T06:47:57.403Z] ----------------------------------- [2025-05-23T06:47:57.403Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-05-23T06:47:57.403Z] ----------------------------------- [2025-05-23T06:47:57.403Z] [2025-05-23T06:47:57.403Z] TEST TEARDOWN: [2025-05-23T06:47:57.403Z] Nothing to be done for teardown. [2025-05-23T06:47:57.403Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Fri May 23 06:47:56 2025 Epoch Time (ms): 1747982876808