[2025-10-03T20:35:22.058Z] Running test renaissance-dec-tree_0 ... [2025-10-03T20:35:22.058Z] =============================================== [2025-10-03T20:35:22.058Z] renaissance-dec-tree_0 Start Time: Fri Oct 3 16:35:22 2025 Epoch Time (ms): 1759523722004 [2025-10-03T20:35:22.417Z] variation: NoOptions [2025-10-03T20:35:22.417Z] JVM_OPTIONS: [2025-10-03T20:35:22.417Z] { \ [2025-10-03T20:35:22.417Z] echo ""; echo "TEST SETUP:"; \ [2025-10-03T20:35:22.417Z] echo "Nothing to be done for setup."; \ [2025-10-03T20:35:22.417Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17595234413722/renaissance-dec-tree_0"; \ [2025-10-03T20:35:22.417Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17595234413722/renaissance-dec-tree_0"; \ [2025-10-03T20:35:22.417Z] echo ""; echo "TESTING:"; \ [2025-10-03T20:35:22.417Z] "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17595234413722/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-10-03T20:35:22.417Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17595234413722/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-03T20:35:22.417Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-03T20:35:22.417Z] echo "Nothing to be done for teardown."; \ [2025-10-03T20:35:22.417Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17595234413722/TestTargetResult"; [2025-10-03T20:35:22.417Z] [2025-10-03T20:35:22.417Z] TEST SETUP: [2025-10-03T20:35:22.417Z] Nothing to be done for setup. [2025-10-03T20:35:22.417Z] [2025-10-03T20:35:22.417Z] TESTING: [2025-10-03T20:35:25.534Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-10-03T20:35:26.782Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-10-03T20:35:27.139Z] GC before operation: completed in 44.802 ms, heap usage 74.559 MB -> 35.221 MB. [2025-10-03T20:35:32.217Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4938.353 ms) ====== [2025-10-03T20:35:32.217Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-10-03T20:35:32.217Z] GC before operation: completed in 61.715 ms, heap usage 441.098 MB -> 69.504 MB. [2025-10-03T20:35:33.000Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (997.342 ms) ====== [2025-10-03T20:35:33.000Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-10-03T20:35:33.000Z] GC before operation: completed in 58.025 ms, heap usage 294.481 MB -> 69.721 MB. [2025-10-03T20:35:34.357Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (929.265 ms) ====== [2025-10-03T20:35:34.357Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-10-03T20:35:34.357Z] GC before operation: completed in 68.996 ms, heap usage 317.724 MB -> 97.545 MB. [2025-10-03T20:35:35.125Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (971.459 ms) ====== [2025-10-03T20:35:35.125Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-10-03T20:35:35.125Z] GC before operation: completed in 60.631 ms, heap usage 301.935 MB -> 70.240 MB. [2025-10-03T20:35:35.915Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (887.913 ms) ====== [2025-10-03T20:35:35.915Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-10-03T20:35:35.915Z] GC before operation: completed in 54.454 ms, heap usage 242.988 MB -> 70.336 MB. [2025-10-03T20:35:37.152Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (877.900 ms) ====== [2025-10-03T20:35:37.152Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-10-03T20:35:37.152Z] GC before operation: completed in 51.906 ms, heap usage 242.309 MB -> 70.685 MB. [2025-10-03T20:35:37.920Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (891.179 ms) ====== [2025-10-03T20:35:37.920Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-10-03T20:35:37.920Z] GC before operation: completed in 57.139 ms, heap usage 244.485 MB -> 70.905 MB. [2025-10-03T20:35:38.761Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (839.139 ms) ====== [2025-10-03T20:35:38.761Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-10-03T20:35:38.761Z] GC before operation: completed in 58.096 ms, heap usage 354.119 MB -> 70.924 MB. [2025-10-03T20:35:39.552Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (823.946 ms) ====== [2025-10-03T20:35:39.552Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-10-03T20:35:39.552Z] GC before operation: completed in 61.072 ms, heap usage 258.107 MB -> 71.116 MB. [2025-10-03T20:35:40.361Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (839.358 ms) ====== [2025-10-03T20:35:40.361Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-10-03T20:35:40.716Z] GC before operation: completed in 56.769 ms, heap usage 358.807 MB -> 71.214 MB. [2025-10-03T20:35:41.506Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (772.520 ms) ====== [2025-10-03T20:35:41.506Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-10-03T20:35:41.506Z] GC before operation: completed in 67.712 ms, heap usage 278.828 MB -> 71.395 MB. [2025-10-03T20:35:42.312Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (804.387 ms) ====== [2025-10-03T20:35:42.312Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-10-03T20:35:42.312Z] GC before operation: completed in 64.129 ms, heap usage 212.529 MB -> 71.420 MB. [2025-10-03T20:35:43.115Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (798.027 ms) ====== [2025-10-03T20:35:43.116Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-10-03T20:35:43.116Z] GC before operation: completed in 54.596 ms, heap usage 216.420 MB -> 71.552 MB. [2025-10-03T20:35:43.886Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (796.241 ms) ====== [2025-10-03T20:35:43.886Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-10-03T20:35:43.886Z] GC before operation: completed in 55.396 ms, heap usage 229.723 MB -> 71.808 MB. [2025-10-03T20:35:44.658Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (758.843 ms) ====== [2025-10-03T20:35:44.659Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-10-03T20:35:44.659Z] GC before operation: completed in 69.319 ms, heap usage 341.654 MB -> 71.820 MB. [2025-10-03T20:35:45.462Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (735.249 ms) ====== [2025-10-03T20:35:45.462Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-10-03T20:35:45.462Z] GC before operation: completed in 61.001 ms, heap usage 229.358 MB -> 71.970 MB. [2025-10-03T20:35:46.232Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (735.729 ms) ====== [2025-10-03T20:35:46.232Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-10-03T20:35:46.590Z] GC before operation: completed in 58.338 ms, heap usage 206.470 MB -> 72.286 MB. [2025-10-03T20:35:47.385Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (744.586 ms) ====== [2025-10-03T20:35:47.385Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-10-03T20:35:47.385Z] GC before operation: completed in 67.013 ms, heap usage 115.377 MB -> 71.730 MB. [2025-10-03T20:35:48.215Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (751.420 ms) ====== [2025-10-03T20:35:48.215Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-10-03T20:35:48.215Z] GC before operation: completed in 65.360 ms, heap usage 355.821 MB -> 72.355 MB. [2025-10-03T20:35:49.010Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (735.762 ms) ====== [2025-10-03T20:35:49.010Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-10-03T20:35:49.010Z] GC before operation: completed in 72.546 ms, heap usage 216.904 MB -> 72.493 MB. [2025-10-03T20:35:49.789Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (724.976 ms) ====== [2025-10-03T20:35:49.789Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-10-03T20:35:49.789Z] GC before operation: completed in 59.330 ms, heap usage 314.049 MB -> 72.502 MB. [2025-10-03T20:35:50.589Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (766.280 ms) ====== [2025-10-03T20:35:50.589Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-10-03T20:35:50.589Z] GC before operation: completed in 62.701 ms, heap usage 216.624 MB -> 72.662 MB. [2025-10-03T20:35:51.381Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (688.982 ms) ====== [2025-10-03T20:35:51.381Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-10-03T20:35:51.381Z] GC before operation: completed in 67.326 ms, heap usage 209.319 MB -> 73.367 MB. [2025-10-03T20:35:52.142Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (752.691 ms) ====== [2025-10-03T20:35:52.142Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-10-03T20:35:52.142Z] GC before operation: completed in 64.581 ms, heap usage 156.510 MB -> 72.545 MB. [2025-10-03T20:35:52.903Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (719.848 ms) ====== [2025-10-03T20:35:52.903Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-10-03T20:35:52.903Z] GC before operation: completed in 62.623 ms, heap usage 419.002 MB -> 87.883 MB. [2025-10-03T20:35:53.690Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (697.306 ms) ====== [2025-10-03T20:35:53.690Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-10-03T20:35:53.690Z] GC before operation: completed in 71.345 ms, heap usage 315.764 MB -> 100.706 MB. [2025-10-03T20:35:54.485Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (682.050 ms) ====== [2025-10-03T20:35:54.485Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-10-03T20:35:54.485Z] GC before operation: completed in 65.543 ms, heap usage 275.816 MB -> 73.143 MB. [2025-10-03T20:35:55.323Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (726.027 ms) ====== [2025-10-03T20:35:55.323Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-10-03T20:35:55.323Z] GC before operation: completed in 70.712 ms, heap usage 349.790 MB -> 73.403 MB. [2025-10-03T20:35:56.121Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (752.679 ms) ====== [2025-10-03T20:35:56.121Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-10-03T20:35:56.121Z] GC before operation: completed in 68.752 ms, heap usage 208.542 MB -> 73.404 MB. [2025-10-03T20:35:56.922Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (738.187 ms) ====== [2025-10-03T20:35:56.922Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-10-03T20:35:56.922Z] GC before operation: completed in 65.167 ms, heap usage 147.509 MB -> 73.327 MB. [2025-10-03T20:35:57.682Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (743.766 ms) ====== [2025-10-03T20:35:57.682Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-10-03T20:35:57.682Z] GC before operation: completed in 68.641 ms, heap usage 394.981 MB -> 88.168 MB. [2025-10-03T20:35:58.479Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (739.467 ms) ====== [2025-10-03T20:35:58.479Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-10-03T20:35:58.479Z] GC before operation: completed in 69.178 ms, heap usage 242.673 MB -> 73.777 MB. [2025-10-03T20:35:59.271Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (736.880 ms) ====== [2025-10-03T20:35:59.271Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-10-03T20:35:59.271Z] GC before operation: completed in 76.293 ms, heap usage 364.370 MB -> 88.789 MB. [2025-10-03T20:36:00.044Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (715.733 ms) ====== [2025-10-03T20:36:00.044Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-10-03T20:36:00.044Z] GC before operation: completed in 71.205 ms, heap usage 392.773 MB -> 86.847 MB. [2025-10-03T20:36:00.885Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (746.493 ms) ====== [2025-10-03T20:36:00.885Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-10-03T20:36:00.885Z] GC before operation: completed in 69.346 ms, heap usage 414.577 MB -> 74.056 MB. [2025-10-03T20:36:01.692Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (714.410 ms) ====== [2025-10-03T20:36:01.692Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-10-03T20:36:01.692Z] GC before operation: completed in 62.705 ms, heap usage 207.711 MB -> 74.311 MB. [2025-10-03T20:36:02.193Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (718.997 ms) ====== [2025-10-03T20:36:02.193Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-10-03T20:36:02.578Z] GC before operation: completed in 80.725 ms, heap usage 417.768 MB -> 74.248 MB. [2025-10-03T20:36:02.962Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (701.552 ms) ====== [2025-10-03T20:36:02.962Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-10-03T20:36:03.361Z] GC before operation: completed in 71.385 ms, heap usage 182.874 MB -> 74.068 MB. [2025-10-03T20:36:03.747Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (736.915 ms) ====== [2025-10-03T20:36:03.747Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-10-03T20:36:04.122Z] GC before operation: completed in 72.122 ms, heap usage 247.215 MB -> 74.618 MB. [2025-10-03T20:36:04.507Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (681.136 ms) ====== [2025-10-03T20:36:04.874Z] ----------------------------------- [2025-10-03T20:36:04.874Z] renaissance-dec-tree_0_PASSED [2025-10-03T20:36:04.874Z] ----------------------------------- [2025-10-03T20:36:04.874Z] [2025-10-03T20:36:04.874Z] TEST TEARDOWN: [2025-10-03T20:36:04.874Z] Nothing to be done for teardown. [2025-10-03T20:36:04.874Z] renaissance-dec-tree_0 Finish Time: Fri Oct 3 16:36:04 2025 Epoch Time (ms): 1759523764571