[2026-02-06T01:58:36.635Z] Running test renaissance-als_0 ... [2026-02-06T01:58:36.635Z] =============================================== [2026-02-06T01:58:36.635Z] renaissance-als_0 Start Time: Fri Feb 6 01:58:35 2026 Epoch Time (ms): 1770343115438 [2026-02-06T01:58:36.635Z] variation: NoOptions [2026-02-06T01:58:36.635Z] JVM_OPTIONS: [2026-02-06T01:58:36.635Z] { \ [2026-02-06T01:58:36.635Z] echo ""; echo "TEST SETUP:"; \ [2026-02-06T01:58:36.635Z] echo "Nothing to be done for setup."; \ [2026-02-06T01:58:36.635Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17703431144533/renaissance-als_0"; \ [2026-02-06T01:58:36.635Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17703431144533/renaissance-als_0"; \ [2026-02-06T01:58:36.635Z] echo ""; echo "TESTING:"; \ [2026-02-06T01:58:36.635Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/jdkbinary/j2sdk-image/bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17703431144533/renaissance-als_0"/als.json" als; \ [2026-02-06T01:58:36.635Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17703431144533/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-06T01:58:36.635Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-06T01:58:36.635Z] echo "Nothing to be done for teardown."; \ [2026-02-06T01:58:36.636Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17703431144533/TestTargetResult"; [2026-02-06T01:58:36.636Z] [2026-02-06T01:58:36.636Z] TEST SETUP: [2026-02-06T01:58:36.636Z] Nothing to be done for setup. [2026-02-06T01:58:36.636Z] [2026-02-06T01:58:36.636Z] TESTING: [2026-02-06T01:58:38.647Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-06T01:58:38.647Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17703431144533/renaissance-als_0/launcher-015836-10695886765183232/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-06T01:58:38.647Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-06T01:58:38.647Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-06T01:58:50.539Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-06T01:58:58.908Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-06T01:58:58.908Z] GC before operation: completed in 64.352 ms, heap usage 155.525 MB -> 35.323 MB. [2026-02-06T01:59:29.532Z] ====== als (apache-spark) [default], iteration 0 completed (29456.246 ms) ====== [2026-02-06T01:59:29.532Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-06T01:59:29.532Z] GC before operation: completed in 179.274 ms, heap usage 428.639 MB -> 62.113 MB. [2026-02-06T01:59:39.799Z] ====== als (apache-spark) [default], iteration 1 completed (9798.617 ms) ====== [2026-02-06T01:59:39.799Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-06T01:59:39.799Z] GC before operation: completed in 159.958 ms, heap usage 184.605 MB -> 62.815 MB. [2026-02-06T01:59:48.220Z] ====== als (apache-spark) [default], iteration 2 completed (8315.199 ms) ====== [2026-02-06T01:59:48.220Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-06T01:59:48.220Z] GC before operation: completed in 155.231 ms, heap usage 498.163 MB -> 63.873 MB. [2026-02-06T01:59:56.558Z] ====== als (apache-spark) [default], iteration 3 completed (8333.538 ms) ====== [2026-02-06T01:59:56.558Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-06T01:59:56.558Z] GC before operation: completed in 164.899 ms, heap usage 451.124 MB -> 64.428 MB. [2026-02-06T02:00:04.975Z] ====== als (apache-spark) [default], iteration 4 completed (7837.703 ms) ====== [2026-02-06T02:00:04.975Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-06T02:00:04.975Z] GC before operation: completed in 175.809 ms, heap usage 303.317 MB -> 64.782 MB. [2026-02-06T02:00:13.230Z] ====== als (apache-spark) [default], iteration 5 completed (7540.892 ms) ====== [2026-02-06T02:00:13.230Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-06T02:00:13.230Z] GC before operation: completed in 165.910 ms, heap usage 322.127 MB -> 65.312 MB. [2026-02-06T02:00:21.561Z] ====== als (apache-spark) [default], iteration 6 completed (7441.034 ms) ====== [2026-02-06T02:00:21.561Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-06T02:00:21.561Z] GC before operation: completed in 172.898 ms, heap usage 206.660 MB -> 65.799 MB. [2026-02-06T02:00:28.383Z] ====== als (apache-spark) [default], iteration 7 completed (7078.426 ms) ====== [2026-02-06T02:00:28.383Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-06T02:00:29.354Z] GC before operation: completed in 229.073 ms, heap usage 254.709 MB -> 66.375 MB. [2026-02-06T02:00:37.789Z] ====== als (apache-spark) [default], iteration 8 completed (7560.160 ms) ====== [2026-02-06T02:00:37.789Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-06T02:00:37.789Z] GC before operation: completed in 169.173 ms, heap usage 531.889 MB -> 67.255 MB. [2026-02-06T02:00:44.595Z] ====== als (apache-spark) [default], iteration 9 completed (7153.075 ms) ====== [2026-02-06T02:00:44.595Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-06T02:00:44.595Z] GC before operation: completed in 177.024 ms, heap usage 353.300 MB -> 67.291 MB. [2026-02-06T02:00:52.838Z] ====== als (apache-spark) [default], iteration 10 completed (7944.419 ms) ====== [2026-02-06T02:00:52.838Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-06T02:00:52.838Z] GC before operation: completed in 170.268 ms, heap usage 283.096 MB -> 67.396 MB. [2026-02-06T02:01:01.100Z] ====== als (apache-spark) [default], iteration 11 completed (7075.591 ms) ====== [2026-02-06T02:01:01.100Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-06T02:01:01.100Z] GC before operation: completed in 196.904 ms, heap usage 490.102 MB -> 68.041 MB. [2026-02-06T02:01:07.892Z] ====== als (apache-spark) [default], iteration 12 completed (6872.600 ms) ====== [2026-02-06T02:01:07.892Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-06T02:01:07.892Z] GC before operation: completed in 166.009 ms, heap usage 272.681 MB -> 67.922 MB. [2026-02-06T02:01:14.667Z] ====== als (apache-spark) [default], iteration 13 completed (6741.428 ms) ====== [2026-02-06T02:01:14.667Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-06T02:01:14.667Z] GC before operation: completed in 180.954 ms, heap usage 497.406 MB -> 68.506 MB. [2026-02-06T02:01:24.525Z] ====== als (apache-spark) [default], iteration 14 completed (8516.758 ms) ====== [2026-02-06T02:01:24.525Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-06T02:01:24.525Z] GC before operation: completed in 183.960 ms, heap usage 201.225 MB -> 68.470 MB. [2026-02-06T02:01:31.462Z] ====== als (apache-spark) [default], iteration 15 completed (6787.438 ms) ====== [2026-02-06T02:01:31.462Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-06T02:01:31.462Z] GC before operation: completed in 195.594 ms, heap usage 295.351 MB -> 68.834 MB. [2026-02-06T02:01:38.253Z] ====== als (apache-spark) [default], iteration 16 completed (6906.289 ms) ====== [2026-02-06T02:01:38.253Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-06T02:01:38.253Z] GC before operation: completed in 199.376 ms, heap usage 321.785 MB -> 69.059 MB. [2026-02-06T02:01:46.519Z] ====== als (apache-spark) [default], iteration 17 completed (6888.787 ms) ====== [2026-02-06T02:01:46.519Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-06T02:01:46.519Z] GC before operation: completed in 194.464 ms, heap usage 328.261 MB -> 69.370 MB. [2026-02-06T02:01:53.445Z] ====== als (apache-spark) [default], iteration 18 completed (6715.391 ms) ====== [2026-02-06T02:01:53.445Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-06T02:01:53.445Z] GC before operation: completed in 200.700 ms, heap usage 567.648 MB -> 69.961 MB. [2026-02-06T02:02:01.699Z] ====== als (apache-spark) [default], iteration 19 completed (7264.325 ms) ====== [2026-02-06T02:02:01.699Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-06T02:02:01.699Z] GC before operation: completed in 222.689 ms, heap usage 611.008 MB -> 70.175 MB. [2026-02-06T02:02:08.492Z] ====== als (apache-spark) [default], iteration 20 completed (7062.463 ms) ====== [2026-02-06T02:02:08.492Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-06T02:02:08.492Z] GC before operation: completed in 194.400 ms, heap usage 106.340 MB -> 69.879 MB. [2026-02-06T02:02:15.296Z] ====== als (apache-spark) [default], iteration 21 completed (6890.795 ms) ====== [2026-02-06T02:02:15.296Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-06T02:02:16.304Z] GC before operation: completed in 190.874 ms, heap usage 448.510 MB -> 70.543 MB. [2026-02-06T02:02:23.105Z] ====== als (apache-spark) [default], iteration 22 completed (6801.980 ms) ====== [2026-02-06T02:02:23.105Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-06T02:02:23.105Z] GC before operation: completed in 203.498 ms, heap usage 237.864 MB -> 70.484 MB. [2026-02-06T02:02:29.912Z] ====== als (apache-spark) [default], iteration 23 completed (6698.838 ms) ====== [2026-02-06T02:02:29.912Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-06T02:02:29.912Z] GC before operation: completed in 220.494 ms, heap usage 214.336 MB -> 70.548 MB. [2026-02-06T02:02:38.310Z] ====== als (apache-spark) [default], iteration 24 completed (6847.313 ms) ====== [2026-02-06T02:02:38.310Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-06T02:02:38.310Z] GC before operation: completed in 210.816 ms, heap usage 160.940 MB -> 70.891 MB. [2026-02-06T02:02:45.159Z] ====== als (apache-spark) [default], iteration 25 completed (6371.584 ms) ====== [2026-02-06T02:02:45.159Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-06T02:02:45.159Z] GC before operation: completed in 199.016 ms, heap usage 537.721 MB -> 71.695 MB. [2026-02-06T02:02:51.442Z] ====== als (apache-spark) [default], iteration 26 completed (6524.776 ms) ====== [2026-02-06T02:02:51.442Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-06T02:02:51.442Z] GC before operation: completed in 195.856 ms, heap usage 112.851 MB -> 71.417 MB. [2026-02-06T02:02:58.341Z] ====== als (apache-spark) [default], iteration 27 completed (6463.194 ms) ====== [2026-02-06T02:02:58.341Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-06T02:02:58.341Z] GC before operation: completed in 192.706 ms, heap usage 587.172 MB -> 72.191 MB. [2026-02-06T02:03:05.214Z] ====== als (apache-spark) [default], iteration 28 completed (6740.228 ms) ====== [2026-02-06T02:03:05.214Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-06T02:03:05.214Z] GC before operation: completed in 221.430 ms, heap usage 122.350 MB -> 71.974 MB. [2026-02-06T02:03:12.001Z] ====== als (apache-spark) [default], iteration 29 completed (6392.471 ms) ====== [2026-02-06T02:03:12.965Z] ----------------------------------- [2026-02-06T02:03:12.965Z] renaissance-als_0_PASSED [2026-02-06T02:03:12.965Z] ----------------------------------- [2026-02-06T02:03:12.965Z] [2026-02-06T02:03:12.965Z] TEST TEARDOWN: [2026-02-06T02:03:12.965Z] Nothing to be done for teardown. [2026-02-06T02:03:12.965Z] renaissance-als_0 Finish Time: Fri Feb 6 02:03:12 2026 Epoch Time (ms): 1770343392455