[2026-01-10T13:07:06.019Z] Running test renaissance-als_0 ... [2026-01-10T13:07:06.019Z] =============================================== [2026-01-10T13:07:06.019Z] renaissance-als_0 Start Time: Sat Jan 10 13:07:05 2026 Epoch Time (ms): 1768050425940 [2026-01-10T13:07:06.019Z] variation: NoOptions [2026-01-10T13:07:06.019Z] JVM_OPTIONS: [2026-01-10T13:07:06.019Z] { \ [2026-01-10T13:07:06.019Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T13:07:06.019Z] echo "Nothing to be done for setup."; \ [2026-01-10T13:07:06.019Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680504258627/renaissance-als_0"; \ [2026-01-10T13:07:06.019Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680504258627/renaissance-als_0"; \ [2026-01-10T13:07:06.019Z] echo ""; echo "TESTING:"; \ [2026-01-10T13:07:06.019Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680504258627/renaissance-als_0"/als.json" als; \ [2026-01-10T13:07:06.019Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680504258627/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T13:07:06.019Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T13:07:06.019Z] echo "Nothing to be done for teardown."; \ [2026-01-10T13:07:06.019Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17680504258627/TestTargetResult"; [2026-01-10T13:07:06.019Z] [2026-01-10T13:07:06.019Z] TEST SETUP: [2026-01-10T13:07:06.019Z] Nothing to be done for setup. [2026-01-10T13:07:06.019Z] [2026-01-10T13:07:06.019Z] TESTING: [2026-01-10T13:07:15.780Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T13:07:21.278Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-10T13:07:21.278Z] GC before operation: completed in 84.665 ms, heap usage 48.426 MB -> 34.973 MB. [2026-01-10T13:07:56.691Z] ====== als (apache-spark) [default], iteration 0 completed (33138.163 ms) ====== [2026-01-10T13:07:56.691Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-10T13:07:56.691Z] GC before operation: completed in 179.926 ms, heap usage 303.436 MB -> 62.025 MB. [2026-01-10T13:08:13.113Z] ====== als (apache-spark) [default], iteration 1 completed (14596.773 ms) ====== [2026-01-10T13:08:13.113Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-10T13:08:13.113Z] GC before operation: completed in 180.006 ms, heap usage 208.553 MB -> 62.872 MB. [2026-01-10T13:08:22.859Z] ====== als (apache-spark) [default], iteration 2 completed (11276.117 ms) ====== [2026-01-10T13:08:22.859Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-10T13:08:23.609Z] GC before operation: completed in 179.465 ms, heap usage 445.358 MB -> 63.867 MB. [2026-01-10T13:08:35.128Z] ====== als (apache-spark) [default], iteration 3 completed (10860.577 ms) ====== [2026-01-10T13:08:35.128Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-10T13:08:35.128Z] GC before operation: completed in 180.471 ms, heap usage 353.512 MB -> 64.149 MB. [2026-01-10T13:08:46.694Z] ====== als (apache-spark) [default], iteration 4 completed (11204.844 ms) ====== [2026-01-10T13:08:46.695Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-10T13:08:46.695Z] GC before operation: completed in 169.129 ms, heap usage 184.920 MB -> 64.479 MB. [2026-01-10T13:09:03.274Z] ====== als (apache-spark) [default], iteration 5 completed (16203.477 ms) ====== [2026-01-10T13:09:03.274Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-10T13:09:03.274Z] GC before operation: completed in 156.757 ms, heap usage 186.270 MB -> 64.942 MB. [2026-01-10T13:09:16.860Z] ====== als (apache-spark) [default], iteration 6 completed (11815.243 ms) ====== [2026-01-10T13:09:16.860Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-10T13:09:16.860Z] GC before operation: completed in 190.944 ms, heap usage 354.965 MB -> 65.817 MB. [2026-01-10T13:09:26.583Z] ====== als (apache-spark) [default], iteration 7 completed (10681.875 ms) ====== [2026-01-10T13:09:26.583Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-10T13:09:27.335Z] GC before operation: completed in 229.674 ms, heap usage 500.086 MB -> 66.448 MB. [2026-01-10T13:09:38.904Z] ====== als (apache-spark) [default], iteration 8 completed (11054.845 ms) ====== [2026-01-10T13:09:38.904Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-10T13:09:38.904Z] GC before operation: completed in 161.803 ms, heap usage 236.292 MB -> 66.690 MB. [2026-01-10T13:09:50.425Z] ====== als (apache-spark) [default], iteration 9 completed (10087.766 ms) ====== [2026-01-10T13:09:50.425Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-10T13:09:50.425Z] GC before operation: completed in 196.528 ms, heap usage 440.082 MB -> 67.362 MB. [2026-01-10T13:10:00.643Z] ====== als (apache-spark) [default], iteration 10 completed (10478.744 ms) ====== [2026-01-10T13:10:00.643Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-10T13:10:00.643Z] GC before operation: completed in 166.654 ms, heap usage 233.690 MB -> 67.184 MB. [2026-01-10T13:10:12.186Z] ====== als (apache-spark) [default], iteration 11 completed (11584.338 ms) ====== [2026-01-10T13:10:12.186Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-10T13:10:12.186Z] GC before operation: completed in 160.220 ms, heap usage 276.734 MB -> 67.660 MB. [2026-01-10T13:10:23.708Z] ====== als (apache-spark) [default], iteration 12 completed (10042.007 ms) ====== [2026-01-10T13:10:23.708Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-10T13:10:23.708Z] GC before operation: completed in 159.768 ms, heap usage 127.110 MB -> 67.764 MB. [2026-01-10T13:10:33.491Z] ====== als (apache-spark) [default], iteration 13 completed (10547.906 ms) ====== [2026-01-10T13:10:33.491Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-10T13:10:34.249Z] GC before operation: completed in 143.356 ms, heap usage 236.255 MB -> 67.994 MB. [2026-01-10T13:10:50.204Z] ====== als (apache-spark) [default], iteration 14 completed (14220.708 ms) ====== [2026-01-10T13:10:50.204Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-10T13:10:50.204Z] GC before operation: completed in 170.308 ms, heap usage 198.486 MB -> 68.264 MB. [2026-01-10T13:10:58.862Z] ====== als (apache-spark) [default], iteration 15 completed (10317.072 ms) ====== [2026-01-10T13:10:58.862Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-10T13:10:59.638Z] GC before operation: completed in 154.036 ms, heap usage 522.229 MB -> 68.877 MB. [2026-01-10T13:11:11.143Z] ====== als (apache-spark) [default], iteration 16 completed (10708.953 ms) ====== [2026-01-10T13:11:11.143Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-10T13:11:11.143Z] GC before operation: completed in 179.063 ms, heap usage 343.642 MB -> 69.113 MB. [2026-01-10T13:11:22.734Z] ====== als (apache-spark) [default], iteration 17 completed (11902.594 ms) ====== [2026-01-10T13:11:22.734Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-10T13:11:22.734Z] GC before operation: completed in 172.517 ms, heap usage 231.551 MB -> 69.134 MB. [2026-01-10T13:11:34.252Z] ====== als (apache-spark) [default], iteration 18 completed (10306.139 ms) ====== [2026-01-10T13:11:34.252Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-10T13:11:34.252Z] GC before operation: completed in 170.783 ms, heap usage 222.424 MB -> 69.265 MB. [2026-01-10T13:11:45.785Z] ====== als (apache-spark) [default], iteration 19 completed (11067.962 ms) ====== [2026-01-10T13:11:45.785Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-10T13:11:45.785Z] GC before operation: completed in 180.474 ms, heap usage 398.101 MB -> 69.778 MB. [2026-01-10T13:11:57.867Z] ====== als (apache-spark) [default], iteration 20 completed (10756.496 ms) ====== [2026-01-10T13:11:57.867Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-10T13:11:57.867Z] GC before operation: completed in 185.654 ms, heap usage 142.781 MB -> 69.788 MB. [2026-01-10T13:12:09.572Z] ====== als (apache-spark) [default], iteration 21 completed (9952.903 ms) ====== [2026-01-10T13:12:09.572Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-10T13:12:09.572Z] GC before operation: completed in 175.707 ms, heap usage 154.341 MB -> 70.187 MB. [2026-01-10T13:12:25.971Z] ====== als (apache-spark) [default], iteration 22 completed (15971.440 ms) ====== [2026-01-10T13:12:25.971Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-10T13:12:25.971Z] GC before operation: completed in 178.151 ms, heap usage 266.449 MB -> 70.627 MB. [2026-01-10T13:12:36.492Z] ====== als (apache-spark) [default], iteration 23 completed (12134.910 ms) ====== [2026-01-10T13:12:36.492Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-10T13:12:36.492Z] GC before operation: completed in 173.176 ms, heap usage 330.822 MB -> 70.860 MB. [2026-01-10T13:12:47.868Z] ====== als (apache-spark) [default], iteration 24 completed (10758.232 ms) ====== [2026-01-10T13:12:47.868Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-10T13:12:47.868Z] GC before operation: completed in 193.125 ms, heap usage 549.281 MB -> 71.363 MB. [2026-01-10T13:12:57.933Z] ====== als (apache-spark) [default], iteration 25 completed (10404.350 ms) ====== [2026-01-10T13:12:57.933Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-10T13:12:57.933Z] GC before operation: completed in 182.083 ms, heap usage 103.463 MB -> 71.020 MB. [2026-01-10T13:13:09.447Z] ====== als (apache-spark) [default], iteration 26 completed (10302.017 ms) ====== [2026-01-10T13:13:09.447Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-10T13:13:09.447Z] GC before operation: completed in 182.849 ms, heap usage 169.045 MB -> 71.527 MB. [2026-01-10T13:13:20.797Z] ====== als (apache-spark) [default], iteration 27 completed (10946.859 ms) ====== [2026-01-10T13:13:20.797Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-10T13:13:20.797Z] GC before operation: completed in 187.679 ms, heap usage 212.060 MB -> 71.735 MB. [2026-01-10T13:13:32.545Z] ====== als (apache-spark) [default], iteration 28 completed (10538.981 ms) ====== [2026-01-10T13:13:32.545Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-10T13:13:32.545Z] GC before operation: completed in 177.859 ms, heap usage 492.394 MB -> 71.850 MB. [2026-01-10T13:13:42.839Z] ====== als (apache-spark) [default], iteration 29 completed (10880.972 ms) ====== [2026-01-10T13:13:43.569Z] ----------------------------------- [2026-01-10T13:13:43.569Z] renaissance-als_0_PASSED [2026-01-10T13:13:43.569Z] ----------------------------------- [2026-01-10T13:13:43.569Z] [2026-01-10T13:13:43.569Z] TEST TEARDOWN: [2026-01-10T13:13:43.569Z] Nothing to be done for teardown. [2026-01-10T13:13:43.569Z] renaissance-als_0 Finish Time: Sat Jan 10 13:13:43 2026 Epoch Time (ms): 1768050823146