[2024-11-21T05:13:16.332Z] Running test ConcurrentLoadTest_5m_1 ... [2024-11-21T05:13:16.628Z] =============================================== [2024-11-21T05:13:16.925Z] ConcurrentLoadTest_5m_1 Start Time: Thu Nov 21 05:13:16 2024 Epoch Time (ms): 1732165996735 [2024-11-21T05:13:17.222Z] variation: Mode650 [2024-11-21T05:13:17.520Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-11-21T05:13:17.520Z] { \ [2024-11-21T05:13:17.520Z] echo ""; echo "TEST SETUP:"; \ [2024-11-21T05:13:17.520Z] echo "Nothing to be done for setup."; \ [2024-11-21T05:13:17.520Z] mkdir -p "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\\TKG\\output_17321622988539\\ConcurrentLoadTest_5m_1"; \ [2024-11-21T05:13:17.520Z] cd "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\\TKG\\output_17321622988539\\ConcurrentLoadTest_5m_1"; \ [2024-11-21T05:13:17.520Z] echo ""; echo "TESTING:"; \ [2024-11-21T05:13:17.520Z] perl C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests///..//jvmtest\\system\\otherLoadTest/../\\STF\\stf.core\\scripts\\stf.pl -test-root="C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests///..//jvmtest\\system\\otherLoadTest/../\\STF;C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests///..//jvmtest\\system\\otherLoadTest/../\\aqa-systemtest""" -systemtest-prereqs="C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/../../testDependency/system_lib\\" -java-args=' -XX:-UseCompressedOops ' -results-root="C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\\TKG\\output_17321622988539\\ConcurrentLoadTest_5m_1" -test=ConcurrentLoadTest -test-args="timeLimit=5m"; \ [2024-11-21T05:13:17.520Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "ConcurrentLoadTest_5m_1""_PASSED"; echo "-----------------------------------"; cd C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/; rm -f -r "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\\TKG\\output_17321622988539\\ConcurrentLoadTest_5m_1"; else echo "-----------------------------------"; echo "ConcurrentLoadTest_5m_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-21T05:13:17.520Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-21T05:13:17.520Z] echo "Nothing to be done for teardown."; \ [2024-11-21T05:13:17.520Z] } 2>&1 | tee -a "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\\TKG\\output_17321622988539\\TestTargetResult"; [2024-11-21T05:13:17.817Z] [2024-11-21T05:13:17.817Z] TEST SETUP: [2024-11-21T05:13:17.817Z] Nothing to be done for setup. [2024-11-21T05:13:17.817Z] [2024-11-21T05:13:17.817Z] TESTING: [2024-11-21T05:13:18.114Z] STF 05:13:17.969 - ========================= S T F ========================= [2024-11-21T05:13:18.114Z] systemtest-prereqs has been processed, and set to: C:/Users/jenkins/testDependency/system_libRetrieving amount of free space on drive containing C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1 [2024-11-21T05:13:18.413Z] There is 20860 Mb free [2024-11-21T05:13:18.413Z] STF 05:13:18.052 - ================== G E N E R A T I O N ================== [2024-11-21T05:13:18.413Z] STF 05:13:18.058 - Checking JVM: C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jdkbinary/j2sdk-image [2024-11-21T05:13:18.413Z] STF 05:13:18.058 - Starting process to generate scripts: C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/../../testDependency/system_lib\/log4j/log4j-api.jar;C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/../../testDependency/system_lib\/log4j/log4j-core.jar;C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/stf_parameters.properties, , C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest" [2024-11-21T05:13:18.413Z] GEN stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-21T05:13:19.459Z] GEN Java lib directory does not exist: C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\jdkbinary\lib [2024-11-21T05:13:19.459Z] GEN 05:13:19.297 - Found test. Project: 'openjdk.test.load' class: 'ConcurrentLoadTest.class' Dir: 'C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\jvmtest\system\aqa-systemtest\openjdk.test.load\bin' [2024-11-21T05:13:19.459Z] GEN 05:13:19.360 - Found test. Project: 'openjdk.test.load' class: 'net.adoptopenjdk.stf.ConcurrentLoadTest' [2024-11-21T05:13:19.754Z] GEN Classpath directories used by project 'openjdk.test.load': [2024-11-21T05:13:19.754Z] GEN C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_extended.system_aarch64_windows\\jvmtest\\system\\aqa-systemtest\\openjdk.test.load\\bin [2024-11-21T05:13:19.754Z] GEN C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_extended.system_aarch64_windows\\jvmtest\\system\\STF\\stf.core\\bin [2024-11-21T05:13:19.754Z] GEN C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_extended.system_aarch64_windows\\jvmtest\\system\\STF\\stf.load\\bin [2024-11-21T05:13:19.754Z] GEN C:/Users/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-11-21T05:13:19.754Z] GEN C:/Users/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-11-21T05:13:19.754Z] GEN C:/Users/jenkins/testDependency/system_lib/junit/junit.jar [2024-11-21T05:13:19.754Z] GEN C:/Users/jenkins/testDependency/system_lib/junit/hamcrest-core.jar [2024-11-21T05:13:19.754Z] GEN Java lib directory does not exist: C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\jdkbinary\lib [2024-11-21T05:13:19.754Z] GEN 05:13:19.594 - Using Mode NoOptions. Values = '' [2024-11-21T05:13:19.754Z] GEN 05:13:19.719 - [2024-11-21T05:13:19.754Z] GEN 05:13:19.719 - Test command summary: [2024-11-21T05:13:19.754Z] GEN 05:13:19.719 - Step Stage Command Description [2024-11-21T05:13:19.754Z] GEN 05:13:19.719 - -----+--------+-----------------+------------ [2024-11-21T05:13:19.754Z] GEN 05:13:19.719 - 1 execute Run java Run concurrency unit tests [2024-11-21T05:13:20.050Z] STF 05:13:19.772 - [2024-11-21T05:13:20.050Z] STF 05:13:19.772 - Script generation completed [2024-11-21T05:13:20.050Z] STF 05:13:19.772 - [2024-11-21T05:13:20.050Z] STF 05:13:19.775 - [2024-11-21T05:13:20.050Z] STF 05:13:19.775 - ======================= S E T U P ======================= [2024-11-21T05:13:20.050Z] STF 05:13:19.775 - Running setup: perl C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/setUp.pl [2024-11-21T05:13:20.346Z] STF 05:13:20.141 - SETUP stage completed [2024-11-21T05:13:20.346Z] STF 05:13:20.188 - [2024-11-21T05:13:20.346Z] STF 05:13:20.188 - ==================== E X E C U T E - ==================== [2024-11-21T05:13:20.346Z] STF 05:13:20.188 - Running execute: perl C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/execute.pl [2024-11-21T05:13:20.643Z] STF 05:13:20.563 - [2024-11-21T05:13:20.643Z] STF 05:13:20.563 - Java version [2024-11-21T05:13:20.643Z] STF 05:13:20.563 - Running: C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jdkbinary/j2sdk-image/bin/java -version [2024-11-21T05:13:20.643Z] Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-21T05:13:20.941Z] openjdk version "21.0.6-beta" 2025-01-21 [2024-11-21T05:13:20.941Z] OpenJDK Runtime Environment Temurin-21.0.6+4-202411202006 (build 21.0.6-beta+4-ea) [2024-11-21T05:13:20.941Z] OpenJDK 64-Bit Server VM Temurin-21.0.6+4-202411202006 (build 21.0.6-beta+4-ea, mixed mode) [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - +------ Step 1 - Run concurrency unit tests [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - | Run foreground process [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - | Program: C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jdkbinary/j2sdk-image/bin/java [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - | Mnemonic: LT [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - | Echo: ECHO_ON [2024-11-21T05:13:20.941Z] STF 05:13:20.685 - | Expectation: CLEAN_RUN within 1h5m [2024-11-21T05:13:20.941Z] STF 05:13:20.686 - | [2024-11-21T05:13:20.941Z] STF 05:13:20.687 - Running command: C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jdkbinary/j2sdk-image/bin/java -XX:-UseCompressedOops -classpath C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\jvmtest\system\STF\stf.load\bin;C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\jvmtest\system\STF\stf.core\bin;C:/Users/jenkins/testDependency/system_lib/log4j/log4j-api.jar;C:/Users/jenkins/testDependency/system_lib/log4j/log4j-core.jar;C:/Users/jenkins/testDependency/system_lib/junit/junit.jar;C:/Users/jenkins/testDependency/system_lib/junit/hamcrest-core.jar;C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\jvmtest\system\aqa-systemtest\openjdk.test.concurrent\bin net.adoptopenjdk.loadTest.LoadTest -resultsDir C:\Users\jenkins\workspace\Test_openjdk21_hs_extended.system_aarch64_windows\aqa-tests\TKG\output_17321622988539\ConcurrentLoadTest_5m_1\20241121-051317-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 C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/TKG/output_17321622988539/ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent.xml -suite.concurrent.inventoryExcludeFile C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/TKG/output_17321622988539/ConcurrentLoadTest_5m_1/20241121-051317-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-11-21T05:13:20.941Z] STF 05:13:20.687 - Redirecting stderr to C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/TKG/output_17321622988539/ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/results/1.LT.stderr [2024-11-21T05:13:20.941Z] STF 05:13:20.687 - Redirecting stdout to C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/TKG/output_17321622988539/ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/results/1.LT.stdout [2024-11-21T05:13:20.941Z] STF 05:13:20.755 - Monitoring processes: LT [2024-11-21T05:13:20.941Z] LT stderr Picked up JAVA_TOOL_OPTIONS: -Djava.security.manager=allow [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Load test parameters [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Time limited = true [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Time limit = 5m [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - abortIfOutOfMemory = false [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - reportFailureLimit = 1 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - abortAtFailureLimit = 10 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - maxTotalLogFileSpace = 209715200 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - maxSingleLogSize = 8388608 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Parameters for suite 0 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Suite name = concurrent [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Number threads = 20 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Supplied seed = -1 [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Inventory file = C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/TKG/output_17321622988539/ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-11-21T05:13:22.004Z] LT 05:13:21.782 - Exclude file = C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/TKG/output_17321622988539/ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-11-21T05:13:22.004Z] LT 05:13:21.797 - Number tests = -1 [2024-11-21T05:13:22.004Z] LT 05:13:21.797 - Repeat count = 1 [2024-11-21T05:13:22.004Z] LT 05:13:21.797 - Thinking time = 0ms..0ms [2024-11-21T05:13:22.004Z] LT 05:13:21.797 - Selection mode = random [2024-11-21T05:13:22.004Z] LT 05:13:21.797 - Actual seed = 1730869910207 [2024-11-21T05:13:22.004Z] LT 05:13:21.797 - Parsing inventory file. Root=C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_extended.system_aarch64_windows\\aqa-tests\\TKG\\output_17321622988539\\ConcurrentLoadTest_5m_1\\20241121-051317-ConcurrentLoadTest\\results\\1.LT.inventory File=openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-11-21T05:13:22.004Z] LT 05:13:21.813 - Reading exclusion file. File=openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-11-21T05:13:22.004Z] LT 05:13:21.813 - Parsing inventory file. Root=C:\\Users\\jenkins\\workspace\\Test_openjdk21_hs_extended.system_aarch64_windows\\aqa-tests\\TKG\\output_17321622988539\\ConcurrentLoadTest_5m_1\\20241121-051317-ConcurrentLoadTest\\results\\1.LT.inventory File=openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-11-21T05:13:22.004Z] LT 05:13:21.813 - Final test list: [2024-11-21T05:13:22.004Z] LT 05:13:21.828 - 0 JUnit[net.adoptopenjdk.test.concurrent.ArrayBlockingQueueTest] Weighting=1 [2024-11-21T05:13:22.004Z] LT 05:13:21.828 - 1 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentHashMapTest] Weighting=1 [2024-11-21T05:13:22.004Z] LT 05:13:21.828 - 2 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentLinkedQueueTest] Weighting=1 [2024-11-21T05:13:22.004Z] LT 05:13:21.828 - 3 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentSkipListMapTest] Weighting=1 [2024-11-21T05:13:22.004Z] LT 05:13:21.828 - 5 JUnit[net.adoptopenjdk.test.concurrent.CopyOnWriteArrayListTest] Weighting=1 [2024-11-21T05:13:22.004Z] LT 05:13:21.828 - 6 JUnit[net.adoptopenjdk.test.concurrent.CopyOnWriteArraySetTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 7 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 8 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTestAPI] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 9 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTestStress] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 11 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.LinkedTransferQueueTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 12 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.PhaserTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 13 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ThreadLocalRandomTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 14 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicBooleanTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 15 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 16 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerFieldUpdaterTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 17 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 18 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 19 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongFieldUpdaterTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 20 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 21 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicMarkableReferenceTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 22 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceArrayTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 23 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceFieldUpdaterTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 24 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 25 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicStampedReferenceTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 26 JUnit[net.adoptopenjdk.test.concurrent.locks.ReentrantLockTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT 05:13:21.828 - 27 JUnit[net.adoptopenjdk.test.concurrent.locks.ReentrantReadWriteLockTest] Weighting=1 [2024-11-21T05:13:22.005Z] LT stderr WARNING: A terminally deprecated method in java.lang.System has been called [2024-11-21T05:13:22.005Z] LT stderr WARNING: System::setSecurityManager has been called by net.adoptopenjdk.loadTest.LoadTest (file:/C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/jvmtest/system/STF/stf.load/bin/) [2024-11-21T05:13:22.005Z] LT stderr WARNING: Please consider reporting this to the maintainers of net.adoptopenjdk.loadTest.LoadTest [2024-11-21T05:13:22.326Z] LT stderr WARNING: System::setSecurityManager will be removed in a future release [2024-11-21T05:13:22.326Z] LT 05:13:21.875 - Starting thread. Suite=0 thread=0 [2024-11-21T05:13:22.326Z] LT 05:13:21.875 - Starting thread. Suite=0 thread=1 [2024-11-21T05:13:22.326Z] LT 05:13:21.903 - Starting thread. Suite=0 thread=2 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=3 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=4 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=5 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=6 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=7 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=8 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=9 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=10 [2024-11-21T05:13:22.326Z] LT 05:13:21.904 - Starting thread. Suite=0 thread=11 [2024-11-21T05:13:22.326Z] LT 05:13:21.910 - Starting thread. Suite=0 thread=12 [2024-11-21T05:13:22.326Z] LT 05:13:21.911 - Starting thread. Suite=0 thread=13 [2024-11-21T05:13:22.326Z] LT 05:13:21.911 - Starting thread. Suite=0 thread=14 [2024-11-21T05:13:22.326Z] LT 05:13:21.911 - Starting thread. Suite=0 thread=15 [2024-11-21T05:13:22.326Z] LT 05:13:21.911 - Starting thread. Suite=0 thread=16 [2024-11-21T05:13:22.326Z] LT 05:13:21.912 - Starting thread. Suite=0 thread=17 [2024-11-21T05:13:22.326Z] LT 05:13:21.912 - Starting thread. Suite=0 thread=18 [2024-11-21T05:13:22.326Z] LT 05:13:21.912 - Starting thread. Suite=0 thread=19 [2024-11-21T05:13:44.877Z] LT 05:13:41.961 - Completed 6.7%. Number of tests started=176 [2024-11-21T05:14:03.646Z] LT 05:14:01.898 - Completed 13.4%. Number of tests started=278 (+102) [2024-11-21T05:14:26.173Z] LT 05:14:21.945 - Completed 20.0%. Number of tests started=358 (+80) [2024-11-21T05:14:44.827Z] LT 05:14:41.945 - Completed 26.7%. Number of tests started=460 (+102) [2024-11-21T05:15:03.477Z] LT 05:15:01.914 - Completed 33.4%. Number of tests started=532 (+72) [2024-11-21T05:15:22.212Z] LT 05:15:21.914 - Completed 40.0%. Number of tests started=610 (+78) [2024-11-21T05:15:44.725Z] LT 05:15:41.929 - Completed 46.7%. Number of tests started=735 (+125) [2024-11-21T05:16:03.418Z] LT 05:16:01.929 - Completed 53.4%. Number of tests started=797 (+62) [2024-11-21T05:16:22.174Z] LT 05:16:21.898 - Completed 60.0%. Number of tests started=875 (+78) [2024-11-21T05:16:44.700Z] LT 05:16:41.867 - Completed 66.7%. Number of tests started=1004 (+129) [2024-11-21T05:17:03.355Z] LT 05:17:01.882 - Completed 73.4%. Number of tests started=1075 (+71) [2024-11-21T05:17:25.871Z] LT 05:17:21.866 - Completed 80.0%. Number of tests started=1161 (+86) [2024-11-21T05:17:44.552Z] LT 05:17:41.866 - Completed 86.7%. Number of tests started=1265 (+104) [2024-11-21T05:17:57.280Z] LT 05:17:55.866 - First failure detected by thread: load-4. Not creating dumps as no dump generation is requested for this load test [2024-11-21T05:17:57.280Z] LT 05:17:55.866 - suite.getInventory().getInventoryFileRef(): openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-11-21T05:17:57.280Z] LT 05:17:55.866 - suite.isCreateDump() : false [2024-11-21T05:17:57.280Z] LT 05:17:55.866 - Test failed [2024-11-21T05:17:57.281Z] LT Failure num. = 1 [2024-11-21T05:17:57.281Z] LT Test number = 15 [2024-11-21T05:17:57.281Z] LT Test details = 'JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest]' [2024-11-21T05:17:57.281Z] LT Suite number = 0 [2024-11-21T05:17:57.281Z] LT Thread number = 4 [2024-11-21T05:17:57.281Z] LT >>> Captured test output >>> [2024-11-21T05:17:57.281Z] LT testStarted : testAPI(net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest) [2024-11-21T05:17:57.281Z] LT testFailure: testAPI(net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest): 30 : weakCompareAndSet() expected:<true> but was:<false> [2024-11-21T05:17:57.281Z] LT junit.framework.AssertionFailedError: 30 : weakCompareAndSet() expected:<true> but was:<false> [2024-11-21T05:17:57.281Z] LT at junit.framework.Assert.fail(Assert.java:57) [2024-11-21T05:17:57.281Z] LT at junit.framework.Assert.failNotEquals(Assert.java:329) [2024-11-21T05:17:57.281Z] LT at junit.framework.Assert.assertEquals(Assert.java:78) [2024-11-21T05:17:57.281Z] LT at junit.framework.Assert.assertEquals(Assert.java:174) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestCase.assertEquals(TestCase.java:333) [2024-11-21T05:17:57.281Z] LT at net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest.testAPI(AtomicIntegerArrayTest.java:141) [2024-11-21T05:17:57.281Z] LT at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2024-11-21T05:17:57.281Z] LT at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestCase.runTest(TestCase.java:176) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestCase.runBare(TestCase.java:141) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestResult$1.protect(TestResult.java:122) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestResult.runProtected(TestResult.java:142) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestResult.run(TestResult.java:125) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestCase.run(TestCase.java:129) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2024-11-21T05:17:57.281Z] LT at junit.framework.TestSuite.run(TestSuite.java:247) [2024-11-21T05:17:57.281Z] LT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.Suite.runChild(Suite.java:128) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.Suite.runChild(Suite.java:27) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2024-11-21T05:17:57.281Z] LT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2024-11-21T05:17:57.281Z] LT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2024-11-21T05:17:57.281Z] LT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2024-11-21T05:17:57.281Z] LT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2024-11-21T05:17:57.281Z] LT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2024-11-21T05:17:57.281Z] LT at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) [2024-11-21T05:17:57.281Z] LT at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) [2024-11-21T05:17:57.281Z] LT at java.base/java.lang.Thread.run(Thread.java:1583) [2024-11-21T05:17:57.281Z] LT testFinished: testAPI(net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest) [2024-11-21T05:17:57.281Z] LT testStarted : testStress(net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest) [2024-11-21T05:17:57.281Z] LT testFinished: testStress(net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest) [2024-11-21T05:17:57.281Z] LT [2024-11-21T05:17:57.281Z] LT JUnit Test Results for: net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest [2024-11-21T05:17:57.281Z] LT Ran : 2 [2024-11-21T05:17:57.281Z] LT Passed : 1 [2024-11-21T05:17:57.281Z] LT Failed : 1 [2024-11-21T05:17:57.281Z] LT Ignored: 0 [2024-11-21T05:17:57.281Z] LT Result : FAILED [2024-11-21T05:17:57.281Z] LT <<< [2024-11-21T05:17:57.281Z] LT [2024-11-21T05:18:02.976Z] LT 05:18:01.960 - Completed 93.4%. Number of tests started=1345 (+80) (with 1 failure(s)) [2024-11-21T05:18:21.631Z] STF 05:18:20.072 - Heartbeat: Process LT is still running [2024-11-21T05:18:22.272Z] LT 05:18:21.913 - Completed 100.0%. Number of tests started=1409 (+64) (with 1 failure(s)) [2024-11-21T05:18:23.321Z] LT 05:18:22.773 - Thread completed. Suite=0 thread=13 [2024-11-21T05:18:24.368Z] LT 05:18:24.132 - Thread completed. Suite=0 thread=1 [2024-11-21T05:18:25.007Z] LT 05:18:24.273 - Thread completed. Suite=0 thread=12 [2024-11-21T05:18:26.055Z] LT 05:18:25.585 - Thread completed. Suite=0 thread=17 [2024-11-21T05:18:26.350Z] LT 05:18:26.257 - Thread completed. Suite=0 thread=2 [2024-11-21T05:18:27.394Z] LT 05:18:27.288 - Thread completed. Suite=0 thread=14 [2024-11-21T05:18:28.034Z] LT 05:18:27.554 - Thread completed. Suite=0 thread=10 [2024-11-21T05:18:30.116Z] LT 05:18:29.460 - Thread completed. Suite=0 thread=3 [2024-11-21T05:18:31.641Z] LT 05:18:31.272 - Thread completed. Suite=0 thread=11 [2024-11-21T05:18:32.686Z] LT 05:18:32.038 - Thread completed. Suite=0 thread=6 [2024-11-21T05:18:37.164Z] LT 05:18:36.304 - Thread completed. Suite=0 thread=5 [2024-11-21T05:18:39.244Z] LT 05:18:39.116 - Thread completed. Suite=0 thread=18 [2024-11-21T05:18:39.888Z] LT 05:18:39.647 - Thread completed. Suite=0 thread=19 [2024-11-21T05:18:42.635Z] LT 05:18:41.835 - Thread completed. Suite=0 thread=4 [2024-11-21T05:18:42.635Z] LT 05:18:41.944 - Completed 100.0%. Number of tests started=1409 (+0) (with 1 failure(s)) [2024-11-21T05:18:46.180Z] LT 05:18:45.585 - Thread completed. Suite=0 thread=0 [2024-11-21T05:18:50.685Z] LT 05:18:50.007 - Thread completed. Suite=0 thread=16 [2024-11-21T05:18:51.324Z] LT 05:18:50.835 - Thread completed. Suite=0 thread=8 [2024-11-21T05:19:03.988Z] LT 05:19:01.960 - Completed 100.0%. Number of tests started=1409 (+0) (with 1 failure(s)) [2024-11-21T05:19:04.628Z] LT 05:19:04.210 - Thread completed. Suite=0 thread=15 [2024-11-21T05:19:04.628Z] LT 05:19:04.210 - Thread completed. Suite=0 thread=7 [2024-11-21T05:19:06.145Z] LT 05:19:05.569 - Thread completed. Suite=0 thread=9 [2024-11-21T05:19:06.145Z] LT 05:19:05.679 - Test stopped due to reaching runtime limit [2024-11-21T05:19:06.145Z] LT 05:19:05.679 - Load test completed [2024-11-21T05:19:06.145Z] LT 05:19:05.679 - Ran : 1409 [2024-11-21T05:19:06.145Z] LT 05:19:05.679 - Passed : 1408 [2024-11-21T05:19:06.145Z] LT 05:19:05.679 - Failed : 1 [2024-11-21T05:19:06.145Z] LT 05:19:05.679 - Result : FAILED [2024-11-21T05:19:06.145Z] STF 05:19:06.030 - **FAILED** Process LT ended with exit code (1) and not the expected exit code/s (0) [2024-11-21T05:19:06.145Z] STF 05:19:06.030 - Monitoring Report Summary: [2024-11-21T05:19:06.145Z] STF 05:19:06.030 - o Process LT ended with exit code (1) and not the expected exit code/s (0) [2024-11-21T05:19:06.145Z] STF 05:19:06.031 - Killing processes: LT [2024-11-21T05:19:06.145Z] STF 05:19:06.031 - o Process LT pid 54084 is not running [2024-11-21T05:19:06.145Z] **FAILED** at step 1 (Run concurrency unit tests). Expected return value=0 Actual=1 at C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/execute.pl line 94. [2024-11-21T05:19:06.785Z] STF 05:19:06.577 - **FAILED** execute script failed. Expected return value=0 Actual=1 [2024-11-21T05:19:06.785Z] STF 05:19:06.577 - [2024-11-21T05:19:06.785Z] STF 05:19:06.577 - ==================== T E A R D O W N ==================== [2024-11-21T05:19:06.785Z] STF 05:19:06.577 - Running teardown: perl C:/Users/jenkins/workspace/Test_openjdk21_hs_extended.system_aarch64_windows/aqa-tests/\TKG\output_17321622988539\ConcurrentLoadTest_5m_1/20241121-051317-ConcurrentLoadTest/tearDown.pl [2024-11-21T05:19:07.191Z] STF 05:19:06.936 - TEARDOWN stage completed [2024-11-21T05:19:07.191Z] STF 05:19:06.987 - [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - ===================== R E S U L T S ===================== [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - Stage results: [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - setUp: pass [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - execute: *fail* [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - teardown: pass [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - [2024-11-21T05:19:07.191Z] STF 05:19:06.988 - Overall result: **FAILED** [2024-11-21T05:19:07.191Z] ----------------------------------- [2024-11-21T05:19:07.191Z] ConcurrentLoadTest_5m_1_FAILED [2024-11-21T05:19:07.191Z] ----------------------------------- [2024-11-21T05:19:07.191Z] [2024-11-21T05:19:07.191Z] TEST TEARDOWN: [2024-11-21T05:19:07.191Z] Nothing to be done for teardown. [2024-11-21T05:19:07.519Z] ConcurrentLoadTest_5m_1 Finish Time: Thu Nov 21 05:19:07 2024 Epoch Time (ms): 1732166347327