[2026-01-03T17:47:10.089Z] Running test renaissance-als_0 ... [2026-01-03T17:47:10.089Z] =============================================== [2026-01-03T17:47:10.089Z] renaissance-als_0 Start Time: Sat Jan 3 17:47:09 2026 Epoch Time (ms): 1767462429851 [2026-01-03T17:47:10.089Z] variation: NoOptions [2026-01-03T17:47:10.089Z] JVM_OPTIONS: [2026-01-03T17:47:10.089Z] { \ [2026-01-03T17:47:10.089Z] echo ""; echo "TEST SETUP:"; \ [2026-01-03T17:47:10.089Z] echo "Nothing to be done for setup."; \ [2026-01-03T17:47:10.089Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17674619209086/renaissance-als_0"; \ [2026-01-03T17:47:10.089Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17674619209086/renaissance-als_0"; \ [2026-01-03T17:47:10.089Z] echo ""; echo "TESTING:"; \ [2026-01-03T17:47:10.089Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_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_riscv64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17674619209086/renaissance-als_0"/als.json" als; \ [2026-01-03T17:47:10.089Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17674619209086/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-03T17:47:10.089Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-03T17:47:10.089Z] echo "Nothing to be done for teardown."; \ [2026-01-03T17:47:10.089Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/../TKG/output_17674619209086/TestTargetResult"; [2026-01-03T17:47:10.089Z] [2026-01-03T17:47:10.089Z] TEST SETUP: [2026-01-03T17:47:10.089Z] Nothing to be done for setup. [2026-01-03T17:47:10.089Z] [2026-01-03T17:47:10.089Z] TESTING: [2026-01-03T17:47:12.435Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-03T17:47:12.435Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux/aqa-tests/TKG/output_17674619209086/renaissance-als_0/launcher-174710-2452691709961016293/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-03T17:47:12.435Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-03T17:47:12.435Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-03T17:47:35.494Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-03T17:47:51.310Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-03T17:47:51.310Z] GC before operation: completed in 226.680 ms, heap usage 173.924 MB -> 35.430 MB. [2026-01-03T17:49:00.501Z] ====== als (apache-spark) [default], iteration 0 completed (67029.759 ms) ====== [2026-01-03T17:49:00.501Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-03T17:49:01.222Z] GC before operation: completed in 620.405 ms, heap usage 269.038 MB -> 75.260 MB. [2026-01-03T17:49:28.933Z] ====== als (apache-spark) [default], iteration 1 completed (25766.559 ms) ====== [2026-01-03T17:49:28.933Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-03T17:49:28.933Z] GC before operation: completed in 648.657 ms, heap usage 587.416 MB -> 76.674 MB. [2026-01-03T17:49:56.596Z] ====== als (apache-spark) [default], iteration 2 completed (22756.326 ms) ====== [2026-01-03T17:49:56.596Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-03T17:49:56.596Z] GC before operation: completed in 668.499 ms, heap usage 521.982 MB -> 77.272 MB. [2026-01-03T17:50:19.600Z] ====== als (apache-spark) [default], iteration 3 completed (21805.025 ms) ====== [2026-01-03T17:50:19.600Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-03T17:50:19.600Z] GC before operation: completed in 700.548 ms, heap usage 601.636 MB -> 77.966 MB. [2026-01-03T17:50:42.583Z] ====== als (apache-spark) [default], iteration 4 completed (21328.920 ms) ====== [2026-01-03T17:50:42.583Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-03T17:50:42.583Z] GC before operation: completed in 726.904 ms, heap usage 246.725 MB -> 77.880 MB. [2026-01-03T17:51:01.704Z] ====== als (apache-spark) [default], iteration 5 completed (20633.264 ms) ====== [2026-01-03T17:51:01.704Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-03T17:51:02.419Z] GC before operation: completed in 772.990 ms, heap usage 150.783 MB -> 78.443 MB. [2026-01-03T17:51:26.146Z] ====== als (apache-spark) [default], iteration 6 completed (21614.384 ms) ====== [2026-01-03T17:51:26.146Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-03T17:51:26.146Z] GC before operation: completed in 817.240 ms, heap usage 335.839 MB -> 79.261 MB. [2026-01-03T17:51:49.142Z] ====== als (apache-spark) [default], iteration 7 completed (21209.598 ms) ====== [2026-01-03T17:51:49.142Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-03T17:51:49.142Z] GC before operation: completed in 817.527 ms, heap usage 526.428 MB -> 80.058 MB. [2026-01-03T17:52:12.228Z] ====== als (apache-spark) [default], iteration 8 completed (20655.605 ms) ====== [2026-01-03T17:52:12.228Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-03T17:52:12.228Z] GC before operation: completed in 834.693 ms, heap usage 506.124 MB -> 80.571 MB. [2026-01-03T17:52:35.214Z] ====== als (apache-spark) [default], iteration 9 completed (20666.876 ms) ====== [2026-01-03T17:52:35.214Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-03T17:52:35.214Z] GC before operation: completed in 804.737 ms, heap usage 601.817 MB -> 80.894 MB. [2026-01-03T17:52:58.198Z] ====== als (apache-spark) [default], iteration 10 completed (20651.336 ms) ====== [2026-01-03T17:52:58.198Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-03T17:52:58.198Z] GC before operation: completed in 822.456 ms, heap usage 239.215 MB -> 80.683 MB. [2026-01-03T17:53:17.286Z] ====== als (apache-spark) [default], iteration 11 completed (20273.169 ms) ====== [2026-01-03T17:53:17.286Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-03T17:53:17.617Z] GC before operation: completed in 823.388 ms, heap usage 160.388 MB -> 80.811 MB. [2026-01-03T17:53:40.659Z] ====== als (apache-spark) [default], iteration 12 completed (19861.030 ms) ====== [2026-01-03T17:53:40.659Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-03T17:53:40.659Z] GC before operation: completed in 839.765 ms, heap usage 258.696 MB -> 81.394 MB. [2026-01-03T17:54:03.711Z] ====== als (apache-spark) [default], iteration 13 completed (20270.425 ms) ====== [2026-01-03T17:54:03.711Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-03T17:54:03.711Z] GC before operation: completed in 865.090 ms, heap usage 1.452 GB -> 82.938 MB. [2026-01-03T17:54:22.801Z] ====== als (apache-spark) [default], iteration 14 completed (20395.091 ms) ====== [2026-01-03T17:54:22.801Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-03T17:54:22.801Z] GC before operation: completed in 850.946 ms, heap usage 404.289 MB -> 82.068 MB. [2026-01-03T17:54:45.821Z] ====== als (apache-spark) [default], iteration 15 completed (19605.525 ms) ====== [2026-01-03T17:54:45.821Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-03T17:54:45.821Z] GC before operation: completed in 868.589 ms, heap usage 461.080 MB -> 82.434 MB. [2026-01-03T17:55:05.017Z] ====== als (apache-spark) [default], iteration 16 completed (20211.211 ms) ====== [2026-01-03T17:55:05.017Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-03T17:55:06.187Z] GC before operation: completed in 919.995 ms, heap usage 1.474 GB -> 83.796 MB. [2026-01-03T17:55:29.202Z] ====== als (apache-spark) [default], iteration 17 completed (20107.445 ms) ====== [2026-01-03T17:55:29.202Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-03T17:55:29.202Z] GC before operation: completed in 892.698 ms, heap usage 577.791 MB -> 83.181 MB. [2026-01-03T17:55:48.288Z] ====== als (apache-spark) [default], iteration 18 completed (19706.593 ms) ====== [2026-01-03T17:55:48.288Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-03T17:55:49.442Z] GC before operation: completed in 904.958 ms, heap usage 280.650 MB -> 83.048 MB. [2026-01-03T17:56:12.431Z] ====== als (apache-spark) [default], iteration 19 completed (19733.886 ms) ====== [2026-01-03T17:56:12.431Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-03T17:56:12.431Z] GC before operation: completed in 904.438 ms, heap usage 246.651 MB -> 83.221 MB. [2026-01-03T17:56:31.619Z] ====== als (apache-spark) [default], iteration 20 completed (20215.885 ms) ====== [2026-01-03T17:56:31.619Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-03T17:56:32.787Z] GC before operation: completed in 925.590 ms, heap usage 140.518 MB -> 83.306 MB. [2026-01-03T17:56:55.783Z] ====== als (apache-spark) [default], iteration 21 completed (19558.453 ms) ====== [2026-01-03T17:56:55.784Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-03T17:56:55.784Z] GC before operation: completed in 910.726 ms, heap usage 232.609 MB -> 83.600 MB. [2026-01-03T17:57:14.895Z] ====== als (apache-spark) [default], iteration 22 completed (19393.351 ms) ====== [2026-01-03T17:57:14.896Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-03T17:57:14.896Z] GC before operation: completed in 960.809 ms, heap usage 192.447 MB -> 83.936 MB. [2026-01-03T17:57:37.893Z] ====== als (apache-spark) [default], iteration 23 completed (19599.344 ms) ====== [2026-01-03T17:57:37.893Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-03T17:57:37.893Z] GC before operation: completed in 950.875 ms, heap usage 537.560 MB -> 84.751 MB. [2026-01-03T17:57:57.108Z] ====== als (apache-spark) [default], iteration 24 completed (19828.291 ms) ====== [2026-01-03T17:57:57.108Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-03T17:57:57.847Z] GC before operation: completed in 943.034 ms, heap usage 228.740 MB -> 84.460 MB. [2026-01-03T17:58:20.880Z] ====== als (apache-spark) [default], iteration 25 completed (19197.446 ms) ====== [2026-01-03T17:58:20.880Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-03T17:58:20.880Z] GC before operation: completed in 953.129 ms, heap usage 136.939 MB -> 84.275 MB. [2026-01-03T17:58:39.972Z] ====== als (apache-spark) [default], iteration 26 completed (19569.694 ms) ====== [2026-01-03T17:58:39.972Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-03T17:58:39.972Z] GC before operation: completed in 940.056 ms, heap usage 114.250 MB -> 85.584 MB. [2026-01-03T17:59:03.025Z] ====== als (apache-spark) [default], iteration 27 completed (19147.246 ms) ====== [2026-01-03T17:59:03.025Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-03T17:59:03.025Z] GC before operation: completed in 949.873 ms, heap usage 240.003 MB -> 85.332 MB. [2026-01-03T17:59:22.177Z] ====== als (apache-spark) [default], iteration 28 completed (19833.666 ms) ====== [2026-01-03T17:59:22.177Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-03T17:59:22.177Z] GC before operation: completed in 967.509 ms, heap usage 157.766 MB -> 84.921 MB. [2026-01-03T17:59:45.169Z] ====== als (apache-spark) [default], iteration 29 completed (18529.637 ms) ====== [2026-01-03T17:59:45.169Z] ----------------------------------- [2026-01-03T17:59:45.169Z] renaissance-als_0_PASSED [2026-01-03T17:59:45.169Z] ----------------------------------- [2026-01-03T17:59:45.169Z] [2026-01-03T17:59:45.169Z] TEST TEARDOWN: [2026-01-03T17:59:45.169Z] Nothing to be done for teardown. [2026-01-03T17:59:45.169Z] renaissance-als_0 Finish Time: Sat Jan 3 17:59:43 2026 Epoch Time (ms): 1767463183609