[2025-11-26T22:13:49.725Z] Running test renaissance-dec-tree_0 ... [2025-11-26T22:13:49.725Z] =============================================== [2025-11-26T22:13:49.725Z] renaissance-dec-tree_0 Start Time: Wed Nov 26 14:13:48 2025 Epoch Time (ms): 1764195228061 [2025-11-26T22:13:49.725Z] variation: NoOptions [2025-11-26T22:13:49.725Z] JVM_OPTIONS: [2025-11-26T22:13:49.725Z] { \ [2025-11-26T22:13:49.725Z] echo ""; echo "TEST SETUP:"; \ [2025-11-26T22:13:49.725Z] echo "Nothing to be done for setup."; \ [2025-11-26T22:13:49.725Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17641940902829/renaissance-dec-tree_0"; \ [2025-11-26T22:13:49.725Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17641940902829/renaissance-dec-tree_0"; \ [2025-11-26T22:13:49.725Z] echo ""; echo "TESTING:"; \ [2025-11-26T22:13:49.725Z] "/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_17641940902829/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-26T22:13:49.725Z] 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_17641940902829/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-26T22:13:49.725Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-26T22:13:49.725Z] echo "Nothing to be done for teardown."; \ [2025-11-26T22:13:49.725Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17641940902829/TestTargetResult"; [2025-11-26T22:13:49.725Z] [2025-11-26T22:13:49.725Z] TEST SETUP: [2025-11-26T22:13:49.725Z] Nothing to be done for setup. [2025-11-26T22:13:49.725Z] [2025-11-26T22:13:49.725Z] TESTING: [2025-11-26T22:14:00.183Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-26T22:14:05.069Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-26T22:14:05.524Z] GC before operation: completed in 54.846 ms, heap usage 37.261 MB -> 34.057 MB. [2025-11-26T22:14:32.583Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (24223.864 ms) ====== [2025-11-26T22:14:32.583Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-26T22:14:32.583Z] GC before operation: completed in 168.143 ms, heap usage 353.781 MB -> 70.196 MB. [2025-11-26T22:14:33.539Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3977.145 ms) ====== [2025-11-26T22:14:33.539Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-26T22:14:33.539Z] GC before operation: completed in 83.076 ms, heap usage 207.750 MB -> 70.334 MB. [2025-11-26T22:14:38.672Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4983.072 ms) ====== [2025-11-26T22:14:38.672Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-26T22:14:38.672Z] GC before operation: completed in 111.096 ms, heap usage 140.192 MB -> 70.378 MB. [2025-11-26T22:14:42.750Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3861.348 ms) ====== [2025-11-26T22:14:42.750Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-26T22:14:42.750Z] GC before operation: completed in 74.009 ms, heap usage 269.405 MB -> 70.793 MB. [2025-11-26T22:14:47.101Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3828.301 ms) ====== [2025-11-26T22:14:47.101Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-26T22:14:47.101Z] GC before operation: completed in 446.157 ms, heap usage 389.914 MB -> 71.131 MB. [2025-11-26T22:14:51.123Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4097.089 ms) ====== [2025-11-26T22:14:51.123Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-26T22:14:51.123Z] GC before operation: completed in 164.736 ms, heap usage 307.530 MB -> 71.212 MB. [2025-11-26T22:14:55.161Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3785.175 ms) ====== [2025-11-26T22:14:55.161Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-26T22:14:55.161Z] GC before operation: completed in 130.525 ms, heap usage 236.465 MB -> 71.430 MB. [2025-11-26T22:15:00.205Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4525.109 ms) ====== [2025-11-26T22:15:00.205Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-26T22:15:00.205Z] GC before operation: completed in 677.282 ms, heap usage 390.678 MB -> 71.947 MB. [2025-11-26T22:15:04.508Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3776.942 ms) ====== [2025-11-26T22:15:04.508Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-26T22:15:04.508Z] GC before operation: completed in 138.916 ms, heap usage 121.041 MB -> 71.921 MB. [2025-11-26T22:15:09.754Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4818.155 ms) ====== [2025-11-26T22:15:09.754Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-26T22:15:09.754Z] GC before operation: completed in 283.439 ms, heap usage 308.126 MB -> 72.192 MB. [2025-11-26T22:15:14.066Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4647.464 ms) ====== [2025-11-26T22:15:14.066Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-26T22:15:15.280Z] GC before operation: completed in 1005.872 ms, heap usage 118.493 MB -> 71.628 MB. [2025-11-26T22:15:19.252Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4291.479 ms) ====== [2025-11-26T22:15:19.252Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-26T22:15:19.920Z] GC before operation: completed in 171.399 ms, heap usage 640.017 MB -> 72.304 MB. [2025-11-26T22:15:25.122Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (5195.816 ms) ====== [2025-11-26T22:15:25.122Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-26T22:15:25.122Z] GC before operation: completed in 205.932 ms, heap usage 433.899 MB -> 99.813 MB. [2025-11-26T22:15:28.898Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3850.879 ms) ====== [2025-11-26T22:15:28.898Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-26T22:15:28.898Z] GC before operation: completed in 203.253 ms, heap usage 357.546 MB -> 72.420 MB. [2025-11-26T22:15:34.264Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4250.995 ms) ====== [2025-11-26T22:15:34.264Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-26T22:15:34.264Z] GC before operation: completed in 203.437 ms, heap usage 312.865 MB -> 100.174 MB. [2025-11-26T22:15:37.601Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3637.240 ms) ====== [2025-11-26T22:15:37.601Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-26T22:15:37.601Z] GC before operation: completed in 210.867 ms, heap usage 600.094 MB -> 72.820 MB. [2025-11-26T22:15:40.799Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (3468.792 ms) ====== [2025-11-26T22:15:40.799Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-26T22:15:41.371Z] GC before operation: completed in 161.967 ms, heap usage 213.790 MB -> 72.639 MB. [2025-11-26T22:15:45.993Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4717.469 ms) ====== [2025-11-26T22:15:45.993Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-26T22:15:45.993Z] GC before operation: completed in 166.685 ms, heap usage 394.185 MB -> 72.843 MB. [2025-11-26T22:15:49.427Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3297.079 ms) ====== [2025-11-26T22:15:49.427Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-26T22:15:49.427Z] GC before operation: completed in 160.763 ms, heap usage 306.310 MB -> 72.849 MB. [2025-11-26T22:15:52.590Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3024.602 ms) ====== [2025-11-26T22:15:52.590Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-26T22:15:52.590Z] GC before operation: completed in 134.812 ms, heap usage 266.423 MB -> 95.186 MB. [2025-11-26T22:15:55.280Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2812.839 ms) ====== [2025-11-26T22:15:55.280Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-26T22:15:55.280Z] GC before operation: completed in 100.854 ms, heap usage 226.754 MB -> 73.439 MB. [2025-11-26T22:15:58.503Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2785.506 ms) ====== [2025-11-26T22:15:58.503Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-26T22:15:58.503Z] GC before operation: completed in 111.742 ms, heap usage 328.037 MB -> 73.226 MB. [2025-11-26T22:16:01.136Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2541.235 ms) ====== [2025-11-26T22:16:01.136Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-26T22:16:01.136Z] GC before operation: completed in 109.322 ms, heap usage 375.218 MB -> 73.340 MB. [2025-11-26T22:16:03.980Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2379.770 ms) ====== [2025-11-26T22:16:03.980Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-26T22:16:03.980Z] GC before operation: completed in 154.743 ms, heap usage 118.204 MB -> 72.829 MB. [2025-11-26T22:16:06.422Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2555.324 ms) ====== [2025-11-26T22:16:06.422Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-26T22:16:06.422Z] GC before operation: completed in 121.713 ms, heap usage 522.161 MB -> 73.803 MB. [2025-11-26T22:16:08.670Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2511.811 ms) ====== [2025-11-26T22:16:08.670Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-26T22:16:09.145Z] GC before operation: completed in 163.300 ms, heap usage 300.768 MB -> 73.667 MB. [2025-11-26T22:16:10.120Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1139.795 ms) ====== [2025-11-26T22:16:10.120Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-26T22:16:10.120Z] GC before operation: completed in 106.000 ms, heap usage 111.983 MB -> 73.743 MB. [2025-11-26T22:16:12.917Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2310.548 ms) ====== [2025-11-26T22:16:12.917Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-26T22:16:12.917Z] GC before operation: completed in 118.793 ms, heap usage 507.971 MB -> 74.183 MB. [2025-11-26T22:16:15.428Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2629.301 ms) ====== [2025-11-26T22:16:15.428Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-26T22:16:15.428Z] GC before operation: completed in 213.651 ms, heap usage 300.109 MB -> 74.023 MB. [2025-11-26T22:16:17.124Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1376.392 ms) ====== [2025-11-26T22:16:17.124Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-26T22:16:17.124Z] GC before operation: completed in 93.135 ms, heap usage 298.549 MB -> 74.270 MB. [2025-11-26T22:16:18.846Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1938.756 ms) ====== [2025-11-26T22:16:18.846Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-26T22:16:18.846Z] GC before operation: completed in 103.551 ms, heap usage 278.574 MB -> 74.258 MB. [2025-11-26T22:16:20.474Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1270.847 ms) ====== [2025-11-26T22:16:20.474Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-26T22:16:20.474Z] GC before operation: completed in 107.094 ms, heap usage 249.482 MB -> 74.376 MB. [2025-11-26T22:16:22.895Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2085.774 ms) ====== [2025-11-26T22:16:22.895Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-26T22:16:22.895Z] GC before operation: completed in 134.125 ms, heap usage 177.999 MB -> 74.182 MB. [2025-11-26T22:16:24.470Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2098.357 ms) ====== [2025-11-26T22:16:24.470Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-26T22:16:24.929Z] GC before operation: completed in 200.835 ms, heap usage 149.751 MB -> 74.254 MB. [2025-11-26T22:16:28.298Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3120.833 ms) ====== [2025-11-26T22:16:28.298Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-26T22:16:28.298Z] GC before operation: completed in 179.663 ms, heap usage 118.375 MB -> 74.587 MB. [2025-11-26T22:16:32.973Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4292.761 ms) ====== [2025-11-26T22:16:32.973Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-26T22:16:32.973Z] GC before operation: completed in 130.733 ms, heap usage 120.592 MB -> 74.562 MB. [2025-11-26T22:16:36.013Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3157.771 ms) ====== [2025-11-26T22:16:36.013Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-26T22:16:36.013Z] GC before operation: completed in 185.415 ms, heap usage 299.853 MB -> 75.052 MB. [2025-11-26T22:16:40.765Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4212.956 ms) ====== [2025-11-26T22:16:40.765Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-26T22:16:40.765Z] GC before operation: completed in 154.195 ms, heap usage 396.319 MB -> 75.139 MB. [2025-11-26T22:16:43.769Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (3315.891 ms) ====== [2025-11-26T22:16:43.769Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-26T22:16:43.769Z] GC before operation: completed in 198.838 ms, heap usage 419.309 MB -> 75.116 MB. [2025-11-26T22:16:47.732Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3617.190 ms) ====== [2025-11-26T22:16:48.682Z] ----------------------------------- [2025-11-26T22:16:48.682Z] renaissance-dec-tree_0_PASSED [2025-11-26T22:16:48.682Z] ----------------------------------- [2025-11-26T22:16:48.682Z] [2025-11-26T22:16:48.682Z] TEST TEARDOWN: [2025-11-26T22:16:48.682Z] Nothing to be done for teardown. [2025-11-26T22:16:48.682Z] renaissance-dec-tree_0 Finish Time: Wed Nov 26 14:16:48 2025 Epoch Time (ms): 1764195408241