[2026-02-09T10:52:03.022Z] Running test renaissance-als_0 ... [2026-02-09T10:52:03.022Z] =============================================== [2026-02-09T10:52:03.022Z] renaissance-als_0 Start Time: Mon Feb 9 10:52:02 2026 Epoch Time (ms): 1770634322813 [2026-02-09T10:52:03.022Z] variation: NoOptions [2026-02-09T10:52:03.022Z] JVM_OPTIONS: [2026-02-09T10:52:03.022Z] { \ [2026-02-09T10:52:03.022Z] echo ""; echo "TEST SETUP:"; \ [2026-02-09T10:52:03.022Z] echo "Nothing to be done for setup."; \ [2026-02-09T10:52:03.022Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17706343213487/renaissance-als_0"; \ [2026-02-09T10:52:03.022Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17706343213487/renaissance-als_0"; \ [2026-02-09T10:52:03.022Z] echo ""; echo "TESTING:"; \ [2026-02-09T10:52:03.022Z] "/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_17706343213487/renaissance-als_0"/als.json" als; \ [2026-02-09T10:52:03.023Z] 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_17706343213487/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-09T10:52:03.023Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-09T10:52:03.023Z] echo "Nothing to be done for teardown."; \ [2026-02-09T10:52:03.023Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17706343213487/TestTargetResult"; [2026-02-09T10:52:03.023Z] [2026-02-09T10:52:03.023Z] TEST SETUP: [2026-02-09T10:52:03.023Z] Nothing to be done for setup. [2026-02-09T10:52:03.023Z] [2026-02-09T10:52:03.023Z] TESTING: [2026-02-09T10:52:05.898Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-09T10:52:05.898Z] 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_17706343213487/renaissance-als_0/launcher-105203-13246402157477159293/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-09T10:52:05.898Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-09T10:52:05.898Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-09T10:52:28.735Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-09T10:52:44.407Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-09T10:52:44.407Z] GC before operation: completed in 222.392 ms, heap usage 144.000 MB -> 35.563 MB. [2026-02-09T10:53:53.485Z] ====== als (apache-spark) [default], iteration 0 completed (65736.173 ms) ====== [2026-02-09T10:53:53.485Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-09T10:53:53.485Z] GC before operation: completed in 610.586 ms, heap usage 457.297 MB -> 75.899 MB. [2026-02-09T10:54:21.025Z] ====== als (apache-spark) [default], iteration 1 completed (24450.804 ms) ====== [2026-02-09T10:54:21.025Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-09T10:54:21.025Z] GC before operation: completed in 646.309 ms, heap usage 307.764 MB -> 76.375 MB. [2026-02-09T10:54:44.163Z] ====== als (apache-spark) [default], iteration 2 completed (21539.007 ms) ====== [2026-02-09T10:54:44.163Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-09T10:54:44.163Z] GC before operation: completed in 680.652 ms, heap usage 361.690 MB -> 77.052 MB. [2026-02-09T10:55:07.006Z] ====== als (apache-spark) [default], iteration 3 completed (21028.660 ms) ====== [2026-02-09T10:55:07.006Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-09T10:55:07.006Z] GC before operation: completed in 703.128 ms, heap usage 159.317 MB -> 77.394 MB. [2026-02-09T10:55:28.293Z] ====== als (apache-spark) [default], iteration 4 completed (20353.315 ms) ====== [2026-02-09T10:55:28.293Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-09T10:55:28.293Z] GC before operation: completed in 721.810 ms, heap usage 362.627 MB -> 78.238 MB. [2026-02-09T10:55:51.148Z] ====== als (apache-spark) [default], iteration 5 completed (19925.973 ms) ====== [2026-02-09T10:55:51.148Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-09T10:55:51.148Z] GC before operation: completed in 750.048 ms, heap usage 344.549 MB -> 78.706 MB. [2026-02-09T10:56:13.999Z] ====== als (apache-spark) [default], iteration 6 completed (20422.354 ms) ====== [2026-02-09T10:56:13.999Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-09T10:56:13.999Z] GC before operation: completed in 763.707 ms, heap usage 250.421 MB -> 79.187 MB. [2026-02-09T10:56:32.939Z] ====== als (apache-spark) [default], iteration 7 completed (19514.012 ms) ====== [2026-02-09T10:56:32.939Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-09T10:56:32.939Z] GC before operation: completed in 854.410 ms, heap usage 246.190 MB -> 79.682 MB. [2026-02-09T10:56:55.793Z] ====== als (apache-spark) [default], iteration 8 completed (19857.811 ms) ====== [2026-02-09T10:56:55.793Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-09T10:56:55.793Z] GC before operation: completed in 805.530 ms, heap usage 292.598 MB -> 80.320 MB. [2026-02-09T10:57:14.754Z] ====== als (apache-spark) [default], iteration 9 completed (19291.220 ms) ====== [2026-02-09T10:57:14.754Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-09T10:57:15.454Z] GC before operation: completed in 795.895 ms, heap usage 499.760 MB -> 80.880 MB. [2026-02-09T10:57:38.308Z] ====== als (apache-spark) [default], iteration 10 completed (20028.086 ms) ====== [2026-02-09T10:57:38.308Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-09T10:57:38.308Z] GC before operation: completed in 839.361 ms, heap usage 547.799 MB -> 81.274 MB. [2026-02-09T10:58:01.294Z] ====== als (apache-spark) [default], iteration 11 completed (19929.632 ms) ====== [2026-02-09T10:58:01.294Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-09T10:58:01.294Z] GC before operation: completed in 825.544 ms, heap usage 492.055 MB -> 81.543 MB. [2026-02-09T10:58:20.238Z] ====== als (apache-spark) [default], iteration 12 completed (19271.858 ms) ====== [2026-02-09T10:58:20.238Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-09T10:58:20.238Z] GC before operation: completed in 826.594 ms, heap usage 312.059 MB -> 81.455 MB. [2026-02-09T10:58:39.190Z] ====== als (apache-spark) [default], iteration 13 completed (18795.966 ms) ====== [2026-02-09T10:58:39.190Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-09T10:58:40.344Z] GC before operation: completed in 864.425 ms, heap usage 627.413 MB -> 82.075 MB. [2026-02-09T10:58:59.333Z] ====== als (apache-spark) [default], iteration 14 completed (18350.576 ms) ====== [2026-02-09T10:58:59.333Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-09T10:59:01.756Z] GC before operation: completed in 855.410 ms, heap usage 491.086 MB -> 82.184 MB. [2026-02-09T10:59:20.757Z] ====== als (apache-spark) [default], iteration 15 completed (18516.491 ms) ====== [2026-02-09T10:59:20.757Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-09T10:59:20.757Z] GC before operation: completed in 886.369 ms, heap usage 128.568 MB -> 82.014 MB. [2026-02-09T10:59:39.747Z] ====== als (apache-spark) [default], iteration 16 completed (18616.892 ms) ====== [2026-02-09T10:59:39.747Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-09T10:59:40.902Z] GC before operation: completed in 918.632 ms, heap usage 236.774 MB -> 82.266 MB. [2026-02-09T11:00:01.399Z] ====== als (apache-spark) [default], iteration 17 completed (19189.838 ms) ====== [2026-02-09T11:00:01.399Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-09T11:00:01.723Z] GC before operation: completed in 911.333 ms, heap usage 218.584 MB -> 82.555 MB. [2026-02-09T11:00:20.782Z] ====== als (apache-spark) [default], iteration 18 completed (18319.446 ms) ====== [2026-02-09T11:00:20.782Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-09T11:00:21.925Z] GC before operation: completed in 934.929 ms, heap usage 283.573 MB -> 82.941 MB. [2026-02-09T11:00:44.921Z] ====== als (apache-spark) [default], iteration 19 completed (19284.083 ms) ====== [2026-02-09T11:00:44.921Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-09T11:00:44.921Z] GC before operation: completed in 904.933 ms, heap usage 464.250 MB -> 83.585 MB. [2026-02-09T11:01:03.900Z] ====== als (apache-spark) [default], iteration 20 completed (19244.146 ms) ====== [2026-02-09T11:01:03.900Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-09T11:01:03.900Z] GC before operation: completed in 905.083 ms, heap usage 288.923 MB -> 83.409 MB. [2026-02-09T11:01:26.836Z] ====== als (apache-spark) [default], iteration 21 completed (20744.129 ms) ====== [2026-02-09T11:01:26.836Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-09T11:01:26.836Z] GC before operation: completed in 955.707 ms, heap usage 504.919 MB -> 84.843 MB. [2026-02-09T11:01:45.784Z] ====== als (apache-spark) [default], iteration 22 completed (18453.892 ms) ====== [2026-02-09T11:01:45.784Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-09T11:01:46.485Z] GC before operation: completed in 949.679 ms, heap usage 486.944 MB -> 85.223 MB. [2026-02-09T11:02:05.535Z] ====== als (apache-spark) [default], iteration 23 completed (18234.173 ms) ====== [2026-02-09T11:02:05.535Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-09T11:02:06.677Z] GC before operation: completed in 946.179 ms, heap usage 226.759 MB -> 85.051 MB. [2026-02-09T11:02:29.545Z] ====== als (apache-spark) [default], iteration 24 completed (18641.321 ms) ====== [2026-02-09T11:02:29.545Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-09T11:02:29.545Z] GC before operation: completed in 944.753 ms, heap usage 347.756 MB -> 85.464 MB. [2026-02-09T11:02:48.508Z] ====== als (apache-spark) [default], iteration 25 completed (18831.156 ms) ====== [2026-02-09T11:02:48.508Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-09T11:02:48.508Z] GC before operation: completed in 966.135 ms, heap usage 277.677 MB -> 85.629 MB. [2026-02-09T11:03:07.499Z] ====== als (apache-spark) [default], iteration 26 completed (17929.897 ms) ====== [2026-02-09T11:03:07.499Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-09T11:03:07.499Z] GC before operation: completed in 962.384 ms, heap usage 145.553 MB -> 85.778 MB. [2026-02-09T11:03:26.440Z] ====== als (apache-spark) [default], iteration 27 completed (18322.031 ms) ====== [2026-02-09T11:03:26.440Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-09T11:03:27.146Z] GC before operation: completed in 964.048 ms, heap usage 632.327 MB -> 86.667 MB. [2026-02-09T11:03:46.359Z] ====== als (apache-spark) [default], iteration 28 completed (18508.303 ms) ====== [2026-02-09T11:03:46.359Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-09T11:03:47.486Z] GC before operation: completed in 1004.557 ms, heap usage 576.847 MB -> 86.424 MB. [2026-02-09T11:04:06.432Z] ====== als (apache-spark) [default], iteration 29 completed (18320.464 ms) ====== [2026-02-09T11:04:08.624Z] ----------------------------------- [2026-02-09T11:04:08.624Z] renaissance-als_0_PASSED [2026-02-09T11:04:08.624Z] ----------------------------------- [2026-02-09T11:04:08.624Z] [2026-02-09T11:04:08.624Z] TEST TEARDOWN: [2026-02-09T11:04:08.624Z] Nothing to be done for teardown. [2026-02-09T11:04:08.624Z] renaissance-als_0 Finish Time: Mon Feb 9 11:04:08 2026 Epoch Time (ms): 1770635048561