[2024-01-22T11:50:13.759Z] Running test TestJlmRemoteThreadNoAuth_2 ... [2024-01-22T11:50:14.133Z] =============================================== [2024-01-22T11:50:14.133Z] TestJlmRemoteThreadNoAuth_2 Start Time: Mon Jan 22 11:50:13 2024 Epoch Time (ms): 1705924213745 [2024-01-22T11:50:14.134Z] variation: Mode1000 [2024-01-22T11:50:14.134Z] JVM_OPTIONS: [2024-01-22T11:50:14.134Z] { \ [2024-01-22T11:50:14.134Z] echo ""; echo "TEST SETUP:"; \ [2024-01-22T11:50:14.134Z] echo "Nothing to be done for setup."; \ [2024-01-22T11:50:14.134Z] mkdir -p "/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2"; \ [2024-01-22T11:50:14.134Z] cd "/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2"; \ [2024-01-22T11:50:14.134Z] echo ""; echo "TESTING:"; \ [2024-01-22T11:50:14.134Z] perl /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF/stf.core/scripts/stf.pl -test-root="/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//STF;/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//aqa-systemtest""" -systemtest-prereqs="/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//systemtest_prereqs" -java-args=' ' -results-root="/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2" -test=TestJlmRemoteThreadNoAuth; \ [2024-01-22T11:50:14.134Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_2""_PASSED"; echo "-----------------------------------"; cd /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/..; rm -f -r "/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2"; else echo "-----------------------------------"; echo "TestJlmRemoteThreadNoAuth_2""_FAILED"; echo "-----------------------------------"; fi; \ [2024-01-22T11:50:14.134Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-01-22T11:50:14.134Z] echo "Nothing to be done for teardown."; \ [2024-01-22T11:50:14.134Z] } 2>&1 | tee -a "/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestTargetResult"; [2024-01-22T11:50:14.134Z] [2024-01-22T11:50:14.134Z] TEST SETUP: [2024-01-22T11:50:14.134Z] Nothing to be done for setup. [2024-01-22T11:50:14.134Z] [2024-01-22T11:50:14.134Z] TESTING: [2024-01-22T11:50:14.134Z] STF 11:50:13.905 - ========================= S T F ========================= [2024-01-22T11:50:14.134Z] systemtest-prereqs has been processed, and set to: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqsRetrieving amount of free space on drive containing /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2 [2024-01-22T11:50:14.134Z] There is 60823 Mb free [2024-01-22T11:50:14.134Z] STF 11:50:13.919 - ================== G E N E R A T I O N ================== [2024-01-22T11:50:14.134Z] STF 11:50:13.921 - Checking JVM: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image [2024-01-22T11:50:14.134Z] STF 11:50:13.921 - Starting process to generate scripts: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//systemtest_prereqs/log4j/log4j-api.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../../jvmtest/system/jlm/..//systemtest_prereqs/log4j/log4j-core.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/stf_parameters.properties, , /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth" [2024-01-22T11:50:16.638Z] GEN 11:50:15.978 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteThreadNoAuth.class' Dir: '/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin' [2024-01-22T11:50:16.638Z] GEN 11:50:15.996 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteThreadNoAuth' [2024-01-22T11:50:16.638Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-01-22T11:50:16.638Z] GEN /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin [2024-01-22T11:50:16.638Z] GEN /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/bin [2024-01-22T11:50:16.638Z] GEN /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/log4j/log4j-api.jar [2024-01-22T11:50:16.638Z] GEN /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/log4j/log4j-core.jar [2024-01-22T11:50:16.638Z] GEN /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/junit.jar [2024-01-22T11:50:16.638Z] GEN 11:50:16.367 - Using Mode NoOptions. Values = '' [2024-01-22T11:50:16.638Z] GEN 11:50:16.543 - [2024-01-22T11:50:16.638Z] GEN 11:50:16.543 - Test command summary: [2024-01-22T11:50:16.638Z] GEN 11:50:16.544 - Step Stage Command Description [2024-01-22T11:50:16.638Z] GEN 11:50:16.544 - -----+--------+-----------------+------------ [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 1 execute Run java Running ThreadProfiler Proxy test Server Process [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 3 execute Monitor Wait for processes to complete [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 4 execute kill Stop LT1 process [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 5 execute Run java Running ThreadProfiler Server test Server Process(without security) [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 7 execute Monitor Wait for processes to complete [2024-01-22T11:50:16.638Z] GEN 11:50:16.545 - 8 execute kill Stop LT2 process [2024-01-22T11:50:17.021Z] STF 11:50:16.605 - [2024-01-22T11:50:17.022Z] STF 11:50:16.605 - Script generation completed [2024-01-22T11:50:17.022Z] STF 11:50:16.605 - [2024-01-22T11:50:17.022Z] STF 11:50:16.606 - [2024-01-22T11:50:17.022Z] STF 11:50:16.606 - ======================= S E T U P ======================= [2024-01-22T11:50:17.022Z] STF 11:50:16.606 - Running setup: perl /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/setUp.pl [2024-01-22T11:50:17.022Z] STF 11:50:16.743 - SETUP stage completed [2024-01-22T11:50:17.022Z] STF 11:50:16.750 - [2024-01-22T11:50:17.022Z] STF 11:50:16.750 - ==================== E X E C U T E - ==================== [2024-01-22T11:50:17.022Z] STF 11:50:16.750 - Running execute: perl /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/execute.pl [2024-01-22T11:50:17.022Z] STF 11:50:16.888 - [2024-01-22T11:50:17.022Z] STF 11:50:16.888 - Java version [2024-01-22T11:50:17.022Z] STF 11:50:16.888 - Running: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -version [2024-01-22T11:50:17.403Z] openjdk version "1.8.0_402" [2024-01-22T11:50:17.403Z] OpenJDK Runtime Environment (Temurin)(build 1.8.0_402-b06) [2024-01-22T11:50:17.403Z] OpenJDK Client VM (Temurin)(build 25.402-b06, mixed mode) [2024-01-22T11:50:17.403Z] STF 11:50:17.071 - [2024-01-22T11:50:17.403Z] STF 11:50:17.071 - +------ Step 1 - Running ThreadProfiler Proxy test Server Process [2024-01-22T11:50:17.403Z] STF 11:50:17.072 - | Start background process [2024-01-22T11:50:17.403Z] STF 11:50:17.072 - | Program: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-01-22T11:50:17.403Z] STF 11:50:17.072 - | Mnemonic: LT1 [2024-01-22T11:50:17.403Z] STF 11:50:17.072 - | Echo: ECHO_OFF [2024-01-22T11:50:17.403Z] STF 11:50:17.072 - | Expectation: NEVER [2024-01-22T11:50:17.403Z] STF 11:50:17.072 - | [2024-01-22T11:50:17.403Z] STF 11:50:17.073 - Running command: /ssd/jenkins/workspace/Test_openjdk8_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 /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.load/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/log4j/log4j-api.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/log4j/log4j-core.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/junit.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/hamcrest-core.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-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 /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-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-01-22T11:50:17.403Z] STF 11:50:17.073 - Redirecting stderr to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/1.LT1.stderr [2024-01-22T11:50:17.403Z] STF 11:50:17.073 - Redirecting stdout to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/1.LT1.stdout [2024-01-22T11:50:17.403Z] STF 11:50:17.094 - [2024-01-22T11:50:17.403Z] STF 11:50:17.094 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-01-22T11:50:17.403Z] STF 11:50:17.094 - | Start background process [2024-01-22T11:50:17.403Z] STF 11:50:17.094 - | Program: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-01-22T11:50:17.403Z] STF 11:50:17.094 - | Mnemonic: CL1 [2024-01-22T11:50:17.403Z] STF 11:50:17.095 - | Echo: ECHO_ON [2024-01-22T11:50:17.403Z] STF 11:50:17.095 - | Expectation: CLEAN_RUN within 30m [2024-01-22T11:50:17.403Z] STF 11:50:17.095 - | [2024-01-22T11:50:17.403Z] STF 11:50:17.096 - Running command: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -classpath /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler proxy /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-01-22T11:50:17.403Z] STF 11:50:17.096 - Redirecting stderr to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/2.CL1.stderr [2024-01-22T11:50:17.403Z] STF 11:50:17.096 - Redirecting stdout to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/2.CL1.stdout [2024-01-22T11:50:17.403Z] STF 11:50:17.098 - [2024-01-22T11:50:17.403Z] STF 11:50:17.098 - +------ Step 3 - Wait for processes to complete [2024-01-22T11:50:17.403Z] STF 11:50:17.098 - | Wait for processes to meet expectations [2024-01-22T11:50:17.403Z] STF 11:50:17.098 - | Processes: [LT1, CL1] [2024-01-22T11:50:17.403Z] STF 11:50:17.098 - | [2024-01-22T11:50:17.403Z] STF 11:50:17.098 - Monitoring processes: CL1 LT1 [2024-01-22T11:50:17.790Z] CL1 j> 2024/01/22 11:50:17.370 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-01-22T11:50:17.791Z] CL1 j> 2024/01/22 11:50:17.440 Attempting to connect [2024-01-22T11:50:18.169Z] CL1 j> 2024/01/22 11:50:17.856 Monitored VM not ready at Jan 22, 2024 11:50:17 AM (attempt 1, elapsed 382ms). [2024-01-22T11:50:18.169Z] CL1 j> 2024/01/22 11:50:17.857 Waiting 5 secs and trying again... [2024-01-22T11:50:23.310Z] CL1 j> 2024/01/22 11:50:22.864 Attempting to connect [2024-01-22T11:50:24.130Z] CL1 j> 2024/01/22 11:50:23.601 Connection established! [2024-01-22T11:50:24.131Z] CL1 j> 2024/01/22 11:50:23.943 Starting to write data [2024-01-22T11:55:20.264Z] STF 11:55:16.095 - Heartbeat: Process CL1 is still running [2024-01-22T11:58:00.135Z] STF 11:57:52.186 - Monitoring Report Summary: [2024-01-22T11:58:00.135Z] STF 11:57:52.186 - o Process CL1 ended with the expected exit code (0) [2024-01-22T11:58:00.135Z] STF 11:57:52.186 - o Process LT1 is still running as expected [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - +------ Step 4 - Stop LT1 process [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - | Kill running processes [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - | Processes: [LT1] [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - | [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - Killing processes: LT1 [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - o Process clean up attempt 1 for LT1 pid 2965 [2024-01-22T11:58:00.135Z] STF 11:57:52.187 - o Process LT1 pid 2965 stop() [2024-01-22T11:58:02.640Z] STF 11:58:02.189 - o Process LT1 pid 2965 terminate() [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - o Process LT1 pid 2965 killed [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - +------ Step 5 - Running ThreadProfiler Server test Server Process(without security) [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - | Start background process [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - | Program: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - | Mnemonic: LT2 [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - | Echo: ECHO_OFF [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - | Expectation: NEVER [2024-01-22T11:58:03.445Z] STF 11:58:03.190 - | [2024-01-22T11:58:03.445Z] STF 11:58:03.191 - Running command: /ssd/jenkins/workspace/Test_openjdk8_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 /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.load/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/STF/stf.core/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/log4j/log4j-api.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/log4j/log4j-core.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/junit.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/hamcrest-core.jar:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.lang/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.util/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.math/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-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 /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-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-01-22T11:58:03.445Z] STF 11:58:03.191 - Redirecting stderr to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/5.LT2.stderr [2024-01-22T11:58:03.445Z] STF 11:58:03.191 - Redirecting stdout to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/5.LT2.stdout [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - | Start background process [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - | Program: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - | Mnemonic: CL2 [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - | Echo: ECHO_ON [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - | Expectation: CLEAN_RUN within 30m [2024-01-22T11:58:03.445Z] STF 11:58:03.193 - | [2024-01-22T11:58:03.445Z] STF 11:58:03.195 - Running command: /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jdkbinary/j2sdk-image/bin/java -Xmx256m -classpath /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/aqa-systemtest/openjdk.test.jlm/bin:/ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/jvmtest/system/systemtest_prereqs/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ThreadProfiler server /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/thd_proxy.log /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/thd_proxy.csv anon localhost 1234 [2024-01-22T11:58:03.445Z] STF 11:58:03.195 - Redirecting stderr to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/6.CL2.stderr [2024-01-22T11:58:03.445Z] STF 11:58:03.195 - Redirecting stdout to /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/results/6.CL2.stdout [2024-01-22T11:58:03.445Z] STF 11:58:03.197 - [2024-01-22T11:58:03.445Z] STF 11:58:03.197 - +------ Step 7 - Wait for processes to complete [2024-01-22T11:58:03.445Z] STF 11:58:03.197 - | Wait for processes to meet expectations [2024-01-22T11:58:03.445Z] STF 11:58:03.197 - | Processes: [LT2, CL2] [2024-01-22T11:58:03.445Z] STF 11:58:03.197 - | [2024-01-22T11:58:03.445Z] STF 11:58:03.197 - Monitoring processes: CL2 LT2 [2024-01-22T11:58:04.250Z] CL2 j> 2024/01/22 11:58:03.466 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-01-22T11:58:04.250Z] CL2 j> 2024/01/22 11:58:03.534 Attempting to connect [2024-01-22T11:58:04.625Z] CL2 j> 2024/01/22 11:58:03.942 Monitored VM not ready at Jan 22, 2024 11:58:03 AM (attempt 1, elapsed 374ms). [2024-01-22T11:58:04.625Z] CL2 j> 2024/01/22 11:58:03.942 Waiting 5 secs and trying again... [2024-01-22T11:58:09.802Z] CL2 j> 2024/01/22 11:58:08.943 Attempting to connect [2024-01-22T11:58:10.618Z] CL2 j> 2024/01/22 11:58:09.869 Connection established! [2024-01-22T11:58:24.388Z] CL2 j> 2024/01/22 11:58:22.867 Writing report data ... [2024-01-22T11:58:33.851Z] CL2 j> 2024/01/22 11:58:33.150 done. [2024-01-22T11:58:45.307Z] CL2 j> 2024/01/22 11:58:43.376 Writing report data ... [2024-01-22T11:58:53.097Z] CL2 j> 2024/01/22 11:58:51.498 done. [2024-01-22T11:59:02.554Z] CL2 j> 2024/01/22 11:59:01.729 Writing report data ... [2024-01-22T11:59:10.346Z] CL2 j> 2024/01/22 11:59:09.946 done. [2024-01-22T11:59:21.766Z] CL2 j> 2024/01/22 11:59:20.353 Writing report data ... [2024-01-22T11:59:29.497Z] CL2 j> 2024/01/22 11:59:27.965 done. [2024-01-22T11:59:39.008Z] CL2 j> 2024/01/22 11:59:38.188 Writing report data ... [2024-01-22T11:59:46.780Z] CL2 j> 2024/01/22 11:59:45.905 done. [2024-01-22T11:59:58.167Z] CL2 j> 2024/01/22 11:59:56.143 Writing report data ... [2024-01-22T12:00:04.534Z] CL2 j> 2024/01/22 12:00:03.462 done. [2024-01-22T12:00:15.972Z] CL2 j> 2024/01/22 12:00:13.604 Writing report data ... [2024-01-22T12:00:16.781Z] STF 12:00:16.430 - Heartbeat: Process CL2 is still running [2024-01-22T12:00:21.929Z] CL2 j> 2024/01/22 12:00:21.256 done. [2024-01-22T12:00:33.451Z] CL2 j> 2024/01/22 12:00:31.483 Writing report data ... [2024-01-22T12:00:39.785Z] CL2 j> 2024/01/22 12:00:38.311 done. [2024-01-22T12:00:49.235Z] CL2 j> 2024/01/22 12:00:48.480 Writing report data ... [2024-01-22T12:00:56.974Z] CL2 j> 2024/01/22 12:00:55.538 done. [2024-01-22T12:01:06.458Z] CL2 j> 2024/01/22 12:01:05.809 Writing report data ... [2024-01-22T12:01:14.295Z] CL2 j> 2024/01/22 12:01:13.383 done. [2024-01-22T12:01:25.723Z] CL2 j> 2024/01/22 12:01:23.518 Writing report data ... [2024-01-22T12:01:32.068Z] CL2 j> 2024/01/22 12:01:30.554 done. [2024-01-22T12:01:41.524Z] CL2 j> 2024/01/22 12:01:40.759 Writing report data ... [2024-01-22T12:01:49.299Z] CL2 j> 2024/01/22 12:01:48.262 done. [2024-01-22T12:02:00.704Z] CL2 j> 2024/01/22 12:01:58.522 Writing report data ... [2024-01-22T12:02:06.112Z] CL2 j> 2024/01/22 12:02:05.746 done. [2024-01-22T12:02:17.551Z] CL2 j> 2024/01/22 12:02:15.977 Writing report data ... [2024-01-22T12:02:23.880Z] CL2 j> 2024/01/22 12:02:22.897 done. [2024-01-22T12:02:35.355Z] CL2 j> 2024/01/22 12:02:33.123 Writing report data ... [2024-01-22T12:02:41.720Z] CL2 j> 2024/01/22 12:02:40.594 done. [2024-01-22T12:02:53.119Z] CL2 j> 2024/01/22 12:02:50.842 Writing report data ... [2024-01-22T12:02:59.587Z] CL2 j> 2024/01/22 12:02:58.379 done. [2024-01-22T12:03:09.019Z] CL2 j> 2024/01/22 12:03:08.530 Writing report data ... [2024-01-22T12:03:16.750Z] CL2 j> 2024/01/22 12:03:15.846 done. [2024-01-22T12:03:28.131Z] CL2 j> 2024/01/22 12:03:26.111 Writing report data ... [2024-01-22T12:03:34.456Z] CL2 j> 2024/01/22 12:03:32.838 done. [2024-01-22T12:03:43.881Z] CL2 j> 2024/01/22 12:03:43.025 Writing report data ... [2024-01-22T12:03:51.677Z] CL2 j> 2024/01/22 12:03:50.310 done. [2024-01-22T12:04:01.135Z] CL2 j> 2024/01/22 12:04:00.473 Writing report data ... [2024-01-22T12:04:08.889Z] CL2 j> 2024/01/22 12:04:07.682 done. [2024-01-22T12:04:20.336Z] CL2 j> 2024/01/22 12:04:17.869 Writing report data ... [2024-01-22T12:04:26.692Z] CL2 j> 2024/01/22 12:04:24.723 done. [2024-01-22T12:04:36.208Z] CL2 j> 2024/01/22 12:04:34.837 Writing report data ... [2024-01-22T12:04:43.992Z] CL2 j> 2024/01/22 12:04:42.228 done. [2024-01-22T12:04:53.478Z] CL2 j> 2024/01/22 12:04:52.520 Writing report data ... [2024-01-22T12:05:01.190Z] CL2 j> 2024/01/22 12:04:59.440 done. [2024-01-22T12:05:10.599Z] CL2 j> 2024/01/22 12:05:09.574 Writing report data ... [2024-01-22T12:05:16.920Z] STF 12:05:16.027 - Heartbeat: Process CL2 is still running [2024-01-22T12:05:18.207Z] CL2 j> 2024/01/22 12:05:17.130 done. [2024-01-22T12:05:29.728Z] CL2 j> 2024/01/22 12:05:27.458 Writing report data ... [2024-01-22T12:05:36.091Z] CL2 j> 2024/01/22 12:05:34.883 done. [2024-01-22T12:05:47.473Z] CL2 j> 2024/01/22 12:05:45.086 Writing report data ... [2024-01-22T12:05:53.845Z] CL2 j> 2024/01/22 12:05:52.041 done. [2024-01-22T12:06:03.276Z] CL2 j> 2024/01/22 12:06:02.251 Writing report data ... [2024-01-22T12:06:11.077Z] CL2 j> 2024/01/22 12:06:09.343 done. [2024-01-22T12:06:20.523Z] CL2 j> 2024/01/22 12:06:19.505 Writing report data ... [2024-01-22T12:06:28.255Z] CL2 j> 2024/01/22 12:06:27.010 done. [2024-01-22T12:06:39.672Z] CL2 j> 2024/01/22 12:06:37.188 Writing report data ... [2024-01-22T12:06:45.983Z] CL2 j> 2024/01/22 12:06:44.393 done. [2024-01-22T12:06:55.390Z] CL2 j> 2024/01/22 12:06:54.583 Writing report data ... [2024-01-22T12:07:01.753Z] CL2 j> 2024/01/22 12:07:01.126 done. [2024-01-22T12:07:02.584Z] STF 12:07:02.249 - Monitoring Report Summary: [2024-01-22T12:07:02.584Z] STF 12:07:02.250 - o Process CL2 ended with the expected exit code (0) [2024-01-22T12:07:02.584Z] STF 12:07:02.250 - o Process LT2 is still running as expected [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - +------ Step 8 - Stop LT2 process [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - | Kill running processes [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - | Processes: [LT2] [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - | [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - Killing processes: LT2 [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - o Process clean up attempt 1 for LT2 pid 3445 [2024-01-22T12:07:02.584Z] STF 12:07:02.251 - o Process LT2 pid 3445 stop() [2024-01-22T12:07:13.983Z] STF 12:07:12.269 - o Process LT2 pid 3445 terminate() [2024-01-22T12:07:13.983Z] STF 12:07:13.270 - o Process LT2 pid 3445 killed [2024-01-22T12:07:13.983Z] STF 12:07:13.270 - EXECUTE stage completed [2024-01-22T12:07:13.983Z] STF 12:07:13.545 - [2024-01-22T12:07:13.983Z] STF 12:07:13.545 - ==================== T E A R D O W N ==================== [2024-01-22T12:07:13.983Z] STF 12:07:13.545 - Running teardown: perl /ssd/jenkins/workspace/Test_openjdk8_hs_sanity.system_arm_linux/aqa-tests/TKG/../TKG/output_17059219191197/TestJlmRemoteThreadNoAuth_2/20240122-115013-TestJlmRemoteThreadNoAuth/tearDown.pl [2024-01-22T12:07:13.983Z] STF 12:07:13.682 - TEARDOWN stage completed [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - ===================== R E S U L T S ===================== [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - Stage results: [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - setUp: pass [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - execute: pass [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - teardown: pass [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - [2024-01-22T12:07:13.983Z] STF 12:07:13.691 - Overall result: PASSED [2024-01-22T12:07:13.983Z] ----------------------------------- [2024-01-22T12:07:13.983Z] TestJlmRemoteThreadNoAuth_2_PASSED [2024-01-22T12:07:13.983Z] ----------------------------------- [2024-01-22T12:07:13.983Z] [2024-01-22T12:07:13.983Z] TEST TEARDOWN: [2024-01-22T12:07:13.983Z] Nothing to be done for teardown. [2024-01-22T12:07:13.983Z] TestJlmRemoteThreadNoAuth_2 Finish Time: Mon Jan 22 12:07:13 2024 Epoch Time (ms): 1705925233734