TestJlmRemoteThreadNoAuth_1
[2025-08-01T22:30:54.464Z] Running test TestJlmRemoteThreadNoAuth_1 ...
[2025-08-01T22:30:54.464Z] ===============================================
[2025-08-01T22:30:54.464Z] TestJlmRemoteThreadNoAuth_1 Start Time: Fri Aug 1 22:30:54 2025 Epoch Time (ms): 1754087454048
[2025-08-01T22:30:54.464Z] variation: Mode650
[2025-08-01T22:30:54.464Z] JVM_OPTIONS: -XX:-UseCompressedOops
[2025-08-01T22:30:54.464Z] { \
[2025-08-01T22:30:54.464Z] echo ""; echo "TEST SETUP:"; \
[2025-08-01T22:30:54.464Z] echo "Nothing to be done for setup."; \
[2025-08-01T22:30:54.464Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1"; \
[2025-08-01T22:30:54.464Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1"; \
[2025-08-01T22:30:54.464Z] echo ""; echo "TESTING:"; \
[2025-08-01T22:30:54.464Z] perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \
[2025-08-01T22:30:54.464Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \
[2025-08-01T22:30:54.464Z] echo ""; echo "TEST TEARDOWN:"; \
[2025-08-01T22:30:54.464Z] echo "Nothing to be done for teardown."; \
[2025-08-01T22:30:54.464Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestTargetResult";
[2025-08-01T22:30:54.464Z]
[2025-08-01T22:30:54.464Z] TEST SETUP:
[2025-08-01T22:30:54.464Z] Nothing to be done for setup.
[2025-08-01T22:30:54.464Z]
[2025-08-01T22:30:54.464Z] TESTING:
[2025-08-01T22:30:54.464Z] STF 22:30:54.104 - ========================= S T F =========================
[2025-08-01T22:30:54.464Z] 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_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1
[2025-08-01T22:30:54.464Z] There is 82524 Mb free
[2025-08-01T22:30:54.464Z] STF 22:30:54.108 - ================== G E N E R A T I O N ==================
[2025-08-01T22:30:54.464Z] STF 22:30:54.109 - Checking JVM: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image
[2025-08-01T22:30:54.464Z] STF 22:30:54.109 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../../stf.load/bin/stf.load.jar -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//asm/asm.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//asm/asm-commons.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth"
[2025-08-01T22:30:55.852Z] GEN 22:30:55.715 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin'
[2025-08-01T22:30:55.852Z] GEN 22:30:55.722 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth'
[2025-08-01T22:30:56.513Z] GEN Classpath directories used by project 'openjdk.test.jlm':
[2025-08-01T22:30:56.513Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin
[2025-08-01T22:30:56.513Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/STF/stf.core/bin
[2025-08-01T22:30:56.513Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar
[2025-08-01T22:30:56.513Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar
[2025-08-01T22:30:56.513Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar
[2025-08-01T22:30:56.513Z] GEN 22:30:56.047 - Using Mode NoOptions. Values = ''
[2025-08-01T22:30:56.513Z] GEN 22:30:56.178 -
[2025-08-01T22:30:56.513Z] GEN 22:30:56.179 - Test command summary:
[2025-08-01T22:30:56.513Z] GEN 22:30:56.179 - Step Stage Command Description
[2025-08-01T22:30:56.513Z] GEN 22:30:56.180 - -----+--------+-----------------+------------
[2025-08-01T22:30:56.513Z] GEN 22:30:56.180 - 1 execute Run java Running ThreadProfiler Proxy test Server Process
[2025-08-01T22:30:56.513Z] GEN 22:30:56.180 - 2 execute Run java Running the monitoring Client with proxy connection(without security)
[2025-08-01T22:30:56.513Z] GEN 22:30:56.180 - 3 execute Monitor Wait for processes to complete
[2025-08-01T22:30:56.513Z] GEN 22:30:56.181 - 4 execute kill Stop LT1 process
[2025-08-01T22:30:56.513Z] GEN 22:30:56.181 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security)
[2025-08-01T22:30:56.513Z] GEN 22:30:56.181 - 6 execute Run java Running the Monitoring Client with server-connection(without security)
[2025-08-01T22:30:56.513Z] GEN 22:30:56.182 - 7 execute Monitor Wait for processes to complete
[2025-08-01T22:30:56.513Z] GEN 22:30:56.182 - 8 execute kill Stop LT2 process
[2025-08-01T22:30:56.513Z] STF 22:30:56.224 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.224 - Script generation completed
[2025-08-01T22:30:56.513Z] STF 22:30:56.224 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.225 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.225 - ======================= S E T U P =======================
[2025-08-01T22:30:56.513Z] STF 22:30:56.225 - Running setup: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/setUp.pl
[2025-08-01T22:30:56.513Z] STF 22:30:56.270 - SETUP stage completed
[2025-08-01T22:30:56.513Z] STF 22:30:56.276 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.276 - ==================== E X E C U T E - ====================
[2025-08-01T22:30:56.513Z] STF 22:30:56.276 - Running execute: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/execute.pl
[2025-08-01T22:30:56.513Z] STF 22:30:56.322 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.322 - Java version
[2025-08-01T22:30:56.513Z] STF 22:30:56.322 - Running: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -version
[2025-08-01T22:30:56.513Z] openjdk version "11.0.29-beta" 2025-10-21
[2025-08-01T22:30:56.513Z] OpenJDK Runtime Environment Temurin-11.0.29+1-202508012003 (build 11.0.29-beta+1-ea)
[2025-08-01T22:30:56.513Z] OpenJDK 64-Bit Server VM Temurin-11.0.29+1-202508012003 (build 11.0.29-beta+1-ea, mixed mode)
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - | Start background process
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - | Mnemonic: LT1
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - | Echo: ECHO_OFF
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - | Expectation: NEVER
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - |
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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-08-01T22:30:56.513Z] STF 22:30:56.448 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr
[2025-08-01T22:30:56.513Z] STF 22:30:56.448 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - +------ Step 2 - Running the monitoring Client with proxy connection(without security)
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - | Start background process
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - | Mnemonic: CL1
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - | Echo: ECHO_ON
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - | Expectation: CLEAN_RUN within 30m
[2025-08-01T22:30:56.513Z] STF 22:30:56.455 - |
[2025-08-01T22:30:56.513Z] STF 22:30:56.456 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234
[2025-08-01T22:30:56.513Z] STF 22:30:56.456 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr
[2025-08-01T22:30:56.513Z] STF 22:30:56.456 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout
[2025-08-01T22:30:56.513Z] STF 22:30:56.456 -
[2025-08-01T22:30:56.513Z] STF 22:30:56.456 - +------ Step 3 - Wait for processes to complete
[2025-08-01T22:30:56.513Z] STF 22:30:56.457 - | Wait for processes to meet expectations
[2025-08-01T22:30:56.513Z] STF 22:30:56.457 - | Processes: [LT1, CL1]
[2025-08-01T22:30:56.513Z] STF 22:30:56.457 - |
[2025-08-01T22:30:56.513Z] STF 22:30:56.457 - Monitoring processes: CL1 LT1
[2025-08-01T22:30:57.927Z] CL1 j> 2025/08/01 22:30:56.914 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi
[2025-08-01T22:30:57.927Z] CL1 j> 2025/08/01 22:30:57.308 Attempting to connect
[2025-08-01T22:30:57.927Z] CL1 j> 2025/08/01 22:30:57.671 Monitored VM not ready at Aug 1, 2025, 10:30:57 PM (attempt 1, elapsed 330ms).
[2025-08-01T22:30:57.927Z] CL1 j> 2025/08/01 22:30:57.672 Waiting 5 secs and trying again...
[2025-08-01T22:31:02.975Z] CL1 j> 2025/08/01 22:31:02.679 Attempting to connect
[2025-08-01T22:31:04.390Z] CL1 j> 2025/08/01 22:31:03.530 Connection established!
[2025-08-01T22:31:04.390Z] CL1 j> 2025/08/01 22:31:03.938 Starting to write data
[2025-08-01T22:35:57.070Z] STF 22:35:56.223 - Heartbeat: Process CL1 is still running
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - Monitoring Report Summary:
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - o Process CL1 ended with the expected exit code (0)
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - o Process LT1 is still running as expected
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 -
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - +------ Step 4 - Stop LT1 process
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - | Kill running processes
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - | Processes: [LT1]
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - |
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - Killing processes: LT1
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - o Process clean up attempt 1 for LT1 pid 386353
[2025-08-01T22:36:53.326Z] STF 22:36:47.517 - o Process LT1 pid 386353 stop()
[2025-08-01T22:36:58.589Z] STF 22:36:57.559 - o Process LT1 pid 386353 terminate()
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - o Process LT1 pid 386353 killed
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 -
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security)
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - | Start background process
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - | Mnemonic: LT2
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - | Echo: ECHO_OFF
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - | Expectation: NEVER
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - |
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -javaagent:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-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-08-01T22:36:59.263Z] STF 22:36:58.560 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr
[2025-08-01T22:36:59.263Z] STF 22:36:58.560 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 -
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - +------ Step 6 - Running the Monitoring Client with server-connection(without security)
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - | Start background process
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - | Mnemonic: CL2
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - | Echo: ECHO_ON
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - | Expectation: CLEAN_RUN within 30m
[2025-08-01T22:36:59.263Z] STF 22:36:58.562 - |
[2025-08-01T22:36:59.264Z] STF 22:36:58.562 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_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_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234
[2025-08-01T22:36:59.264Z] STF 22:36:58.562 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr
[2025-08-01T22:36:59.264Z] STF 22:36:58.562 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout
[2025-08-01T22:36:59.264Z] STF 22:36:58.563 -
[2025-08-01T22:36:59.264Z] STF 22:36:58.563 - +------ Step 7 - Wait for processes to complete
[2025-08-01T22:36:59.264Z] STF 22:36:58.563 - | Wait for processes to meet expectations
[2025-08-01T22:36:59.264Z] STF 22:36:58.563 - | Processes: [LT2, CL2]
[2025-08-01T22:36:59.264Z] STF 22:36:58.563 - |
[2025-08-01T22:36:59.264Z] STF 22:36:58.563 - Monitoring processes: CL2 LT2
[2025-08-01T22:36:59.948Z] CL2 j> 2025/08/01 22:36:59.055 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi
[2025-08-01T22:36:59.948Z] CL2 j> 2025/08/01 22:36:59.376 Attempting to connect
[2025-08-01T22:36:59.948Z] CL2 j> 2025/08/01 22:36:59.721 Monitored VM not ready at Aug 1, 2025, 10:36:59 PM (attempt 1, elapsed 325ms).
[2025-08-01T22:36:59.948Z] CL2 j> 2025/08/01 22:36:59.721 Waiting 5 secs and trying again...
[2025-08-01T22:37:05.142Z] CL2 j> 2025/08/01 22:37:04.759 Attempting to connect
[2025-08-01T22:37:06.684Z] CL2 j> 2025/08/01 22:37:06.071 Connection established!
[2025-08-01T22:37:19.640Z] CL2 j> 2025/08/01 22:37:18.503 Writing report data ...
[2025-08-01T22:37:30.838Z] CL2 j> 2025/08/01 22:37:28.679 done.
[2025-08-01T22:37:40.539Z] CL2 j> 2025/08/01 22:37:39.100 Writing report data ...
[2025-08-01T22:37:44.732Z] CL2 j> 2025/08/01 22:37:43.535 done.
[2025-08-01T22:37:54.262Z] CL2 j> 2025/08/01 22:37:53.640 Writing report data ...
[2025-08-01T22:37:58.500Z] CL2 j> 2025/08/01 22:37:57.681 done.
[2025-08-01T22:38:09.800Z] CL2 j> 2025/08/01 22:38:07.931 Writing report data ...
[2025-08-01T22:38:14.034Z] CL2 j> 2025/08/01 22:38:12.111 done.
[2025-08-01T22:38:23.605Z] CL2 j> 2025/08/01 22:38:22.261 Writing report data ...
[2025-08-01T22:38:27.911Z] CL2 j> 2025/08/01 22:38:26.917 done.
[2025-08-01T22:38:39.754Z] CL2 j> 2025/08/01 22:38:37.800 Writing report data ...
[2025-08-01T22:38:41.302Z] CL2 j> 2025/08/01 22:38:40.471 done.
[2025-08-01T22:38:52.409Z] CL2 j> 2025/08/01 22:38:50.723 Writing report data ...
[2025-08-01T22:38:55.591Z] CL2 j> 2025/08/01 22:38:54.163 done.
[2025-08-01T22:39:05.191Z] CL2 j> 2025/08/01 22:39:04.250 Writing report data ...
[2025-08-01T22:39:09.676Z] CL2 j> 2025/08/01 22:39:08.016 done.
[2025-08-01T22:39:19.322Z] CL2 j> 2025/08/01 22:39:18.305 Writing report data ...
[2025-08-01T22:39:23.603Z] CL2 j> 2025/08/01 22:39:22.045 done.
[2025-08-01T22:39:34.889Z] CL2 j> 2025/08/01 22:39:32.420 Writing report data ...
[2025-08-01T22:39:36.377Z] CL2 j> 2025/08/01 22:39:35.544 done.
[2025-08-01T22:39:47.515Z] CL2 j> 2025/08/01 22:39:45.759 Writing report data ...
[2025-08-01T22:39:50.150Z] CL2 j> 2025/08/01 22:39:48.534 done.
[2025-08-01T22:40:01.078Z] CL2 j> 2025/08/01 22:39:58.806 Writing report data ...
[2025-08-01T22:40:01.794Z] CL2 j> 2025/08/01 22:40:01.113 done.
[2025-08-01T22:40:13.032Z] CL2 j> 2025/08/01 22:40:11.290 Writing report data ...
[2025-08-01T22:40:15.332Z] CL2 j> 2025/08/01 22:40:14.366 done.
[2025-08-01T22:40:26.629Z] CL2 j> 2025/08/01 22:40:24.551 Writing report data ...
[2025-08-01T22:40:29.903Z] CL2 j> 2025/08/01 22:40:28.741 done.
[2025-08-01T22:40:40.275Z] CL2 j> 2025/08/01 22:40:39.194 Writing report data ...
[2025-08-01T22:40:43.611Z] CL2 j> 2025/08/01 22:40:42.848 done.
[2025-08-01T22:40:54.740Z] CL2 j> 2025/08/01 22:40:53.263 Writing report data ...
[2025-08-01T22:40:57.072Z] STF 22:40:56.207 - Heartbeat: Process CL2 is still running
[2025-08-01T22:40:57.937Z] CL2 j> 2025/08/01 22:40:57.058 done.
[2025-08-01T22:41:09.284Z] CL2 j> 2025/08/01 22:41:07.923 Writing report data ...
[2025-08-01T22:41:11.716Z] CL2 j> 2025/08/01 22:41:10.842 done.
[2025-08-01T22:41:22.803Z] CL2 j> 2025/08/01 22:41:21.061 Writing report data ...
[2025-08-01T22:41:25.029Z] CL2 j> 2025/08/01 22:41:22.867 done.
[2025-08-01T22:41:35.036Z] CL2 j> 2025/08/01 22:41:33.390 Writing report data ...
[2025-08-01T22:41:35.812Z] CL2 j> 2025/08/01 22:41:34.164 done.
[2025-08-01T22:41:45.496Z] CL2 j> 2025/08/01 22:41:44.348 Writing report data ...
[2025-08-01T22:41:48.736Z] CL2 j> 2025/08/01 22:41:47.792 done.
[2025-08-01T22:42:00.475Z] CL2 j> 2025/08/01 22:41:58.247 Writing report data ...
[2025-08-01T22:42:04.863Z] CL2 j> 2025/08/01 22:42:03.169 done.
[2025-08-01T22:42:16.017Z] CL2 j> 2025/08/01 22:42:13.889 Writing report data ...
[2025-08-01T22:42:17.431Z] CL2 j> 2025/08/01 22:42:16.721 done.
[2025-08-01T22:42:28.833Z] CL2 j> 2025/08/01 22:42:27.016 Writing report data ...
[2025-08-01T22:42:32.089Z] CL2 j> 2025/08/01 22:42:31.588 done.
[2025-08-01T22:42:43.882Z] CL2 j> 2025/08/01 22:42:41.884 Writing report data ...
[2025-08-01T22:42:47.182Z] CL2 j> 2025/08/01 22:42:46.512 done.
[2025-08-01T22:42:57.776Z] CL2 j> 2025/08/01 22:42:56.855 Writing report data ...
[2025-08-01T22:43:02.172Z] CL2 j> 2025/08/01 22:43:00.969 done.
[2025-08-01T22:43:12.115Z] CL2 j> 2025/08/01 22:43:11.238 Writing report data ...
[2025-08-01T22:43:16.324Z] CL2 j> 2025/08/01 22:43:15.215 done.
[2025-08-01T22:43:27.647Z] CL2 j> 2025/08/01 22:43:25.431 Writing report data ...
[2025-08-01T22:43:30.180Z] CL2 j> 2025/08/01 22:43:29.297 done.
[2025-08-01T22:43:41.869Z] CL2 j> 2025/08/01 22:43:39.754 Writing report data ...
[2025-08-01T22:43:46.523Z] CL2 j> 2025/08/01 22:43:44.588 done.
[2025-08-01T22:43:56.247Z] CL2 j> 2025/08/01 22:43:55.142 Writing report data ...
[2025-08-01T22:44:00.485Z] CL2 j> 2025/08/01 22:43:59.398 done.
[2025-08-01T22:44:11.864Z] CL2 j> 2025/08/01 22:44:09.548 Writing report data ...
[2025-08-01T22:44:13.312Z] CL2 j> 2025/08/01 22:44:12.302 done.
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - Monitoring Report Summary:
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - o Process CL2 ended with the expected exit code (0)
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - o Process LT2 is still running as expected
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 -
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - +------ Step 8 - Stop LT2 process
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - | Kill running processes
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - | Processes: [LT2]
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - |
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - Killing processes: LT2
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - o Process clean up attempt 1 for LT2 pid 386876
[2025-08-01T22:44:14.127Z] STF 22:44:13.746 - o Process LT2 pid 386876 stop()
[2025-08-01T22:44:24.147Z] STF 22:44:23.841 - o Process LT2 pid 386876 terminate()
[2025-08-01T22:44:25.532Z] STF 22:44:24.842 - o Process LT2 pid 386876 killed
[2025-08-01T22:44:25.532Z] STF 22:44:24.842 - EXECUTE stage completed
[2025-08-01T22:44:25.532Z] STF 22:44:25.054 -
[2025-08-01T22:44:25.532Z] STF 22:44:25.054 - ==================== T E A R D O W N ====================
[2025-08-01T22:44:25.532Z] STF 22:44:25.054 - Running teardown: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_2/aqa-tests/TKG/../TKG/output_17540850107384/TestJlmRemoteThreadNoAuth_1/20250801-223054-TestJlmRemoteThreadNoAuth/tearDown.pl
[2025-08-01T22:44:25.532Z] STF 22:44:25.187 - TEARDOWN stage completed
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 -
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 - ===================== R E S U L T S =====================
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 - Stage results:
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 - setUp: pass
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 - execute: pass
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 - teardown: pass
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 -
[2025-08-01T22:44:25.532Z] STF 22:44:25.202 - Overall result: PASSED
[2025-08-01T22:44:25.532Z] -----------------------------------
[2025-08-01T22:44:25.532Z] TestJlmRemoteThreadNoAuth_1_PASSED
[2025-08-01T22:44:25.532Z] -----------------------------------
[2025-08-01T22:44:25.532Z]
[2025-08-01T22:44:25.532Z] TEST TEARDOWN:
[2025-08-01T22:44:25.532Z] Nothing to be done for teardown.
[2025-08-01T22:44:25.532Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Fri Aug 1 22:44:25 2025 Epoch Time (ms): 1754088265232