[2025-09-25T01:11:03.927Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2025-09-25T01:11:03.927Z] =============================================== [2025-09-25T01:11:03.927Z] TestJlmRemoteThreadNoAuth_1 Start Time: Wed Sep 24 20:11:03 2025 Epoch Time (ms): 1758762663633 [2025-09-25T01:11:03.927Z] variation: Mode650 [2025-09-25T01:11:03.927Z] JVM_OPTIONS: -XX:-UseCompressedOops [2025-09-25T01:11:03.927Z] { \ [2025-09-25T01:11:03.927Z] echo ""; echo "TEST SETUP:"; \ [2025-09-25T01:11:03.927Z] echo "Nothing to be done for setup."; \ [2025-09-25T01:11:03.927Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1"; \ [2025-09-25T01:11:03.927Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1"; \ [2025-09-25T01:11:03.927Z] echo ""; echo "TESTING:"; \ [2025-09-25T01:11:03.927Z] perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/../../externalDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2025-09-25T01:11:03.927Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2025-09-25T01:11:03.927Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-09-25T01:11:03.927Z] echo "Nothing to be done for teardown."; \ [2025-09-25T01:11:03.927Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestTargetResult"; [2025-09-25T01:11:03.927Z] [2025-09-25T01:11:03.927Z] TEST SETUP: [2025-09-25T01:11:03.927Z] Nothing to be done for setup. [2025-09-25T01:11:03.927Z] [2025-09-25T01:11:03.927Z] TESTING: [2025-09-25T01:11:03.927Z] STF 20:11:03.671 - ========================= S T F ========================= [2025-09-25T01:11:03.927Z] systemtest-prereqs has been processed, and set to: /home/jenkins/externalDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1 [2025-09-25T01:11:03.927Z] There is 74506 Mb free [2025-09-25T01:11:03.927Z] STF 20:11:03.674 - ================== G E N E R A T I O N ================== [2025-09-25T01:11:03.927Z] STF 20:11:03.675 - Checking JVM: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image [2025-09-25T01:11:03.927Z] STF 20:11:03.675 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_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_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/../../externalDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/../../externalDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/../../externalDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/../../externalDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth" [2025-09-25T01:11:03.927Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-25T01:11:03.927Z] GEN [0.003s][warning][cds] Archived non-system classes are disabled because the java.system.class.loader property is specified (value = "net.adoptopenjdk.stf.runner.StfClassLoader"). To use archived non-system classes, this property must not be set [2025-09-25T01:11:05.165Z] GEN 20:11:04.841 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2025-09-25T01:11:05.165Z] GEN 20:11:04.847 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2025-09-25T01:11:05.165Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2025-09-25T01:11:05.165Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2025-09-25T01:11:05.165Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/bin [2025-09-25T01:11:05.165Z] GEN /home/jenkins/externalDependency/system_lib/log4j/log4j-api.jar [2025-09-25T01:11:05.165Z] GEN /home/jenkins/externalDependency/system_lib/log4j/log4j-core.jar [2025-09-25T01:11:05.165Z] GEN /home/jenkins/externalDependency/system_lib/junit/junit.jar [2025-09-25T01:11:05.165Z] GEN 20:11:04.959 - Using Mode NoOptions. Values = '' [2025-09-25T01:11:05.165Z] GEN 20:11:05.031 - [2025-09-25T01:11:05.165Z] GEN 20:11:05.032 - Test command summary: [2025-09-25T01:11:05.165Z] GEN 20:11:05.032 - Step Stage Command Description [2025-09-25T01:11:05.165Z] GEN 20:11:05.032 - -----+--------+-----------------+------------ [2025-09-25T01:11:05.165Z] GEN 20:11:05.033 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2025-09-25T01:11:05.165Z] GEN 20:11:05.033 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2025-09-25T01:11:05.165Z] GEN 20:11:05.033 - 3 execute Monitor Wait for processes to complete [2025-09-25T01:11:05.165Z] GEN 20:11:05.033 - 4 execute kill Stop LT1 process [2025-09-25T01:11:05.165Z] GEN 20:11:05.033 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2025-09-25T01:11:05.165Z] GEN 20:11:05.034 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2025-09-25T01:11:05.165Z] GEN 20:11:05.034 - 7 execute Monitor Wait for processes to complete [2025-09-25T01:11:05.165Z] GEN 20:11:05.034 - 8 execute kill Stop LT2 process [2025-09-25T01:11:05.165Z] STF 20:11:05.067 - [2025-09-25T01:11:05.165Z] STF 20:11:05.067 - Script generation completed [2025-09-25T01:11:05.165Z] STF 20:11:05.067 - [2025-09-25T01:11:05.165Z] STF 20:11:05.067 - [2025-09-25T01:11:05.165Z] STF 20:11:05.067 - ======================= S E T U P ======================= [2025-09-25T01:11:05.165Z] STF 20:11:05.067 - Running setup: perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/setUp.pl [2025-09-25T01:11:05.165Z] STF 20:11:05.107 - SETUP stage completed [2025-09-25T01:11:05.165Z] STF 20:11:05.112 - [2025-09-25T01:11:05.165Z] STF 20:11:05.112 - ==================== E X E C U T E - ==================== [2025-09-25T01:11:05.166Z] STF 20:11:05.112 - Running execute: perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/execute.pl [2025-09-25T01:11:05.762Z] STF 20:11:05.148 - [2025-09-25T01:11:05.762Z] STF 20:11:05.148 - Java version [2025-09-25T01:11:05.762Z] STF 20:11:05.148 - Running: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -version [2025-09-25T01:11:05.762Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-25T01:11:05.762Z] openjdk version "21.0.9-beta" 2025-10-21 [2025-09-25T01:11:05.762Z] OpenJDK Runtime Environment Temurin-21.0.9+8-202509241903 (build 21.0.9-beta+8-ea) [2025-09-25T01:11:05.762Z] OpenJDK 64-Bit Server VM Temurin-21.0.9+8-202509241903 (build 21.0.9-beta+8-ea, mixed mode, sharing) [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - | Start background process [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - | Mnemonic: LT1 [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - | Echo: ECHO_OFF [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - | Expectation: NEVER [2025-09-25T01:11:05.762Z] STF 20:11:05.189 - | [2025-09-25T01:11:05.762Z] STF 20:11:05.190 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_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_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/bin:/home/jenkins/externalDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/externalDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/externalDependency/system_lib/asm/asm.jar:/home/jenkins/externalDependency/system_lib/asm/asm-commons.jar:/home/jenkins/externalDependency/system_lib/junit/junit.jar:/home/jenkins/externalDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-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_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-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-09-25T01:11:05.762Z] STF 20:11:05.190 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2025-09-25T01:11:05.762Z] STF 20:11:05.190 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2025-09-25T01:11:05.762Z] STF 20:11:05.195 - [2025-09-25T01:11:05.762Z] STF 20:11:05.195 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2025-09-25T01:11:05.762Z] STF 20:11:05.195 - | Start background process [2025-09-25T01:11:05.762Z] STF 20:11:05.195 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2025-09-25T01:11:05.762Z] STF 20:11:05.195 - | Mnemonic: CL1 [2025-09-25T01:11:05.762Z] STF 20:11:05.195 - | Echo: ECHO_ON [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - | Expectation: CLEAN_RUN within 30m [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - | [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/externalDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - +------ Step 3 - Wait for processes to complete [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - | Wait for processes to meet expectations [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - | Processes: [LT1, CL1] [2025-09-25T01:11:05.762Z] STF 20:11:05.196 - | [2025-09-25T01:11:05.763Z] STF 20:11:05.196 - Monitoring processes: CL1 LT1 [2025-09-25T01:11:05.763Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2025-09-25T01:11:05.763Z] CL1 j> 2025/09/24 20:11:05.443 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2025-09-25T01:11:05.763Z] CL1 j> 2025/09/24 20:11:05.614 Attempting to connect [2025-09-25T01:11:06.353Z] CL1 j> 2025/09/24 20:11:05.796 Monitored VM not ready at Sep 24, 2025, 8:11:05 PM (attempt 1, elapsed 137ms). [2025-09-25T01:11:06.353Z] CL1 j> 2025/09/24 20:11:05.797 Waiting 5 secs and trying again... [2025-09-25T01:11:11.706Z] CL1 j> 2025/09/24 20:11:10.798 Attempting to connect [2025-09-25T01:11:14.487Z] CL1 j> 2025/09/24 20:11:14.274 Monitored VM not ready at Sep 24, 2025, 8:11:14 PM (attempt 2, elapsed 8657ms). [2025-09-25T01:11:14.487Z] CL1 j> 2025/09/24 20:11:14.274 Waiting 5 secs and trying again... [2025-09-25T01:11:20.315Z] CL1 j> 2025/09/24 20:11:19.279 Attempting to connect [2025-09-25T01:11:20.905Z] CL1 j> 2025/09/24 20:11:20.284 Monitored VM not ready at Sep 24, 2025, 8:11:20 PM (attempt 3, elapsed 14668ms). [2025-09-25T01:11:20.905Z] CL1 j> 2025/09/24 20:11:20.284 Waiting 5 secs and trying again... [2025-09-25T01:11:25.696Z] CL1 j> 2025/09/24 20:11:25.302 Attempting to connect [2025-09-25T01:11:27.053Z] CL1 j> 2025/09/24 20:11:26.304 Monitored VM not ready at Sep 24, 2025, 8:11:26 PM (attempt 4, elapsed 20688ms). [2025-09-25T01:11:27.053Z] CL1 j> 2025/09/24 20:11:26.304 Waiting 5 secs and trying again... [2025-09-25T01:11:31.735Z] CL1 j> 2025/09/24 20:11:31.305 Attempting to connect [2025-09-25T01:11:32.987Z] CL1 j> 2025/09/24 20:11:32.324 Monitored VM not ready at Sep 24, 2025, 8:11:32 PM (attempt 5, elapsed 26708ms). [2025-09-25T01:11:32.987Z] CL1 j> 2025/09/24 20:11:32.324 Waiting 5 secs and trying again... [2025-09-25T01:11:38.738Z] CL1 j> 2025/09/24 20:11:37.325 Attempting to connect [2025-09-25T01:11:39.384Z] CL1 j> 2025/09/24 20:11:38.425 Monitored VM not ready at Sep 24, 2025, 8:11:38 PM (attempt 6, elapsed 32809ms). [2025-09-25T01:11:39.384Z] CL1 j> 2025/09/24 20:11:38.425 Waiting 5 secs and trying again... [2025-09-25T01:11:44.008Z] CL1 j> 2025/09/24 20:11:43.426 Attempting to connect [2025-09-25T01:11:45.322Z] CL1 j> 2025/09/24 20:11:44.434 Monitored VM not ready at Sep 24, 2025, 8:11:44 PM (attempt 7, elapsed 38818ms). [2025-09-25T01:11:45.322Z] CL1 j> 2025/09/24 20:11:44.434 Waiting 5 secs and trying again... [2025-09-25T01:11:51.086Z] CL1 j> 2025/09/24 20:11:49.437 Attempting to connect [2025-09-25T01:11:51.676Z] CL1 j> 2025/09/24 20:11:50.483 Monitored VM not ready at Sep 24, 2025, 8:11:50 PM (attempt 8, elapsed 44868ms). [2025-09-25T01:11:51.676Z] CL1 j> 2025/09/24 20:11:50.484 Waiting 5 secs and trying again... [2025-09-25T01:11:56.850Z] CL1 j> 2025/09/24 20:11:55.484 Attempting to connect [2025-09-25T01:11:57.449Z] CL1 j> 2025/09/24 20:11:56.493 Monitored VM not ready at Sep 24, 2025, 8:11:56 PM (attempt 9, elapsed 50878ms). [2025-09-25T01:11:57.449Z] CL1 j> 2025/09/24 20:11:56.494 Waiting 5 secs and trying again... [2025-09-25T01:12:02.207Z] CL1 j> 2025/09/24 20:12:01.498 Attempting to connect [2025-09-25T01:12:02.836Z] CL1 j> 2025/09/24 20:12:02.504 Monitored VM not ready at Sep 24, 2025, 8:12:02 PM (attempt 10, elapsed 56888ms). [2025-09-25T01:12:02.836Z] CL1 j> 2025/09/24 20:12:02.504 Waiting 5 secs and trying again... [2025-09-25T01:12:08.575Z] CL1 j> 2025/09/24 20:12:07.504 Attempting to connect [2025-09-25T01:12:09.192Z] CL1 j> 2025/09/24 20:12:08.519 Monitored VM not ready at Sep 24, 2025, 8:12:08 PM (attempt 11, elapsed 62903ms). [2025-09-25T01:12:09.192Z] CL1 j> 2025/09/24 20:12:08.520 Waiting 5 secs and trying again... [2025-09-25T01:12:14.970Z] CL1 j> 2025/09/24 20:12:13.520 Attempting to connect [2025-09-25T01:12:15.616Z] CL1 j> 2025/09/24 20:12:14.523 Monitored VM not ready at Sep 24, 2025, 8:12:14 PM (attempt 12, elapsed 68908ms). [2025-09-25T01:12:15.616Z] CL1 j> 2025/09/24 20:12:14.524 Waiting 5 secs and trying again... [2025-09-25T01:12:20.285Z] CL1 j> 2025/09/24 20:12:19.530 Attempting to connect [2025-09-25T01:12:21.546Z] CL1 j> 2025/09/24 20:12:20.544 Monitored VM not ready at Sep 24, 2025, 8:12:20 PM (attempt 13, elapsed 74929ms). [2025-09-25T01:12:21.546Z] CL1 j> 2025/09/24 20:12:20.545 Waiting 5 secs and trying again... [2025-09-25T01:12:27.301Z] CL1 j> 2025/09/24 20:12:25.545 Attempting to connect [2025-09-25T01:12:27.301Z] CL1 j> 2025/09/24 20:12:26.554 Monitored VM not ready at Sep 24, 2025, 8:12:26 PM (attempt 14, elapsed 80938ms). [2025-09-25T01:12:27.301Z] CL1 j> 2025/09/24 20:12:26.554 Waiting 5 secs and trying again... [2025-09-25T01:12:33.203Z] CL1 j> 2025/09/24 20:12:31.554 Attempting to connect [2025-09-25T01:12:33.928Z] CL1 j> 2025/09/24 20:12:32.573 Monitored VM not ready at Sep 24, 2025, 8:12:32 PM (attempt 15, elapsed 86958ms). [2025-09-25T01:12:33.928Z] CL1 j> 2025/09/24 20:12:32.574 Waiting 5 secs and trying again... [2025-09-25T01:12:38.704Z] CL1 j> 2025/09/24 20:12:37.582 Attempting to connect [2025-09-25T01:12:40.087Z] CL1 j> 2025/09/24 20:12:38.764 Monitored VM not ready at Sep 24, 2025, 8:12:38 PM (attempt 16, elapsed 93148ms). [2025-09-25T01:12:40.087Z] CL1 j> 2025/09/24 20:12:38.764 Waiting 5 secs and trying again... [2025-09-25T01:12:45.501Z] CL1 j> 2025/09/24 20:12:43.766 Attempting to connect [2025-09-25T01:12:45.501Z] CL1 j> 2025/09/24 20:12:44.824 Monitored VM not ready at Sep 24, 2025, 8:12:44 PM (attempt 17, elapsed 99208ms). [2025-09-25T01:12:45.501Z] CL1 j> 2025/09/24 20:12:44.824 Waiting 5 secs and trying again... [2025-09-25T01:12:51.636Z] CL1 j> 2025/09/24 20:12:49.825 Attempting to connect [2025-09-25T01:12:51.636Z] CL1 j> 2025/09/24 20:12:50.836 Monitored VM not ready at Sep 24, 2025, 8:12:50 PM (attempt 18, elapsed 105220ms). [2025-09-25T01:12:51.636Z] CL1 j> 2025/09/24 20:12:50.837 Waiting 5 secs and trying again... [2025-09-25T01:12:56.561Z] CL1 j> 2025/09/24 20:12:55.837 Attempting to connect [2025-09-25T01:12:57.871Z] CL1 j> 2025/09/24 20:12:56.872 Monitored VM not ready at Sep 24, 2025, 8:12:56 PM (attempt 19, elapsed 111247ms). [2025-09-25T01:12:57.871Z] CL1 j> 2025/09/24 20:12:56.872 Waiting 5 secs and trying again... [2025-09-25T01:13:03.610Z] CL1 j> 2025/09/24 20:13:01.873 Attempting to connect [2025-09-25T01:13:04.232Z] CL1 j> 2025/09/24 20:13:02.890 Monitored VM not ready at Sep 24, 2025, 8:13:02 PM (attempt 20, elapsed 117274ms). [2025-09-25T01:13:04.232Z] CL1 j> 2025/09/24 20:13:02.890 Waiting 5 secs and trying again... [2025-09-25T01:13:09.188Z] CL1 j> 2025/09/24 20:13:07.916 Attempting to connect [2025-09-25T01:13:11.251Z] CL1 j> 2025/09/24 20:13:10.453 Monitored VM not ready at Sep 24, 2025, 8:13:10 PM (attempt 21, elapsed 124837ms). [2025-09-25T01:13:11.251Z] CL1 j> 2025/09/24 20:13:10.454 Waiting 5 secs and trying again... [2025-09-25T01:13:17.146Z] CL1 j> 2025/09/24 20:13:15.472 Attempting to connect [2025-09-25T01:13:17.803Z] CL1 j> 2025/09/24 20:13:16.516 Monitored VM not ready at Sep 24, 2025, 8:13:16 PM (attempt 22, elapsed 130901ms). [2025-09-25T01:13:17.803Z] CL1 j> 2025/09/24 20:13:16.517 Waiting 5 secs and trying again... [2025-09-25T01:13:22.591Z] CL1 j> 2025/09/24 20:13:21.543 Attempting to connect [2025-09-25T01:13:23.891Z] CL1 j> 2025/09/24 20:13:22.834 Monitored VM not ready at Sep 24, 2025, 8:13:22 PM (attempt 23, elapsed 137218ms). [2025-09-25T01:13:23.891Z] CL1 j> 2025/09/24 20:13:22.834 Waiting 5 secs and trying again... [2025-09-25T01:13:28.693Z] CL1 j> 2025/09/24 20:13:27.842 Attempting to connect [2025-09-25T01:13:30.004Z] CL1 j> 2025/09/24 20:13:28.856 Monitored VM not ready at Sep 24, 2025, 8:13:28 PM (attempt 24, elapsed 143240ms). [2025-09-25T01:13:30.004Z] CL1 j> 2025/09/24 20:13:28.857 Waiting 5 secs and trying again... [2025-09-25T01:13:35.230Z] CL1 j> 2025/09/24 20:13:33.860 Attempting to connect [2025-09-25T01:13:35.833Z] CL1 j> 2025/09/24 20:13:34.884 Monitored VM not ready at Sep 24, 2025, 8:13:34 PM (attempt 25, elapsed 149268ms). [2025-09-25T01:13:35.833Z] CL1 j> 2025/09/24 20:13:34.884 Waiting 5 secs and trying again... [2025-09-25T01:13:40.603Z] CL1 j> 2025/09/24 20:13:39.884 Attempting to connect [2025-09-25T01:13:41.926Z] CL1 j> 2025/09/24 20:13:40.894 Monitored VM not ready at Sep 24, 2025, 8:13:40 PM (attempt 26, elapsed 155278ms). [2025-09-25T01:13:41.926Z] CL1 j> 2025/09/24 20:13:40.894 Waiting 5 secs and trying again... [2025-09-25T01:13:47.700Z] CL1 j> 2025/09/24 20:13:45.902 Attempting to connect [2025-09-25T01:13:47.700Z] CL1 j> 2025/09/24 20:13:46.905 Monitored VM not ready at Sep 24, 2025, 8:13:46 PM (attempt 27, elapsed 161289ms). [2025-09-25T01:13:47.700Z] CL1 j> 2025/09/24 20:13:46.905 Waiting 5 secs and trying again... [2025-09-25T01:13:53.647Z] CL1 j> 2025/09/24 20:13:51.922 Attempting to connect [2025-09-25T01:13:53.647Z] CL1 j> 2025/09/24 20:13:52.947 Monitored VM not ready at Sep 24, 2025, 8:13:52 PM (attempt 28, elapsed 167331ms). [2025-09-25T01:13:53.647Z] CL1 j> 2025/09/24 20:13:52.947 Waiting 5 secs and trying again... [2025-09-25T01:13:58.952Z] CL1 j> 2025/09/24 20:13:57.948 Attempting to connect [2025-09-25T01:13:59.666Z] CL1 j> 2025/09/24 20:13:59.014 Monitored VM not ready at Sep 24, 2025, 8:13:59 PM (attempt 29, elapsed 173398ms). [2025-09-25T01:13:59.666Z] CL1 j> 2025/09/24 20:13:59.014 Waiting 5 secs and trying again... [2025-09-25T01:14:04.699Z] CL1 j> 2025/09/24 20:14:04.014 Attempting to connect [2025-09-25T01:14:06.051Z] CL1 j> 2025/09/24 20:14:05.039 Failed to connect to Monitored VM after 30 attempts in 179 seconds - giving up. Connection Exception received is below: [2025-09-25T01:14:06.051Z] CL1 stderr java.rmi.ConnectIOException: Exception creating connection to: 148.100.74.92; nested exception is: [2025-09-25T01:14:06.051Z] CL1 stderr java.net.NoRouteToHostException: No route to host [2025-09-25T01:14:06.051Z] CL1 stderr at java.rmi/sun.rmi.transport.tcp.TCPEndpoint.newSocket(TCPEndpoint.java:637) [2025-09-25T01:14:06.051Z] CL1 stderr at java.rmi/sun.rmi.transport.tcp.TCPChannel.createConnection(TCPChannel.java:217) [2025-09-25T01:14:06.051Z] CL1 stderr at java.rmi/sun.rmi.transport.tcp.TCPChannel.newConnection(TCPChannel.java:204) [2025-09-25T01:14:06.051Z] CL1 stderr at java.rmi/sun.rmi.server.UnicastRef.invoke(UnicastRef.java:134) [2025-09-25T01:14:06.051Z] CL1 stderr at java.management.rmi/javax.management.remote.rmi.RMIServerImpl_Stub.newClient(RMIServerImpl_Stub.java:83) [2025-09-25T01:14:06.052Z] CL1 stderr at java.management.rmi/javax.management.remote.rmi.RMIConnector.getConnection(RMIConnector.java:2106) [2025-09-25T01:14:06.052Z] CL1 stderr at java.management.rmi/javax.management.remote.rmi.RMIConnector.connect(RMIConnector.java:321) [2025-09-25T01:14:06.052Z] CL1 stderr at java.management/javax.management.remote.JMXConnectorFactory.connect(JMXConnectorFactory.java:270) [2025-09-25T01:14:06.052Z] CL1 stderr at java.management/javax.management.remote.JMXConnectorFactory.connect(JMXConnectorFactory.java:229) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ServerConnector.doConnect(ServerConnector.java:276) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ServerConnector.getServerConnection(ServerConnector.java:101) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ServerConnector.<init>(ServerConnector.java:63) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ThreadProfiler.<init>(ThreadProfiler.java:58) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ThreadProfiler.main(ThreadProfiler.java:87) [2025-09-25T01:14:06.052Z] CL1 stderr Caused by: java.net.NoRouteToHostException: No route to host [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/sun.nio.ch.Net.connect0(Native Method) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/sun.nio.ch.Net.connect(Net.java:589) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/sun.nio.ch.Net.connect(Net.java:578) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:583) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/java.net.Socket.connect(Socket.java:751) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/java.net.Socket.connect(Socket.java:686) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/java.net.Socket.<init>(Socket.java:555) [2025-09-25T01:14:06.052Z] CL1 stderr at java.base/java.net.Socket.<init>(Socket.java:324) [2025-09-25T01:14:06.052Z] CL1 stderr at java.rmi/sun.rmi.transport.tcp.TCPDirectSocketFactory.createSocket(TCPDirectSocketFactory.java:40) [2025-09-25T01:14:06.052Z] CL1 stderr at java.rmi/sun.rmi.transport.tcp.TCPEndpoint.newSocket(TCPEndpoint.java:619) [2025-09-25T01:14:06.052Z] CL1 stderr ... 13 more [2025-09-25T01:14:06.052Z] CL1 stderr Exception in thread "main" java.lang.NullPointerException: Cannot invoke "javax.management.MBeanServerConnection.isInstanceOf(javax.management.ObjectName, String)" because "connection" is null [2025-09-25T01:14:06.052Z] CL1 stderr at java.management/java.lang.management.ManagementFactory.isInstanceOf(ManagementFactory.java:656) [2025-09-25T01:14:06.052Z] CL1 stderr at java.management/java.lang.management.ManagementFactory.newPlatformMXBeanProxy(ManagementFactory.java:616) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ThreadProfiler.getStatsViaProxy(ThreadProfiler.java:112) [2025-09-25T01:14:06.052Z] CL1 stderr at net.adoptopenjdk.test.jlm.remote.ThreadProfiler.main(ThreadProfiler.java:97) [2025-09-25T01:14:06.052Z] STF 20:14:05.293 - **FAILED** Process CL1 ended with exit code (1) and not the expected exit code/s (0) [2025-09-25T01:14:06.052Z] STF 20:14:05.293 - Monitoring Report Summary: [2025-09-25T01:14:06.052Z] STF 20:14:05.293 - o Process CL1 ended with exit code (1) and not the expected exit code/s (0) [2025-09-25T01:14:06.052Z] STF 20:14:05.293 - o Process LT1 is still running as expected [2025-09-25T01:14:06.052Z] STF 20:14:05.294 - Killing processes: CL1 LT1 [2025-09-25T01:14:06.052Z] STF 20:14:05.294 - o Process clean up attempt 1 for LT1 pid 9168 [2025-09-25T01:14:06.052Z] STF 20:14:05.294 - o Process LT1 pid 9168 stop() [2025-09-25T01:14:16.893Z] STF 20:14:15.322 - o Process LT1 pid 9168 terminate() [2025-09-25T01:14:16.893Z] STF 20:14:16.322 - o Process LT1 pid 9168 killed [2025-09-25T01:14:16.893Z] STF 20:14:16.323 - o Process CL1 pid 9169 is not running [2025-09-25T01:14:16.893Z] **FAILED** at step 3 (Wait for processes to complete). Expected return value=0 Actual=1 at /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/execute.pl line 161. [2025-09-25T01:14:16.893Z] STF 20:14:16.719 - **FAILED** execute script failed. Expected return value=0 Actual=1 [2025-09-25T01:14:16.893Z] STF 20:14:16.719 - [2025-09-25T01:14:16.893Z] STF 20:14:16.719 - ==================== T E A R D O W N ==================== [2025-09-25T01:14:16.893Z] STF 20:14:16.719 - Running teardown: perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_1758761315871/TestJlmRemoteThreadNoAuth_1/20250924-201103-TestJlmRemoteThreadNoAuth/tearDown.pl [2025-09-25T01:14:16.893Z] STF 20:14:16.777 - TEARDOWN stage completed [2025-09-25T01:14:16.893Z] STF 20:14:16.783 - [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - ===================== R E S U L T S ===================== [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - Stage results: [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - setUp: pass [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - execute: *fail* [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - teardown: pass [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - [2025-09-25T01:14:16.893Z] STF 20:14:16.784 - Overall result: **FAILED** [2025-09-25T01:14:16.893Z] ----------------------------------- [2025-09-25T01:14:16.893Z] TestJlmRemoteThreadNoAuth_1_FAILED [2025-09-25T01:14:16.893Z] ----------------------------------- [2025-09-25T01:14:16.893Z] [2025-09-25T01:14:16.893Z] TEST TEARDOWN: [2025-09-25T01:14:16.893Z] Nothing to be done for teardown. [2025-09-25T01:14:16.893Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Wed Sep 24 20:14:16 2025 Epoch Time (ms): 1758762856799