[2024-10-16T02:20:24.086Z] Running test TestJlmRemoteThreadNoAuth_0 ... [2024-10-16T02:20:24.086Z] =============================================== [2024-10-16T02:20:24.086Z] TestJlmRemoteThreadNoAuth_0 Start Time: Wed Oct 16 02:20:24 2024 Epoch Time (ms): 1729045224014 [2024-10-16T02:20:24.647Z] variation: Mode150 [2024-10-16T02:20:24.647Z] JVM_OPTIONS: -XX:+UseCompressedOops [2024-10-16T02:20:24.647Z] { \ [2024-10-16T02:20:24.647Z] echo ""; echo "TEST SETUP:"; \ [2024-10-16T02:20:24.647Z] echo "Nothing to be done for setup."; \ [2024-10-16T02:20:24.647Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0"; \ [2024-10-16T02:20:24.647Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0"; \ [2024-10-16T02:20:24.647Z] echo ""; echo "TESTING:"; \ [2024-10-16T02:20:24.647Z] perl /home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/../../testDependency/system_lib/" -java-args=' -XX:+UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0" -test=TestJlmRemoteThreadNoAuth; \ [2024-10-16T02:20:24.647Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-16T02:20:24.647Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-16T02:20:24.647Z] echo "Nothing to be done for teardown."; \ [2024-10-16T02:20:24.647Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestTargetResult"; [2024-10-16T02:20:24.647Z] [2024-10-16T02:20:24.647Z] TEST SETUP: [2024-10-16T02:20:24.647Z] Nothing to be done for setup. [2024-10-16T02:20:24.647Z] [2024-10-16T02:20:24.647Z] TESTING: [2024-10-16T02:20:24.647Z] STF 02:20:24.190 - ========================= S T F ========================= [2024-10-16T02:20:24.647Z] 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_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0 [2024-10-16T02:20:24.647Z] There is 160601 Mb free [2024-10-16T02:20:24.647Z] STF 02:20:24.204 - ================== G E N E R A T I O N ================== [2024-10-16T02:20:24.647Z] STF 02:20:24.204 - Checking JVM: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image [2024-10-16T02:20:24.647Z] STF 02:20:24.204 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth" [2024-10-16T02:20:30.176Z] GEN 02:20:29.349 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2024-10-16T02:20:30.176Z] GEN 02:20:29.400 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-10-16T02:20:30.754Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-10-16T02:20:30.754Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2024-10-16T02:20:30.754Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/bin [2024-10-16T02:20:30.754Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-10-16T02:20:30.754Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-10-16T02:20:30.754Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2024-10-16T02:20:30.754Z] GEN 02:20:30.390 - Using Mode NoOptions. Values = '' [2024-10-16T02:20:31.337Z] GEN 02:20:31.250 - [2024-10-16T02:20:31.337Z] GEN 02:20:31.250 - Test command summary: [2024-10-16T02:20:31.337Z] GEN 02:20:31.252 - Step Stage Command Description [2024-10-16T02:20:31.337Z] GEN 02:20:31.253 - -----+--------+-----------------+------------ [2024-10-16T02:20:31.337Z] GEN 02:20:31.254 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-10-16T02:20:31.337Z] GEN 02:20:31.254 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-10-16T02:20:31.337Z] GEN 02:20:31.254 - 3 execute Monitor Wait for processes to complete [2024-10-16T02:20:31.337Z] GEN 02:20:31.254 - 4 execute kill Stop LT1 process [2024-10-16T02:20:31.337Z] GEN 02:20:31.255 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-10-16T02:20:31.337Z] GEN 02:20:31.255 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-10-16T02:20:31.337Z] GEN 02:20:31.255 - 7 execute Monitor Wait for processes to complete [2024-10-16T02:20:31.337Z] GEN 02:20:31.255 - 8 execute kill Stop LT2 process [2024-10-16T02:20:31.879Z] STF 02:20:31.499 - [2024-10-16T02:20:31.879Z] STF 02:20:31.499 - Script generation completed [2024-10-16T02:20:31.879Z] STF 02:20:31.499 - [2024-10-16T02:20:31.879Z] STF 02:20:31.549 - [2024-10-16T02:20:31.879Z] STF 02:20:31.549 - ======================= S E T U P ======================= [2024-10-16T02:20:31.879Z] STF 02:20:31.549 - Running setup: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/setUp.pl [2024-10-16T02:20:31.879Z] STF 02:20:31.643 - SETUP stage completed [2024-10-16T02:20:31.879Z] STF 02:20:31.675 - [2024-10-16T02:20:31.879Z] STF 02:20:31.676 - ==================== E X E C U T E - ==================== [2024-10-16T02:20:31.879Z] STF 02:20:31.676 - Running execute: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/execute.pl [2024-10-16T02:20:31.879Z] STF 02:20:31.766 - [2024-10-16T02:20:31.879Z] STF 02:20:31.766 - Java version [2024-10-16T02:20:31.879Z] STF 02:20:31.766 - Running: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -version [2024-10-16T02:20:32.476Z] openjdk version "11.0.25" 2024-10-15 [2024-10-16T02:20:32.476Z] OpenJDK Runtime Environment Temurin-11.0.25+9 (build 11.0.25+9) [2024-10-16T02:20:32.476Z] OpenJDK 64-Bit Server VM Temurin-11.0.25+9 (build 11.0.25+9, mixed mode) [2024-10-16T02:20:32.476Z] STF 02:20:32.325 - [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - | Start background process [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - | Mnemonic: LT1 [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - | Echo: ECHO_OFF [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - | Expectation: NEVER [2024-10-16T02:20:32.476Z] STF 02:20:32.326 - | [2024-10-16T02:20:32.477Z] STF 02:20:32.328 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -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_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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 [2024-10-16T02:20:32.477Z] STF 02:20:32.328 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-10-16T02:20:32.477Z] STF 02:20:32.328 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - | Start background process [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - | Mnemonic: CL1 [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - | Echo: ECHO_ON [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - | Expectation: CLEAN_RUN within 30m [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - | [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-10-16T02:20:32.477Z] STF 02:20:32.345 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-10-16T02:20:32.477Z] STF 02:20:32.346 - [2024-10-16T02:20:32.477Z] STF 02:20:32.346 - +------ Step 3 - Wait for processes to complete [2024-10-16T02:20:32.477Z] STF 02:20:32.346 - | Wait for processes to meet expectations [2024-10-16T02:20:32.477Z] STF 02:20:32.346 - | Processes: [LT1, CL1] [2024-10-16T02:20:32.477Z] STF 02:20:32.346 - | [2024-10-16T02:20:32.477Z] STF 02:20:32.347 - Monitoring processes: CL1 LT1 [2024-10-16T02:20:34.679Z] CL1 j> 2024/10/16 02:20:33.640 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-16T02:20:34.679Z] CL1 j> 2024/10/16 02:20:34.165 Attempting to connect [2024-10-16T02:20:35.545Z] CL1 j> 2024/10/16 02:20:35.069 Monitored VM not ready at Oct 16, 2024, 2:20:35 AM (attempt 1, elapsed 857ms). [2024-10-16T02:20:35.545Z] CL1 j> 2024/10/16 02:20:35.070 Waiting 5 secs and trying again... [2024-10-16T02:20:40.391Z] CL1 j> 2024/10/16 02:20:40.108 Attempting to connect [2024-10-16T02:20:47.457Z] CL1 j> 2024/10/16 02:20:46.988 Connection established! [2024-10-16T02:20:50.356Z] CL1 j> 2024/10/16 02:20:49.430 Starting to write data [2024-10-16T02:25:40.486Z] STF 02:25:31.489 - Heartbeat: Process LT1 is still running [2024-10-16T02:28:12.661Z] STF 02:28:02.334 - Monitoring Report Summary: [2024-10-16T02:28:12.661Z] STF 02:28:02.334 - o Process CL1 ended with the expected exit code (0) [2024-10-16T02:28:12.661Z] STF 02:28:02.334 - o Process LT1 is still running as expected [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - +------ Step 4 - Stop LT1 process [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - | Kill running processes [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - | Processes: [LT1] [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - | [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - Killing processes: LT1 [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - o Process clean up attempt 1 for LT1 pid 3344541 [2024-10-16T02:28:12.661Z] STF 02:28:02.335 - o Process LT1 pid 3344541 stop() [2024-10-16T02:28:13.307Z] STF 02:28:12.471 - o Process LT1 pid 3344541 terminate() [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - o Process LT1 pid 3344541 killed [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - | Start background process [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - | Mnemonic: LT2 [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - | Echo: ECHO_OFF [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - | Expectation: NEVER [2024-10-16T02:28:13.846Z] STF 02:28:13.475 - | [2024-10-16T02:28:13.846Z] STF 02:28:13.476 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -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_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-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 [2024-10-16T02:28:13.846Z] STF 02:28:13.476 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-10-16T02:28:13.846Z] STF 02:28:13.476 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - | Start background process [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - | Mnemonic: CL2 [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - | Echo: ECHO_ON [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - | Expectation: CLEAN_RUN within 30m [2024-10-16T02:28:13.846Z] STF 02:28:13.482 - | [2024-10-16T02:28:13.846Z] STF 02:28:13.483 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:+UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/home/jenkins/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-16T02:28:13.846Z] STF 02:28:13.483 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-10-16T02:28:13.846Z] STF 02:28:13.483 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-10-16T02:28:13.846Z] STF 02:28:13.484 - [2024-10-16T02:28:13.846Z] STF 02:28:13.484 - +------ Step 7 - Wait for processes to complete [2024-10-16T02:28:13.846Z] STF 02:28:13.484 - | Wait for processes to meet expectations [2024-10-16T02:28:13.846Z] STF 02:28:13.484 - | Processes: [LT2, CL2] [2024-10-16T02:28:13.846Z] STF 02:28:13.484 - | [2024-10-16T02:28:13.846Z] STF 02:28:13.484 - Monitoring processes: CL2 LT2 [2024-10-16T02:28:17.429Z] CL2 j> 2024/10/16 02:28:15.275 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-16T02:28:17.429Z] CL2 j> 2024/10/16 02:28:15.990 Attempting to connect [2024-10-16T02:28:17.991Z] CL2 j> 2024/10/16 02:28:17.555 Monitored VM not ready at Oct 16, 2024, 2:28:17 AM (attempt 1, elapsed 1412ms). [2024-10-16T02:28:17.991Z] CL2 j> 2024/10/16 02:28:17.555 Waiting 5 secs and trying again... [2024-10-16T02:28:23.512Z] CL2 j> 2024/10/16 02:28:22.572 Attempting to connect [2024-10-16T02:28:28.768Z] CL2 j> 2024/10/16 02:28:27.685 Connection established! [2024-10-16T02:28:57.816Z] CL2 j> 2024/10/16 02:28:53.799 Writing report data ... [2024-10-16T02:29:32.359Z] CL2 j> 2024/10/16 02:29:29.814 done. [2024-10-16T02:29:42.719Z] CL2 j> 2024/10/16 02:29:41.577 Writing report data ... [2024-10-16T02:29:54.927Z] CL2 j> 2024/10/16 02:29:54.743 done. [2024-10-16T02:30:08.014Z] CL2 j> 2024/10/16 02:30:06.230 Writing report data ... [2024-10-16T02:30:29.516Z] CL2 j> 2024/10/16 02:30:26.371 done. [2024-10-16T02:30:31.561Z] STF 02:30:31.169 - Heartbeat: Process CL2 is still running [2024-10-16T02:30:37.582Z] CL2 j> 2024/10/16 02:30:36.877 Writing report data ... [2024-10-16T02:30:54.768Z] CL2 j> 2024/10/16 02:30:52.511 done. [2024-10-16T02:31:05.250Z] CL2 j> 2024/10/16 02:31:03.350 Writing report data ... [2024-10-16T02:31:16.206Z] CL2 j> 2024/10/16 02:31:14.387 done. [2024-10-16T02:31:27.019Z] CL2 j> 2024/10/16 02:31:25.505 Writing report data ... [2024-10-16T02:31:32.338Z] CL2 j> 2024/10/16 02:31:31.056 done. [2024-10-16T02:31:42.865Z] CL2 j> 2024/10/16 02:31:41.811 Writing report data ... [2024-10-16T02:31:51.526Z] CL2 j> 2024/10/16 02:31:50.240 done. [2024-10-16T02:32:03.917Z] CL2 j> 2024/10/16 02:32:01.817 Writing report data ... [2024-10-16T02:32:10.290Z] CL2 j> 2024/10/16 02:32:08.285 done. [2024-10-16T02:32:19.374Z] CL2 j> 2024/10/16 02:32:18.785 Writing report data ... [2024-10-16T02:32:25.328Z] CL2 j> 2024/10/16 02:32:24.103 done. [2024-10-16T02:32:37.310Z] CL2 j> 2024/10/16 02:32:34.805 Writing report data ... [2024-10-16T02:32:38.831Z] CL2 j> 2024/10/16 02:32:37.727 done. [2024-10-16T02:32:49.831Z] CL2 j> 2024/10/16 02:32:48.717 Writing report data ... [2024-10-16T02:32:55.675Z] CL2 j> 2024/10/16 02:32:54.157 done. [2024-10-16T02:33:05.927Z] CL2 j> 2024/10/16 02:33:04.599 Writing report data ... [2024-10-16T02:33:09.480Z] CL2 j> 2024/10/16 02:33:08.408 done. [2024-10-16T02:33:19.745Z] CL2 j> 2024/10/16 02:33:18.879 Writing report data ... [2024-10-16T02:33:22.429Z] CL2 j> 2024/10/16 02:33:21.791 done. [2024-10-16T02:33:34.314Z] CL2 j> 2024/10/16 02:33:31.964 Writing report data ... [2024-10-16T02:33:36.486Z] CL2 j> 2024/10/16 02:33:35.697 done. [2024-10-16T02:33:47.127Z] CL2 j> 2024/10/16 02:33:46.077 Writing report data ... [2024-10-16T02:33:54.344Z] CL2 j> 2024/10/16 02:33:52.885 done. [2024-10-16T02:34:04.945Z] CL2 j> 2024/10/16 02:34:03.585 Writing report data ... [2024-10-16T02:34:08.786Z] CL2 j> 2024/10/16 02:34:07.910 done. [2024-10-16T02:34:21.167Z] CL2 j> 2024/10/16 02:34:19.063 Writing report data ... [2024-10-16T02:34:28.037Z] CL2 j> 2024/10/16 02:34:26.403 done. [2024-10-16T02:34:38.318Z] CL2 j> 2024/10/16 02:34:36.734 Writing report data ... [2024-10-16T02:34:41.056Z] CL2 j> 2024/10/16 02:34:40.130 done. [2024-10-16T02:34:53.115Z] CL2 j> 2024/10/16 02:34:50.858 Writing report data ... [2024-10-16T02:34:54.558Z] CL2 j> 2024/10/16 02:34:53.356 done. [2024-10-16T02:35:05.005Z] CL2 j> 2024/10/16 02:35:04.219 Writing report data ... [2024-10-16T02:35:12.131Z] CL2 j> 2024/10/16 02:35:10.488 done. [2024-10-16T02:35:22.433Z] CL2 j> 2024/10/16 02:35:21.300 Writing report data ... [2024-10-16T02:35:27.068Z] CL2 j> 2024/10/16 02:35:26.593 done. [2024-10-16T02:35:32.069Z] STF 02:35:31.338 - Heartbeat: Process CL2 is still running [2024-10-16T02:35:38.661Z] CL2 j> 2024/10/16 02:35:37.367 Writing report data ... [2024-10-16T02:35:42.097Z] CL2 j> 2024/10/16 02:35:41.550 done. [2024-10-16T02:35:54.109Z] CL2 j> 2024/10/16 02:35:52.324 Writing report data ... [2024-10-16T02:35:58.647Z] CL2 j> 2024/10/16 02:35:57.370 done. [2024-10-16T02:36:08.786Z] CL2 j> 2024/10/16 02:36:07.968 Writing report data ... [2024-10-16T02:36:12.309Z] CL2 j> 2024/10/16 02:36:10.955 done. [2024-10-16T02:36:22.204Z] CL2 j> 2024/10/16 02:36:21.573 Writing report data ... [2024-10-16T02:36:25.854Z] CL2 j> 2024/10/16 02:36:25.317 done. [2024-10-16T02:36:37.595Z] CL2 j> 2024/10/16 02:36:36.033 Writing report data ... [2024-10-16T02:36:46.248Z] CL2 j> 2024/10/16 02:36:44.510 done. [2024-10-16T02:36:56.797Z] CL2 j> 2024/10/16 02:36:55.503 Writing report data ... [2024-10-16T02:37:00.565Z] CL2 j> 2024/10/16 02:36:59.009 done. [2024-10-16T02:37:10.930Z] CL2 j> 2024/10/16 02:37:09.908 Writing report data ... [2024-10-16T02:37:16.724Z] CL2 j> 2024/10/16 02:37:15.526 done. [2024-10-16T02:37:28.619Z] CL2 j> 2024/10/16 02:37:26.098 Writing report data ... [2024-10-16T02:37:31.268Z] CL2 j> 2024/10/16 02:37:30.567 done. [2024-10-16T02:37:41.822Z] CL2 j> 2024/10/16 02:37:40.737 Writing report data ... [2024-10-16T02:37:46.487Z] CL2 j> 2024/10/16 02:37:45.170 done. [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - Monitoring Report Summary: [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - o Process CL2 ended with the expected exit code (0) [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - o Process LT2 is still running as expected [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - +------ Step 8 - Stop LT2 process [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - | Kill running processes [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - | Processes: [LT2] [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - | [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - Killing processes: LT2 [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - o Process clean up attempt 1 for LT2 pid 3344959 [2024-10-16T02:37:47.911Z] STF 02:37:47.075 - o Process LT2 pid 3344959 stop() [2024-10-16T02:37:58.513Z] STF 02:37:57.347 - o Process LT2 pid 3344959 terminate() [2024-10-16T02:37:59.074Z] STF 02:37:58.361 - o Process LT2 pid 3344959 killed [2024-10-16T02:37:59.074Z] STF 02:37:58.361 - EXECUTE stage completed [2024-10-16T02:37:59.074Z] STF 02:37:58.723 - [2024-10-16T02:37:59.074Z] STF 02:37:58.723 - ==================== T E A R D O W N ==================== [2024-10-16T02:37:59.074Z] STF 02:37:58.723 - Running teardown: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17290394182109/TestJlmRemoteThreadNoAuth_0/20241016-022024-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-10-16T02:37:59.074Z] STF 02:37:58.853 - TEARDOWN stage completed [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - ===================== R E S U L T S ===================== [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - Stage results: [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - setUp: pass [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - execute: pass [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - teardown: pass [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - [2024-10-16T02:37:59.074Z] STF 02:37:58.860 - Overall result: PASSED [2024-10-16T02:37:59.074Z] ----------------------------------- [2024-10-16T02:37:59.074Z] TestJlmRemoteThreadNoAuth_0_PASSED [2024-10-16T02:37:59.074Z] ----------------------------------- [2024-10-16T02:37:59.074Z] [2024-10-16T02:37:59.074Z] TEST TEARDOWN: [2024-10-16T02:37:59.074Z] Nothing to be done for teardown. [2024-10-16T02:37:59.074Z] TestJlmRemoteThreadNoAuth_0 Finish Time: Wed Oct 16 02:37:58 2024 Epoch Time (ms): 1729046278906