[2026-01-10T04:03:52.939Z] Running test renaissance-als_0 ... [2026-01-10T04:03:52.939Z] =============================================== [2026-01-10T04:03:52.939Z] renaissance-als_0 Start Time: Sat Jan 10 04:03:52 2026 Epoch Time (ms): 1768017832164 [2026-01-10T04:03:52.939Z] variation: NoOptions [2026-01-10T04:03:52.939Z] JVM_OPTIONS: [2026-01-10T04:03:52.939Z] { \ [2026-01-10T04:03:52.939Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T04:03:52.939Z] echo "Nothing to be done for setup."; \ [2026-01-10T04:03:52.939Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17680178317920/renaissance-als_0"; \ [2026-01-10T04:03:52.939Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17680178317920/renaissance-als_0"; \ [2026-01-10T04:03:52.939Z] echo ""; echo "TESTING:"; \ [2026-01-10T04:03:52.939Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17680178317920/renaissance-als_0"/als.json" als; \ [2026-01-10T04:03:52.939Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17680178317920/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T04:03:52.939Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T04:03:52.939Z] echo "Nothing to be done for teardown."; \ [2026-01-10T04:03:52.939Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17680178317920/TestTargetResult"; [2026-01-10T04:03:52.939Z] [2026-01-10T04:03:52.939Z] TEST SETUP: [2026-01-10T04:03:52.939Z] Nothing to be done for setup. [2026-01-10T04:03:52.939Z] [2026-01-10T04:03:52.939Z] TESTING: [2026-01-10T04:04:05.568Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T04:04:13.774Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-01-10T04:04:13.774Z] GC before operation: completed in 139.578 ms, heap usage 94.170 MB -> 35.097 MB. [2026-01-10T04:05:06.011Z] ====== als (apache-spark) [default], iteration 0 completed (48995.250 ms) ====== [2026-01-10T04:05:06.011Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-01-10T04:05:06.011Z] GC before operation: completed in 366.961 ms, heap usage 428.300 MB -> 62.352 MB. [2026-01-10T04:05:24.535Z] ====== als (apache-spark) [default], iteration 1 completed (18826.908 ms) ====== [2026-01-10T04:05:24.535Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-01-10T04:05:24.535Z] GC before operation: completed in 233.994 ms, heap usage 630.976 MB -> 63.425 MB. [2026-01-10T04:05:40.625Z] ====== als (apache-spark) [default], iteration 2 completed (15559.672 ms) ====== [2026-01-10T04:05:40.625Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-01-10T04:05:40.625Z] GC before operation: completed in 200.074 ms, heap usage 608.963 MB -> 64.056 MB. [2026-01-10T04:05:56.572Z] ====== als (apache-spark) [default], iteration 3 completed (15334.359 ms) ====== [2026-01-10T04:05:56.572Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-01-10T04:05:56.572Z] GC before operation: completed in 237.994 ms, heap usage 555.076 MB -> 64.652 MB. [2026-01-10T04:06:12.559Z] ====== als (apache-spark) [default], iteration 4 completed (14260.634 ms) ====== [2026-01-10T04:06:12.559Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-01-10T04:06:12.559Z] GC before operation: completed in 249.963 ms, heap usage 404.971 MB -> 64.817 MB. [2026-01-10T04:06:27.146Z] ====== als (apache-spark) [default], iteration 5 completed (13502.474 ms) ====== [2026-01-10T04:06:27.146Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-01-10T04:06:27.146Z] GC before operation: completed in 302.162 ms, heap usage 752.935 MB -> 65.906 MB. [2026-01-10T04:06:40.840Z] ====== als (apache-spark) [default], iteration 6 completed (12998.695 ms) ====== [2026-01-10T04:06:40.840Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-01-10T04:06:40.840Z] GC before operation: completed in 246.026 ms, heap usage 460.575 MB -> 65.931 MB. [2026-01-10T04:06:54.481Z] ====== als (apache-spark) [default], iteration 7 completed (12771.183 ms) ====== [2026-01-10T04:06:54.481Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-01-10T04:06:54.481Z] GC before operation: completed in 281.009 ms, heap usage 277.831 MB -> 66.354 MB. [2026-01-10T04:07:08.253Z] ====== als (apache-spark) [default], iteration 8 completed (12478.901 ms) ====== [2026-01-10T04:07:08.253Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-01-10T04:07:08.253Z] GC before operation: completed in 264.176 ms, heap usage 384.316 MB -> 67.046 MB. [2026-01-10T04:07:21.870Z] ====== als (apache-spark) [default], iteration 9 completed (13230.682 ms) ====== [2026-01-10T04:07:21.870Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-01-10T04:07:21.870Z] GC before operation: completed in 269.804 ms, heap usage 408.178 MB -> 67.349 MB. [2026-01-10T04:07:35.604Z] ====== als (apache-spark) [default], iteration 10 completed (12954.648 ms) ====== [2026-01-10T04:07:35.604Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-01-10T04:07:35.604Z] GC before operation: completed in 268.698 ms, heap usage 529.723 MB -> 67.911 MB. [2026-01-10T04:07:49.233Z] ====== als (apache-spark) [default], iteration 11 completed (12890.908 ms) ====== [2026-01-10T04:07:49.233Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-01-10T04:07:49.233Z] GC before operation: completed in 259.442 ms, heap usage 600.779 MB -> 68.056 MB. [2026-01-10T04:08:02.932Z] ====== als (apache-spark) [default], iteration 12 completed (12708.650 ms) ====== [2026-01-10T04:08:02.932Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-01-10T04:08:02.932Z] GC before operation: completed in 287.535 ms, heap usage 691.642 MB -> 68.493 MB. [2026-01-10T04:08:15.124Z] ====== als (apache-spark) [default], iteration 13 completed (12445.570 ms) ====== [2026-01-10T04:08:15.124Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-01-10T04:08:15.124Z] GC before operation: completed in 312.543 ms, heap usage 224.696 MB -> 68.213 MB. [2026-01-10T04:08:28.770Z] ====== als (apache-spark) [default], iteration 14 completed (12444.606 ms) ====== [2026-01-10T04:08:28.770Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-01-10T04:08:28.770Z] GC before operation: completed in 269.489 ms, heap usage 290.823 MB -> 68.460 MB. [2026-01-10T04:08:40.390Z] ====== als (apache-spark) [default], iteration 15 completed (11724.901 ms) ====== [2026-01-10T04:08:40.390Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-01-10T04:08:40.390Z] GC before operation: completed in 286.685 ms, heap usage 800.638 MB -> 69.492 MB. [2026-01-10T04:08:54.349Z] ====== als (apache-spark) [default], iteration 16 completed (12438.868 ms) ====== [2026-01-10T04:08:54.349Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-01-10T04:08:54.349Z] GC before operation: completed in 261.964 ms, heap usage 458.257 MB -> 69.384 MB. [2026-01-10T04:09:08.154Z] ====== als (apache-spark) [default], iteration 17 completed (12425.576 ms) ====== [2026-01-10T04:09:08.154Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-01-10T04:09:08.154Z] GC before operation: completed in 366.380 ms, heap usage 529.342 MB -> 69.744 MB. [2026-01-10T04:09:19.849Z] ====== als (apache-spark) [default], iteration 18 completed (11904.705 ms) ====== [2026-01-10T04:09:19.849Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-01-10T04:09:19.849Z] GC before operation: completed in 234.722 ms, heap usage 267.153 MB -> 69.472 MB. [2026-01-10T04:09:33.540Z] ====== als (apache-spark) [default], iteration 19 completed (11980.321 ms) ====== [2026-01-10T04:09:33.540Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-01-10T04:09:33.540Z] GC before operation: completed in 287.304 ms, heap usage 194.472 MB -> 69.563 MB. [2026-01-10T04:09:45.288Z] ====== als (apache-spark) [default], iteration 20 completed (12461.277 ms) ====== [2026-01-10T04:09:45.288Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-01-10T04:09:46.279Z] GC before operation: completed in 264.384 ms, heap usage 306.958 MB -> 70.044 MB. [2026-01-10T04:09:58.711Z] ====== als (apache-spark) [default], iteration 21 completed (12710.860 ms) ====== [2026-01-10T04:09:58.711Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-01-10T04:09:59.685Z] GC before operation: completed in 271.615 ms, heap usage 742.196 MB -> 70.846 MB. [2026-01-10T04:10:11.325Z] ====== als (apache-spark) [default], iteration 22 completed (11722.299 ms) ====== [2026-01-10T04:10:11.325Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-01-10T04:10:11.325Z] GC before operation: completed in 303.551 ms, heap usage 701.037 MB -> 71.193 MB. [2026-01-10T04:10:25.058Z] ====== als (apache-spark) [default], iteration 23 completed (12146.900 ms) ====== [2026-01-10T04:10:25.058Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-01-10T04:10:25.058Z] GC before operation: completed in 312.332 ms, heap usage 651.561 MB -> 71.344 MB. [2026-01-10T04:10:36.841Z] ====== als (apache-spark) [default], iteration 24 completed (12176.133 ms) ====== [2026-01-10T04:10:36.841Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-01-10T04:10:37.817Z] GC before operation: completed in 327.815 ms, heap usage 699.625 MB -> 71.805 MB. [2026-01-10T04:10:51.621Z] ====== als (apache-spark) [default], iteration 25 completed (12241.163 ms) ====== [2026-01-10T04:10:51.621Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-01-10T04:10:51.622Z] GC before operation: completed in 327.708 ms, heap usage 342.602 MB -> 71.511 MB. [2026-01-10T04:11:03.506Z] ====== als (apache-spark) [default], iteration 26 completed (11465.936 ms) ====== [2026-01-10T04:11:03.506Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-01-10T04:11:03.506Z] GC before operation: completed in 395.645 ms, heap usage 715.371 MB -> 72.300 MB. [2026-01-10T04:11:15.224Z] ====== als (apache-spark) [default], iteration 27 completed (12017.454 ms) ====== [2026-01-10T04:11:15.224Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-01-10T04:11:15.224Z] GC before operation: completed in 278.479 ms, heap usage 386.218 MB -> 71.969 MB. [2026-01-10T04:11:28.917Z] ====== als (apache-spark) [default], iteration 28 completed (12448.263 ms) ====== [2026-01-10T04:11:28.917Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-01-10T04:11:28.917Z] GC before operation: completed in 294.943 ms, heap usage 235.537 MB -> 72.109 MB. [2026-01-10T04:11:41.013Z] ====== als (apache-spark) [default], iteration 29 completed (11683.390 ms) ====== [2026-01-10T04:11:41.970Z] ----------------------------------- [2026-01-10T04:11:41.970Z] renaissance-als_0_PASSED [2026-01-10T04:11:41.970Z] ----------------------------------- [2026-01-10T04:11:41.970Z] [2026-01-10T04:11:41.970Z] TEST TEARDOWN: [2026-01-10T04:11:41.970Z] Nothing to be done for teardown. [2026-01-10T04:11:41.970Z] renaissance-als_0 Finish Time: Sat Jan 10 04:11:41 2026 Epoch Time (ms): 1768018301679