[2024-11-20T22:51:25.745Z] Running test TestJlmRemoteThreadNoAuth_2 ... [2024-11-20T22:51:25.745Z] =============================================== [2024-11-20T22:51:25.745Z] TestJlmRemoteThreadNoAuth_2 Start Time: Wed Nov 20 22:51:25 2024 Epoch Time (ms): 1732143085256 [2024-11-20T22:51:25.745Z] variation: Mode1000 [2024-11-20T22:51:25.745Z] JVM_OPTIONS: [2024-11-20T22:51:25.745Z] { \ [2024-11-20T22:51:25.745Z] echo ""; echo "TEST SETUP:"; \ [2024-11-20T22:51:25.745Z] echo "Nothing to be done for setup."; \ [2024-11-20T22:51:25.745Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2"; \ [2024-11-20T22:51:25.745Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2"; \ [2024-11-20T22:51:25.745Z] echo ""; echo "TESTING:"; \ [2024-11-20T22:51:25.745Z] perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/../../testDependency/system_lib/" -java-args=' ' -results-root="/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2" -test=TestJlmRemoteThreadNoAuth; \ [2024-11-20T22:51:25.745Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_2""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_2""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-20T22:51:25.745Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-20T22:51:25.745Z] echo "Nothing to be done for teardown."; \ [2024-11-20T22:51:25.745Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestTargetResult"; [2024-11-20T22:51:25.745Z] [2024-11-20T22:51:25.745Z] TEST SETUP: [2024-11-20T22:51:25.745Z] Nothing to be done for setup. [2024-11-20T22:51:25.745Z] [2024-11-20T22:51:25.745Z] TESTING: [2024-11-20T22:51:25.745Z] STF 22:51:25.505 - ========================= S T F ========================= [2024-11-20T22:51:25.745Z] 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_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2 [2024-11-20T22:51:25.745Z] There is 684511 Mb free [2024-11-20T22:51:25.745Z] STF 22:51:25.520 - ================== G E N E R A T I O N ================== [2024-11-20T22:51:25.745Z] STF 22:51:25.521 - Checking JVM: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image [2024-11-20T22:51:25.745Z] STF 22:51:25.521 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/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_arm_linux/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth" [2024-11-20T22:51:32.799Z] GEN Java lib directory does not exist: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/lib [2024-11-20T22:51:32.799Z] GEN 22:51:31.656 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2024-11-20T22:51:32.799Z] GEN 22:51:31.829 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-11-20T22:51:32.799Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-11-20T22:51:32.799Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2024-11-20T22:51:32.799Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/bin [2024-11-20T22:51:32.799Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-11-20T22:51:32.799Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-11-20T22:51:32.799Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2024-11-20T22:51:32.799Z] GEN Java lib directory does not exist: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/lib [2024-11-20T22:51:33.617Z] GEN 22:51:32.933 - Using Mode NoOptions. Values = '' [2024-11-20T22:51:34.405Z] GEN 22:51:33.978 - [2024-11-20T22:51:34.405Z] GEN 22:51:33.978 - Test command summary: [2024-11-20T22:51:34.405Z] GEN 22:51:33.978 - Step Stage Command Description [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - -----+--------+-----------------+------------ [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 3 execute Monitor Wait for processes to complete [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 4 execute kill Stop LT1 process [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 7 execute Monitor Wait for processes to complete [2024-11-20T22:51:34.405Z] GEN 22:51:33.979 - 8 execute kill Stop LT2 process [2024-11-20T22:51:34.405Z] STF 22:51:34.173 - [2024-11-20T22:51:34.405Z] STF 22:51:34.173 - Script generation completed [2024-11-20T22:51:34.405Z] STF 22:51:34.173 - [2024-11-20T22:51:34.405Z] STF 22:51:34.173 - [2024-11-20T22:51:34.405Z] STF 22:51:34.173 - ======================= S E T U P ======================= [2024-11-20T22:51:34.405Z] STF 22:51:34.173 - Running setup: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/setUp.pl [2024-11-20T22:51:34.405Z] STF 22:51:34.296 - SETUP stage completed [2024-11-20T22:51:34.405Z] STF 22:51:34.314 - [2024-11-20T22:51:34.405Z] STF 22:51:34.315 - ==================== E X E C U T E - ==================== [2024-11-20T22:51:34.405Z] STF 22:51:34.315 - Running execute: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/execute.pl [2024-11-20T22:51:35.196Z] STF 22:51:34.449 - [2024-11-20T22:51:35.196Z] STF 22:51:34.450 - Java version [2024-11-20T22:51:35.196Z] STF 22:51:34.450 - Running: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -version [2024-11-20T22:51:35.196Z] openjdk version "11.0.26-beta" 2025-01-21 [2024-11-20T22:51:35.196Z] OpenJDK Runtime Environment Temurin-11.0.26+2-202411202103 (build 11.0.26-beta+2-ea) [2024-11-20T22:51:35.196Z] OpenJDK Server VM Temurin-11.0.26+2-202411202103 (build 11.0.26-beta+2-ea, mixed mode) [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - | Start background process [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - | Mnemonic: LT1 [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - | Echo: ECHO_OFF [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - | Expectation: NEVER [2024-11-20T22:51:35.196Z] STF 22:51:34.963 - | [2024-11-20T22:51:35.196Z] STF 22:51:34.964 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/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_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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-11-20T22:51:35.196Z] STF 22:51:34.964 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-11-20T22:51:35.196Z] STF 22:51:34.964 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-11-20T22:51:35.196Z] STF 22:51:34.975 - [2024-11-20T22:51:35.196Z] STF 22:51:34.976 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - | Start background process [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - | Mnemonic: CL1 [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - | Echo: ECHO_ON [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - | Expectation: CLEAN_RUN within 30m [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - | [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-11-20T22:51:35.197Z] STF 22:51:34.976 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-11-20T22:51:35.197Z] STF 22:51:34.999 - [2024-11-20T22:51:35.197Z] STF 22:51:34.999 - +------ Step 3 - Wait for processes to complete [2024-11-20T22:51:35.197Z] STF 22:51:34.999 - | Wait for processes to meet expectations [2024-11-20T22:51:35.197Z] STF 22:51:34.999 - | Processes: [LT1, CL1] [2024-11-20T22:51:35.197Z] STF 22:51:34.999 - | [2024-11-20T22:51:35.197Z] STF 22:51:34.999 - Monitoring processes: CL1 LT1 [2024-11-20T22:51:38.648Z] CL1 j> 2024/11/20 22:51:36.973 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-20T22:51:38.648Z] CL1 j> 2024/11/20 22:51:38.030 Attempting to connect [2024-11-20T22:51:40.341Z] CL1 j> 2024/11/20 22:51:40.143 Connection established! [2024-11-20T22:51:41.111Z] CL1 j> 2024/11/20 22:51:40.567 Starting to write data [2024-11-20T22:56:38.693Z] STF 22:56:34.028 - Heartbeat: Process LT1 is still running [2024-11-20T23:01:06.051Z] STF 23:00:51.475 - Monitoring Report Summary: [2024-11-20T23:01:06.051Z] STF 23:00:51.475 - o Process CL1 ended with the expected exit code (0) [2024-11-20T23:01:06.051Z] STF 23:00:51.475 - o Process LT1 is still running as expected [2024-11-20T23:01:06.051Z] STF 23:00:51.475 - [2024-11-20T23:01:06.051Z] STF 23:00:51.475 - +------ Step 4 - Stop LT1 process [2024-11-20T23:01:06.051Z] STF 23:00:51.475 - | Kill running processes [2024-11-20T23:01:06.051Z] STF 23:00:51.476 - | Processes: [LT1] [2024-11-20T23:01:06.051Z] STF 23:00:51.476 - | [2024-11-20T23:01:06.051Z] STF 23:00:51.476 - Killing processes: LT1 [2024-11-20T23:01:06.051Z] STF 23:00:51.476 - o Process clean up attempt 1 for LT1 pid 2524522 [2024-11-20T23:01:06.051Z] STF 23:00:51.476 - o Process LT1 pid 2524522 stop() [2024-11-20T23:01:06.051Z] STF 23:01:01.536 - o Process LT1 pid 2524522 terminate() [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - o Process LT1 pid 2524522 killed [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - | Start background process [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - | Mnemonic: LT2 [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - | Echo: ECHO_OFF [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - | Expectation: NEVER [2024-11-20T23:01:06.051Z] STF 23:01:02.537 - | [2024-11-20T23:01:06.051Z] STF 23:01:02.538 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -Dcom.sun.management.jmxremote.port=1234 -Dcom.sun.management.jmxremote.authenticate=false -Dcom.sun.management.jmxremote.ssl=false -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/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_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-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-11-20T23:01:06.051Z] STF 23:01:02.538 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-11-20T23:01:06.051Z] STF 23:01:02.538 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - | Start background process [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - | Mnemonic: CL2 [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - | Echo: ECHO_ON [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - | Expectation: CLEAN_RUN within 30m [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - | [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -classpath /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/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_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-11-20T23:01:06.051Z] STF 23:01:02.539 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-11-20T23:01:06.051Z] STF 23:01:02.540 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-11-20T23:01:06.051Z] STF 23:01:02.541 - [2024-11-20T23:01:06.051Z] STF 23:01:02.541 - +------ Step 7 - Wait for processes to complete [2024-11-20T23:01:06.051Z] STF 23:01:02.541 - | Wait for processes to meet expectations [2024-11-20T23:01:06.051Z] STF 23:01:02.541 - | Processes: [LT2, CL2] [2024-11-20T23:01:06.051Z] STF 23:01:02.541 - | [2024-11-20T23:01:06.051Z] STF 23:01:02.541 - Monitoring processes: CL2 LT2 [2024-11-20T23:01:06.051Z] CL2 j> 2024/11/20 23:01:03.640 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-20T23:01:06.051Z] CL2 j> 2024/11/20 23:01:04.422 Attempting to connect [2024-11-20T23:01:06.051Z] CL2 j> 2024/11/20 23:01:05.456 Monitored VM not ready at Nov 20, 2024, 11:01:05 PM (attempt 1, elapsed 901ms). [2024-11-20T23:01:06.051Z] CL2 j> 2024/11/20 23:01:05.456 Waiting 5 secs and trying again... [2024-11-20T23:01:11.758Z] CL2 j> 2024/11/20 23:01:10.456 Attempting to connect [2024-11-20T23:01:12.586Z] CL2 j> 2024/11/20 23:01:11.253 Connection established! [2024-11-20T23:01:30.188Z] CL2 j> 2024/11/20 23:01:29.620 Writing report data ... [2024-11-20T23:01:35.149Z] STF 23:01:34.268 - Heartbeat: Process CL2 is still running [2024-11-20T23:03:10.400Z] CL2 j> 2024/11/20 23:03:01.729 done. [2024-11-20T23:03:13.766Z] CL2 j> 2024/11/20 23:03:12.637 Writing report data ... [2024-11-20T23:03:45.337Z] CL2 j> 2024/11/20 23:03:40.280 done. [2024-11-20T23:03:52.644Z] CL2 j> 2024/11/20 23:03:51.054 Writing report data ... [2024-11-20T23:04:06.843Z] CL2 j> 2024/11/20 23:04:04.857 done. [2024-11-20T23:04:15.651Z] CL2 j> 2024/11/20 23:04:15.043 Writing report data ... [2024-11-20T23:04:27.734Z] CL2 j> 2024/11/20 23:04:25.233 done. [2024-11-20T23:04:36.460Z] CL2 j> 2024/11/20 23:04:35.509 Writing report data ... [2024-11-20T23:04:47.262Z] CL2 j> 2024/11/20 23:04:46.068 done. [2024-11-20T23:04:57.514Z] CL2 j> 2024/11/20 23:04:56.257 Writing report data ... [2024-11-20T23:05:06.104Z] CL2 j> 2024/11/20 23:05:04.151 done. [2024-11-20T23:05:16.390Z] CL2 j> 2024/11/20 23:05:14.357 Writing report data ... [2024-11-20T23:05:24.846Z] CL2 j> 2024/11/20 23:05:22.849 done. [2024-11-20T23:05:35.263Z] CL2 j> 2024/11/20 23:05:33.028 Writing report data ... [2024-11-20T23:05:41.294Z] CL2 j> 2024/11/20 23:05:39.726 done. [2024-11-20T23:05:50.662Z] CL2 j> 2024/11/20 23:05:49.794 Writing report data ... [2024-11-20T23:05:57.711Z] CL2 j> 2024/11/20 23:05:57.070 done. [2024-11-20T23:06:08.053Z] CL2 j> 2024/11/20 23:06:07.377 Writing report data ... [2024-11-20T23:06:16.532Z] CL2 j> 2024/11/20 23:06:14.177 done. [2024-11-20T23:06:25.240Z] CL2 j> 2024/11/20 23:06:24.286 Writing report data ... [2024-11-20T23:06:33.964Z] CL2 j> 2024/11/20 23:06:32.962 done. [2024-11-20T23:06:34.794Z] STF 23:06:34.153 - Heartbeat: Process CL2 is still running [2024-11-20T23:06:44.968Z] CL2 j> 2024/11/20 23:06:43.321 Writing report data ... [2024-11-20T23:06:52.020Z] CL2 j> 2024/11/20 23:06:50.951 done. [2024-11-20T23:07:02.367Z] CL2 j> 2024/11/20 23:07:01.043 Writing report data ... [2024-11-20T23:07:07.562Z] CL2 j> 2024/11/20 23:07:06.699 done. [2024-11-20T23:07:17.828Z] CL2 j> 2024/11/20 23:07:16.994 Writing report data ... [2024-11-20T23:07:26.315Z] CL2 j> 2024/11/20 23:07:25.621 done. [2024-11-20T23:07:36.796Z] CL2 j> 2024/11/20 23:07:35.862 Writing report data ... [2024-11-20T23:07:43.989Z] CL2 j> 2024/11/20 23:07:43.244 done. [2024-11-20T23:07:56.152Z] CL2 j> 2024/11/20 23:07:53.432 Writing report data ... [2024-11-20T23:08:02.000Z] CL2 j> 2024/11/20 23:08:00.057 done. [2024-11-20T23:08:12.371Z] CL2 j> 2024/11/20 23:08:10.276 Writing report data ... [2024-11-20T23:08:18.916Z] CL2 j> 2024/11/20 23:08:17.348 done. [2024-11-20T23:08:29.244Z] CL2 j> 2024/11/20 23:08:27.509 Writing report data ... [2024-11-20T23:08:36.534Z] CL2 j> 2024/11/20 23:08:34.853 done. [2024-11-20T23:08:46.788Z] CL2 j> 2024/11/20 23:08:45.197 Writing report data ... [2024-11-20T23:08:53.879Z] CL2 j> 2024/11/20 23:08:53.167 done. [2024-11-20T23:09:04.239Z] CL2 j> 2024/11/20 23:09:03.383 Writing report data ... [2024-11-20T23:09:11.452Z] CL2 j> 2024/11/20 23:09:10.335 done. [2024-11-20T23:09:21.695Z] CL2 j> 2024/11/20 23:09:20.531 Writing report data ... [2024-11-20T23:09:29.405Z] CL2 j> 2024/11/20 23:09:27.569 done. [2024-11-20T23:09:39.774Z] CL2 j> 2024/11/20 23:09:37.911 Writing report data ... [2024-11-20T23:09:46.965Z] CL2 j> 2024/11/20 23:09:45.722 done. [2024-11-20T23:09:57.145Z] CL2 j> 2024/11/20 23:09:55.811 Writing report data ... [2024-11-20T23:10:05.916Z] CL2 j> 2024/11/20 23:10:04.367 done. [2024-11-20T23:10:16.259Z] CL2 j> 2024/11/20 23:10:14.532 Writing report data ... [2024-11-20T23:10:26.468Z] CL2 j> 2024/11/20 23:10:24.495 done. [2024-11-20T23:10:36.792Z] CL2 j> 2024/11/20 23:10:34.793 Writing report data ... [2024-11-20T23:10:44.092Z] CL2 j> 2024/11/20 23:10:42.746 done. [2024-11-20T23:10:54.290Z] CL2 j> 2024/11/20 23:10:52.942 Writing report data ... [2024-11-20T23:11:01.361Z] CL2 j> 2024/11/20 23:10:59.813 done. [2024-11-20T23:11:11.575Z] CL2 j> 2024/11/20 23:11:10.114 Writing report data ... [2024-11-20T23:11:21.854Z] CL2 j> 2024/11/20 23:11:19.771 done. [2024-11-20T23:11:30.571Z] CL2 j> 2024/11/20 23:11:29.963 Writing report data ... [2024-11-20T23:11:35.195Z] STF 23:11:34.031 - Heartbeat: Process CL2 is still running [2024-11-20T23:11:42.680Z] CL2 j> 2024/11/20 23:11:40.949 done. [2024-11-20T23:11:53.122Z] CL2 j> 2024/11/20 23:11:51.076 Writing report data ... [2024-11-20T23:12:00.143Z] CL2 j> 2024/11/20 23:11:58.973 done. [2024-11-20T23:12:10.461Z] CL2 j> 2024/11/20 23:12:09.157 Writing report data ... [2024-11-20T23:12:19.012Z] CL2 j> 2024/11/20 23:12:17.278 done. [2024-11-20T23:12:19.787Z] STF 23:12:18.849 - Monitoring Report Summary: [2024-11-20T23:12:19.787Z] STF 23:12:18.849 - o Process CL2 ended with the expected exit code (0) [2024-11-20T23:12:19.787Z] STF 23:12:18.849 - o Process LT2 is still running as expected [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - +------ Step 8 - Stop LT2 process [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - | Kill running processes [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - | Processes: [LT2] [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - | [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - Killing processes: LT2 [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - o Process clean up attempt 1 for LT2 pid 2525018 [2024-11-20T23:12:19.787Z] STF 23:12:18.850 - o Process LT2 pid 2525018 stop() [2024-11-20T23:12:29.895Z] STF 23:12:28.987 - o Process LT2 pid 2525018 terminate() [2024-11-20T23:12:30.666Z] STF 23:12:29.987 - o Process LT2 pid 2525018 killed [2024-11-20T23:12:30.666Z] STF 23:12:29.987 - EXECUTE stage completed [2024-11-20T23:12:30.666Z] STF 23:12:30.472 - [2024-11-20T23:12:30.666Z] STF 23:12:30.472 - ==================== T E A R D O W N ==================== [2024-11-20T23:12:30.666Z] STF 23:12:30.472 - Running teardown: perl /home/jenkins/workspace/Test_openjdk11_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17321396071365/TestJlmRemoteThreadNoAuth_2/20241120-225125-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-11-20T23:12:30.666Z] STF 23:12:30.572 - TEARDOWN stage completed [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - ===================== R E S U L T S ===================== [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - Stage results: [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - setUp: pass [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - execute: pass [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - teardown: pass [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - [2024-11-20T23:12:30.666Z] STF 23:12:30.592 - Overall result: PASSED [2024-11-20T23:12:30.666Z] ----------------------------------- [2024-11-20T23:12:30.666Z] TestJlmRemoteThreadNoAuth_2_PASSED [2024-11-20T23:12:30.666Z] ----------------------------------- [2024-11-20T23:12:31.440Z] [2024-11-20T23:12:31.440Z] TEST TEARDOWN: [2024-11-20T23:12:31.440Z] Nothing to be done for teardown. [2024-11-20T23:12:31.440Z] TestJlmRemoteThreadNoAuth_2 Finish Time: Wed Nov 20 23:12:30 2024 Epoch Time (ms): 1732144350651