[2025-11-20T09:09:33.697Z] Running test renaissance-als_0 ... [2025-11-20T09:09:33.697Z] =============================================== [2025-11-20T09:09:33.697Z] renaissance-als_0 Start Time: Thu Nov 20 09:09:33 2025 Epoch Time (ms): 1763629773656 [2025-11-20T09:09:33.697Z] variation: NoOptions [2025-11-20T09:09:33.697Z] JVM_OPTIONS: [2025-11-20T09:09:33.697Z] { \ [2025-11-20T09:09:33.697Z] echo ""; echo "TEST SETUP:"; \ [2025-11-20T09:09:33.697Z] echo "Nothing to be done for setup."; \ [2025-11-20T09:09:33.697Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17636291647237/renaissance-als_0"; \ [2025-11-20T09:09:33.697Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17636291647237/renaissance-als_0"; \ [2025-11-20T09:09:33.697Z] echo ""; echo "TESTING:"; \ [2025-11-20T09:09:33.697Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17636291647237/renaissance-als_0"/als.json" als; \ [2025-11-20T09:09:33.697Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17636291647237/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-20T09:09:33.697Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-20T09:09:33.697Z] echo "Nothing to be done for teardown."; \ [2025-11-20T09:09:33.697Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17636291647237/TestTargetResult"; [2025-11-20T09:09:33.697Z] [2025-11-20T09:09:33.697Z] TEST SETUP: [2025-11-20T09:09:33.697Z] Nothing to be done for setup. [2025-11-20T09:09:34.022Z] [2025-11-20T09:09:34.022Z] TESTING: [2025-11-20T09:09:57.015Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-20T09:10:16.096Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-11-20T09:10:16.096Z] GC before operation: completed in 213.264 ms, heap usage 75.031 MB -> 36.388 MB. [2025-11-20T09:11:39.077Z] ====== als (apache-spark) [default], iteration 0 completed (76505.586 ms) ====== [2025-11-20T09:11:39.077Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-11-20T09:11:39.077Z] GC before operation: completed in 598.783 ms, heap usage 534.664 MB -> 76.787 MB. [2025-11-20T09:12:06.762Z] ====== als (apache-spark) [default], iteration 1 completed (28565.498 ms) ====== [2025-11-20T09:12:06.762Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-11-20T09:12:06.762Z] GC before operation: completed in 689.494 ms, heap usage 993.080 MB -> 78.135 MB. [2025-11-20T09:12:34.799Z] ====== als (apache-spark) [default], iteration 2 completed (25208.268 ms) ====== [2025-11-20T09:12:34.799Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-11-20T09:12:34.799Z] GC before operation: completed in 745.398 ms, heap usage 241.157 MB -> 77.850 MB. [2025-11-20T09:13:02.490Z] ====== als (apache-spark) [default], iteration 3 completed (23921.023 ms) ====== [2025-11-20T09:13:02.490Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-11-20T09:13:02.490Z] GC before operation: completed in 787.447 ms, heap usage 1.063 GB -> 79.509 MB. [2025-11-20T09:13:25.526Z] ====== als (apache-spark) [default], iteration 4 completed (22596.953 ms) ====== [2025-11-20T09:13:25.526Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-11-20T09:13:25.526Z] GC before operation: completed in 761.063 ms, heap usage 497.496 MB -> 79.496 MB. [2025-11-20T09:13:48.542Z] ====== als (apache-spark) [default], iteration 5 completed (22400.158 ms) ====== [2025-11-20T09:13:48.542Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-11-20T09:13:48.542Z] GC before operation: completed in 788.287 ms, heap usage 307.187 MB -> 79.565 MB. [2025-11-20T09:14:11.568Z] ====== als (apache-spark) [default], iteration 6 completed (22353.454 ms) ====== [2025-11-20T09:14:11.568Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-11-20T09:14:12.278Z] GC before operation: completed in 866.332 ms, heap usage 247.454 MB -> 80.277 MB. [2025-11-20T09:14:35.301Z] ====== als (apache-spark) [default], iteration 7 completed (21430.872 ms) ====== [2025-11-20T09:14:35.301Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-11-20T09:14:35.628Z] GC before operation: completed in 871.825 ms, heap usage 132.016 MB -> 80.324 MB. [2025-11-20T09:14:58.664Z] ====== als (apache-spark) [default], iteration 8 completed (21772.755 ms) ====== [2025-11-20T09:14:58.664Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-11-20T09:14:58.996Z] GC before operation: completed in 856.079 ms, heap usage 614.276 MB -> 81.707 MB. [2025-11-20T09:15:21.984Z] ====== als (apache-spark) [default], iteration 9 completed (21826.537 ms) ====== [2025-11-20T09:15:21.984Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-11-20T09:15:22.706Z] GC before operation: completed in 832.948 ms, heap usage 197.397 MB -> 81.717 MB. [2025-11-20T09:15:45.721Z] ====== als (apache-spark) [default], iteration 10 completed (21812.497 ms) ====== [2025-11-20T09:15:45.721Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-11-20T09:15:46.444Z] GC before operation: completed in 868.679 ms, heap usage 314.940 MB -> 81.813 MB. [2025-11-20T09:16:09.497Z] ====== als (apache-spark) [default], iteration 11 completed (21438.748 ms) ====== [2025-11-20T09:16:09.497Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-11-20T09:16:09.827Z] GC before operation: completed in 877.385 ms, heap usage 588.570 MB -> 82.493 MB. [2025-11-20T09:16:32.946Z] ====== als (apache-spark) [default], iteration 12 completed (21839.403 ms) ====== [2025-11-20T09:16:32.946Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-11-20T09:16:33.698Z] GC before operation: completed in 926.326 ms, heap usage 216.474 MB -> 82.190 MB. [2025-11-20T09:16:56.731Z] ====== als (apache-spark) [default], iteration 13 completed (21443.830 ms) ====== [2025-11-20T09:16:56.731Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-11-20T09:16:56.731Z] GC before operation: completed in 921.571 ms, heap usage 1.228 GB -> 83.905 MB. [2025-11-20T09:17:19.758Z] ====== als (apache-spark) [default], iteration 14 completed (21189.074 ms) ====== [2025-11-20T09:17:19.758Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-11-20T09:17:19.758Z] GC before operation: completed in 930.879 ms, heap usage 347.570 MB -> 82.903 MB. [2025-11-20T09:17:42.725Z] ====== als (apache-spark) [default], iteration 15 completed (21073.397 ms) ====== [2025-11-20T09:17:42.725Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-11-20T09:17:42.725Z] GC before operation: completed in 949.976 ms, heap usage 628.628 MB -> 83.544 MB. [2025-11-20T09:18:10.405Z] ====== als (apache-spark) [default], iteration 16 completed (22719.431 ms) ====== [2025-11-20T09:18:10.405Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-11-20T09:18:10.405Z] GC before operation: completed in 994.444 ms, heap usage 509.778 MB -> 83.746 MB. [2025-11-20T09:18:33.411Z] ====== als (apache-spark) [default], iteration 17 completed (21553.771 ms) ====== [2025-11-20T09:18:33.411Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-11-20T09:18:33.411Z] GC before operation: completed in 951.158 ms, heap usage 170.611 MB -> 83.617 MB. [2025-11-20T09:18:56.370Z] ====== als (apache-spark) [default], iteration 18 completed (22129.985 ms) ====== [2025-11-20T09:18:56.370Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-11-20T09:18:56.370Z] GC before operation: completed in 952.126 ms, heap usage 298.877 MB -> 83.974 MB. [2025-11-20T09:19:19.400Z] ====== als (apache-spark) [default], iteration 19 completed (20842.738 ms) ====== [2025-11-20T09:19:19.400Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-11-20T09:19:19.400Z] GC before operation: completed in 955.715 ms, heap usage 1.337 GB -> 85.379 MB. [2025-11-20T09:19:42.410Z] ====== als (apache-spark) [default], iteration 20 completed (22018.406 ms) ====== [2025-11-20T09:19:42.410Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-11-20T09:19:42.410Z] GC before operation: completed in 960.889 ms, heap usage 680.316 MB -> 85.086 MB. [2025-11-20T09:20:03.686Z] ====== als (apache-spark) [default], iteration 21 completed (21254.796 ms) ====== [2025-11-20T09:20:03.686Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-11-20T09:20:04.838Z] GC before operation: completed in 1000.980 ms, heap usage 139.007 MB -> 84.888 MB. [2025-11-20T09:20:27.842Z] ====== als (apache-spark) [default], iteration 22 completed (20786.516 ms) ====== [2025-11-20T09:20:27.842Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-11-20T09:20:27.842Z] GC before operation: completed in 1002.252 ms, heap usage 1.119 GB -> 85.997 MB. [2025-11-20T09:20:51.161Z] ====== als (apache-spark) [default], iteration 23 completed (22072.869 ms) ====== [2025-11-20T09:20:51.161Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-11-20T09:20:51.161Z] GC before operation: completed in 997.197 ms, heap usage 1.321 GB -> 86.488 MB. [2025-11-20T09:21:14.146Z] ====== als (apache-spark) [default], iteration 24 completed (21021.938 ms) ====== [2025-11-20T09:21:14.146Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-11-20T09:21:14.146Z] GC before operation: completed in 967.937 ms, heap usage 189.488 MB -> 85.460 MB. [2025-11-20T09:21:37.120Z] ====== als (apache-spark) [default], iteration 25 completed (20691.537 ms) ====== [2025-11-20T09:21:37.120Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-11-20T09:21:37.120Z] GC before operation: completed in 981.453 ms, heap usage 1018.993 MB -> 86.733 MB. [2025-11-20T09:22:00.106Z] ====== als (apache-spark) [default], iteration 26 completed (20153.654 ms) ====== [2025-11-20T09:22:00.106Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-11-20T09:22:00.106Z] GC before operation: completed in 990.724 ms, heap usage 1.194 GB -> 87.249 MB. [2025-11-20T09:22:23.095Z] ====== als (apache-spark) [default], iteration 27 completed (20504.563 ms) ====== [2025-11-20T09:22:23.095Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-11-20T09:22:23.095Z] GC before operation: completed in 1003.195 ms, heap usage 544.830 MB -> 86.723 MB. [2025-11-20T09:22:42.170Z] ====== als (apache-spark) [default], iteration 28 completed (20447.297 ms) ====== [2025-11-20T09:22:42.170Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-11-20T09:22:43.355Z] GC before operation: completed in 1008.676 ms, heap usage 341.775 MB -> 86.320 MB. [2025-11-20T09:23:06.342Z] ====== als (apache-spark) [default], iteration 29 completed (19999.875 ms) ====== [2025-11-20T09:23:06.668Z] ----------------------------------- [2025-11-20T09:23:06.668Z] renaissance-als_0_PASSED [2025-11-20T09:23:06.668Z] ----------------------------------- [2025-11-20T09:23:06.668Z] [2025-11-20T09:23:06.668Z] TEST TEARDOWN: [2025-11-20T09:23:06.668Z] Nothing to be done for teardown. [2025-11-20T09:23:06.995Z] renaissance-als_0 Finish Time: Thu Nov 20 09:23:06 2025 Epoch Time (ms): 1763630586665