[2024-11-08T20:19:36.860Z] Running test TestJlmRemoteClassNoAuth_2 ... [2024-11-08T20:19:37.178Z] =============================================== [2024-11-08T20:19:37.178Z] TestJlmRemoteClassNoAuth_2 Start Time: Fri Nov 8 20:19:37 2024 Epoch Time (ms): 1731097177023 [2024-11-08T20:19:37.178Z] variation: Mode1000 [2024-11-08T20:19:37.507Z] JVM_OPTIONS: [2024-11-08T20:19:37.507Z] { \ [2024-11-08T20:19:37.507Z] echo ""; echo "TEST SETUP:"; \ [2024-11-08T20:19:37.507Z] echo "Nothing to be done for setup."; \ [2024-11-08T20:19:37.507Z] mkdir -p "C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\\TKG\\output_17310971309251\\TestJlmRemoteClassNoAuth_2"; \ [2024-11-08T20:19:37.507Z] cd "C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\\TKG\\output_17310971309251\\TestJlmRemoteClassNoAuth_2"; \ [2024-11-08T20:19:37.507Z] echo ""; echo "TESTING:"; \ [2024-11-08T20:19:37.507Z] perl C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\STF;C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests///..//jvmtest\\system\\jlm/../\\aqa-systemtest""" -systemtest-prereqs="c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/../../testDependency/system_lib\\" -java-args=' ' -results-root="C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\\TKG\\output_17310971309251\\TestJlmRemoteClassNoAuth_2" -test=TestJlmRemoteClassNoAuth; \ [2024-11-08T20:19:37.507Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "TestJlmRemoteClassNoAuth_2""_PASSED"; echo "-----------------------------------"; cd C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/; rm -f -r "C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\\TKG\\output_17310971309251\\TestJlmRemoteClassNoAuth_2"; else echo "-----------------------------------"; echo "TestJlmRemoteClassNoAuth_2""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-08T20:19:37.507Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-08T20:19:37.507Z] echo "Nothing to be done for teardown."; \ [2024-11-08T20:19:37.508Z] } 2>&1 | tee -a "C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\\TKG\\output_17310971309251\\TestTargetResult"; [2024-11-08T20:19:37.508Z] [2024-11-08T20:19:37.508Z] TEST SETUP: [2024-11-08T20:19:37.508Z] Nothing to be done for setup. [2024-11-08T20:19:37.508Z] [2024-11-08T20:19:37.508Z] TESTING: [2024-11-08T20:19:37.832Z] STF 20:19:37.642 - ========================= S T F ========================= [2024-11-08T20:19:37.833Z] systemtest-prereqs has been processed, and set to: c:/workspace/testDependency/system_libRetrieving amount of free space on drive containing C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2 [2024-11-08T20:19:37.833Z] There is 95188 Mb free [2024-11-08T20:19:37.833Z] STF 20:19:37.712 - ================== G E N E R A T I O N ================== [2024-11-08T20:19:37.833Z] STF 20:19:37.715 - Checking JVM: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image [2024-11-08T20:19:37.833Z] STF 20:19:37.715 - Starting process to generate scripts: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/../../testDependency/system_lib\/log4j/log4j-api.jar;c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/stf_parameters.properties, , C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth" [2024-11-08T20:19:38.946Z] GEN 20:19:38.634 - Found test. Project: 'openjdk.test.jlm' class: 'TestJlmRemoteClassNoAuth.class' Dir: 'C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin' [2024-11-08T20:19:38.946Z] GEN 20:19:38.683 - Found test. Project: 'openjdk.test.jlm' class: 'net.adoptopenjdk.test.jlm.TestJlmRemoteClassNoAuth' [2024-11-08T20:19:38.946Z] GEN Classpath directories used by project 'openjdk.test.jlm': [2024-11-08T20:19:38.946Z] GEN C:\\workspace\\workspace\\Test_openjdk17_hs_sanity.system_x86-32_windows\\jvmtest\\system\\aqa-systemtest\\openjdk.test.jlm\\bin [2024-11-08T20:19:38.946Z] GEN C:\\workspace\\workspace\\Test_openjdk17_hs_sanity.system_x86-32_windows\\jvmtest\\system\\STF\\stf.core\\bin [2024-11-08T20:19:38.946Z] GEN c:/workspace/testDependency/system_lib/log4j/log4j-api.jar [2024-11-08T20:19:38.946Z] GEN c:/workspace/testDependency/system_lib/log4j/log4j-core.jar [2024-11-08T20:19:38.946Z] GEN c:/workspace/testDependency/system_lib/junit/junit.jar [2024-11-08T20:19:39.273Z] GEN 20:19:38.933 - Using Mode NoOptions. Values = '' [2024-11-08T20:19:39.273Z] GEN 20:19:39.157 - [2024-11-08T20:19:39.273Z] GEN 20:19:39.157 - Test command summary: [2024-11-08T20:19:39.273Z] GEN 20:19:39.157 - Step Stage Command Description [2024-11-08T20:19:39.273Z] GEN 20:19:39.157 - -----+--------+-----------------+------------ [2024-11-08T20:19:39.273Z] GEN 20:19:39.157 - 1 execute Run java Running ClassProfiler Proxy test Server Process [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 2 execute Run java Running the monitoring Client with proxy connection(without security) [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 3 execute Monitor Wait for processes to complete [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 4 execute kill Stop LT1 process [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 5 execute Run java Running ClassProfiler Server test Server Process(without security) [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 6 execute Run java Running the Monitoring Client with server-connection(without security) [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 7 execute Monitor Wait for processes to complete [2024-11-08T20:19:39.273Z] GEN 20:19:39.158 - 8 execute kill Stop LT2 process [2024-11-08T20:19:39.273Z] STF 20:19:39.198 - [2024-11-08T20:19:39.273Z] STF 20:19:39.198 - Script generation completed [2024-11-08T20:19:39.273Z] STF 20:19:39.198 - [2024-11-08T20:19:39.273Z] STF 20:19:39.201 - [2024-11-08T20:19:39.273Z] STF 20:19:39.201 - ======================= S E T U P ======================= [2024-11-08T20:19:39.273Z] STF 20:19:39.201 - Running setup: perl C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/setUp.pl [2024-11-08T20:19:39.603Z] STF 20:19:39.376 - SETUP stage completed [2024-11-08T20:19:39.603Z] STF 20:19:39.394 - [2024-11-08T20:19:39.603Z] STF 20:19:39.394 - ==================== E X E C U T E - ==================== [2024-11-08T20:19:39.603Z] STF 20:19:39.394 - Running execute: perl C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/execute.pl [2024-11-08T20:19:39.938Z] STF 20:19:39.571 - [2024-11-08T20:19:39.938Z] STF 20:19:39.571 - Java version [2024-11-08T20:19:39.938Z] STF 20:19:39.571 - Running: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java -version [2024-11-08T20:19:39.938Z] openjdk version "17.0.14-beta" 2025-01-21 [2024-11-08T20:19:39.938Z] OpenJDK Runtime Environment Temurin-17.0.14+2-202411081525 (build 17.0.14-beta+2-ea) [2024-11-08T20:19:39.938Z] OpenJDK Client VM Temurin-17.0.14+2-202411081525 (build 17.0.14-beta+2-ea, mixed mode, emulated-client) [2024-11-08T20:19:39.938Z] STF 20:19:39.715 - [2024-11-08T20:19:39.938Z] STF 20:19:39.715 - +------ Step 1 - Running ClassProfiler Proxy test Server Process [2024-11-08T20:19:39.938Z] STF 20:19:39.715 - | Start background process [2024-11-08T20:19:39.938Z] STF 20:19:39.715 - | Program: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java [2024-11-08T20:19:39.938Z] STF 20:19:39.715 - | Mnemonic: LT1 [2024-11-08T20:19:39.939Z] STF 20:19:39.715 - | Echo: ECHO_OFF [2024-11-08T20:19:39.939Z] STF 20:19:39.715 - | Expectation: NEVER [2024-11-08T20:19:39.939Z] STF 20:19:39.715 - | [2024-11-08T20:19:39.939Z] STF 20:19:39.716 - Running command: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/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 C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\STF\stf.load\bin;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\STF\stf.core\bin;c:/workspace/testDependency/system_lib/log4j/log4j-api.jar;c:/workspace/testDependency/system_lib/log4j/log4j-core.jar;c:/workspace/testDependency/system_lib/junit/junit.jar;c:/workspace/testDependency/system_lib/junit/hamcrest-core.jar;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\aqa-tests\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2\20241108-201937-TestJlmRemoteClassNoAuth\results -resultsPrefix 1.LT1. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/1.LT1.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/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-08T20:19:39.939Z] STF 20:19:39.716 - Redirecting stderr to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/1.LT1.stderr [2024-11-08T20:19:39.939Z] STF 20:19:39.716 - Redirecting stdout to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/1.LT1.stdout [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - +------ Step 2 - Running the monitoring Client with proxy connection(without security) [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - | Start background process [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - | Program: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - | Mnemonic: CL1 [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - | Echo: ECHO_ON [2024-11-08T20:19:39.939Z] STF 20:19:39.758 - | Expectation: CLEAN_RUN within 30m [2024-11-08T20:19:39.939Z] STF 20:19:39.759 - | [2024-11-08T20:19:39.939Z] STF 20:19:39.759 - Running command: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -classpath C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;c:/workspace/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ClassProfiler proxy C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/cls_proxy.log C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/cls_proxy.csv anon localhost 1234 [2024-11-08T20:19:39.939Z] STF 20:19:39.759 - Redirecting stderr to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/2.CL1.stderr [2024-11-08T20:19:39.939Z] STF 20:19:39.759 - Redirecting stdout to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/2.CL1.stdout [2024-11-08T20:19:39.939Z] STF 20:19:39.773 - [2024-11-08T20:19:39.939Z] STF 20:19:39.773 - +------ Step 3 - Wait for processes to complete [2024-11-08T20:19:39.939Z] STF 20:19:39.773 - | Wait for processes to meet expectations [2024-11-08T20:19:39.939Z] STF 20:19:39.773 - | Processes: [LT1, CL1] [2024-11-08T20:19:39.939Z] STF 20:19:39.773 - | [2024-11-08T20:19:39.939Z] STF 20:19:39.773 - Monitoring processes: CL1 LT1 [2024-11-08T20:19:40.267Z] CL1 j> 2024/11/08 20:19:40.068 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-08T20:19:40.267Z] CL1 j> 2024/11/08 20:19:40.146 Attempting to connect [2024-11-08T20:19:40.593Z] CL1 j> 2024/11/08 20:19:40.444 Monitored VM not ready at Nov 8, 2024, 8:19:40 PM (attempt 1, elapsed 272ms). [2024-11-08T20:19:40.593Z] CL1 j> 2024/11/08 20:19:40.444 Waiting 5 secs and trying again... [2024-11-08T20:19:46.512Z] CL1 j> 2024/11/08 20:19:45.446 Attempting to connect [2024-11-08T20:19:46.512Z] CL1 j> 2024/11/08 20:19:45.636 Connection established! [2024-11-08T20:19:48.855Z] CL1 j> 2024/11/08 20:19:48.301 Starting to write data [2024-11-08T20:24:43.168Z] STF 20:24:39.246 - Heartbeat: Process LT1 is still running [2024-11-08T20:24:59.143Z] STF 20:24:57.474 - Monitoring Report Summary: [2024-11-08T20:24:59.143Z] STF 20:24:57.474 - o Process CL1 ended with the expected exit code (0) [2024-11-08T20:24:59.143Z] STF 20:24:57.474 - o Process LT1 is still running as expected [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - +------ Step 4 - Stop LT1 process [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - | Kill running processes [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - | Processes: [LT1] [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - | [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - Killing processes: LT1 [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - o Process clean up attempt 1 for LT1 pid 37048 [2024-11-08T20:24:59.143Z] STF 20:24:57.475 - o Process LT1 pid 37048 stop() [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - o Process LT1 pid 37048 killed [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - +------ Step 5 - Running ClassProfiler Server test Server Process(without security) [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - | Start background process [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - | Program: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - | Mnemonic: LT2 [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - | Echo: ECHO_OFF [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - | Expectation: NEVER [2024-11-08T20:24:59.143Z] STF 20:24:57.476 - | [2024-11-08T20:24:59.144Z] STF 20:24:57.477 - Running command: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/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 C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\STF\stf.load\bin;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\STF\stf.core\bin;c:/workspace/testDependency/system_lib/log4j/log4j-api.jar;c:/workspace/testDependency/system_lib/log4j/log4j-core.jar;c:/workspace/testDependency/system_lib/junit/junit.jar;c:/workspace/testDependency/system_lib/junit/hamcrest-core.jar;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.lang\bin;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.util\bin;C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.math\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\aqa-tests\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2\20241108-201937-TestJlmRemoteClassNoAuth\results -resultsPrefix 5.LT2. -timeLimit 30m -abortAtFailureLimit -1 -reportFailureLimit 1 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.mini-mix.totalNumberTests 20000000 -suite.mini-mix.inventoryFile C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix.xml -suite.mini-mix.inventoryExcludeFile C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/5.LT2.inventory/openjdk.test.load/config/inventories/mix/mini-mix_exclude.xml -suite.mini-mix.inventoryExcludeFile C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/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-08T20:24:59.144Z] STF 20:24:57.477 - Redirecting stderr to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/5.LT2.stderr [2024-11-08T20:24:59.144Z] STF 20:24:57.477 - Redirecting stdout to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/5.LT2.stdout [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - +------ Step 6 - Running the Monitoring Client with server-connection(without security) [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - | Start background process [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - | Program: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - | Mnemonic: CL2 [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - | Echo: ECHO_ON [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - | Expectation: CLEAN_RUN within 30m [2024-11-08T20:24:59.144Z] STF 20:24:57.492 - | [2024-11-08T20:24:59.144Z] STF 20:24:57.493 - Running command: c:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/jdkbinary/j2sdk-image/bin/java -Xmx256m -classpath C:\workspace\workspace\Test_openjdk17_hs_sanity.system_x86-32_windows\jvmtest\system\aqa-systemtest\openjdk.test.jlm\bin;c:/workspace/testDependency/system_lib/junit/junit.jar net.adoptopenjdk.test.jlm.remote.ClassProfiler server C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/cls_proxy.log C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/cls_proxy.csv anon localhost 1234 [2024-11-08T20:24:59.144Z] STF 20:24:57.493 - Redirecting stderr to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/6.CL2.stderr [2024-11-08T20:24:59.144Z] STF 20:24:57.493 - Redirecting stdout to C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/TKG/output_17310971309251/TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/results/6.CL2.stdout [2024-11-08T20:24:59.144Z] STF 20:24:57.505 - [2024-11-08T20:24:59.144Z] STF 20:24:57.505 - +------ Step 7 - Wait for processes to complete [2024-11-08T20:24:59.144Z] STF 20:24:57.505 - | Wait for processes to meet expectations [2024-11-08T20:24:59.144Z] STF 20:24:57.505 - | Processes: [LT2, CL2] [2024-11-08T20:24:59.144Z] STF 20:24:57.505 - | [2024-11-08T20:24:59.144Z] STF 20:24:57.505 - Monitoring processes: CL2 LT2 [2024-11-08T20:24:59.144Z] CL2 j> 2024/11/08 20:24:57.775 ServerURL=service:jmx:rmi:///jndi/rmi://localhost:1234/jmxrmi [2024-11-08T20:24:59.144Z] CL2 j> 2024/11/08 20:24:57.848 Attempting to connect [2024-11-08T20:24:59.144Z] CL2 j> 2024/11/08 20:24:58.097 Monitored VM not ready at Nov 8, 2024, 8:24:58 PM (attempt 1, elapsed 225ms). [2024-11-08T20:24:59.144Z] CL2 j> 2024/11/08 20:24:58.097 Waiting 5 secs and trying again... [2024-11-08T20:25:03.927Z] CL2 j> 2024/11/08 20:25:03.111 Attempting to connect [2024-11-08T20:25:04.267Z] CL2 j> 2024/11/08 20:25:03.267 Connection established! [2024-11-08T20:29:43.511Z] STF 20:29:39.350 - Heartbeat: Process LT2 is still running [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - Monitoring Report Summary: [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - o Process CL2 ended with the expected exit code (0) [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - o Process LT2 is still running as expected [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - +------ Step 8 - Stop LT2 process [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - | Kill running processes [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - | Processes: [LT2] [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - | [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - Killing processes: LT2 [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - o Process clean up attempt 1 for LT2 pid 25860 [2024-11-08T20:30:11.264Z] STF 20:30:09.119 - o Process LT2 pid 25860 stop() [2024-11-08T20:30:11.264Z] STF 20:30:09.120 - o Process LT2 pid 25860 killed [2024-11-08T20:30:11.264Z] STF 20:30:09.120 - EXECUTE stage completed [2024-11-08T20:30:11.264Z] STF 20:30:09.610 - [2024-11-08T20:30:11.264Z] STF 20:30:09.610 - ==================== T E A R D O W N ==================== [2024-11-08T20:30:11.264Z] STF 20:30:09.610 - Running teardown: perl C:/workspace/workspace/Test_openjdk17_hs_sanity.system_x86-32_windows/aqa-tests/\TKG\output_17310971309251\TestJlmRemoteClassNoAuth_2/20241108-201937-TestJlmRemoteClassNoAuth/tearDown.pl [2024-11-08T20:30:11.264Z] STF 20:30:09.800 - TEARDOWN stage completed [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - ===================== R E S U L T S ===================== [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - Stage results: [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - setUp: pass [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - execute: pass [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - teardown: pass [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - [2024-11-08T20:30:11.264Z] STF 20:30:09.816 - Overall result: PASSED [2024-11-08T20:30:11.264Z] ----------------------------------- [2024-11-08T20:30:11.264Z] TestJlmRemoteClassNoAuth_2_PASSED [2024-11-08T20:30:11.264Z] ----------------------------------- [2024-11-08T20:30:11.265Z] [2024-11-08T20:30:11.265Z] TEST TEARDOWN: [2024-11-08T20:30:11.265Z] Nothing to be done for teardown. [2024-11-08T20:30:11.265Z] TestJlmRemoteClassNoAuth_2 Finish Time: Fri Nov 8 20:30:10 2024 Epoch Time (ms): 1731097810020