[2025-06-19T01:13:16.678Z] Running test TestJlmRemoteThreadNoAuth_0 ... [2025-06-19T01:13:16.678Z] =============================================== [2025-06-19T01:13:16.678Z] TestJlmRemoteThreadNoAuth_0 Start Time: Thu Jun 19 01:13:15 2025 Epoch Time (ms): 1750295595847 [2025-06-19T01:13:16.678Z] variation: Mode150 [2025-06-19T01:13:16.678Z] JVM_OPTIONS: -XX:+UseCompressedOops [2025-06-19T01:13:16.678Z] { \ [2025-06-19T01:13:16.678Z] echo ""; echo "TEST SETUP:"; \ [2025-06-19T01:13:16.678Z] echo "Nothing to be done for setup."; \ [2025-06-19T01:13:16.678Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0"; \ [2025-06-19T01:13:16.678Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0"; \ [2025-06-19T01:13:16.678Z] echo ""; echo "TESTING:"; \ [2025-06-19T01:13:16.678Z] perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/../../testDependency/system_lib/" -java-args=' -XX:+UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0" -test=TestJlmRemoteThreadNoAuth; \ [2025-06-19T01:13:16.678Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-19T01:13:16.678Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-19T01:13:16.678Z] echo "Nothing to be done for teardown."; \ [2025-06-19T01:13:16.678Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestTargetResult"; [2025-06-19T01:13:16.678Z] [2025-06-19T01:13:16.678Z] TEST SETUP: [2025-06-19T01:13:16.678Z] Nothing to be done for setup. [2025-06-19T01:13:16.678Z] [2025-06-19T01:13:16.678Z] TESTING: [2025-06-19T01:13:16.678Z] STF 01:13:16.053 - ========================= S T F ========================= [2025-06-19T01:13:16.678Z] 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_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0 [2025-06-19T01:13:16.678Z] There is 38684 Mb free [2025-06-19T01:13:16.678Z] STF 01:13:16.121 - ================== G E N E R A T I O N ================== [2025-06-19T01:13:16.678Z] STF 01:13:16.123 - Checking JVM: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image [2025-06-19T01:13:16.678Z] STF 01:13:16.123 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth" [2025-06-19T01:13:16.678Z] 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 [2025-06-19T01:13:21.132Z] GEN 01:13:20.137 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-06-19T01:13:21.132Z] GEN 01:13:20.862 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-06-19T01:13:22.071Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-06-19T01:13:22.071Z] GEN /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-06-19T01:13:22.071Z] GEN /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/STF/stf.core/bin [2025-06-19T01:13:22.071Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-06-19T01:13:22.071Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-06-19T01:13:22.071Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-06-19T01:13:22.071Z] GEN 01:13:21.572 - Using Mode NoOptions. Values = '' [2025-06-19T01:13:22.071Z] GEN 01:13:21.875 - [2025-06-19T01:13:22.071Z] GEN 01:13:21.875 - Test command summary: [2025-06-19T01:13:22.071Z] GEN 01:13:21.875 - Step Stage Command Description [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - -----+--------+-----------------+------------ [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 3 execute Monitor Wait for processes to complete [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 4 execute kill Stop LT1 process [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 7 execute Monitor Wait for processes to complete [2025-06-19T01:13:22.071Z] GEN 01:13:21.876 - 8 execute kill Stop LT2 process [2025-06-19T01:13:22.071Z] STF 01:13:21.922 - [2025-06-19T01:13:22.071Z] STF 01:13:21.922 - Script generation completed [2025-06-19T01:13:22.071Z] STF 01:13:21.922 - [2025-06-19T01:13:22.071Z] STF 01:13:21.922 - [2025-06-19T01:13:22.071Z] STF 01:13:21.922 - ======================= S E T U P ======================= [2025-06-19T01:13:22.071Z] STF 01:13:21.922 - Running setup: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/setUp.pl [2025-06-19T01:13:23.018Z] STF 01:13:22.009 - SETUP stage completed [2025-06-19T01:13:23.018Z] STF 01:13:22.019 - [2025-06-19T01:13:23.018Z] STF 01:13:22.019 - ==================== E X E C U T E - ==================== [2025-06-19T01:13:23.018Z] STF 01:13:22.019 - Running execute: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/execute.pl [2025-06-19T01:13:23.018Z] STF 01:13:22.095 - [2025-06-19T01:13:23.018Z] STF 01:13:22.095 - Java version [2025-06-19T01:13:23.018Z] STF 01:13:22.096 - Running: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -version [2025-06-19T01:13:23.018Z] openjdk version "17.0.16-beta" 2025-07-15 [2025-06-19T01:13:23.018Z] OpenJDK Runtime Environment Temurin-17.0.16+7-202506181933 (build 17.0.16-beta+7-ea) [2025-06-19T01:13:23.018Z] OpenJDK 64-Bit Server VM Temurin-17.0.16+7-202506181933 (build 17.0.16-beta+7-ea, mixed mode, sharing) [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - | Start background process [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - | Mnemonic: LT1 [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - | Echo: ECHO_OFF [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - | Expectation: NEVER [2025-06-19T01:13:23.018Z] STF 01:13:22.207 - | [2025-06-19T01:13:23.019Z] STF 01:13:22.208 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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-06-19T01:13:23.019Z] STF 01:13:22.208 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-06-19T01:13:23.019Z] STF 01:13:22.208 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-06-19T01:13:23.019Z] STF 01:13:22.221 - [2025-06-19T01:13:23.019Z] STF 01:13:22.221 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-06-19T01:13:23.019Z] STF 01:13:22.221 - | Start background process [2025-06-19T01:13:23.019Z] STF 01:13:22.222 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-06-19T01:13:23.019Z] STF 01:13:22.222 - | Mnemonic: CL1 [2025-06-19T01:13:23.019Z] STF 01:13:22.222 - | Echo: ECHO_ON [2025-06-19T01:13:23.019Z] STF 01:13:22.234 - | Expectation: CLEAN_RUN within 30m [2025-06-19T01:13:23.019Z] STF 01:13:22.234 - | [2025-06-19T01:13:23.019Z] STF 01:13:22.234 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-06-19T01:13:23.019Z] STF 01:13:22.234 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-06-19T01:13:23.019Z] STF 01:13:22.234 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-06-19T01:13:23.019Z] STF 01:13:22.235 - [2025-06-19T01:13:23.019Z] STF 01:13:22.235 - +------ Step 3 - Wait for processes to complete [2025-06-19T01:13:23.019Z] STF 01:13:22.235 - | Wait for processes to meet expectations [2025-06-19T01:13:23.019Z] STF 01:13:22.235 - | Processes: [LT1, CL1] [2025-06-19T01:13:23.019Z] STF 01:13:22.235 - | [2025-06-19T01:13:23.019Z] STF 01:13:22.235 - Monitoring processes: CL1 LT1 [2025-06-19T01:13:23.960Z] CL1 j> 2025/06/19 01:13:22.732 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-06-19T01:13:23.960Z] CL1 j> 2025/06/19 01:13:22.983 Attempting to connect [2025-06-19T01:13:23.960Z] CL1 j> 2025/06/19 01:13:23.562 Monitored VM not ready at Jun 19, 2025, 1:13:23 AM (attempt 1, elapsed 526ms). [2025-06-19T01:13:23.960Z] CL1 j> 2025/06/19 01:13:23.562 Waiting 5 secs and trying again... [2025-06-19T01:13:29.378Z] CL1 j> 2025/06/19 01:13:28.573 Attempting to connect [2025-06-19T01:13:31.377Z] CL1 j> 2025/06/19 01:13:30.635 Connection established! [2025-06-19T01:13:33.444Z] CL1 j> 2025/06/19 01:13:32.398 Starting to write data [2025-06-19T01:18:37.108Z] STF 01:18:22.342 - Heartbeat: Process LT1 is still running [2025-06-19T01:21:19.091Z] STF 01:21:03.331 - Monitoring Report Summary: [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - o Process CL1 ended with the expected exit code (0) [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - o Process LT1 is still running as expected [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - +------ Step 4 - Stop LT1 process [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - | Kill running processes [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - | Processes: [LT1] [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - | [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - Killing processes: LT1 [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - o Process clean up attempt 1 for LT1 pid 2785221 [2025-06-19T01:21:19.091Z] STF 01:21:03.332 - o Process LT1 pid 2785221 stop() [2025-06-19T01:21:19.091Z] STF 01:21:13.378 - o Process LT1 pid 2785221 terminate() [2025-06-19T01:21:19.091Z] STF 01:21:14.378 - o Process LT1 pid 2785221 killed [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - | Start background process [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - | Mnemonic: LT2 [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - | Echo: ECHO_OFF [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - | Expectation: NEVER [2025-06-19T01:21:19.091Z] STF 01:21:14.379 - | [2025-06-19T01:21:19.092Z] STF 01:21:14.379 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-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-06-19T01:21:19.092Z] STF 01:21:14.379 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-06-19T01:21:19.092Z] STF 01:21:14.379 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - | Start background process [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - | Program: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - | Mnemonic: CL2 [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - | Echo: ECHO_ON [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - | Expectation: CLEAN_RUN within 30m [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - | [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - Running command: /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_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_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-06-19T01:21:19.092Z] STF 01:21:14.381 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-06-19T01:21:19.093Z] STF 01:21:14.381 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-06-19T01:21:19.093Z] STF 01:21:14.386 - [2025-06-19T01:21:19.093Z] STF 01:21:14.386 - +------ Step 7 - Wait for processes to complete [2025-06-19T01:21:19.093Z] STF 01:21:14.386 - | Wait for processes to meet expectations [2025-06-19T01:21:19.093Z] STF 01:21:14.386 - | Processes: [LT2, CL2] [2025-06-19T01:21:19.093Z] STF 01:21:14.386 - | [2025-06-19T01:21:19.093Z] STF 01:21:14.386 - Monitoring processes: CL2 LT2 [2025-06-19T01:21:19.093Z] CL2 j> 2025/06/19 01:21:14.766 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-06-19T01:21:19.093Z] CL2 j> 2025/06/19 01:21:15.059 Attempting to connect [2025-06-19T01:21:19.093Z] CL2 j> 2025/06/19 01:21:15.577 Monitored VM not ready at Jun 19, 2025, 1:21:15 AM (attempt 1, elapsed 471ms). [2025-06-19T01:21:19.093Z] CL2 j> 2025/06/19 01:21:15.577 Waiting 5 secs and trying again... [2025-06-19T01:21:22.214Z] CL2 j> 2025/06/19 01:21:20.622 Attempting to connect [2025-06-19T01:21:23.210Z] CL2 j> 2025/06/19 01:21:22.526 Connection established! [2025-06-19T01:21:39.270Z] CL2 j> 2025/06/19 01:21:37.775 Writing report data ... [2025-06-19T01:22:13.237Z] CL2 j> 2025/06/19 01:22:09.241 done. [2025-06-19T01:22:22.298Z] CL2 j> 2025/06/19 01:22:20.834 Writing report data ... [2025-06-19T01:22:38.562Z] CL2 j> 2025/06/19 01:22:37.452 done. [2025-06-19T01:22:48.522Z] CL2 j> 2025/06/19 01:22:48.052 Writing report data ... [2025-06-19T01:23:02.389Z] CL2 j> 2025/06/19 01:23:01.842 done. [2025-06-19T01:23:14.603Z] CL2 j> 2025/06/19 01:23:12.584 Writing report data ... [2025-06-19T01:23:22.982Z] CL2 j> 2025/06/19 01:23:22.244 done. [2025-06-19T01:23:22.982Z] STF 01:23:22.270 - Heartbeat: Process CL2 is still running [2025-06-19T01:23:35.087Z] CL2 j> 2025/06/19 01:23:33.483 Writing report data ... [2025-06-19T01:23:45.032Z] CL2 j> 2025/06/19 01:23:44.246 done. [2025-06-19T01:23:56.027Z] CL2 j> 2025/06/19 01:23:54.877 Writing report data ... [2025-06-19T01:24:09.967Z] CL2 j> 2025/06/19 01:24:08.162 done. [2025-06-19T01:24:20.546Z] CL2 j> 2025/06/19 01:24:18.949 Writing report data ... [2025-06-19T01:24:30.543Z] CL2 j> 2025/06/19 01:24:29.412 done. [2025-06-19T01:24:42.447Z] CL2 j> 2025/06/19 01:24:40.273 Writing report data ... [2025-06-19T01:24:50.071Z] CL2 j> 2025/06/19 01:24:47.544 done. [2025-06-19T01:24:58.584Z] CL2 j> 2025/06/19 01:24:57.870 Writing report data ... [2025-06-19T01:25:08.696Z] CL2 j> 2025/06/19 01:25:06.534 done. [2025-06-19T01:25:17.973Z] CL2 j> 2025/06/19 01:25:17.082 Writing report data ... [2025-06-19T01:25:29.798Z] CL2 j> 2025/06/19 01:25:27.310 done. [2025-06-19T01:25:38.562Z] CL2 j> 2025/06/19 01:25:37.802 Writing report data ... [2025-06-19T01:25:45.586Z] CL2 j> 2025/06/19 01:25:44.386 done. [2025-06-19T01:25:55.488Z] CL2 j> 2025/06/19 01:25:54.632 Writing report data ... [2025-06-19T01:26:09.635Z] CL2 j> 2025/06/19 01:26:06.773 done. [2025-06-19T01:26:18.191Z] CL2 j> 2025/06/19 01:26:17.270 Writing report data ... [2025-06-19T01:26:26.587Z] CL2 j> 2025/06/19 01:26:24.753 done. [2025-06-19T01:26:36.740Z] CL2 j> 2025/06/19 01:26:35.142 Writing report data ... [2025-06-19T01:26:44.661Z] CL2 j> 2025/06/19 01:26:43.177 done. [2025-06-19T01:26:54.721Z] CL2 j> 2025/06/19 01:26:53.895 Writing report data ... [2025-06-19T01:27:03.087Z] CL2 j> 2025/06/19 01:27:01.894 done. [2025-06-19T01:27:13.362Z] CL2 j> 2025/06/19 01:27:12.423 Writing report data ... [2025-06-19T01:27:18.979Z] CL2 j> 2025/06/19 01:27:18.354 done. [2025-06-19T01:27:30.867Z] CL2 j> 2025/06/19 01:27:28.558 Writing report data ... [2025-06-19T01:27:39.357Z] CL2 j> 2025/06/19 01:27:37.676 done. [2025-06-19T01:27:49.351Z] CL2 j> 2025/06/19 01:27:48.030 Writing report data ... [2025-06-19T01:27:54.971Z] CL2 j> 2025/06/19 01:27:53.948 done. [2025-06-19T01:28:06.834Z] CL2 j> 2025/06/19 01:28:04.187 Writing report data ... [2025-06-19T01:28:13.837Z] CL2 j> 2025/06/19 01:28:12.365 done. [2025-06-19T01:28:24.147Z] STF 01:28:22.476 - Heartbeat: Process CL2 is still running [2025-06-19T01:28:24.147Z] CL2 j> 2025/06/19 01:28:22.854 Writing report data ... [2025-06-19T01:28:32.407Z] CL2 j> 2025/06/19 01:28:30.621 done. [2025-06-19T01:28:42.328Z] CL2 j> 2025/06/19 01:28:40.874 Writing report data ... [2025-06-19T01:28:50.718Z] CL2 j> 2025/06/19 01:28:48.709 done. [2025-06-19T01:29:00.947Z] CL2 j> 2025/06/19 01:28:58.927 Writing report data ... [2025-06-19T01:29:08.056Z] CL2 j> 2025/06/19 01:29:07.090 done. [2025-06-19T01:29:19.992Z] CL2 j> 2025/06/19 01:29:17.714 Writing report data ... [2025-06-19T01:29:27.838Z] CL2 j> 2025/06/19 01:29:26.965 done. [2025-06-19T01:29:38.026Z] CL2 j> 2025/06/19 01:29:37.322 Writing report data ... [2025-06-19T01:29:46.384Z] CL2 j> 2025/06/19 01:29:44.790 done. [2025-06-19T01:29:56.494Z] CL2 j> 2025/06/19 01:29:54.992 Writing report data ... [2025-06-19T01:30:02.099Z] CL2 j> 2025/06/19 01:30:01.690 done. [2025-06-19T01:30:14.370Z] CL2 j> 2025/06/19 01:30:11.894 Writing report data ... [2025-06-19T01:30:21.228Z] CL2 j> 2025/06/19 01:30:19.590 done. [2025-06-19T01:30:31.236Z] CL2 j> 2025/06/19 01:30:29.888 Writing report data ... [2025-06-19T01:30:43.167Z] CL2 j> 2025/06/19 01:30:41.576 done. [2025-06-19T01:30:52.307Z] CL2 j> 2025/06/19 01:30:51.977 Writing report data ... [2025-06-19T01:30:59.172Z] CL2 j> 2025/06/19 01:30:57.717 done. [2025-06-19T01:31:09.192Z] CL2 j> 2025/06/19 01:31:07.985 Writing report data ... [2025-06-19T01:31:16.198Z] CL2 j> 2025/06/19 01:31:14.985 done. [2025-06-19T01:31:26.363Z] CL2 j> 2025/06/19 01:31:25.258 Writing report data ... [2025-06-19T01:31:31.919Z] CL2 j> 2025/06/19 01:31:30.934 done. [2025-06-19T01:31:32.942Z] STF 01:31:32.333 - Monitoring Report Summary: [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - o Process CL2 ended with the expected exit code (0) [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - o Process LT2 is still running as expected [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - +------ Step 8 - Stop LT2 process [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - | Kill running processes [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - | Processes: [LT2] [2025-06-19T01:31:32.943Z] STF 01:31:32.333 - | [2025-06-19T01:31:32.943Z] STF 01:31:32.334 - Killing processes: LT2 [2025-06-19T01:31:32.943Z] STF 01:31:32.334 - o Process clean up attempt 1 for LT2 pid 2785650 [2025-06-19T01:31:32.943Z] STF 01:31:32.334 - o Process LT2 pid 2785650 stop() [2025-06-19T01:31:42.915Z] STF 01:31:42.439 - o Process LT2 pid 2785650 terminate() [2025-06-19T01:31:44.827Z] STF 01:31:43.441 - o Process LT2 pid 2785650 killed [2025-06-19T01:31:44.827Z] STF 01:31:43.441 - EXECUTE stage completed [2025-06-19T01:31:44.827Z] STF 01:31:43.755 - [2025-06-19T01:31:44.827Z] STF 01:31:43.755 - ==================== T E A R D O W N ==================== [2025-06-19T01:31:44.827Z] STF 01:31:43.755 - Running teardown: perl /home/jenkins/workspace/Test_openjdk17_hs_sanity.system_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17502889315095/TestJlmRemoteThreadNoAuth_0/20250619-011316-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-06-19T01:31:44.827Z] STF 01:31:43.865 - TEARDOWN stage completed [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - ===================== R E S U L T S ===================== [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - Stage results: [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - setUp: pass [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - execute: pass [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - teardown: pass [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - [2025-06-19T01:31:44.827Z] STF 01:31:43.873 - Overall result: PASSED [2025-06-19T01:31:44.827Z] ----------------------------------- [2025-06-19T01:31:44.827Z] TestJlmRemoteThreadNoAuth_0_PASSED [2025-06-19T01:31:44.827Z] ----------------------------------- [2025-06-19T01:31:44.827Z] [2025-06-19T01:31:44.827Z] TEST TEARDOWN: [2025-06-19T01:31:44.827Z] Nothing to be done for teardown. [2025-06-19T01:31:44.827Z] TestJlmRemoteThreadNoAuth_0 Finish Time: Thu Jun 19 01:31:43 2025 Epoch Time (ms): 1750296704001