[2026-02-06T08:21:06.500Z] Running test renaissance-als_0 ... [2026-02-06T08:21:06.500Z] =============================================== [2026-02-06T08:21:06.500Z] renaissance-als_0 Start Time: Fri Feb 6 08:21:06 2026 Epoch Time (ms): 1770366066284 [2026-02-06T08:21:06.500Z] variation: NoOptions [2026-02-06T08:21:06.500Z] JVM_OPTIONS: [2026-02-06T08:21:06.500Z] { \ [2026-02-06T08:21:06.500Z] echo ""; echo "TEST SETUP:"; \ [2026-02-06T08:21:06.500Z] echo "Nothing to be done for setup."; \ [2026-02-06T08:21:06.500Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17703660654041/renaissance-als_0"; \ [2026-02-06T08:21:06.501Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17703660654041/renaissance-als_0"; \ [2026-02-06T08:21:06.501Z] echo ""; echo "TESTING:"; \ [2026-02-06T08:21:06.501Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/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_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17703660654041/renaissance-als_0"/als.json" als; \ [2026-02-06T08:21:06.501Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17703660654041/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-06T08:21:06.501Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-06T08:21:06.501Z] echo "Nothing to be done for teardown."; \ [2026-02-06T08:21:06.501Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17703660654041/TestTargetResult"; [2026-02-06T08:21:06.501Z] [2026-02-06T08:21:06.501Z] TEST SETUP: [2026-02-06T08:21:06.501Z] Nothing to be done for setup. [2026-02-06T08:21:06.501Z] [2026-02-06T08:21:06.501Z] TESTING: [2026-02-06T08:21:08.827Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-06T08:21:08.827Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/output_17703660654041/renaissance-als_0/launcher-082107-5702614867026444664/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-06T08:21:08.827Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-06T08:21:08.827Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-06T08:21:32.086Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-06T08:21:48.162Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-06T08:21:48.162Z] GC before operation: completed in 234.587 ms, heap usage 55.710 MB -> 35.438 MB. [2026-02-06T08:22:58.278Z] ====== als (apache-spark) [default], iteration 0 completed (66260.815 ms) ====== [2026-02-06T08:22:58.278Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-06T08:22:58.278Z] GC before operation: completed in 671.087 ms, heap usage 174.846 MB -> 75.324 MB. [2026-02-06T08:23:26.242Z] ====== als (apache-spark) [default], iteration 1 completed (23835.520 ms) ====== [2026-02-06T08:23:26.242Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-06T08:23:26.242Z] GC before operation: completed in 631.687 ms, heap usage 362.248 MB -> 76.350 MB. [2026-02-06T08:23:49.512Z] ====== als (apache-spark) [default], iteration 2 completed (21801.619 ms) ====== [2026-02-06T08:23:49.512Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-06T08:23:49.513Z] GC before operation: completed in 691.780 ms, heap usage 452.429 MB -> 77.153 MB. [2026-02-06T08:24:12.811Z] ====== als (apache-spark) [default], iteration 3 completed (21141.408 ms) ====== [2026-02-06T08:24:12.811Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-06T08:24:12.811Z] GC before operation: completed in 711.434 ms, heap usage 461.827 MB -> 77.763 MB. [2026-02-06T08:24:32.151Z] ====== als (apache-spark) [default], iteration 4 completed (20273.661 ms) ====== [2026-02-06T08:24:32.151Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-06T08:24:32.151Z] GC before operation: completed in 736.120 ms, heap usage 159.401 MB -> 77.854 MB. [2026-02-06T08:24:55.409Z] ====== als (apache-spark) [default], iteration 5 completed (20109.278 ms) ====== [2026-02-06T08:24:55.409Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-06T08:24:55.409Z] GC before operation: completed in 747.307 ms, heap usage 215.911 MB -> 78.620 MB. [2026-02-06T08:25:18.693Z] ====== als (apache-spark) [default], iteration 6 completed (20176.650 ms) ====== [2026-02-06T08:25:18.693Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-06T08:25:18.693Z] GC before operation: completed in 748.893 ms, heap usage 370.849 MB -> 79.195 MB. [2026-02-06T08:25:38.015Z] ====== als (apache-spark) [default], iteration 7 completed (19442.734 ms) ====== [2026-02-06T08:25:38.015Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-06T08:25:38.015Z] GC before operation: completed in 890.263 ms, heap usage 493.494 MB -> 79.952 MB. [2026-02-06T08:25:57.372Z] ====== als (apache-spark) [default], iteration 8 completed (19106.376 ms) ====== [2026-02-06T08:25:57.372Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-06T08:25:57.720Z] GC before operation: completed in 817.527 ms, heap usage 321.887 MB -> 80.323 MB. [2026-02-06T08:26:21.026Z] ====== als (apache-spark) [default], iteration 9 completed (20103.438 ms) ====== [2026-02-06T08:26:21.026Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-06T08:26:21.026Z] GC before operation: completed in 821.686 ms, heap usage 459.176 MB -> 80.756 MB. [2026-02-06T08:26:40.374Z] ====== als (apache-spark) [default], iteration 10 completed (19173.405 ms) ====== [2026-02-06T08:26:40.374Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-06T08:26:40.718Z] GC before operation: completed in 851.470 ms, heap usage 284.919 MB -> 80.644 MB. [2026-02-06T08:27:03.996Z] ====== als (apache-spark) [default], iteration 11 completed (19677.739 ms) ====== [2026-02-06T08:27:03.996Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-06T08:27:03.996Z] GC before operation: completed in 828.716 ms, heap usage 235.585 MB -> 80.893 MB. [2026-02-06T08:27:23.827Z] ====== als (apache-spark) [default], iteration 12 completed (18732.515 ms) ====== [2026-02-06T08:27:23.827Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-06T08:27:23.827Z] GC before operation: completed in 894.378 ms, heap usage 193.241 MB -> 81.091 MB. [2026-02-06T08:27:43.201Z] ====== als (apache-spark) [default], iteration 13 completed (18966.057 ms) ====== [2026-02-06T08:27:43.201Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-06T08:27:43.201Z] GC before operation: completed in 865.307 ms, heap usage 493.056 MB -> 81.843 MB. [2026-02-06T08:28:06.586Z] ====== als (apache-spark) [default], iteration 14 completed (19282.200 ms) ====== [2026-02-06T08:28:06.586Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-06T08:28:06.586Z] GC before operation: completed in 868.858 ms, heap usage 271.491 MB -> 81.815 MB. [2026-02-06T08:28:25.942Z] ====== als (apache-spark) [default], iteration 15 completed (18556.065 ms) ====== [2026-02-06T08:28:25.942Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-06T08:28:25.942Z] GC before operation: completed in 886.957 ms, heap usage 356.839 MB -> 82.167 MB. [2026-02-06T08:28:45.273Z] ====== als (apache-spark) [default], iteration 16 completed (18498.255 ms) ====== [2026-02-06T08:28:45.273Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-06T08:28:45.273Z] GC before operation: completed in 916.307 ms, heap usage 635.253 MB -> 82.748 MB. [2026-02-06T08:29:04.728Z] ====== als (apache-spark) [default], iteration 17 completed (18497.683 ms) ====== [2026-02-06T08:29:04.728Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-06T08:29:04.729Z] GC before operation: completed in 910.210 ms, heap usage 505.289 MB -> 82.838 MB. [2026-02-06T08:29:24.092Z] ====== als (apache-spark) [default], iteration 18 completed (18406.178 ms) ====== [2026-02-06T08:29:24.092Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-06T08:29:24.849Z] GC before operation: completed in 900.916 ms, heap usage 284.246 MB -> 82.854 MB. [2026-02-06T08:29:44.202Z] ====== als (apache-spark) [default], iteration 19 completed (18604.379 ms) ====== [2026-02-06T08:29:44.202Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-06T08:29:44.957Z] GC before operation: completed in 918.946 ms, heap usage 393.755 MB -> 83.212 MB. [2026-02-06T08:30:08.255Z] ====== als (apache-spark) [default], iteration 20 completed (19691.794 ms) ====== [2026-02-06T08:30:08.255Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-06T08:30:08.255Z] GC before operation: completed in 935.203 ms, heap usage 447.641 MB -> 83.695 MB. [2026-02-06T08:30:27.605Z] ====== als (apache-spark) [default], iteration 21 completed (18345.818 ms) ====== [2026-02-06T08:30:27.605Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-06T08:30:27.605Z] GC before operation: completed in 926.929 ms, heap usage 614.599 MB -> 84.059 MB. [2026-02-06T08:30:46.946Z] ====== als (apache-spark) [default], iteration 22 completed (18676.595 ms) ====== [2026-02-06T08:30:46.947Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-06T08:30:46.947Z] GC before operation: completed in 935.684 ms, heap usage 141.856 MB -> 83.696 MB. [2026-02-06T08:31:06.335Z] ====== als (apache-spark) [default], iteration 23 completed (18299.140 ms) ====== [2026-02-06T08:31:06.335Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-06T08:31:06.717Z] GC before operation: completed in 944.892 ms, heap usage 1.034 GB -> 85.223 MB. [2026-02-06T08:31:30.236Z] ====== als (apache-spark) [default], iteration 24 completed (19111.450 ms) ====== [2026-02-06T08:31:30.236Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-06T08:31:30.236Z] GC before operation: completed in 934.225 ms, heap usage 150.863 MB -> 84.273 MB. [2026-02-06T08:31:49.663Z] ====== als (apache-spark) [default], iteration 25 completed (18859.710 ms) ====== [2026-02-06T08:31:49.663Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-06T08:31:49.663Z] GC before operation: completed in 949.340 ms, heap usage 471.807 MB -> 84.975 MB. [2026-02-06T08:32:09.012Z] ====== als (apache-spark) [default], iteration 26 completed (18040.040 ms) ====== [2026-02-06T08:32:09.012Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-06T08:32:09.012Z] GC before operation: completed in 941.639 ms, heap usage 503.376 MB -> 85.322 MB. [2026-02-06T08:32:28.329Z] ====== als (apache-spark) [default], iteration 27 completed (18166.715 ms) ====== [2026-02-06T08:32:28.329Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-06T08:32:28.329Z] GC before operation: completed in 956.057 ms, heap usage 502.549 MB -> 85.486 MB. [2026-02-06T08:32:47.688Z] ====== als (apache-spark) [default], iteration 28 completed (18567.174 ms) ====== [2026-02-06T08:32:47.688Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-06T08:32:48.028Z] GC before operation: completed in 1004.958 ms, heap usage 210.839 MB -> 84.850 MB. [2026-02-06T08:33:07.353Z] ====== als (apache-spark) [default], iteration 29 completed (18002.859 ms) ====== [2026-02-06T08:33:08.539Z] ----------------------------------- [2026-02-06T08:33:08.539Z] renaissance-als_0_PASSED [2026-02-06T08:33:08.539Z] ----------------------------------- [2026-02-06T08:33:08.882Z] [2026-02-06T08:33:08.882Z] TEST TEARDOWN: [2026-02-06T08:33:08.882Z] Nothing to be done for teardown. [2026-02-06T08:33:08.882Z] renaissance-als_0 Finish Time: Fri Feb 6 08:33:08 2026 Epoch Time (ms): 1770366788844