[2025-06-26T16:39:55.576Z] Running test renaissance-dec-tree_0 ... [2025-06-26T16:39:55.576Z] =============================================== [2025-06-26T16:39:55.576Z] renaissance-dec-tree_0 Start Time: Thu Jun 26 12:39:54 2025 Epoch Time (ms): 1750955994794 [2025-06-26T16:39:55.576Z] variation: NoOptions [2025-06-26T16:39:55.576Z] JVM_OPTIONS: [2025-06-26T16:39:55.576Z] { \ [2025-06-26T16:39:55.576Z] echo ""; echo "TEST SETUP:"; \ [2025-06-26T16:39:55.576Z] echo "Nothing to be done for setup."; \ [2025-06-26T16:39:55.576Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17509557086572/renaissance-dec-tree_0"; \ [2025-06-26T16:39:55.576Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17509557086572/renaissance-dec-tree_0"; \ [2025-06-26T16:39:55.576Z] echo ""; echo "TESTING:"; \ [2025-06-26T16:39:55.576Z] "/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_17509557086572/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-06-26T16:39:55.576Z] 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_17509557086572/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-26T16:39:55.576Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-26T16:39:55.576Z] echo "Nothing to be done for teardown."; \ [2025-06-26T16:39:55.576Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17509557086572/TestTargetResult"; [2025-06-26T16:39:55.576Z] [2025-06-26T16:39:55.576Z] TEST SETUP: [2025-06-26T16:39:55.576Z] Nothing to be done for setup. [2025-06-26T16:39:55.576Z] [2025-06-26T16:39:55.576Z] TESTING: [2025-06-26T16:39:58.739Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-06-26T16:40:01.474Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-06-26T16:40:01.474Z] GC before operation: completed in 36.467 ms, heap usage 67.279 MB -> 35.209 MB. [2025-06-26T16:40:06.571Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5824.548 ms) ====== [2025-06-26T16:40:06.571Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-06-26T16:40:06.571Z] GC before operation: completed in 66.700 ms, heap usage 156.389 MB -> 68.858 MB. [2025-06-26T16:40:07.384Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1306.847 ms) ====== [2025-06-26T16:40:07.384Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-06-26T16:40:07.741Z] GC before operation: completed in 68.524 ms, heap usage 321.652 MB -> 69.539 MB. [2025-06-26T16:40:09.050Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1118.254 ms) ====== [2025-06-26T16:40:09.050Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-06-26T16:40:09.050Z] GC before operation: completed in 52.657 ms, heap usage 254.539 MB -> 69.652 MB. [2025-06-26T16:40:09.883Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1139.670 ms) ====== [2025-06-26T16:40:09.883Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-06-26T16:40:09.883Z] GC before operation: completed in 69.766 ms, heap usage 251.908 MB -> 70.004 MB. [2025-06-26T16:40:11.130Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1047.016 ms) ====== [2025-06-26T16:40:11.130Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-06-26T16:40:11.130Z] GC before operation: completed in 61.816 ms, heap usage 244.212 MB -> 70.099 MB. [2025-06-26T16:40:12.407Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1042.296 ms) ====== [2025-06-26T16:40:12.407Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-06-26T16:40:12.407Z] GC before operation: completed in 64.883 ms, heap usage 353.603 MB -> 70.324 MB. [2025-06-26T16:40:13.191Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1007.118 ms) ====== [2025-06-26T16:40:13.191Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-06-26T16:40:13.191Z] GC before operation: completed in 67.739 ms, heap usage 161.263 MB -> 70.271 MB. [2025-06-26T16:40:14.463Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (941.988 ms) ====== [2025-06-26T16:40:14.463Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-06-26T16:40:14.463Z] GC before operation: completed in 68.269 ms, heap usage 241.584 MB -> 70.881 MB. [2025-06-26T16:40:15.245Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (962.885 ms) ====== [2025-06-26T16:40:15.245Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-06-26T16:40:15.245Z] GC before operation: completed in 70.643 ms, heap usage 352.124 MB -> 70.981 MB. [2025-06-26T16:40:16.518Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (959.469 ms) ====== [2025-06-26T16:40:16.518Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-06-26T16:40:16.518Z] GC before operation: completed in 61.056 ms, heap usage 242.203 MB -> 98.372 MB. [2025-06-26T16:40:17.309Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (936.467 ms) ====== [2025-06-26T16:40:17.309Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-06-26T16:40:17.309Z] GC before operation: completed in 74.821 ms, heap usage 290.866 MB -> 71.162 MB. [2025-06-26T16:40:18.555Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (969.486 ms) ====== [2025-06-26T16:40:18.555Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-06-26T16:40:18.555Z] GC before operation: completed in 66.982 ms, heap usage 127.969 MB -> 70.793 MB. [2025-06-26T16:40:19.317Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (917.376 ms) ====== [2025-06-26T16:40:19.317Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-06-26T16:40:19.317Z] GC before operation: completed in 68.364 ms, heap usage 448.812 MB -> 71.460 MB. [2025-06-26T16:40:20.573Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (932.204 ms) ====== [2025-06-26T16:40:20.573Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-06-26T16:40:20.573Z] GC before operation: completed in 70.621 ms, heap usage 293.087 MB -> 71.545 MB. [2025-06-26T16:40:21.338Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (917.897 ms) ====== [2025-06-26T16:40:21.338Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-06-26T16:40:21.338Z] GC before operation: completed in 61.183 ms, heap usage 353.716 MB -> 71.674 MB. [2025-06-26T16:40:22.120Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (859.691 ms) ====== [2025-06-26T16:40:22.120Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-06-26T16:40:22.476Z] GC before operation: completed in 78.122 ms, heap usage 359.191 MB -> 71.800 MB. [2025-06-26T16:40:23.242Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (896.529 ms) ====== [2025-06-26T16:40:23.242Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-06-26T16:40:23.242Z] GC before operation: completed in 73.404 ms, heap usage 216.803 MB -> 97.699 MB. [2025-06-26T16:40:24.043Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (893.258 ms) ====== [2025-06-26T16:40:24.043Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-06-26T16:40:24.400Z] GC before operation: completed in 80.358 ms, heap usage 288.781 MB -> 72.085 MB. [2025-06-26T16:40:25.176Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (925.490 ms) ====== [2025-06-26T16:40:25.176Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-06-26T16:40:25.176Z] GC before operation: completed in 59.624 ms, heap usage 215.091 MB -> 84.950 MB. [2025-06-26T16:40:26.464Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (920.681 ms) ====== [2025-06-26T16:40:26.464Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-06-26T16:40:26.464Z] GC before operation: completed in 133.125 ms, heap usage 131.872 MB -> 84.621 MB. [2025-06-26T16:40:27.244Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (860.681 ms) ====== [2025-06-26T16:40:27.244Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-06-26T16:40:27.244Z] GC before operation: completed in 71.195 ms, heap usage 302.068 MB -> 86.973 MB. [2025-06-26T16:40:28.023Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (941.254 ms) ====== [2025-06-26T16:40:28.023Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-06-26T16:40:28.411Z] GC before operation: completed in 76.412 ms, heap usage 408.123 MB -> 72.542 MB. [2025-06-26T16:40:29.193Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (924.034 ms) ====== [2025-06-26T16:40:29.193Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-06-26T16:40:29.193Z] GC before operation: completed in 68.772 ms, heap usage 340.375 MB -> 72.742 MB. [2025-06-26T16:40:29.957Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (858.928 ms) ====== [2025-06-26T16:40:29.957Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-06-26T16:40:30.441Z] GC before operation: completed in 77.189 ms, heap usage 331.201 MB -> 72.829 MB. [2025-06-26T16:40:31.220Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (869.308 ms) ====== [2025-06-26T16:40:31.220Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-06-26T16:40:31.220Z] GC before operation: completed in 81.109 ms, heap usage 362.966 MB -> 87.448 MB. [2025-06-26T16:40:32.023Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (915.660 ms) ====== [2025-06-26T16:40:32.023Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-06-26T16:40:32.023Z] GC before operation: completed in 107.985 ms, heap usage 159.505 MB -> 72.582 MB. [2025-06-26T16:40:33.256Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (931.960 ms) ====== [2025-06-26T16:40:33.256Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-06-26T16:40:33.256Z] GC before operation: completed in 73.002 ms, heap usage 106.683 MB -> 72.819 MB. [2025-06-26T16:40:34.054Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (927.825 ms) ====== [2025-06-26T16:40:34.054Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-06-26T16:40:34.054Z] GC before operation: completed in 80.624 ms, heap usage 511.916 MB -> 73.476 MB. [2025-06-26T16:40:35.355Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (939.084 ms) ====== [2025-06-26T16:40:35.355Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-06-26T16:40:35.355Z] GC before operation: completed in 76.683 ms, heap usage 300.138 MB -> 73.360 MB. [2025-06-26T16:40:36.184Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (906.575 ms) ====== [2025-06-26T16:40:36.185Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-06-26T16:40:36.185Z] GC before operation: completed in 88.122 ms, heap usage 338.015 MB -> 73.351 MB. [2025-06-26T16:40:37.451Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (960.847 ms) ====== [2025-06-26T16:40:37.451Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-06-26T16:40:37.451Z] GC before operation: completed in 74.886 ms, heap usage 348.248 MB -> 88.379 MB. [2025-06-26T16:40:38.237Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (936.289 ms) ====== [2025-06-26T16:40:38.237Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-06-26T16:40:38.237Z] GC before operation: completed in 84.394 ms, heap usage 252.991 MB -> 88.474 MB. [2025-06-26T16:40:39.017Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (855.801 ms) ====== [2025-06-26T16:40:39.017Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-06-26T16:40:39.017Z] GC before operation: completed in 76.748 ms, heap usage 234.023 MB -> 73.704 MB. [2025-06-26T16:40:40.272Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (920.407 ms) ====== [2025-06-26T16:40:40.272Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-06-26T16:40:40.272Z] GC before operation: completed in 105.353 ms, heap usage 114.782 MB -> 73.147 MB. [2025-06-26T16:40:41.050Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (871.932 ms) ====== [2025-06-26T16:40:41.050Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-06-26T16:40:41.050Z] GC before operation: completed in 73.229 ms, heap usage 505.010 MB -> 87.235 MB. [2025-06-26T16:40:41.826Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (837.648 ms) ====== [2025-06-26T16:40:41.826Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-06-26T16:40:42.204Z] GC before operation: completed in 82.295 ms, heap usage 251.254 MB -> 99.835 MB. [2025-06-26T16:40:43.003Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (895.221 ms) ====== [2025-06-26T16:40:43.003Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-06-26T16:40:43.003Z] GC before operation: completed in 90.010 ms, heap usage 220.630 MB -> 86.503 MB. [2025-06-26T16:40:43.789Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (863.111 ms) ====== [2025-06-26T16:40:43.789Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-06-26T16:40:44.185Z] GC before operation: completed in 99.763 ms, heap usage 419.736 MB -> 74.196 MB. [2025-06-26T16:40:44.953Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (870.966 ms) ====== [2025-06-26T16:40:44.953Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-06-26T16:40:44.953Z] GC before operation: completed in 80.972 ms, heap usage 326.987 MB -> 74.318 MB. [2025-06-26T16:40:45.726Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (853.664 ms) ====== [2025-06-26T16:40:46.089Z] ----------------------------------- [2025-06-26T16:40:46.089Z] renaissance-dec-tree_0_PASSED [2025-06-26T16:40:46.089Z] ----------------------------------- [2025-06-26T16:40:46.089Z] [2025-06-26T16:40:46.089Z] TEST TEARDOWN: [2025-06-26T16:40:46.089Z] Nothing to be done for teardown. [2025-06-26T16:40:46.089Z] renaissance-dec-tree_0 Finish Time: Thu Jun 26 12:40:45 2025 Epoch Time (ms): 1750956045795