[2025-02-05T21:25:14.717Z] Running test renaissance-dec-tree_0 ... [2025-02-05T21:25:14.717Z] =============================================== [2025-02-05T21:25:14.717Z] renaissance-dec-tree_0 Start Time: Wed Feb 5 16:25:14 2025 Epoch Time (ms): 1738790714199 [2025-02-05T21:25:14.717Z] variation: NoOptions [2025-02-05T21:25:14.717Z] JVM_OPTIONS: [2025-02-05T21:25:14.717Z] { \ [2025-02-05T21:25:14.717Z] echo ""; echo "TEST SETUP:"; \ [2025-02-05T21:25:14.717Z] echo "Nothing to be done for setup."; \ [2025-02-05T21:25:14.717Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387905668889/renaissance-dec-tree_0"; \ [2025-02-05T21:25:14.717Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387905668889/renaissance-dec-tree_0"; \ [2025-02-05T21:25:14.717Z] echo ""; echo "TESTING:"; \ [2025-02-05T21:25:14.717Z] "/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_17387905668889/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-05T21:25:14.717Z] 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_17387905668889/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-05T21:25:14.717Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-05T21:25:14.717Z] echo "Nothing to be done for teardown."; \ [2025-02-05T21:25:14.717Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387905668889/TestTargetResult"; [2025-02-05T21:25:14.717Z] [2025-02-05T21:25:14.717Z] TEST SETUP: [2025-02-05T21:25:14.717Z] Nothing to be done for setup. [2025-02-05T21:25:14.717Z] [2025-02-05T21:25:14.717Z] TESTING: [2025-02-05T21:25:16.080Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-05T21:25:16.925Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-02-05T21:25:18.950Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-05T21:25:18.950Z] GC before operation: completed in 29.054 ms, heap usage 50.762 MB -> 35.166 MB. [2025-02-05T21:25:22.342Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (3911.043 ms) ====== [2025-02-05T21:25:22.342Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-05T21:25:22.342Z] GC before operation: completed in 38.422 ms, heap usage 111.420 MB -> 64.403 MB. [2025-02-05T21:25:23.786Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (996.617 ms) ====== [2025-02-05T21:25:23.786Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-05T21:25:23.786Z] GC before operation: completed in 29.123 ms, heap usage 336.335 MB -> 64.913 MB. [2025-02-05T21:25:24.976Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (835.554 ms) ====== [2025-02-05T21:25:24.976Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-05T21:25:24.976Z] GC before operation: completed in 39.528 ms, heap usage 226.325 MB -> 65.336 MB. [2025-02-05T21:25:24.976Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (801.444 ms) ====== [2025-02-05T21:25:24.976Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-05T21:25:25.381Z] GC before operation: completed in 45.191 ms, heap usage 287.725 MB -> 65.438 MB. [2025-02-05T21:25:25.783Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (741.466 ms) ====== [2025-02-05T21:25:25.783Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-05T21:25:26.182Z] GC before operation: completed in 40.110 ms, heap usage 174.263 MB -> 65.397 MB. [2025-02-05T21:25:26.576Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (692.376 ms) ====== [2025-02-05T21:25:26.576Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-05T21:25:26.576Z] GC before operation: completed in 32.216 ms, heap usage 246.455 MB -> 66.054 MB. [2025-02-05T21:25:27.433Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (750.548 ms) ====== [2025-02-05T21:25:27.433Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-05T21:25:27.433Z] GC before operation: completed in 51.921 ms, heap usage 248.143 MB -> 93.805 MB. [2025-02-05T21:25:28.466Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (708.909 ms) ====== [2025-02-05T21:25:28.466Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-05T21:25:28.466Z] GC before operation: completed in 33.106 ms, heap usage 166.891 MB -> 66.080 MB. [2025-02-05T21:25:28.879Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (697.011 ms) ====== [2025-02-05T21:25:28.879Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-05T21:25:28.879Z] GC before operation: completed in 34.343 ms, heap usage 342.188 MB -> 66.361 MB. [2025-02-05T21:25:29.764Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (717.651 ms) ====== [2025-02-05T21:25:29.764Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-05T21:25:29.764Z] GC before operation: completed in 37.188 ms, heap usage 249.394 MB -> 66.446 MB. [2025-02-05T21:25:30.652Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (742.341 ms) ====== [2025-02-05T21:25:30.652Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-05T21:25:30.652Z] GC before operation: completed in 38.498 ms, heap usage 258.841 MB -> 66.668 MB. [2025-02-05T21:25:31.057Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (681.313 ms) ====== [2025-02-05T21:25:31.057Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-05T21:25:31.474Z] GC before operation: completed in 56.785 ms, heap usage 221.517 MB -> 66.643 MB. [2025-02-05T21:25:31.881Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (704.267 ms) ====== [2025-02-05T21:25:31.881Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-05T21:25:31.881Z] GC before operation: completed in 36.349 ms, heap usage 333.684 MB -> 66.795 MB. [2025-02-05T21:25:32.895Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (665.589 ms) ====== [2025-02-05T21:25:32.895Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-05T21:25:32.895Z] GC before operation: completed in 49.103 ms, heap usage 300.227 MB -> 66.941 MB. [2025-02-05T21:25:33.297Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (643.541 ms) ====== [2025-02-05T21:25:33.297Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-05T21:25:33.297Z] GC before operation: completed in 38.613 ms, heap usage 221.820 MB -> 67.076 MB. [2025-02-05T21:25:34.152Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (638.053 ms) ====== [2025-02-05T21:25:34.152Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-05T21:25:34.152Z] GC before operation: completed in 51.898 ms, heap usage 333.542 MB -> 67.426 MB. [2025-02-05T21:25:34.558Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (586.302 ms) ====== [2025-02-05T21:25:34.558Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-05T21:25:34.558Z] GC before operation: completed in 36.014 ms, heap usage 321.060 MB -> 67.360 MB. [2025-02-05T21:25:35.450Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (612.065 ms) ====== [2025-02-05T21:25:35.450Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-05T21:25:35.450Z] GC before operation: completed in 36.694 ms, heap usage 195.581 MB -> 67.505 MB. [2025-02-05T21:25:36.305Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (703.085 ms) ====== [2025-02-05T21:25:36.305Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-05T21:25:36.305Z] GC before operation: completed in 38.386 ms, heap usage 424.046 MB -> 80.732 MB. [2025-02-05T21:25:36.719Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (589.167 ms) ====== [2025-02-05T21:25:36.719Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-05T21:25:36.719Z] GC before operation: completed in 52.176 ms, heap usage 333.769 MB -> 67.904 MB. [2025-02-05T21:25:37.844Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (625.851 ms) ====== [2025-02-05T21:25:37.844Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-05T21:25:37.844Z] GC before operation: completed in 38.424 ms, heap usage 194.225 MB -> 67.727 MB. [2025-02-05T21:25:38.523Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (631.072 ms) ====== [2025-02-05T21:25:38.523Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-05T21:25:38.523Z] GC before operation: completed in 54.059 ms, heap usage 328.022 MB -> 95.478 MB. [2025-02-05T21:25:38.934Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (660.786 ms) ====== [2025-02-05T21:25:38.934Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-05T21:25:38.934Z] GC before operation: completed in 42.254 ms, heap usage 289.200 MB -> 68.071 MB. [2025-02-05T21:25:39.328Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (681.027 ms) ====== [2025-02-05T21:25:39.328Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-05T21:25:39.328Z] GC before operation: completed in 39.305 ms, heap usage 237.575 MB -> 68.064 MB. [2025-02-05T21:25:40.208Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (632.210 ms) ====== [2025-02-05T21:25:40.208Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-05T21:25:40.208Z] GC before operation: completed in 40.206 ms, heap usage 212.582 MB -> 68.342 MB. [2025-02-05T21:25:41.215Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (643.270 ms) ====== [2025-02-05T21:25:41.215Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-05T21:25:41.215Z] GC before operation: completed in 41.784 ms, heap usage 227.516 MB -> 68.248 MB. [2025-02-05T21:25:41.622Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (654.278 ms) ====== [2025-02-05T21:25:41.623Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-05T21:25:41.623Z] GC before operation: completed in 41.470 ms, heap usage 214.436 MB -> 68.316 MB. [2025-02-05T21:25:42.016Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (629.901 ms) ====== [2025-02-05T21:25:42.016Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-05T21:25:42.460Z] GC before operation: completed in 41.802 ms, heap usage 213.500 MB -> 68.391 MB. [2025-02-05T21:25:42.874Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (581.165 ms) ====== [2025-02-05T21:25:42.874Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-05T21:25:42.874Z] GC before operation: completed in 53.122 ms, heap usage 207.468 MB -> 68.872 MB. [2025-02-05T21:25:43.730Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (617.244 ms) ====== [2025-02-05T21:25:43.730Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-05T21:25:43.730Z] GC before operation: completed in 58.171 ms, heap usage 191.290 MB -> 69.036 MB. [2025-02-05T21:25:44.145Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (561.522 ms) ====== [2025-02-05T21:25:44.145Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-05T21:25:44.145Z] GC before operation: completed in 47.865 ms, heap usage 190.180 MB -> 68.811 MB. [2025-02-05T21:25:45.012Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (586.320 ms) ====== [2025-02-05T21:25:45.012Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-05T21:25:45.012Z] GC before operation: completed in 39.982 ms, heap usage 185.512 MB -> 69.076 MB. [2025-02-05T21:25:45.423Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (629.252 ms) ====== [2025-02-05T21:25:45.423Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-05T21:25:45.423Z] GC before operation: completed in 41.487 ms, heap usage 148.755 MB -> 68.740 MB. [2025-02-05T21:25:46.271Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (604.172 ms) ====== [2025-02-05T21:25:46.271Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-05T21:25:46.271Z] GC before operation: completed in 49.042 ms, heap usage 415.966 MB -> 84.058 MB. [2025-02-05T21:25:46.677Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (636.920 ms) ====== [2025-02-05T21:25:46.677Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-05T21:25:46.677Z] GC before operation: completed in 41.017 ms, heap usage 228.309 MB -> 69.263 MB. [2025-02-05T21:25:47.534Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (624.641 ms) ====== [2025-02-05T21:25:47.534Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-05T21:25:47.534Z] GC before operation: completed in 58.600 ms, heap usage 364.012 MB -> 96.911 MB. [2025-02-05T21:25:47.929Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (600.393 ms) ====== [2025-02-05T21:25:47.929Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-05T21:25:48.321Z] GC before operation: completed in 51.403 ms, heap usage 263.599 MB -> 69.576 MB. [2025-02-05T21:25:48.718Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (624.587 ms) ====== [2025-02-05T21:25:48.718Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-05T21:25:48.718Z] GC before operation: completed in 48.024 ms, heap usage 337.578 MB -> 84.235 MB. [2025-02-05T21:25:49.585Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (641.589 ms) ====== [2025-02-05T21:25:49.585Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-05T21:25:49.585Z] GC before operation: completed in 45.550 ms, heap usage 287.470 MB -> 69.755 MB. [2025-02-05T21:25:49.984Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (633.316 ms) ====== [2025-02-05T21:25:50.391Z] ----------------------------------- [2025-02-05T21:25:50.391Z] renaissance-dec-tree_0_PASSED [2025-02-05T21:25:50.391Z] ----------------------------------- [2025-02-05T21:25:50.391Z] [2025-02-05T21:25:50.391Z] TEST TEARDOWN: [2025-02-05T21:25:50.391Z] Nothing to be done for teardown. [2025-02-05T21:25:50.391Z] renaissance-dec-tree_0 Finish Time: Wed Feb 5 16:25:49 2025 Epoch Time (ms): 1738790749979