[2025-04-16T17:07:45.514Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-04-16T17:07:45.514Z] =============================================== [2025-04-16T17:07:45.514Z] TestJlmRemoteThreadNoAuth_1 Start Time: Wed Apr 16 17:07:44 2025 Epoch Time (ms): 1744823264736 [2025-04-16T17:07:45.514Z] variation: Mode650 [2025-04-16T17:07:45.514Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-04-16T17:07:45.514Z] { \ [2025-04-16T17:07:45.514Z] echo ""; echo "TEST SETUP:"; \ [2025-04-16T17:07:45.514Z] echo "Nothing to be done for setup."; \ [2025-04-16T17:07:45.514Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1"; \ [2025-04-16T17:07:45.514Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1"; \ [2025-04-16T17:07:45.514Z] echo ""; echo "TESTING:"; \ [2025-04-16T17:07:45.514Z] perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-04-16T17:07:45.514Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-04-16T17:07:45.514Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-04-16T17:07:45.514Z] echo "Nothing to be done for teardown."; \ [2025-04-16T17:07:45.514Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestTargetResult"; [2025-04-16T17:07:45.514Z] [2025-04-16T17:07:45.514Z] TEST SETUP: [2025-04-16T17:07:45.514Z] Nothing to be done for setup. [2025-04-16T17:07:45.514Z] [2025-04-16T17:07:45.514Z] TESTING: [2025-04-16T17:07:45.514Z] STF 17:07:44.844 - ========================= S T F ========================= [2025-04-16T17:07:45.514Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1 [2025-04-16T17:07:45.514Z] There is 24645 Mb free [2025-04-16T17:07:45.514Z] STF 17:07:44.859 - ================== G E N E R A T I O N ================== [2025-04-16T17:07:45.514Z] STF 17:07:44.860 - Checking JVM: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image [2025-04-16T17:07:45.515Z] STF 17:07:44.861 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth" [2025-04-16T17:07:46.312Z] GEN 17:07:46.083 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-04-16T17:07:46.312Z] GEN 17:07:46.118 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-04-16T17:07:47.103Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-04-16T17:07:47.103Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-04-16T17:07:47.103Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/STF/stf.core/bin [2025-04-16T17:07:47.103Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-04-16T17:07:47.103Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-04-16T17:07:47.103Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-04-16T17:07:47.103Z] GEN 17:07:46.323 - Using Mode NoOptions. Values = '' [2025-04-16T17:07:47.103Z] GEN 17:07:46.448 - [2025-04-16T17:07:47.103Z] GEN 17:07:46.448 - Test command summary: [2025-04-16T17:07:47.103Z] GEN 17:07:46.448 - Step Stage Command Description [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - -----+--------+-----------------+------------ [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 3 execute Monitor Wait for processes to complete [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 4 execute kill Stop LT1 process [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 7 execute Monitor Wait for processes to complete [2025-04-16T17:07:47.103Z] GEN 17:07:46.449 - 8 execute kill Stop LT2 process [2025-04-16T17:07:47.103Z] STF 17:07:46.499 - [2025-04-16T17:07:47.103Z] STF 17:07:46.499 - Script generation completed [2025-04-16T17:07:47.103Z] STF 17:07:46.499 - [2025-04-16T17:07:47.103Z] STF 17:07:46.500 - [2025-04-16T17:07:47.103Z] STF 17:07:46.500 - ======================= S E T U P ======================= [2025-04-16T17:07:47.103Z] STF 17:07:46.500 - Running setup: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/setUp.pl [2025-04-16T17:07:47.103Z] STF 17:07:46.583 - SETUP stage completed [2025-04-16T17:07:47.103Z] STF 17:07:46.589 - [2025-04-16T17:07:47.103Z] STF 17:07:46.589 - ==================== E X E C U T E - ==================== [2025-04-16T17:07:47.103Z] STF 17:07:46.589 - Running execute: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/execute.pl [2025-04-16T17:07:47.103Z] STF 17:07:46.673 - [2025-04-16T17:07:47.103Z] STF 17:07:46.673 - Java version [2025-04-16T17:07:47.103Z] STF 17:07:46.673 - Running: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java -version [2025-04-16T17:07:47.103Z] openjdk version "11.0.27" 2025-04-15 [2025-04-16T17:07:47.103Z] OpenJDK Runtime Environment Temurin-11.0.27+6 (build 11.0.27+6) [2025-04-16T17:07:47.103Z] OpenJDK 64-Bit Server VM Temurin-11.0.27+6 (build 11.0.27+6, mixed mode) [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - | Start background process [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - | Mnemonic: LT1 [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - | Echo: ECHO_OFF [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - | Expectation: NEVER [2025-04-16T17:07:47.103Z] STF 17:07:46.784 - | [2025-04-16T17:07:47.104Z] STF 17:07:46.785 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-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-04-16T17:07:47.104Z] STF 17:07:46.785 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-04-16T17:07:47.104Z] STF 17:07:46.785 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - | Start background process [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - | Mnemonic: CL1 [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - | Echo: ECHO_ON [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - | Expectation: CLEAN_RUN within 30m [2025-04-16T17:07:47.104Z] STF 17:07:46.805 - | [2025-04-16T17:07:47.104Z] STF 17:07:46.806 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-04-16T17:07:47.104Z] STF 17:07:46.806 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-04-16T17:07:47.104Z] STF 17:07:46.806 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-04-16T17:07:47.104Z] STF 17:07:46.812 - [2025-04-16T17:07:47.104Z] STF 17:07:46.812 - +------ Step 3 - Wait for processes to complete [2025-04-16T17:07:47.104Z] STF 17:07:46.812 - | Wait for processes to meet expectations [2025-04-16T17:07:47.104Z] STF 17:07:46.812 - | Processes: [LT1, CL1] [2025-04-16T17:07:47.104Z] STF 17:07:46.812 - | [2025-04-16T17:07:47.104Z] STF 17:07:46.812 - Monitoring processes: CL1 LT1 [2025-04-16T17:07:47.895Z] CL1 j> 2025/04/16 17:07:47.077 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-04-16T17:07:47.895Z] CL1 j> 2025/04/16 17:07:47.218 Attempting to connect [2025-04-16T17:07:47.895Z] CL1 j> 2025/04/16 17:07:47.382 Monitored VM not ready at Apr 16, 2025, 5:07:47 PM (attempt 1, elapsed 147ms). [2025-04-16T17:07:47.895Z] CL1 j> 2025/04/16 17:07:47.382 Waiting 5 secs and trying again... [2025-04-16T17:07:53.698Z] CL1 j> 2025/04/16 17:07:52.383 Attempting to connect [2025-04-16T17:07:53.698Z] CL1 j> 2025/04/16 17:07:52.589 Connection established! [2025-04-16T17:07:53.698Z] CL1 j> 2025/04/16 17:07:52.728 Starting to write data [2025-04-16T17:12:49.605Z] STF 17:12:46.408 - Heartbeat: Process CL1 is still running [2025-04-16T17:13:12.676Z] STF 17:13:12.131 - Monitoring Report Summary: [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - o Process CL1 ended with the expected exit code (0) [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - o Process LT1 is still running as expected [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - +------ Step 4 - Stop LT1 process [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - | Kill running processes [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - | Processes: [LT1] [2025-04-16T17:13:12.676Z] STF 17:13:12.132 - | [2025-04-16T17:13:12.676Z] STF 17:13:12.133 - Killing processes: LT1 [2025-04-16T17:13:12.676Z] STF 17:13:12.133 - o Process clean up attempt 1 for LT1 pid 25297318 [2025-04-16T17:13:12.676Z] STF 17:13:12.133 - o Process LT1 pid 25297318 stop() [2025-04-16T17:13:22.742Z] STF 17:13:22.132 - o Process LT1 pid 25297318 terminate() [2025-04-16T17:13:23.533Z] STF 17:13:23.132 - o Process LT1 pid 25297318 killed [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - | Start background process [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - | Mnemonic: LT2 [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - | Echo: ECHO_OFF [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - | Expectation: NEVER [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - | [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-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-04-16T17:13:23.533Z] STF 17:13:23.133 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-04-16T17:13:23.533Z] STF 17:13:23.133 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - | Start background process [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - | Mnemonic: CL2 [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - | Echo: ECHO_ON [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - | Expectation: CLEAN_RUN within 30m [2025-04-16T17:13:23.533Z] STF 17:13:23.140 - | [2025-04-16T17:13:23.533Z] STF 17:13:23.141 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/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_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-04-16T17:13:23.533Z] STF 17:13:23.141 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-04-16T17:13:23.533Z] STF 17:13:23.141 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-04-16T17:13:23.533Z] STF 17:13:23.147 - [2025-04-16T17:13:23.533Z] STF 17:13:23.147 - +------ Step 7 - Wait for processes to complete [2025-04-16T17:13:23.533Z] STF 17:13:23.147 - | Wait for processes to meet expectations [2025-04-16T17:13:23.533Z] STF 17:13:23.147 - | Processes: [LT2, CL2] [2025-04-16T17:13:23.533Z] STF 17:13:23.147 - | [2025-04-16T17:13:23.533Z] STF 17:13:23.148 - Monitoring processes: CL2 LT2 [2025-04-16T17:13:25.199Z] CL2 j> 2025/04/16 17:13:23.674 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-04-16T17:13:25.199Z] CL2 j> 2025/04/16 17:13:23.984 Attempting to connect [2025-04-16T17:13:25.199Z] CL2 j> 2025/04/16 17:13:24.295 Monitored VM not ready at Apr 16, 2025, 5:13:24 PM (attempt 1, elapsed 284ms). [2025-04-16T17:13:25.199Z] CL2 j> 2025/04/16 17:13:24.295 Waiting 5 secs and trying again... [2025-04-16T17:13:29.769Z] CL2 j> 2025/04/16 17:13:29.295 Attempting to connect [2025-04-16T17:13:30.560Z] CL2 j> 2025/04/16 17:13:29.614 Connection established! [2025-04-16T17:13:40.620Z] CL2 j> 2025/04/16 17:13:40.001 Writing report data ... [2025-04-16T17:13:42.253Z] CL2 j> 2025/04/16 17:13:41.361 done. [2025-04-16T17:13:52.315Z] CL2 j> 2025/04/16 17:13:51.390 Writing report data ... [2025-04-16T17:13:53.105Z] CL2 j> 2025/04/16 17:13:52.019 done. [2025-04-16T17:14:03.162Z] CL2 j> 2025/04/16 17:14:02.033 Writing report data ... [2025-04-16T17:14:03.162Z] CL2 j> 2025/04/16 17:14:02.454 done. [2025-04-16T17:14:13.254Z] CL2 j> 2025/04/16 17:14:12.468 Writing report data ... [2025-04-16T17:14:14.045Z] CL2 j> 2025/04/16 17:14:12.934 done. [2025-04-16T17:14:24.113Z] CL2 j> 2025/04/16 17:14:22.957 Writing report data ... [2025-04-16T17:14:24.904Z] CL2 j> 2025/04/16 17:14:23.304 done. [2025-04-16T17:14:34.963Z] CL2 j> 2025/04/16 17:14:33.319 Writing report data ... [2025-04-16T17:14:34.963Z] CL2 j> 2025/04/16 17:14:33.873 done. [2025-04-16T17:14:45.018Z] CL2 j> 2025/04/16 17:14:43.885 Writing report data ... [2025-04-16T17:14:45.811Z] CL2 j> 2025/04/16 17:14:44.457 done. [2025-04-16T17:14:55.137Z] CL2 j> 2025/04/16 17:14:54.478 Writing report data ... [2025-04-16T17:14:55.927Z] CL2 j> 2025/04/16 17:14:54.980 done. [2025-04-16T17:15:05.990Z] CL2 j> 2025/04/16 17:15:04.993 Writing report data ... [2025-04-16T17:15:05.990Z] CL2 j> 2025/04/16 17:15:05.316 done. [2025-04-16T17:15:16.043Z] CL2 j> 2025/04/16 17:15:15.336 Writing report data ... [2025-04-16T17:15:16.839Z] CL2 j> 2025/04/16 17:15:15.736 done. [2025-04-16T17:15:26.900Z] CL2 j> 2025/04/16 17:15:25.749 Writing report data ... [2025-04-16T17:15:26.900Z] CL2 j> 2025/04/16 17:15:26.134 done. [2025-04-16T17:15:36.958Z] CL2 j> 2025/04/16 17:15:36.145 Writing report data ... [2025-04-16T17:15:37.747Z] CL2 j> 2025/04/16 17:15:36.626 done. [2025-04-16T17:15:47.806Z] CL2 j> 2025/04/16 17:15:46.646 Writing report data ... [2025-04-16T17:15:47.806Z] CL2 j> 2025/04/16 17:15:47.113 done. [2025-04-16T17:15:58.025Z] CL2 j> 2025/04/16 17:15:57.134 Writing report data ... [2025-04-16T17:15:58.815Z] CL2 j> 2025/04/16 17:15:57.569 done. [2025-04-16T17:16:08.888Z] CL2 j> 2025/04/16 17:16:07.580 Writing report data ... [2025-04-16T17:16:08.888Z] CL2 j> 2025/04/16 17:16:08.101 done. [2025-04-16T17:16:19.521Z] CL2 j> 2025/04/16 17:16:18.122 Writing report data ... [2025-04-16T17:16:19.521Z] CL2 j> 2025/04/16 17:16:18.555 done. [2025-04-16T17:16:29.587Z] CL2 j> 2025/04/16 17:16:28.566 Writing report data ... [2025-04-16T17:16:30.377Z] CL2 j> 2025/04/16 17:16:28.972 done. [2025-04-16T17:16:40.436Z] CL2 j> 2025/04/16 17:16:38.981 Writing report data ... [2025-04-16T17:16:40.436Z] CL2 j> 2025/04/16 17:16:39.283 done. [2025-04-16T17:16:50.498Z] CL2 j> 2025/04/16 17:16:49.302 Writing report data ... [2025-04-16T17:16:50.498Z] CL2 j> 2025/04/16 17:16:49.684 done. [2025-04-16T17:17:00.561Z] CL2 j> 2025/04/16 17:16:59.694 Writing report data ... [2025-04-16T17:17:00.561Z] CL2 j> 2025/04/16 17:17:00.053 done. [2025-04-16T17:17:10.616Z] CL2 j> 2025/04/16 17:17:10.072 Writing report data ... [2025-04-16T17:17:11.409Z] CL2 j> 2025/04/16 17:17:10.654 done. [2025-04-16T17:17:21.473Z] CL2 j> 2025/04/16 17:17:20.664 Writing report data ... [2025-04-16T17:17:22.264Z] CL2 j> 2025/04/16 17:17:21.001 done. [2025-04-16T17:17:32.351Z] CL2 j> 2025/04/16 17:17:31.010 Writing report data ... [2025-04-16T17:17:32.351Z] CL2 j> 2025/04/16 17:17:31.372 done. [2025-04-16T17:17:42.603Z] CL2 j> 2025/04/16 17:17:41.391 Writing report data ... [2025-04-16T17:17:42.603Z] CL2 j> 2025/04/16 17:17:41.822 done. [2025-04-16T17:17:47.170Z] STF 17:17:46.002 - Heartbeat: Process LT2 is still running [2025-04-16T17:17:53.456Z] CL2 j> 2025/04/16 17:17:51.831 Writing report data ... [2025-04-16T17:17:53.456Z] CL2 j> 2025/04/16 17:17:52.297 done. [2025-04-16T17:18:03.569Z] CL2 j> 2025/04/16 17:18:02.307 Writing report data ... [2025-04-16T17:18:04.360Z] CL2 j> 2025/04/16 17:18:02.801 done. [2025-04-16T17:18:14.449Z] CL2 j> 2025/04/16 17:18:12.820 Writing report data ... [2025-04-16T17:18:14.449Z] CL2 j> 2025/04/16 17:18:13.157 done. [2025-04-16T17:18:24.509Z] CL2 j> 2025/04/16 17:18:23.166 Writing report data ... [2025-04-16T17:18:24.509Z] CL2 j> 2025/04/16 17:18:23.587 done. [2025-04-16T17:18:34.591Z] CL2 j> 2025/04/16 17:18:33.596 Writing report data ... [2025-04-16T17:18:35.382Z] CL2 j> 2025/04/16 17:18:33.937 done. [2025-04-16T17:18:45.444Z] CL2 j> 2025/04/16 17:18:43.951 Writing report data ... [2025-04-16T17:18:45.444Z] CL2 j> 2025/04/16 17:18:44.272 done. [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - Monitoring Report Summary: [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - o Process CL2 ended with the expected exit code (0) [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - o Process LT2 is still running as expected [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - +------ Step 8 - Stop LT2 process [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - | Kill running processes [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - | Processes: [LT2] [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - | [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - Killing processes: LT2 [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - o Process clean up attempt 1 for LT2 pid 25297320 [2025-04-16T17:18:46.235Z] STF 17:18:45.513 - o Process LT2 pid 25297320 stop() [2025-04-16T17:18:56.294Z] STF 17:18:55.514 - o Process LT2 pid 25297320 terminate() [2025-04-16T17:18:57.084Z] STF 17:18:56.515 - o Process LT2 pid 25297320 killed [2025-04-16T17:18:57.084Z] STF 17:18:56.515 - EXECUTE stage completed [2025-04-16T17:18:57.084Z] STF 17:18:56.908 - [2025-04-16T17:18:57.084Z] STF 17:18:56.908 - ==================== T E A R D O W N ==================== [2025-04-16T17:18:57.084Z] STF 17:18:56.908 - Running teardown: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_ppc64_aix_testList_2/aqa-tests/TKG/../TKG/output_17448211346743/TestJlmRemoteThreadNoAuth_1/20250416-170744-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-04-16T17:18:57.887Z] STF 17:18:57.017 - TEARDOWN stage completed [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - ===================== R E S U L T S ===================== [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - Stage results: [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - setUp: pass [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - execute: pass [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - teardown: pass [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - [2025-04-16T17:18:57.887Z] STF 17:18:57.023 - Overall result: PASSED [2025-04-16T17:18:57.887Z] ----------------------------------- [2025-04-16T17:18:57.887Z] TestJlmRemoteThreadNoAuth_1_PASSED [2025-04-16T17:18:57.887Z] ----------------------------------- [2025-04-16T17:18:57.887Z] [2025-04-16T17:18:57.887Z] TEST TEARDOWN: [2025-04-16T17:18:57.887Z] Nothing to be done for teardown. [2025-04-16T17:18:57.887Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Wed Apr 16 17:18:57 2025 Epoch Time (ms): 1744823937071