[2025-10-01T22:56:51.453Z] Running test renaissance-dec-tree_0 ... [2025-10-01T22:56:51.453Z] =============================================== [2025-10-01T22:56:51.453Z] renaissance-dec-tree_0 Start Time: Wed Oct 1 18:56:51 2025 Epoch Time (ms): 1759359411275 [2025-10-01T22:56:51.454Z] variation: NoOptions [2025-10-01T22:56:51.454Z] JVM_OPTIONS: [2025-10-01T22:56:51.454Z] { \ [2025-10-01T22:56:51.454Z] echo ""; echo "TEST SETUP:"; \ [2025-10-01T22:56:51.454Z] echo "Nothing to be done for setup."; \ [2025-10-01T22:56:51.454Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1759359095914/renaissance-dec-tree_0"; \ [2025-10-01T22:56:51.454Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1759359095914/renaissance-dec-tree_0"; \ [2025-10-01T22:56:51.454Z] echo ""; echo "TESTING:"; \ [2025-10-01T22:56:51.454Z] "/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_1759359095914/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-10-01T22:56:51.454Z] 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_1759359095914/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-10-01T22:56:51.454Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-10-01T22:56:51.454Z] echo "Nothing to be done for teardown."; \ [2025-10-01T22:56:51.454Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1759359095914/TestTargetResult"; [2025-10-01T22:56:51.454Z] [2025-10-01T22:56:51.454Z] TEST SETUP: [2025-10-01T22:56:51.454Z] Nothing to be done for setup. [2025-10-01T22:56:51.454Z] [2025-10-01T22:56:51.454Z] TESTING: [2025-10-01T22:56:56.438Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-10-01T22:56:56.438Z] WARNING: An illegal reflective access operation has occurred [2025-10-01T22:56:56.438Z] 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_1759359095914/renaissance-dec-tree_0/harness-185651-1757312351510392397/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-10-01T22:56:56.438Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-10-01T22:56:56.438Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-10-01T22:56:56.438Z] WARNING: All illegal access operations will be denied in a future release [2025-10-01T22:56:57.657Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-10-01T22:56:57.657Z] GC before operation: completed in 34.274 ms, heap usage 56.544 MB -> 34.479 MB. [2025-10-01T22:57:03.821Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6200.091 ms) ====== [2025-10-01T22:57:03.821Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-10-01T22:57:03.821Z] GC before operation: completed in 60.822 ms, heap usage 230.031 MB -> 68.278 MB. [2025-10-01T22:57:05.099Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1550.325 ms) ====== [2025-10-01T22:57:05.099Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-10-01T22:57:05.464Z] GC before operation: completed in 68.173 ms, heap usage 245.934 MB -> 68.597 MB. [2025-10-01T22:57:06.722Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1196.198 ms) ====== [2025-10-01T22:57:06.722Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-10-01T22:57:06.722Z] GC before operation: completed in 69.667 ms, heap usage 134.390 MB -> 68.936 MB. [2025-10-01T22:57:07.547Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1063.279 ms) ====== [2025-10-01T22:57:07.547Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-10-01T22:57:07.909Z] GC before operation: completed in 63.669 ms, heap usage 244.317 MB -> 69.105 MB. [2025-10-01T22:57:08.698Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (983.629 ms) ====== [2025-10-01T22:57:08.698Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-10-01T22:57:08.698Z] GC before operation: completed in 67.024 ms, heap usage 307.559 MB -> 69.463 MB. [2025-10-01T22:57:09.918Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (946.898 ms) ====== [2025-10-01T22:57:09.918Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-10-01T22:57:09.918Z] GC before operation: completed in 62.869 ms, heap usage 125.647 MB -> 69.355 MB. [2025-10-01T22:57:10.704Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (883.746 ms) ====== [2025-10-01T22:57:10.704Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-10-01T22:57:10.704Z] GC before operation: completed in 65.185 ms, heap usage 111.354 MB -> 69.426 MB. [2025-10-01T22:57:11.923Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (934.915 ms) ====== [2025-10-01T22:57:11.923Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-10-01T22:57:11.923Z] GC before operation: completed in 62.960 ms, heap usage 187.500 MB -> 69.860 MB. [2025-10-01T22:57:12.697Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (858.513 ms) ====== [2025-10-01T22:57:12.697Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-10-01T22:57:12.697Z] GC before operation: completed in 69.004 ms, heap usage 149.455 MB -> 69.968 MB. [2025-10-01T22:57:13.459Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (918.201 ms) ====== [2025-10-01T22:57:13.460Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-10-01T22:57:13.828Z] GC before operation: completed in 70.200 ms, heap usage 116.109 MB -> 69.922 MB. [2025-10-01T22:57:14.606Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (880.707 ms) ====== [2025-10-01T22:57:14.606Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-10-01T22:57:14.606Z] GC before operation: completed in 68.769 ms, heap usage 212.371 MB -> 70.223 MB. [2025-10-01T22:57:15.361Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (878.414 ms) ====== [2025-10-01T22:57:15.361Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-10-01T22:57:15.721Z] GC before operation: completed in 75.454 ms, heap usage 104.991 MB -> 70.166 MB. [2025-10-01T22:57:16.519Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (886.029 ms) ====== [2025-10-01T22:57:16.519Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-10-01T22:57:16.519Z] GC before operation: completed in 80.031 ms, heap usage 208.259 MB -> 70.789 MB. [2025-10-01T22:57:17.304Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (830.947 ms) ====== [2025-10-01T22:57:17.304Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-10-01T22:57:17.304Z] GC before operation: completed in 77.790 ms, heap usage 181.201 MB -> 70.727 MB. [2025-10-01T22:57:18.550Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (837.987 ms) ====== [2025-10-01T22:57:18.551Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-10-01T22:57:18.551Z] GC before operation: completed in 75.938 ms, heap usage 184.498 MB -> 70.694 MB. [2025-10-01T22:57:19.326Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (844.765 ms) ====== [2025-10-01T22:57:19.326Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-10-01T22:57:19.326Z] GC before operation: completed in 77.468 ms, heap usage 209.249 MB -> 71.011 MB. [2025-10-01T22:57:20.091Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (848.390 ms) ====== [2025-10-01T22:57:20.091Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-10-01T22:57:20.091Z] GC before operation: completed in 82.585 ms, heap usage 214.568 MB -> 71.126 MB. [2025-10-01T22:57:21.409Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (847.445 ms) ====== [2025-10-01T22:57:21.409Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-10-01T22:57:21.409Z] GC before operation: completed in 84.935 ms, heap usage 184.817 MB -> 71.086 MB. [2025-10-01T22:57:22.163Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (838.755 ms) ====== [2025-10-01T22:57:22.164Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-10-01T22:57:22.164Z] GC before operation: completed in 84.990 ms, heap usage 155.945 MB -> 83.746 MB. [2025-10-01T22:57:22.932Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (799.617 ms) ====== [2025-10-01T22:57:22.932Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-10-01T22:57:22.932Z] GC before operation: completed in 85.333 ms, heap usage 150.174 MB -> 71.433 MB. [2025-10-01T22:57:23.699Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (798.900 ms) ====== [2025-10-01T22:57:23.699Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-10-01T22:57:23.699Z] GC before operation: completed in 92.042 ms, heap usage 187.993 MB -> 71.408 MB. [2025-10-01T22:57:24.484Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (799.710 ms) ====== [2025-10-01T22:57:24.484Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-10-01T22:57:24.866Z] GC before operation: completed in 81.816 ms, heap usage 227.201 MB -> 71.518 MB. [2025-10-01T22:57:25.634Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (813.626 ms) ====== [2025-10-01T22:57:25.635Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-10-01T22:57:25.635Z] GC before operation: completed in 84.002 ms, heap usage 188.725 MB -> 71.773 MB. [2025-10-01T22:57:26.406Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (836.958 ms) ====== [2025-10-01T22:57:26.406Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-10-01T22:57:26.406Z] GC before operation: completed in 87.452 ms, heap usage 121.216 MB -> 71.542 MB. [2025-10-01T22:57:27.195Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (804.838 ms) ====== [2025-10-01T22:57:27.195Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-10-01T22:57:27.580Z] GC before operation: completed in 89.973 ms, heap usage 217.253 MB -> 72.003 MB. [2025-10-01T22:57:28.331Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (809.545 ms) ====== [2025-10-01T22:57:28.331Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-10-01T22:57:28.331Z] GC before operation: completed in 90.166 ms, heap usage 230.521 MB -> 71.961 MB. [2025-10-01T22:57:29.084Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (787.848 ms) ====== [2025-10-01T22:57:29.084Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-10-01T22:57:29.084Z] GC before operation: completed in 83.759 ms, heap usage 135.169 MB -> 72.197 MB. [2025-10-01T22:57:29.869Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (772.818 ms) ====== [2025-10-01T22:57:29.869Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-10-01T22:57:30.247Z] GC before operation: completed in 96.611 ms, heap usage 261.603 MB -> 99.773 MB. [2025-10-01T22:57:31.010Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (771.617 ms) ====== [2025-10-01T22:57:31.010Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-10-01T22:57:31.010Z] GC before operation: completed in 99.631 ms, heap usage 224.421 MB -> 72.252 MB. [2025-10-01T22:57:31.796Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (783.725 ms) ====== [2025-10-01T22:57:31.796Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-10-01T22:57:31.796Z] GC before operation: completed in 90.025 ms, heap usage 268.945 MB -> 72.512 MB. [2025-10-01T22:57:32.565Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (803.391 ms) ====== [2025-10-01T22:57:32.565Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-10-01T22:57:32.565Z] GC before operation: completed in 91.201 ms, heap usage 230.894 MB -> 87.160 MB. [2025-10-01T22:57:33.795Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (824.014 ms) ====== [2025-10-01T22:57:33.795Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-10-01T22:57:33.795Z] GC before operation: completed in 93.085 ms, heap usage 148.625 MB -> 72.571 MB. [2025-10-01T22:57:34.565Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (759.410 ms) ====== [2025-10-01T22:57:34.565Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-10-01T22:57:34.565Z] GC before operation: completed in 94.636 ms, heap usage 112.666 MB -> 72.364 MB. [2025-10-01T22:57:35.343Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (765.388 ms) ====== [2025-10-01T22:57:35.343Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-10-01T22:57:35.343Z] GC before operation: completed in 92.662 ms, heap usage 188.652 MB -> 72.492 MB. [2025-10-01T22:57:36.123Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (831.333 ms) ====== [2025-10-01T22:57:36.123Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-10-01T22:57:36.123Z] GC before operation: completed in 97.692 ms, heap usage 138.782 MB -> 72.890 MB. [2025-10-01T22:57:37.370Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (800.970 ms) ====== [2025-10-01T22:57:37.370Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-10-01T22:57:37.370Z] GC before operation: completed in 101.867 ms, heap usage 270.271 MB -> 98.550 MB. [2025-10-01T22:57:38.137Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (769.691 ms) ====== [2025-10-01T22:57:38.137Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-10-01T22:57:38.137Z] GC before operation: completed in 103.903 ms, heap usage 301.194 MB -> 85.813 MB. [2025-10-01T22:57:38.912Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (765.288 ms) ====== [2025-10-01T22:57:38.912Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-10-01T22:57:38.912Z] GC before operation: completed in 95.094 ms, heap usage 313.660 MB -> 73.377 MB. [2025-10-01T22:57:39.668Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (780.812 ms) ====== [2025-10-01T22:57:39.668Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-10-01T22:57:39.668Z] GC before operation: completed in 98.634 ms, heap usage 159.024 MB -> 73.326 MB. [2025-10-01T22:57:40.893Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (805.784 ms) ====== [2025-10-01T22:57:40.893Z] ----------------------------------- [2025-10-01T22:57:40.893Z] renaissance-dec-tree_0_PASSED [2025-10-01T22:57:40.893Z] ----------------------------------- [2025-10-01T22:57:40.893Z] [2025-10-01T22:57:40.893Z] TEST TEARDOWN: [2025-10-01T22:57:40.893Z] Nothing to be done for teardown. [2025-10-01T22:57:40.893Z] renaissance-dec-tree_0 Finish Time: Wed Oct 1 18:57:40 2025 Epoch Time (ms): 1759359460586