[2025-11-13T09:15:30.428Z] Running test renaissance-als_0 ... [2025-11-13T09:15:30.428Z] =============================================== [2025-11-13T09:15:30.428Z] renaissance-als_0 Start Time: Thu Nov 13 09:15:30 2025 Epoch Time (ms): 1763025330282 [2025-11-13T09:15:30.428Z] variation: NoOptions [2025-11-13T09:15:30.428Z] JVM_OPTIONS: [2025-11-13T09:15:30.428Z] { \ [2025-11-13T09:15:30.428Z] echo ""; echo "TEST SETUP:"; \ [2025-11-13T09:15:30.428Z] echo "Nothing to be done for setup."; \ [2025-11-13T09:15:30.428Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17630247206909/renaissance-als_0"; \ [2025-11-13T09:15:30.428Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17630247206909/renaissance-als_0"; \ [2025-11-13T09:15:30.428Z] echo ""; echo "TESTING:"; \ [2025-11-13T09:15:30.428Z] "/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_17630247206909/renaissance-als_0"/als.json" als; \ [2025-11-13T09:15:30.428Z] 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_17630247206909/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-13T09:15:30.428Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-13T09:15:30.428Z] echo "Nothing to be done for teardown."; \ [2025-11-13T09:15:30.428Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17630247206909/TestTargetResult"; [2025-11-13T09:15:30.428Z] [2025-11-13T09:15:30.428Z] TEST SETUP: [2025-11-13T09:15:30.428Z] Nothing to be done for setup. [2025-11-13T09:15:30.428Z] [2025-11-13T09:15:30.428Z] TESTING: [2025-11-13T09:15:53.451Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-13T09:16:12.616Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-11-13T09:16:12.616Z] GC before operation: completed in 189.445 ms, heap usage 69.193 MB -> 36.185 MB. [2025-11-13T09:17:35.620Z] ====== als (apache-spark) [default], iteration 0 completed (73216.059 ms) ====== [2025-11-13T09:17:35.620Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-11-13T09:17:35.620Z] GC before operation: completed in 592.954 ms, heap usage 1.273 GB -> 77.230 MB. [2025-11-13T09:17:58.631Z] ====== als (apache-spark) [default], iteration 1 completed (27187.612 ms) ====== [2025-11-13T09:17:58.632Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-11-13T09:17:58.632Z] GC before operation: completed in 647.882 ms, heap usage 460.138 MB -> 77.340 MB. [2025-11-13T09:18:26.307Z] ====== als (apache-spark) [default], iteration 2 completed (24002.918 ms) ====== [2025-11-13T09:18:26.307Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-11-13T09:18:26.307Z] GC before operation: completed in 708.295 ms, heap usage 766.707 MB -> 78.486 MB. [2025-11-13T09:18:49.378Z] ====== als (apache-spark) [default], iteration 3 completed (22962.695 ms) ====== [2025-11-13T09:18:49.378Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-11-13T09:18:49.378Z] GC before operation: completed in 762.555 ms, heap usage 712.720 MB -> 79.087 MB. [2025-11-13T09:19:12.402Z] ====== als (apache-spark) [default], iteration 4 completed (22072.185 ms) ====== [2025-11-13T09:19:12.402Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-11-13T09:19:12.402Z] GC before operation: completed in 761.691 ms, heap usage 1.107 GB -> 79.903 MB. [2025-11-13T09:19:35.770Z] ====== als (apache-spark) [default], iteration 5 completed (21291.643 ms) ====== [2025-11-13T09:19:35.770Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-11-13T09:19:35.770Z] GC before operation: completed in 798.551 ms, heap usage 657.247 MB -> 80.010 MB. [2025-11-13T09:19:58.787Z] ====== als (apache-spark) [default], iteration 6 completed (21526.214 ms) ====== [2025-11-13T09:19:58.787Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-11-13T09:19:59.114Z] GC before operation: completed in 807.467 ms, heap usage 1.030 GB -> 81.079 MB. [2025-11-13T09:20:22.525Z] ====== als (apache-spark) [default], iteration 7 completed (20822.035 ms) ====== [2025-11-13T09:20:22.525Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-11-13T09:20:22.525Z] GC before operation: completed in 852.517 ms, heap usage 543.076 MB -> 81.032 MB. [2025-11-13T09:20:45.556Z] ====== als (apache-spark) [default], iteration 8 completed (20911.548 ms) ====== [2025-11-13T09:20:45.556Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-11-13T09:20:45.556Z] GC before operation: completed in 842.287 ms, heap usage 560.048 MB -> 81.696 MB. [2025-11-13T09:21:10.873Z] ====== als (apache-spark) [default], iteration 9 completed (21673.187 ms) ====== [2025-11-13T09:21:10.873Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-11-13T09:21:10.873Z] GC before operation: completed in 819.291 ms, heap usage 508.989 MB -> 81.829 MB. [2025-11-13T09:21:32.093Z] ====== als (apache-spark) [default], iteration 10 completed (20828.593 ms) ====== [2025-11-13T09:21:32.093Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-11-13T09:21:32.093Z] GC before operation: completed in 852.576 ms, heap usage 961.079 MB -> 82.513 MB. [2025-11-13T09:21:54.726Z] ====== als (apache-spark) [default], iteration 11 completed (21214.961 ms) ====== [2025-11-13T09:21:54.726Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-11-13T09:21:54.726Z] GC before operation: completed in 899.768 ms, heap usage 771.193 MB -> 82.640 MB. [2025-11-13T09:22:20.148Z] ====== als (apache-spark) [default], iteration 12 completed (20319.076 ms) ====== [2025-11-13T09:22:20.148Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-11-13T09:22:20.148Z] GC before operation: completed in 897.750 ms, heap usage 265.224 MB -> 82.189 MB. [2025-11-13T09:22:37.823Z] ====== als (apache-spark) [default], iteration 13 completed (20854.859 ms) ====== [2025-11-13T09:22:37.823Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-11-13T09:22:38.564Z] GC before operation: completed in 940.777 ms, heap usage 1.103 GB -> 83.471 MB. [2025-11-13T09:23:01.140Z] ====== als (apache-spark) [default], iteration 14 completed (19999.110 ms) ====== [2025-11-13T09:23:01.140Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-11-13T09:23:01.140Z] GC before operation: completed in 919.984 ms, heap usage 441.876 MB -> 82.935 MB. [2025-11-13T09:23:24.145Z] ====== als (apache-spark) [default], iteration 15 completed (20092.491 ms) ====== [2025-11-13T09:23:24.145Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-11-13T09:23:24.145Z] GC before operation: completed in 945.891 ms, heap usage 1.022 GB -> 84.002 MB. [2025-11-13T09:23:47.155Z] ====== als (apache-spark) [default], iteration 16 completed (20179.361 ms) ====== [2025-11-13T09:23:47.155Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-11-13T09:23:47.155Z] GC before operation: completed in 958.229 ms, heap usage 405.455 MB -> 83.539 MB. [2025-11-13T09:24:06.596Z] ====== als (apache-spark) [default], iteration 17 completed (20711.940 ms) ====== [2025-11-13T09:24:06.596Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-11-13T09:24:07.318Z] GC before operation: completed in 953.561 ms, heap usage 234.354 MB -> 83.589 MB. [2025-11-13T09:24:30.340Z] ====== als (apache-spark) [default], iteration 18 completed (20179.638 ms) ====== [2025-11-13T09:24:30.340Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-11-13T09:24:30.340Z] GC before operation: completed in 985.153 ms, heap usage 328.829 MB -> 83.989 MB. [2025-11-13T09:24:51.613Z] ====== als (apache-spark) [default], iteration 19 completed (19853.578 ms) ====== [2025-11-13T09:24:51.613Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-11-13T09:24:51.613Z] GC before operation: completed in 944.948 ms, heap usage 319.249 MB -> 84.124 MB. [2025-11-13T09:25:14.608Z] ====== als (apache-spark) [default], iteration 20 completed (20633.563 ms) ====== [2025-11-13T09:25:14.608Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-11-13T09:25:14.608Z] GC before operation: completed in 948.368 ms, heap usage 796.612 MB -> 85.074 MB. [2025-11-13T09:25:37.671Z] ====== als (apache-spark) [default], iteration 21 completed (20203.516 ms) ====== [2025-11-13T09:25:37.671Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-11-13T09:25:37.671Z] GC before operation: completed in 966.700 ms, heap usage 380.903 MB -> 84.850 MB. [2025-11-13T09:25:56.768Z] ====== als (apache-spark) [default], iteration 22 completed (19632.154 ms) ====== [2025-11-13T09:25:56.768Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-11-13T09:25:57.094Z] GC before operation: completed in 986.512 ms, heap usage 696.084 MB -> 85.483 MB. [2025-11-13T09:26:20.114Z] ====== als (apache-spark) [default], iteration 23 completed (20454.545 ms) ====== [2025-11-13T09:26:20.114Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-11-13T09:26:20.114Z] GC before operation: completed in 985.466 ms, heap usage 624.062 MB -> 85.706 MB. [2025-11-13T09:26:43.125Z] ====== als (apache-spark) [default], iteration 24 completed (19897.218 ms) ====== [2025-11-13T09:26:43.125Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-11-13T09:26:43.125Z] GC before operation: completed in 985.360 ms, heap usage 735.560 MB -> 86.019 MB. [2025-11-13T09:27:02.249Z] ====== als (apache-spark) [default], iteration 25 completed (19776.381 ms) ====== [2025-11-13T09:27:02.249Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-11-13T09:27:02.588Z] GC before operation: completed in 1021.736 ms, heap usage 445.250 MB -> 85.841 MB. [2025-11-13T09:27:25.593Z] ====== als (apache-spark) [default], iteration 26 completed (19150.457 ms) ====== [2025-11-13T09:27:25.593Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-11-13T09:27:25.593Z] GC before operation: completed in 1025.055 ms, heap usage 800.560 MB -> 86.613 MB. [2025-11-13T09:27:44.709Z] ====== als (apache-spark) [default], iteration 27 completed (20092.394 ms) ====== [2025-11-13T09:27:44.709Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-11-13T09:27:45.471Z] GC before operation: completed in 975.543 ms, heap usage 662.793 MB -> 86.775 MB. [2025-11-13T09:28:08.813Z] ====== als (apache-spark) [default], iteration 28 completed (19303.079 ms) ====== [2025-11-13T09:28:08.813Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-11-13T09:28:08.813Z] GC before operation: completed in 990.016 ms, heap usage 951.164 MB -> 86.897 MB. [2025-11-13T09:28:27.939Z] ====== als (apache-spark) [default], iteration 29 completed (19758.020 ms) ====== [2025-11-13T09:28:29.578Z] ----------------------------------- [2025-11-13T09:28:29.578Z] renaissance-als_0_PASSED [2025-11-13T09:28:29.578Z] ----------------------------------- [2025-11-13T09:28:29.942Z] [2025-11-13T09:28:29.942Z] TEST TEARDOWN: [2025-11-13T09:28:29.942Z] Nothing to be done for teardown. [2025-11-13T09:28:29.942Z] renaissance-als_0 Finish Time: Thu Nov 13 09:28:29 2025 Epoch Time (ms): 1763026109755