[2026-01-21T09:34:06.295Z] Running test renaissance-als_0 ... [2026-01-21T09:34:06.295Z] =============================================== [2026-01-21T09:34:06.295Z] renaissance-als_0 Start Time: Wed Jan 21 09:34:06 2026 Epoch Time (ms): 1768988046243 [2026-01-21T09:34:06.295Z] variation: NoOptions [2026-01-21T09:34:06.295Z] JVM_OPTIONS: [2026-01-21T09:34:06.295Z] { \ [2026-01-21T09:34:06.295Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T09:34:06.295Z] echo "Nothing to be done for setup."; \ [2026-01-21T09:34:06.295Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17689880455839/renaissance-als_0"; \ [2026-01-21T09:34:06.295Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17689880455839/renaissance-als_0"; \ [2026-01-21T09:34:06.295Z] echo ""; echo "TESTING:"; \ [2026-01-21T09:34:06.295Z] "/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_17689880455839/renaissance-als_0"/als.json" als; \ [2026-01-21T09:34:06.295Z] 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_17689880455839/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T09:34:06.295Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T09:34:06.295Z] echo "Nothing to be done for teardown."; \ [2026-01-21T09:34:06.295Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17689880455839/TestTargetResult"; [2026-01-21T09:34:06.295Z] [2026-01-21T09:34:06.295Z] TEST SETUP: [2026-01-21T09:34:06.295Z] Nothing to be done for setup. [2026-01-21T09:34:06.295Z] [2026-01-21T09:34:06.295Z] TESTING: [2026-01-21T09:34:29.897Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-21T09:34:49.272Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-21T09:34:49.272Z] GC before operation: completed in 225.416 ms, heap usage 65.979 MB -> 35.452 MB. [2026-01-21T09:36:12.775Z] ====== als (apache-spark) [default], iteration 0 completed (70423.411 ms) ====== [2026-01-21T09:36:12.775Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-21T09:36:12.775Z] GC before operation: completed in 755.162 ms, heap usage 751.300 MB -> 76.364 MB. [2026-01-21T09:36:36.199Z] ====== als (apache-spark) [default], iteration 1 completed (27509.255 ms) ====== [2026-01-21T09:36:36.199Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-21T09:36:36.199Z] GC before operation: completed in 718.670 ms, heap usage 542.443 MB -> 76.955 MB. [2026-01-21T09:36:59.525Z] ====== als (apache-spark) [default], iteration 2 completed (24963.905 ms) ====== [2026-01-21T09:36:59.526Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-21T09:37:00.279Z] GC before operation: completed in 766.135 ms, heap usage 1.032 GB -> 78.235 MB. [2026-01-21T09:37:28.888Z] ====== als (apache-spark) [default], iteration 3 completed (24051.948 ms) ====== [2026-01-21T09:37:28.888Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-21T09:37:28.888Z] GC before operation: completed in 740.892 ms, heap usage 421.314 MB -> 78.013 MB. [2026-01-21T09:37:52.207Z] ====== als (apache-spark) [default], iteration 4 completed (23272.261 ms) ====== [2026-01-21T09:37:52.207Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-21T09:37:52.207Z] GC before operation: completed in 735.516 ms, heap usage 302.482 MB -> 78.374 MB. [2026-01-21T09:38:15.543Z] ====== als (apache-spark) [default], iteration 5 completed (22696.225 ms) ====== [2026-01-21T09:38:15.543Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-21T09:38:15.892Z] GC before operation: completed in 654.575 ms, heap usage 145.179 MB -> 78.834 MB. [2026-01-21T09:38:44.003Z] ====== als (apache-spark) [default], iteration 6 completed (23059.365 ms) ====== [2026-01-21T09:38:44.003Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-21T09:38:44.003Z] GC before operation: completed in 681.997 ms, heap usage 469.093 MB -> 79.850 MB. [2026-01-21T09:39:07.649Z] ====== als (apache-spark) [default], iteration 7 completed (22267.558 ms) ====== [2026-01-21T09:39:07.649Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-21T09:39:07.649Z] GC before operation: completed in 680.911 ms, heap usage 167.655 MB -> 80.014 MB. [2026-01-21T09:39:31.040Z] ====== als (apache-spark) [default], iteration 8 completed (22037.682 ms) ====== [2026-01-21T09:39:31.040Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-21T09:39:31.040Z] GC before operation: completed in 729.349 ms, heap usage 517.160 MB -> 80.936 MB. [2026-01-21T09:39:54.356Z] ====== als (apache-spark) [default], iteration 9 completed (22472.330 ms) ====== [2026-01-21T09:39:54.356Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-21T09:39:54.356Z] GC before operation: completed in 786.147 ms, heap usage 1.405 GB -> 82.670 MB. [2026-01-21T09:40:17.957Z] ====== als (apache-spark) [default], iteration 10 completed (22154.103 ms) ====== [2026-01-21T09:40:17.957Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-21T09:40:17.957Z] GC before operation: completed in 758.693 ms, heap usage 373.275 MB -> 81.203 MB. [2026-01-21T09:40:41.276Z] ====== als (apache-spark) [default], iteration 11 completed (21788.596 ms) ====== [2026-01-21T09:40:41.276Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-21T09:40:41.276Z] GC before operation: completed in 794.886 ms, heap usage 1.063 GB -> 82.467 MB. [2026-01-21T09:41:04.658Z] ====== als (apache-spark) [default], iteration 12 completed (20994.158 ms) ====== [2026-01-21T09:41:04.658Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-21T09:41:04.658Z] GC before operation: completed in 787.124 ms, heap usage 802.766 MB -> 82.322 MB. [2026-01-21T09:41:27.984Z] ====== als (apache-spark) [default], iteration 13 completed (21174.604 ms) ====== [2026-01-21T09:41:27.984Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-21T09:41:27.984Z] GC before operation: completed in 836.773 ms, heap usage 1.385 GB -> 83.307 MB. [2026-01-21T09:41:51.279Z] ====== als (apache-spark) [default], iteration 14 completed (21249.319 ms) ====== [2026-01-21T09:41:51.279Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-21T09:41:51.279Z] GC before operation: completed in 815.964 ms, heap usage 868.015 MB -> 82.966 MB. [2026-01-21T09:42:10.649Z] ====== als (apache-spark) [default], iteration 15 completed (21059.887 ms) ====== [2026-01-21T09:42:10.649Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-21T09:42:11.406Z] GC before operation: completed in 841.832 ms, heap usage 562.668 MB -> 82.904 MB. [2026-01-21T09:42:34.785Z] ====== als (apache-spark) [default], iteration 16 completed (21349.059 ms) ====== [2026-01-21T09:42:34.785Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-21T09:42:34.785Z] GC before operation: completed in 802.992 ms, heap usage 266.733 MB -> 82.785 MB. [2026-01-21T09:42:58.467Z] ====== als (apache-spark) [default], iteration 17 completed (21591.773 ms) ====== [2026-01-21T09:42:58.467Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-21T09:42:58.467Z] GC before operation: completed in 775.833 ms, heap usage 145.343 MB -> 82.861 MB. [2026-01-21T09:43:21.887Z] ====== als (apache-spark) [default], iteration 18 completed (21421.736 ms) ====== [2026-01-21T09:43:21.887Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-21T09:43:21.887Z] GC before operation: completed in 765.113 ms, heap usage 362.899 MB -> 83.254 MB. [2026-01-21T09:43:45.232Z] ====== als (apache-spark) [default], iteration 19 completed (21444.766 ms) ====== [2026-01-21T09:43:45.232Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-21T09:43:45.232Z] GC before operation: completed in 760.567 ms, heap usage 526.878 MB -> 83.705 MB. [2026-01-21T09:44:08.577Z] ====== als (apache-spark) [default], iteration 20 completed (21516.685 ms) ====== [2026-01-21T09:44:08.577Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-21T09:44:08.577Z] GC before operation: completed in 769.761 ms, heap usage 282.772 MB -> 83.648 MB. [2026-01-21T09:44:31.973Z] ====== als (apache-spark) [default], iteration 21 completed (20637.132 ms) ====== [2026-01-21T09:44:31.974Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-21T09:44:31.974Z] GC before operation: completed in 776.284 ms, heap usage 202.672 MB -> 83.689 MB. [2026-01-21T09:44:55.332Z] ====== als (apache-spark) [default], iteration 22 completed (21072.593 ms) ====== [2026-01-21T09:44:55.332Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-21T09:44:55.332Z] GC before operation: completed in 799.714 ms, heap usage 228.170 MB -> 84.054 MB. [2026-01-21T09:45:14.739Z] ====== als (apache-spark) [default], iteration 23 completed (21004.388 ms) ====== [2026-01-21T09:45:14.739Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-21T09:45:15.086Z] GC before operation: completed in 790.472 ms, heap usage 242.504 MB -> 84.482 MB. [2026-01-21T09:45:38.430Z] ====== als (apache-spark) [default], iteration 24 completed (20977.195 ms) ====== [2026-01-21T09:45:38.430Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-21T09:45:38.430Z] GC before operation: completed in 794.973 ms, heap usage 178.099 MB -> 84.558 MB. [2026-01-21T09:46:01.747Z] ====== als (apache-spark) [default], iteration 25 completed (20561.947 ms) ====== [2026-01-21T09:46:01.747Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-21T09:46:01.747Z] GC before operation: completed in 812.284 ms, heap usage 336.438 MB -> 85.136 MB. [2026-01-21T09:46:25.070Z] ====== als (apache-spark) [default], iteration 26 completed (20400.190 ms) ====== [2026-01-21T09:46:25.070Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-21T09:46:25.070Z] GC before operation: completed in 805.383 ms, heap usage 555.517 MB -> 85.535 MB. [2026-01-21T09:46:44.450Z] ====== als (apache-spark) [default], iteration 27 completed (20107.449 ms) ====== [2026-01-21T09:46:44.450Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-21T09:46:44.450Z] GC before operation: completed in 819.375 ms, heap usage 238.829 MB -> 84.772 MB. [2026-01-21T09:47:07.793Z] ====== als (apache-spark) [default], iteration 28 completed (20548.988 ms) ====== [2026-01-21T09:47:07.793Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-21T09:47:07.793Z] GC before operation: completed in 845.849 ms, heap usage 632.378 MB -> 85.734 MB. [2026-01-21T09:47:31.419Z] ====== als (apache-spark) [default], iteration 29 completed (20666.364 ms) ====== [2026-01-21T09:47:31.419Z] ----------------------------------- [2026-01-21T09:47:31.419Z] renaissance-als_0_PASSED [2026-01-21T09:47:31.419Z] ----------------------------------- [2026-01-21T09:47:31.419Z] [2026-01-21T09:47:31.419Z] TEST TEARDOWN: [2026-01-21T09:47:31.419Z] Nothing to be done for teardown. [2026-01-21T09:47:31.419Z] renaissance-als_0 Finish Time: Wed Jan 21 09:47:30 2026 Epoch Time (ms): 1768988850594