[2025-02-12T21:39:49.682Z] Running test renaissance-dec-tree_0 ... [2025-02-12T21:39:49.682Z] =============================================== [2025-02-12T21:39:49.682Z] renaissance-dec-tree_0 Start Time: Wed Feb 12 16:39:49 2025 Epoch Time (ms): 1739396389361 [2025-02-12T21:39:49.682Z] variation: NoOptions [2025-02-12T21:39:49.682Z] JVM_OPTIONS: [2025-02-12T21:39:49.682Z] { \ [2025-02-12T21:39:49.682Z] echo ""; echo "TEST SETUP:"; \ [2025-02-12T21:39:49.682Z] echo "Nothing to be done for setup."; \ [2025-02-12T21:39:49.682Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17393962263427/renaissance-dec-tree_0"; \ [2025-02-12T21:39:49.682Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17393962263427/renaissance-dec-tree_0"; \ [2025-02-12T21:39:49.682Z] echo ""; echo "TESTING:"; \ [2025-02-12T21:39:49.682Z] "/Users/admin/workspace/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17393962263427/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-12T21:39:49.682Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17393962263427/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-12T21:39:49.682Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-12T21:39:49.682Z] echo "Nothing to be done for teardown."; \ [2025-02-12T21:39:49.682Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17393962263427/TestTargetResult"; [2025-02-12T21:39:49.682Z] [2025-02-12T21:39:49.682Z] TEST SETUP: [2025-02-12T21:39:49.682Z] Nothing to be done for setup. [2025-02-12T21:39:49.682Z] [2025-02-12T21:39:49.682Z] TESTING: [2025-02-12T21:39:52.102Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-12T21:39:52.884Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-02-12T21:39:55.320Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-12T21:39:55.320Z] GC before operation: completed in 29.033 ms, heap usage 41.497 MB -> 35.036 MB. [2025-02-12T21:40:00.449Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4868.196 ms) ====== [2025-02-12T21:40:00.449Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-12T21:40:00.449Z] GC before operation: completed in 52.093 ms, heap usage 129.132 MB -> 64.234 MB. [2025-02-12T21:40:01.238Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1447.318 ms) ====== [2025-02-12T21:40:01.238Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-12T21:40:01.238Z] GC before operation: completed in 43.739 ms, heap usage 174.732 MB -> 64.754 MB. [2025-02-12T21:40:02.581Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1223.014 ms) ====== [2025-02-12T21:40:02.581Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-12T21:40:02.581Z] GC before operation: completed in 40.480 ms, heap usage 303.895 MB -> 65.287 MB. [2025-02-12T21:40:03.860Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1106.431 ms) ====== [2025-02-12T21:40:03.860Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-12T21:40:03.860Z] GC before operation: completed in 42.284 ms, heap usage 216.323 MB -> 65.560 MB. [2025-02-12T21:40:04.704Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1034.147 ms) ====== [2025-02-12T21:40:04.704Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-12T21:40:04.704Z] GC before operation: completed in 49.886 ms, heap usage 167.834 MB -> 65.348 MB. [2025-02-12T21:40:05.971Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (979.812 ms) ====== [2025-02-12T21:40:05.971Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-12T21:40:05.971Z] GC before operation: completed in 47.187 ms, heap usage 259.076 MB -> 65.833 MB. [2025-02-12T21:40:06.780Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (970.232 ms) ====== [2025-02-12T21:40:06.780Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-12T21:40:06.780Z] GC before operation: completed in 45.619 ms, heap usage 115.181 MB -> 65.487 MB. [2025-02-12T21:40:08.037Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1016.764 ms) ====== [2025-02-12T21:40:08.037Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-12T21:40:08.037Z] GC before operation: completed in 48.703 ms, heap usage 182.164 MB -> 66.343 MB. [2025-02-12T21:40:08.853Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (957.990 ms) ====== [2025-02-12T21:40:08.853Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-12T21:40:08.853Z] GC before operation: completed in 59.056 ms, heap usage 238.027 MB -> 66.311 MB. [2025-02-12T21:40:10.132Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (929.771 ms) ====== [2025-02-12T21:40:10.132Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-12T21:40:10.132Z] GC before operation: completed in 51.946 ms, heap usage 253.393 MB -> 66.432 MB. [2025-02-12T21:40:10.924Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (880.644 ms) ====== [2025-02-12T21:40:10.924Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-12T21:40:10.924Z] GC before operation: completed in 46.717 ms, heap usage 338.599 MB -> 66.551 MB. [2025-02-12T21:40:11.700Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (900.754 ms) ====== [2025-02-12T21:40:11.700Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-12T21:40:11.700Z] GC before operation: completed in 44.351 ms, heap usage 325.394 MB -> 66.634 MB. [2025-02-12T21:40:12.958Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (889.629 ms) ====== [2025-02-12T21:40:12.958Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-12T21:40:12.958Z] GC before operation: completed in 51.445 ms, heap usage 309.681 MB -> 66.921 MB. [2025-02-12T21:40:13.801Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (853.628 ms) ====== [2025-02-12T21:40:13.801Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-12T21:40:13.801Z] GC before operation: completed in 58.616 ms, heap usage 211.300 MB -> 66.923 MB. [2025-02-12T21:40:14.593Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (931.038 ms) ====== [2025-02-12T21:40:14.593Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-12T21:40:14.593Z] GC before operation: completed in 58.559 ms, heap usage 338.406 MB -> 81.824 MB. [2025-02-12T21:40:15.372Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (782.439 ms) ====== [2025-02-12T21:40:15.372Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-12T21:40:15.372Z] GC before operation: completed in 62.322 ms, heap usage 323.971 MB -> 67.362 MB. [2025-02-12T21:40:16.623Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (829.144 ms) ====== [2025-02-12T21:40:16.623Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-12T21:40:16.623Z] GC before operation: completed in 57.251 ms, heap usage 199.521 MB -> 67.287 MB. [2025-02-12T21:40:17.404Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (844.311 ms) ====== [2025-02-12T21:40:17.404Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-12T21:40:17.404Z] GC before operation: completed in 69.826 ms, heap usage 213.538 MB -> 82.351 MB. [2025-02-12T21:40:18.174Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (883.033 ms) ====== [2025-02-12T21:40:18.174Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-12T21:40:18.174Z] GC before operation: completed in 61.850 ms, heap usage 212.775 MB -> 67.527 MB. [2025-02-12T21:40:18.963Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (835.420 ms) ====== [2025-02-12T21:40:18.963Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-12T21:40:19.333Z] GC before operation: completed in 61.158 ms, heap usage 210.120 MB -> 80.762 MB. [2025-02-12T21:40:20.113Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (825.131 ms) ====== [2025-02-12T21:40:20.113Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-12T21:40:20.113Z] GC before operation: completed in 60.808 ms, heap usage 332.120 MB -> 82.682 MB. [2025-02-12T21:40:20.921Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (855.693 ms) ====== [2025-02-12T21:40:20.921Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-12T21:40:20.921Z] GC before operation: completed in 66.809 ms, heap usage 319.201 MB -> 67.842 MB. [2025-02-12T21:40:21.693Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (784.292 ms) ====== [2025-02-12T21:40:21.693Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-12T21:40:21.693Z] GC before operation: completed in 57.871 ms, heap usage 200.689 MB -> 68.067 MB. [2025-02-12T21:40:22.480Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (828.418 ms) ====== [2025-02-12T21:40:22.480Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-12T21:40:22.847Z] GC before operation: completed in 59.804 ms, heap usage 294.411 MB -> 82.759 MB. [2025-02-12T21:40:23.675Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (790.010 ms) ====== [2025-02-12T21:40:23.675Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-12T21:40:23.675Z] GC before operation: completed in 58.633 ms, heap usage 295.556 MB -> 68.136 MB. [2025-02-12T21:40:24.450Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (808.025 ms) ====== [2025-02-12T21:40:24.450Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-12T21:40:24.450Z] GC before operation: completed in 59.810 ms, heap usage 191.829 MB -> 81.092 MB. [2025-02-12T21:40:25.249Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (834.240 ms) ====== [2025-02-12T21:40:25.250Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-12T21:40:25.250Z] GC before operation: completed in 63.264 ms, heap usage 343.499 MB -> 68.364 MB. [2025-02-12T21:40:26.019Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (775.174 ms) ====== [2025-02-12T21:40:26.019Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-12T21:40:26.019Z] GC before operation: completed in 63.919 ms, heap usage 171.840 MB -> 68.374 MB. [2025-02-12T21:40:26.796Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (798.063 ms) ====== [2025-02-12T21:40:26.796Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-12T21:40:27.162Z] GC before operation: completed in 55.444 ms, heap usage 258.944 MB -> 68.770 MB. [2025-02-12T21:40:27.933Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (808.662 ms) ====== [2025-02-12T21:40:27.933Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-12T21:40:27.933Z] GC before operation: completed in 69.837 ms, heap usage 202.635 MB -> 68.654 MB. [2025-02-12T21:40:28.703Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (845.400 ms) ====== [2025-02-12T21:40:28.703Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-12T21:40:28.703Z] GC before operation: completed in 62.714 ms, heap usage 310.178 MB -> 81.651 MB. [2025-02-12T21:40:29.495Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (809.233 ms) ====== [2025-02-12T21:40:29.495Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-12T21:40:29.495Z] GC before operation: completed in 63.151 ms, heap usage 295.484 MB -> 69.065 MB. [2025-02-12T21:40:30.261Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (668.788 ms) ====== [2025-02-12T21:40:30.261Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-12T21:40:30.261Z] GC before operation: completed in 40.281 ms, heap usage 198.058 MB -> 68.986 MB. [2025-02-12T21:40:31.046Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (553.927 ms) ====== [2025-02-12T21:40:31.046Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-12T21:40:31.046Z] GC before operation: completed in 43.795 ms, heap usage 189.153 MB -> 69.109 MB. [2025-02-12T21:40:31.823Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (816.720 ms) ====== [2025-02-12T21:40:31.823Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-12T21:40:31.823Z] GC before operation: completed in 64.953 ms, heap usage 186.589 MB -> 84.182 MB. [2025-02-12T21:40:32.612Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (790.038 ms) ====== [2025-02-12T21:40:32.612Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-12T21:40:32.612Z] GC before operation: completed in 68.857 ms, heap usage 295.644 MB -> 82.470 MB. [2025-02-12T21:40:33.399Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (778.549 ms) ====== [2025-02-12T21:40:33.399Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-12T21:40:33.399Z] GC before operation: completed in 63.218 ms, heap usage 306.277 MB -> 69.438 MB. [2025-02-12T21:40:34.220Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (763.888 ms) ====== [2025-02-12T21:40:34.220Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-12T21:40:34.220Z] GC before operation: completed in 66.527 ms, heap usage 197.300 MB -> 69.554 MB. [2025-02-12T21:40:35.465Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (789.859 ms) ====== [2025-02-12T21:40:35.465Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-12T21:40:35.465Z] GC before operation: completed in 61.379 ms, heap usage 407.940 MB -> 69.652 MB. [2025-02-12T21:40:36.234Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (785.955 ms) ====== [2025-02-12T21:40:36.234Z] ----------------------------------- [2025-02-12T21:40:36.234Z] renaissance-dec-tree_0_PASSED [2025-02-12T21:40:36.234Z] ----------------------------------- [2025-02-12T21:40:36.234Z] [2025-02-12T21:40:36.234Z] TEST TEARDOWN: [2025-02-12T21:40:36.234Z] Nothing to be done for teardown. [2025-02-12T21:40:36.234Z] renaissance-dec-tree_0 Finish Time: Wed Feb 12 16:40:35 2025 Epoch Time (ms): 1739396435994