[2026-02-12T02:41:26.638Z] Running test renaissance-als_0 ... [2026-02-12T02:41:26.638Z] =============================================== [2026-02-12T02:41:26.962Z] renaissance-als_0 Start Time: Thu Feb 12 02:41:26 2026 Epoch Time (ms): 1770864086655 [2026-02-12T02:41:26.962Z] variation: NoOptions [2026-02-12T02:41:26.962Z] JVM_OPTIONS: [2026-02-12T02:41:26.962Z] { \ [2026-02-12T02:41:26.962Z] echo ""; echo "TEST SETUP:"; \ [2026-02-12T02:41:26.962Z] echo "Nothing to be done for setup."; \ [2026-02-12T02:41:26.962Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17708635293022/renaissance-als_0"; \ [2026-02-12T02:41:26.962Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17708635293022/renaissance-als_0"; \ [2026-02-12T02:41:26.962Z] echo ""; echo "TESTING:"; \ [2026-02-12T02:41:26.962Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17708635293022/renaissance-als_0"/als.json" als; \ [2026-02-12T02:41:26.962Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17708635293022/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-12T02:41:26.962Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-12T02:41:26.962Z] echo "Nothing to be done for teardown."; \ [2026-02-12T02:41:26.962Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17708635293022/TestTargetResult"; [2026-02-12T02:41:26.962Z] [2026-02-12T02:41:26.962Z] TEST SETUP: [2026-02-12T02:41:26.962Z] Nothing to be done for setup. [2026-02-12T02:41:26.962Z] [2026-02-12T02:41:26.962Z] TESTING: [2026-02-12T02:41:49.951Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-12T02:42:09.069Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-12T02:42:09.414Z] GC before operation: completed in 209.837 ms, heap usage 58.724 MB -> 35.397 MB. [2026-02-12T02:43:32.378Z] ====== als (apache-spark) [default], iteration 0 completed (78705.826 ms) ====== [2026-02-12T02:43:32.378Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-12T02:43:32.378Z] GC before operation: completed in 709.844 ms, heap usage 774.584 MB -> 76.233 MB. [2026-02-12T02:44:05.667Z] ====== als (apache-spark) [default], iteration 1 completed (28951.708 ms) ====== [2026-02-12T02:44:05.667Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-12T02:44:05.667Z] GC before operation: completed in 758.647 ms, heap usage 515.702 MB -> 76.731 MB. [2026-02-12T02:44:33.349Z] ====== als (apache-spark) [default], iteration 2 completed (24776.731 ms) ====== [2026-02-12T02:44:33.349Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-12T02:44:33.349Z] GC before operation: completed in 677.252 ms, heap usage 238.011 MB -> 76.943 MB. [2026-02-12T02:44:56.440Z] ====== als (apache-spark) [default], iteration 3 completed (23604.744 ms) ====== [2026-02-12T02:44:56.440Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-12T02:44:56.440Z] GC before operation: completed in 716.662 ms, heap usage 458.485 MB -> 77.854 MB. [2026-02-12T02:45:24.123Z] ====== als (apache-spark) [default], iteration 4 completed (23323.884 ms) ====== [2026-02-12T02:45:24.123Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-12T02:45:24.123Z] GC before operation: completed in 735.776 ms, heap usage 480.204 MB -> 78.400 MB. [2026-02-12T02:45:47.114Z] ====== als (apache-spark) [default], iteration 5 completed (22241.264 ms) ====== [2026-02-12T02:45:47.114Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-12T02:45:47.114Z] GC before operation: completed in 763.872 ms, heap usage 135.733 MB -> 78.754 MB. [2026-02-12T02:46:10.326Z] ====== als (apache-spark) [default], iteration 6 completed (22685.834 ms) ====== [2026-02-12T02:46:10.326Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-12T02:46:10.326Z] GC before operation: completed in 805.630 ms, heap usage 252.620 MB -> 79.082 MB. [2026-02-12T02:46:33.329Z] ====== als (apache-spark) [default], iteration 7 completed (22365.639 ms) ====== [2026-02-12T02:46:33.329Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-12T02:46:33.658Z] GC before operation: completed in 790.984 ms, heap usage 325.482 MB -> 79.881 MB. [2026-02-12T02:46:56.706Z] ====== als (apache-spark) [default], iteration 8 completed (21869.773 ms) ====== [2026-02-12T02:46:56.706Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-12T02:46:57.436Z] GC before operation: completed in 843.672 ms, heap usage 163.239 MB -> 80.219 MB. [2026-02-12T02:47:20.738Z] ====== als (apache-spark) [default], iteration 9 completed (21749.659 ms) ====== [2026-02-12T02:47:20.738Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-12T02:47:21.064Z] GC before operation: completed in 850.633 ms, heap usage 255.945 MB -> 80.573 MB. [2026-02-12T02:47:48.752Z] ====== als (apache-spark) [default], iteration 10 completed (22188.434 ms) ====== [2026-02-12T02:47:48.752Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-12T02:47:48.752Z] GC before operation: completed in 823.680 ms, heap usage 283.793 MB -> 80.751 MB. [2026-02-12T02:48:07.859Z] ====== als (apache-spark) [default], iteration 11 completed (21534.742 ms) ====== [2026-02-12T02:48:07.859Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-12T02:48:08.582Z] GC before operation: completed in 768.608 ms, heap usage 262.408 MB -> 80.958 MB. [2026-02-12T02:48:31.640Z] ====== als (apache-spark) [default], iteration 12 completed (22258.403 ms) ====== [2026-02-12T02:48:31.640Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-12T02:48:32.367Z] GC before operation: completed in 742.689 ms, heap usage 588.056 MB -> 81.710 MB. [2026-02-12T02:48:55.412Z] ====== als (apache-spark) [default], iteration 13 completed (22196.925 ms) ====== [2026-02-12T02:48:55.412Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-12T02:48:56.132Z] GC before operation: completed in 751.850 ms, heap usage 352.056 MB -> 81.634 MB. [2026-02-12T02:49:19.372Z] ====== als (apache-spark) [default], iteration 14 completed (21984.540 ms) ====== [2026-02-12T02:49:19.372Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-12T02:49:20.118Z] GC before operation: completed in 765.655 ms, heap usage 451.278 MB -> 82.800 MB. [2026-02-12T02:49:43.122Z] ====== als (apache-spark) [default], iteration 15 completed (21489.965 ms) ====== [2026-02-12T02:49:43.122Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-12T02:49:43.122Z] GC before operation: completed in 761.442 ms, heap usage 275.726 MB -> 82.105 MB. [2026-02-12T02:50:06.129Z] ====== als (apache-spark) [default], iteration 16 completed (21772.784 ms) ====== [2026-02-12T02:50:06.129Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-12T02:50:06.464Z] GC before operation: completed in 785.310 ms, heap usage 345.528 MB -> 82.603 MB. [2026-02-12T02:50:29.596Z] ====== als (apache-spark) [default], iteration 17 completed (20478.143 ms) ====== [2026-02-12T02:50:29.596Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-12T02:50:29.596Z] GC before operation: completed in 797.768 ms, heap usage 506.235 MB -> 82.998 MB. [2026-02-12T02:50:52.614Z] ====== als (apache-spark) [default], iteration 18 completed (21249.162 ms) ====== [2026-02-12T02:50:52.614Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-12T02:50:52.614Z] GC before operation: completed in 847.845 ms, heap usage 700.823 MB -> 83.527 MB. [2026-02-12T02:51:15.624Z] ====== als (apache-spark) [default], iteration 19 completed (21145.213 ms) ====== [2026-02-12T02:51:15.624Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-12T02:51:15.624Z] GC before operation: completed in 831.514 ms, heap usage 161.792 MB -> 83.110 MB. [2026-02-12T02:51:38.778Z] ====== als (apache-spark) [default], iteration 20 completed (21950.427 ms) ====== [2026-02-12T02:51:38.778Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-12T02:51:38.778Z] GC before operation: completed in 883.541 ms, heap usage 1.295 GB -> 84.723 MB. [2026-02-12T02:52:01.782Z] ====== als (apache-spark) [default], iteration 21 completed (20927.997 ms) ====== [2026-02-12T02:52:01.782Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-12T02:52:01.782Z] GC before operation: completed in 843.324 ms, heap usage 301.826 MB -> 83.795 MB. [2026-02-12T02:52:24.772Z] ====== als (apache-spark) [default], iteration 22 completed (20802.219 ms) ====== [2026-02-12T02:52:24.772Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-12T02:52:24.772Z] GC before operation: completed in 805.801 ms, heap usage 269.473 MB -> 84.021 MB. [2026-02-12T02:52:47.768Z] ====== als (apache-spark) [default], iteration 23 completed (20507.465 ms) ====== [2026-02-12T02:52:47.768Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-12T02:52:47.768Z] GC before operation: completed in 841.813 ms, heap usage 1.214 GB -> 85.483 MB. [2026-02-12T02:53:10.778Z] ====== als (apache-spark) [default], iteration 24 completed (21778.313 ms) ====== [2026-02-12T02:53:10.778Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-12T02:53:10.778Z] GC before operation: completed in 763.548 ms, heap usage 475.753 MB -> 84.784 MB. [2026-02-12T02:53:33.911Z] ====== als (apache-spark) [default], iteration 25 completed (20882.773 ms) ====== [2026-02-12T02:53:33.911Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-12T02:53:33.911Z] GC before operation: completed in 764.542 ms, heap usage 162.919 MB -> 84.604 MB. [2026-02-12T02:53:53.014Z] ====== als (apache-spark) [default], iteration 26 completed (19701.120 ms) ====== [2026-02-12T02:53:53.014Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-12T02:53:53.014Z] GC before operation: completed in 774.536 ms, heap usage 497.750 MB -> 85.313 MB. [2026-02-12T02:54:16.048Z] ====== als (apache-spark) [default], iteration 27 completed (20298.349 ms) ====== [2026-02-12T02:54:16.048Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-12T02:54:16.048Z] GC before operation: completed in 766.486 ms, heap usage 145.842 MB -> 84.658 MB. [2026-02-12T02:54:39.194Z] ====== als (apache-spark) [default], iteration 28 completed (20271.976 ms) ====== [2026-02-12T02:54:39.194Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-12T02:54:39.194Z] GC before operation: completed in 782.390 ms, heap usage 307.660 MB -> 85.026 MB. [2026-02-12T02:54:58.257Z] ====== als (apache-spark) [default], iteration 29 completed (19883.084 ms) ====== [2026-02-12T02:55:00.492Z] ----------------------------------- [2026-02-12T02:55:00.492Z] renaissance-als_0_PASSED [2026-02-12T02:55:00.492Z] ----------------------------------- [2026-02-12T02:55:00.492Z] [2026-02-12T02:55:00.492Z] TEST TEARDOWN: [2026-02-12T02:55:00.492Z] Nothing to be done for teardown. [2026-02-12T02:55:00.492Z] renaissance-als_0 Finish Time: Thu Feb 12 02:55:00 2026 Epoch Time (ms): 1770864900210