[2026-02-14T08:09:11.418Z] Running test renaissance-als_0 ... [2026-02-14T08:09:11.418Z] =============================================== [2026-02-14T08:09:11.418Z] renaissance-als_0 Start Time: Sat Feb 14 08:09:11 2026 Epoch Time (ms): 1771056551251 [2026-02-14T08:09:11.418Z] variation: NoOptions [2026-02-14T08:09:11.418Z] JVM_OPTIONS: [2026-02-14T08:09:11.418Z] { \ [2026-02-14T08:09:11.418Z] echo ""; echo "TEST SETUP:"; \ [2026-02-14T08:09:11.418Z] echo "Nothing to be done for setup."; \ [2026-02-14T08:09:11.418Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17710565506285/renaissance-als_0"; \ [2026-02-14T08:09:11.418Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17710565506285/renaissance-als_0"; \ [2026-02-14T08:09:11.418Z] echo ""; echo "TESTING:"; \ [2026-02-14T08:09:11.418Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/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_riscv64_linux_testList_2/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17710565506285/renaissance-als_0"/als.json" als; \ [2026-02-14T08:09:11.418Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17710565506285/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-14T08:09:11.418Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-14T08:09:11.418Z] echo "Nothing to be done for teardown."; \ [2026-02-14T08:09:11.418Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17710565506285/TestTargetResult"; [2026-02-14T08:09:11.418Z] [2026-02-14T08:09:11.418Z] TEST SETUP: [2026-02-14T08:09:11.418Z] Nothing to be done for setup. [2026-02-14T08:09:11.418Z] [2026-02-14T08:09:11.418Z] TESTING: [2026-02-14T08:09:14.394Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-14T08:09:14.394Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/output_17710565506285/renaissance-als_0/launcher-080911-2052390606363042962/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-14T08:09:14.394Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-14T08:09:14.394Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-14T08:09:37.492Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-14T08:09:53.381Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-14T08:09:53.382Z] GC before operation: completed in 213.035 ms, heap usage 53.735 MB -> 35.410 MB. [2026-02-14T08:11:02.672Z] ====== als (apache-spark) [default], iteration 0 completed (65838.637 ms) ====== [2026-02-14T08:11:02.672Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-14T08:11:02.672Z] GC before operation: completed in 608.091 ms, heap usage 270.019 MB -> 75.594 MB. [2026-02-14T08:11:30.650Z] ====== als (apache-spark) [default], iteration 1 completed (23735.127 ms) ====== [2026-02-14T08:11:30.650Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-14T08:11:30.650Z] GC before operation: completed in 717.432 ms, heap usage 267.856 MB -> 76.544 MB. [2026-02-14T08:11:53.761Z] ====== als (apache-spark) [default], iteration 2 completed (21906.294 ms) ====== [2026-02-14T08:11:53.761Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-14T08:11:53.761Z] GC before operation: completed in 746.969 ms, heap usage 1.218 GB -> 78.299 MB. [2026-02-14T08:12:16.843Z] ====== als (apache-spark) [default], iteration 3 completed (21363.289 ms) ====== [2026-02-14T08:12:16.843Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-14T08:12:16.843Z] GC before operation: completed in 737.060 ms, heap usage 153.053 MB -> 77.605 MB. [2026-02-14T08:12:39.968Z] ====== als (apache-spark) [default], iteration 4 completed (20699.661 ms) ====== [2026-02-14T08:12:39.968Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-14T08:12:39.968Z] GC before operation: completed in 767.261 ms, heap usage 206.644 MB -> 78.164 MB. [2026-02-14T08:12:59.209Z] ====== als (apache-spark) [default], iteration 5 completed (19618.620 ms) ====== [2026-02-14T08:12:59.209Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-14T08:12:59.209Z] GC before operation: completed in 738.538 ms, heap usage 519.350 MB -> 79.211 MB. [2026-02-14T08:13:22.304Z] ====== als (apache-spark) [default], iteration 6 completed (19805.405 ms) ====== [2026-02-14T08:13:22.305Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-14T08:13:22.305Z] GC before operation: completed in 777.900 ms, heap usage 1.528 GB -> 80.834 MB. [2026-02-14T08:13:41.764Z] ====== als (apache-spark) [default], iteration 7 completed (20374.969 ms) ====== [2026-02-14T08:13:41.765Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-14T08:13:42.109Z] GC before operation: completed in 814.109 ms, heap usage 445.091 MB -> 80.129 MB. [2026-02-14T08:14:05.196Z] ====== als (apache-spark) [default], iteration 8 completed (19323.974 ms) ====== [2026-02-14T08:14:05.196Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-14T08:14:05.196Z] GC before operation: completed in 796.222 ms, heap usage 372.190 MB -> 80.456 MB. [2026-02-14T08:14:24.634Z] ====== als (apache-spark) [default], iteration 9 completed (19271.454 ms) ====== [2026-02-14T08:14:24.634Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-14T08:14:24.634Z] GC before operation: completed in 810.055 ms, heap usage 507.483 MB -> 81.067 MB. [2026-02-14T08:14:47.740Z] ====== als (apache-spark) [default], iteration 10 completed (19571.764 ms) ====== [2026-02-14T08:14:47.740Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-14T08:14:47.740Z] GC before operation: completed in 815.956 ms, heap usage 420.966 MB -> 81.074 MB. [2026-02-14T08:15:06.925Z] ====== als (apache-spark) [default], iteration 11 completed (18850.989 ms) ====== [2026-02-14T08:15:06.925Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-14T08:15:06.925Z] GC before operation: completed in 856.316 ms, heap usage 532.752 MB -> 81.665 MB. [2026-02-14T08:15:26.175Z] ====== als (apache-spark) [default], iteration 12 completed (19031.684 ms) ====== [2026-02-14T08:15:26.175Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-14T08:15:26.512Z] GC before operation: completed in 850.858 ms, heap usage 326.409 MB -> 81.515 MB. [2026-02-14T08:15:49.660Z] ====== als (apache-spark) [default], iteration 13 completed (18780.110 ms) ====== [2026-02-14T08:15:49.660Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-14T08:15:49.660Z] GC before operation: completed in 861.525 ms, heap usage 631.364 MB -> 82.117 MB. [2026-02-14T08:16:08.993Z] ====== als (apache-spark) [default], iteration 14 completed (18765.496 ms) ====== [2026-02-14T08:16:08.993Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-14T08:16:08.993Z] GC before operation: completed in 868.832 ms, heap usage 603.164 MB -> 82.240 MB. [2026-02-14T08:16:28.161Z] ====== als (apache-spark) [default], iteration 15 completed (18612.018 ms) ====== [2026-02-14T08:16:28.161Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-14T08:16:28.161Z] GC before operation: completed in 909.563 ms, heap usage 236.946 MB -> 82.120 MB. [2026-02-14T08:16:47.359Z] ====== als (apache-spark) [default], iteration 16 completed (18306.355 ms) ====== [2026-02-14T08:16:47.359Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-14T08:16:47.692Z] GC before operation: completed in 887.776 ms, heap usage 179.004 MB -> 82.452 MB. [2026-02-14T08:17:10.797Z] ====== als (apache-spark) [default], iteration 17 completed (18935.174 ms) ====== [2026-02-14T08:17:10.797Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-14T08:17:10.797Z] GC before operation: completed in 883.628 ms, heap usage 495.847 MB -> 82.998 MB. [2026-02-14T08:17:30.076Z] ====== als (apache-spark) [default], iteration 18 completed (18394.155 ms) ====== [2026-02-14T08:17:30.076Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-14T08:17:30.076Z] GC before operation: completed in 904.624 ms, heap usage 380.068 MB -> 83.092 MB. [2026-02-14T08:17:49.261Z] ====== als (apache-spark) [default], iteration 19 completed (18375.259 ms) ====== [2026-02-14T08:17:49.261Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-14T08:17:49.261Z] GC before operation: completed in 907.284 ms, heap usage 225.716 MB -> 83.264 MB. [2026-02-14T08:18:08.440Z] ====== als (apache-spark) [default], iteration 20 completed (18843.035 ms) ====== [2026-02-14T08:18:08.440Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-14T08:18:09.164Z] GC before operation: completed in 923.175 ms, heap usage 277.717 MB -> 83.656 MB. [2026-02-14T08:18:28.337Z] ====== als (apache-spark) [default], iteration 21 completed (17904.061 ms) ====== [2026-02-14T08:18:28.337Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-14T08:18:28.675Z] GC before operation: completed in 928.492 ms, heap usage 142.289 MB -> 83.181 MB. [2026-02-14T08:18:51.825Z] ====== als (apache-spark) [default], iteration 22 completed (18748.552 ms) ====== [2026-02-14T08:18:51.825Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-14T08:18:51.826Z] GC before operation: completed in 947.534 ms, heap usage 457.861 MB -> 84.372 MB. [2026-02-14T08:19:11.108Z] ====== als (apache-spark) [default], iteration 23 completed (18306.721 ms) ====== [2026-02-14T08:19:11.108Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-14T08:19:11.108Z] GC before operation: completed in 925.716 ms, heap usage 574.290 MB -> 84.770 MB. [2026-02-14T08:19:30.331Z] ====== als (apache-spark) [default], iteration 24 completed (18812.988 ms) ====== [2026-02-14T08:19:30.331Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-14T08:19:30.331Z] GC before operation: completed in 933.523 ms, heap usage 478.787 MB -> 84.930 MB. [2026-02-14T08:19:49.509Z] ====== als (apache-spark) [default], iteration 25 completed (18693.519 ms) ====== [2026-02-14T08:19:49.510Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-14T08:19:49.847Z] GC before operation: completed in 980.832 ms, heap usage 382.432 MB -> 84.982 MB. [2026-02-14T08:20:09.042Z] ====== als (apache-spark) [default], iteration 26 completed (18241.930 ms) ====== [2026-02-14T08:20:09.042Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-14T08:20:09.787Z] GC before operation: completed in 952.648 ms, heap usage 351.481 MB -> 85.323 MB. [2026-02-14T08:20:29.215Z] ====== als (apache-spark) [default], iteration 27 completed (18157.254 ms) ====== [2026-02-14T08:20:29.215Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-14T08:20:29.928Z] GC before operation: completed in 963.369 ms, heap usage 240.785 MB -> 84.814 MB. [2026-02-14T08:20:49.133Z] ====== als (apache-spark) [default], iteration 28 completed (18179.934 ms) ====== [2026-02-14T08:20:49.133Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-14T08:20:49.849Z] GC before operation: completed in 952.251 ms, heap usage 387.567 MB -> 85.314 MB. [2026-02-14T08:21:08.994Z] ====== als (apache-spark) [default], iteration 29 completed (17900.458 ms) ====== [2026-02-14T08:21:10.142Z] ----------------------------------- [2026-02-14T08:21:10.142Z] renaissance-als_0_PASSED [2026-02-14T08:21:10.142Z] ----------------------------------- [2026-02-14T08:21:10.474Z] [2026-02-14T08:21:10.474Z] TEST TEARDOWN: [2026-02-14T08:21:10.474Z] Nothing to be done for teardown. [2026-02-14T08:21:10.474Z] renaissance-als_0 Finish Time: Sat Feb 14 08:21:10 2026 Epoch Time (ms): 1771057270398