[2026-03-04T23:06:37.747Z] Running test renaissance-als_0 ... [2026-03-04T23:06:37.747Z] =============================================== [2026-03-04T23:06:37.747Z] renaissance-als_0 Start Time: Wed Mar 4 23:06:36 2026 Epoch Time (ms): 1772665596934 [2026-03-04T23:06:37.747Z] variation: NoOptions [2026-03-04T23:06:37.747Z] JVM_OPTIONS: [2026-03-04T23:06:37.747Z] { \ [2026-03-04T23:06:37.747Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T23:06:37.747Z] echo "Nothing to be done for setup."; \ [2026-03-04T23:06:37.747Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772665439678/renaissance-als_0"; \ [2026-03-04T23:06:37.747Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772665439678/renaissance-als_0"; \ [2026-03-04T23:06:37.747Z] echo ""; echo "TESTING:"; \ [2026-03-04T23:06:37.747Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772665439678/renaissance-als_0"/als.json" als; \ [2026-03-04T23:06:37.747Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772665439678/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T23:06:37.747Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T23:06:37.747Z] echo "Nothing to be done for teardown."; \ [2026-03-04T23:06:37.747Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1772665439678/TestTargetResult"; [2026-03-04T23:06:37.747Z] [2026-03-04T23:06:37.747Z] TEST SETUP: [2026-03-04T23:06:37.747Z] Nothing to be done for setup. [2026-03-04T23:06:37.747Z] [2026-03-04T23:06:37.747Z] TESTING: [2026-03-04T23:06:43.119Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-03-04T23:06:47.268Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-03-04T23:06:47.268Z] GC before operation: completed in 52.357 ms, heap usage 328.411 MB -> 35.175 MB. [2026-03-04T23:07:05.081Z] ====== als (apache-spark) [default], iteration 0 completed (17234.670 ms) ====== [2026-03-04T23:07:05.081Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-03-04T23:07:05.081Z] GC before operation: completed in 112.435 ms, heap usage 459.799 MB -> 62.334 MB. [2026-03-04T23:07:13.848Z] ====== als (apache-spark) [default], iteration 1 completed (7886.250 ms) ====== [2026-03-04T23:07:13.848Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-03-04T23:07:14.803Z] GC before operation: completed in 90.504 ms, heap usage 468.943 MB -> 63.173 MB. [2026-03-04T23:07:21.504Z] ====== als (apache-spark) [default], iteration 2 completed (7024.200 ms) ====== [2026-03-04T23:07:21.504Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-03-04T23:07:21.504Z] GC before operation: completed in 84.792 ms, heap usage 353.958 MB -> 63.568 MB. [2026-03-04T23:07:28.200Z] ====== als (apache-spark) [default], iteration 3 completed (6911.368 ms) ====== [2026-03-04T23:07:28.200Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-03-04T23:07:28.200Z] GC before operation: completed in 116.239 ms, heap usage 543.936 MB -> 64.496 MB. [2026-03-04T23:07:36.351Z] ====== als (apache-spark) [default], iteration 4 completed (6893.835 ms) ====== [2026-03-04T23:07:36.352Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-03-04T23:07:36.352Z] GC before operation: completed in 104.684 ms, heap usage 263.274 MB -> 64.598 MB. [2026-03-04T23:07:43.051Z] ====== als (apache-spark) [default], iteration 5 completed (6906.730 ms) ====== [2026-03-04T23:07:43.051Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-03-04T23:07:43.051Z] GC before operation: completed in 96.490 ms, heap usage 115.889 MB -> 64.987 MB. [2026-03-04T23:07:49.844Z] ====== als (apache-spark) [default], iteration 6 completed (6821.839 ms) ====== [2026-03-04T23:07:49.844Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-03-04T23:07:49.844Z] GC before operation: completed in 120.144 ms, heap usage 218.876 MB -> 65.570 MB. [2026-03-04T23:07:56.547Z] ====== als (apache-spark) [default], iteration 7 completed (6806.847 ms) ====== [2026-03-04T23:07:56.547Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-03-04T23:07:57.500Z] GC before operation: completed in 102.975 ms, heap usage 483.954 MB -> 66.581 MB. [2026-03-04T23:08:04.231Z] ====== als (apache-spark) [default], iteration 8 completed (6635.868 ms) ====== [2026-03-04T23:08:04.231Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-03-04T23:08:04.231Z] GC before operation: completed in 101.163 ms, heap usage 179.376 MB -> 66.736 MB. [2026-03-04T23:08:11.182Z] ====== als (apache-spark) [default], iteration 9 completed (6625.551 ms) ====== [2026-03-04T23:08:11.182Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-03-04T23:08:11.182Z] GC before operation: completed in 107.250 ms, heap usage 263.707 MB -> 67.064 MB. [2026-03-04T23:08:17.902Z] ====== als (apache-spark) [default], iteration 10 completed (6774.932 ms) ====== [2026-03-04T23:08:17.902Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-03-04T23:08:17.902Z] GC before operation: completed in 109.501 ms, heap usage 429.738 MB -> 67.585 MB. [2026-03-04T23:08:24.598Z] ====== als (apache-spark) [default], iteration 11 completed (6647.641 ms) ====== [2026-03-04T23:08:24.598Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-03-04T23:08:24.598Z] GC before operation: completed in 93.758 ms, heap usage 129.613 MB -> 67.458 MB. [2026-03-04T23:08:32.743Z] ====== als (apache-spark) [default], iteration 12 completed (6634.431 ms) ====== [2026-03-04T23:08:32.743Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-03-04T23:08:32.743Z] GC before operation: completed in 111.484 ms, heap usage 241.819 MB -> 67.805 MB. [2026-03-04T23:08:39.486Z] ====== als (apache-spark) [default], iteration 13 completed (6609.402 ms) ====== [2026-03-04T23:08:39.486Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-03-04T23:08:39.486Z] GC before operation: completed in 108.822 ms, heap usage 121.709 MB -> 67.987 MB. [2026-03-04T23:08:46.186Z] ====== als (apache-spark) [default], iteration 14 completed (6626.011 ms) ====== [2026-03-04T23:08:46.186Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-03-04T23:08:46.186Z] GC before operation: completed in 100.588 ms, heap usage 126.376 MB -> 68.224 MB. [2026-03-04T23:08:52.881Z] ====== als (apache-spark) [default], iteration 15 completed (6634.044 ms) ====== [2026-03-04T23:08:52.881Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-03-04T23:08:52.881Z] GC before operation: completed in 104.945 ms, heap usage 329.718 MB -> 68.699 MB. [2026-03-04T23:08:59.578Z] ====== als (apache-spark) [default], iteration 16 completed (6598.299 ms) ====== [2026-03-04T23:08:59.578Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-03-04T23:08:59.578Z] GC before operation: completed in 126.501 ms, heap usage 403.527 MB -> 68.953 MB. [2026-03-04T23:09:06.465Z] ====== als (apache-spark) [default], iteration 17 completed (6702.941 ms) ====== [2026-03-04T23:09:06.465Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-03-04T23:09:06.465Z] GC before operation: completed in 99.501 ms, heap usage 221.065 MB -> 69.059 MB. [2026-03-04T23:09:13.397Z] ====== als (apache-spark) [default], iteration 18 completed (6599.663 ms) ====== [2026-03-04T23:09:13.397Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-03-04T23:09:13.397Z] GC before operation: completed in 117.121 ms, heap usage 358.792 MB -> 69.385 MB. [2026-03-04T23:09:20.089Z] ====== als (apache-spark) [default], iteration 19 completed (6502.605 ms) ====== [2026-03-04T23:09:20.089Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-03-04T23:09:20.089Z] GC before operation: completed in 108.436 ms, heap usage 199.968 MB -> 69.439 MB. [2026-03-04T23:09:26.786Z] ====== als (apache-spark) [default], iteration 20 completed (6638.892 ms) ====== [2026-03-04T23:09:26.786Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-03-04T23:09:27.738Z] GC before operation: completed in 108.661 ms, heap usage 208.039 MB -> 69.775 MB. [2026-03-04T23:09:34.441Z] ====== als (apache-spark) [default], iteration 21 completed (6547.327 ms) ====== [2026-03-04T23:09:34.441Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-03-04T23:09:34.441Z] GC before operation: completed in 117.137 ms, heap usage 360.245 MB -> 70.250 MB. [2026-03-04T23:09:41.147Z] ====== als (apache-spark) [default], iteration 22 completed (6475.349 ms) ====== [2026-03-04T23:09:41.147Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-03-04T23:09:41.147Z] GC before operation: completed in 107.775 ms, heap usage 687.433 MB -> 70.989 MB. [2026-03-04T23:09:47.858Z] ====== als (apache-spark) [default], iteration 23 completed (6413.086 ms) ====== [2026-03-04T23:09:47.858Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-03-04T23:09:47.858Z] GC before operation: completed in 120.491 ms, heap usage 282.983 MB -> 70.677 MB. [2026-03-04T23:09:54.575Z] ====== als (apache-spark) [default], iteration 24 completed (6410.356 ms) ====== [2026-03-04T23:09:54.575Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-03-04T23:09:54.575Z] GC before operation: completed in 109.362 ms, heap usage 535.072 MB -> 71.378 MB. [2026-03-04T23:10:02.402Z] ====== als (apache-spark) [default], iteration 25 completed (6544.215 ms) ====== [2026-03-04T23:10:02.402Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-03-04T23:10:02.402Z] GC before operation: completed in 133.615 ms, heap usage 587.183 MB -> 71.579 MB. [2026-03-04T23:10:07.939Z] ====== als (apache-spark) [default], iteration 26 completed (6487.712 ms) ====== [2026-03-04T23:10:07.939Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-03-04T23:10:07.939Z] GC before operation: completed in 107.576 ms, heap usage 512.307 MB -> 71.752 MB. [2026-03-04T23:10:14.637Z] ====== als (apache-spark) [default], iteration 27 completed (6394.388 ms) ====== [2026-03-04T23:10:14.637Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-03-04T23:10:14.637Z] GC before operation: completed in 101.852 ms, heap usage 196.921 MB -> 71.602 MB. [2026-03-04T23:10:21.329Z] ====== als (apache-spark) [default], iteration 28 completed (6483.254 ms) ====== [2026-03-04T23:10:21.329Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-03-04T23:10:21.329Z] GC before operation: completed in 98.384 ms, heap usage 278.740 MB -> 72.038 MB. [2026-03-04T23:10:28.017Z] ====== als (apache-spark) [default], iteration 29 completed (6518.805 ms) ====== [2026-03-04T23:10:28.968Z] ----------------------------------- [2026-03-04T23:10:28.968Z] renaissance-als_0_PASSED [2026-03-04T23:10:28.968Z] ----------------------------------- [2026-03-04T23:10:28.968Z] [2026-03-04T23:10:28.968Z] TEST TEARDOWN: [2026-03-04T23:10:28.968Z] Nothing to be done for teardown. [2026-03-04T23:10:28.968Z] renaissance-als_0 Finish Time: Wed Mar 4 23:10:28 2026 Epoch Time (ms): 1772665828123