[2024-09-02T10:45:19.868Z] Running test renaissance-dec-tree_0 ... [2024-09-02T10:45:19.868Z] =============================================== [2024-09-02T10:45:19.868Z] renaissance-dec-tree_0 Start Time: Mon Sep 2 03:45:18 2024 Epoch Time (ms): 1725273918711 [2024-09-02T10:45:19.868Z] variation: NoOptions [2024-09-02T10:45:19.868Z] JVM_OPTIONS: [2024-09-02T10:45:19.868Z] { \ [2024-09-02T10:45:19.868Z] echo ""; echo "TEST SETUP:"; \ [2024-09-02T10:45:19.868Z] echo "Nothing to be done for setup."; \ [2024-09-02T10:45:19.868Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17252714445277/renaissance-dec-tree_0"; \ [2024-09-02T10:45:19.868Z] cd "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17252714445277/renaissance-dec-tree_0"; \ [2024-09-02T10:45:19.868Z] echo ""; echo "TESTING:"; \ [2024-09-02T10:45:19.868Z] "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//bin/java" -jar "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17252714445277/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-02T10:45:19.868Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17252714445277/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-02T10:45:19.868Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-02T10:45:19.868Z] echo "Nothing to be done for teardown."; \ [2024-09-02T10:45:19.868Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17252714445277/TestTargetResult"; [2024-09-02T10:45:19.868Z] [2024-09-02T10:45:19.868Z] TEST SETUP: [2024-09-02T10:45:19.868Z] Nothing to be done for setup. [2024-09-02T10:45:19.868Z] [2024-09-02T10:45:19.868Z] TESTING: [2024-09-02T10:45:28.686Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-02T10:45:32.341Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-09-02T10:45:40.665Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-02T10:45:41.155Z] GC before operation: completed in 891.928 ms, heap usage 86.267 MB -> 26.082 MB. [2024-09-02T10:46:02.338Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (20648.175 ms) ====== [2024-09-02T10:46:02.338Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-02T10:46:02.338Z] GC before operation: completed in 992.630 ms, heap usage 825.238 MB -> 54.189 MB. [2024-09-02T10:46:07.222Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4368.917 ms) ====== [2024-09-02T10:46:07.222Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-02T10:46:07.222Z] GC before operation: completed in 326.540 ms, heap usage 191.269 MB -> 54.949 MB. [2024-09-02T10:46:12.952Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4832.882 ms) ====== [2024-09-02T10:46:12.952Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-02T10:46:12.952Z] GC before operation: completed in 340.889 ms, heap usage 703.750 MB -> 82.147 MB. [2024-09-02T10:46:16.192Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3650.230 ms) ====== [2024-09-02T10:46:16.192Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-02T10:46:17.500Z] GC before operation: completed in 1218.429 ms, heap usage 724.159 MB -> 83.459 MB. [2024-09-02T10:46:21.310Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4039.041 ms) ====== [2024-09-02T10:46:21.310Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-02T10:46:21.310Z] GC before operation: completed in 191.238 ms, heap usage 712.433 MB -> 55.239 MB. [2024-09-02T10:46:25.084Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3130.860 ms) ====== [2024-09-02T10:46:25.084Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-02T10:46:25.084Z] GC before operation: completed in 207.928 ms, heap usage 644.175 MB -> 55.437 MB. [2024-09-02T10:46:29.036Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (4128.116 ms) ====== [2024-09-02T10:46:29.036Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-02T10:46:29.459Z] GC before operation: completed in 633.952 ms, heap usage 610.844 MB -> 55.940 MB. [2024-09-02T10:46:33.216Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3376.497 ms) ====== [2024-09-02T10:46:33.216Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-02T10:46:33.216Z] GC before operation: completed in 286.659 ms, heap usage 645.884 MB -> 56.343 MB. [2024-09-02T10:46:36.213Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3043.803 ms) ====== [2024-09-02T10:46:36.213Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-02T10:46:36.691Z] GC before operation: completed in 239.090 ms, heap usage 586.731 MB -> 83.468 MB. [2024-09-02T10:46:38.777Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2060.240 ms) ====== [2024-09-02T10:46:38.777Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-02T10:46:38.777Z] GC before operation: completed in 318.843 ms, heap usage 626.256 MB -> 83.586 MB. [2024-09-02T10:46:41.966Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2952.452 ms) ====== [2024-09-02T10:46:41.966Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-02T10:46:41.966Z] GC before operation: completed in 261.265 ms, heap usage 639.277 MB -> 85.427 MB. [2024-09-02T10:46:45.707Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3007.299 ms) ====== [2024-09-02T10:46:45.707Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-02T10:46:46.735Z] GC before operation: completed in 1245.219 ms, heap usage 640.135 MB -> 56.634 MB. [2024-09-02T10:46:48.985Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2423.071 ms) ====== [2024-09-02T10:46:48.985Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-02T10:46:49.470Z] GC before operation: completed in 732.942 ms, heap usage 605.352 MB -> 84.009 MB. [2024-09-02T10:46:52.471Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2425.861 ms) ====== [2024-09-02T10:46:52.471Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-02T10:46:52.966Z] GC before operation: completed in 805.566 ms, heap usage 645.279 MB -> 56.543 MB. [2024-09-02T10:47:04.001Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (9902.071 ms) ====== [2024-09-02T10:47:04.001Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-02T10:47:04.001Z] GC before operation: completed in 1021.623 ms, heap usage 604.531 MB -> 84.136 MB. [2024-09-02T10:47:07.095Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3255.266 ms) ====== [2024-09-02T10:47:07.096Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-02T10:47:07.556Z] GC before operation: completed in 360.857 ms, heap usage 630.405 MB -> 84.694 MB. [2024-09-02T10:47:09.760Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2008.315 ms) ====== [2024-09-02T10:47:09.760Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-02T10:47:09.760Z] GC before operation: completed in 264.562 ms, heap usage 644.763 MB -> 57.055 MB. [2024-09-02T10:47:11.924Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2049.340 ms) ====== [2024-09-02T10:47:11.924Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-02T10:47:11.924Z] GC before operation: completed in 367.746 ms, heap usage 608.266 MB -> 85.132 MB. [2024-09-02T10:47:15.862Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3228.455 ms) ====== [2024-09-02T10:47:15.862Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-02T10:47:15.862Z] GC before operation: completed in 795.934 ms, heap usage 635.887 MB -> 57.294 MB. [2024-09-02T10:47:18.721Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2428.350 ms) ====== [2024-09-02T10:47:18.721Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-02T10:47:19.759Z] GC before operation: completed in 1049.705 ms, heap usage 612.124 MB -> 85.046 MB. [2024-09-02T10:47:19.759Z] 24/09/02 03:47:19 WARN BlockManager: Asked to remove block broadcast_274, which does not exist [2024-09-02T10:47:21.994Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2370.070 ms) ====== [2024-09-02T10:47:21.994Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-02T10:47:22.530Z] GC before operation: completed in 531.678 ms, heap usage 641.848 MB -> 57.582 MB. [2024-09-02T10:47:25.409Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2663.128 ms) ====== [2024-09-02T10:47:25.409Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-02T10:47:25.905Z] GC before operation: completed in 725.805 ms, heap usage 607.345 MB -> 57.715 MB. [2024-09-02T10:47:28.131Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2377.993 ms) ====== [2024-09-02T10:47:28.131Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-02T10:47:29.173Z] GC before operation: completed in 694.777 ms, heap usage 598.766 MB -> 58.256 MB. [2024-09-02T10:47:31.425Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2504.857 ms) ====== [2024-09-02T10:47:31.425Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-02T10:47:32.446Z] GC before operation: completed in 806.654 ms, heap usage 607.610 MB -> 85.805 MB. [2024-09-02T10:47:34.535Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2173.981 ms) ====== [2024-09-02T10:47:34.535Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-02T10:47:35.431Z] GC before operation: completed in 902.177 ms, heap usage 628.475 MB -> 85.617 MB. [2024-09-02T10:47:35.431Z] 24/09/02 03:47:34 WARN BlockManager: Asked to remove block broadcast_344, which does not exist [2024-09-02T10:47:37.490Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2315.241 ms) ====== [2024-09-02T10:47:37.490Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-02T10:47:38.471Z] GC before operation: completed in 813.734 ms, heap usage 627.558 MB -> 58.309 MB. [2024-09-02T10:47:41.469Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2630.620 ms) ====== [2024-09-02T10:47:41.469Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-02T10:47:41.970Z] 24/09/02 03:47:41 WARN BlockManager: Asked to remove block rdd_1320_2, which does not exist [2024-09-02T10:47:41.970Z] GC before operation: completed in 781.789 ms, heap usage 593.111 MB -> 86.037 MB. [2024-09-02T10:47:41.970Z] 24/09/02 03:47:41 WARN BlockManager: Asked to remove block rdd_1320_1, which does not exist [2024-09-02T10:47:43.602Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1740.367 ms) ====== [2024-09-02T10:47:43.602Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-02T10:47:44.065Z] GC before operation: completed in 236.258 ms, heap usage 628.266 MB -> 86.174 MB. [2024-09-02T10:47:46.233Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2556.925 ms) ====== [2024-09-02T10:47:46.233Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-02T10:47:46.666Z] GC before operation: completed in 260.464 ms, heap usage 630.664 MB -> 71.742 MB. [2024-09-02T10:47:48.745Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2246.669 ms) ====== [2024-09-02T10:47:48.745Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-02T10:47:49.174Z] GC before operation: completed in 266.543 ms, heap usage 625.393 MB -> 86.593 MB. [2024-09-02T10:47:51.397Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2316.486 ms) ====== [2024-09-02T10:47:51.397Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-02T10:47:51.865Z] GC before operation: completed in 214.396 ms, heap usage 636.070 MB -> 59.189 MB. [2024-09-02T10:47:53.307Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1815.593 ms) ====== [2024-09-02T10:47:53.307Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-02T10:47:54.293Z] GC before operation: completed in 583.700 ms, heap usage 603.853 MB -> 86.792 MB. [2024-09-02T10:47:56.417Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1960.638 ms) ====== [2024-09-02T10:47:56.417Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-02T10:47:56.417Z] GC before operation: completed in 207.823 ms, heap usage 632.481 MB -> 59.303 MB. [2024-09-02T10:47:58.711Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2464.691 ms) ====== [2024-09-02T10:47:58.711Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-02T10:47:59.250Z] GC before operation: completed in 256.824 ms, heap usage 602.767 MB -> 59.439 MB. [2024-09-02T10:48:01.475Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2380.728 ms) ====== [2024-09-02T10:48:01.475Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-02T10:48:01.475Z] GC before operation: completed in 193.399 ms, heap usage 595.417 MB -> 87.199 MB. [2024-09-02T10:48:04.576Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2825.091 ms) ====== [2024-09-02T10:48:04.576Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-02T10:48:04.576Z] GC before operation: completed in 221.717 ms, heap usage 632.844 MB -> 59.694 MB. [2024-09-02T10:48:07.514Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2774.475 ms) ====== [2024-09-02T10:48:07.514Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-02T10:48:07.514Z] GC before operation: completed in 249.377 ms, heap usage 592.282 MB -> 59.829 MB. [2024-09-02T10:48:11.191Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (3065.037 ms) ====== [2024-09-02T10:48:11.191Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-02T10:48:11.191Z] GC before operation: completed in 214.675 ms, heap usage 597.579 MB -> 87.568 MB. [2024-09-02T10:48:14.126Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2786.838 ms) ====== [2024-09-02T10:48:14.126Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-02T10:48:14.126Z] GC before operation: completed in 260.828 ms, heap usage 625.518 MB -> 60.084 MB. [2024-09-02T10:48:21.514Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (6920.627 ms) ====== [2024-09-02T10:48:23.652Z] ----------------------------------- [2024-09-02T10:48:23.652Z] renaissance-dec-tree_0_PASSED [2024-09-02T10:48:23.652Z] ----------------------------------- [2024-09-02T10:48:23.652Z] [2024-09-02T10:48:23.652Z] TEST TEARDOWN: [2024-09-02T10:48:23.652Z] Nothing to be done for teardown. [2024-09-02T10:48:24.122Z] renaissance-dec-tree_0 Finish Time: Mon Sep 2 03:48:23 2024 Epoch Time (ms): 1725274103486