[2024-08-28T22:21:27.085Z] Running test ConcurrentLoadTest_5m_1 ... [2024-08-28T22:21:27.085Z] =============================================== [2024-08-28T22:21:27.469Z] ConcurrentLoadTest_5m_1 Start Time: Wed Aug 28 22:21:27 2024 Epoch Time (ms): 1724883687086 [2024-08-28T22:21:27.469Z] variation: Mode650 [2024-08-28T22:21:27.469Z] JVM_OPTIONS: -XX:-UseCompressedOops [2024-08-28T22:21:27.469Z] { \ [2024-08-28T22:21:27.469Z] echo ""; echo "TEST SETUP:"; \ [2024-08-28T22:21:27.469Z] echo "Nothing to be done for setup."; \ [2024-08-28T22:21:27.469Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1"; \ [2024-08-28T22:21:27.469Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1"; \ [2024-08-28T22:21:27.469Z] echo ""; echo "TESTING:"; \ [2024-08-28T22:21:27.470Z] perl /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../../jvmtest/system/otherLoadTest/..//STF/stf.core/scripts/stf.pl -test-root="/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../../jvmtest/system/otherLoadTest/..//STF;/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../../jvmtest/system/otherLoadTest/..//aqa-systemtest""" -systemtest-prereqs="/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/../../testDependency/system_lib/" -java-args=' -XX:-UseCompressedOops ' -results-root="/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1" -test=ConcurrentLoadTest -test-args="timeLimit=5m"; \ [2024-08-28T22:21:27.470Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "ConcurrentLoadTest_5m_1""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1"; else echo "-----------------------------------"; echo "ConcurrentLoadTest_5m_1""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-28T22:21:27.470Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-28T22:21:27.470Z] echo "Nothing to be done for teardown."; \ [2024-08-28T22:21:27.470Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/TestTargetResult"; [2024-08-28T22:21:27.470Z] [2024-08-28T22:21:27.470Z] TEST SETUP: [2024-08-28T22:21:27.470Z] Nothing to be done for setup. [2024-08-28T22:21:27.470Z] [2024-08-28T22:21:27.470Z] TESTING: [2024-08-28T22:21:27.470Z] STF 22:21:27.188 - ========================= S T F ========================= [2024-08-28T22:21:27.470Z] systemtest-prereqs has been processed, and set to: /home/jenkins/testDependency/system_libRetrieving amount of free space on drive containing /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1 [2024-08-28T22:21:27.470Z] There is 85032 Mb free [2024-08-28T22:21:27.470Z] STF 22:21:27.196 - ================== G E N E R A T I O N ================== [2024-08-28T22:21:27.470Z] STF 22:21:27.197 - Checking JVM: /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jdkbinary/j2sdk-image [2024-08-28T22:21:27.470Z] STF 22:21:27.197 - Starting process to generate scripts: /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -Dlog4j.skipJansi=true -Djava.system.class.loader=net.adoptopenjdk.stf.runner.StfClassLoader -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/../../testDependency/system_lib//log4j/log4j-api.jar:/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/../../testDependency/system_lib//log4j/log4j-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/STF/stf.core/scripts/../bin net.adoptopenjdk.stf.runner.StfRunner -properties "/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/stf_parameters.properties, , /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/STF/stf.core/config/stf.properties" -testDir "/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest" [2024-08-28T22:21:28.803Z] GEN 22:21:28.599 - Found test. Project: 'openjdk.test.load' class: 'ConcurrentLoadTest.class' Dir: '/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.load/bin' [2024-08-28T22:21:28.803Z] GEN 22:21:28.624 - Found test. Project: 'openjdk.test.load' class: 'net.adoptopenjdk.stf.ConcurrentLoadTest' [2024-08-28T22:21:29.191Z] GEN Classpath directories used by project 'openjdk.test.load': [2024-08-28T22:21:29.191Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.load/bin [2024-08-28T22:21:29.191Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/STF/stf.core/bin [2024-08-28T22:21:29.191Z] GEN /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/STF/stf.load/bin [2024-08-28T22:21:29.191Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-api.jar [2024-08-28T22:21:29.191Z] GEN /home/jenkins/testDependency/system_lib/log4j/log4j-core.jar [2024-08-28T22:21:29.191Z] GEN /home/jenkins/testDependency/system_lib/junit/junit.jar [2024-08-28T22:21:29.191Z] GEN /home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar [2024-08-28T22:21:29.191Z] GEN 22:21:28.928 - Using Mode NoOptions. Values = '' [2024-08-28T22:21:29.191Z] GEN 22:21:29.160 - [2024-08-28T22:21:29.191Z] GEN 22:21:29.160 - Test command summary: [2024-08-28T22:21:29.191Z] GEN 22:21:29.160 - Step Stage Command Description [2024-08-28T22:21:29.191Z] GEN 22:21:29.161 - -----+--------+-----------------+------------ [2024-08-28T22:21:29.191Z] GEN 22:21:29.161 - 1 execute Run java Run concurrency unit tests [2024-08-28T22:21:29.568Z] STF 22:21:29.238 - [2024-08-28T22:21:29.568Z] STF 22:21:29.238 - Script generation completed [2024-08-28T22:21:29.568Z] STF 22:21:29.238 - [2024-08-28T22:21:29.568Z] STF 22:21:29.238 - [2024-08-28T22:21:29.568Z] STF 22:21:29.238 - ======================= S E T U P ======================= [2024-08-28T22:21:29.568Z] STF 22:21:29.238 - Running setup: perl /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/setUp.pl [2024-08-28T22:21:29.568Z] STF 22:21:29.324 - SETUP stage completed [2024-08-28T22:21:29.568Z] STF 22:21:29.327 - [2024-08-28T22:21:29.568Z] STF 22:21:29.327 - ==================== E X E C U T E - ==================== [2024-08-28T22:21:29.568Z] STF 22:21:29.327 - Running execute: perl /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/execute.pl [2024-08-28T22:21:29.568Z] STF 22:21:29.413 - [2024-08-28T22:21:29.568Z] STF 22:21:29.413 - Java version [2024-08-28T22:21:29.568Z] STF 22:21:29.413 - Running: /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -version [2024-08-28T22:21:29.568Z] openjdk version "11.0.25-beta" 2024-10-15 [2024-08-28T22:21:29.568Z] OpenJDK Runtime Environment Temurin-11.0.25+5-202408282003 (build 11.0.25-beta+5-ea) [2024-08-28T22:21:29.568Z] OpenJDK 64-Bit Server VM Temurin-11.0.25+5-202408282003 (build 11.0.25-beta+5-ea, mixed mode) [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - +------ Step 1 - Run concurrency unit tests [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - | Run foreground process [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - | Program: /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - | Mnemonic: LT [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - | Echo: ECHO_ON [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - | Expectation: CLEAN_RUN within 1h5m [2024-08-28T22:21:29.568Z] STF 22:21:29.520 - | [2024-08-28T22:21:29.569Z] STF 22:21:29.521 - Running command: /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jdkbinary/j2sdk-image/bin/java -XX:-UseCompressedOops -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/STF/stf.load/bin:/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/STF/stf.core/bin:/home/jenkins/testDependency/system_lib/log4j/log4j-api.jar:/home/jenkins/testDependency/system_lib/log4j/log4j-core.jar:/home/jenkins/testDependency/system_lib/junit/junit.jar:/home/jenkins/testDependency/system_lib/junit/hamcrest-core.jar:/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/jvmtest/system/aqa-systemtest/openjdk.test.concurrent/bin net.adoptopenjdk.loadTest.LoadTest -resultsDir /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-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 /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent.xml -suite.concurrent.inventoryExcludeFile /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-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-28T22:21:29.569Z] STF 22:21:29.521 - Redirecting stderr to /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.stderr [2024-08-28T22:21:29.569Z] STF 22:21:29.521 - Redirecting stdout to /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.stdout [2024-08-28T22:21:29.569Z] STF 22:21:29.533 - Monitoring processes: LT [2024-08-28T22:21:30.911Z] LT 22:21:30.760 - Load test parameters [2024-08-28T22:21:30.911Z] LT 22:21:30.765 - Time limited = true [2024-08-28T22:21:30.911Z] LT 22:21:30.765 - Time limit = 5m [2024-08-28T22:21:30.911Z] LT 22:21:30.766 - abortIfOutOfMemory = false [2024-08-28T22:21:30.911Z] LT 22:21:30.766 - reportFailureLimit = 1 [2024-08-28T22:21:30.911Z] LT 22:21:30.767 - abortAtFailureLimit = 10 [2024-08-28T22:21:30.911Z] LT 22:21:30.776 - maxTotalLogFileSpace = 209715200 [2024-08-28T22:21:30.911Z] LT 22:21:30.776 - maxSingleLogSize = 8388608 [2024-08-28T22:21:30.911Z] LT 22:21:30.777 - Parameters for suite 0 [2024-08-28T22:21:30.911Z] LT 22:21:30.777 - Suite name = concurrent [2024-08-28T22:21:30.911Z] LT 22:21:30.777 - Number threads = 20 [2024-08-28T22:21:30.911Z] LT 22:21:30.778 - Supplied seed = -1 [2024-08-28T22:21:30.911Z] LT 22:21:30.778 - Inventory file = /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-08-28T22:21:30.911Z] LT 22:21:30.782 - Exclude file = /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.inventory/openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-08-28T22:21:30.911Z] LT 22:21:30.783 - Number tests = -1 [2024-08-28T22:21:30.911Z] LT 22:21:30.784 - Repeat count = 1 [2024-08-28T22:21:30.911Z] LT 22:21:30.784 - Thinking time = 0ms..0ms [2024-08-28T22:21:30.911Z] LT 22:21:30.784 - Selection mode = random [2024-08-28T22:21:30.911Z] LT 22:21:30.785 - Actual seed = 1723188988967 [2024-08-28T22:21:30.911Z] LT 22:21:30.820 - Parsing inventory file. Root=/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.inventory File=openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-08-28T22:21:30.911Z] LT 22:21:30.830 - Reading exclusion file. File=openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-08-28T22:21:30.911Z] LT 22:21:30.830 - Parsing inventory file. Root=/home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/results/1.LT.inventory File=openjdk.test.load/config/inventories/concurrent/concurrent_exclude.xml [2024-08-28T22:21:30.911Z] LT 22:21:30.833 - Final test list: [2024-08-28T22:21:30.911Z] LT 22:21:30.860 - 0 JUnit[net.adoptopenjdk.test.concurrent.ArrayBlockingQueueTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 1 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentHashMapTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 2 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentLinkedQueueTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 3 JUnit[net.adoptopenjdk.test.concurrent.ConcurrentSkipListMapTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 5 JUnit[net.adoptopenjdk.test.concurrent.CopyOnWriteArrayListTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 6 JUnit[net.adoptopenjdk.test.concurrent.CopyOnWriteArraySetTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 7 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 8 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTestAPI] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.861 - 9 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ForkJoinPoolTestStress] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 11 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.LinkedTransferQueueTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 12 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.PhaserTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 13 JUnit[net.adoptopenjdk.test.concurrent.jsr166y.ThreadLocalRandomTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 14 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicBooleanTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 15 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerArrayTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 16 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerFieldUpdaterTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 17 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicIntegerTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.862 - 18 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 19 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongFieldUpdaterTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 20 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 21 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicMarkableReferenceTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 22 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceArrayTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 23 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceFieldUpdaterTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 24 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicReferenceTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 25 JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicStampedReferenceTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.863 - 26 JUnit[net.adoptopenjdk.test.concurrent.locks.ReentrantLockTest] Weighting=1 [2024-08-28T22:21:30.911Z] LT 22:21:30.864 - 27 JUnit[net.adoptopenjdk.test.concurrent.locks.ReentrantReadWriteLockTest] Weighting=1 [2024-08-28T22:21:31.303Z] LT 22:21:30.950 - Starting thread. Suite=0 thread=0 [2024-08-28T22:21:31.303Z] LT 22:21:30.952 - Starting thread. Suite=0 thread=1 [2024-08-28T22:21:31.303Z] LT 22:21:30.953 - Starting thread. Suite=0 thread=2 [2024-08-28T22:21:31.303Z] LT 22:21:30.953 - Starting thread. Suite=0 thread=3 [2024-08-28T22:21:31.303Z] LT 22:21:30.960 - Starting thread. Suite=0 thread=4 [2024-08-28T22:21:31.303Z] LT 22:21:30.962 - Starting thread. Suite=0 thread=5 [2024-08-28T22:21:31.303Z] LT 22:21:30.963 - Starting thread. Suite=0 thread=6 [2024-08-28T22:21:31.303Z] LT 22:21:30.972 - Starting thread. Suite=0 thread=7 [2024-08-28T22:21:31.303Z] LT 22:21:30.973 - Starting thread. Suite=0 thread=8 [2024-08-28T22:21:31.303Z] LT 22:21:30.976 - Starting thread. Suite=0 thread=9 [2024-08-28T22:21:31.303Z] LT 22:21:30.978 - Starting thread. Suite=0 thread=10 [2024-08-28T22:21:31.303Z] LT 22:21:30.984 - Starting thread. Suite=0 thread=11 [2024-08-28T22:21:31.303Z] LT 22:21:30.984 - Starting thread. Suite=0 thread=12 [2024-08-28T22:21:31.303Z] LT 22:21:30.986 - Starting thread. Suite=0 thread=13 [2024-08-28T22:21:31.303Z] LT 22:21:30.993 - Starting thread. Suite=0 thread=14 [2024-08-28T22:21:31.303Z] LT 22:21:30.994 - Starting thread. Suite=0 thread=15 [2024-08-28T22:21:31.303Z] LT 22:21:30.995 - Starting thread. Suite=0 thread=16 [2024-08-28T22:21:31.303Z] LT 22:21:30.996 - Starting thread. Suite=0 thread=17 [2024-08-28T22:21:31.303Z] LT 22:21:30.997 - Starting thread. Suite=0 thread=18 [2024-08-28T22:21:31.303Z] LT 22:21:30.997 - Starting thread. Suite=0 thread=19 [2024-08-28T22:21:55.196Z] LT 22:21:51.026 - Completed 6.7%. Number of tests started=106 [2024-08-28T22:22:11.814Z] LT 22:22:10.939 - Completed 13.3%. Number of tests started=173 (+67) [2024-08-28T22:22:32.029Z] LT 22:22:31.003 - Completed 20.0%. Number of tests started=254 (+81) [2024-08-28T22:22:52.579Z] LT 22:22:51.013 - Completed 26.7%. Number of tests started=323 (+69) [2024-08-28T22:23:12.905Z] LT 22:23:10.933 - Completed 33.4%. Number of tests started=384 (+61) [2024-08-28T22:23:32.828Z] LT 22:23:30.987 - Completed 40.0%. Number of tests started=440 (+56) [2024-08-28T22:23:53.479Z] LT 22:23:50.963 - Completed 46.7%. Number of tests started=548 (+108) [2024-08-28T22:24:14.389Z] LT 22:24:11.003 - Completed 53.4%. Number of tests started=622 (+74) [2024-08-28T22:24:31.509Z] LT 22:24:30.943 - Completed 60.0%. Number of tests started=717 (+95) [2024-08-28T22:24:55.810Z] LT 22:24:50.941 - Completed 66.7%. Number of tests started=764 (+47) [2024-08-28T22:25:12.349Z] LT 22:25:10.999 - Completed 73.4%. Number of tests started=822 (+58) [2024-08-28T22:25:29.348Z] LT 22:25:25.663 - First failure detected by thread: load-3. Not creating dumps as no dump generation is requested for this load test [2024-08-28T22:25:29.348Z] LT 22:25:25.668 - suite.getInventory().getInventoryFileRef(): openjdk.test.load/config/inventories/concurrent/concurrent.xml [2024-08-28T22:25:29.348Z] LT 22:25:25.668 - suite.isCreateDump() : false [2024-08-28T22:25:29.348Z] LT 22:25:25.689 - Test failed [2024-08-28T22:25:29.348Z] LT Failure num. = 1 [2024-08-28T22:25:29.348Z] LT Test number = 18 [2024-08-28T22:25:29.348Z] LT Test details = 'JUnit[net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest]' [2024-08-28T22:25:29.348Z] LT Suite number = 0 [2024-08-28T22:25:29.348Z] LT Thread number = 3 [2024-08-28T22:25:29.348Z] LT >>> Captured test output >>> [2024-08-28T22:25:29.348Z] LT testStarted : testAPI(net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest) [2024-08-28T22:25:29.348Z] LT testFailure: testAPI(net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest): 26 : weakCompareAndSet() expected:<true> but was:<false> [2024-08-28T22:25:29.348Z] LT junit.framework.AssertionFailedError: 26 : weakCompareAndSet() expected:<true> but was:<false> [2024-08-28T22:25:29.348Z] LT at junit.framework.Assert.fail(Assert.java:57) [2024-08-28T22:25:29.348Z] LT at junit.framework.Assert.failNotEquals(Assert.java:329) [2024-08-28T22:25:29.348Z] LT at junit.framework.Assert.assertEquals(Assert.java:78) [2024-08-28T22:25:29.348Z] LT at junit.framework.Assert.assertEquals(Assert.java:174) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestCase.assertEquals(TestCase.java:333) [2024-08-28T22:25:29.348Z] LT at net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest.testAPI(AtomicLongArrayTest.java:136) [2024-08-28T22:25:29.348Z] LT at jdk.internal.reflect.GeneratedMethodAccessor21.invoke(Unknown Source) [2024-08-28T22:25:29.348Z] LT at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [2024-08-28T22:25:29.348Z] LT at java.base/java.lang.reflect.Method.invoke(Method.java:566) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestCase.runTest(TestCase.java:176) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestCase.runBare(TestCase.java:141) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestResult$1.protect(TestResult.java:122) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestResult.runProtected(TestResult.java:142) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestResult.run(TestResult.java:125) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestCase.run(TestCase.java:129) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestSuite.runTest(TestSuite.java:252) [2024-08-28T22:25:29.348Z] LT at junit.framework.TestSuite.run(TestSuite.java:247) [2024-08-28T22:25:29.348Z] LT at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:86) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.Suite.runChild(Suite.java:128) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.Suite.runChild(Suite.java:27) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [2024-08-28T22:25:29.348Z] LT at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [2024-08-28T22:25:29.348Z] LT at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [2024-08-28T22:25:29.348Z] LT at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [2024-08-28T22:25:29.348Z] LT at net.adoptopenjdk.loadTest.adaptors.JUnitAdaptor.executeTest(JUnitAdaptor.java:130) [2024-08-28T22:25:29.348Z] LT at net.adoptopenjdk.loadTest.LoadTestRunner$2.run(LoadTestRunner.java:182) [2024-08-28T22:25:29.348Z] LT at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [2024-08-28T22:25:29.348Z] LT at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [2024-08-28T22:25:29.348Z] LT at java.base/java.lang.Thread.run(Thread.java:829) [2024-08-28T22:25:29.348Z] LT testFinished: testAPI(net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest) [2024-08-28T22:25:29.348Z] LT testStarted : testStress(net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest) [2024-08-28T22:25:29.348Z] LT testFinished: testStress(net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest) [2024-08-28T22:25:29.348Z] LT [2024-08-28T22:25:29.348Z] LT JUnit Test Results for: net.adoptopenjdk.test.concurrent.atomic.AtomicLongArrayTest [2024-08-28T22:25:29.348Z] LT Ran : 2 [2024-08-28T22:25:29.348Z] LT Passed : 1 [2024-08-28T22:25:29.348Z] LT Failed : 1 [2024-08-28T22:25:29.348Z] LT Ignored: 0 [2024-08-28T22:25:29.348Z] LT Result : FAILED [2024-08-28T22:25:29.348Z] LT <<< [2024-08-28T22:25:29.348Z] LT [2024-08-28T22:25:32.019Z] LT 22:25:31.024 - Completed 80.1%. Number of tests started=905 (+83) (with 1 failure(s)) [2024-08-28T22:25:52.195Z] LT 22:25:50.961 - Completed 86.7%. Number of tests started=1028 (+123) (with 1 failure(s)) [2024-08-28T22:26:12.329Z] LT 22:26:10.953 - Completed 93.4%. Number of tests started=1093 (+65) (with 1 failure(s)) [2024-08-28T22:26:29.449Z] STF 22:26:29.014 - Heartbeat: Process LT is still running [2024-08-28T22:26:31.478Z] LT 22:26:30.993 - Completed 100.0%. Number of tests started=1141 (+48) (with 1 failure(s)) [2024-08-28T22:26:35.201Z] LT 22:26:33.741 - Thread completed. Suite=0 thread=15 [2024-08-28T22:26:35.201Z] LT 22:26:34.024 - Thread completed. Suite=0 thread=18 [2024-08-28T22:26:36.059Z] LT 22:26:35.263 - Thread completed. Suite=0 thread=7 [2024-08-28T22:26:37.463Z] LT 22:26:36.200 - Thread completed. Suite=0 thread=8 [2024-08-28T22:26:37.851Z] LT 22:26:36.733 - Thread completed. Suite=0 thread=17 [2024-08-28T22:26:38.739Z] LT 22:26:38.003 - Thread completed. Suite=0 thread=2 [2024-08-28T22:26:40.738Z] LT 22:26:39.443 - Thread completed. Suite=0 thread=12 [2024-08-28T22:26:42.098Z] LT 22:26:41.124 - Thread completed. Suite=0 thread=1 [2024-08-28T22:26:46.564Z] LT 22:26:45.224 - Thread completed. Suite=0 thread=10 [2024-08-28T22:26:46.979Z] LT 22:26:46.263 - Thread completed. Suite=0 thread=16 [2024-08-28T22:26:48.519Z] LT 22:26:47.803 - Thread completed. Suite=0 thread=14 [2024-08-28T22:26:51.538Z] LT 22:26:50.970 - Completed 100.0%. Number of tests started=1141 (+0) (with 1 failure(s)) [2024-08-28T22:26:52.939Z] LT 22:26:52.573 - Thread completed. Suite=0 thread=11 [2024-08-28T22:26:54.359Z] LT 22:26:53.364 - Thread completed. Suite=0 thread=0 [2024-08-28T22:26:54.359Z] LT 22:26:53.493 - Thread completed. Suite=0 thread=9 [2024-08-28T22:27:06.413Z] LT 22:27:04.233 - Thread completed. Suite=0 thread=5 [2024-08-28T22:27:06.413Z] LT 22:27:04.303 - Thread completed. Suite=0 thread=4 [2024-08-28T22:27:06.413Z] LT 22:27:04.843 - Thread completed. Suite=0 thread=19 [2024-08-28T22:27:06.413Z] LT 22:27:04.930 - Thread completed. Suite=0 thread=3 [2024-08-28T22:27:06.413Z] LT 22:27:04.930 - Thread completed. Suite=0 thread=13 [2024-08-28T22:27:08.254Z] LT 22:27:07.483 - Thread completed. Suite=0 thread=6 [2024-08-28T22:27:08.254Z] LT 22:27:07.546 - Test stopped due to reaching runtime limit [2024-08-28T22:27:08.254Z] LT 22:27:07.546 - Load test completed [2024-08-28T22:27:08.254Z] LT 22:27:07.547 - Ran : 1141 [2024-08-28T22:27:08.254Z] LT 22:27:07.547 - Passed : 1140 [2024-08-28T22:27:08.254Z] LT 22:27:07.547 - Failed : 1 [2024-08-28T22:27:08.254Z] LT 22:27:07.548 - Result : FAILED [2024-08-28T22:27:08.254Z] STF 22:27:07.841 - **FAILED** Process LT ended with exit code (1) and not the expected exit code/s (0) [2024-08-28T22:27:08.254Z] STF 22:27:07.841 - Monitoring Report Summary: [2024-08-28T22:27:08.254Z] STF 22:27:07.841 - o Process LT ended with exit code (1) and not the expected exit code/s (0) [2024-08-28T22:27:08.254Z] STF 22:27:07.841 - Killing processes: LT [2024-08-28T22:27:08.254Z] STF 22:27:07.841 - o Process LT pid 18160 is not running [2024-08-28T22:27:08.254Z] **FAILED** at step 1 (Run concurrency unit tests). Expected return value=0 Actual=1 at /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/execute.pl line 93. [2024-08-28T22:27:08.254Z] STF 22:27:08.091 - **FAILED** execute script failed. Expected return value=0 Actual=1 [2024-08-28T22:27:08.254Z] STF 22:27:08.091 - [2024-08-28T22:27:08.254Z] STF 22:27:08.091 - ==================== T E A R D O W N ==================== [2024-08-28T22:27:08.254Z] STF 22:27:08.091 - Running teardown: perl /home/jenkins/workspace/Test_openjdk11_hs_extended.system_aarch64_linux/aqa-tests/TKG/../TKG/output_17248800522337/ConcurrentLoadTest_5m_1/20240828-222127-ConcurrentLoadTest/tearDown.pl [2024-08-28T22:27:08.254Z] STF 22:27:08.176 - TEARDOWN stage completed [2024-08-28T22:27:08.254Z] STF 22:27:08.179 - [2024-08-28T22:27:08.254Z] STF 22:27:08.179 - ===================== R E S U L T S ===================== [2024-08-28T22:27:08.254Z] STF 22:27:08.179 - Stage results: [2024-08-28T22:27:08.254Z] STF 22:27:08.179 - setUp: pass [2024-08-28T22:27:08.254Z] STF 22:27:08.179 - execute: *fail* [2024-08-28T22:27:08.254Z] STF 22:27:08.180 - teardown: pass [2024-08-28T22:27:08.254Z] STF 22:27:08.180 - [2024-08-28T22:27:08.254Z] STF 22:27:08.180 - Overall result: **FAILED** [2024-08-28T22:27:08.254Z] ----------------------------------- [2024-08-28T22:27:08.254Z] ConcurrentLoadTest_5m_1_FAILED [2024-08-28T22:27:08.254Z] ----------------------------------- [2024-08-28T22:27:08.254Z] [2024-08-28T22:27:08.254Z] TEST TEARDOWN: [2024-08-28T22:27:08.254Z] Nothing to be done for teardown. [2024-08-28T22:27:08.255Z] ConcurrentLoadTest_5m_1 Finish Time: Wed Aug 28 22:27:08 2024 Epoch Time (ms): 1724884028198