[2025-11-27T16:34:03.838Z] Running test renaissance-als_0 ... [2025-11-27T16:34:03.838Z] =============================================== [2025-11-27T16:34:04.169Z] renaissance-als_0 Start Time: Thu Nov 27 16:34:03 2025 Epoch Time (ms): 1764261243863 [2025-11-27T16:34:04.169Z] variation: NoOptions [2025-11-27T16:34:04.169Z] JVM_OPTIONS: [2025-11-27T16:34:04.169Z] { \ [2025-11-27T16:34:04.169Z] echo ""; echo "TEST SETUP:"; \ [2025-11-27T16:34:04.169Z] echo "Nothing to be done for setup."; \ [2025-11-27T16:34:04.169Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17642606825143/renaissance-als_0"; \ [2025-11-27T16:34:04.169Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17642606825143/renaissance-als_0"; \ [2025-11-27T16:34:04.169Z] echo ""; echo "TESTING:"; \ [2025-11-27T16:34:04.170Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_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_riscv64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17642606825143/renaissance-als_0"/als.json" als; \ [2025-11-27T16:34:04.170Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17642606825143/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-27T16:34:04.170Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-27T16:34:04.170Z] echo "Nothing to be done for teardown."; \ [2025-11-27T16:34:04.170Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_riscv64_linux_testList_1/aqa-tests/TKG/../TKG/output_17642606825143/TestTargetResult"; [2025-11-27T16:34:04.170Z] [2025-11-27T16:34:04.170Z] TEST SETUP: [2025-11-27T16:34:04.170Z] Nothing to be done for setup. [2025-11-27T16:34:04.170Z] [2025-11-27T16:34:04.170Z] TESTING: [2025-11-27T16:34:27.174Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-27T16:34:46.278Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-11-27T16:34:46.278Z] GC before operation: completed in 199.855 ms, heap usage 73.009 MB -> 36.213 MB. [2025-11-27T16:36:09.283Z] ====== als (apache-spark) [default], iteration 0 completed (73811.724 ms) ====== [2025-11-27T16:36:09.283Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-11-27T16:36:09.283Z] GC before operation: completed in 652.112 ms, heap usage 799.079 MB -> 76.922 MB. [2025-11-27T16:36:32.406Z] ====== als (apache-spark) [default], iteration 1 completed (27851.385 ms) ====== [2025-11-27T16:36:32.406Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-11-27T16:36:32.733Z] GC before operation: completed in 643.007 ms, heap usage 298.372 MB -> 77.354 MB. [2025-11-27T16:37:00.408Z] ====== als (apache-spark) [default], iteration 2 completed (23406.390 ms) ====== [2025-11-27T16:37:00.408Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-11-27T16:37:00.408Z] GC before operation: completed in 709.890 ms, heap usage 481.607 MB -> 78.232 MB. [2025-11-27T16:37:23.418Z] ====== als (apache-spark) [default], iteration 3 completed (22529.507 ms) ====== [2025-11-27T16:37:23.418Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-11-27T16:37:23.418Z] GC before operation: completed in 750.679 ms, heap usage 920.705 MB -> 79.365 MB. [2025-11-27T16:37:46.530Z] ====== als (apache-spark) [default], iteration 4 completed (22380.364 ms) ====== [2025-11-27T16:37:46.530Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-11-27T16:37:46.856Z] GC before operation: completed in 786.484 ms, heap usage 956.386 MB -> 79.852 MB. [2025-11-27T16:38:09.888Z] ====== als (apache-spark) [default], iteration 5 completed (21245.359 ms) ====== [2025-11-27T16:38:09.888Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-11-27T16:38:09.888Z] GC before operation: completed in 778.353 ms, heap usage 906.118 MB -> 80.472 MB. [2025-11-27T16:38:32.883Z] ====== als (apache-spark) [default], iteration 6 completed (20863.770 ms) ====== [2025-11-27T16:38:32.883Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-11-27T16:38:32.883Z] GC before operation: completed in 815.621 ms, heap usage 905.068 MB -> 81.100 MB. [2025-11-27T16:38:55.871Z] ====== als (apache-spark) [default], iteration 7 completed (20960.341 ms) ====== [2025-11-27T16:38:55.871Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-11-27T16:38:55.871Z] GC before operation: completed in 847.305 ms, heap usage 721.128 MB -> 81.300 MB. [2025-11-27T16:39:18.955Z] ====== als (apache-spark) [default], iteration 8 completed (21204.860 ms) ====== [2025-11-27T16:39:18.955Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-11-27T16:39:18.955Z] GC before operation: completed in 803.413 ms, heap usage 135.987 MB -> 81.239 MB. [2025-11-27T16:39:42.196Z] ====== als (apache-spark) [default], iteration 9 completed (20678.799 ms) ====== [2025-11-27T16:39:42.196Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-11-27T16:39:42.196Z] GC before operation: completed in 848.000 ms, heap usage 278.632 MB -> 81.402 MB. [2025-11-27T16:40:05.209Z] ====== als (apache-spark) [default], iteration 10 completed (21551.874 ms) ====== [2025-11-27T16:40:05.209Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-11-27T16:40:05.209Z] GC before operation: completed in 880.641 ms, heap usage 1.019 GB -> 82.646 MB. [2025-11-27T16:40:28.214Z] ====== als (apache-spark) [default], iteration 11 completed (20459.121 ms) ====== [2025-11-27T16:40:28.214Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-11-27T16:40:28.214Z] GC before operation: completed in 884.589 ms, heap usage 1.027 GB -> 83.046 MB. [2025-11-27T16:40:51.561Z] ====== als (apache-spark) [default], iteration 12 completed (20898.832 ms) ====== [2025-11-27T16:40:51.561Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-11-27T16:40:51.561Z] GC before operation: completed in 923.719 ms, heap usage 831.860 MB -> 83.033 MB. [2025-11-27T16:41:14.562Z] ====== als (apache-spark) [default], iteration 13 completed (21018.058 ms) ====== [2025-11-27T16:41:14.562Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-11-27T16:41:14.562Z] GC before operation: completed in 940.080 ms, heap usage 1018.745 MB -> 83.489 MB. [2025-11-27T16:41:37.567Z] ====== als (apache-spark) [default], iteration 14 completed (20308.689 ms) ====== [2025-11-27T16:41:37.567Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-11-27T16:41:37.567Z] GC before operation: completed in 955.674 ms, heap usage 1.015 GB -> 83.734 MB. [2025-11-27T16:41:56.695Z] ====== als (apache-spark) [default], iteration 15 completed (20312.455 ms) ====== [2025-11-27T16:41:56.695Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-11-27T16:41:57.142Z] GC before operation: completed in 958.540 ms, heap usage 553.527 MB -> 83.535 MB. [2025-11-27T16:42:20.165Z] ====== als (apache-spark) [default], iteration 16 completed (21389.880 ms) ====== [2025-11-27T16:42:20.165Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-11-27T16:42:20.491Z] GC before operation: completed in 953.705 ms, heap usage 657.666 MB -> 83.900 MB. [2025-11-27T16:42:43.512Z] ====== als (apache-spark) [default], iteration 17 completed (20393.497 ms) ====== [2025-11-27T16:42:43.512Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-11-27T16:42:43.512Z] GC before operation: completed in 935.031 ms, heap usage 285.882 MB -> 83.729 MB. [2025-11-27T16:43:06.515Z] ====== als (apache-spark) [default], iteration 18 completed (20899.610 ms) ====== [2025-11-27T16:43:06.515Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-11-27T16:43:06.515Z] GC before operation: completed in 961.287 ms, heap usage 1.155 GB -> 85.049 MB. [2025-11-27T16:43:29.711Z] ====== als (apache-spark) [default], iteration 19 completed (20099.326 ms) ====== [2025-11-27T16:43:29.711Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-11-27T16:43:29.711Z] GC before operation: completed in 973.114 ms, heap usage 714.701 MB -> 84.767 MB. [2025-11-27T16:43:48.824Z] ====== als (apache-spark) [default], iteration 20 completed (20381.474 ms) ====== [2025-11-27T16:43:48.824Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-11-27T16:43:49.549Z] GC before operation: completed in 975.003 ms, heap usage 151.693 MB -> 84.278 MB. [2025-11-27T16:44:12.547Z] ====== als (apache-spark) [default], iteration 21 completed (20597.568 ms) ====== [2025-11-27T16:44:12.547Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-11-27T16:44:12.547Z] GC before operation: completed in 993.410 ms, heap usage 243.236 MB -> 84.624 MB. [2025-11-27T16:44:35.544Z] ====== als (apache-spark) [default], iteration 22 completed (19706.571 ms) ====== [2025-11-27T16:44:35.544Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-11-27T16:44:35.544Z] GC before operation: completed in 1040.043 ms, heap usage 1015.113 MB -> 85.937 MB. [2025-11-27T16:44:58.642Z] ====== als (apache-spark) [default], iteration 23 completed (20337.924 ms) ====== [2025-11-27T16:44:58.642Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-11-27T16:44:58.642Z] GC before operation: completed in 1013.567 ms, heap usage 1.258 GB -> 86.593 MB. [2025-11-27T16:45:17.749Z] ====== als (apache-spark) [default], iteration 24 completed (20286.928 ms) ====== [2025-11-27T16:45:17.749Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-11-27T16:45:18.080Z] GC before operation: completed in 975.235 ms, heap usage 978.107 MB -> 86.432 MB. [2025-11-27T16:45:41.062Z] ====== als (apache-spark) [default], iteration 25 completed (19870.868 ms) ====== [2025-11-27T16:45:41.063Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-11-27T16:45:41.063Z] GC before operation: completed in 1000.645 ms, heap usage 742.622 MB -> 86.465 MB. [2025-11-27T16:46:00.160Z] ====== als (apache-spark) [default], iteration 26 completed (19242.969 ms) ====== [2025-11-27T16:46:00.160Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-11-27T16:46:00.872Z] GC before operation: completed in 1011.218 ms, heap usage 864.528 MB -> 86.895 MB. [2025-11-27T16:46:23.870Z] ====== als (apache-spark) [default], iteration 27 completed (19773.059 ms) ====== [2025-11-27T16:46:23.870Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-11-27T16:46:23.870Z] GC before operation: completed in 1008.114 ms, heap usage 281.346 MB -> 86.316 MB. [2025-11-27T16:46:46.868Z] ====== als (apache-spark) [default], iteration 28 completed (19848.521 ms) ====== [2025-11-27T16:46:46.869Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-11-27T16:46:46.869Z] GC before operation: completed in 1017.565 ms, heap usage 610.713 MB -> 86.636 MB. [2025-11-27T16:47:05.938Z] ====== als (apache-spark) [default], iteration 29 completed (19379.235 ms) ====== [2025-11-27T16:47:07.068Z] ----------------------------------- [2025-11-27T16:47:07.068Z] renaissance-als_0_PASSED [2025-11-27T16:47:07.068Z] ----------------------------------- [2025-11-27T16:47:07.068Z] [2025-11-27T16:47:07.068Z] TEST TEARDOWN: [2025-11-27T16:47:07.068Z] Nothing to be done for teardown. [2025-11-27T16:47:07.068Z] renaissance-als_0 Finish Time: Thu Nov 27 16:47:07 2025 Epoch Time (ms): 1764262027028