[2025-02-05T22:27:03.517Z] Running test renaissance-dec-tree_0 ... [2025-02-05T22:27:03.517Z] =============================================== [2025-02-05T22:27:03.517Z] renaissance-dec-tree_0 Start Time: Wed Feb 5 17:27:03 2025 Epoch Time (ms): 1738794423336 [2025-02-05T22:27:03.517Z] variation: NoOptions [2025-02-05T22:27:03.517Z] JVM_OPTIONS: [2025-02-05T22:27:03.517Z] { \ [2025-02-05T22:27:03.517Z] echo ""; echo "TEST SETUP:"; \ [2025-02-05T22:27:03.517Z] echo "Nothing to be done for setup."; \ [2025-02-05T22:27:03.517Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387942506025/renaissance-dec-tree_0"; \ [2025-02-05T22:27:03.517Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387942506025/renaissance-dec-tree_0"; \ [2025-02-05T22:27:03.517Z] echo ""; echo "TESTING:"; \ [2025-02-05T22:27:03.517Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/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_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387942506025/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-05T22:27:03.517Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387942506025/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-05T22:27:03.517Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-05T22:27:03.517Z] echo "Nothing to be done for teardown."; \ [2025-02-05T22:27:03.517Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17387942506025/TestTargetResult"; [2025-02-05T22:27:03.517Z] [2025-02-05T22:27:03.517Z] TEST SETUP: [2025-02-05T22:27:03.517Z] Nothing to be done for setup. [2025-02-05T22:27:03.517Z] [2025-02-05T22:27:03.517Z] TESTING: [2025-02-05T22:27:06.143Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-05T22:27:06.554Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-02-05T22:27:06.963Z] WARNING: An illegal reflective access operation has occurred [2025-02-05T22:27:06.963Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_17387942506025/renaissance-dec-tree_0/harness-172703-275310774447905836/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-05T22:27:06.963Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-05T22:27:06.963Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-05T22:27:06.963Z] WARNING: All illegal access operations will be denied in a future release [2025-02-05T22:27:08.324Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-05T22:27:08.324Z] GC before operation: completed in 30.133 ms, heap usage 37.875 MB -> 33.833 MB. [2025-02-05T22:27:12.667Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4246.709 ms) ====== [2025-02-05T22:27:12.667Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-05T22:27:12.667Z] GC before operation: completed in 41.043 ms, heap usage 269.796 MB -> 63.838 MB. [2025-02-05T22:27:13.567Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1178.701 ms) ====== [2025-02-05T22:27:13.567Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-05T22:27:13.567Z] GC before operation: completed in 42.983 ms, heap usage 244.978 MB -> 63.993 MB. [2025-02-05T22:27:14.435Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (891.907 ms) ====== [2025-02-05T22:27:14.435Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-05T22:27:14.883Z] GC before operation: completed in 47.317 ms, heap usage 165.621 MB -> 64.624 MB. [2025-02-05T22:27:15.292Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (813.091 ms) ====== [2025-02-05T22:27:15.292Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-05T22:27:15.715Z] GC before operation: completed in 44.520 ms, heap usage 177.882 MB -> 64.487 MB. [2025-02-05T22:27:16.575Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (815.033 ms) ====== [2025-02-05T22:27:16.575Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-05T22:27:16.575Z] GC before operation: completed in 47.153 ms, heap usage 214.340 MB -> 64.689 MB. [2025-02-05T22:27:17.462Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (927.021 ms) ====== [2025-02-05T22:27:17.462Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-05T22:27:17.462Z] GC before operation: completed in 49.184 ms, heap usage 172.234 MB -> 64.894 MB. [2025-02-05T22:27:18.345Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (769.935 ms) ====== [2025-02-05T22:27:18.345Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-05T22:27:18.346Z] GC before operation: completed in 49.675 ms, heap usage 138.350 MB -> 65.124 MB. [2025-02-05T22:27:19.222Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (762.937 ms) ====== [2025-02-05T22:27:19.222Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-05T22:27:19.222Z] GC before operation: completed in 57.711 ms, heap usage 142.048 MB -> 65.234 MB. [2025-02-05T22:27:19.617Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (793.413 ms) ====== [2025-02-05T22:27:19.617Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-05T22:27:20.021Z] GC before operation: completed in 63.817 ms, heap usage 181.826 MB -> 65.508 MB. [2025-02-05T22:27:20.878Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (784.339 ms) ====== [2025-02-05T22:27:20.878Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-05T22:27:20.878Z] GC before operation: completed in 62.068 ms, heap usage 169.779 MB -> 65.622 MB. [2025-02-05T22:27:21.361Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (796.012 ms) ====== [2025-02-05T22:27:21.361Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-05T22:27:21.754Z] GC before operation: completed in 60.856 ms, heap usage 116.186 MB -> 65.307 MB. [2025-02-05T22:27:22.161Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (664.141 ms) ====== [2025-02-05T22:27:22.161Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-05T22:27:22.161Z] GC before operation: completed in 54.720 ms, heap usage 212.067 MB -> 65.699 MB. [2025-02-05T22:27:23.005Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (657.868 ms) ====== [2025-02-05T22:27:23.005Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-05T22:27:23.005Z] GC before operation: completed in 61.317 ms, heap usage 156.692 MB -> 65.951 MB. [2025-02-05T22:27:23.854Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (621.904 ms) ====== [2025-02-05T22:27:23.854Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-05T22:27:23.854Z] GC before operation: completed in 52.831 ms, heap usage 170.253 MB -> 65.922 MB. [2025-02-05T22:27:24.246Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (695.664 ms) ====== [2025-02-05T22:27:24.246Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-05T22:27:24.638Z] GC before operation: completed in 68.661 ms, heap usage 236.131 MB -> 66.031 MB. [2025-02-05T22:27:25.030Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (647.003 ms) ====== [2025-02-05T22:27:25.030Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-05T22:27:25.030Z] GC before operation: completed in 68.816 ms, heap usage 200.793 MB -> 66.345 MB. [2025-02-05T22:27:25.892Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (620.005 ms) ====== [2025-02-05T22:27:25.892Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-05T22:27:25.892Z] GC before operation: completed in 71.873 ms, heap usage 183.638 MB -> 66.300 MB. [2025-02-05T22:27:26.743Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (702.295 ms) ====== [2025-02-05T22:27:26.743Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-05T22:27:26.743Z] GC before operation: completed in 69.968 ms, heap usage 195.903 MB -> 66.412 MB. [2025-02-05T22:27:27.146Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (625.080 ms) ====== [2025-02-05T22:27:27.146Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-05T22:27:27.146Z] GC before operation: completed in 68.493 ms, heap usage 174.022 MB -> 66.512 MB. [2025-02-05T22:27:28.016Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (637.984 ms) ====== [2025-02-05T22:27:28.016Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-05T22:27:28.016Z] GC before operation: completed in 81.054 ms, heap usage 183.062 MB -> 66.590 MB. [2025-02-05T22:27:28.865Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (655.665 ms) ====== [2025-02-05T22:27:28.865Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-05T22:27:28.865Z] GC before operation: completed in 83.078 ms, heap usage 226.006 MB -> 81.565 MB. [2025-02-05T22:27:29.263Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (668.340 ms) ====== [2025-02-05T22:27:29.263Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-05T22:27:29.654Z] GC before operation: completed in 80.442 ms, heap usage 227.256 MB -> 66.796 MB. [2025-02-05T22:27:30.067Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (672.885 ms) ====== [2025-02-05T22:27:30.067Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-05T22:27:30.465Z] GC before operation: completed in 77.141 ms, heap usage 170.791 MB -> 66.891 MB. [2025-02-05T22:27:30.867Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (697.091 ms) ====== [2025-02-05T22:27:30.867Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-05T22:27:30.867Z] GC before operation: completed in 78.748 ms, heap usage 101.838 MB -> 66.715 MB. [2025-02-05T22:27:31.710Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (633.280 ms) ====== [2025-02-05T22:27:31.710Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-05T22:27:31.710Z] GC before operation: completed in 71.742 ms, heap usage 188.415 MB -> 67.244 MB. [2025-02-05T22:27:32.563Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (597.739 ms) ====== [2025-02-05T22:27:32.563Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-05T22:27:32.563Z] GC before operation: completed in 72.091 ms, heap usage 256.578 MB -> 67.373 MB. [2025-02-05T22:27:32.957Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (612.816 ms) ====== [2025-02-05T22:27:32.957Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-05T22:27:32.957Z] GC before operation: completed in 73.759 ms, heap usage 140.401 MB -> 67.312 MB. [2025-02-05T22:27:33.817Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (608.969 ms) ====== [2025-02-05T22:27:33.817Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-05T22:27:33.817Z] GC before operation: completed in 72.588 ms, heap usage 181.219 MB -> 67.425 MB. [2025-02-05T22:27:34.212Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (598.191 ms) ====== [2025-02-05T22:27:34.212Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-05T22:27:34.613Z] GC before operation: completed in 71.467 ms, heap usage 193.618 MB -> 67.528 MB. [2025-02-05T22:27:35.005Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (600.182 ms) ====== [2025-02-05T22:27:35.005Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-05T22:27:35.005Z] GC before operation: completed in 73.057 ms, heap usage 237.667 MB -> 67.622 MB. [2025-02-05T22:27:35.860Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (575.654 ms) ====== [2025-02-05T22:27:35.860Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-05T22:27:35.860Z] GC before operation: completed in 76.381 ms, heap usage 159.745 MB -> 67.459 MB. [2025-02-05T22:27:36.259Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (600.117 ms) ====== [2025-02-05T22:27:36.259Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-05T22:27:36.674Z] GC before operation: completed in 77.290 ms, heap usage 117.511 MB -> 67.266 MB. [2025-02-05T22:27:37.079Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (587.228 ms) ====== [2025-02-05T22:27:37.079Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-05T22:27:37.079Z] GC before operation: completed in 74.737 ms, heap usage 105.565 MB -> 67.360 MB. [2025-02-05T22:27:37.926Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (586.508 ms) ====== [2025-02-05T22:27:37.926Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-05T22:27:37.926Z] GC before operation: completed in 74.908 ms, heap usage 195.263 MB -> 68.018 MB. [2025-02-05T22:27:38.316Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (592.639 ms) ====== [2025-02-05T22:27:38.316Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-05T22:27:38.316Z] GC before operation: completed in 77.914 ms, heap usage 129.072 MB -> 67.799 MB. [2025-02-05T22:27:39.194Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (585.874 ms) ====== [2025-02-05T22:27:39.194Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-05T22:27:39.194Z] GC before operation: completed in 76.399 ms, heap usage 113.046 MB -> 67.769 MB. [2025-02-05T22:27:39.617Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (596.854 ms) ====== [2025-02-05T22:27:39.617Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-05T22:27:39.617Z] GC before operation: completed in 76.377 ms, heap usage 143.885 MB -> 68.266 MB. [2025-02-05T22:27:40.477Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (565.357 ms) ====== [2025-02-05T22:27:40.477Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-05T22:27:40.477Z] GC before operation: completed in 76.078 ms, heap usage 159.859 MB -> 68.386 MB. [2025-02-05T22:27:40.890Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (563.063 ms) ====== [2025-02-05T22:27:40.891Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-05T22:27:41.293Z] GC before operation: completed in 76.759 ms, heap usage 202.885 MB -> 68.631 MB. [2025-02-05T22:27:41.685Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (619.429 ms) ====== [2025-02-05T22:27:41.685Z] ----------------------------------- [2025-02-05T22:27:41.685Z] renaissance-dec-tree_0_PASSED [2025-02-05T22:27:41.685Z] ----------------------------------- [2025-02-05T22:27:41.685Z] [2025-02-05T22:27:41.685Z] TEST TEARDOWN: [2025-02-05T22:27:41.685Z] Nothing to be done for teardown. [2025-02-05T22:27:41.685Z] renaissance-dec-tree_0 Finish Time: Wed Feb 5 17:27:41 2025 Epoch Time (ms): 1738794461600