[2024-10-30T23:53:37.129Z] Running test TestJlmRemoteThreadNoAuth_1 ... [2024-10-30T23:53:37.129Z] =============================================== [2024-10-30T23:53:37.129Z] TestJlmRemoteThreadNoAuth_1 Start Time: Wed Oct 30 23:53:36 2024 Epoch Time (ms): 1730332416605 [2024-10-30T23:53:37.129Z] variation: Mode650 [2024-10-30T23:53:37.129Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-10-30T23:53:37.129Z] { \ [2024-10-30T23:53:37.129Z] echo ""; echo "TEST SETUP:"; \ [2024-10-30T23:53:37.129Z] echo "Nothing to be done for setup."; \ [2024-10-30T23:53:37.129Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1"; \ [2024-10-30T23:53:37.129Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1"; \ [2024-10-30T23:53:37.129Z] echo ""; echo "TESTING:"; \ [2024-10-30T23:53:37.129Z] perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1" -test=TestJlmRemoteThreadNoAuth; \ [2024-10-30T23:53:37.129Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-30T23:53:37.129Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-30T23:53:37.129Z] echo "Nothing to be done for teardown."; \ [2024-10-30T23:53:37.129Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestTargetResult"; [2024-10-30T23:53:37.129Z] [2024-10-30T23:53:37.129Z] TEST SETUP: [2024-10-30T23:53:37.129Z] Nothing to be done for setup. [2024-10-30T23:53:37.129Z] [2024-10-30T23:53:37.129Z] TESTING: [2024-10-30T23:53:37.965Z] STF 23:53:37.171 - ========================= S T F ========================= [2024-10-30T23:53:37.965Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1 [2024-10-30T23:53:37.965Z] There is 630780 Mb free [2024-10-30T23:53:37.965Z] STF 23:53:37.273 - ================== G E N E R A T I O N ================== [2024-10-30T23:53:37.965Z] STF 23:53:37.274 - Checking JVM: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image [2024-10-30T23:53:37.965Z] STF 23:53:37.274 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth" [2024-10-30T23:53:37.965Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-30T23:53:37.965Z] GEN [0.051s][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 [2024-10-30T23:53:48.134Z] GEN 23:53:47.070 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2024-10-30T23:53:48.134Z] GEN 23:53:47.237 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-10-30T23:53:48.905Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-10-30T23:53:48.905Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2024-10-30T23:53:48.905Z] GEN /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/STF/stf.core/bin [2024-10-30T23:53:48.905Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-10-30T23:53:48.905Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-10-30T23:53:48.905Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2024-10-30T23:53:49.693Z] GEN 23:53:49.107 - Using Mode NoOptions. Values = '' [2024-10-30T23:53:51.425Z] GEN 23:53:50.302 - [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - Test command summary: [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - Step Stage Command Description [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - -----+--------+-----------------+------------ [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - 3 execute Monitor Wait for processes to complete [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - 4 execute kill Stop LT1 process [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-10-30T23:53:51.425Z] GEN 23:53:50.303 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-10-30T23:53:51.425Z] GEN 23:53:50.304 - 7 execute Monitor Wait for processes to complete [2024-10-30T23:53:51.425Z] GEN 23:53:50.304 - 8 execute kill Stop LT2 process [2024-10-30T23:53:51.425Z] STF 23:53:50.572 - [2024-10-30T23:53:51.426Z] STF 23:53:50.572 - Script generation completed [2024-10-30T23:53:51.426Z] STF 23:53:50.572 - [2024-10-30T23:53:51.426Z] STF 23:53:50.572 - [2024-10-30T23:53:51.426Z] STF 23:53:50.572 - ======================= S E T U P ======================= [2024-10-30T23:53:51.426Z] STF 23:53:50.572 - Running setup: perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/setUp.pl [2024-10-30T23:53:51.426Z] STF 23:53:51.146 - SETUP stage completed [2024-10-30T23:53:51.426Z] STF 23:53:51.149 - [2024-10-30T23:53:51.426Z] STF 23:53:51.149 - ==================== E X E C U T E - ==================== [2024-10-30T23:53:51.426Z] STF 23:53:51.149 - Running execute: perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/execute.pl [2024-10-30T23:53:52.321Z] STF 23:53:51.852 - [2024-10-30T23:53:52.321Z] STF 23:53:51.852 - Java version [2024-10-30T23:53:52.321Z] STF 23:53:51.852 - Running: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -version [2024-10-30T23:53:52.321Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-30T23:53:53.109Z] openjdk version "21.0.6-beta" 2025-01-21 [2024-10-30T23:53:53.109Z] OpenJDK Runtime Environment Temurin-21.0.6+1-202410302003 (build 21.0.6-beta+1-ea) [2024-10-30T23:53:53.109Z] OpenJDK 64-Bit Server VM Temurin-21.0.6+1-202410302003 (build 21.0.6-beta+1-ea, mixed mode, sharing) [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - | Start background process [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - | Mnemonic: LT1 [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - | Echo: ECHO_OFF [2024-10-30T23:53:53.109Z] STF 23:53:52.472 - | Expectation: NEVER [2024-10-30T23:53:53.110Z] STF 23:53:52.472 - | [2024-10-30T23:53:53.110Z] STF 23:53:52.473 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-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_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-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_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-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_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-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-30T23:53:53.110Z] STF 23:53:52.473 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-10-30T23:53:53.110Z] STF 23:53:52.473 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - | Start background process [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - | Mnemonic: CL1 [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - | Echo: ECHO_ON [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - | Expectation: CLEAN_RUN within 30m [2024-10-30T23:53:53.110Z] STF 23:53:52.565 - | [2024-10-30T23:53:53.110Z] STF 23:53:52.566 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-30T23:53:53.110Z] STF 23:53:52.566 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-10-30T23:53:53.110Z] STF 23:53:52.566 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-10-30T23:53:53.110Z] STF 23:53:52.624 - [2024-10-30T23:53:53.110Z] STF 23:53:52.624 - +------ Step 3 - Wait for processes to complete [2024-10-30T23:53:53.110Z] STF 23:53:52.624 - | Wait for processes to meet expectations [2024-10-30T23:53:53.110Z] STF 23:53:52.624 - | Processes: [LT1, CL1] [2024-10-30T23:53:53.110Z] STF 23:53:52.624 - | [2024-10-30T23:53:53.110Z] STF 23:53:52.624 - Monitoring processes: CL1 LT1 [2024-10-30T23:53:53.110Z] CL1 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-30T23:53:56.734Z] CL1 j> 2024/10/30 23:53:54.825 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-30T23:53:56.734Z] CL1 j> 2024/10/30 23:53:56.020 Attempting to connect [2024-10-30T23:53:59.516Z] CL1 j> 2024/10/30 23:53:58.527 Monitored VM not ready at Oct 30, 2024, 11:53:58 PM (attempt 1, elapsed 2025ms). [2024-10-30T23:53:59.516Z] CL1 j> 2024/10/30 23:53:58.527 Waiting 5 secs and trying again... [2024-10-30T23:54:04.440Z] CL1 j> 2024/10/30 23:54:03.529 Attempting to connect [2024-10-30T23:54:06.173Z] CL1 j> 2024/10/30 23:54:05.881 Connection established! [2024-10-30T23:54:08.827Z] CL1 j> 2024/10/30 23:54:08.426 Starting to write data [2024-10-30T23:58:56.685Z] STF 23:58:51.457 - Heartbeat: Process LT1 is still running [2024-10-31T00:03:59.354Z] STF 00:03:51.395 - Heartbeat: Process LT1 is still running [2024-10-31T00:08:59.428Z] STF 00:08:51.230 - Heartbeat: Process LT1 is still running [2024-10-31T00:11:54.780Z] STF 00:11:48.310 - Monitoring Report Summary: [2024-10-31T00:11:54.780Z] STF 00:11:48.310 - o Process CL1 ended with the expected exit code (0) [2024-10-31T00:11:54.780Z] STF 00:11:48.310 - o Process LT1 is still running as expected [2024-10-31T00:11:54.780Z] STF 00:11:48.311 - [2024-10-31T00:11:54.780Z] STF 00:11:48.311 - +------ Step 4 - Stop LT1 process [2024-10-31T00:11:54.781Z] STF 00:11:48.311 - | Kill running processes [2024-10-31T00:11:54.781Z] STF 00:11:48.311 - | Processes: [LT1] [2024-10-31T00:11:54.781Z] STF 00:11:48.311 - | [2024-10-31T00:11:54.781Z] STF 00:11:48.311 - Killing processes: LT1 [2024-10-31T00:11:54.781Z] STF 00:11:48.311 - o Process clean up attempt 1 for LT1 pid 2628141 [2024-10-31T00:11:54.781Z] STF 00:11:48.311 - o Process LT1 pid 2628141 stop() [2024-10-31T00:11:59.556Z] STF 00:11:58.591 - o Process LT1 pid 2628141 terminate() [2024-10-31T00:12:00.333Z] STF 00:11:59.591 - o Process LT1 pid 2628141 killed [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - | Start background process [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - | Mnemonic: LT2 [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - | Echo: ECHO_OFF [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - | Expectation: NEVER [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - | [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-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-31T00:12:00.333Z] STF 00:11:59.592 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-10-31T00:12:00.333Z] STF 00:11:59.592 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - | Start background process [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - | Program: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - | Mnemonic: CL2 [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - | Echo: ECHO_ON [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - | Expectation: CLEAN_RUN within 30m [2024-10-31T00:12:00.333Z] STF 00:11:59.594 - | [2024-10-31T00:12:00.333Z] STF 00:11:59.595 - Running command: /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java -Xmx256m -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_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_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-10-31T00:12:00.333Z] STF 00:11:59.613 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-10-31T00:12:00.333Z] STF 00:11:59.613 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-10-31T00:12:00.333Z] STF 00:11:59.614 - [2024-10-31T00:12:00.333Z] STF 00:11:59.614 - +------ Step 7 - Wait for processes to complete [2024-10-31T00:12:00.333Z] STF 00:11:59.614 - | Wait for processes to meet expectations [2024-10-31T00:12:00.333Z] STF 00:11:59.614 - | Processes: [LT2, CL2] [2024-10-31T00:12:00.333Z] STF 00:11:59.614 - | [2024-10-31T00:12:00.333Z] STF 00:11:59.615 - Monitoring processes: CL2 LT2 [2024-10-31T00:12:00.333Z] CL2 stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-10-31T00:12:02.871Z] CL2 j> 2024/10/31 00:12:01.148 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-10-31T00:12:02.871Z] CL2 j> 2024/10/31 00:12:02.381 Attempting to connect [2024-10-31T00:12:05.393Z] CL2 j> 2024/10/31 00:12:04.311 Monitored VM not ready at Oct 31, 2024, 12:12:04 AM (attempt 1, elapsed 1687ms). [2024-10-31T00:12:05.393Z] CL2 j> 2024/10/31 00:12:04.311 Waiting 5 secs and trying again... [2024-10-31T00:12:09.956Z] CL2 j> 2024/10/31 00:12:09.344 Attempting to connect [2024-10-31T00:12:11.578Z] CL2 j> 2024/10/31 00:12:10.931 Connection established! [2024-10-31T00:12:28.892Z] CL2 j> 2024/10/31 00:12:26.093 Writing report data ... [2024-10-31T00:14:06.692Z] STF 00:13:51.113 - Heartbeat: Process CL2 is still running [2024-10-31T00:14:06.692Z] CL2 j> 2024/10/31 00:13:58.085 done. [2024-10-31T00:14:12.056Z] CL2 j> 2024/10/31 00:14:10.705 Writing report data ... [2024-10-31T00:15:47.610Z] CL2 j> 2024/10/31 00:15:39.633 done. [2024-10-31T00:15:53.892Z] CL2 j> 2024/10/31 00:15:52.930 Writing report data ... [2024-10-31T00:16:53.596Z] CL2 j> 2024/10/31 00:16:52.395 done. [2024-10-31T00:17:06.632Z] CL2 j> 2024/10/31 00:17:05.007 Writing report data ... [2024-10-31T00:17:59.588Z] CL2 j> 2024/10/31 00:17:57.338 done. [2024-10-31T00:18:11.228Z] CL2 j> 2024/10/31 00:18:10.189 Writing report data ... [2024-10-31T00:18:53.860Z] STF 00:18:51.473 - Heartbeat: Process CL2 is still running [2024-10-31T00:19:09.176Z] CL2 j> 2024/10/31 00:19:06.742 done. [2024-10-31T00:19:22.065Z] CL2 j> 2024/10/31 00:19:19.720 Writing report data ... [2024-10-31T00:20:13.153Z] CL2 j> 2024/10/31 00:20:05.177 done. [2024-10-31T00:20:20.980Z] CL2 j> 2024/10/31 00:20:18.834 Writing report data ... [2024-10-31T00:21:20.555Z] CL2 j> 2024/10/31 00:21:15.652 done. [2024-10-31T00:21:26.954Z] CL2 j> 2024/10/31 00:21:26.026 Writing report data ... [2024-10-31T00:22:11.003Z] CL2 j> 2024/10/31 00:22:08.537 done. [2024-10-31T00:22:21.968Z] CL2 j> 2024/10/31 00:22:20.753 Writing report data ... [2024-10-31T00:23:00.849Z] CL2 j> 2024/10/31 00:22:57.325 done. [2024-10-31T00:23:11.852Z] CL2 j> 2024/10/31 00:23:10.245 Writing report data ... [2024-10-31T00:23:55.109Z] STF 00:23:51.031 - Heartbeat: Process CL2 is still running [2024-10-31T00:23:55.109Z] CL2 j> 2024/10/31 00:23:51.953 done. [2024-10-31T00:24:06.128Z] CL2 j> 2024/10/31 00:24:04.644 Writing report data ... [2024-10-31T00:24:56.848Z] CL2 j> 2024/10/31 00:24:50.847 done. [2024-10-31T00:25:03.335Z] CL2 j> 2024/10/31 00:25:01.987 Writing report data ... [2024-10-31T00:25:42.493Z] CL2 j> 2024/10/31 00:25:38.170 done. [2024-10-31T00:25:51.617Z] CL2 j> 2024/10/31 00:25:50.172 Writing report data ... [2024-10-31T00:26:24.788Z] CL2 j> 2024/10/31 00:26:21.901 done. [2024-10-31T00:26:34.506Z] CL2 j> 2024/10/31 00:26:33.190 Writing report data ... [2024-10-31T00:27:02.800Z] CL2 j> 2024/10/31 00:27:01.202 done. [2024-10-31T00:27:13.601Z] CL2 j> 2024/10/31 00:27:12.814 Writing report data ... [2024-10-31T00:27:47.297Z] CL2 j> 2024/10/31 00:27:42.460 done. [2024-10-31T00:27:55.417Z] CL2 j> 2024/10/31 00:27:53.649 Writing report data ... [2024-10-31T00:28:27.259Z] CL2 j> 2024/10/31 00:28:21.901 done. [2024-10-31T00:28:35.004Z] CL2 j> 2024/10/31 00:28:33.426 Writing report data ... [2024-10-31T00:28:52.390Z] STF 00:28:51.005 - Heartbeat: Process CL2 is still running [2024-10-31T00:29:02.081Z] CL2 j> 2024/10/31 00:29:01.129 done. [2024-10-31T00:29:13.589Z] CL2 j> 2024/10/31 00:29:12.213 Writing report data ... [2024-10-31T00:29:45.290Z] CL2 j> 2024/10/31 00:29:41.385 done. [2024-10-31T00:29:54.646Z] CL2 j> 2024/10/31 00:29:52.984 Writing report data ... [2024-10-31T00:30:18.073Z] CL2 j> 2024/10/31 00:30:17.233 done. [2024-10-31T00:30:30.835Z] CL2 j> 2024/10/31 00:30:29.845 Writing report data ... [2024-10-31T00:31:07.299Z] CL2 j> 2024/10/31 00:31:04.872 done. [2024-10-31T00:31:18.173Z] CL2 j> 2024/10/31 00:31:16.877 Writing report data ... [2024-10-31T00:31:56.777Z] CL2 j> 2024/10/31 00:31:51.592 done. [2024-10-31T00:32:04.354Z] CL2 j> 2024/10/31 00:32:03.421 Writing report data ... [2024-10-31T00:32:41.841Z] CL2 j> 2024/10/31 00:32:37.893 done. [2024-10-31T00:32:49.421Z] CL2 j> 2024/10/31 00:32:48.474 Writing report data ... [2024-10-31T00:33:18.613Z] CL2 j> 2024/10/31 00:33:15.828 done. [2024-10-31T00:33:28.123Z] CL2 j> 2024/10/31 00:33:26.549 Writing report data ... [2024-10-31T00:33:52.995Z] STF 00:33:51.123 - Heartbeat: Process CL2 is still running [2024-10-31T00:33:56.872Z] CL2 j> 2024/10/31 00:33:55.479 done. [2024-10-31T00:34:07.653Z] CL2 j> 2024/10/31 00:34:06.481 Writing report data ... [2024-10-31T00:34:39.537Z] CL2 j> 2024/10/31 00:34:35.129 done. [2024-10-31T00:34:50.911Z] CL2 j> 2024/10/31 00:34:48.549 Writing report data ... [2024-10-31T00:35:33.701Z] CL2 j> 2024/10/31 00:35:31.129 done. [2024-10-31T00:35:45.446Z] CL2 j> 2024/10/31 00:35:43.833 Writing report data ... [2024-10-31T00:36:05.201Z] CL2 j> 2024/10/31 00:36:03.125 done. [2024-10-31T00:36:14.432Z] CL2 j> 2024/10/31 00:36:13.721 Writing report data ... [2024-10-31T00:36:37.968Z] CL2 j> 2024/10/31 00:36:34.273 done. [2024-10-31T00:36:45.529Z] CL2 j> 2024/10/31 00:36:44.364 Writing report data ... [2024-10-31T00:37:17.129Z] CL2 j> 2024/10/31 00:37:15.849 done. [2024-10-31T00:37:28.039Z] CL2 j> 2024/10/31 00:37:26.769 Writing report data ... [2024-10-31T00:37:48.681Z] CL2 j> 2024/10/31 00:37:46.142 done. [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - Monitoring Report Summary: [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - o Process CL2 ended with the expected exit code (0) [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - o Process LT2 is still running as expected [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - +------ Step 8 - Stop LT2 process [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - | Kill running processes [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - | Processes: [LT2] [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - | [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - Killing processes: LT2 [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - o Process clean up attempt 1 for LT2 pid 2628922 [2024-10-31T00:37:48.681Z] STF 00:37:47.382 - o Process LT2 pid 2628922 stop() [2024-10-31T00:37:59.052Z] STF 00:37:57.544 - o Process LT2 pid 2628922 terminate() [2024-10-31T00:37:59.052Z] STF 00:37:58.544 - o Process LT2 pid 2628922 killed [2024-10-31T00:37:59.052Z] STF 00:37:58.545 - EXECUTE stage completed [2024-10-31T00:37:59.052Z] STF 00:37:58.910 - [2024-10-31T00:37:59.052Z] STF 00:37:58.910 - ==================== T E A R D O W N ==================== [2024-10-31T00:37:59.052Z] STF 00:37:58.910 - Running teardown: perl /home/jenkins/workspace/Test_openjdk21_hs_sanity.system_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17303238046281/TestJlmRemoteThreadNoAuth_1/20241030-235337-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-10-31T00:37:59.828Z] STF 00:37:59.506 - TEARDOWN stage completed [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - ===================== R E S U L T S ===================== [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - Stage results: [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - setUp: pass [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - execute: pass [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - teardown: pass [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - [2024-10-31T00:37:59.828Z] STF 00:37:59.512 - Overall result: PASSED [2024-10-31T00:37:59.828Z] ----------------------------------- [2024-10-31T00:37:59.828Z] TestJlmRemoteThreadNoAuth_1_PASSED [2024-10-31T00:37:59.828Z] ----------------------------------- [2024-10-31T00:37:59.828Z] [2024-10-31T00:37:59.828Z] TEST TEARDOWN: [2024-10-31T00:37:59.828Z] Nothing to be done for teardown. [2024-10-31T00:37:59.828Z] TestJlmRemoteThreadNoAuth_1 Finish Time: Thu Oct 31 00:37:59 2024 Epoch Time (ms): 1730335079678