[2025-08-20T20:50:00.172Z] Running test renaissance-dec-tree_0 ... [2025-08-20T20:50:00.172Z] =============================================== [2025-08-20T20:50:00.172Z] renaissance-dec-tree_0 Start Time: Wed Aug 20 13:49:59 2025 Epoch Time (ms): 1755722999935 [2025-08-20T20:50:00.172Z] variation: NoOptions [2025-08-20T20:50:00.584Z] JVM_OPTIONS: [2025-08-20T20:50:00.584Z] { \ [2025-08-20T20:50:00.584Z] echo ""; echo "TEST SETUP:"; \ [2025-08-20T20:50:00.584Z] echo "Nothing to be done for setup."; \ [2025-08-20T20:50:00.584Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17557211464627/renaissance-dec-tree_0"; \ [2025-08-20T20:50:00.584Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17557211464627/renaissance-dec-tree_0"; \ [2025-08-20T20:50:00.584Z] echo ""; echo "TESTING:"; \ [2025-08-20T20:50:00.584Z] "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_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_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17557211464627/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-08-20T20:50:00.584Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17557211464627/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-20T20:50:00.584Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-20T20:50:00.584Z] echo "Nothing to be done for teardown."; \ [2025-08-20T20:50:00.584Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17557211464627/TestTargetResult"; [2025-08-20T20:50:00.584Z] [2025-08-20T20:50:00.584Z] TEST SETUP: [2025-08-20T20:50:00.584Z] Nothing to be done for setup. [2025-08-20T20:50:00.584Z] [2025-08-20T20:50:00.584Z] TESTING: [2025-08-20T20:50:18.199Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-08-20T20:50:27.230Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-08-20T20:50:27.231Z] GC before operation: completed in 137.733 ms, heap usage 91.469 MB -> 35.095 MB. [2025-08-20T20:50:57.877Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (30493.305 ms) ====== [2025-08-20T20:50:57.877Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-08-20T20:50:57.877Z] GC before operation: completed in 422.281 ms, heap usage 317.674 MB -> 69.427 MB. [2025-08-20T20:51:07.276Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (8003.332 ms) ====== [2025-08-20T20:51:07.276Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-08-20T20:51:07.276Z] GC before operation: completed in 366.093 ms, heap usage 356.694 MB -> 84.559 MB. [2025-08-20T20:51:13.999Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (6963.593 ms) ====== [2025-08-20T20:51:13.999Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-08-20T20:51:13.999Z] GC before operation: completed in 341.299 ms, heap usage 415.585 MB -> 70.263 MB. [2025-08-20T20:51:18.946Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (5053.214 ms) ====== [2025-08-20T20:51:18.946Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-08-20T20:51:19.572Z] GC before operation: completed in 309.719 ms, heap usage 275.869 MB -> 70.258 MB. [2025-08-20T20:51:24.541Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4961.258 ms) ====== [2025-08-20T20:51:24.541Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-08-20T20:51:24.541Z] GC before operation: completed in 209.886 ms, heap usage 270.992 MB -> 70.343 MB. [2025-08-20T20:51:30.203Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (5786.273 ms) ====== [2025-08-20T20:51:30.203Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-08-20T20:51:30.203Z] GC before operation: completed in 261.274 ms, heap usage 247.833 MB -> 70.560 MB. [2025-08-20T20:51:35.154Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (4992.114 ms) ====== [2025-08-20T20:51:35.154Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-08-20T20:51:35.595Z] GC before operation: completed in 236.255 ms, heap usage 318.307 MB -> 71.355 MB. [2025-08-20T20:51:40.379Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5098.951 ms) ====== [2025-08-20T20:51:40.379Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-08-20T20:51:40.957Z] GC before operation: completed in 216.491 ms, heap usage 342.676 MB -> 71.043 MB. [2025-08-20T20:51:45.523Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4387.263 ms) ====== [2025-08-20T20:51:45.523Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-08-20T20:51:45.523Z] GC before operation: completed in 257.573 ms, heap usage 399.582 MB -> 71.211 MB. [2025-08-20T20:51:50.241Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4155.241 ms) ====== [2025-08-20T20:51:50.241Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-08-20T20:51:50.241Z] GC before operation: completed in 282.860 ms, heap usage 367.283 MB -> 71.303 MB. [2025-08-20T20:51:54.147Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4454.978 ms) ====== [2025-08-20T20:51:54.147Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-08-20T20:51:54.695Z] GC before operation: completed in 263.801 ms, heap usage 248.256 MB -> 99.063 MB. [2025-08-20T20:51:59.384Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4508.200 ms) ====== [2025-08-20T20:51:59.384Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-08-20T20:51:59.384Z] GC before operation: completed in 297.944 ms, heap usage 581.957 MB -> 71.805 MB. [2025-08-20T20:52:04.224Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4911.786 ms) ====== [2025-08-20T20:52:04.224Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-08-20T20:52:04.720Z] GC before operation: completed in 314.513 ms, heap usage 240.870 MB -> 71.672 MB. [2025-08-20T20:52:09.838Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (4637.240 ms) ====== [2025-08-20T20:52:09.838Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-08-20T20:52:09.838Z] GC before operation: completed in 289.729 ms, heap usage 254.342 MB -> 99.311 MB. [2025-08-20T20:52:14.375Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4797.134 ms) ====== [2025-08-20T20:52:14.375Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-08-20T20:52:14.923Z] GC before operation: completed in 269.446 ms, heap usage 243.791 MB -> 71.916 MB. [2025-08-20T20:52:19.700Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (4418.501 ms) ====== [2025-08-20T20:52:19.700Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-08-20T20:52:19.700Z] GC before operation: completed in 242.111 ms, heap usage 269.491 MB -> 71.890 MB. [2025-08-20T20:52:24.416Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4625.936 ms) ====== [2025-08-20T20:52:24.416Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-08-20T20:52:24.416Z] GC before operation: completed in 313.204 ms, heap usage 316.458 MB -> 72.014 MB. [2025-08-20T20:52:29.203Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4618.139 ms) ====== [2025-08-20T20:52:29.204Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-08-20T20:52:29.204Z] GC before operation: completed in 255.812 ms, heap usage 304.709 MB -> 72.248 MB. [2025-08-20T20:52:33.358Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (4455.584 ms) ====== [2025-08-20T20:52:33.358Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-08-20T20:52:34.263Z] GC before operation: completed in 372.337 ms, heap usage 300.383 MB -> 72.225 MB. [2025-08-20T20:52:38.237Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4495.413 ms) ====== [2025-08-20T20:52:38.237Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-08-20T20:52:38.665Z] GC before operation: completed in 230.054 ms, heap usage 395.948 MB -> 72.690 MB. [2025-08-20T20:52:43.570Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4640.237 ms) ====== [2025-08-20T20:52:43.570Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-08-20T20:52:43.570Z] GC before operation: completed in 251.718 ms, heap usage 289.371 MB -> 72.446 MB. [2025-08-20T20:52:47.356Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3887.144 ms) ====== [2025-08-20T20:52:47.356Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-08-20T20:52:47.792Z] GC before operation: completed in 374.053 ms, heap usage 236.636 MB -> 72.913 MB. [2025-08-20T20:52:52.687Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4223.306 ms) ====== [2025-08-20T20:52:52.687Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-08-20T20:52:52.687Z] GC before operation: completed in 367.713 ms, heap usage 292.486 MB -> 72.675 MB. [2025-08-20T20:52:56.631Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (4103.275 ms) ====== [2025-08-20T20:52:56.631Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-08-20T20:52:56.631Z] GC before operation: completed in 240.242 ms, heap usage 234.222 MB -> 72.786 MB. [2025-08-20T20:53:01.263Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (4233.047 ms) ====== [2025-08-20T20:53:01.263Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-08-20T20:53:01.263Z] GC before operation: completed in 338.457 ms, heap usage 121.927 MB -> 72.283 MB. [2025-08-20T20:53:05.379Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (4161.801 ms) ====== [2025-08-20T20:53:05.379Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-08-20T20:53:05.848Z] GC before operation: completed in 368.609 ms, heap usage 568.841 MB -> 73.277 MB. [2025-08-20T20:53:10.515Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4094.303 ms) ====== [2025-08-20T20:53:10.515Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-08-20T20:53:10.515Z] GC before operation: completed in 297.502 ms, heap usage 341.343 MB -> 73.093 MB. [2025-08-20T20:53:15.246Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4686.954 ms) ====== [2025-08-20T20:53:15.246Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-08-20T20:53:15.246Z] GC before operation: completed in 271.739 ms, heap usage 232.947 MB -> 101.062 MB. [2025-08-20T20:53:20.271Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (4719.110 ms) ====== [2025-08-20T20:53:20.271Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-08-20T20:53:20.271Z] GC before operation: completed in 351.946 ms, heap usage 271.062 MB -> 73.728 MB. [2025-08-20T20:53:24.087Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3227.057 ms) ====== [2025-08-20T20:53:24.087Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-08-20T20:53:24.087Z] GC before operation: completed in 240.131 ms, heap usage 143.659 MB -> 73.140 MB. [2025-08-20T20:53:28.718Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4216.216 ms) ====== [2025-08-20T20:53:28.718Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-08-20T20:53:28.718Z] GC before operation: completed in 271.165 ms, heap usage 110.187 MB -> 72.956 MB. [2025-08-20T20:53:32.453Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (4240.902 ms) ====== [2025-08-20T20:53:32.453Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-08-20T20:53:32.901Z] GC before operation: completed in 387.914 ms, heap usage 551.690 MB -> 73.948 MB. [2025-08-20T20:53:37.512Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3990.711 ms) ====== [2025-08-20T20:53:37.512Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-08-20T20:53:37.512Z] GC before operation: completed in 307.590 ms, heap usage 193.046 MB -> 73.517 MB. [2025-08-20T20:53:40.707Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3352.056 ms) ====== [2025-08-20T20:53:40.707Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-08-20T20:53:40.707Z] GC before operation: completed in 246.196 ms, heap usage 367.922 MB -> 74.057 MB. [2025-08-20T20:53:45.623Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (4194.993 ms) ====== [2025-08-20T20:53:45.623Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-08-20T20:53:45.623Z] GC before operation: completed in 391.250 ms, heap usage 237.112 MB -> 101.605 MB. [2025-08-20T20:53:49.278Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (3800.895 ms) ====== [2025-08-20T20:53:49.278Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-08-20T20:53:49.712Z] GC before operation: completed in 270.389 ms, heap usage 290.571 MB -> 101.733 MB. [2025-08-20T20:53:56.463Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6272.036 ms) ====== [2025-08-20T20:53:56.463Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-08-20T20:53:56.463Z] GC before operation: completed in 399.136 ms, heap usage 447.418 MB -> 101.759 MB. [2025-08-20T20:54:01.422Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (5170.788 ms) ====== [2025-08-20T20:54:01.422Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-08-20T20:54:01.422Z] GC before operation: completed in 309.340 ms, heap usage 567.114 MB -> 74.530 MB. [2025-08-20T20:54:05.075Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (3183.206 ms) ====== [2025-08-20T20:54:05.075Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-08-20T20:54:05.075Z] GC before operation: completed in 197.029 ms, heap usage 442.273 MB -> 74.533 MB. [2025-08-20T20:54:08.829Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3343.808 ms) ====== [2025-08-20T20:54:09.202Z] ----------------------------------- [2025-08-20T20:54:09.202Z] renaissance-dec-tree_0_PASSED [2025-08-20T20:54:09.202Z] ----------------------------------- [2025-08-20T20:54:09.202Z] [2025-08-20T20:54:09.202Z] TEST TEARDOWN: [2025-08-20T20:54:09.202Z] Nothing to be done for teardown. [2025-08-20T20:54:09.664Z] renaissance-dec-tree_0 Finish Time: Wed Aug 20 13:54:09 2025 Epoch Time (ms): 1755723249037