[2024-08-29T00:06:48.555Z] Running test ConcurrentLoadTest_5m_1 ... [2024-08-29T00:06:48.555Z] =============================================== [2024-08-29T00:06:48.555Z] ConcurrentLoadTest_5m_1 Start Time: Thu Aug 29 00:06:48 2024 Epoch Time (ms): 1724890008476 [2024-08-29T00:06:48.555Z] variation: Mode650 [2024-08-29T00:06:48.858Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-08-29T00:06:48.858Z] { \ [2024-08-29T00:06:48.858Z] echo ""; echo "TEST SETUP:"; \ [2024-08-29T00:06:48.858Z] echo "Nothing to be done for setup."; \ [2024-08-29T00:06:48.858Z] mkdir -p "F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\\TKG\\output_17248863237634\\ConcurrentLoadTest_5m_1"; \ [2024-08-29T00:06:48.858Z] cd "F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\\TKG\\output_17248863237634\\ConcurrentLoadTest_5m_1"; \ [2024-08-29T00:06:48.858Z] echo ""; echo "TESTING:"; \ [2024-08-29T00:06:48.858Z] perl F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\otherLoadTest/../\\STF\\stf.core\\scripts\\stf.pl -test-root="F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\otherLoadTest/../\\STF;F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests///..//jvmtest\\system\\otherLoadTest/../\\aqa-systemtest""" -systemtest-prereqs="F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/../../testDependency/system_lib\\" -java-args=' -XX:-UseCompressedOops ' -results-root="F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\\TKG\\output_17248863237634\\ConcurrentLoadTest_5m_1" -test=ConcurrentLoadTest -test-args="timeLimit=5m"; \ [2024-08-29T00:06:48.858Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "ConcurrentLoadTest_5m_1""_PASSED"; echo "-----------------------------------"; cd F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/; rm -f -r "F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\\TKG\\output_17248863237634\\ConcurrentLoadTest_5m_1"; else echo "-----------------------------------"; echo "ConcurrentLoadTest_5m_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-29T00:06:48.858Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-29T00:06:48.858Z] echo "Nothing to be done for teardown."; \ [2024-08-29T00:06:48.858Z] } 2>&1 | tee -a "F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\\TKG\\output_17248863237634\\TestTargetResult"; [2024-08-29T00:06:48.858Z] [2024-08-29T00:06:48.858Z] TEST SETUP: [2024-08-29T00:06:48.858Z] Nothing to be done for setup. [2024-08-29T00:06:48.858Z] [2024-08-29T00:06:48.858Z] TESTING: [2024-08-29T00:06:49.166Z] STF 00:06:48.902 - ========================= S T F ========================= [2024-08-29T00:06:49.166Z] systemtest-prereqs has been processed, and set to: F:/workspace/testDependency/system_libRetrieving amount of free space on drive containing F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\TKG\output_17248863237634\ConcurrentLoadTest_5m_1 [2024-08-29T00:06:49.167Z] There is 113775 Mb free [2024-08-29T00:06:49.167Z] STF 00:06:48.933 - ================== G E N E R A T I O N ================== [2024-08-29T00:06:49.167Z] STF 00:06:48.937 - Checking JVM: F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jdkbinary/j2sdk-image [2024-08-29T00:06:49.167Z] STF 00:06:48.937 - Starting process to generate scripts: F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/../../testDependency/system_lib\/log4j/log4j-api.jar;F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/../../testDependency/system_lib\/log4j/log4j-core.jar;F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\TKG\output_17248863237634\ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/stf_parameters.properties, , F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\TKG\output_17248863237634\ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest" [2024-08-29T00:06:49.167Z] GEN stderr OpenJDK 64-Bit Server VM warning: 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-08-29T00:06:49.829Z] GEN 00:06:49.804 - Found test. Project: 'openjdk.test.load' class: 'ConcurrentLoadTest.class' Dir: 'F:\workspace\workspace\Test_openjdk17_hs_extended.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.load\bin' [2024-08-29T00:06:50.132Z] GEN 00:06:49.822 - Found test. Project: 'openjdk.test.load' class: 'net.adoptopenjdk.stf.ConcurrentLoadTest' [2024-08-29T00:06:50.132Z] GEN Classpath directories used by project 'openjdk.test.load': [2024-08-29T00:06:50.132Z] GEN F:\\workspace\\workspace\\Test_openjdk17_hs_extended.system_x86-64_windows\\jvmtest\\system\\aqa-systemtest\\openjdk.test.load\\bin [2024-08-29T00:06:50.132Z] GEN F:\\workspace\\workspace\\Test_openjdk17_hs_extended.system_x86-64_windows\\jvmtest\\system\\STF\\stf.core\\bin [2024-08-29T00:06:50.132Z] GEN F:\\workspace\\workspace\\Test_openjdk17_hs_extended.system_x86-64_windows\\jvmtest\\system\\STF\\stf.load\\bin [2024-08-29T00:06:50.132Z] GEN F:/workspace/testDependency/system_lib/log4j/log4j-api.jar [2024-08-29T00:06:50.132Z] GEN F:/workspace/testDependency/system_lib/log4j/log4j-core.jar [2024-08-29T00:06:50.132Z] GEN F:/workspace/testDependency/system_lib/junit/junit.jar [2024-08-29T00:06:50.132Z] GEN F:/workspace/testDependency/system_lib/junit/hamcrest-core.jar [2024-08-29T00:06:50.132Z] GEN 00:06:50.050 - Using Mode NoOptions. Values = '' [2024-08-29T00:06:50.436Z] GEN 00:06:50.135 - [2024-08-29T00:06:50.437Z] GEN 00:06:50.136 - Test command summary: [2024-08-29T00:06:50.437Z] GEN 00:06:50.136 - Step Stage Command Description [2024-08-29T00:06:50.437Z] GEN 00:06:50.136 - -----+--------+-----------------+------------ [2024-08-29T00:06:50.437Z] GEN 00:06:50.137 - 1 execute Run java Run concurrency unit tests [2024-08-29T00:06:50.437Z] STF 00:06:50.168 - [2024-08-29T00:06:50.437Z] STF 00:06:50.168 - Script generation completed [2024-08-29T00:06:50.437Z] STF 00:06:50.168 - [2024-08-29T00:06:50.437Z] STF 00:06:50.168 - [2024-08-29T00:06:50.437Z] STF 00:06:50.168 - ======================= S E T U P ======================= [2024-08-29T00:06:50.437Z] STF 00:06:50.168 - Running setup: perl F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\TKG\output_17248863237634\ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/setUp.pl [2024-08-29T00:06:50.437Z] STF 00:06:50.294 - SETUP stage completed [2024-08-29T00:06:50.437Z] STF 00:06:50.311 - [2024-08-29T00:06:50.437Z] STF 00:06:50.311 - ==================== E X E C U T E - ==================== [2024-08-29T00:06:50.437Z] STF 00:06:50.311 - Running execute: perl F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\TKG\output_17248863237634\ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/execute.pl [2024-08-29T00:06:50.740Z] STF 00:06:50.439 - [2024-08-29T00:06:50.740Z] STF 00:06:50.439 - Java version [2024-08-29T00:06:50.740Z] STF 00:06:50.439 - Running: F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -version [2024-08-29T00:06:50.740Z] openjdk version "17.0.13-beta" 2024-10-15 [2024-08-29T00:06:50.740Z] OpenJDK Runtime Environment Temurin-17.0.13+5-202408281940 (build 17.0.13-beta+5-ea) [2024-08-29T00:06:50.740Z] OpenJDK 64-Bit Server VM Temurin-17.0.13+5-202408281940 (build 17.0.13-beta+5-ea, mixed mode, sharing) [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - +------ Step 1 - Run concurrency unit tests [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - | Run foreground process [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - | Program: F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - | Mnemonic: LT [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - | Echo: ECHO_ON [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - | Expectation: CLEAN_RUN within 1h5m [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - | [2024-08-29T00:06:50.740Z] STF 00:06:50.533 - Running command: F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jdkbinary/j2sdk-image/bin/java -XX:-UseCompressedOops -classpath F:\workspace\workspace\Test_openjdk17_hs_extended.system_x86-64_windows\jvmtest\system\STF\stf.load\bin;F:\workspace\workspace\Test_openjdk17_hs_extended.system_x86-64_windows\jvmtest\system\STF\stf.core\bin;F:/workspace/testDependency/system_lib/log4j/log4j-api.jar;F:/workspace/testDependency/system_lib/log4j/log4j-core.jar;F:/workspace/testDependency/system_lib/junit/junit.jar;F:/workspace/testDependency/system_lib/junit/hamcrest-core.jar;F:\workspace\workspace\Test_openjdk17_hs_extended.system_x86-64_windows\jvmtest\system\aqa-systemtest\openjdk.test.concurrent\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir F:\workspace\workspace\Test_openjdk17_hs_extended.system_x86-64_windows\aqa-tests\TKG\output_17248863237634\ConcurrentLoadTest_5m_1\20240829-000648-ConcurrentLoadTest\results -resultsPrefix 1.LT. -timeLimit 5m -abortIfOutOfMemory false -reportFailureLimit 1 -abortAtFailureLimit 10 -maxTotalLogFileSpace 200M -maxSingleLogSize 1/25 -suite.concurrent.threadCount 20 -suite.concurrent.inventoryFile F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/TKG/output_17248863237634/ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent.xml -suite.concurrent.inventoryExcludeFile F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/TKG/output_17248863237634/ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml -suite.concurrent.selection random -suite.concurrent.seed -1 -suite.concurrent.repeatCount 1 -suite.concurrent.thinkingTime 0ms..0ms [2024-08-29T00:06:50.741Z] STF 00:06:50.535 - Redirecting stderr to F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/TKG/output_17248863237634/ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/results/1.LT.stderr [2024-08-29T00:06:50.741Z] STF 00:06:50.535 - Redirecting stdout to F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/TKG/output_17248863237634/ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/results/1.LT.stdout [2024-08-29T00:06:50.741Z] STF 00:06:50.560 - Monitoring processes: LT [2024-08-29T00:06:51.398Z] LT 00:06:51.367 - Load test parameters [2024-08-29T00:06:51.398Z] LT 00:06:51.370 - Time limited = true [2024-08-29T00:06:51.398Z] LT 00:06:51.371 - Time limit = 5m [2024-08-29T00:06:51.398Z] LT 00:06:51.371 - abortIfOutOfMemory = false [2024-08-29T00:06:51.398Z] LT 00:06:51.371 - reportFailureLimit = 1 [2024-08-29T00:06:51.398Z] LT 00:06:51.371 - abortAtFailureLimit = 10 [2024-08-29T00:06:51.398Z] LT 00:06:51.374 - maxTotalLogFileSpace = 209715200 [2024-08-29T00:06:51.398Z] LT 00:06:51.375 - maxSingleLogSize = 8388608 [2024-08-29T00:06:51.398Z] LT 00:06:51.375 - Parameters for suite 0 [2024-08-29T00:06:51.398Z] LT 00:06:51.375 - Suite name = concurrent [2024-08-29T00:06:51.398Z] LT 00:06:51.375 - Number threads = 20 [2024-08-29T00:06:51.398Z] LT 00:06:51.375 - Supplied seed = -1 [2024-08-29T00:06:51.398Z] LT 00:06:51.376 - Inventory file = F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/TKG/output_17248863237634/ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-08-29T00:06:51.398Z] LT 00:06:51.377 - Exclude file = F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/TKG/output_17248863237634/ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-08-29T00:06:51.398Z] LT 00:06:51.378 - Number tests = -1 [2024-08-29T00:06:51.398Z] LT 00:06:51.378 - Repeat count = 1 [2024-08-29T00:06:51.398Z] LT 00:06:51.378 - Thinking time = 0ms..0ms [2024-08-29T00:06:51.398Z] LT 00:06:51.378 - Selection mode = random [2024-08-29T00:06:51.398Z] LT 00:06:51.379 - Actual seed = 1724912823564 [2024-08-29T00:06:51.707Z] LT 00:06:51.385 - Parsing inventory file. Root=F:\\workspace\\workspace\\Test_openjdk17_hs_extended.system_x86-64_windows\\aqa-tests\\TKG\\output_17248863237634\\ConcurrentLoadTest_5m_1\\20240829-000648-ConcurrentLoadTest\\results\\1.LT.inventory File=openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-08-29T00:06:51.707Z] LT 00:06:51.393 - Reading exclusion file. File=openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-08-29T00:06:51.707Z] LT 00:06:51.394 - Parsing inventory file. Root=F:\\workspace\\workspace\\Test_openjdk17_hs_extended.system_x86-64_windows\\aqa-tests\\TKG\\output_17248863237634\\ConcurrentLoadTest_5m_1\\20240829-000648-ConcurrentLoadTest\\results\\1.LT.inventory File=openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-08-29T00:06:51.707Z] LT 00:06:51.396 - Final test list: [2024-08-29T00:06:51.707Z] LT 00:06:51.404 - 0 JUnit[net.adoptopenjdk.test.concurrent.ArrayBlockingQueueTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.404 - 1 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentHashMapTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.404 - 2 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentLinkedQueueTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.404 - 3 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentSkipListMapTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.404 - 5 JUnit[net.adoptopenjdk.test.concurrent.CopyOnWriteArrayListTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 6 JUnit[net.adoptopenjdk.test.concurrent.CopyOnWriteArraySetTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 7 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 8 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTestAPI] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 9 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTestStress] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 11 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.LinkedTransferQueueTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 12 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.PhaserTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 13 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ThreadLocalRandomTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 14 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicBooleanTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 15 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 16 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerFieldUpdaterTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.405 - 17 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.406 - 18 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.406 - 19 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongFieldUpdaterTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.406 - 20 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.406 - 21 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicMarkableReferenceTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.407 - 22 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceArrayTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.407 - 23 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceFieldUpdaterTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.407 - 24 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.407 - 25 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicStampedReferenceTest] Weighting=1 [2024-08-29T00:06:51.707Z] LT 00:06:51.407 - 26 JUnit[net.adoptopenjdk.test.concurrent.locks.ReentrantLockTest] Weighting=1 [2024-08-29T00:06:51.708Z] LT 00:06:51.407 - 27 JUnit[net.adoptopenjdk.test.concurrent.locks.ReentrantReadWriteLockTest] Weighting=1 [2024-08-29T00:06:51.708Z] LT stderr WARNING: A terminally deprecated method in java.lang.System has been called [2024-08-29T00:06:51.708Z] LT stderr WARNING: System::setSecurityManager has been called by net.adoptopenjdk.loadTest.LoadTest (file:/F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/jvmtest/system/STF/stf.load/bin/) [2024-08-29T00:06:51.708Z] LT stderr WARNING: Please consider reporting this to the maintainers of net.adoptopenjdk.loadTest.LoadTest [2024-08-29T00:06:51.708Z] LT stderr WARNING: System::setSecurityManager will be removed in a future release [2024-08-29T00:06:51.708Z] LT 00:06:51.472 - Starting thread. Suite=0 thread=0 [2024-08-29T00:06:51.708Z] LT 00:06:51.474 - Starting thread. Suite=0 thread=1 [2024-08-29T00:06:51.708Z] LT 00:06:51.475 - Starting thread. Suite=0 thread=2 [2024-08-29T00:06:51.708Z] LT 00:06:51.475 - Starting thread. Suite=0 thread=3 [2024-08-29T00:06:51.708Z] LT 00:06:51.475 - Starting thread. Suite=0 thread=4 [2024-08-29T00:06:51.708Z] LT 00:06:51.476 - Starting thread. Suite=0 thread=5 [2024-08-29T00:06:51.708Z] LT 00:06:51.476 - Starting thread. Suite=0 thread=6 [2024-08-29T00:06:51.708Z] LT 00:06:51.476 - Starting thread. Suite=0 thread=7 [2024-08-29T00:06:51.708Z] LT 00:06:51.477 - Starting thread. Suite=0 thread=8 [2024-08-29T00:06:51.708Z] LT 00:06:51.477 - Starting thread. Suite=0 thread=9 [2024-08-29T00:06:51.708Z] LT 00:06:51.477 - Starting thread. Suite=0 thread=10 [2024-08-29T00:06:51.708Z] LT 00:06:51.478 - Starting thread. Suite=0 thread=11 [2024-08-29T00:06:51.708Z] LT 00:06:51.478 - Starting thread. Suite=0 thread=12 [2024-08-29T00:06:51.708Z] LT 00:06:51.478 - Starting thread. Suite=0 thread=13 [2024-08-29T00:06:51.708Z] LT 00:06:51.479 - Starting thread. Suite=0 thread=14 [2024-08-29T00:06:51.708Z] LT 00:06:51.479 - Starting thread. Suite=0 thread=15 [2024-08-29T00:06:51.708Z] LT 00:06:51.479 - Starting thread. Suite=0 thread=16 [2024-08-29T00:06:51.708Z] LT 00:06:51.480 - Starting thread. Suite=0 thread=17 [2024-08-29T00:06:51.708Z] LT 00:06:51.480 - Starting thread. Suite=0 thread=18 [2024-08-29T00:06:51.708Z] LT 00:06:51.480 - Starting thread. Suite=0 thread=19 [2024-08-29T00:07:14.428Z] LT 00:07:11.479 - Completed 6.7%. Number of tests started=94 [2024-08-29T00:07:34.261Z] LT 00:07:31.944 - Completed 13.5%. Number of tests started=172 (+78) [2024-08-29T00:07:53.177Z] LT 00:07:51.494 - Completed 20.0%. Number of tests started=249 (+77) [2024-08-29T00:08:11.990Z] LT 00:08:11.511 - Completed 26.7%. Number of tests started=286 (+37) [2024-08-29T00:08:35.761Z] LT 00:08:31.656 - Completed 33.4%. Number of tests started=342 (+56) [2024-08-29T00:08:52.811Z] LT 00:08:51.464 - Completed 40.0%. Number of tests started=462 (+120) [2024-08-29T00:09:15.450Z] LT 00:09:11.460 - Completed 46.7%. Number of tests started=528 (+66) [2024-08-29T00:09:34.571Z] LT 00:09:31.638 - Completed 53.4%. Number of tests started=623 (+95) [2024-08-29T00:09:53.464Z] LT 00:09:51.488 - Completed 60.0%. Number of tests started=678 (+55) [2024-08-29T00:10:16.117Z] LT 00:10:11.503 - Completed 66.7%. Number of tests started=748 (+70) [2024-08-29T00:10:31.609Z] LT 00:10:31.466 - Completed 73.4%. Number of tests started=814 (+66) [2024-08-29T00:10:54.368Z] LT 00:10:51.612 - Completed 80.1%. Number of tests started=926 (+112) [2024-08-29T00:11:13.177Z] LT 00:11:11.470 - Completed 86.7%. Number of tests started=1025 (+99) [2024-08-29T00:11:35.842Z] LT 00:11:31.508 - Completed 93.4%. Number of tests started=1156 (+131) [2024-08-29T00:11:51.558Z] STF 00:11:50.696 - Heartbeat: Process LT is still running [2024-08-29T00:11:52.634Z] LT 00:11:51.471 - Completed 100.0%. Number of tests started=1266 (+110) [2024-08-29T00:11:54.193Z] LT 00:11:53.013 - Thread completed. Suite=0 thread=12 [2024-08-29T00:11:54.193Z] LT 00:11:53.193 - Thread completed. Suite=0 thread=7 [2024-08-29T00:11:54.497Z] LT 00:11:53.550 - Thread completed. Suite=0 thread=15 [2024-08-29T00:11:54.497Z] LT 00:11:53.885 - Thread completed. Suite=0 thread=5 [2024-08-29T00:11:56.060Z] LT 00:11:55.476 - Thread completed. Suite=0 thread=11 [2024-08-29T00:12:00.640Z] LT 00:11:59.745 - Thread completed. Suite=0 thread=19 [2024-08-29T00:12:02.774Z] LT 00:12:01.753 - Thread completed. Suite=0 thread=3 [2024-08-29T00:12:03.858Z] LT 00:12:02.866 - Thread completed. Suite=0 thread=4 [2024-08-29T00:12:06.667Z] LT 00:12:05.305 - Thread completed. Suite=0 thread=2 [2024-08-29T00:12:12.482Z] LT 00:12:11.122 - Thread completed. Suite=0 thread=17 [2024-08-29T00:12:12.482Z] LT 00:12:11.501 - Completed 100.0%. Number of tests started=1266 (+0) [2024-08-29T00:12:12.787Z] LT 00:12:12.061 - Thread completed. Suite=0 thread=9 [2024-08-29T00:12:12.787Z] LT 00:12:12.061 - Thread completed. Suite=0 thread=16 [2024-08-29T00:12:18.470Z] LT 00:12:17.386 - Thread completed. Suite=0 thread=1 [2024-08-29T00:12:18.470Z] LT 00:12:17.387 - Thread completed. Suite=0 thread=6 [2024-08-29T00:12:33.986Z] LT 00:12:31.550 - Completed 100.0%. Number of tests started=1266 (+0) [2024-08-29T00:12:36.782Z] LT 00:12:36.147 - Thread completed. Suite=0 thread=0 [2024-08-29T00:12:36.782Z] LT 00:12:36.148 - Thread completed. Suite=0 thread=13 [2024-08-29T00:12:37.436Z] LT 00:12:37.105 - Thread completed. Suite=0 thread=10 [2024-08-29T00:12:38.523Z] LT 00:12:37.914 - Thread completed. Suite=0 thread=8 [2024-08-29T00:12:41.316Z] LT 00:12:41.111 - Thread completed. Suite=0 thread=18 [2024-08-29T00:12:43.440Z] LT 00:12:43.125 - Thread completed. Suite=0 thread=14 [2024-08-29T00:12:44.130Z] LT 00:12:43.218 - Test stopped due to reaching runtime limit [2024-08-29T00:12:44.130Z] LT 00:12:43.218 - Load test completed [2024-08-29T00:12:44.130Z] LT 00:12:43.218 - Ran : 1266 [2024-08-29T00:12:44.130Z] LT 00:12:43.219 - Passed : 1266 [2024-08-29T00:12:44.130Z] LT 00:12:43.219 - Failed : 0 [2024-08-29T00:12:44.130Z] LT 00:12:43.219 - Result : PASSED [2024-08-29T00:12:44.130Z] STF 00:12:43.684 - Monitoring Report Summary: [2024-08-29T00:12:44.130Z] STF 00:12:43.684 - o Process LT ended with the expected exit code (0) [2024-08-29T00:12:44.130Z] STF 00:12:43.684 - EXECUTE stage completed [2024-08-29T00:12:44.131Z] STF 00:12:43.763 - [2024-08-29T00:12:44.131Z] STF 00:12:43.763 - ==================== T E A R D O W N ==================== [2024-08-29T00:12:44.131Z] STF 00:12:43.763 - Running teardown: perl F:/workspace/workspace/Test_openjdk17_hs_extended.system_x86-64_windows/aqa-tests/\TKG\output_17248863237634\ConcurrentLoadTest_5m_1/20240829-000648-ConcurrentLoadTest/tearDown.pl [2024-08-29T00:12:44.131Z] STF 00:12:43.895 - TEARDOWN stage completed [2024-08-29T00:12:44.131Z] STF 00:12:43.909 - [2024-08-29T00:12:44.131Z] STF 00:12:43.909 - ===================== R E S U L T S ===================== [2024-08-29T00:12:44.131Z] STF 00:12:43.910 - Stage results: [2024-08-29T00:12:44.131Z] STF 00:12:43.910 - setUp: pass [2024-08-29T00:12:44.131Z] STF 00:12:43.910 - execute: pass [2024-08-29T00:12:44.131Z] STF 00:12:43.910 - teardown: pass [2024-08-29T00:12:44.131Z] STF 00:12:43.910 - [2024-08-29T00:12:44.131Z] STF 00:12:43.910 - Overall result: PASSED [2024-08-29T00:12:44.131Z] ----------------------------------- [2024-08-29T00:12:44.131Z] ConcurrentLoadTest_5m_1_PASSED [2024-08-29T00:12:44.131Z] ----------------------------------- [2024-08-29T00:12:44.131Z] [2024-08-29T00:12:44.131Z] TEST TEARDOWN: [2024-08-29T00:12:44.131Z] Nothing to be done for teardown. [2024-08-29T00:12:44.433Z] ConcurrentLoadTest_5m_1 Finish Time: Thu Aug 29 00:12:44 2024 Epoch Time (ms): 1724890364233