renaissance-als_0
[2026-03-06T22:17:43.859Z] Running test renaissance-als_0 ...
[2026-03-06T22:17:43.859Z] ===============================================
[2026-03-06T22:17:43.859Z] renaissance-als_0 Start Time: Fri Mar 6 22:17:43 2026 Epoch Time (ms): 1772835463605
[2026-03-06T22:17:43.859Z] variation: NoOptions
[2026-03-06T22:17:43.859Z] JVM_OPTIONS:
[2026-03-06T22:17:43.859Z] { \
[2026-03-06T22:17:43.859Z] echo ""; echo "TEST SETUP:"; \
[2026-03-06T22:17:43.859Z] echo "Nothing to be done for setup."; \
[2026-03-06T22:17:43.859Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_1772835462430/renaissance-als_0"; \
[2026-03-06T22:17:43.859Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_1772835462430/renaissance-als_0"; \
[2026-03-06T22:17:43.859Z] echo ""; echo "TESTING:"; \
[2026-03-06T22:17:43.859Z] "/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_1772835462430/renaissance-als_0"/als.json" als; \
[2026-03-06T22:17:43.859Z] 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_1772835462430/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-03-06T22:17:43.859Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-03-06T22:17:43.859Z] echo "Nothing to be done for teardown."; \
[2026-03-06T22:17:43.859Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_riscv64_linux_testList_2/aqa-tests/TKG/../TKG/output_1772835462430/TestTargetResult";
[2026-03-06T22:17:43.859Z]
[2026-03-06T22:17:43.859Z] TEST SETUP:
[2026-03-06T22:17:43.859Z] Nothing to be done for setup.
[2026-03-06T22:17:43.859Z]
[2026-03-06T22:17:43.859Z] TESTING:
[2026-03-06T22:17:46.182Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called
[2026-03-06T22:17:46.182Z] 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_1772835462430/renaissance-als_0/launcher-221744-1999175013382045819/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar)
[2026-03-06T22:17:46.182Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$
[2026-03-06T22:17:46.182Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release
[2026-03-06T22:18:09.329Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-03-06T22:18:25.507Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-03-06T22:18:25.843Z] GC before operation: completed in 229.902 ms, heap usage 304.460 MB -> 35.502 MB.
[2026-03-06T22:19:35.289Z] ====== als (apache-spark) [default], iteration 0 completed (64784.063 ms) ======
[2026-03-06T22:19:35.289Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-03-06T22:19:35.289Z] GC before operation: completed in 716.703 ms, heap usage 194.845 MB -> 75.374 MB.
[2026-03-06T22:20:03.088Z] ====== als (apache-spark) [default], iteration 1 completed (25227.026 ms) ======
[2026-03-06T22:20:03.088Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-03-06T22:20:03.088Z] GC before operation: completed in 695.225 ms, heap usage 805.756 MB -> 77.056 MB.
[2026-03-06T22:20:27.811Z] ====== als (apache-spark) [default], iteration 2 completed (23310.061 ms) ======
[2026-03-06T22:20:27.811Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-03-06T22:20:27.811Z] GC before operation: completed in 684.892 ms, heap usage 443.208 MB -> 77.298 MB.
[2026-03-06T22:20:50.903Z] ====== als (apache-spark) [default], iteration 3 completed (21583.384 ms) ======
[2026-03-06T22:20:50.903Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-03-06T22:20:50.903Z] GC before operation: completed in 708.291 ms, heap usage 484.309 MB -> 77.830 MB.
[2026-03-06T22:21:14.017Z] ====== als (apache-spark) [default], iteration 4 completed (20872.430 ms) ======
[2026-03-06T22:21:14.017Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-03-06T22:21:14.017Z] GC before operation: completed in 719.642 ms, heap usage 170.476 MB -> 77.953 MB.
[2026-03-06T22:21:37.318Z] ====== als (apache-spark) [default], iteration 5 completed (20724.625 ms) ======
[2026-03-06T22:21:37.318Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-03-06T22:21:37.318Z] GC before operation: completed in 736.448 ms, heap usage 322.514 MB -> 78.856 MB.
[2026-03-06T22:22:00.490Z] ====== als (apache-spark) [default], iteration 6 completed (20760.735 ms) ======
[2026-03-06T22:22:00.490Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-03-06T22:22:00.490Z] GC before operation: completed in 761.451 ms, heap usage 512.757 MB -> 79.546 MB.
[2026-03-06T22:22:19.974Z] ====== als (apache-spark) [default], iteration 7 completed (20214.241 ms) ======
[2026-03-06T22:22:19.974Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-03-06T22:22:19.974Z] GC before operation: completed in 822.188 ms, heap usage 351.007 MB -> 79.804 MB.
[2026-03-06T22:22:43.083Z] ====== als (apache-spark) [default], iteration 8 completed (20299.621 ms) ======
[2026-03-06T22:22:43.083Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-03-06T22:22:43.083Z] GC before operation: completed in 807.823 ms, heap usage 509.087 MB -> 80.595 MB.
[2026-03-06T22:23:06.410Z] ====== als (apache-spark) [default], iteration 9 completed (20376.299 ms) ======
[2026-03-06T22:23:06.410Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-03-06T22:23:06.410Z] GC before operation: completed in 810.170 ms, heap usage 567.275 MB -> 80.777 MB.
[2026-03-06T22:23:25.605Z] ====== als (apache-spark) [default], iteration 10 completed (20120.892 ms) ======
[2026-03-06T22:23:25.605Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-03-06T22:23:25.938Z] GC before operation: completed in 818.520 ms, heap usage 296.075 MB -> 80.641 MB.
[2026-03-06T22:23:49.064Z] ====== als (apache-spark) [default], iteration 11 completed (19810.397 ms) ======
[2026-03-06T22:23:49.064Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-03-06T22:23:49.064Z] GC before operation: completed in 823.205 ms, heap usage 467.919 MB -> 81.302 MB.
[2026-03-06T22:24:08.262Z] ====== als (apache-spark) [default], iteration 12 completed (20108.475 ms) ======
[2026-03-06T22:24:08.262Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-03-06T22:24:08.999Z] GC before operation: completed in 849.705 ms, heap usage 241.925 MB -> 81.228 MB.
[2026-03-06T22:24:32.132Z] ====== als (apache-spark) [default], iteration 13 completed (19502.458 ms) ======
[2026-03-06T22:24:32.133Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-03-06T22:24:32.133Z] GC before operation: completed in 849.496 ms, heap usage 187.749 MB -> 81.558 MB.
[2026-03-06T22:24:51.320Z] ====== als (apache-spark) [default], iteration 14 completed (19150.418 ms) ======
[2026-03-06T22:24:51.320Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-03-06T22:24:51.320Z] GC before operation: completed in 864.611 ms, heap usage 279.510 MB -> 81.843 MB.
[2026-03-06T22:25:14.466Z] ====== als (apache-spark) [default], iteration 15 completed (19190.960 ms) ======
[2026-03-06T22:25:14.466Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-03-06T22:25:14.466Z] GC before operation: completed in 874.283 ms, heap usage 503.309 MB -> 82.425 MB.
[2026-03-06T22:25:33.671Z] ====== als (apache-spark) [default], iteration 16 completed (19052.886 ms) ======
[2026-03-06T22:25:33.671Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-03-06T22:25:33.671Z] GC before operation: completed in 892.828 ms, heap usage 409.954 MB -> 82.449 MB.
[2026-03-06T22:25:56.762Z] ====== als (apache-spark) [default], iteration 17 completed (19458.877 ms) ======
[2026-03-06T22:25:56.762Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-03-06T22:25:56.762Z] GC before operation: completed in 900.336 ms, heap usage 261.914 MB -> 82.598 MB.
[2026-03-06T22:26:15.940Z] ====== als (apache-spark) [default], iteration 18 completed (19770.486 ms) ======
[2026-03-06T22:26:15.941Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-03-06T22:26:15.941Z] GC before operation: completed in 908.915 ms, heap usage 174.336 MB -> 82.737 MB.
[2026-03-06T22:26:39.041Z] ====== als (apache-spark) [default], iteration 19 completed (19185.335 ms) ======
[2026-03-06T22:26:39.041Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-03-06T22:26:39.041Z] GC before operation: completed in 928.092 ms, heap usage 246.228 MB -> 83.108 MB.
[2026-03-06T22:26:58.241Z] ====== als (apache-spark) [default], iteration 20 completed (20086.456 ms) ======
[2026-03-06T22:26:58.241Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-03-06T22:26:58.580Z] GC before operation: completed in 922.918 ms, heap usage 274.098 MB -> 83.350 MB.
[2026-03-06T22:27:22.182Z] ====== als (apache-spark) [default], iteration 21 completed (19852.033 ms) ======
[2026-03-06T22:27:22.182Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-03-06T22:27:22.182Z] GC before operation: completed in 924.199 ms, heap usage 485.740 MB -> 83.936 MB.
[2026-03-06T22:27:41.366Z] ====== als (apache-spark) [default], iteration 22 completed (19757.527 ms) ======
[2026-03-06T22:27:41.367Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-03-06T22:27:41.703Z] GC before operation: completed in 940.671 ms, heap usage 546.712 MB -> 84.381 MB.
[2026-03-06T22:28:04.822Z] ====== als (apache-spark) [default], iteration 23 completed (19202.537 ms) ======
[2026-03-06T22:28:04.822Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-03-06T22:28:04.822Z] GC before operation: completed in 935.278 ms, heap usage 429.557 MB -> 84.245 MB.
[2026-03-06T22:28:24.022Z] ====== als (apache-spark) [default], iteration 24 completed (19441.022 ms) ======
[2026-03-06T22:28:24.022Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-03-06T22:28:24.022Z] GC before operation: completed in 944.794 ms, heap usage 452.716 MB -> 84.811 MB.
[2026-03-06T22:28:47.106Z] ====== als (apache-spark) [default], iteration 25 completed (19548.049 ms) ======
[2026-03-06T22:28:47.106Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-03-06T22:28:47.106Z] GC before operation: completed in 956.486 ms, heap usage 390.077 MB -> 84.780 MB.
[2026-03-06T22:29:06.281Z] ====== als (apache-spark) [default], iteration 26 completed (19043.480 ms) ======
[2026-03-06T22:29:06.281Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-03-06T22:29:06.281Z] GC before operation: completed in 945.508 ms, heap usage 504.943 MB -> 85.287 MB.
[2026-03-06T22:29:25.481Z] ====== als (apache-spark) [default], iteration 27 completed (18841.830 ms) ======
[2026-03-06T22:29:25.481Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-03-06T22:29:26.196Z] GC before operation: completed in 953.350 ms, heap usage 276.763 MB -> 85.232 MB.
[2026-03-06T22:29:49.292Z] ====== als (apache-spark) [default], iteration 28 completed (19284.096 ms) ======
[2026-03-06T22:29:49.292Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-03-06T22:29:49.292Z] GC before operation: completed in 951.074 ms, heap usage 568.429 MB -> 85.924 MB.
[2026-03-06T22:30:08.526Z] ====== als (apache-spark) [default], iteration 29 completed (18914.553 ms) ======
[2026-03-06T22:30:08.856Z] -----------------------------------
[2026-03-06T22:30:08.856Z] renaissance-als_0_PASSED
[2026-03-06T22:30:08.856Z] -----------------------------------
[2026-03-06T22:30:09.186Z]
[2026-03-06T22:30:09.186Z] TEST TEARDOWN:
[2026-03-06T22:30:09.186Z] Nothing to be done for teardown.
[2026-03-06T22:30:09.517Z] renaissance-als_0 Finish Time: Fri Mar 6 22:30:09 2026 Epoch Time (ms): 1772836209197