[2025-03-29T22:58:59.344Z] Running test TestJlmRemoteThreadNoAuth_0 ... [2025-03-29T22:58:59.344Z] =============================================== [2025-03-29T22:58:59.344Z] TestJlmRemoteThreadNoAuth_0 Start Time: Sat Mar 29 22:58:58 2025 Epoch Time (ms): 1743289138768 [2025-03-29T22:58:59.344Z] variation: Mode150 [2025-03-29T22:58:59.344Z] JVM_OPTIONS: -XX:+UseCompressedOops [2025-03-29T22:58:59.344Z] { \ [2025-03-29T22:58:59.344Z] echo ""; echo "TEST SETUP:"; \ [2025-03-29T22:58:59.344Z] echo "Nothing to be done for setup."; \ [2025-03-29T22:58:59.344Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0"; \ [2025-03-29T22:58:59.344Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0"; \ [2025-03-29T22:58:59.344Z] echo ""; echo "TESTING:"; \ [2025-03-29T22:58:59.344Z] perl /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/../../testDependency/system_lib/" -java-args=' -XX:+UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0" -test=TestJlmRemoteThreadNoAuth; \ [2025-03-29T22:58:59.344Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-29T22:58:59.344Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-29T22:58:59.344Z] echo "Nothing to be done for teardown."; \ [2025-03-29T22:58:59.344Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestTargetResult"; [2025-03-29T22:58:59.344Z] [2025-03-29T22:58:59.344Z] TEST SETUP: [2025-03-29T22:58:59.344Z] Nothing to be done for setup. [2025-03-29T22:58:59.344Z] [2025-03-29T22:58:59.344Z] TESTING: [2025-03-29T22:58:59.344Z] STF 22:58:58.884 - ========================= S T F ========================= [2025-03-29T22:58:59.344Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0 [2025-03-29T22:58:59.344Z] There is 29596 Mb free [2025-03-29T22:58:59.344Z] STF 22:58:58.899 - ================== G E N E R A T I O N ================== [2025-03-29T22:58:59.344Z] STF 22:58:58.901 - Checking JVM: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image [2025-03-29T22:58:59.344Z] STF 22:58:58.901 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -Dload.agent.path=/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth" [2025-03-29T22:59:00.940Z] GEN 22:59:00.243 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-03-29T22:59:00.940Z] GEN 22:59:00.264 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-03-29T22:59:00.940Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-03-29T22:59:00.940Z] GEN /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-03-29T22:59:00.940Z] GEN /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.core/bin [2025-03-29T22:59:00.940Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2025-03-29T22:59:00.940Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2025-03-29T22:59:00.940Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2025-03-29T22:59:00.940Z] GEN 22:59:00.500 - Using Mode NoOptions. Values = '' [2025-03-29T22:59:00.940Z] GEN 22:59:00.625 - [2025-03-29T22:59:00.940Z] GEN 22:59:00.625 - Test command summary: [2025-03-29T22:59:00.940Z] GEN 22:59:00.625 - Step Stage Command Description [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - -----+--------+-----------------+------------ [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 3 execute Monitor Wait for processes to complete [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 4 execute kill Stop LT1 process [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 7 execute Monitor Wait for processes to complete [2025-03-29T22:59:00.940Z] GEN 22:59:00.626 - 8 execute kill Stop LT2 process [2025-03-29T22:59:00.940Z] STF 22:59:00.677 - [2025-03-29T22:59:00.940Z] STF 22:59:00.677 - Script generation completed [2025-03-29T22:59:00.940Z] STF 22:59:00.677 - [2025-03-29T22:59:00.940Z] STF 22:59:00.677 - [2025-03-29T22:59:00.940Z] STF 22:59:00.678 - ======================= S E T U P ======================= [2025-03-29T22:59:00.940Z] STF 22:59:00.678 - Running setup: perl /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/setUp.pl [2025-03-29T22:59:00.940Z] STF 22:59:00.766 - SETUP stage completed [2025-03-29T22:59:00.940Z] STF 22:59:00.775 - [2025-03-29T22:59:00.940Z] STF 22:59:00.775 - ==================== E X E C U T E - ==================== [2025-03-29T22:59:00.940Z] STF 22:59:00.775 - Running execute: perl /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/execute.pl [2025-03-29T22:59:01.728Z] STF 22:59:00.865 - [2025-03-29T22:59:01.728Z] STF 22:59:00.865 - Java version [2025-03-29T22:59:01.728Z] STF 22:59:00.865 - Running: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -version [2025-03-29T22:59:01.728Z] openjdk version "1.8.0_452-beta" [2025-03-29T22:59:01.728Z] OpenJDK Runtime Environment (Temurin)(build 1.8.0_452-beta-202503292104-b07) [2025-03-29T22:59:01.728Z] OpenJDK 64-Bit Server VM (Temurin)(build 25.452-b07, mixed mode) [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - | Start background process [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - | Program: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - | Mnemonic: LT1 [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - | Echo: ECHO_OFF [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - | Expectation: NEVER [2025-03-29T22:59:01.728Z] STF 22:59:00.965 - | [2025-03-29T22:59:01.729Z] STF 22:59:00.966 - Running command: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/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_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/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_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-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_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-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-03-29T22:59:01.729Z] STF 22:59:00.966 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-03-29T22:59:01.729Z] STF 22:59:00.966 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - | Start background process [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - | Program: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - | Mnemonic: CL1 [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - | Echo: ECHO_ON [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - | Expectation: CLEAN_RUN within 30m [2025-03-29T22:59:01.729Z] STF 22:59:00.986 - | [2025-03-29T22:59:01.729Z] STF 22:59:00.987 - Running command: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/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_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-03-29T22:59:01.729Z] STF 22:59:00.987 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-03-29T22:59:01.729Z] STF 22:59:00.987 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-03-29T22:59:01.729Z] STF 22:59:01.007 - [2025-03-29T22:59:01.729Z] STF 22:59:01.008 - +------ Step 3 - Wait for processes to complete [2025-03-29T22:59:01.729Z] STF 22:59:01.008 - | Wait for processes to meet expectations [2025-03-29T22:59:01.729Z] STF 22:59:01.008 - | Processes: [LT1, CL1] [2025-03-29T22:59:01.729Z] STF 22:59:01.008 - | [2025-03-29T22:59:01.729Z] STF 22:59:01.008 - Monitoring processes: CL1 LT1 [2025-03-29T22:59:01.729Z] CL1 j> 2025/03/29 22:59:01.128 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-03-29T22:59:01.729Z] CL1 j> 2025/03/29 22:59:01.159 Attempting to connect [2025-03-29T22:59:01.729Z] CL1 j> 2025/03/29 22:59:01.393 Monitored VM not ready at Mar 29, 2025 10:59:01 PM (attempt 1, elapsed 219ms). [2025-03-29T22:59:01.729Z] CL1 j> 2025/03/29 22:59:01.393 Waiting 5 secs and trying again... [2025-03-29T22:59:07.344Z] CL1 j> 2025/03/29 22:59:06.393 Attempting to connect [2025-03-29T22:59:07.344Z] CL1 j> 2025/03/29 22:59:06.855 Connection established! [2025-03-29T22:59:07.344Z] CL1 j> 2025/03/29 22:59:07.037 Starting to write data [2025-03-29T23:04:02.440Z] STF 23:04:00.086 - Heartbeat: Process LT1 is still running [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - Monitoring Report Summary: [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - o Process CL1 ended with the expected exit code (0) [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - o Process LT1 is still running as expected [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - +------ Step 4 - Stop LT1 process [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - | Kill running processes [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - | Processes: [LT1] [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - | [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - Killing processes: LT1 [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - o Process clean up attempt 1 for LT1 pid 27984222 [2025-03-29T23:04:24.433Z] STF 23:04:22.294 - o Process LT1 pid 27984222 stop() [2025-03-29T23:04:34.278Z] STF 23:04:32.295 - o Process LT1 pid 27984222 terminate() [2025-03-29T23:04:34.278Z] STF 23:04:33.295 - o Process LT1 pid 27984222 killed [2025-03-29T23:04:34.278Z] STF 23:04:33.295 - [2025-03-29T23:04:34.278Z] STF 23:04:33.295 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2025-03-29T23:04:34.278Z] STF 23:04:33.295 - | Start background process [2025-03-29T23:04:34.278Z] STF 23:04:33.296 - | Program: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2025-03-29T23:04:34.278Z] STF 23:04:33.296 - | Mnemonic: LT2 [2025-03-29T23:04:34.278Z] STF 23:04:33.296 - | Echo: ECHO_OFF [2025-03-29T23:04:34.278Z] STF 23:04:33.296 - | Expectation: NEVER [2025-03-29T23:04:34.278Z] STF 23:04:33.296 - | [2025-03-29T23:04:34.279Z] STF 23:04:33.296 - Running command: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/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_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/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_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-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_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-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-03-29T23:04:34.279Z] STF 23:04:33.296 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2025-03-29T23:04:34.279Z] STF 23:04:33.296 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2025-03-29T23:04:34.279Z] STF 23:04:33.302 - [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - | Start background process [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - | Program: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - | Mnemonic: CL2 [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - | Echo: ECHO_ON [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - | Expectation: CLEAN_RUN within 30m [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - | [2025-03-29T23:04:34.279Z] STF 23:04:33.303 - Running command: /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/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_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-03-29T23:04:34.279Z] STF 23:04:33.304 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2025-03-29T23:04:34.279Z] STF 23:04:33.304 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2025-03-29T23:04:34.279Z] STF 23:04:33.309 - [2025-03-29T23:04:34.279Z] STF 23:04:33.310 - +------ Step 7 - Wait for processes to complete [2025-03-29T23:04:34.279Z] STF 23:04:33.310 - | Wait for processes to meet expectations [2025-03-29T23:04:34.279Z] STF 23:04:33.310 - | Processes: [LT2, CL2] [2025-03-29T23:04:34.279Z] STF 23:04:33.310 - | [2025-03-29T23:04:34.279Z] STF 23:04:33.310 - Monitoring processes: CL2 LT2 [2025-03-29T23:04:34.279Z] CL2 j> 2025/03/29 23:04:33.436 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-03-29T23:04:34.279Z] CL2 j> 2025/03/29 23:04:33.470 Attempting to connect [2025-03-29T23:04:34.279Z] CL2 j> 2025/03/29 23:04:33.664 Monitored VM not ready at Mar 29, 2025 11:04:33 PM (attempt 1, elapsed 181ms). [2025-03-29T23:04:34.279Z] CL2 j> 2025/03/29 23:04:33.665 Waiting 5 secs and trying again... [2025-03-29T23:04:39.867Z] CL2 j> 2025/03/29 23:04:38.665 Attempting to connect [2025-03-29T23:04:39.867Z] CL2 j> 2025/03/29 23:04:39.269 Connection established! [2025-03-29T23:04:51.513Z] CL2 j> 2025/03/29 23:04:50.270 Writing report data ... [2025-03-29T23:04:53.100Z] CL2 j> 2025/03/29 23:04:52.536 done. [2025-03-29T23:05:04.750Z] CL2 j> 2025/03/29 23:05:02.604 Writing report data ... [2025-03-29T23:05:04.750Z] CL2 j> 2025/03/29 23:05:03.680 done. [2025-03-29T23:05:14.597Z] CL2 j> 2025/03/29 23:05:13.699 Writing report data ... [2025-03-29T23:05:16.181Z] CL2 j> 2025/03/29 23:05:14.502 done. [2025-03-29T23:05:26.029Z] CL2 j> 2025/03/29 23:05:24.519 Writing report data ... [2025-03-29T23:05:26.029Z] CL2 j> 2025/03/29 23:05:25.103 done. [2025-03-29T23:05:35.876Z] CL2 j> 2025/03/29 23:05:35.125 Writing report data ... [2025-03-29T23:05:36.643Z] CL2 j> 2025/03/29 23:05:35.695 done. [2025-03-29T23:05:48.296Z] CL2 j> 2025/03/29 23:05:45.734 Writing report data ... [2025-03-29T23:05:48.296Z] CL2 j> 2025/03/29 23:05:46.296 done. [2025-03-29T23:05:58.141Z] CL2 j> 2025/03/29 23:05:56.318 Writing report data ... [2025-03-29T23:05:58.141Z] CL2 j> 2025/03/29 23:05:56.832 done. [2025-03-29T23:06:07.984Z] CL2 j> 2025/03/29 23:06:06.847 Writing report data ... [2025-03-29T23:06:07.984Z] CL2 j> 2025/03/29 23:06:07.343 done. [2025-03-29T23:06:17.831Z] CL2 j> 2025/03/29 23:06:17.361 Writing report data ... [2025-03-29T23:06:18.598Z] CL2 j> 2025/03/29 23:06:17.803 done. [2025-03-29T23:06:28.440Z] CL2 j> 2025/03/29 23:06:27.822 Writing report data ... [2025-03-29T23:06:29.208Z] CL2 j> 2025/03/29 23:06:28.267 done. [2025-03-29T23:06:39.053Z] CL2 j> 2025/03/29 23:06:38.281 Writing report data ... [2025-03-29T23:06:39.820Z] CL2 j> 2025/03/29 23:06:38.687 done. [2025-03-29T23:06:49.963Z] CL2 j> 2025/03/29 23:06:48.701 Writing report data ... [2025-03-29T23:06:49.963Z] CL2 j> 2025/03/29 23:06:49.124 done. [2025-03-29T23:07:01.611Z] CL2 j> 2025/03/29 23:06:59.138 Writing report data ... [2025-03-29T23:07:01.611Z] CL2 j> 2025/03/29 23:06:59.559 done. [2025-03-29T23:07:11.458Z] CL2 j> 2025/03/29 23:07:09.603 Writing report data ... [2025-03-29T23:07:11.458Z] CL2 j> 2025/03/29 23:07:10.015 done. [2025-03-29T23:07:21.304Z] CL2 j> 2025/03/29 23:07:20.044 Writing report data ... [2025-03-29T23:07:21.304Z] CL2 j> 2025/03/29 23:07:20.452 done. [2025-03-29T23:07:31.145Z] CL2 j> 2025/03/29 23:07:30.476 Writing report data ... [2025-03-29T23:07:31.913Z] CL2 j> 2025/03/29 23:07:30.886 done. [2025-03-29T23:07:41.760Z] CL2 j> 2025/03/29 23:07:40.906 Writing report data ... [2025-03-29T23:07:42.526Z] CL2 j> 2025/03/29 23:07:41.339 done. [2025-03-29T23:07:52.371Z] CL2 j> 2025/03/29 23:07:51.368 Writing report data ... [2025-03-29T23:07:52.371Z] CL2 j> 2025/03/29 23:07:51.747 done. [2025-03-29T23:08:02.216Z] CL2 j> 2025/03/29 23:08:01.765 Writing report data ... [2025-03-29T23:08:02.983Z] CL2 j> 2025/03/29 23:08:02.155 done. [2025-03-29T23:08:12.826Z] CL2 j> 2025/03/29 23:08:12.188 Writing report data ... [2025-03-29T23:08:13.592Z] CL2 j> 2025/03/29 23:08:12.618 done. [2025-03-29T23:08:23.441Z] CL2 j> 2025/03/29 23:08:22.632 Writing report data ... [2025-03-29T23:08:23.441Z] CL2 j> 2025/03/29 23:08:23.033 done. [2025-03-29T23:08:33.466Z] CL2 j> 2025/03/29 23:08:33.055 Writing report data ... [2025-03-29T23:08:34.234Z] CL2 j> 2025/03/29 23:08:33.456 done. [2025-03-29T23:08:44.080Z] CL2 j> 2025/03/29 23:08:43.470 Writing report data ... [2025-03-29T23:08:44.847Z] CL2 j> 2025/03/29 23:08:43.883 done. [2025-03-29T23:08:56.492Z] CL2 j> 2025/03/29 23:08:53.919 Writing report data ... [2025-03-29T23:08:56.492Z] CL2 j> 2025/03/29 23:08:54.301 done. [2025-03-29T23:09:02.077Z] STF 23:09:00.427 - Heartbeat: Process CL2 is still running [2025-03-29T23:09:05.488Z] CL2 j> 2025/03/29 23:09:04.316 Writing report data ... [2025-03-29T23:09:06.255Z] CL2 j> 2025/03/29 23:09:04.747 done. [2025-03-29T23:09:16.103Z] CL2 j> 2025/03/29 23:09:14.768 Writing report data ... [2025-03-29T23:09:16.103Z] CL2 j> 2025/03/29 23:09:15.162 done. [2025-03-29T23:09:27.752Z] CL2 j> 2025/03/29 23:09:25.178 Writing report data ... [2025-03-29T23:09:27.752Z] CL2 j> 2025/03/29 23:09:25.583 done. [2025-03-29T23:09:37.600Z] CL2 j> 2025/03/29 23:09:35.597 Writing report data ... [2025-03-29T23:09:37.600Z] CL2 j> 2025/03/29 23:09:35.994 done. [2025-03-29T23:09:47.450Z] CL2 j> 2025/03/29 23:09:46.013 Writing report data ... [2025-03-29T23:09:47.450Z] CL2 j> 2025/03/29 23:09:46.465 done. [2025-03-29T23:09:57.296Z] CL2 j> 2025/03/29 23:09:56.482 Writing report data ... [2025-03-29T23:09:57.296Z] CL2 j> 2025/03/29 23:09:56.916 done. [2025-03-29T23:09:58.881Z] STF 23:09:57.941 - Monitoring Report Summary: [2025-03-29T23:09:58.881Z] STF 23:09:57.941 - o Process CL2 ended with the expected exit code (0) [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - o Process LT2 is still running as expected [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - +------ Step 8 - Stop LT2 process [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - | Kill running processes [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - | Processes: [LT2] [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - | [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - Killing processes: LT2 [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - o Process clean up attempt 1 for LT2 pid 27984224 [2025-03-29T23:09:58.881Z] STF 23:09:57.942 - o Process LT2 pid 27984224 stop() [2025-03-29T23:10:08.724Z] STF 23:10:07.943 - o Process LT2 pid 27984224 terminate() [2025-03-29T23:10:09.491Z] STF 23:10:08.943 - o Process LT2 pid 27984224 killed [2025-03-29T23:10:09.491Z] STF 23:10:08.943 - EXECUTE stage completed [2025-03-29T23:10:09.491Z] STF 23:10:09.205 - [2025-03-29T23:10:09.491Z] STF 23:10:09.205 - ==================== T E A R D O W N ==================== [2025-03-29T23:10:09.491Z] STF 23:10:09.205 - Running teardown: perl /home/jenkins/workspace/Test_openjdk8_hs_sanity.system_ppc64_aix/aqa-tests/TKG/../TKG/output_17432848064818/TestJlmRemoteThreadNoAuth_0/20250329-225858-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-03-29T23:10:09.491Z] STF 23:10:09.293 - TEARDOWN stage completed [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - ===================== R E S U L T S ===================== [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - Stage results: [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - setUp: pass [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - execute: pass [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - teardown: pass [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - [2025-03-29T23:10:09.491Z] STF 23:10:09.302 - Overall result: PASSED [2025-03-29T23:10:09.491Z] ----------------------------------- [2025-03-29T23:10:09.491Z] TestJlmRemoteThreadNoAuth_0_PASSED [2025-03-29T23:10:09.491Z] ----------------------------------- [2025-03-29T23:10:09.491Z] [2025-03-29T23:10:09.491Z] TEST TEARDOWN: [2025-03-29T23:10:09.491Z] Nothing to be done for teardown. [2025-03-29T23:10:09.491Z] TestJlmRemoteThreadNoAuth_0 Finish Time: Sat Mar 29 23:10:09 2025 Epoch Time (ms): 1743289809336