[2024-12-05T06:01:32.053Z] Running test renaissance-dec-tree_0 ... [2024-12-05T06:01:32.053Z] =============================================== [2024-12-05T06:01:32.501Z] renaissance-dec-tree_0 Start Time: Wed Dec 4 22:01:31 2024 Epoch Time (ms): 1733378491448 [2024-12-05T06:01:32.501Z] variation: NoOptions [2024-12-05T06:01:32.501Z] JVM_OPTIONS: [2024-12-05T06:01:32.501Z] { \ [2024-12-05T06:01:32.501Z] echo ""; echo "TEST SETUP:"; \ [2024-12-05T06:01:32.501Z] echo "Nothing to be done for setup."; \ [2024-12-05T06:01:32.501Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17333780287190/renaissance-dec-tree_0"; \ [2024-12-05T06:01:32.501Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17333780287190/renaissance-dec-tree_0"; \ [2024-12-05T06:01:32.501Z] echo ""; echo "TESTING:"; \ [2024-12-05T06:01:32.501Z] "/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_17333780287190/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-12-05T06:01:32.501Z] 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_17333780287190/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-12-05T06:01:32.501Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-12-05T06:01:32.501Z] echo "Nothing to be done for teardown."; \ [2024-12-05T06:01:32.501Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17333780287190/TestTargetResult"; [2024-12-05T06:01:32.501Z] [2024-12-05T06:01:32.501Z] TEST SETUP: [2024-12-05T06:01:32.501Z] Nothing to be done for setup. [2024-12-05T06:01:32.501Z] [2024-12-05T06:01:32.501Z] TESTING: [2024-12-05T06:01:56.261Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-12-05T06:02:00.767Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-12-05T06:02:19.936Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-12-05T06:02:19.936Z] GC before operation: completed in 98.106 ms, heap usage 51.196 MB -> 35.513 MB. [2024-12-05T06:03:05.942Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (44780.658 ms) ====== [2024-12-05T06:03:05.942Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-12-05T06:03:05.942Z] GC before operation: completed in 335.773 ms, heap usage 332.595 MB -> 65.073 MB. [2024-12-05T06:03:18.685Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (15545.071 ms) ====== [2024-12-05T06:03:18.685Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-12-05T06:03:19.538Z] GC before operation: completed in 663.874 ms, heap usage 139.476 MB -> 65.025 MB. [2024-12-05T06:03:29.983Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (11203.396 ms) ====== [2024-12-05T06:03:29.983Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-12-05T06:03:30.830Z] GC before operation: completed in 274.867 ms, heap usage 352.830 MB -> 65.577 MB. [2024-12-05T06:03:41.275Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9745.612 ms) ====== [2024-12-05T06:03:41.275Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-12-05T06:03:41.275Z] GC before operation: completed in 260.170 ms, heap usage 273.990 MB -> 93.458 MB. [2024-12-05T06:03:41.275Z] 24/12/04 22:03:40 WARN BlockManager: Asked to remove block broadcast_50, which does not exist [2024-12-05T06:03:51.922Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (11210.526 ms) ====== [2024-12-05T06:03:51.922Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-12-05T06:03:51.922Z] GC before operation: completed in 329.033 ms, heap usage 503.700 MB -> 81.313 MB. [2024-12-05T06:04:00.391Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (7318.393 ms) ====== [2024-12-05T06:04:00.391Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-12-05T06:04:00.391Z] GC before operation: completed in 228.354 ms, heap usage 262.108 MB -> 66.395 MB. [2024-12-05T06:04:09.388Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (8984.654 ms) ====== [2024-12-05T06:04:09.388Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-12-05T06:04:09.388Z] GC before operation: completed in 229.318 ms, heap usage 311.068 MB -> 94.040 MB. [2024-12-05T06:04:16.584Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (7887.992 ms) ====== [2024-12-05T06:04:16.584Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-12-05T06:04:17.333Z] GC before operation: completed in 288.875 ms, heap usage 302.408 MB -> 94.229 MB. [2024-12-05T06:04:29.549Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (11802.260 ms) ====== [2024-12-05T06:04:29.549Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-12-05T06:04:29.549Z] GC before operation: completed in 174.913 ms, heap usage 450.428 MB -> 67.085 MB. [2024-12-05T06:04:36.276Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (7067.718 ms) ====== [2024-12-05T06:04:36.276Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-12-05T06:04:36.276Z] GC before operation: completed in 257.908 ms, heap usage 196.595 MB -> 67.376 MB. [2024-12-05T06:04:46.893Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (9490.656 ms) ====== [2024-12-05T06:04:46.894Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-12-05T06:04:46.894Z] GC before operation: completed in 254.648 ms, heap usage 120.442 MB -> 79.344 MB. [2024-12-05T06:04:46.894Z] 24/12/04 22:04:45 WARN BlockManager: Asked to remove block rdd_536_0, which does not exist [2024-12-05T06:04:55.620Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (9758.645 ms) ====== [2024-12-05T06:04:55.620Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-12-05T06:04:57.140Z] GC before operation: completed in 1406.648 ms, heap usage 268.417 MB -> 67.209 MB. [2024-12-05T06:05:05.384Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (7415.276 ms) ====== [2024-12-05T06:05:05.384Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-12-05T06:05:05.384Z] GC before operation: completed in 320.054 ms, heap usage 134.678 MB -> 94.769 MB. [2024-12-05T06:05:15.602Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (9315.447 ms) ====== [2024-12-05T06:05:15.602Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-12-05T06:05:15.602Z] GC before operation: completed in 213.829 ms, heap usage 532.843 MB -> 67.641 MB. [2024-12-05T06:05:23.008Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (8513.989 ms) ====== [2024-12-05T06:05:23.008Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-12-05T06:05:23.591Z] GC before operation: completed in 325.132 ms, heap usage 311.082 MB -> 67.327 MB. [2024-12-05T06:05:30.822Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (7078.248 ms) ====== [2024-12-05T06:05:30.822Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-12-05T06:05:31.770Z] GC before operation: completed in 772.132 ms, heap usage 283.017 MB -> 67.576 MB. [2024-12-05T06:05:40.132Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (8182.521 ms) ====== [2024-12-05T06:05:40.132Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-12-05T06:05:40.132Z] GC before operation: completed in 470.647 ms, heap usage 228.113 MB -> 67.648 MB. [2024-12-05T06:05:50.032Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (8990.155 ms) ====== [2024-12-05T06:05:50.032Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-12-05T06:05:50.032Z] GC before operation: completed in 199.544 ms, heap usage 156.120 MB -> 67.587 MB. [2024-12-05T06:05:57.229Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (7197.851 ms) ====== [2024-12-05T06:05:57.229Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-12-05T06:05:57.229Z] GC before operation: completed in 688.087 ms, heap usage 107.210 MB -> 95.200 MB. [2024-12-05T06:06:05.235Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (8375.266 ms) ====== [2024-12-05T06:06:05.235Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-12-05T06:06:05.792Z] GC before operation: completed in 236.626 ms, heap usage 242.693 MB -> 68.315 MB. [2024-12-05T06:06:12.454Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (7065.067 ms) ====== [2024-12-05T06:06:12.454Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-12-05T06:06:12.944Z] GC before operation: completed in 227.050 ms, heap usage 284.869 MB -> 68.210 MB. [2024-12-05T06:06:21.185Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (8332.465 ms) ====== [2024-12-05T06:06:21.185Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-12-05T06:06:21.835Z] GC before operation: completed in 465.464 ms, heap usage 335.445 MB -> 68.205 MB. [2024-12-05T06:06:37.071Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (14963.970 ms) ====== [2024-12-05T06:06:37.071Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-12-05T06:06:37.071Z] GC before operation: completed in 207.232 ms, heap usage 161.726 MB -> 96.199 MB. [2024-12-05T06:06:44.880Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (7276.944 ms) ====== [2024-12-05T06:06:44.880Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-12-05T06:06:44.880Z] GC before operation: completed in 251.539 ms, heap usage 339.228 MB -> 96.030 MB. [2024-12-05T06:06:52.114Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (7027.659 ms) ====== [2024-12-05T06:06:52.114Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-12-05T06:06:52.114Z] GC before operation: completed in 282.531 ms, heap usage 201.653 MB -> 68.393 MB. [2024-12-05T06:07:00.811Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (7913.092 ms) ====== [2024-12-05T06:07:00.811Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-12-05T06:07:00.811Z] GC before operation: completed in 420.858 ms, heap usage 137.457 MB -> 68.251 MB. [2024-12-05T06:07:08.164Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (8295.299 ms) ====== [2024-12-05T06:07:08.164Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-12-05T06:07:09.399Z] GC before operation: completed in 881.937 ms, heap usage 206.149 MB -> 68.840 MB. [2024-12-05T06:07:17.359Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (7022.221 ms) ====== [2024-12-05T06:07:17.359Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-12-05T06:07:17.359Z] GC before operation: completed in 176.303 ms, heap usage 131.250 MB -> 68.793 MB. [2024-12-05T06:07:24.125Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (7394.779 ms) ====== [2024-12-05T06:07:24.125Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-12-05T06:07:24.125Z] GC before operation: completed in 285.821 ms, heap usage 199.215 MB -> 69.042 MB. [2024-12-05T06:07:32.390Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (7818.413 ms) ====== [2024-12-05T06:07:32.390Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-12-05T06:07:33.021Z] GC before operation: completed in 832.377 ms, heap usage 308.108 MB -> 96.543 MB. [2024-12-05T06:07:41.073Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (8173.627 ms) ====== [2024-12-05T06:07:41.073Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-12-05T06:07:42.039Z] GC before operation: completed in 380.364 ms, heap usage 582.543 MB -> 69.299 MB. [2024-12-05T06:07:48.955Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (6628.506 ms) ====== [2024-12-05T06:07:48.955Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-12-05T06:07:48.955Z] GC before operation: completed in 308.989 ms, heap usage 307.115 MB -> 69.166 MB. [2024-12-05T06:07:48.955Z] 24/12/04 22:07:47 WARN BlockManager: Asked to remove block broadcast_446, which does not exist [2024-12-05T06:07:55.473Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (7126.507 ms) ====== [2024-12-05T06:07:55.473Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-12-05T06:07:56.572Z] GC before operation: completed in 840.030 ms, heap usage 369.603 MB -> 69.360 MB. [2024-12-05T06:08:02.087Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5085.796 ms) ====== [2024-12-05T06:08:02.087Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-12-05T06:08:02.701Z] GC before operation: completed in 1092.904 ms, heap usage 211.409 MB -> 97.456 MB. [2024-12-05T06:08:10.838Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (7775.126 ms) ====== [2024-12-05T06:08:10.838Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-12-05T06:08:10.838Z] GC before operation: completed in 197.636 ms, heap usage 118.134 MB -> 69.749 MB. [2024-12-05T06:08:17.654Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (6733.191 ms) ====== [2024-12-05T06:08:17.654Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-12-05T06:08:18.221Z] GC before operation: completed in 924.345 ms, heap usage 137.503 MB -> 84.341 MB. [2024-12-05T06:08:24.642Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6021.735 ms) ====== [2024-12-05T06:08:24.642Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-12-05T06:08:24.642Z] GC before operation: completed in 392.663 ms, heap usage 570.640 MB -> 97.608 MB. [2024-12-05T06:08:32.867Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (7706.491 ms) ====== [2024-12-05T06:08:32.867Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-12-05T06:08:33.378Z] GC before operation: completed in 1024.901 ms, heap usage 501.028 MB -> 97.744 MB. [2024-12-05T06:08:40.143Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (6961.344 ms) ====== [2024-12-05T06:08:40.143Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-12-05T06:08:41.204Z] GC before operation: completed in 327.162 ms, heap usage 554.154 MB -> 97.772 MB. [2024-12-05T06:08:47.989Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (7511.945 ms) ====== [2024-12-05T06:08:49.069Z] ----------------------------------- [2024-12-05T06:08:49.069Z] renaissance-dec-tree_0_PASSED [2024-12-05T06:08:49.069Z] ----------------------------------- [2024-12-05T06:08:49.069Z] [2024-12-05T06:08:49.069Z] TEST TEARDOWN: [2024-12-05T06:08:49.069Z] Nothing to be done for teardown. [2024-12-05T06:08:49.069Z] renaissance-dec-tree_0 Finish Time: Wed Dec 4 22:08:48 2024 Epoch Time (ms): 1733378928189