[2026-02-25T21:44:11.057Z] Running test renaissance-als_0 ... [2026-02-25T21:44:11.057Z] =============================================== [2026-02-25T21:44:11.057Z] renaissance-als_0 Start Time: Wed Feb 25 21:44:11 2026 Epoch Time (ms): 1772055851025 [2026-02-25T21:44:11.057Z] variation: NoOptions [2026-02-25T21:44:11.057Z] JVM_OPTIONS: [2026-02-25T21:44:11.057Z] { \ [2026-02-25T21:44:11.057Z] echo ""; echo "TEST SETUP:"; \ [2026-02-25T21:44:11.057Z] echo "Nothing to be done for setup."; \ [2026-02-25T21:44:11.057Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17720556599305/renaissance-als_0"; \ [2026-02-25T21:44:11.057Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17720556599305/renaissance-als_0"; \ [2026-02-25T21:44:11.057Z] echo ""; echo "TESTING:"; \ [2026-02-25T21:44:11.057Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_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_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17720556599305/renaissance-als_0"/als.json" als; \ [2026-02-25T21:44:11.057Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17720556599305/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-25T21:44:11.057Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-25T21:44:11.057Z] echo "Nothing to be done for teardown."; \ [2026-02-25T21:44:11.057Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17720556599305/TestTargetResult"; [2026-02-25T21:44:11.057Z] [2026-02-25T21:44:11.057Z] TEST SETUP: [2026-02-25T21:44:11.057Z] Nothing to be done for setup. [2026-02-25T21:44:11.057Z] [2026-02-25T21:44:11.057Z] TESTING: [2026-02-25T21:44:16.805Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-02-25T21:44:20.503Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-25T21:44:20.503Z] GC before operation: completed in 94.575 ms, heap usage 281.426 MB -> 34.671 MB. [2026-02-25T21:44:53.642Z] ====== als (apache-spark) [default], iteration 0 completed (28360.327 ms) ====== [2026-02-25T21:44:53.642Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-25T21:44:53.642Z] GC before operation: completed in 80.833 ms, heap usage 236.394 MB -> 61.453 MB. [2026-02-25T21:45:04.263Z] ====== als (apache-spark) [default], iteration 1 completed (12622.360 ms) ====== [2026-02-25T21:45:04.263Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-25T21:45:04.263Z] GC before operation: completed in 87.921 ms, heap usage 183.759 MB -> 62.213 MB. [2026-02-25T21:45:17.157Z] ====== als (apache-spark) [default], iteration 2 completed (12177.919 ms) ====== [2026-02-25T21:45:17.157Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-25T21:45:17.157Z] GC before operation: completed in 77.627 ms, heap usage 363.532 MB -> 63.122 MB. [2026-02-25T21:45:27.811Z] ====== als (apache-spark) [default], iteration 3 completed (11038.255 ms) ====== [2026-02-25T21:45:27.811Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-25T21:45:27.811Z] GC before operation: completed in 78.853 ms, heap usage 186.730 MB -> 63.478 MB. [2026-02-25T21:45:38.534Z] ====== als (apache-spark) [default], iteration 4 completed (10201.517 ms) ====== [2026-02-25T21:45:38.534Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-25T21:45:38.534Z] GC before operation: completed in 86.426 ms, heap usage 230.762 MB -> 64.051 MB. [2026-02-25T21:45:49.156Z] ====== als (apache-spark) [default], iteration 5 completed (9926.538 ms) ====== [2026-02-25T21:45:49.156Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-25T21:45:49.156Z] GC before operation: completed in 92.055 ms, heap usage 125.841 MB -> 64.524 MB. [2026-02-25T21:45:59.770Z] ====== als (apache-spark) [default], iteration 6 completed (10671.075 ms) ====== [2026-02-25T21:45:59.770Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-25T21:45:59.770Z] GC before operation: completed in 85.671 ms, heap usage 467.639 MB -> 65.490 MB. [2026-02-25T21:46:10.460Z] ====== als (apache-spark) [default], iteration 7 completed (10172.002 ms) ====== [2026-02-25T21:46:10.460Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-25T21:46:10.460Z] GC before operation: completed in 101.587 ms, heap usage 300.961 MB -> 65.728 MB. [2026-02-25T21:46:21.168Z] ====== als (apache-spark) [default], iteration 8 completed (10203.367 ms) ====== [2026-02-25T21:46:21.168Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-25T21:46:21.168Z] GC before operation: completed in 83.484 ms, heap usage 426.400 MB -> 66.515 MB. [2026-02-25T21:46:31.785Z] ====== als (apache-spark) [default], iteration 9 completed (10883.164 ms) ====== [2026-02-25T21:46:31.785Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-25T21:46:31.785Z] GC before operation: completed in 92.305 ms, heap usage 333.768 MB -> 66.592 MB. [2026-02-25T21:46:42.383Z] ====== als (apache-spark) [default], iteration 10 completed (10857.898 ms) ====== [2026-02-25T21:46:42.383Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-25T21:46:42.383Z] GC before operation: completed in 100.318 ms, heap usage 145.354 MB -> 66.718 MB. [2026-02-25T21:46:53.028Z] ====== als (apache-spark) [default], iteration 11 completed (10077.432 ms) ====== [2026-02-25T21:46:53.028Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-25T21:46:53.028Z] GC before operation: completed in 93.821 ms, heap usage 443.252 MB -> 67.395 MB. [2026-02-25T21:47:03.690Z] ====== als (apache-spark) [default], iteration 12 completed (10016.410 ms) ====== [2026-02-25T21:47:03.690Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-25T21:47:03.690Z] GC before operation: completed in 104.485 ms, heap usage 140.841 MB -> 67.306 MB. [2026-02-25T21:47:14.308Z] ====== als (apache-spark) [default], iteration 13 completed (9962.429 ms) ====== [2026-02-25T21:47:14.308Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-25T21:47:14.308Z] GC before operation: completed in 117.866 ms, heap usage 336.115 MB -> 67.689 MB. [2026-02-25T21:47:23.010Z] ====== als (apache-spark) [default], iteration 14 completed (9959.625 ms) ====== [2026-02-25T21:47:23.010Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-25T21:47:23.010Z] GC before operation: completed in 101.284 ms, heap usage 488.104 MB -> 68.213 MB. [2026-02-25T21:47:33.625Z] ====== als (apache-spark) [default], iteration 15 completed (9777.601 ms) ====== [2026-02-25T21:47:33.625Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-25T21:47:33.625Z] GC before operation: completed in 90.999 ms, heap usage 245.055 MB -> 68.154 MB. [2026-02-25T21:47:44.313Z] ====== als (apache-spark) [default], iteration 16 completed (9443.238 ms) ====== [2026-02-25T21:47:44.313Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-25T21:47:44.313Z] GC before operation: completed in 89.593 ms, heap usage 164.106 MB -> 68.369 MB. [2026-02-25T21:47:53.104Z] ====== als (apache-spark) [default], iteration 17 completed (9670.676 ms) ====== [2026-02-25T21:47:53.104Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-25T21:47:53.104Z] GC before operation: completed in 96.947 ms, heap usage 437.120 MB -> 68.971 MB. [2026-02-25T21:48:03.826Z] ====== als (apache-spark) [default], iteration 18 completed (9578.448 ms) ====== [2026-02-25T21:48:03.826Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-25T21:48:03.826Z] GC before operation: completed in 92.314 ms, heap usage 284.461 MB -> 68.828 MB. [2026-02-25T21:48:12.535Z] ====== als (apache-spark) [default], iteration 19 completed (9559.339 ms) ====== [2026-02-25T21:48:12.535Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-25T21:48:12.535Z] GC before operation: completed in 96.849 ms, heap usage 164.875 MB -> 69.088 MB. [2026-02-25T21:48:23.135Z] ====== als (apache-spark) [default], iteration 20 completed (9959.774 ms) ====== [2026-02-25T21:48:23.135Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-25T21:48:23.135Z] GC before operation: completed in 98.922 ms, heap usage 490.195 MB -> 69.777 MB. [2026-02-25T21:48:33.842Z] ====== als (apache-spark) [default], iteration 21 completed (10074.948 ms) ====== [2026-02-25T21:48:33.843Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-25T21:48:33.843Z] GC before operation: completed in 102.265 ms, heap usage 636.928 MB -> 70.243 MB. [2026-02-25T21:48:44.667Z] ====== als (apache-spark) [default], iteration 22 completed (9699.286 ms) ====== [2026-02-25T21:48:44.667Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-25T21:48:44.667Z] GC before operation: completed in 95.620 ms, heap usage 169.875 MB -> 69.792 MB. [2026-02-25T21:48:53.382Z] ====== als (apache-spark) [default], iteration 23 completed (9733.852 ms) ====== [2026-02-25T21:48:53.382Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-25T21:48:53.382Z] GC before operation: completed in 135.052 ms, heap usage 132.878 MB -> 70.136 MB. [2026-02-25T21:49:04.039Z] ====== als (apache-spark) [default], iteration 24 completed (9723.295 ms) ====== [2026-02-25T21:49:04.039Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-25T21:49:04.039Z] GC before operation: completed in 102.566 ms, heap usage 572.687 MB -> 70.850 MB. [2026-02-25T21:49:12.794Z] ====== als (apache-spark) [default], iteration 25 completed (9410.759 ms) ====== [2026-02-25T21:49:12.794Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-25T21:49:12.794Z] GC before operation: completed in 93.775 ms, heap usage 153.158 MB -> 70.635 MB. [2026-02-25T21:49:23.583Z] ====== als (apache-spark) [default], iteration 26 completed (9381.839 ms) ====== [2026-02-25T21:49:23.583Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-25T21:49:23.583Z] GC before operation: completed in 98.622 ms, heap usage 376.552 MB -> 71.094 MB. [2026-02-25T21:49:32.320Z] ====== als (apache-spark) [default], iteration 27 completed (9160.947 ms) ====== [2026-02-25T21:49:32.320Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-25T21:49:32.320Z] GC before operation: completed in 99.492 ms, heap usage 118.678 MB -> 71.110 MB. [2026-02-25T21:49:42.951Z] ====== als (apache-spark) [default], iteration 28 completed (10084.120 ms) ====== [2026-02-25T21:49:42.951Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-25T21:49:42.951Z] GC before operation: completed in 102.717 ms, heap usage 130.165 MB -> 71.492 MB. [2026-02-25T21:49:53.566Z] ====== als (apache-spark) [default], iteration 29 completed (9571.987 ms) ====== [2026-02-25T21:49:53.566Z] ----------------------------------- [2026-02-25T21:49:53.566Z] renaissance-als_0_PASSED [2026-02-25T21:49:53.566Z] ----------------------------------- [2026-02-25T21:49:53.566Z] [2026-02-25T21:49:53.566Z] TEST TEARDOWN: [2026-02-25T21:49:53.566Z] Nothing to be done for teardown. [2026-02-25T21:49:53.566Z] renaissance-als_0 Finish Time: Wed Feb 25 21:49:52 2026 Epoch Time (ms): 1772056192394