[2026-03-04T23:14:03.276Z] Running test renaissance-dec-tree_0 ... [2026-03-04T23:14:03.276Z] =============================================== [2026-03-04T23:14:03.276Z] renaissance-dec-tree_0 Start Time: Wed Mar 4 23:14:02 2026 Epoch Time (ms): 1772666042542 [2026-03-04T23:14:03.276Z] variation: NoOptions [2026-03-04T23:14:03.276Z] JVM_OPTIONS: [2026-03-04T23:14:03.276Z] { \ [2026-03-04T23:14:03.276Z] echo ""; echo "TEST SETUP:"; \ [2026-03-04T23:14:03.276Z] echo "Nothing to be done for setup."; \ [2026-03-04T23:14:03.276Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/renaissance-dec-tree_0"; \ [2026-03-04T23:14:03.276Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/renaissance-dec-tree_0"; \ [2026-03-04T23:14:03.276Z] echo ""; echo "TESTING:"; \ [2026-03-04T23:14:03.276Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_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_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-03-04T23:14:03.276Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-03-04T23:14:03.276Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-03-04T23:14:03.276Z] echo "Nothing to be done for teardown."; \ [2026-03-04T23:14:03.276Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17726649278792/TestTargetResult"; [2026-03-04T23:14:03.276Z] [2026-03-04T23:14:03.276Z] TEST SETUP: [2026-03-04T23:14:03.276Z] Nothing to be done for setup. [2026-03-04T23:14:03.276Z] [2026-03-04T23:14:03.276Z] TESTING: [2026-03-04T23:14:10.755Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-03-04T23:14:11.489Z] WARNING: An illegal reflective access operation has occurred [2026-03-04T23:14:11.489Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17726649278792/renaissance-dec-tree_0/harness-231403-76785574038669158/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-03-04T23:14:11.489Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-03-04T23:14:11.489Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-03-04T23:14:11.489Z] WARNING: All illegal access operations will be denied in a future release [2026-03-04T23:14:13.193Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-03-04T23:14:13.193Z] GC before operation: completed in 60.984 ms, heap usage 37.500 MB -> 34.135 MB. [2026-03-04T23:14:29.268Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (14961.977 ms) ====== [2026-03-04T23:14:29.268Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-03-04T23:14:29.268Z] GC before operation: completed in 193.260 ms, heap usage 174.844 MB -> 94.191 MB. [2026-03-04T23:14:33.125Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4296.759 ms) ====== [2026-03-04T23:14:33.125Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-03-04T23:14:33.125Z] GC before operation: completed in 137.134 ms, heap usage 144.530 MB -> 67.021 MB. [2026-03-04T23:14:36.139Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3181.986 ms) ====== [2026-03-04T23:14:36.139Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-03-04T23:14:36.139Z] GC before operation: completed in 137.207 ms, heap usage 186.928 MB -> 67.417 MB. [2026-03-04T23:14:40.020Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3678.615 ms) ====== [2026-03-04T23:14:40.020Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-03-04T23:14:40.020Z] GC before operation: completed in 144.575 ms, heap usage 269.639 MB -> 67.806 MB. [2026-03-04T23:14:42.316Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2520.560 ms) ====== [2026-03-04T23:14:42.316Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-03-04T23:14:42.316Z] GC before operation: completed in 142.206 ms, heap usage 147.879 MB -> 67.878 MB. [2026-03-04T23:14:44.616Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2325.581 ms) ====== [2026-03-04T23:14:44.616Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-03-04T23:14:44.953Z] GC before operation: completed in 177.866 ms, heap usage 228.831 MB -> 68.038 MB. [2026-03-04T23:14:47.348Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2307.637 ms) ====== [2026-03-04T23:14:47.348Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-03-04T23:14:47.348Z] GC before operation: completed in 149.824 ms, heap usage 103.677 MB -> 68.274 MB. [2026-03-04T23:14:49.650Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2278.337 ms) ====== [2026-03-04T23:14:49.650Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-03-04T23:14:49.987Z] GC before operation: completed in 150.793 ms, heap usage 205.886 MB -> 68.815 MB. [2026-03-04T23:14:52.305Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2194.714 ms) ====== [2026-03-04T23:14:52.305Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-03-04T23:14:52.305Z] GC before operation: completed in 153.229 ms, heap usage 191.704 MB -> 68.673 MB. [2026-03-04T23:14:54.612Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2292.490 ms) ====== [2026-03-04T23:14:54.612Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-03-04T23:14:54.612Z] GC before operation: completed in 162.324 ms, heap usage 280.829 MB -> 88.086 MB. [2026-03-04T23:14:56.932Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2288.213 ms) ====== [2026-03-04T23:14:56.932Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-03-04T23:14:56.932Z] GC before operation: completed in 157.703 ms, heap usage 254.253 MB -> 69.147 MB. [2026-03-04T23:14:59.242Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2011.213 ms) ====== [2026-03-04T23:14:59.242Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-03-04T23:14:59.242Z] GC before operation: completed in 164.518 ms, heap usage 240.526 MB -> 96.070 MB. [2026-03-04T23:15:01.554Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2136.350 ms) ====== [2026-03-04T23:15:01.554Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-03-04T23:15:01.554Z] GC before operation: completed in 161.240 ms, heap usage 223.716 MB -> 77.533 MB. [2026-03-04T23:15:03.852Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2037.534 ms) ====== [2026-03-04T23:15:03.852Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-03-04T23:15:03.852Z] GC before operation: completed in 157.041 ms, heap usage 211.879 MB -> 69.235 MB. [2026-03-04T23:15:06.156Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2086.219 ms) ====== [2026-03-04T23:15:06.156Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-03-04T23:15:06.156Z] GC before operation: completed in 165.462 ms, heap usage 191.199 MB -> 88.650 MB. [2026-03-04T23:15:06.156Z] 23:15:05.827 WARN [block-manager-storage-async-thread-pool-91] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_205, which does not exist [2026-03-04T23:15:07.855Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1980.951 ms) ====== [2026-03-04T23:15:07.855Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-03-04T23:15:08.208Z] GC before operation: completed in 172.190 ms, heap usage 318.803 MB -> 69.536 MB. [2026-03-04T23:15:09.912Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1903.380 ms) ====== [2026-03-04T23:15:09.912Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-03-04T23:15:10.336Z] GC before operation: completed in 164.465 ms, heap usage 254.238 MB -> 69.648 MB. [2026-03-04T23:15:12.035Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1932.961 ms) ====== [2026-03-04T23:15:12.035Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-03-04T23:15:12.375Z] GC before operation: completed in 169.397 ms, heap usage 193.140 MB -> 89.063 MB. [2026-03-04T23:15:12.375Z] 23:15:12.148 WARN [block-manager-storage-async-thread-pool-97] org.apache.spark.storage.BlockManager - Asked to remove block rdd_861_0, which does not exist [2026-03-04T23:15:14.683Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1981.270 ms) ====== [2026-03-04T23:15:14.683Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-03-04T23:15:14.683Z] GC before operation: completed in 169.142 ms, heap usage 303.100 MB -> 69.916 MB. [2026-03-04T23:15:16.384Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1943.413 ms) ====== [2026-03-04T23:15:16.384Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-03-04T23:15:16.723Z] GC before operation: completed in 169.941 ms, heap usage 230.677 MB -> 78.200 MB. [2026-03-04T23:15:16.724Z] 23:15:16.414 WARN [block-manager-storage-async-thread-pool-38] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_275, which does not exist [2026-03-04T23:15:18.423Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1840.784 ms) ====== [2026-03-04T23:15:18.423Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-03-04T23:15:18.765Z] GC before operation: completed in 170.253 ms, heap usage 306.876 MB -> 78.115 MB. [2026-03-04T23:15:20.463Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1918.588 ms) ====== [2026-03-04T23:15:20.463Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-03-04T23:15:20.803Z] GC before operation: completed in 173.859 ms, heap usage 321.211 MB -> 70.210 MB. [2026-03-04T23:15:22.494Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1841.495 ms) ====== [2026-03-04T23:15:22.494Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-03-04T23:15:22.833Z] GC before operation: completed in 169.009 ms, heap usage 104.485 MB -> 69.994 MB. [2026-03-04T23:15:25.157Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2011.552 ms) ====== [2026-03-04T23:15:25.157Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-03-04T23:15:25.157Z] GC before operation: completed in 169.939 ms, heap usage 187.070 MB -> 70.270 MB. [2026-03-04T23:15:26.858Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1897.373 ms) ====== [2026-03-04T23:15:26.858Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-03-04T23:15:26.858Z] GC before operation: completed in 166.401 ms, heap usage 113.751 MB -> 70.037 MB. [2026-03-04T23:15:29.163Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1851.060 ms) ====== [2026-03-04T23:15:29.163Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-03-04T23:15:29.163Z] GC before operation: completed in 181.429 ms, heap usage 291.633 MB -> 98.060 MB. [2026-03-04T23:15:30.885Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1831.481 ms) ====== [2026-03-04T23:15:30.885Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-03-04T23:15:30.885Z] GC before operation: completed in 173.807 ms, heap usage 301.564 MB -> 70.569 MB. [2026-03-04T23:15:33.227Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1936.529 ms) ====== [2026-03-04T23:15:33.227Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-03-04T23:15:33.227Z] GC before operation: completed in 170.871 ms, heap usage 115.832 MB -> 70.503 MB. [2026-03-04T23:15:35.013Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1860.495 ms) ====== [2026-03-04T23:15:35.013Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-03-04T23:15:35.013Z] GC before operation: completed in 173.881 ms, heap usage 250.610 MB -> 78.935 MB. [2026-03-04T23:15:37.323Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1821.282 ms) ====== [2026-03-04T23:15:37.323Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-03-04T23:15:37.323Z] GC before operation: completed in 176.463 ms, heap usage 115.712 MB -> 90.013 MB. [2026-03-04T23:15:39.021Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1719.975 ms) ====== [2026-03-04T23:15:39.021Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-03-04T23:15:39.021Z] GC before operation: completed in 184.352 ms, heap usage 307.186 MB -> 90.427 MB. [2026-03-04T23:15:41.328Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1927.789 ms) ====== [2026-03-04T23:15:41.328Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-03-04T23:15:41.328Z] GC before operation: completed in 175.393 ms, heap usage 274.659 MB -> 71.238 MB. [2026-03-04T23:15:43.020Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1770.207 ms) ====== [2026-03-04T23:15:43.020Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-03-04T23:15:43.020Z] GC before operation: completed in 181.900 ms, heap usage 146.083 MB -> 90.625 MB. [2026-03-04T23:15:45.328Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1838.006 ms) ====== [2026-03-04T23:15:45.328Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-03-04T23:15:45.328Z] GC before operation: completed in 178.839 ms, heap usage 307.786 MB -> 71.293 MB. [2026-03-04T23:15:47.047Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1817.998 ms) ====== [2026-03-04T23:15:47.047Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-03-04T23:15:47.047Z] GC before operation: completed in 180.542 ms, heap usage 108.687 MB -> 90.511 MB. [2026-03-04T23:15:48.812Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1782.997 ms) ====== [2026-03-04T23:15:48.812Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-03-04T23:15:49.150Z] 23:15:48.911 WARN [block-manager-storage-async-thread-pool-4] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_499, which does not exist [2026-03-04T23:15:49.150Z] GC before operation: completed in 190.068 ms, heap usage 282.614 MB -> 71.872 MB. [2026-03-04T23:15:51.480Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1988.687 ms) ====== [2026-03-04T23:15:51.480Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-03-04T23:15:51.480Z] GC before operation: completed in 190.756 ms, heap usage 261.043 MB -> 80.155 MB. [2026-03-04T23:15:53.177Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1962.274 ms) ====== [2026-03-04T23:15:53.177Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-03-04T23:15:53.534Z] GC before operation: completed in 182.673 ms, heap usage 185.987 MB -> 72.103 MB. [2026-03-04T23:15:55.238Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1786.743 ms) ====== [2026-03-04T23:15:55.238Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-03-04T23:15:55.238Z] GC before operation: completed in 182.928 ms, heap usage 271.827 MB -> 71.956 MB. [2026-03-04T23:15:56.965Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1725.650 ms) ====== [2026-03-04T23:15:57.301Z] ----------------------------------- [2026-03-04T23:15:57.301Z] renaissance-dec-tree_0_PASSED [2026-03-04T23:15:57.301Z] ----------------------------------- [2026-03-04T23:15:57.301Z] [2026-03-04T23:15:57.301Z] TEST TEARDOWN: [2026-03-04T23:15:57.301Z] Nothing to be done for teardown. [2026-03-04T23:15:57.301Z] renaissance-dec-tree_0 Finish Time: Wed Mar 4 23:15:57 2026 Epoch Time (ms): 1772666157244