[2026-03-04T22:05:10.537Z] Running test renaissance-als_0 ... [2026-03-04T22:05:10.537Z] =============================================== [2026-03-04T22:05:10.537Z] renaissance-als_0 Start Time: Wed Mar 4 22:05:10 2026 Epoch Time (ms): 1772661910116 [2026-03-04T22:05:10.537Z] variation: NoOptions [2026-03-04T22:05:10.537Z] JVM_OPTIONS: [2026-03-04T22:05:10.537Z] { \ [2026-03-04T22:05:10.537Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T22:05:10.537Z] echo "Nothing to be done for setup."; \ [2026-03-04T22:05:10.537Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726617305382/renaissance-als_0"; \ [2026-03-04T22:05:10.537Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726617305382/renaissance-als_0"; \ [2026-03-04T22:05:10.537Z] echo ""; echo "TESTING:"; \ [2026-03-04T22:05:10.537Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/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_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726617305382/renaissance-als_0"/als.json" als; \ [2026-03-04T22:05:10.537Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726617305382/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T22:05:10.537Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T22:05:10.537Z] echo "Nothing to be done for teardown."; \ [2026-03-04T22:05:10.537Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726617305382/TestTargetResult"; [2026-03-04T22:05:10.537Z] [2026-03-04T22:05:10.537Z] TEST SETUP: [2026-03-04T22:05:10.537Z] Nothing to be done for setup. [2026-03-04T22:05:10.537Z] [2026-03-04T22:05:10.537Z] TESTING: [2026-03-04T22:05:18.524Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-03-04T22:05:22.500Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-03-04T22:05:22.500Z] GC before operation: completed in 42.127 ms, heap usage 277.867 MB -> 34.847 MB. [2026-03-04T22:05:51.266Z] ====== als (apache-spark) [default], iteration 0 completed (25422.403 ms) ====== [2026-03-04T22:05:51.266Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-03-04T22:05:51.266Z] GC before operation: completed in 133.617 ms, heap usage 173.484 MB -> 61.575 MB. [2026-03-04T22:06:02.965Z] ====== als (apache-spark) [default], iteration 1 completed (13425.885 ms) ====== [2026-03-04T22:06:02.965Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-03-04T22:06:02.965Z] GC before operation: completed in 104.384 ms, heap usage 321.805 MB -> 62.650 MB. [2026-03-04T22:06:14.281Z] ====== als (apache-spark) [default], iteration 2 completed (10796.756 ms) ====== [2026-03-04T22:06:14.281Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-03-04T22:06:14.281Z] GC before operation: completed in 87.735 ms, heap usage 445.389 MB -> 63.371 MB. [2026-03-04T22:06:25.805Z] ====== als (apache-spark) [default], iteration 3 completed (11103.989 ms) ====== [2026-03-04T22:06:25.806Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-03-04T22:06:25.806Z] GC before operation: completed in 95.776 ms, heap usage 434.513 MB -> 63.932 MB. [2026-03-04T22:06:37.078Z] ====== als (apache-spark) [default], iteration 4 completed (10867.923 ms) ====== [2026-03-04T22:06:37.078Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-03-04T22:06:37.078Z] GC before operation: completed in 104.148 ms, heap usage 220.532 MB -> 64.157 MB. [2026-03-04T22:06:48.675Z] ====== als (apache-spark) [default], iteration 5 completed (10361.513 ms) ====== [2026-03-04T22:06:48.675Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-03-04T22:06:48.675Z] GC before operation: completed in 93.250 ms, heap usage 361.942 MB -> 64.900 MB. [2026-03-04T22:06:57.537Z] ====== als (apache-spark) [default], iteration 6 completed (10382.838 ms) ====== [2026-03-04T22:06:57.537Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-03-04T22:06:58.093Z] GC before operation: completed in 122.611 ms, heap usage 445.892 MB -> 65.615 MB. [2026-03-04T22:07:07.960Z] ====== als (apache-spark) [default], iteration 7 completed (10161.762 ms) ====== [2026-03-04T22:07:07.960Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-03-04T22:07:08.480Z] GC before operation: completed in 100.057 ms, heap usage 210.148 MB -> 65.709 MB. [2026-03-04T22:07:20.043Z] ====== als (apache-spark) [default], iteration 8 completed (10244.958 ms) ====== [2026-03-04T22:07:20.043Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-03-04T22:07:20.043Z] GC before operation: completed in 100.441 ms, heap usage 176.870 MB -> 66.256 MB. [2026-03-04T22:07:29.398Z] ====== als (apache-spark) [default], iteration 9 completed (10058.729 ms) ====== [2026-03-04T22:07:29.398Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-03-04T22:07:29.398Z] GC before operation: completed in 99.288 ms, heap usage 106.370 MB -> 66.430 MB. [2026-03-04T22:07:39.822Z] ====== als (apache-spark) [default], iteration 10 completed (10370.316 ms) ====== [2026-03-04T22:07:39.822Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-03-04T22:07:39.822Z] GC before operation: completed in 106.995 ms, heap usage 106.417 MB -> 66.745 MB. [2026-03-04T22:07:50.985Z] ====== als (apache-spark) [default], iteration 11 completed (9669.488 ms) ====== [2026-03-04T22:07:50.985Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-03-04T22:07:50.985Z] GC before operation: completed in 176.374 ms, heap usage 285.127 MB -> 67.074 MB. [2026-03-04T22:08:00.104Z] ====== als (apache-spark) [default], iteration 12 completed (9875.748 ms) ====== [2026-03-04T22:08:00.104Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-03-04T22:08:00.104Z] GC before operation: completed in 105.990 ms, heap usage 238.830 MB -> 67.295 MB. [2026-03-04T22:08:11.272Z] ====== als (apache-spark) [default], iteration 13 completed (10087.905 ms) ====== [2026-03-04T22:08:11.272Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-03-04T22:08:11.272Z] GC before operation: completed in 103.744 ms, heap usage 118.370 MB -> 67.414 MB. [2026-03-04T22:08:22.576Z] ====== als (apache-spark) [default], iteration 14 completed (10195.203 ms) ====== [2026-03-04T22:08:22.576Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-03-04T22:08:22.576Z] GC before operation: completed in 106.911 ms, heap usage 174.876 MB -> 67.720 MB. [2026-03-04T22:08:31.745Z] ====== als (apache-spark) [default], iteration 15 completed (10283.238 ms) ====== [2026-03-04T22:08:31.745Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-03-04T22:08:31.746Z] GC before operation: completed in 107.812 ms, heap usage 99.210 MB -> 68.033 MB. [2026-03-04T22:08:42.908Z] ====== als (apache-spark) [default], iteration 16 completed (9940.753 ms) ====== [2026-03-04T22:08:42.908Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-03-04T22:08:42.908Z] GC before operation: completed in 108.846 ms, heap usage 325.000 MB -> 68.455 MB. [2026-03-04T22:08:52.030Z] ====== als (apache-spark) [default], iteration 17 completed (10014.448 ms) ====== [2026-03-04T22:08:52.030Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-03-04T22:08:52.371Z] GC before operation: completed in 115.389 ms, heap usage 505.834 MB -> 68.893 MB. [2026-03-04T22:09:03.595Z] ====== als (apache-spark) [default], iteration 18 completed (10058.964 ms) ====== [2026-03-04T22:09:03.595Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-03-04T22:09:03.595Z] GC before operation: completed in 106.394 ms, heap usage 155.967 MB -> 68.800 MB. [2026-03-04T22:09:12.955Z] ====== als (apache-spark) [default], iteration 19 completed (10023.990 ms) ====== [2026-03-04T22:09:12.955Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-03-04T22:09:13.304Z] GC before operation: completed in 114.228 ms, heap usage 180.870 MB -> 68.974 MB. [2026-03-04T22:09:24.718Z] ====== als (apache-spark) [default], iteration 20 completed (10179.270 ms) ====== [2026-03-04T22:09:24.718Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-03-04T22:09:24.718Z] GC before operation: completed in 108.518 ms, heap usage 266.703 MB -> 69.531 MB. [2026-03-04T22:09:34.550Z] ====== als (apache-spark) [default], iteration 21 completed (10189.691 ms) ====== [2026-03-04T22:09:34.550Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-03-04T22:09:34.550Z] GC before operation: completed in 95.940 ms, heap usage 248.114 MB -> 69.734 MB. [2026-03-04T22:09:45.514Z] ====== als (apache-spark) [default], iteration 22 completed (9846.572 ms) ====== [2026-03-04T22:09:45.514Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-03-04T22:09:45.514Z] GC before operation: completed in 105.055 ms, heap usage 101.042 MB -> 69.699 MB. [2026-03-04T22:09:54.730Z] ====== als (apache-spark) [default], iteration 23 completed (9946.331 ms) ====== [2026-03-04T22:09:54.730Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-03-04T22:09:54.730Z] GC before operation: completed in 105.715 ms, heap usage 316.434 MB -> 70.333 MB. [2026-03-04T22:10:05.864Z] ====== als (apache-spark) [default], iteration 24 completed (10163.526 ms) ====== [2026-03-04T22:10:05.864Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-03-04T22:10:05.864Z] GC before operation: completed in 101.851 ms, heap usage 225.694 MB -> 70.450 MB. [2026-03-04T22:10:16.783Z] ====== als (apache-spark) [default], iteration 25 completed (9969.531 ms) ====== [2026-03-04T22:10:16.783Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-03-04T22:10:16.783Z] GC before operation: completed in 95.684 ms, heap usage 508.949 MB -> 71.028 MB. [2026-03-04T22:10:25.716Z] ====== als (apache-spark) [default], iteration 26 completed (9923.167 ms) ====== [2026-03-04T22:10:25.716Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-03-04T22:10:25.716Z] GC before operation: completed in 101.069 ms, heap usage 216.197 MB -> 70.936 MB. [2026-03-04T22:10:36.946Z] ====== als (apache-spark) [default], iteration 27 completed (10350.420 ms) ====== [2026-03-04T22:10:36.946Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-03-04T22:10:36.946Z] GC before operation: completed in 108.195 ms, heap usage 513.295 MB -> 71.502 MB. [2026-03-04T22:10:47.877Z] ====== als (apache-spark) [default], iteration 28 completed (10454.144 ms) ====== [2026-03-04T22:10:47.877Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-03-04T22:10:47.877Z] GC before operation: completed in 101.309 ms, heap usage 489.257 MB -> 71.846 MB. [2026-03-04T22:10:56.873Z] ====== als (apache-spark) [default], iteration 29 completed (9532.079 ms) ====== [2026-03-04T22:10:57.216Z] ----------------------------------- [2026-03-04T22:10:57.216Z] renaissance-als_0_PASSED [2026-03-04T22:10:57.216Z] ----------------------------------- [2026-03-04T22:10:57.216Z] [2026-03-04T22:10:57.216Z] TEST TEARDOWN: [2026-03-04T22:10:57.216Z] Nothing to be done for teardown. [2026-03-04T22:10:57.216Z] renaissance-als_0 Finish Time: Wed Mar 4 22:10:56 2026 Epoch Time (ms): 1772662256915