[2025-10-01T22:14:14.238Z] Running test renaissance-dec-tree_0 ... [2025-10-01T22:14:14.238Z] =============================================== [2025-10-01T22:14:14.238Z] renaissance-dec-tree_0 Start Time: Wed Oct 1 15:14:12 2025 Epoch Time (ms): 1759356852232 [2025-10-01T22:14:14.238Z] variation: NoOptions [2025-10-01T22:14:14.238Z] JVM_OPTIONS: [2025-10-01T22:14:14.238Z] { \ [2025-10-01T22:14:14.238Z] echo ""; echo "TEST SETUP:"; \ [2025-10-01T22:14:14.238Z] echo "Nothing to be done for setup."; \ [2025-10-01T22:14:14.238Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17593541385335/renaissance-dec-tree_0"; \ [2025-10-01T22:14:14.238Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17593541385335/renaissance-dec-tree_0"; \ [2025-10-01T22:14:14.238Z] echo ""; echo "TESTING:"; \ [2025-10-01T22:14:14.238Z] "/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_17593541385335/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-10-01T22:14:14.238Z] 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_17593541385335/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-01T22:14:14.238Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-01T22:14:14.238Z] echo "Nothing to be done for teardown."; \ [2025-10-01T22:14:14.238Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17593541385335/TestTargetResult"; [2025-10-01T22:14:14.238Z] [2025-10-01T22:14:14.238Z] TEST SETUP: [2025-10-01T22:14:14.238Z] Nothing to be done for setup. [2025-10-01T22:14:14.238Z] [2025-10-01T22:14:14.238Z] TESTING: [2025-10-01T22:14:40.146Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-10-01T22:14:51.072Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-10-01T22:14:51.072Z] GC before operation: completed in 132.792 ms, heap usage 38.456 MB -> 35.069 MB. [2025-10-01T22:15:43.772Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (45338.811 ms) ====== [2025-10-01T22:15:43.772Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-10-01T22:15:43.772Z] GC before operation: completed in 394.611 ms, heap usage 203.108 MB -> 68.820 MB. [2025-10-01T22:15:47.672Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (10991.678 ms) ====== [2025-10-01T22:15:47.672Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-10-01T22:15:48.809Z] GC before operation: completed in 1047.642 ms, heap usage 215.771 MB -> 69.587 MB. [2025-10-01T22:16:00.480Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (10438.632 ms) ====== [2025-10-01T22:16:00.480Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-10-01T22:16:00.480Z] GC before operation: completed in 381.862 ms, heap usage 408.316 MB -> 69.822 MB. [2025-10-01T22:16:12.200Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (12078.603 ms) ====== [2025-10-01T22:16:12.200Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-10-01T22:16:12.200Z] GC before operation: completed in 241.624 ms, heap usage 294.221 MB -> 97.528 MB. [2025-10-01T22:16:21.785Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (9572.257 ms) ====== [2025-10-01T22:16:21.785Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-10-01T22:16:21.785Z] GC before operation: completed in 317.719 ms, heap usage 389.773 MB -> 70.253 MB. [2025-10-01T22:16:29.799Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (7170.787 ms) ====== [2025-10-01T22:16:29.799Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-10-01T22:16:29.799Z] GC before operation: completed in 803.916 ms, heap usage 211.036 MB -> 70.460 MB. [2025-10-01T22:16:39.124Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (8423.326 ms) ====== [2025-10-01T22:16:39.124Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-10-01T22:16:39.124Z] GC before operation: completed in 300.903 ms, heap usage 151.588 MB -> 70.257 MB. [2025-10-01T22:16:46.501Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (6999.717 ms) ====== [2025-10-01T22:16:46.501Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-10-01T22:16:46.501Z] GC before operation: completed in 314.196 ms, heap usage 393.026 MB -> 98.305 MB. [2025-10-01T22:16:56.010Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (9762.469 ms) ====== [2025-10-01T22:16:56.010Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-10-01T22:16:56.010Z] GC before operation: completed in 352.061 ms, heap usage 335.187 MB -> 70.835 MB. [2025-10-01T22:17:05.318Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (8217.195 ms) ====== [2025-10-01T22:17:05.318Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-10-01T22:17:05.318Z] GC before operation: completed in 363.368 ms, heap usage 238.232 MB -> 72.802 MB. [2025-10-01T22:17:14.693Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (9506.890 ms) ====== [2025-10-01T22:17:14.694Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-10-01T22:17:14.694Z] GC before operation: completed in 233.166 ms, heap usage 472.938 MB -> 71.086 MB. [2025-10-01T22:17:22.657Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (8594.696 ms) ====== [2025-10-01T22:17:22.657Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-10-01T22:17:23.189Z] GC before operation: completed in 347.562 ms, heap usage 444.179 MB -> 98.793 MB. [2025-10-01T22:17:31.631Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (7494.324 ms) ====== [2025-10-01T22:17:31.631Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-10-01T22:17:31.631Z] GC before operation: completed in 325.688 ms, heap usage 388.844 MB -> 71.339 MB. [2025-10-01T22:17:37.920Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6545.204 ms) ====== [2025-10-01T22:17:37.920Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-10-01T22:17:37.920Z] GC before operation: completed in 331.558 ms, heap usage 211.637 MB -> 71.459 MB. [2025-10-01T22:17:45.964Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (7817.212 ms) ====== [2025-10-01T22:17:45.964Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-10-01T22:17:45.964Z] GC before operation: completed in 275.029 ms, heap usage 252.980 MB -> 71.582 MB. [2025-10-01T22:17:52.027Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5960.288 ms) ====== [2025-10-01T22:17:52.027Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-10-01T22:17:52.027Z] GC before operation: completed in 215.414 ms, heap usage 312.566 MB -> 71.693 MB. [2025-10-01T22:17:59.571Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (6302.375 ms) ====== [2025-10-01T22:17:59.571Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-10-01T22:17:59.571Z] GC before operation: completed in 246.431 ms, heap usage 194.941 MB -> 71.636 MB. [2025-10-01T22:18:07.814Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (9000.067 ms) ====== [2025-10-01T22:18:07.814Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-10-01T22:18:08.278Z] GC before operation: completed in 344.978 ms, heap usage 403.133 MB -> 72.053 MB. [2025-10-01T22:18:15.853Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (7584.116 ms) ====== [2025-10-01T22:18:15.853Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-10-01T22:18:16.904Z] GC before operation: completed in 996.814 ms, heap usage 369.718 MB -> 72.048 MB. [2025-10-01T22:18:24.461Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (7305.086 ms) ====== [2025-10-01T22:18:24.461Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-10-01T22:18:25.712Z] GC before operation: completed in 542.480 ms, heap usage 400.104 MB -> 72.055 MB. [2025-10-01T22:18:32.283Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (7787.430 ms) ====== [2025-10-01T22:18:32.283Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-10-01T22:18:32.712Z] GC before operation: completed in 263.158 ms, heap usage 227.432 MB -> 72.301 MB. [2025-10-01T22:18:37.598Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5163.843 ms) ====== [2025-10-01T22:18:37.598Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-10-01T22:18:38.117Z] GC before operation: completed in 488.343 ms, heap usage 370.458 MB -> 99.999 MB. [2025-10-01T22:18:45.615Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (7427.389 ms) ====== [2025-10-01T22:18:45.615Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-10-01T22:18:46.112Z] GC before operation: completed in 294.253 ms, heap usage 462.202 MB -> 72.609 MB. [2025-10-01T22:18:52.383Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (6177.641 ms) ====== [2025-10-01T22:18:52.383Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-10-01T22:18:52.383Z] GC before operation: completed in 146.440 ms, heap usage 217.371 MB -> 72.892 MB. [2025-10-01T22:18:59.222Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (6297.118 ms) ====== [2025-10-01T22:18:59.222Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-10-01T22:18:59.222Z] GC before operation: completed in 259.128 ms, heap usage 306.443 MB -> 100.219 MB. [2025-10-01T22:19:05.570Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6211.742 ms) ====== [2025-10-01T22:19:05.570Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-10-01T22:19:05.570Z] GC before operation: completed in 538.167 ms, heap usage 254.367 MB -> 100.422 MB. [2025-10-01T22:19:14.500Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (7982.050 ms) ====== [2025-10-01T22:19:14.500Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-10-01T22:19:14.500Z] GC before operation: completed in 185.703 ms, heap usage 320.825 MB -> 73.297 MB. [2025-10-01T22:19:20.768Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (6464.331 ms) ====== [2025-10-01T22:19:20.768Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-10-01T22:19:20.768Z] GC before operation: completed in 241.468 ms, heap usage 421.924 MB -> 73.090 MB. [2025-10-01T22:19:25.712Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (5464.361 ms) ====== [2025-10-01T22:19:25.712Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-10-01T22:19:26.954Z] GC before operation: completed in 651.573 ms, heap usage 209.648 MB -> 73.433 MB. [2025-10-01T22:19:34.567Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (7925.274 ms) ====== [2025-10-01T22:19:34.567Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-10-01T22:19:35.099Z] GC before operation: completed in 340.453 ms, heap usage 488.541 MB -> 73.319 MB. [2025-10-01T22:19:41.325Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (6112.249 ms) ====== [2025-10-01T22:19:41.325Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-10-01T22:19:42.085Z] GC before operation: completed in 1045.511 ms, heap usage 144.545 MB -> 100.746 MB. [2025-10-01T22:19:49.727Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (7680.689 ms) ====== [2025-10-01T22:19:49.727Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-10-01T22:19:50.169Z] GC before operation: completed in 213.930 ms, heap usage 350.839 MB -> 73.575 MB. [2025-10-01T22:19:56.377Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (6383.925 ms) ====== [2025-10-01T22:19:56.377Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-10-01T22:19:57.197Z] GC before operation: completed in 310.544 ms, heap usage 161.019 MB -> 73.622 MB. [2025-10-01T22:20:04.949Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (7368.422 ms) ====== [2025-10-01T22:20:04.949Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-10-01T22:20:04.949Z] GC before operation: completed in 631.889 ms, heap usage 126.466 MB -> 72.959 MB. [2025-10-01T22:20:12.401Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (7248.424 ms) ====== [2025-10-01T22:20:12.401Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-10-01T22:20:12.401Z] GC before operation: completed in 351.493 ms, heap usage 121.375 MB -> 73.456 MB. [2025-10-01T22:20:18.747Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (6297.442 ms) ====== [2025-10-01T22:20:18.747Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-10-01T22:20:19.353Z] GC before operation: completed in 554.354 ms, heap usage 213.447 MB -> 74.009 MB. [2025-10-01T22:20:25.783Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6652.295 ms) ====== [2025-10-01T22:20:25.783Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-10-01T22:20:26.998Z] GC before operation: completed in 1349.228 ms, heap usage 117.017 MB -> 74.194 MB. [2025-10-01T22:20:36.360Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (8239.137 ms) ====== [2025-10-01T22:20:36.360Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-10-01T22:20:36.360Z] GC before operation: completed in 279.691 ms, heap usage 148.951 MB -> 73.778 MB. [2025-10-01T22:20:44.388Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (7766.170 ms) ====== [2025-10-01T22:20:44.388Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-10-01T22:20:44.883Z] GC before operation: completed in 1332.373 ms, heap usage 150.350 MB -> 73.791 MB. [2025-10-01T22:20:51.302Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (6198.475 ms) ====== [2025-10-01T22:20:51.748Z] ----------------------------------- [2025-10-01T22:20:51.748Z] renaissance-dec-tree_0_PASSED [2025-10-01T22:20:51.748Z] ----------------------------------- [2025-10-01T22:20:51.748Z] [2025-10-01T22:20:51.748Z] TEST TEARDOWN: [2025-10-01T22:20:51.748Z] Nothing to be done for teardown. [2025-10-01T22:20:51.748Z] renaissance-dec-tree_0 Finish Time: Wed Oct 1 15:20:51 2025 Epoch Time (ms): 1759357251083