[2026-02-27T06:34:37.528Z] Running test renaissance-als_0 ... [2026-02-27T06:34:37.528Z] =============================================== [2026-02-27T06:34:37.528Z] renaissance-als_0 Start Time: Fri Feb 27 06:34:37 2026 Epoch Time (ms): 1772174077319 [2026-02-27T06:34:37.528Z] variation: NoOptions [2026-02-27T06:34:37.528Z] JVM_OPTIONS: [2026-02-27T06:34:37.528Z] { \ [2026-02-27T06:34:37.528Z] echo ""; echo "TEST SETUP:"; \ [2026-02-27T06:34:37.528Z] echo "Nothing to be done for setup."; \ [2026-02-27T06:34:37.528Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17721740768496/renaissance-als_0"; \ [2026-02-27T06:34:37.528Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17721740768496/renaissance-als_0"; \ [2026-02-27T06:34:37.528Z] echo ""; echo "TESTING:"; \ [2026-02-27T06:34:37.529Z] "/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_17721740768496/renaissance-als_0"/als.json" als; \ [2026-02-27T06:34:37.529Z] 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_17721740768496/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-27T06:34:37.529Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-27T06:34:37.529Z] echo "Nothing to be done for teardown."; \ [2026-02-27T06:34:37.529Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_17721740768496/TestTargetResult"; [2026-02-27T06:34:37.529Z] [2026-02-27T06:34:37.529Z] TEST SETUP: [2026-02-27T06:34:37.529Z] Nothing to be done for setup. [2026-02-27T06:34:37.529Z] [2026-02-27T06:34:37.529Z] TESTING: [2026-02-27T06:34:39.829Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-27T06:34:39.829Z] 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_17721740768496/renaissance-als_0/launcher-063438-9406635242300329267/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-27T06:34:39.829Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-27T06:34:39.829Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-27T06:35:02.917Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-27T06:35:22.071Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-27T06:35:22.071Z] GC before operation: completed in 234.623 ms, heap usage 56.821 MB -> 35.448 MB. [2026-02-27T06:36:31.429Z] ====== als (apache-spark) [default], iteration 0 completed (66628.759 ms) ====== [2026-02-27T06:36:31.429Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-27T06:36:31.429Z] GC before operation: completed in 618.169 ms, heap usage 233.284 MB -> 75.295 MB. [2026-02-27T06:36:59.287Z] ====== als (apache-spark) [default], iteration 1 completed (23980.011 ms) ====== [2026-02-27T06:36:59.287Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-27T06:36:59.287Z] GC before operation: completed in 643.071 ms, heap usage 494.695 MB -> 76.638 MB. [2026-02-27T06:37:22.447Z] ====== als (apache-spark) [default], iteration 2 completed (22363.183 ms) ====== [2026-02-27T06:37:22.447Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-27T06:37:22.447Z] GC before operation: completed in 698.318 ms, heap usage 496.776 MB -> 77.323 MB. [2026-02-27T06:37:45.539Z] ====== als (apache-spark) [default], iteration 3 completed (21320.891 ms) ====== [2026-02-27T06:37:45.539Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-27T06:37:45.539Z] GC before operation: completed in 723.740 ms, heap usage 501.365 MB -> 77.828 MB. [2026-02-27T06:38:04.759Z] ====== als (apache-spark) [default], iteration 4 completed (20306.655 ms) ====== [2026-02-27T06:38:04.759Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-27T06:38:04.759Z] GC before operation: completed in 750.778 ms, heap usage 349.103 MB -> 78.204 MB. [2026-02-27T06:38:28.144Z] ====== als (apache-spark) [default], iteration 5 completed (20483.364 ms) ====== [2026-02-27T06:38:28.144Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-27T06:38:28.144Z] GC before operation: completed in 768.444 ms, heap usage 1.383 GB -> 80.026 MB. [2026-02-27T06:38:51.246Z] ====== als (apache-spark) [default], iteration 6 completed (20027.953 ms) ====== [2026-02-27T06:38:51.246Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-27T06:38:51.246Z] GC before operation: completed in 764.796 ms, heap usage 319.990 MB -> 79.158 MB. [2026-02-27T06:39:10.423Z] ====== als (apache-spark) [default], iteration 7 completed (19402.213 ms) ====== [2026-02-27T06:39:10.423Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-27T06:39:10.423Z] GC before operation: completed in 849.114 ms, heap usage 1.416 GB -> 81.137 MB. [2026-02-27T06:39:33.539Z] ====== als (apache-spark) [default], iteration 8 completed (19757.036 ms) ====== [2026-02-27T06:39:33.539Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-27T06:39:33.539Z] GC before operation: completed in 785.943 ms, heap usage 223.782 MB -> 80.209 MB. [2026-02-27T06:39:52.722Z] ====== als (apache-spark) [default], iteration 9 completed (19646.578 ms) ====== [2026-02-27T06:39:52.722Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-27T06:39:52.722Z] GC before operation: completed in 821.506 ms, heap usage 497.224 MB -> 80.809 MB. [2026-02-27T06:40:15.807Z] ====== als (apache-spark) [default], iteration 10 completed (19357.153 ms) ====== [2026-02-27T06:40:15.807Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-27T06:40:15.807Z] GC before operation: completed in 824.318 ms, heap usage 396.200 MB -> 80.861 MB. [2026-02-27T06:40:34.966Z] ====== als (apache-spark) [default], iteration 11 completed (19073.888 ms) ====== [2026-02-27T06:40:34.966Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-27T06:40:34.966Z] GC before operation: completed in 845.708 ms, heap usage 316.746 MB -> 81.035 MB. [2026-02-27T06:40:54.116Z] ====== als (apache-spark) [default], iteration 12 completed (18757.071 ms) ====== [2026-02-27T06:40:54.116Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-27T06:40:55.294Z] GC before operation: completed in 875.222 ms, heap usage 159.632 MB -> 81.224 MB. [2026-02-27T06:41:14.452Z] ====== als (apache-spark) [default], iteration 13 completed (18637.264 ms) ====== [2026-02-27T06:41:14.452Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-27T06:41:15.175Z] GC before operation: completed in 893.491 ms, heap usage 533.552 MB -> 82.101 MB. [2026-02-27T06:41:34.372Z] ====== als (apache-spark) [default], iteration 14 completed (18295.925 ms) ====== [2026-02-27T06:41:34.372Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-27T06:41:35.108Z] GC before operation: completed in 890.383 ms, heap usage 198.253 MB -> 81.689 MB. [2026-02-27T06:41:54.312Z] ====== als (apache-spark) [default], iteration 15 completed (17859.225 ms) ====== [2026-02-27T06:41:54.312Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-27T06:41:54.648Z] GC before operation: completed in 897.698 ms, heap usage 278.747 MB -> 82.202 MB. [2026-02-27T06:42:17.789Z] ====== als (apache-spark) [default], iteration 16 completed (18511.785 ms) ====== [2026-02-27T06:42:17.789Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-27T06:42:17.789Z] GC before operation: completed in 964.638 ms, heap usage 680.669 MB -> 83.055 MB. [2026-02-27T06:42:37.094Z] ====== als (apache-spark) [default], iteration 17 completed (18718.511 ms) ====== [2026-02-27T06:42:37.094Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-27T06:42:37.094Z] GC before operation: completed in 941.361 ms, heap usage 281.201 MB -> 82.720 MB. [2026-02-27T06:42:56.267Z] ====== als (apache-spark) [default], iteration 18 completed (18081.662 ms) ====== [2026-02-27T06:42:56.267Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-27T06:42:56.267Z] GC before operation: completed in 935.696 ms, heap usage 185.068 MB -> 82.838 MB. [2026-02-27T06:43:15.438Z] ====== als (apache-spark) [default], iteration 19 completed (18585.767 ms) ====== [2026-02-27T06:43:15.438Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-27T06:43:15.773Z] GC before operation: completed in 944.414 ms, heap usage 207.459 MB -> 82.960 MB. [2026-02-27T06:43:34.987Z] ====== als (apache-spark) [default], iteration 20 completed (18386.379 ms) ====== [2026-02-27T06:43:34.987Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-27T06:43:35.722Z] GC before operation: completed in 939.308 ms, heap usage 115.790 MB -> 83.265 MB. [2026-02-27T06:43:58.796Z] ====== als (apache-spark) [default], iteration 21 completed (19536.235 ms) ====== [2026-02-27T06:43:58.796Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-27T06:43:58.796Z] GC before operation: completed in 992.357 ms, heap usage 552.793 MB -> 84.092 MB. [2026-02-27T06:44:17.965Z] ====== als (apache-spark) [default], iteration 22 completed (18373.557 ms) ====== [2026-02-27T06:44:17.965Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-27T06:44:17.965Z] GC before operation: completed in 929.509 ms, heap usage 516.144 MB -> 84.314 MB. [2026-02-27T06:44:37.185Z] ====== als (apache-spark) [default], iteration 23 completed (18591.209 ms) ====== [2026-02-27T06:44:37.185Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-27T06:44:37.912Z] GC before operation: completed in 1037.934 ms, heap usage 190.775 MB -> 84.134 MB. [2026-02-27T06:45:00.977Z] ====== als (apache-spark) [default], iteration 24 completed (18775.366 ms) ====== [2026-02-27T06:45:00.977Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-27T06:45:00.977Z] GC before operation: completed in 965.584 ms, heap usage 258.360 MB -> 84.519 MB. [2026-02-27T06:45:20.141Z] ====== als (apache-spark) [default], iteration 25 completed (18601.224 ms) ====== [2026-02-27T06:45:20.141Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-27T06:45:20.141Z] GC before operation: completed in 960.562 ms, heap usage 379.809 MB -> 84.901 MB. [2026-02-27T06:45:39.304Z] ====== als (apache-spark) [default], iteration 26 completed (17694.602 ms) ====== [2026-02-27T06:45:39.305Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-27T06:45:39.305Z] GC before operation: completed in 975.521 ms, heap usage 243.245 MB -> 85.056 MB. [2026-02-27T06:45:58.775Z] ====== als (apache-spark) [default], iteration 27 completed (18692.583 ms) ====== [2026-02-27T06:45:58.775Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-27T06:45:58.775Z] GC before operation: completed in 956.947 ms, heap usage 272.574 MB -> 85.331 MB. [2026-02-27T06:46:19.072Z] ====== als (apache-spark) [default], iteration 28 completed (18247.840 ms) ====== [2026-02-27T06:46:19.072Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-27T06:46:19.072Z] GC before operation: completed in 1064.945 ms, heap usage 430.693 MB -> 85.198 MB. [2026-02-27T06:46:38.249Z] ====== als (apache-spark) [default], iteration 29 completed (18067.661 ms) ====== [2026-02-27T06:46:39.399Z] ----------------------------------- [2026-02-27T06:46:39.399Z] renaissance-als_0_PASSED [2026-02-27T06:46:39.399Z] ----------------------------------- [2026-02-27T06:46:39.399Z] [2026-02-27T06:46:39.399Z] TEST TEARDOWN: [2026-02-27T06:46:39.399Z] Nothing to be done for teardown. [2026-02-27T06:46:39.729Z] renaissance-als_0 Finish Time: Fri Feb 27 06:46:39 2026 Epoch Time (ms): 1772174799396