[2025-12-04T11:41:20.064Z] Running test renaissance-dec-tree_0 ... [2025-12-04T11:41:20.064Z] =============================================== [2025-12-04T11:41:20.064Z] renaissance-dec-tree_0 Start Time: Thu Dec 4 03:41:18 2025 Epoch Time (ms): 1764848478056 [2025-12-04T11:41:20.064Z] variation: NoOptions [2025-12-04T11:41:20.064Z] JVM_OPTIONS: [2025-12-04T11:41:20.064Z] { \ [2025-12-04T11:41:20.064Z] echo ""; echo "TEST SETUP:"; \ [2025-12-04T11:41:20.064Z] echo "Nothing to be done for setup."; \ [2025-12-04T11:41:20.064Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17648478159843/renaissance-dec-tree_0"; \ [2025-12-04T11:41:20.064Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17648478159843/renaissance-dec-tree_0"; \ [2025-12-04T11:41:20.064Z] echo ""; echo "TESTING:"; \ [2025-12-04T11:41:20.064Z] "/Users/admin/workspace/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17648478159843/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-12-04T11:41:20.064Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17648478159843/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-04T11:41:20.064Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-04T11:41:20.064Z] echo "Nothing to be done for teardown."; \ [2025-12-04T11:41:20.064Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17648478159843/TestTargetResult"; [2025-12-04T11:41:20.064Z] [2025-12-04T11:41:20.064Z] TEST SETUP: [2025-12-04T11:41:20.064Z] Nothing to be done for setup. [2025-12-04T11:41:20.064Z] [2025-12-04T11:41:20.064Z] TESTING: [2025-12-04T11:41:39.872Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-04T11:41:39.872Z] WARNING: An illegal reflective access operation has occurred [2025-12-04T11:41:39.872Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/output_17648478159843/renaissance-dec-tree_0/harness-034119-11486399752656627769/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-12-04T11:41:39.872Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-12-04T11:41:39.872Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-12-04T11:41:39.872Z] WARNING: All illegal access operations will be denied in a future release [2025-12-04T11:41:42.008Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-12-04T11:41:42.427Z] GC before operation: completed in 94.467 ms, heap usage 141.090 MB -> 34.619 MB. [2025-12-04T11:42:07.408Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (25120.626 ms) ====== [2025-12-04T11:42:07.408Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-12-04T11:42:07.936Z] GC before operation: completed in 423.727 ms, heap usage 235.072 MB -> 68.660 MB. [2025-12-04T11:42:18.727Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (9792.076 ms) ====== [2025-12-04T11:42:18.727Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-12-04T11:42:18.727Z] GC before operation: completed in 382.160 ms, heap usage 301.106 MB -> 69.212 MB. [2025-12-04T11:42:26.066Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (7574.598 ms) ====== [2025-12-04T11:42:26.066Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-12-04T11:42:26.066Z] GC before operation: completed in 279.245 ms, heap usage 115.598 MB -> 69.149 MB. [2025-12-04T11:42:33.241Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (6720.407 ms) ====== [2025-12-04T11:42:33.241Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-12-04T11:42:33.241Z] GC before operation: completed in 241.176 ms, heap usage 250.678 MB -> 69.306 MB. [2025-12-04T11:42:40.592Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (7194.360 ms) ====== [2025-12-04T11:42:40.592Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-12-04T11:42:40.592Z] GC before operation: completed in 237.647 ms, heap usage 264.748 MB -> 97.111 MB. [2025-12-04T11:42:45.359Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4457.863 ms) ====== [2025-12-04T11:42:45.359Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-12-04T11:42:45.359Z] GC before operation: completed in 305.884 ms, heap usage 198.978 MB -> 97.020 MB. [2025-12-04T11:42:45.359Z] 03:42:43.572 WARN [block-manager-storage-async-thread-pool-88] org.apache.spark.storage.BlockManager - Asked to remove block rdd_285_2, which does not exist [2025-12-04T11:42:50.080Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (4929.466 ms) ====== [2025-12-04T11:42:50.080Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-12-04T11:42:50.080Z] GC before operation: completed in 210.638 ms, heap usage 447.687 MB -> 70.139 MB. [2025-12-04T11:42:54.894Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4652.224 ms) ====== [2025-12-04T11:42:54.894Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-12-04T11:42:54.894Z] GC before operation: completed in 316.622 ms, heap usage 282.089 MB -> 70.037 MB. [2025-12-04T11:43:00.589Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4898.895 ms) ====== [2025-12-04T11:43:00.589Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-12-04T11:43:00.589Z] GC before operation: completed in 165.036 ms, heap usage 279.058 MB -> 75.966 MB. [2025-12-04T11:43:03.544Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3589.115 ms) ====== [2025-12-04T11:43:03.544Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-12-04T11:43:03.973Z] GC before operation: completed in 258.045 ms, heap usage 379.391 MB -> 70.406 MB. [2025-12-04T11:43:07.671Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3805.040 ms) ====== [2025-12-04T11:43:07.671Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-12-04T11:43:08.083Z] GC before operation: completed in 244.973 ms, heap usage 362.062 MB -> 70.530 MB. [2025-12-04T11:43:12.582Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3874.887 ms) ====== [2025-12-04T11:43:12.582Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-12-04T11:43:12.582Z] GC before operation: completed in 159.298 ms, heap usage 247.530 MB -> 70.503 MB. [2025-12-04T11:43:16.429Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3875.249 ms) ====== [2025-12-04T11:43:16.429Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-12-04T11:43:16.429Z] GC before operation: completed in 471.632 ms, heap usage 331.403 MB -> 70.755 MB. [2025-12-04T11:43:29.276Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (12138.878 ms) ====== [2025-12-04T11:43:29.276Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-12-04T11:43:29.276Z] GC before operation: completed in 651.827 ms, heap usage 324.591 MB -> 70.869 MB. [2025-12-04T11:43:31.981Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2444.723 ms) ====== [2025-12-04T11:43:31.981Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-12-04T11:43:31.981Z] GC before operation: completed in 157.767 ms, heap usage 109.636 MB -> 98.144 MB. [2025-12-04T11:43:34.623Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2650.831 ms) ====== [2025-12-04T11:43:34.623Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-12-04T11:43:34.623Z] GC before operation: completed in 232.617 ms, heap usage 244.890 MB -> 71.021 MB. [2025-12-04T11:43:38.154Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (3539.122 ms) ====== [2025-12-04T11:43:38.154Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-12-04T11:43:38.548Z] GC before operation: completed in 174.127 ms, heap usage 160.044 MB -> 70.954 MB. [2025-12-04T11:43:43.255Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4280.907 ms) ====== [2025-12-04T11:43:43.255Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-12-04T11:43:43.255Z] GC before operation: completed in 244.622 ms, heap usage 232.887 MB -> 98.835 MB. [2025-12-04T11:43:46.067Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2993.291 ms) ====== [2025-12-04T11:43:46.067Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-12-04T11:43:46.067Z] GC before operation: completed in 207.339 ms, heap usage 420.989 MB -> 71.346 MB. [2025-12-04T11:43:49.506Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3085.304 ms) ====== [2025-12-04T11:43:49.506Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-12-04T11:43:49.506Z] GC before operation: completed in 176.206 ms, heap usage 343.320 MB -> 71.600 MB. [2025-12-04T11:43:52.136Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2418.387 ms) ====== [2025-12-04T11:43:52.137Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-12-04T11:43:52.137Z] GC before operation: completed in 136.594 ms, heap usage 391.908 MB -> 88.234 MB. [2025-12-04T11:43:54.115Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2319.904 ms) ====== [2025-12-04T11:43:54.115Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-12-04T11:43:54.512Z] GC before operation: completed in 184.292 ms, heap usage 398.230 MB -> 71.627 MB. [2025-12-04T11:43:56.593Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2121.483 ms) ====== [2025-12-04T11:43:56.593Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-12-04T11:43:57.016Z] GC before operation: completed in 217.225 ms, heap usage 127.488 MB -> 71.109 MB. [2025-12-04T11:44:00.724Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3554.637 ms) ====== [2025-12-04T11:44:00.724Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-12-04T11:44:00.724Z] GC before operation: completed in 149.341 ms, heap usage 127.075 MB -> 71.362 MB. [2025-12-04T11:44:03.643Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (3277.746 ms) ====== [2025-12-04T11:44:03.643Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-12-04T11:44:04.083Z] GC before operation: completed in 239.909 ms, heap usage 337.635 MB -> 99.542 MB. [2025-12-04T11:44:08.447Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (4253.275 ms) ====== [2025-12-04T11:44:08.447Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-12-04T11:44:08.447Z] GC before operation: completed in 305.638 ms, heap usage 448.755 MB -> 99.659 MB. [2025-12-04T11:44:11.920Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3391.273 ms) ====== [2025-12-04T11:44:11.920Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-12-04T11:44:12.325Z] GC before operation: completed in 236.459 ms, heap usage 358.914 MB -> 72.387 MB. [2025-12-04T11:44:15.161Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3036.237 ms) ====== [2025-12-04T11:44:15.161Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-12-04T11:44:15.604Z] GC before operation: completed in 193.299 ms, heap usage 240.965 MB -> 72.418 MB. [2025-12-04T11:44:18.407Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2942.696 ms) ====== [2025-12-04T11:44:18.407Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-12-04T11:44:18.407Z] GC before operation: completed in 150.582 ms, heap usage 255.582 MB -> 83.671 MB. [2025-12-04T11:44:22.375Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3470.692 ms) ====== [2025-12-04T11:44:22.375Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-12-04T11:44:22.375Z] GC before operation: completed in 247.941 ms, heap usage 413.827 MB -> 72.851 MB. [2025-12-04T11:44:25.466Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2760.657 ms) ====== [2025-12-04T11:44:25.466Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-12-04T11:44:25.968Z] GC before operation: completed in 944.805 ms, heap usage 116.763 MB -> 71.954 MB. [2025-12-04T11:44:30.548Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3815.758 ms) ====== [2025-12-04T11:44:30.548Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-12-04T11:44:30.548Z] GC before operation: completed in 279.546 ms, heap usage 161.772 MB -> 72.684 MB. [2025-12-04T11:44:34.226Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (4216.797 ms) ====== [2025-12-04T11:44:34.226Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-12-04T11:44:34.616Z] GC before operation: completed in 238.292 ms, heap usage 186.801 MB -> 72.796 MB. [2025-12-04T11:44:39.146Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (4039.859 ms) ====== [2025-12-04T11:44:39.146Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-12-04T11:44:39.146Z] GC before operation: completed in 349.011 ms, heap usage 119.711 MB -> 72.585 MB. [2025-12-04T11:44:43.738Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (4788.477 ms) ====== [2025-12-04T11:44:43.738Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-12-04T11:44:44.247Z] GC before operation: completed in 335.523 ms, heap usage 103.635 MB -> 72.820 MB. [2025-12-04T11:44:50.065Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (5522.026 ms) ====== [2025-12-04T11:44:50.065Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-12-04T11:44:50.065Z] GC before operation: completed in 431.119 ms, heap usage 148.743 MB -> 73.113 MB. [2025-12-04T11:44:56.062Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (5833.534 ms) ====== [2025-12-04T11:44:56.062Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-12-04T11:44:56.607Z] GC before operation: completed in 800.151 ms, heap usage 209.863 MB -> 100.840 MB. [2025-12-04T11:45:02.210Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4758.742 ms) ====== [2025-12-04T11:45:02.210Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-12-04T11:45:02.210Z] GC before operation: completed in 279.104 ms, heap usage 189.100 MB -> 100.601 MB. [2025-12-04T11:45:07.056Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4990.206 ms) ====== [2025-12-04T11:45:07.056Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-12-04T11:45:07.056Z] GC before operation: completed in 236.826 ms, heap usage 434.874 MB -> 101.027 MB. [2025-12-04T11:45:10.823Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3409.248 ms) ====== [2025-12-04T11:45:10.823Z] ----------------------------------- [2025-12-04T11:45:10.823Z] renaissance-dec-tree_0_PASSED [2025-12-04T11:45:10.823Z] ----------------------------------- [2025-12-04T11:45:10.823Z] [2025-12-04T11:45:10.823Z] TEST TEARDOWN: [2025-12-04T11:45:10.823Z] Nothing to be done for teardown. [2025-12-04T11:45:11.703Z] renaissance-dec-tree_0 Finish Time: Thu Dec 4 03:45:10 2025 Epoch Time (ms): 1764848710084