[2025-11-12T22:48:45.287Z] Running test renaissance-dec-tree_0 ... [2025-11-12T22:48:45.287Z] =============================================== [2025-11-12T22:48:45.287Z] renaissance-dec-tree_0 Start Time: Wed Nov 12 17:48:44 2025 Epoch Time (ms): 1762987724692 [2025-11-12T22:48:45.287Z] variation: NoOptions [2025-11-12T22:48:45.287Z] JVM_OPTIONS: [2025-11-12T22:48:45.287Z] { \ [2025-11-12T22:48:45.287Z] echo ""; echo "TEST SETUP:"; \ [2025-11-12T22:48:45.287Z] echo "Nothing to be done for setup."; \ [2025-11-12T22:48:45.287Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17629875435339/renaissance-dec-tree_0"; \ [2025-11-12T22:48:45.287Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17629875435339/renaissance-dec-tree_0"; \ [2025-11-12T22:48:45.287Z] echo ""; echo "TESTING:"; \ [2025-11-12T22:48:45.287Z] "/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_17629875435339/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-12T22:48:45.287Z] 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_17629875435339/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-12T22:48:45.287Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-12T22:48:45.287Z] echo "Nothing to be done for teardown."; \ [2025-11-12T22:48:45.287Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17629875435339/TestTargetResult"; [2025-11-12T22:48:45.287Z] [2025-11-12T22:48:45.287Z] TEST SETUP: [2025-11-12T22:48:45.287Z] Nothing to be done for setup. [2025-11-12T22:48:45.287Z] [2025-11-12T22:48:45.287Z] TESTING: [2025-11-12T22:48:47.660Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-12T22:48:48.407Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-12T22:48:48.407Z] GC before operation: completed in 21.131 ms, heap usage 56.771 MB -> 35.380 MB. [2025-11-12T22:48:52.349Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (3481.124 ms) ====== [2025-11-12T22:48:52.349Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-12T22:48:52.349Z] GC before operation: completed in 39.563 ms, heap usage 297.613 MB -> 69.550 MB. [2025-11-12T22:48:52.705Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (795.514 ms) ====== [2025-11-12T22:48:52.705Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-12T22:48:53.059Z] GC before operation: completed in 45.087 ms, heap usage 149.634 MB -> 69.447 MB. [2025-11-12T22:48:53.422Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (654.352 ms) ====== [2025-11-12T22:48:53.422Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-12T22:48:53.422Z] GC before operation: completed in 45.334 ms, heap usage 237.947 MB -> 70.026 MB. [2025-11-12T22:48:54.187Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (620.889 ms) ====== [2025-11-12T22:48:54.187Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-12T22:48:54.187Z] GC before operation: completed in 32.494 ms, heap usage 117.698 MB -> 69.622 MB. [2025-11-12T22:48:54.945Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (566.040 ms) ====== [2025-11-12T22:48:54.945Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-12T22:48:54.945Z] GC before operation: completed in 35.664 ms, heap usage 242.498 MB -> 70.463 MB. [2025-11-12T22:48:55.299Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (552.142 ms) ====== [2025-11-12T22:48:55.299Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-12T22:48:55.299Z] GC before operation: completed in 35.107 ms, heap usage 291.727 MB -> 70.691 MB. [2025-11-12T22:48:56.045Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (564.292 ms) ====== [2025-11-12T22:48:56.045Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-12T22:48:56.045Z] GC before operation: completed in 36.245 ms, heap usage 116.191 MB -> 70.287 MB. [2025-11-12T22:48:56.799Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (551.275 ms) ====== [2025-11-12T22:48:56.799Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-12T22:48:56.799Z] GC before operation: completed in 37.885 ms, heap usage 460.190 MB -> 71.047 MB. [2025-11-12T22:48:57.148Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (563.578 ms) ====== [2025-11-12T22:48:57.148Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-12T22:48:57.148Z] GC before operation: completed in 36.966 ms, heap usage 310.294 MB -> 71.186 MB. [2025-11-12T22:48:57.942Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (529.883 ms) ====== [2025-11-12T22:48:57.942Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-12T22:48:57.942Z] GC before operation: completed in 37.072 ms, heap usage 116.556 MB -> 70.686 MB. [2025-11-12T22:48:58.293Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (533.939 ms) ====== [2025-11-12T22:48:58.293Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-12T22:48:58.293Z] GC before operation: completed in 40.053 ms, heap usage 212.938 MB -> 71.468 MB. [2025-11-12T22:48:59.043Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (518.253 ms) ====== [2025-11-12T22:48:59.043Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-12T22:48:59.043Z] GC before operation: completed in 40.224 ms, heap usage 270.966 MB -> 71.721 MB. [2025-11-12T22:48:59.392Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (518.526 ms) ====== [2025-11-12T22:48:59.392Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-12T22:48:59.392Z] GC before operation: completed in 41.341 ms, heap usage 401.768 MB -> 71.844 MB. [2025-11-12T22:49:00.147Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (526.449 ms) ====== [2025-11-12T22:49:00.147Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-12T22:49:00.147Z] GC before operation: completed in 41.673 ms, heap usage 401.476 MB -> 72.010 MB. [2025-11-12T22:49:00.505Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (533.321 ms) ====== [2025-11-12T22:49:00.505Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-12T22:49:00.505Z] GC before operation: completed in 40.953 ms, heap usage 399.836 MB -> 71.955 MB. [2025-11-12T22:49:01.275Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (522.405 ms) ====== [2025-11-12T22:49:01.275Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-12T22:49:01.275Z] GC before operation: completed in 43.161 ms, heap usage 399.844 MB -> 72.068 MB. [2025-11-12T22:49:01.631Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (522.615 ms) ====== [2025-11-12T22:49:01.631Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-12T22:49:01.631Z] GC before operation: completed in 44.547 ms, heap usage 398.934 MB -> 72.195 MB. [2025-11-12T22:49:02.404Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (521.254 ms) ====== [2025-11-12T22:49:02.404Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-12T22:49:02.404Z] GC before operation: completed in 44.425 ms, heap usage 399.814 MB -> 83.202 MB. [2025-11-12T22:49:02.765Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (533.973 ms) ====== [2025-11-12T22:49:02.765Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-12T22:49:02.765Z] GC before operation: completed in 44.067 ms, heap usage 228.188 MB -> 72.406 MB. [2025-11-12T22:49:03.536Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (518.579 ms) ====== [2025-11-12T22:49:03.536Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-12T22:49:03.536Z] GC before operation: completed in 44.982 ms, heap usage 228.997 MB -> 72.519 MB. [2025-11-12T22:49:03.888Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (514.677 ms) ====== [2025-11-12T22:49:03.889Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-12T22:49:03.889Z] GC before operation: completed in 42.579 ms, heap usage 365.633 MB -> 72.631 MB. [2025-11-12T22:49:04.644Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (519.737 ms) ====== [2025-11-12T22:49:04.644Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-12T22:49:04.644Z] GC before operation: completed in 44.083 ms, heap usage 400.238 MB -> 72.767 MB. [2025-11-12T22:49:04.997Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (505.865 ms) ====== [2025-11-12T22:49:04.997Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-12T22:49:04.997Z] GC before operation: completed in 47.237 ms, heap usage 387.388 MB -> 72.889 MB. [2025-11-12T22:49:05.748Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (503.467 ms) ====== [2025-11-12T22:49:05.748Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-12T22:49:05.748Z] GC before operation: completed in 45.277 ms, heap usage 387.889 MB -> 73.009 MB. [2025-11-12T22:49:06.100Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (499.790 ms) ====== [2025-11-12T22:49:06.100Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-12T22:49:06.100Z] GC before operation: completed in 45.816 ms, heap usage 386.625 MB -> 73.075 MB. [2025-11-12T22:49:06.853Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (519.254 ms) ====== [2025-11-12T22:49:06.853Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-12T22:49:06.853Z] GC before operation: completed in 46.284 ms, heap usage 271.699 MB -> 73.192 MB. [2025-11-12T22:49:07.203Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (507.773 ms) ====== [2025-11-12T22:49:07.203Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-12T22:49:07.203Z] GC before operation: completed in 46.143 ms, heap usage 386.644 MB -> 73.344 MB. [2025-11-12T22:49:07.960Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (519.547 ms) ====== [2025-11-12T22:49:07.960Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-12T22:49:07.960Z] GC before operation: completed in 47.794 ms, heap usage 399.893 MB -> 73.465 MB. [2025-11-12T22:49:08.314Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (512.181 ms) ====== [2025-11-12T22:49:08.314Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-12T22:49:08.664Z] GC before operation: completed in 47.402 ms, heap usage 387.786 MB -> 73.459 MB. [2025-11-12T22:49:09.014Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (500.859 ms) ====== [2025-11-12T22:49:09.014Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-12T22:49:09.014Z] GC before operation: completed in 45.947 ms, heap usage 387.719 MB -> 73.575 MB. [2025-11-12T22:49:09.367Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (495.663 ms) ====== [2025-11-12T22:49:09.367Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-12T22:49:09.716Z] GC before operation: completed in 46.317 ms, heap usage 375.180 MB -> 73.690 MB. [2025-11-12T22:49:10.065Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (512.466 ms) ====== [2025-11-12T22:49:10.065Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-12T22:49:10.066Z] GC before operation: completed in 47.560 ms, heap usage 377.003 MB -> 73.827 MB. [2025-11-12T22:49:10.815Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (499.575 ms) ====== [2025-11-12T22:49:10.815Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-12T22:49:10.815Z] GC before operation: completed in 47.342 ms, heap usage 241.836 MB -> 73.944 MB. [2025-11-12T22:49:11.191Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (503.322 ms) ====== [2025-11-12T22:49:11.191Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-12T22:49:11.191Z] GC before operation: completed in 47.239 ms, heap usage 349.578 MB -> 74.202 MB. [2025-11-12T22:49:11.947Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (513.933 ms) ====== [2025-11-12T22:49:11.947Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-12T22:49:11.947Z] GC before operation: completed in 47.996 ms, heap usage 228.826 MB -> 74.188 MB. [2025-11-12T22:49:12.300Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (509.658 ms) ====== [2025-11-12T22:49:12.300Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-12T22:49:12.300Z] GC before operation: completed in 49.151 ms, heap usage 339.792 MB -> 74.261 MB. [2025-11-12T22:49:13.056Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (514.114 ms) ====== [2025-11-12T22:49:13.056Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-12T22:49:13.056Z] GC before operation: completed in 49.677 ms, heap usage 364.098 MB -> 74.508 MB. [2025-11-12T22:49:13.408Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (491.506 ms) ====== [2025-11-12T22:49:13.408Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-12T22:49:13.408Z] GC before operation: completed in 51.596 ms, heap usage 364.114 MB -> 74.495 MB. [2025-11-12T22:49:14.156Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (497.621 ms) ====== [2025-11-12T22:49:14.156Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-12T22:49:14.156Z] GC before operation: completed in 51.071 ms, heap usage 229.519 MB -> 74.701 MB. [2025-11-12T22:49:14.506Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (489.607 ms) ====== [2025-11-12T22:49:14.506Z] ----------------------------------- [2025-11-12T22:49:14.506Z] renaissance-dec-tree_0_PASSED [2025-11-12T22:49:14.506Z] ----------------------------------- [2025-11-12T22:49:14.506Z] [2025-11-12T22:49:14.506Z] TEST TEARDOWN: [2025-11-12T22:49:14.506Z] Nothing to be done for teardown. [2025-11-12T22:49:14.506Z] renaissance-dec-tree_0 Finish Time: Wed Nov 12 17:49:14 2025 Epoch Time (ms): 1762987754406