[2024-08-02T07:35:14.884Z] Running test renaissance-dec-tree_0 ... [2024-08-02T07:35:14.884Z] =============================================== [2024-08-02T07:35:15.459Z] renaissance-dec-tree_0 Start Time: Fri Aug 2 00:35:13 2024 Epoch Time (ms): 1722584113543 [2024-08-02T07:35:15.459Z] variation: NoOptions [2024-08-02T07:35:15.459Z] JVM_OPTIONS: [2024-08-02T07:35:15.459Z] { \ [2024-08-02T07:35:15.459Z] echo ""; echo "TEST SETUP:"; \ [2024-08-02T07:35:15.459Z] echo "Nothing to be done for setup."; \ [2024-08-02T07:35:15.459Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-dec-tree_0"; \ [2024-08-02T07:35:15.459Z] cd "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-dec-tree_0"; \ [2024-08-02T07:35:15.459Z] echo ""; echo "TESTING:"; \ [2024-08-02T07:35:15.459Z] "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/..//bin/java" -jar "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-02T07:35:15.459Z] 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_testList_0/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-02T07:35:15.459Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-02T07:35:15.459Z] echo "Nothing to be done for teardown."; \ [2024-08-02T07:35:15.459Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/TestTargetResult"; [2024-08-02T07:35:16.011Z] [2024-08-02T07:35:16.011Z] TEST SETUP: [2024-08-02T07:35:16.011Z] Nothing to be done for setup. [2024-08-02T07:35:16.011Z] [2024-08-02T07:35:16.011Z] TESTING: [2024-08-02T07:35:23.096Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-02T07:35:27.852Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-08-02T07:35:36.255Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-02T07:35:36.255Z] GC before operation: completed in 901.139 ms, heap usage 78.361 MB -> 25.388 MB. [2024-08-02T07:36:01.921Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (23969.653 ms) ====== [2024-08-02T07:36:01.921Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-02T07:36:01.921Z] GC before operation: completed in 1601.088 ms, heap usage 697.906 MB -> 54.348 MB. [2024-08-02T07:36:08.039Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (5538.435 ms) ====== [2024-08-02T07:36:08.039Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-02T07:36:08.039Z] GC before operation: completed in 203.682 ms, heap usage 131.982 MB -> 54.374 MB. [2024-08-02T07:36:09.541Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1860.975 ms) ====== [2024-08-02T07:36:09.541Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-02T07:36:09.541Z] GC before operation: completed in 138.960 ms, heap usage 669.279 MB -> 54.922 MB. [2024-08-02T07:36:10.945Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1265.395 ms) ====== [2024-08-02T07:36:10.946Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-02T07:36:10.946Z] GC before operation: completed in 127.262 ms, heap usage 693.343 MB -> 55.217 MB. [2024-08-02T07:36:12.298Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1142.663 ms) ====== [2024-08-02T07:36:12.298Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-02T07:36:12.298Z] GC before operation: completed in 101.009 ms, heap usage 671.451 MB -> 68.012 MB. [2024-08-02T07:36:12.298Z] 24/08/02 00:36:10 WARN BlockManager: Asked to remove block broadcast_64, which does not exist [2024-08-02T07:36:15.338Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2611.205 ms) ====== [2024-08-02T07:36:15.338Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-02T07:36:15.338Z] GC before operation: completed in 213.017 ms, heap usage 672.742 MB -> 55.491 MB. [2024-08-02T07:36:18.268Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2828.287 ms) ====== [2024-08-02T07:36:18.268Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-02T07:36:18.268Z] GC before operation: completed in 262.727 ms, heap usage 652.746 MB -> 68.516 MB. [2024-08-02T07:36:20.298Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2215.713 ms) ====== [2024-08-02T07:36:20.298Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-02T07:36:20.730Z] GC before operation: completed in 158.018 ms, heap usage 659.707 MB -> 55.858 MB. [2024-08-02T07:36:22.222Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1396.895 ms) ====== [2024-08-02T07:36:22.222Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-02T07:36:22.222Z] GC before operation: completed in 189.188 ms, heap usage 632.824 MB -> 56.194 MB. [2024-08-02T07:36:25.130Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2791.752 ms) ====== [2024-08-02T07:36:25.130Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-02T07:36:25.130Z] GC before operation: completed in 187.215 ms, heap usage 636.924 MB -> 56.010 MB. [2024-08-02T07:36:27.985Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2424.649 ms) ====== [2024-08-02T07:36:27.985Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-02T07:36:27.985Z] GC before operation: completed in 220.125 ms, heap usage 686.185 MB -> 56.141 MB. [2024-08-02T07:36:30.104Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2191.925 ms) ====== [2024-08-02T07:36:30.104Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-02T07:36:30.104Z] GC before operation: completed in 158.253 ms, heap usage 622.898 MB -> 56.672 MB. [2024-08-02T07:36:31.952Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1863.006 ms) ====== [2024-08-02T07:36:31.952Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-02T07:36:33.700Z] GC before operation: completed in 1323.430 ms, heap usage 619.804 MB -> 56.455 MB. [2024-08-02T07:36:35.278Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1766.046 ms) ====== [2024-08-02T07:36:35.278Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-02T07:36:36.284Z] GC before operation: completed in 1159.601 ms, heap usage 607.528 MB -> 56.605 MB. [2024-08-02T07:36:39.374Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2969.364 ms) ====== [2024-08-02T07:36:39.374Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-02T07:36:39.374Z] GC before operation: completed in 228.917 ms, heap usage 611.924 MB -> 57.138 MB. [2024-08-02T07:36:43.210Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3171.721 ms) ====== [2024-08-02T07:36:43.210Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-02T07:36:43.210Z] GC before operation: completed in 328.133 ms, heap usage 607.602 MB -> 84.535 MB. [2024-08-02T07:36:45.302Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2127.001 ms) ====== [2024-08-02T07:36:45.302Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-02T07:36:45.302Z] GC before operation: completed in 225.433 ms, heap usage 664.892 MB -> 57.130 MB. [2024-08-02T07:36:47.564Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1701.111 ms) ====== [2024-08-02T07:36:47.564Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-02T07:36:48.061Z] GC before operation: completed in 1156.280 ms, heap usage 624.733 MB -> 57.566 MB. [2024-08-02T07:36:50.112Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1541.983 ms) ====== [2024-08-02T07:36:50.112Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-02T07:36:50.112Z] GC before operation: completed in 164.607 ms, heap usage 618.061 MB -> 70.438 MB. [2024-08-02T07:36:51.649Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1775.135 ms) ====== [2024-08-02T07:36:51.649Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-02T07:36:51.649Z] GC before operation: completed in 160.392 ms, heap usage 632.174 MB -> 85.085 MB. [2024-08-02T07:36:53.129Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1407.684 ms) ====== [2024-08-02T07:36:53.129Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-02T07:36:53.605Z] GC before operation: completed in 186.916 ms, heap usage 661.899 MB -> 57.629 MB. [2024-08-02T07:36:55.697Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2025.486 ms) ====== [2024-08-02T07:36:55.697Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-02T07:36:55.697Z] GC before operation: completed in 131.533 ms, heap usage 625.108 MB -> 57.906 MB. [2024-08-02T07:36:58.527Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2510.794 ms) ====== [2024-08-02T07:36:58.527Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-02T07:36:58.527Z] GC before operation: completed in 519.757 ms, heap usage 629.945 MB -> 70.767 MB. [2024-08-02T07:37:01.546Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2587.395 ms) ====== [2024-08-02T07:37:01.546Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-02T07:37:01.546Z] GC before operation: completed in 157.020 ms, heap usage 637.803 MB -> 85.618 MB. [2024-08-02T07:37:02.428Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1181.808 ms) ====== [2024-08-02T07:37:02.428Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-02T07:37:02.855Z] GC before operation: completed in 163.130 ms, heap usage 669.123 MB -> 71.103 MB. [2024-08-02T07:37:05.074Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2470.711 ms) ====== [2024-08-02T07:37:05.074Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-02T07:37:05.547Z] GC before operation: completed in 194.023 ms, heap usage 652.116 MB -> 58.437 MB. [2024-08-02T07:37:08.462Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2610.435 ms) ====== [2024-08-02T07:37:08.462Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-02T07:37:08.462Z] GC before operation: completed in 174.903 ms, heap usage 636.060 MB -> 58.414 MB. [2024-08-02T07:37:11.480Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2927.316 ms) ====== [2024-08-02T07:37:11.480Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-02T07:37:11.480Z] GC before operation: completed in 168.120 ms, heap usage 636.223 MB -> 71.649 MB. [2024-08-02T07:37:11.480Z] 24/08/02 00:37:09 WARN BlockManager: Asked to remove block broadcast_386, which does not exist [2024-08-02T07:37:11.480Z] 24/08/02 00:37:09 WARN BlockManager: Asked to remove block broadcast_386_piece0, which does not exist [2024-08-02T07:37:14.406Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2718.523 ms) ====== [2024-08-02T07:37:14.406Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-02T07:37:14.406Z] GC before operation: completed in 208.012 ms, heap usage 636.363 MB -> 86.286 MB. [2024-08-02T07:37:17.357Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2667.678 ms) ====== [2024-08-02T07:37:17.357Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-02T07:37:17.357Z] GC before operation: completed in 126.038 ms, heap usage 674.561 MB -> 71.924 MB. [2024-08-02T07:37:19.720Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2676.000 ms) ====== [2024-08-02T07:37:19.720Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-02T07:37:19.720Z] GC before operation: completed in 155.353 ms, heap usage 655.513 MB -> 84.744 MB. [2024-08-02T07:37:21.177Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1485.707 ms) ====== [2024-08-02T07:37:21.177Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-02T07:37:22.119Z] GC before operation: completed in 649.090 ms, heap usage 671.505 MB -> 59.227 MB. [2024-08-02T07:37:23.477Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1433.957 ms) ====== [2024-08-02T07:37:23.477Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-02T07:37:23.477Z] GC before operation: completed in 119.477 ms, heap usage 652.813 MB -> 59.612 MB. [2024-08-02T07:37:24.328Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (905.884 ms) ====== [2024-08-02T07:37:24.328Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-02T07:37:24.765Z] GC before operation: completed in 134.201 ms, heap usage 653.318 MB -> 74.255 MB. [2024-08-02T07:37:26.997Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2457.676 ms) ====== [2024-08-02T07:37:26.997Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-02T07:37:26.997Z] GC before operation: completed in 162.721 ms, heap usage 675.433 MB -> 59.622 MB. [2024-08-02T07:37:29.991Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2529.925 ms) ====== [2024-08-02T07:37:29.991Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-02T07:37:29.991Z] GC before operation: completed in 186.256 ms, heap usage 643.599 MB -> 74.468 MB. [2024-08-02T07:37:31.587Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1420.423 ms) ====== [2024-08-02T07:37:31.587Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-02T07:37:31.587Z] GC before operation: completed in 261.220 ms, heap usage 652.409 MB -> 72.881 MB. [2024-08-02T07:37:33.758Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1991.333 ms) ====== [2024-08-02T07:37:33.758Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-02T07:37:33.758Z] GC before operation: completed in 201.763 ms, heap usage 652.211 MB -> 59.912 MB. [2024-08-02T07:37:36.588Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2467.967 ms) ====== [2024-08-02T07:37:36.588Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-02T07:37:36.588Z] GC before operation: completed in 149.923 ms, heap usage 632.951 MB -> 60.191 MB. [2024-08-02T07:37:37.500Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1114.544 ms) ====== [2024-08-02T07:37:39.095Z] ----------------------------------- [2024-08-02T07:37:39.095Z] renaissance-dec-tree_0_PASSED [2024-08-02T07:37:39.095Z] ----------------------------------- [2024-08-02T07:37:39.095Z] [2024-08-02T07:37:39.095Z] TEST TEARDOWN: [2024-08-02T07:37:39.095Z] Nothing to be done for teardown. [2024-08-02T07:37:39.095Z] renaissance-dec-tree_0 Finish Time: Fri Aug 2 00:37:37 2024 Epoch Time (ms): 1722584257625