[2025-10-22T11:16:22.252Z] Running test renaissance-dec-tree_0 ... [2025-10-22T11:16:22.252Z] =============================================== [2025-10-22T11:16:22.252Z] renaissance-dec-tree_0 Start Time: Wed Oct 22 07:16:22 2025 Epoch Time (ms): 1761131782067 [2025-10-22T11:16:22.252Z] variation: NoOptions [2025-10-22T11:16:22.252Z] JVM_OPTIONS: [2025-10-22T11:16:22.252Z] { \ [2025-10-22T11:16:22.252Z] echo ""; echo "TEST SETUP:"; \ [2025-10-22T11:16:22.252Z] echo "Nothing to be done for setup."; \ [2025-10-22T11:16:22.252Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1761131536905/renaissance-dec-tree_0"; \ [2025-10-22T11:16:22.252Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1761131536905/renaissance-dec-tree_0"; \ [2025-10-22T11:16:22.252Z] echo ""; echo "TESTING:"; \ [2025-10-22T11:16:22.252Z] "/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_1761131536905/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-10-22T11:16:22.252Z] 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_1761131536905/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-22T11:16:22.252Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-22T11:16:22.252Z] echo "Nothing to be done for teardown."; \ [2025-10-22T11:16:22.252Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1761131536905/TestTargetResult"; [2025-10-22T11:16:22.252Z] [2025-10-22T11:16:22.252Z] TEST SETUP: [2025-10-22T11:16:22.252Z] Nothing to be done for setup. [2025-10-22T11:16:22.252Z] [2025-10-22T11:16:22.252Z] TESTING: [2025-10-22T11:16:25.383Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-10-22T11:16:26.154Z] WARNING: An illegal reflective access operation has occurred [2025-10-22T11:16:26.154Z] 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_1761131536905/renaissance-dec-tree_0/harness-071622-11774704791491641034/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-10-22T11:16:26.154Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-10-22T11:16:26.154Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-10-22T11:16:26.154Z] WARNING: All illegal access operations will be denied in a future release [2025-10-22T11:16:26.912Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-10-22T11:16:26.912Z] GC before operation: completed in 28.232 ms, heap usage 43.969 MB -> 34.480 MB. [2025-10-22T11:16:31.380Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4529.378 ms) ====== [2025-10-22T11:16:31.380Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-10-22T11:16:31.380Z] GC before operation: completed in 46.900 ms, heap usage 243.839 MB -> 68.319 MB. [2025-10-22T11:16:32.638Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1088.923 ms) ====== [2025-10-22T11:16:32.638Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-10-22T11:16:32.638Z] GC before operation: completed in 47.630 ms, heap usage 164.469 MB -> 68.756 MB. [2025-10-22T11:16:33.418Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (840.114 ms) ====== [2025-10-22T11:16:33.418Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-10-22T11:16:33.418Z] GC before operation: completed in 48.002 ms, heap usage 261.314 MB -> 69.024 MB. [2025-10-22T11:16:34.198Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (817.962 ms) ====== [2025-10-22T11:16:34.198Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-10-22T11:16:34.198Z] GC before operation: completed in 52.276 ms, heap usage 137.395 MB -> 69.251 MB. [2025-10-22T11:16:34.992Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (804.373 ms) ====== [2025-10-22T11:16:34.992Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-10-22T11:16:34.992Z] GC before operation: completed in 51.503 ms, heap usage 262.051 MB -> 69.315 MB. [2025-10-22T11:16:35.781Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (788.053 ms) ====== [2025-10-22T11:16:35.781Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-10-22T11:16:35.781Z] GC before operation: completed in 51.464 ms, heap usage 114.765 MB -> 69.366 MB. [2025-10-22T11:16:36.598Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (746.893 ms) ====== [2025-10-22T11:16:36.598Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-10-22T11:16:36.598Z] GC before operation: completed in 54.971 ms, heap usage 316.961 MB -> 69.781 MB. [2025-10-22T11:16:37.363Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (696.914 ms) ====== [2025-10-22T11:16:37.363Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-10-22T11:16:37.363Z] GC before operation: completed in 56.289 ms, heap usage 229.177 MB -> 70.045 MB. [2025-10-22T11:16:38.138Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (691.955 ms) ====== [2025-10-22T11:16:38.138Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-10-22T11:16:38.138Z] GC before operation: completed in 59.695 ms, heap usage 205.739 MB -> 70.012 MB. [2025-10-22T11:16:38.917Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (698.011 ms) ====== [2025-10-22T11:16:38.917Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-10-22T11:16:38.917Z] GC before operation: completed in 55.536 ms, heap usage 239.318 MB -> 70.127 MB. [2025-10-22T11:16:39.677Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (718.716 ms) ====== [2025-10-22T11:16:39.677Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-10-22T11:16:39.677Z] GC before operation: completed in 58.047 ms, heap usage 218.510 MB -> 70.251 MB. [2025-10-22T11:16:40.444Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (684.114 ms) ====== [2025-10-22T11:16:40.444Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-10-22T11:16:40.444Z] GC before operation: completed in 69.022 ms, heap usage 199.395 MB -> 70.366 MB. [2025-10-22T11:16:41.229Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (694.554 ms) ====== [2025-10-22T11:16:41.229Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-10-22T11:16:41.229Z] GC before operation: completed in 78.185 ms, heap usage 243.841 MB -> 70.487 MB. [2025-10-22T11:16:41.998Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (679.191 ms) ====== [2025-10-22T11:16:41.998Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-10-22T11:16:41.998Z] GC before operation: completed in 68.567 ms, heap usage 375.643 MB -> 70.761 MB. [2025-10-22T11:16:42.801Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (690.382 ms) ====== [2025-10-22T11:16:42.801Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-10-22T11:16:42.801Z] GC before operation: completed in 66.680 ms, heap usage 182.671 MB -> 70.733 MB. [2025-10-22T11:16:43.624Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (687.208 ms) ====== [2025-10-22T11:16:43.624Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-10-22T11:16:43.624Z] GC before operation: completed in 67.983 ms, heap usage 143.516 MB -> 71.036 MB. [2025-10-22T11:16:44.417Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (639.448 ms) ====== [2025-10-22T11:16:44.417Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-10-22T11:16:44.417Z] GC before operation: completed in 67.610 ms, heap usage 275.017 MB -> 71.015 MB. [2025-10-22T11:16:44.789Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (683.846 ms) ====== [2025-10-22T11:16:44.789Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-10-22T11:16:45.142Z] GC before operation: completed in 69.826 ms, heap usage 183.636 MB -> 70.821 MB. [2025-10-22T11:16:45.506Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (662.946 ms) ====== [2025-10-22T11:16:45.506Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-10-22T11:16:45.875Z] GC before operation: completed in 71.945 ms, heap usage 123.893 MB -> 70.600 MB. [2025-10-22T11:16:46.655Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (678.219 ms) ====== [2025-10-22T11:16:46.655Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-10-22T11:16:46.655Z] GC before operation: completed in 71.456 ms, heap usage 376.857 MB -> 71.343 MB. [2025-10-22T11:16:47.042Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (633.130 ms) ====== [2025-10-22T11:16:47.042Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-10-22T11:16:47.042Z] GC before operation: completed in 72.784 ms, heap usage 171.363 MB -> 71.417 MB. [2025-10-22T11:16:47.815Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (657.523 ms) ====== [2025-10-22T11:16:47.815Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-10-22T11:16:47.815Z] GC before operation: completed in 73.466 ms, heap usage 242.394 MB -> 71.535 MB. [2025-10-22T11:16:48.577Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (648.709 ms) ====== [2025-10-22T11:16:48.577Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-10-22T11:16:48.577Z] GC before operation: completed in 73.623 ms, heap usage 243.487 MB -> 71.643 MB. [2025-10-22T11:16:49.352Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (662.912 ms) ====== [2025-10-22T11:16:49.352Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-10-22T11:16:49.352Z] GC before operation: completed in 98.775 ms, heap usage 171.781 MB -> 71.453 MB. [2025-10-22T11:16:50.144Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (752.641 ms) ====== [2025-10-22T11:16:50.144Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-10-22T11:16:50.144Z] GC before operation: completed in 75.470 ms, heap usage 243.798 MB -> 71.859 MB. [2025-10-22T11:16:50.925Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (646.524 ms) ====== [2025-10-22T11:16:50.925Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-10-22T11:16:50.925Z] GC before operation: completed in 75.707 ms, heap usage 108.844 MB -> 71.332 MB. [2025-10-22T11:16:51.703Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (674.722 ms) ====== [2025-10-22T11:16:51.703Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-10-22T11:16:51.703Z] GC before operation: completed in 74.198 ms, heap usage 353.303 MB -> 72.072 MB. [2025-10-22T11:16:52.483Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (711.756 ms) ====== [2025-10-22T11:16:52.483Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-10-22T11:16:52.483Z] GC before operation: completed in 74.834 ms, heap usage 274.291 MB -> 72.177 MB. [2025-10-22T11:16:53.264Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (688.677 ms) ====== [2025-10-22T11:16:53.264Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-10-22T11:16:53.264Z] GC before operation: completed in 78.348 ms, heap usage 365.330 MB -> 72.287 MB. [2025-10-22T11:16:54.108Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (666.004 ms) ====== [2025-10-22T11:16:54.108Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-10-22T11:16:54.108Z] GC before operation: completed in 77.192 ms, heap usage 351.590 MB -> 72.391 MB. [2025-10-22T11:16:54.875Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (684.287 ms) ====== [2025-10-22T11:16:54.875Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-10-22T11:16:54.875Z] GC before operation: completed in 76.163 ms, heap usage 321.760 MB -> 72.501 MB. [2025-10-22T11:16:55.679Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (702.647 ms) ====== [2025-10-22T11:16:55.679Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-10-22T11:16:55.679Z] GC before operation: completed in 82.889 ms, heap usage 143.753 MB -> 72.283 MB. [2025-10-22T11:16:56.444Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (732.643 ms) ====== [2025-10-22T11:16:56.444Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-10-22T11:16:56.444Z] GC before operation: completed in 82.230 ms, heap usage 293.214 MB -> 72.715 MB. [2025-10-22T11:16:57.223Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (693.724 ms) ====== [2025-10-22T11:16:57.223Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-10-22T11:16:57.223Z] GC before operation: completed in 79.933 ms, heap usage 111.277 MB -> 72.157 MB. [2025-10-22T11:16:58.009Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (737.475 ms) ====== [2025-10-22T11:16:58.009Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-10-22T11:16:58.009Z] GC before operation: completed in 101.208 ms, heap usage 247.575 MB -> 72.898 MB. [2025-10-22T11:16:58.780Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (667.697 ms) ====== [2025-10-22T11:16:58.780Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-10-22T11:16:58.780Z] GC before operation: completed in 80.449 ms, heap usage 112.304 MB -> 72.689 MB. [2025-10-22T11:16:59.568Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (655.416 ms) ====== [2025-10-22T11:16:59.568Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-10-22T11:16:59.568Z] GC before operation: completed in 83.282 ms, heap usage 356.968 MB -> 86.034 MB. [2025-10-22T11:16:59.926Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (621.615 ms) ====== [2025-10-22T11:16:59.926Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-10-22T11:17:00.312Z] GC before operation: completed in 93.166 ms, heap usage 152.769 MB -> 73.226 MB. [2025-10-22T11:17:00.720Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (663.328 ms) ====== [2025-10-22T11:17:00.720Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-10-22T11:17:01.078Z] GC before operation: completed in 80.270 ms, heap usage 145.714 MB -> 73.326 MB. [2025-10-22T11:17:01.483Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (655.510 ms) ====== [2025-10-22T11:17:01.858Z] ----------------------------------- [2025-10-22T11:17:01.858Z] renaissance-dec-tree_0_PASSED [2025-10-22T11:17:01.858Z] ----------------------------------- [2025-10-22T11:17:01.858Z] [2025-10-22T11:17:01.858Z] TEST TEARDOWN: [2025-10-22T11:17:01.858Z] Nothing to be done for teardown. [2025-10-22T11:17:01.858Z] renaissance-dec-tree_0 Finish Time: Wed Oct 22 07:17:01 2025 Epoch Time (ms): 1761131821509