[2025-02-13T01:26:23.631Z] Running test renaissance-dec-tree_0 ... [2025-02-13T01:26:23.631Z] =============================================== [2025-02-13T01:26:23.631Z] renaissance-dec-tree_0 Start Time: Wed Feb 12 17:26:22 2025 Epoch Time (ms): 1739409982790 [2025-02-13T01:26:23.631Z] variation: NoOptions [2025-02-13T01:26:23.631Z] JVM_OPTIONS: [2025-02-13T01:26:23.631Z] { \ [2025-02-13T01:26:23.631Z] echo ""; echo "TEST SETUP:"; \ [2025-02-13T01:26:23.631Z] echo "Nothing to be done for setup."; \ [2025-02-13T01:26:23.631Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17394094624238/renaissance-dec-tree_0"; \ [2025-02-13T01:26:23.631Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17394094624238/renaissance-dec-tree_0"; \ [2025-02-13T01:26:23.631Z] echo ""; echo "TESTING:"; \ [2025-02-13T01:26:23.631Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/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_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17394094624238/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-13T01:26:23.631Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17394094624238/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-13T01:26:23.631Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-13T01:26:23.631Z] echo "Nothing to be done for teardown."; \ [2025-02-13T01:26:23.631Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17394094624238/TestTargetResult"; [2025-02-13T01:26:23.631Z] [2025-02-13T01:26:23.631Z] TEST SETUP: [2025-02-13T01:26:23.631Z] Nothing to be done for setup. [2025-02-13T01:26:23.631Z] [2025-02-13T01:26:23.631Z] TESTING: [2025-02-13T01:26:28.136Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-13T01:26:30.231Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-02-13T01:26:33.772Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-13T01:26:33.772Z] GC before operation: completed in 49.431 ms, heap usage 53.006 MB -> 35.316 MB. [2025-02-13T01:26:44.155Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10008.156 ms) ====== [2025-02-13T01:26:44.155Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-13T01:26:44.155Z] GC before operation: completed in 94.284 ms, heap usage 275.122 MB -> 64.832 MB. [2025-02-13T01:26:46.350Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3062.349 ms) ====== [2025-02-13T01:26:46.350Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-13T01:26:46.350Z] GC before operation: completed in 69.713 ms, heap usage 136.039 MB -> 64.892 MB. [2025-02-13T01:26:48.544Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2187.046 ms) ====== [2025-02-13T01:26:48.544Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-13T01:26:49.011Z] GC before operation: completed in 99.479 ms, heap usage 231.794 MB -> 80.335 MB. [2025-02-13T01:26:49.011Z] 25/02/12 17:26:47 WARN BlockManager: Asked to remove block broadcast_36, which does not exist [2025-02-13T01:26:51.184Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2274.044 ms) ====== [2025-02-13T01:26:51.184Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-13T01:26:51.184Z] GC before operation: completed in 67.358 ms, heap usage 299.859 MB -> 65.669 MB. [2025-02-13T01:26:52.737Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1840.535 ms) ====== [2025-02-13T01:26:52.737Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-13T01:26:53.182Z] GC before operation: completed in 70.365 ms, heap usage 105.846 MB -> 65.472 MB. [2025-02-13T01:26:55.321Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2001.265 ms) ====== [2025-02-13T01:26:55.321Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-13T01:26:55.321Z] GC before operation: completed in 65.516 ms, heap usage 277.618 MB -> 66.252 MB. [2025-02-13T01:26:56.849Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1863.477 ms) ====== [2025-02-13T01:26:56.849Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-13T01:26:56.849Z] GC before operation: completed in 80.124 ms, heap usage 307.170 MB -> 79.397 MB. [2025-02-13T01:26:59.003Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1979.130 ms) ====== [2025-02-13T01:26:59.003Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-13T01:26:59.003Z] GC before operation: completed in 76.403 ms, heap usage 440.740 MB -> 66.656 MB. [2025-02-13T01:27:01.097Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1668.712 ms) ====== [2025-02-13T01:27:01.097Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-13T01:27:01.097Z] GC before operation: completed in 77.737 ms, heap usage 193.855 MB -> 66.578 MB. [2025-02-13T01:27:02.600Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1799.904 ms) ====== [2025-02-13T01:27:02.600Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-13T01:27:02.600Z] GC before operation: completed in 69.785 ms, heap usage 267.203 MB -> 66.701 MB. [2025-02-13T01:27:04.768Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1822.474 ms) ====== [2025-02-13T01:27:04.768Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-13T01:27:04.768Z] GC before operation: completed in 87.442 ms, heap usage 148.235 MB -> 66.535 MB. [2025-02-13T01:27:06.397Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1669.807 ms) ====== [2025-02-13T01:27:06.397Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-13T01:27:06.397Z] GC before operation: completed in 88.233 ms, heap usage 310.753 MB -> 67.086 MB. [2025-02-13T01:27:07.856Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1610.022 ms) ====== [2025-02-13T01:27:07.856Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-13T01:27:08.277Z] GC before operation: completed in 112.278 ms, heap usage 127.744 MB -> 94.637 MB. [2025-02-13T01:27:09.774Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1796.161 ms) ====== [2025-02-13T01:27:09.774Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-13T01:27:10.226Z] GC before operation: completed in 105.181 ms, heap usage 562.535 MB -> 67.436 MB. [2025-02-13T01:27:11.708Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1691.807 ms) ====== [2025-02-13T01:27:11.708Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-13T01:27:11.708Z] GC before operation: completed in 50.731 ms, heap usage 116.305 MB -> 66.947 MB. [2025-02-13T01:27:13.821Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1701.829 ms) ====== [2025-02-13T01:27:13.821Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-13T01:27:13.821Z] GC before operation: completed in 80.082 ms, heap usage 207.137 MB -> 67.514 MB. [2025-02-13T01:27:15.346Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1675.514 ms) ====== [2025-02-13T01:27:15.346Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-13T01:27:15.346Z] GC before operation: completed in 81.671 ms, heap usage 159.965 MB -> 67.208 MB. [2025-02-13T01:27:16.819Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1629.046 ms) ====== [2025-02-13T01:27:16.819Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-13T01:27:16.819Z] GC before operation: completed in 82.810 ms, heap usage 228.057 MB -> 67.989 MB. [2025-02-13T01:27:18.960Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1584.340 ms) ====== [2025-02-13T01:27:18.960Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-13T01:27:18.960Z] GC before operation: completed in 85.182 ms, heap usage 271.856 MB -> 67.924 MB. [2025-02-13T01:27:19.999Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1522.852 ms) ====== [2025-02-13T01:27:19.999Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-13T01:27:20.445Z] GC before operation: completed in 87.611 ms, heap usage 266.235 MB -> 67.917 MB. [2025-02-13T01:27:21.905Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1512.355 ms) ====== [2025-02-13T01:27:21.905Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-13T01:27:21.905Z] GC before operation: completed in 76.768 ms, heap usage 265.505 MB -> 67.906 MB. [2025-02-13T01:27:23.383Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1431.824 ms) ====== [2025-02-13T01:27:23.383Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-13T01:27:23.383Z] GC before operation: completed in 93.903 ms, heap usage 294.410 MB -> 68.155 MB. [2025-02-13T01:27:24.843Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1390.712 ms) ====== [2025-02-13T01:27:24.843Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-13T01:27:24.843Z] GC before operation: completed in 83.525 ms, heap usage 373.248 MB -> 68.280 MB. [2025-02-13T01:27:26.310Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1399.882 ms) ====== [2025-02-13T01:27:26.310Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-13T01:27:26.310Z] GC before operation: completed in 92.538 ms, heap usage 336.147 MB -> 68.254 MB. [2025-02-13T01:27:27.892Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1375.224 ms) ====== [2025-02-13T01:27:27.892Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-13T01:27:27.892Z] GC before operation: completed in 94.939 ms, heap usage 253.072 MB -> 68.382 MB. [2025-02-13T01:27:29.368Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1571.436 ms) ====== [2025-02-13T01:27:29.368Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-13T01:27:29.368Z] GC before operation: completed in 86.322 ms, heap usage 175.919 MB -> 68.231 MB. [2025-02-13T01:27:31.406Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1585.193 ms) ====== [2025-02-13T01:27:31.406Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-13T01:27:31.406Z] GC before operation: completed in 78.628 ms, heap usage 238.715 MB -> 68.779 MB. [2025-02-13T01:27:32.392Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1369.438 ms) ====== [2025-02-13T01:27:32.392Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-13T01:27:32.824Z] GC before operation: completed in 76.503 ms, heap usage 272.434 MB -> 68.801 MB. [2025-02-13T01:27:34.411Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1456.945 ms) ====== [2025-02-13T01:27:34.411Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-13T01:27:34.411Z] GC before operation: completed in 101.437 ms, heap usage 354.062 MB -> 69.001 MB. [2025-02-13T01:27:35.397Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1350.441 ms) ====== [2025-02-13T01:27:35.397Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-13T01:27:35.837Z] GC before operation: completed in 80.095 ms, heap usage 226.786 MB -> 69.172 MB. [2025-02-13T01:27:37.304Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1499.029 ms) ====== [2025-02-13T01:27:37.304Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-13T01:27:37.304Z] GC before operation: completed in 106.572 ms, heap usage 233.579 MB -> 69.268 MB. [2025-02-13T01:27:38.754Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1394.272 ms) ====== [2025-02-13T01:27:38.754Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-13T01:27:38.754Z] GC before operation: completed in 80.122 ms, heap usage 245.549 MB -> 69.210 MB. [2025-02-13T01:27:40.259Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1424.889 ms) ====== [2025-02-13T01:27:40.259Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-13T01:27:40.259Z] GC before operation: completed in 92.936 ms, heap usage 245.380 MB -> 69.461 MB. [2025-02-13T01:27:41.695Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1430.291 ms) ====== [2025-02-13T01:27:41.695Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-13T01:27:41.695Z] GC before operation: completed in 108.411 ms, heap usage 229.939 MB -> 97.057 MB. [2025-02-13T01:27:43.167Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1461.845 ms) ====== [2025-02-13T01:27:43.167Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-13T01:27:43.167Z] GC before operation: completed in 85.723 ms, heap usage 233.309 MB -> 97.164 MB. [2025-02-13T01:27:45.247Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1555.588 ms) ====== [2025-02-13T01:27:45.247Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-13T01:27:45.247Z] GC before operation: completed in 85.156 ms, heap usage 300.670 MB -> 69.665 MB. [2025-02-13T01:27:46.758Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1438.888 ms) ====== [2025-02-13T01:27:46.758Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-13T01:27:46.758Z] GC before operation: completed in 96.857 ms, heap usage 254.654 MB -> 82.331 MB. [2025-02-13T01:27:47.675Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1369.805 ms) ====== [2025-02-13T01:27:47.675Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-13T01:27:48.131Z] GC before operation: completed in 85.934 ms, heap usage 261.200 MB -> 69.920 MB. [2025-02-13T01:27:49.596Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1491.601 ms) ====== [2025-02-13T01:27:49.596Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-13T01:27:49.596Z] GC before operation: completed in 90.600 ms, heap usage 390.832 MB -> 70.011 MB. [2025-02-13T01:27:51.023Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1343.884 ms) ====== [2025-02-13T01:27:51.023Z] ----------------------------------- [2025-02-13T01:27:51.023Z] renaissance-dec-tree_0_PASSED [2025-02-13T01:27:51.023Z] ----------------------------------- [2025-02-13T01:27:51.023Z] [2025-02-13T01:27:51.023Z] TEST TEARDOWN: [2025-02-13T01:27:51.023Z] Nothing to be done for teardown. [2025-02-13T01:27:51.023Z] renaissance-dec-tree_0 Finish Time: Wed Feb 12 17:27:50 2025 Epoch Time (ms): 1739410070313