[2025-08-27T20:01:38.869Z] Running test renaissance-dec-tree_0 ... [2025-08-27T20:01:38.869Z] =============================================== [2025-08-27T20:01:39.221Z] renaissance-dec-tree_0 Start Time: Wed Aug 27 16:01:38 2025 Epoch Time (ms): 1756324898824 [2025-08-27T20:01:39.221Z] variation: NoOptions [2025-08-27T20:01:39.221Z] JVM_OPTIONS: [2025-08-27T20:01:39.221Z] { \ [2025-08-27T20:01:39.221Z] echo ""; echo "TEST SETUP:"; \ [2025-08-27T20:01:39.221Z] echo "Nothing to be done for setup."; \ [2025-08-27T20:01:39.221Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1756324599886/renaissance-dec-tree_0"; \ [2025-08-27T20:01:39.221Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1756324599886/renaissance-dec-tree_0"; \ [2025-08-27T20:01:39.221Z] echo ""; echo "TESTING:"; \ [2025-08-27T20:01:39.221Z] "/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_1756324599886/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-08-27T20:01:39.221Z] 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_1756324599886/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-27T20:01:39.221Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-27T20:01:39.221Z] echo "Nothing to be done for teardown."; \ [2025-08-27T20:01:39.221Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1756324599886/TestTargetResult"; [2025-08-27T20:01:39.221Z] [2025-08-27T20:01:39.221Z] TEST SETUP: [2025-08-27T20:01:39.221Z] Nothing to be done for setup. [2025-08-27T20:01:39.221Z] [2025-08-27T20:01:39.221Z] TESTING: [2025-08-27T20:01:43.235Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-08-27T20:01:44.461Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-08-27T20:01:44.461Z] GC before operation: completed in 32.749 ms, heap usage 73.927 MB -> 35.187 MB. [2025-08-27T20:01:50.627Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5743.960 ms) ====== [2025-08-27T20:01:50.627Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-08-27T20:01:50.627Z] GC before operation: completed in 82.534 ms, heap usage 126.731 MB -> 69.382 MB. [2025-08-27T20:01:51.891Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1367.414 ms) ====== [2025-08-27T20:01:51.891Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-08-27T20:01:51.891Z] GC before operation: completed in 73.622 ms, heap usage 180.382 MB -> 69.211 MB. [2025-08-27T20:01:53.106Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1128.764 ms) ====== [2025-08-27T20:01:53.106Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-08-27T20:01:53.106Z] GC before operation: completed in 66.190 ms, heap usage 332.768 MB -> 72.567 MB. [2025-08-27T20:01:53.875Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (973.555 ms) ====== [2025-08-27T20:01:53.875Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-08-27T20:01:54.234Z] GC before operation: completed in 52.204 ms, heap usage 107.543 MB -> 69.507 MB. [2025-08-27T20:01:55.007Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (947.728 ms) ====== [2025-08-27T20:01:55.007Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-08-27T20:01:55.007Z] GC before operation: completed in 71.975 ms, heap usage 299.737 MB -> 70.216 MB. [2025-08-27T20:01:56.252Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (922.784 ms) ====== [2025-08-27T20:01:56.252Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-08-27T20:01:56.252Z] GC before operation: completed in 59.921 ms, heap usage 326.206 MB -> 70.424 MB. [2025-08-27T20:01:57.008Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (885.371 ms) ====== [2025-08-27T20:01:57.008Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-08-27T20:01:57.008Z] GC before operation: completed in 49.745 ms, heap usage 328.133 MB -> 83.725 MB. [2025-08-27T20:01:57.765Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (918.637 ms) ====== [2025-08-27T20:01:57.765Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-08-27T20:01:58.175Z] GC before operation: completed in 53.940 ms, heap usage 236.914 MB -> 83.846 MB. [2025-08-27T20:01:58.928Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (855.499 ms) ====== [2025-08-27T20:01:58.928Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-08-27T20:01:58.928Z] GC before operation: completed in 68.782 ms, heap usage 134.708 MB -> 70.770 MB. [2025-08-27T20:01:59.707Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (877.251 ms) ====== [2025-08-27T20:01:59.707Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-08-27T20:01:59.707Z] GC before operation: completed in 54.805 ms, heap usage 116.976 MB -> 70.491 MB. [2025-08-27T20:02:00.962Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (913.724 ms) ====== [2025-08-27T20:02:00.962Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-08-27T20:02:00.962Z] GC before operation: completed in 63.096 ms, heap usage 496.478 MB -> 71.217 MB. [2025-08-27T20:02:01.760Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (823.345 ms) ====== [2025-08-27T20:02:01.760Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-08-27T20:02:01.760Z] GC before operation: completed in 63.908 ms, heap usage 218.202 MB -> 71.339 MB. [2025-08-27T20:02:02.561Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (846.186 ms) ====== [2025-08-27T20:02:02.561Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-08-27T20:02:02.561Z] GC before operation: completed in 63.455 ms, heap usage 183.475 MB -> 71.321 MB. [2025-08-27T20:02:03.339Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (875.615 ms) ====== [2025-08-27T20:02:03.339Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-08-27T20:02:03.713Z] GC before operation: completed in 65.292 ms, heap usage 295.945 MB -> 99.276 MB. [2025-08-27T20:02:04.470Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (806.397 ms) ====== [2025-08-27T20:02:04.470Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-08-27T20:02:04.470Z] GC before operation: completed in 67.584 ms, heap usage 145.426 MB -> 71.248 MB. [2025-08-27T20:02:05.223Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (832.876 ms) ====== [2025-08-27T20:02:05.223Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-08-27T20:02:05.223Z] GC before operation: completed in 62.070 ms, heap usage 251.900 MB -> 71.888 MB. [2025-08-27T20:02:05.987Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (790.102 ms) ====== [2025-08-27T20:02:05.987Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-08-27T20:02:06.443Z] GC before operation: completed in 60.995 ms, heap usage 311.529 MB -> 71.929 MB. [2025-08-27T20:02:07.233Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (840.310 ms) ====== [2025-08-27T20:02:07.233Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-08-27T20:02:07.233Z] GC before operation: completed in 69.319 ms, heap usage 312.338 MB -> 72.075 MB. [2025-08-27T20:02:07.999Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (803.133 ms) ====== [2025-08-27T20:02:07.999Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-08-27T20:02:07.999Z] GC before operation: completed in 74.706 ms, heap usage 311.697 MB -> 72.333 MB. [2025-08-27T20:02:08.762Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (770.909 ms) ====== [2025-08-27T20:02:08.762Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-08-27T20:02:08.762Z] GC before operation: completed in 70.433 ms, heap usage 174.471 MB -> 72.027 MB. [2025-08-27T20:02:09.520Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (730.581 ms) ====== [2025-08-27T20:02:09.520Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-08-27T20:02:09.520Z] GC before operation: completed in 71.413 ms, heap usage 215.042 MB -> 72.402 MB. [2025-08-27T20:02:10.287Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (745.843 ms) ====== [2025-08-27T20:02:10.287Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-08-27T20:02:10.287Z] GC before operation: completed in 60.661 ms, heap usage 407.265 MB -> 100.112 MB. [2025-08-27T20:02:11.041Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (698.230 ms) ====== [2025-08-27T20:02:11.041Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-08-27T20:02:11.041Z] GC before operation: completed in 63.872 ms, heap usage 149.144 MB -> 72.002 MB. [2025-08-27T20:02:11.836Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (742.695 ms) ====== [2025-08-27T20:02:11.836Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-08-27T20:02:11.836Z] GC before operation: completed in 80.233 ms, heap usage 497.129 MB -> 100.373 MB. [2025-08-27T20:02:12.586Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (718.544 ms) ====== [2025-08-27T20:02:12.586Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-08-27T20:02:12.944Z] GC before operation: completed in 52.062 ms, heap usage 137.333 MB -> 72.678 MB. [2025-08-27T20:02:13.707Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (717.105 ms) ====== [2025-08-27T20:02:13.707Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-08-27T20:02:13.707Z] GC before operation: completed in 64.334 ms, heap usage 336.725 MB -> 72.983 MB. [2025-08-27T20:02:14.459Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (707.510 ms) ====== [2025-08-27T20:02:14.459Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-08-27T20:02:14.459Z] GC before operation: completed in 71.213 ms, heap usage 300.629 MB -> 73.246 MB. [2025-08-27T20:02:15.218Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (716.666 ms) ====== [2025-08-27T20:02:15.218Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-08-27T20:02:15.218Z] GC before operation: completed in 59.928 ms, heap usage 272.841 MB -> 73.263 MB. [2025-08-27T20:02:15.986Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (764.014 ms) ====== [2025-08-27T20:02:15.986Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-08-27T20:02:15.986Z] GC before operation: completed in 69.525 ms, heap usage 119.551 MB -> 72.842 MB. [2025-08-27T20:02:16.758Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (736.537 ms) ====== [2025-08-27T20:02:16.758Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-08-27T20:02:16.758Z] GC before operation: completed in 60.416 ms, heap usage 448.073 MB -> 73.624 MB. [2025-08-27T20:02:17.535Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (738.998 ms) ====== [2025-08-27T20:02:17.535Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-08-27T20:02:17.535Z] GC before operation: completed in 51.358 ms, heap usage 291.235 MB -> 73.563 MB. [2025-08-27T20:02:18.297Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (707.672 ms) ====== [2025-08-27T20:02:18.297Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-08-27T20:02:18.297Z] GC before operation: completed in 62.700 ms, heap usage 279.669 MB -> 88.329 MB. [2025-08-27T20:02:19.074Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (736.008 ms) ====== [2025-08-27T20:02:19.074Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-08-27T20:02:19.074Z] GC before operation: completed in 60.167 ms, heap usage 128.921 MB -> 73.417 MB. [2025-08-27T20:02:19.834Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (743.420 ms) ====== [2025-08-27T20:02:19.834Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-08-27T20:02:19.834Z] GC before operation: completed in 72.105 ms, heap usage 323.321 MB -> 73.816 MB. [2025-08-27T20:02:20.598Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (698.121 ms) ====== [2025-08-27T20:02:20.598Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-08-27T20:02:20.598Z] GC before operation: completed in 55.533 ms, heap usage 280.436 MB -> 73.937 MB. [2025-08-27T20:02:21.350Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (697.954 ms) ====== [2025-08-27T20:02:21.350Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-08-27T20:02:21.350Z] GC before operation: completed in 76.543 ms, heap usage 279.312 MB -> 87.174 MB. [2025-08-27T20:02:22.109Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (738.864 ms) ====== [2025-08-27T20:02:22.109Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-08-27T20:02:22.109Z] GC before operation: completed in 65.206 ms, heap usage 232.696 MB -> 87.061 MB. [2025-08-27T20:02:22.898Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (701.234 ms) ====== [2025-08-27T20:02:22.898Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-08-27T20:02:22.898Z] GC before operation: completed in 60.539 ms, heap usage 192.188 MB -> 74.017 MB. [2025-08-27T20:02:23.663Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (697.968 ms) ====== [2025-08-27T20:02:23.664Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-08-27T20:02:23.664Z] GC before operation: completed in 75.523 ms, heap usage 220.132 MB -> 74.451 MB. [2025-08-27T20:02:24.415Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (731.681 ms) ====== [2025-08-27T20:02:24.768Z] ----------------------------------- [2025-08-27T20:02:24.768Z] renaissance-dec-tree_0_PASSED [2025-08-27T20:02:24.768Z] ----------------------------------- [2025-08-27T20:02:24.768Z] [2025-08-27T20:02:24.768Z] TEST TEARDOWN: [2025-08-27T20:02:24.768Z] Nothing to be done for teardown. [2025-08-27T20:02:24.768Z] renaissance-dec-tree_0 Finish Time: Wed Aug 27 16:02:24 2025 Epoch Time (ms): 1756324944475