[2026-01-10T04:48:28.188Z] Running test renaissance-als_0 ... [2026-01-10T04:48:28.188Z] =============================================== [2026-01-10T04:48:28.188Z] renaissance-als_0 Start Time: Sat Jan 10 04:48:27 2026 Epoch Time (ms): 1768020507246 [2026-01-10T04:48:28.188Z] variation: NoOptions [2026-01-10T04:48:28.188Z] JVM_OPTIONS: [2026-01-10T04:48:28.188Z] { \ [2026-01-10T04:48:28.188Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T04:48:28.188Z] echo "Nothing to be done for setup."; \ [2026-01-10T04:48:28.188Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17680201907350/renaissance-als_0"; \ [2026-01-10T04:48:28.188Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17680201907350/renaissance-als_0"; \ [2026-01-10T04:48:28.188Z] echo ""; echo "TESTING:"; \ [2026-01-10T04:48:28.188Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_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_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17680201907350/renaissance-als_0"/als.json" als; \ [2026-01-10T04:48:28.188Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17680201907350/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T04:48:28.188Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T04:48:28.188Z] echo "Nothing to be done for teardown."; \ [2026-01-10T04:48:28.188Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17680201907350/TestTargetResult"; [2026-01-10T04:48:28.188Z] [2026-01-10T04:48:28.188Z] TEST SETUP: [2026-01-10T04:48:28.188Z] Nothing to be done for setup. [2026-01-10T04:48:28.188Z] [2026-01-10T04:48:28.188Z] TESTING: [2026-01-10T04:48:29.143Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-10T04:48:29.143Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17680201907350/renaissance-als_0/launcher-044827-12641301872626178493/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-10T04:48:29.143Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-10T04:48:29.143Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-10T04:48:37.319Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T04:48:42.722Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-10T04:48:43.681Z] GC before operation: completed in 72.246 ms, heap usage 54.000 MB -> 35.228 MB. [2026-01-10T04:49:09.139Z] ====== als (apache-spark) [default], iteration 0 completed (25105.021 ms) ====== [2026-01-10T04:49:09.139Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-10T04:49:09.139Z] GC before operation: completed in 128.036 ms, heap usage 237.409 MB -> 61.936 MB. [2026-01-10T04:49:20.810Z] ====== als (apache-spark) [default], iteration 1 completed (10819.017 ms) ====== [2026-01-10T04:49:20.856Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-10T04:49:20.857Z] GC before operation: completed in 114.006 ms, heap usage 538.956 MB -> 63.145 MB. [2026-01-10T04:49:30.658Z] ====== als (apache-spark) [default], iteration 2 completed (9634.358 ms) ====== [2026-01-10T04:49:30.658Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-10T04:49:30.658Z] GC before operation: completed in 118.168 ms, heap usage 344.418 MB -> 63.390 MB. [2026-01-10T04:49:42.258Z] ====== als (apache-spark) [default], iteration 3 completed (9752.997 ms) ====== [2026-01-10T04:49:42.258Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-10T04:49:42.258Z] GC before operation: completed in 121.279 ms, heap usage 235.173 MB -> 63.901 MB. [2026-01-10T04:49:52.069Z] ====== als (apache-spark) [default], iteration 4 completed (9543.948 ms) ====== [2026-01-10T04:49:52.069Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-10T04:49:52.069Z] GC before operation: completed in 115.537 ms, heap usage 239.838 MB -> 64.478 MB. [2026-01-10T04:50:00.357Z] ====== als (apache-spark) [default], iteration 5 completed (9112.399 ms) ====== [2026-01-10T04:50:00.357Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-10T04:50:01.316Z] GC before operation: completed in 116.683 ms, heap usage 280.048 MB -> 65.126 MB. [2026-01-10T04:50:11.147Z] ====== als (apache-spark) [default], iteration 6 completed (8984.766 ms) ====== [2026-01-10T04:50:11.147Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-10T04:50:11.147Z] GC before operation: completed in 118.196 ms, heap usage 213.215 MB -> 65.474 MB. [2026-01-10T04:50:20.961Z] ====== als (apache-spark) [default], iteration 7 completed (9278.172 ms) ====== [2026-01-10T04:50:20.961Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-10T04:50:20.961Z] GC before operation: completed in 121.144 ms, heap usage 256.309 MB -> 66.089 MB. [2026-01-10T04:50:29.867Z] ====== als (apache-spark) [default], iteration 8 completed (9037.464 ms) ====== [2026-01-10T04:50:29.867Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-10T04:50:29.867Z] GC before operation: completed in 118.954 ms, heap usage 429.548 MB -> 67.039 MB. [2026-01-10T04:50:39.667Z] ====== als (apache-spark) [default], iteration 9 completed (8780.473 ms) ====== [2026-01-10T04:50:39.667Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-10T04:50:39.667Z] GC before operation: completed in 126.371 ms, heap usage 204.847 MB -> 66.838 MB. [2026-01-10T04:50:48.410Z] ====== als (apache-spark) [default], iteration 10 completed (8931.503 ms) ====== [2026-01-10T04:50:48.410Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-10T04:50:48.410Z] GC before operation: completed in 148.634 ms, heap usage 281.231 MB -> 67.208 MB. [2026-01-10T04:50:58.303Z] ====== als (apache-spark) [default], iteration 11 completed (8833.430 ms) ====== [2026-01-10T04:50:58.303Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-10T04:50:58.303Z] GC before operation: completed in 132.807 ms, heap usage 211.831 MB -> 67.375 MB. [2026-01-10T04:51:06.494Z] ====== als (apache-spark) [default], iteration 12 completed (9109.362 ms) ====== [2026-01-10T04:51:06.494Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-10T04:51:07.452Z] GC before operation: completed in 134.678 ms, heap usage 495.362 MB -> 68.077 MB. [2026-01-10T04:51:15.652Z] ====== als (apache-spark) [default], iteration 13 completed (8740.730 ms) ====== [2026-01-10T04:51:15.652Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-10T04:51:16.607Z] GC before operation: completed in 138.867 ms, heap usage 321.196 MB -> 68.055 MB. [2026-01-10T04:51:26.409Z] ====== als (apache-spark) [default], iteration 14 completed (8706.394 ms) ====== [2026-01-10T04:51:26.409Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-10T04:51:26.409Z] GC before operation: completed in 130.676 ms, heap usage 247.260 MB -> 68.265 MB. [2026-01-10T04:51:34.615Z] ====== als (apache-spark) [default], iteration 15 completed (8739.797 ms) ====== [2026-01-10T04:51:34.615Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-10T04:51:34.615Z] GC before operation: completed in 132.670 ms, heap usage 130.295 MB -> 68.388 MB. [2026-01-10T04:51:46.997Z] ====== als (apache-spark) [default], iteration 16 completed (8678.539 ms) ====== [2026-01-10T04:51:46.997Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-10T04:51:46.997Z] GC before operation: completed in 135.240 ms, heap usage 207.076 MB -> 68.634 MB. [2026-01-10T04:51:52.549Z] ====== als (apache-spark) [default], iteration 17 completed (8915.938 ms) ====== [2026-01-10T04:51:52.549Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-10T04:51:53.510Z] GC before operation: completed in 138.450 ms, heap usage 461.839 MB -> 69.343 MB. [2026-01-10T04:52:01.722Z] ====== als (apache-spark) [default], iteration 18 completed (8693.218 ms) ====== [2026-01-10T04:52:01.722Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-10T04:52:01.722Z] GC before operation: completed in 136.023 ms, heap usage 357.382 MB -> 69.254 MB. [2026-01-10T04:52:11.550Z] ====== als (apache-spark) [default], iteration 19 completed (8866.677 ms) ====== [2026-01-10T04:52:11.550Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-10T04:52:11.550Z] GC before operation: completed in 149.933 ms, heap usage 317.250 MB -> 69.559 MB. [2026-01-10T04:52:21.372Z] ====== als (apache-spark) [default], iteration 20 completed (8801.273 ms) ====== [2026-01-10T04:52:21.372Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-10T04:52:21.372Z] GC before operation: completed in 144.875 ms, heap usage 254.442 MB -> 69.726 MB. [2026-01-10T04:52:29.593Z] ====== als (apache-spark) [default], iteration 21 completed (8908.610 ms) ====== [2026-01-10T04:52:29.593Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-10T04:52:30.557Z] GC before operation: completed in 138.284 ms, heap usage 261.606 MB -> 70.040 MB. [2026-01-10T04:52:38.758Z] ====== als (apache-spark) [default], iteration 22 completed (8611.450 ms) ====== [2026-01-10T04:52:38.758Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-10T04:52:38.758Z] GC before operation: completed in 145.126 ms, heap usage 592.185 MB -> 70.750 MB. [2026-01-10T04:52:48.556Z] ====== als (apache-spark) [default], iteration 23 completed (8648.734 ms) ====== [2026-01-10T04:52:48.556Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-10T04:52:48.556Z] GC before operation: completed in 144.271 ms, heap usage 487.522 MB -> 70.825 MB. [2026-01-10T04:52:56.782Z] ====== als (apache-spark) [default], iteration 24 completed (8628.723 ms) ====== [2026-01-10T04:52:56.782Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-10T04:52:57.740Z] GC before operation: completed in 139.971 ms, heap usage 295.600 MB -> 70.924 MB. [2026-01-10T04:53:06.846Z] ====== als (apache-spark) [default], iteration 25 completed (8768.156 ms) ====== [2026-01-10T04:53:06.846Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-10T04:53:06.846Z] GC before operation: completed in 140.373 ms, heap usage 214.157 MB -> 70.944 MB. [2026-01-10T04:53:15.223Z] ====== als (apache-spark) [default], iteration 26 completed (8708.887 ms) ====== [2026-01-10T04:53:15.223Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-10T04:53:15.223Z] GC before operation: completed in 139.818 ms, heap usage 153.733 MB -> 71.265 MB. [2026-01-10T04:53:25.031Z] ====== als (apache-spark) [default], iteration 27 completed (8636.587 ms) ====== [2026-01-10T04:53:25.031Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-10T04:53:25.031Z] GC before operation: completed in 141.338 ms, heap usage 215.435 MB -> 71.521 MB. [2026-01-10T04:53:33.237Z] ====== als (apache-spark) [default], iteration 28 completed (8690.311 ms) ====== [2026-01-10T04:53:33.237Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-10T04:53:33.237Z] GC before operation: completed in 142.794 ms, heap usage 612.757 MB -> 71.895 MB. [2026-01-10T04:53:43.033Z] ====== als (apache-spark) [default], iteration 29 completed (8525.081 ms) ====== [2026-01-10T04:53:43.988Z] ----------------------------------- [2026-01-10T04:53:43.988Z] renaissance-als_0_PASSED [2026-01-10T04:53:43.988Z] ----------------------------------- [2026-01-10T04:53:43.988Z] [2026-01-10T04:53:43.988Z] TEST TEARDOWN: [2026-01-10T04:53:43.988Z] Nothing to be done for teardown. [2026-01-10T04:53:43.988Z] renaissance-als_0 Finish Time: Sat Jan 10 04:53:43 2026 Epoch Time (ms): 1768020823455