[2025-11-20T02:39:47.030Z] Running test renaissance-dec-tree_0 ... [2025-11-20T02:39:47.030Z] =============================================== [2025-11-20T02:39:47.030Z] renaissance-dec-tree_0 Start Time: Thu Nov 20 02:39:46 2025 Epoch Time (ms): 1763606386735 [2025-11-20T02:39:47.030Z] variation: NoOptions [2025-11-20T02:39:47.030Z] JVM_OPTIONS: [2025-11-20T02:39:47.030Z] { \ [2025-11-20T02:39:47.030Z] echo ""; echo "TEST SETUP:"; \ [2025-11-20T02:39:47.030Z] echo "Nothing to be done for setup."; \ [2025-11-20T02:39:47.030Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1763605479328/renaissance-dec-tree_0"; \ [2025-11-20T02:39:47.030Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1763605479328/renaissance-dec-tree_0"; \ [2025-11-20T02:39:47.030Z] echo ""; echo "TESTING:"; \ [2025-11-20T02:39:47.031Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/jdkbinary/j2sdk-image/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 "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1763605479328/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-20T02:39:47.031Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1763605479328/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-20T02:39:47.031Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-20T02:39:47.031Z] echo "Nothing to be done for teardown."; \ [2025-11-20T02:39:47.031Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_1763605479328/TestTargetResult"; [2025-11-20T02:39:47.031Z] [2025-11-20T02:39:47.031Z] TEST SETUP: [2025-11-20T02:39:47.031Z] Nothing to be done for setup. [2025-11-20T02:39:47.031Z] [2025-11-20T02:39:47.031Z] TESTING: [2025-11-20T02:39:54.994Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-20T02:39:56.796Z] WARNING: An illegal reflective access operation has occurred [2025-11-20T02:39:56.796Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_1763605479328/renaissance-dec-tree_0/harness-023947-11061668364208363478/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-11-20T02:39:56.796Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-11-20T02:39:56.796Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-11-20T02:39:56.796Z] WARNING: All illegal access operations will be denied in a future release [2025-11-20T02:39:59.241Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-20T02:39:59.241Z] GC before operation: completed in 65.503 ms, heap usage 40.205 MB -> 34.346 MB. [2025-11-20T02:40:15.738Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15436.613 ms) ====== [2025-11-20T02:40:15.738Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-20T02:40:15.738Z] GC before operation: completed in 156.034 ms, heap usage 183.829 MB -> 67.943 MB. [2025-11-20T02:40:19.017Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4178.947 ms) ====== [2025-11-20T02:40:19.017Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-20T02:40:19.017Z] GC before operation: completed in 96.412 ms, heap usage 153.305 MB -> 68.424 MB. [2025-11-20T02:40:22.353Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2968.941 ms) ====== [2025-11-20T02:40:22.353Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-20T02:40:22.353Z] GC before operation: completed in 126.332 ms, heap usage 228.351 MB -> 96.294 MB. [2025-11-20T02:40:24.999Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3205.938 ms) ====== [2025-11-20T02:40:24.999Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-20T02:40:25.367Z] GC before operation: completed in 112.202 ms, heap usage 262.061 MB -> 80.350 MB. [2025-11-20T02:40:27.973Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2610.736 ms) ====== [2025-11-20T02:40:27.973Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-20T02:40:27.973Z] GC before operation: completed in 125.584 ms, heap usage 153.666 MB -> 69.270 MB. [2025-11-20T02:40:30.490Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2569.811 ms) ====== [2025-11-20T02:40:30.490Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-20T02:40:30.898Z] GC before operation: completed in 120.389 ms, heap usage 117.825 MB -> 96.493 MB. [2025-11-20T02:40:33.354Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2248.665 ms) ====== [2025-11-20T02:40:33.354Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-20T02:40:33.354Z] GC before operation: completed in 116.561 ms, heap usage 282.816 MB -> 69.854 MB. [2025-11-20T02:40:35.839Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2360.304 ms) ====== [2025-11-20T02:40:35.839Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-20T02:40:35.839Z] GC before operation: completed in 114.991 ms, heap usage 311.336 MB -> 69.959 MB. [2025-11-20T02:40:37.651Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2227.452 ms) ====== [2025-11-20T02:40:37.651Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-20T02:40:38.038Z] GC before operation: completed in 119.338 ms, heap usage 212.606 MB -> 70.077 MB. [2025-11-20T02:40:40.495Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2330.453 ms) ====== [2025-11-20T02:40:40.495Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-20T02:40:40.495Z] GC before operation: completed in 153.607 ms, heap usage 218.679 MB -> 70.186 MB. [2025-11-20T02:40:42.949Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2304.262 ms) ====== [2025-11-20T02:40:42.949Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-20T02:40:42.949Z] GC before operation: completed in 133.120 ms, heap usage 120.380 MB -> 70.003 MB. [2025-11-20T02:40:45.466Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2229.977 ms) ====== [2025-11-20T02:40:45.466Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-20T02:40:45.466Z] GC before operation: completed in 137.684 ms, heap usage 224.248 MB -> 70.675 MB. [2025-11-20T02:40:47.336Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2271.465 ms) ====== [2025-11-20T02:40:47.336Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-20T02:40:47.710Z] GC before operation: completed in 138.954 ms, heap usage 240.789 MB -> 70.402 MB. [2025-11-20T02:40:50.158Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2205.435 ms) ====== [2025-11-20T02:40:50.158Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-20T02:40:50.158Z] GC before operation: completed in 136.735 ms, heap usage 207.200 MB -> 70.518 MB. [2025-11-20T02:40:52.046Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2102.695 ms) ====== [2025-11-20T02:40:52.046Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-20T02:40:52.046Z] GC before operation: completed in 140.267 ms, heap usage 233.058 MB -> 70.791 MB. [2025-11-20T02:40:54.722Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2128.729 ms) ====== [2025-11-20T02:40:54.722Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-20T02:40:54.722Z] GC before operation: completed in 140.612 ms, heap usage 204.326 MB -> 70.978 MB. [2025-11-20T02:40:56.536Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2156.637 ms) ====== [2025-11-20T02:40:56.536Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-20T02:40:56.935Z] GC before operation: completed in 147.651 ms, heap usage 174.466 MB -> 71.069 MB. [2025-11-20T02:40:58.789Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2162.717 ms) ====== [2025-11-20T02:40:58.789Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-20T02:40:59.162Z] GC before operation: completed in 148.810 ms, heap usage 223.751 MB -> 71.179 MB. [2025-11-20T02:41:01.089Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2171.345 ms) ====== [2025-11-20T02:41:01.089Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-20T02:41:01.475Z] GC before operation: completed in 161.480 ms, heap usage 237.683 MB -> 71.293 MB. [2025-11-20T02:41:03.942Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2150.378 ms) ====== [2025-11-20T02:41:03.942Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-20T02:41:03.942Z] GC before operation: completed in 148.867 ms, heap usage 347.204 MB -> 71.399 MB. [2025-11-20T02:41:05.789Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2098.177 ms) ====== [2025-11-20T02:41:05.789Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-20T02:41:05.789Z] GC before operation: completed in 151.291 ms, heap usage 132.856 MB -> 71.451 MB. [2025-11-20T02:41:08.238Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1998.289 ms) ====== [2025-11-20T02:41:08.238Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-20T02:41:08.238Z] GC before operation: completed in 146.583 ms, heap usage 224.787 MB -> 71.436 MB. [2025-11-20T02:41:10.069Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2124.364 ms) ====== [2025-11-20T02:41:10.069Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-20T02:41:10.450Z] GC before operation: completed in 149.047 ms, heap usage 226.024 MB -> 71.542 MB. [2025-11-20T02:41:12.270Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2075.427 ms) ====== [2025-11-20T02:41:12.270Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-20T02:41:12.635Z] GC before operation: completed in 157.688 ms, heap usage 203.036 MB -> 71.801 MB. [2025-11-20T02:41:15.096Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2078.589 ms) ====== [2025-11-20T02:41:15.096Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-20T02:41:15.096Z] GC before operation: completed in 154.608 ms, heap usage 274.587 MB -> 71.760 MB. [2025-11-20T02:41:16.906Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1998.323 ms) ====== [2025-11-20T02:41:16.906Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-20T02:41:16.906Z] GC before operation: completed in 154.469 ms, heap usage 179.167 MB -> 83.153 MB. [2025-11-20T02:41:16.906Z] 02:41:16.807 WARN [block-manager-storage-async-thread-pool-62] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_359_piece0, which does not exist [2025-11-20T02:41:19.347Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1973.569 ms) ====== [2025-11-20T02:41:19.347Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-20T02:41:19.347Z] GC before operation: completed in 158.489 ms, heap usage 164.421 MB -> 71.672 MB. [2025-11-20T02:41:21.175Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1988.786 ms) ====== [2025-11-20T02:41:21.175Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-20T02:41:21.175Z] GC before operation: completed in 155.725 ms, heap usage 143.043 MB -> 72.225 MB. [2025-11-20T02:41:23.649Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2043.911 ms) ====== [2025-11-20T02:41:23.649Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-20T02:41:23.649Z] GC before operation: completed in 170.793 ms, heap usage 227.251 MB -> 72.359 MB. [2025-11-20T02:41:25.529Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2006.200 ms) ====== [2025-11-20T02:41:25.529Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-20T02:41:25.529Z] GC before operation: completed in 156.712 ms, heap usage 186.997 MB -> 72.144 MB. [2025-11-20T02:41:27.989Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2049.933 ms) ====== [2025-11-20T02:41:27.989Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-20T02:41:27.989Z] GC before operation: completed in 154.125 ms, heap usage 110.872 MB -> 72.236 MB. [2025-11-20T02:41:29.829Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2083.319 ms) ====== [2025-11-20T02:41:29.829Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-20T02:41:30.208Z] GC before operation: completed in 157.814 ms, heap usage 258.978 MB -> 72.668 MB. [2025-11-20T02:41:32.049Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2035.920 ms) ====== [2025-11-20T02:41:32.049Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-20T02:41:32.416Z] GC before operation: completed in 162.227 ms, heap usage 174.278 MB -> 72.468 MB. [2025-11-20T02:41:34.239Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1942.843 ms) ====== [2025-11-20T02:41:34.239Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-20T02:41:34.239Z] GC before operation: completed in 158.991 ms, heap usage 278.255 MB -> 72.731 MB. [2025-11-20T02:41:36.726Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2004.814 ms) ====== [2025-11-20T02:41:36.726Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-20T02:41:36.726Z] GC before operation: completed in 164.225 ms, heap usage 277.255 MB -> 72.828 MB. [2025-11-20T02:41:38.558Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2055.192 ms) ====== [2025-11-20T02:41:38.558Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-20T02:41:38.937Z] GC before operation: completed in 161.139 ms, heap usage 267.841 MB -> 73.078 MB. [2025-11-20T02:41:40.779Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2123.859 ms) ====== [2025-11-20T02:41:40.779Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-20T02:41:41.148Z] GC before operation: completed in 161.873 ms, heap usage 277.860 MB -> 73.187 MB. [2025-11-20T02:41:43.022Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2015.121 ms) ====== [2025-11-20T02:41:43.022Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-20T02:41:43.386Z] GC before operation: completed in 157.928 ms, heap usage 178.805 MB -> 72.845 MB. [2025-11-20T02:41:45.232Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1987.564 ms) ====== [2025-11-20T02:41:45.232Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-20T02:41:45.232Z] GC before operation: completed in 162.940 ms, heap usage 239.607 MB -> 73.388 MB. [2025-11-20T02:41:47.676Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1969.497 ms) ====== [2025-11-20T02:41:47.676Z] ----------------------------------- [2025-11-20T02:41:47.676Z] renaissance-dec-tree_0_PASSED [2025-11-20T02:41:47.676Z] ----------------------------------- [2025-11-20T02:41:47.676Z] [2025-11-20T02:41:47.676Z] TEST TEARDOWN: [2025-11-20T02:41:47.676Z] Nothing to be done for teardown. [2025-11-20T02:41:47.676Z] renaissance-dec-tree_0 Finish Time: Thu Nov 20 02:41:47 2025 Epoch Time (ms): 1763606507535