[2024-11-21T07:25:13.069Z] Running test renaissance-dec-tree_0 ... [2024-11-21T07:25:13.069Z] =============================================== [2024-11-21T07:25:13.478Z] renaissance-dec-tree_0 Start Time: Wed Nov 20 23:25:12 2024 Epoch Time (ms): 1732173912248 [2024-11-21T07:25:13.478Z] variation: NoOptions [2024-11-21T07:25:13.986Z] JVM_OPTIONS: [2024-11-21T07:25:13.986Z] { \ [2024-11-21T07:25:13.986Z] echo ""; echo "TEST SETUP:"; \ [2024-11-21T07:25:13.986Z] echo "Nothing to be done for setup."; \ [2024-11-21T07:25:13.986Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17321734849362/renaissance-dec-tree_0"; \ [2024-11-21T07:25:13.986Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17321734849362/renaissance-dec-tree_0"; \ [2024-11-21T07:25:13.986Z] echo ""; echo "TESTING:"; \ [2024-11-21T07:25:13.986Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/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_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17321734849362/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-21T07:25:13.986Z] 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_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17321734849362/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-21T07:25:13.986Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-21T07:25:13.986Z] echo "Nothing to be done for teardown."; \ [2024-11-21T07:25:13.986Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17321734849362/TestTargetResult"; [2024-11-21T07:25:13.986Z] [2024-11-21T07:25:13.986Z] TEST SETUP: [2024-11-21T07:25:13.986Z] Nothing to be done for setup. [2024-11-21T07:25:13.986Z] [2024-11-21T07:25:13.986Z] TESTING: [2024-11-21T07:25:30.100Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-21T07:25:36.187Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-11-21T07:25:58.235Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-21T07:25:58.235Z] GC before operation: completed in 103.685 ms, heap usage 44.162 MB -> 35.678 MB. [2024-11-21T07:26:30.053Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (32104.319 ms) ====== [2024-11-21T07:26:30.053Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-21T07:26:30.053Z] GC before operation: completed in 246.618 ms, heap usage 145.281 MB -> 64.837 MB. [2024-11-21T07:26:39.637Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (10098.445 ms) ====== [2024-11-21T07:26:39.637Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-21T07:26:39.637Z] GC before operation: completed in 134.629 ms, heap usage 241.892 MB -> 65.618 MB. [2024-11-21T07:26:49.132Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (9336.871 ms) ====== [2024-11-21T07:26:49.132Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-21T07:26:49.132Z] GC before operation: completed in 280.753 ms, heap usage 192.844 MB -> 66.137 MB. [2024-11-21T07:27:00.358Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9502.207 ms) ====== [2024-11-21T07:27:00.358Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-21T07:27:00.358Z] GC before operation: completed in 218.741 ms, heap usage 234.598 MB -> 93.710 MB. [2024-11-21T07:27:07.000Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8197.020 ms) ====== [2024-11-21T07:27:07.000Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-21T07:27:07.439Z] GC before operation: completed in 175.449 ms, heap usage 202.669 MB -> 65.907 MB. [2024-11-21T07:27:17.228Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8997.612 ms) ====== [2024-11-21T07:27:17.228Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-21T07:27:17.228Z] GC before operation: completed in 455.314 ms, heap usage 253.300 MB -> 66.383 MB. [2024-11-21T07:27:25.547Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (7760.921 ms) ====== [2024-11-21T07:27:25.547Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-21T07:27:25.547Z] GC before operation: completed in 255.769 ms, heap usage 327.449 MB -> 66.590 MB. [2024-11-21T07:27:34.404Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (8787.845 ms) ====== [2024-11-21T07:27:34.404Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-21T07:27:34.404Z] GC before operation: completed in 160.502 ms, heap usage 268.003 MB -> 67.133 MB. [2024-11-21T07:27:34.404Z] 24/11/20 23:27:32 WARN BlockManager: Asked to remove block broadcast_106_piece0, which does not exist [2024-11-21T07:27:34.404Z] 24/11/20 23:27:32 WARN BlockManager: Asked to remove block broadcast_106, which does not exist [2024-11-21T07:27:44.121Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (9267.312 ms) ====== [2024-11-21T07:27:44.121Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-21T07:27:44.121Z] GC before operation: completed in 183.585 ms, heap usage 295.141 MB -> 67.023 MB. [2024-11-21T07:27:50.824Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6928.063 ms) ====== [2024-11-21T07:27:50.824Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-21T07:27:50.824Z] GC before operation: completed in 192.592 ms, heap usage 181.213 MB -> 94.451 MB. [2024-11-21T07:27:58.449Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (7790.604 ms) ====== [2024-11-21T07:27:58.449Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-21T07:27:58.449Z] GC before operation: completed in 319.920 ms, heap usage 307.978 MB -> 94.813 MB. [2024-11-21T07:27:58.449Z] 24/11/20 23:27:57 WARN BlockManager: Asked to remove block broadcast_152, which does not exist [2024-11-21T07:28:05.159Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (6320.695 ms) ====== [2024-11-21T07:28:05.159Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-21T07:28:05.159Z] GC before operation: completed in 245.922 ms, heap usage 270.128 MB -> 67.204 MB. [2024-11-21T07:28:11.668Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (6776.845 ms) ====== [2024-11-21T07:28:12.152Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-21T07:28:12.152Z] GC before operation: completed in 199.131 ms, heap usage 384.896 MB -> 67.382 MB. [2024-11-21T07:28:18.829Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6653.674 ms) ====== [2024-11-21T07:28:18.829Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-21T07:28:18.829Z] GC before operation: completed in 234.459 ms, heap usage 113.701 MB -> 94.655 MB. [2024-11-21T07:28:28.232Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (9179.023 ms) ====== [2024-11-21T07:28:28.232Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-21T07:28:28.232Z] GC before operation: completed in 239.057 ms, heap usage 547.231 MB -> 67.935 MB. [2024-11-21T07:28:35.835Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (6888.594 ms) ====== [2024-11-21T07:28:35.835Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-21T07:28:35.835Z] GC before operation: completed in 211.354 ms, heap usage 205.311 MB -> 67.755 MB. [2024-11-21T07:28:42.054Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (5735.935 ms) ====== [2024-11-21T07:28:42.054Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-21T07:28:42.054Z] GC before operation: completed in 218.093 ms, heap usage 296.923 MB -> 67.777 MB. [2024-11-21T07:28:48.206Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6055.049 ms) ====== [2024-11-21T07:28:48.206Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-21T07:28:48.842Z] GC before operation: completed in 1186.569 ms, heap usage 144.553 MB -> 95.379 MB. [2024-11-21T07:29:02.916Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (14056.279 ms) ====== [2024-11-21T07:29:02.916Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-21T07:29:02.916Z] GC before operation: completed in 252.505 ms, heap usage 177.855 MB -> 67.783 MB. [2024-11-21T07:29:07.967Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (5113.160 ms) ====== [2024-11-21T07:29:07.967Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-21T07:29:08.481Z] GC before operation: completed in 260.301 ms, heap usage 373.798 MB -> 68.066 MB. [2024-11-21T07:29:15.983Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (6901.140 ms) ====== [2024-11-21T07:29:15.983Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-21T07:29:15.983Z] GC before operation: completed in 227.935 ms, heap usage 358.950 MB -> 68.209 MB. [2024-11-21T07:29:22.296Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (6629.321 ms) ====== [2024-11-21T07:29:22.296Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-21T07:29:22.981Z] GC before operation: completed in 708.602 ms, heap usage 101.882 MB -> 95.932 MB. [2024-11-21T07:29:32.776Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (9191.411 ms) ====== [2024-11-21T07:29:32.776Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-21T07:29:32.776Z] GC before operation: completed in 345.423 ms, heap usage 313.708 MB -> 68.521 MB. [2024-11-21T07:29:41.017Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (8581.515 ms) ====== [2024-11-21T07:29:41.017Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-21T07:29:41.017Z] GC before operation: completed in 249.454 ms, heap usage 274.193 MB -> 96.009 MB. [2024-11-21T07:29:47.294Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5698.396 ms) ====== [2024-11-21T07:29:47.294Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-21T07:29:47.294Z] GC before operation: completed in 319.039 ms, heap usage 438.417 MB -> 96.290 MB. [2024-11-21T07:29:54.813Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6698.144 ms) ====== [2024-11-21T07:29:54.813Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-21T07:29:54.813Z] GC before operation: completed in 298.529 ms, heap usage 262.498 MB -> 96.505 MB. [2024-11-21T07:30:09.405Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (15043.886 ms) ====== [2024-11-21T07:30:09.405Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-21T07:30:09.405Z] GC before operation: completed in 296.729 ms, heap usage 515.369 MB -> 68.957 MB. [2024-11-21T07:30:14.514Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4700.204 ms) ====== [2024-11-21T07:30:14.514Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-21T07:30:15.514Z] GC before operation: completed in 1084.715 ms, heap usage 267.596 MB -> 96.666 MB. [2024-11-21T07:30:24.768Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (7821.172 ms) ====== [2024-11-21T07:30:24.768Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-21T07:30:24.768Z] GC before operation: completed in 339.725 ms, heap usage 352.166 MB -> 96.622 MB. [2024-11-21T07:30:32.701Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (8480.560 ms) ====== [2024-11-21T07:30:32.701Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-21T07:30:32.701Z] GC before operation: completed in 290.350 ms, heap usage 234.625 MB -> 69.350 MB. [2024-11-21T07:30:39.172Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (6350.741 ms) ====== [2024-11-21T07:30:39.172Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-21T07:30:39.172Z] GC before operation: completed in 217.334 ms, heap usage 195.903 MB -> 69.390 MB. [2024-11-21T07:30:46.940Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (7122.318 ms) ====== [2024-11-21T07:30:46.940Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-21T07:30:46.940Z] GC before operation: completed in 941.186 ms, heap usage 261.122 MB -> 95.230 MB. [2024-11-21T07:30:54.270Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (7271.138 ms) ====== [2024-11-21T07:30:54.270Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-21T07:30:54.809Z] GC before operation: completed in 365.660 ms, heap usage 391.249 MB -> 97.075 MB. [2024-11-21T07:31:01.049Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (6642.460 ms) ====== [2024-11-21T07:31:01.049Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-21T07:31:01.626Z] GC before operation: completed in 235.012 ms, heap usage 179.142 MB -> 97.085 MB. [2024-11-21T07:31:07.926Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (6071.370 ms) ====== [2024-11-21T07:31:07.926Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-21T07:31:07.926Z] GC before operation: completed in 300.366 ms, heap usage 373.881 MB -> 69.975 MB. [2024-11-21T07:31:14.084Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (6086.633 ms) ====== [2024-11-21T07:31:14.084Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-21T07:31:14.085Z] GC before operation: completed in 197.148 ms, heap usage 242.333 MB -> 69.733 MB. [2024-11-21T07:31:20.606Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6035.480 ms) ====== [2024-11-21T07:31:20.606Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-21T07:31:20.606Z] GC before operation: completed in 133.947 ms, heap usage 345.191 MB -> 69.876 MB. [2024-11-21T07:31:24.654Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4221.692 ms) ====== [2024-11-21T07:31:24.654Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-21T07:31:24.654Z] GC before operation: completed in 232.433 ms, heap usage 236.047 MB -> 97.718 MB. [2024-11-21T07:31:32.415Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (6751.277 ms) ====== [2024-11-21T07:31:32.415Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-21T07:31:32.415Z] GC before operation: completed in 176.085 ms, heap usage 159.570 MB -> 69.708 MB. [2024-11-21T07:31:37.242Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5752.463 ms) ====== [2024-11-21T07:31:38.738Z] ----------------------------------- [2024-11-21T07:31:38.738Z] renaissance-dec-tree_0_PASSED [2024-11-21T07:31:38.738Z] ----------------------------------- [2024-11-21T07:31:38.738Z] [2024-11-21T07:31:38.738Z] TEST TEARDOWN: [2024-11-21T07:31:38.738Z] Nothing to be done for teardown. [2024-11-21T07:31:38.738Z] renaissance-dec-tree_0 Finish Time: Wed Nov 20 23:31:37 2024 Epoch Time (ms): 1732174297778