[2026-02-04T23:01:05.497Z] Running test renaissance-dec-tree_0 ... [2026-02-04T23:01:05.497Z] =============================================== [2026-02-04T23:01:05.497Z] renaissance-dec-tree_0 Start Time: Wed Feb 4 16:59:50 2026 Epoch Time (ms): 1770245990853 [2026-02-04T23:01:05.497Z] variation: NoOptions [2026-02-04T23:01:05.497Z] JVM_OPTIONS: [2026-02-04T23:01:05.497Z] { \ [2026-02-04T23:01:05.497Z] echo ""; echo "TEST SETUP:"; \ [2026-02-04T23:01:05.497Z] echo "Nothing to be done for setup."; \ [2026-02-04T23:01:05.497Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702455518785/renaissance-dec-tree_0"; \ [2026-02-04T23:01:05.497Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702455518785/renaissance-dec-tree_0"; \ [2026-02-04T23:01:05.497Z] echo ""; echo "TESTING:"; \ [2026-02-04T23:01:05.497Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702455518785/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-02-04T23:01:05.497Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702455518785/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-04T23:01:05.497Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-04T23:01:05.497Z] echo "Nothing to be done for teardown."; \ [2026-02-04T23:01:05.497Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702455518785/TestTargetResult"; [2026-02-04T23:01:05.497Z] [2026-02-04T23:01:05.497Z] TEST SETUP: [2026-02-04T23:01:05.497Z] Nothing to be done for setup. [2026-02-04T23:01:05.497Z] [2026-02-04T23:01:05.497Z] TESTING: [2026-02-04T23:01:10.546Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2026-02-04T23:01:12.043Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-02-04T23:01:12.043Z] GC before operation: completed in 54.334 ms, heap usage 73.634 MB -> 35.394 MB. [2026-02-04T23:01:20.238Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7911.028 ms) ====== [2026-02-04T23:01:20.238Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-02-04T23:01:20.238Z] GC before operation: completed in 108.299 ms, heap usage 374.069 MB -> 69.472 MB. [2026-02-04T23:01:22.413Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1931.101 ms) ====== [2026-02-04T23:01:22.413Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-02-04T23:01:22.413Z] GC before operation: completed in 103.403 ms, heap usage 317.422 MB -> 86.414 MB. [2026-02-04T23:01:23.805Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1574.505 ms) ====== [2026-02-04T23:01:23.805Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-02-04T23:01:23.805Z] GC before operation: completed in 85.335 ms, heap usage 464.235 MB -> 86.654 MB. [2026-02-04T23:01:25.246Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1288.225 ms) ====== [2026-02-04T23:01:25.246Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-02-04T23:01:25.246Z] GC before operation: completed in 93.354 ms, heap usage 479.422 MB -> 86.944 MB. [2026-02-04T23:01:26.702Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1400.883 ms) ====== [2026-02-04T23:01:26.702Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-02-04T23:01:26.702Z] GC before operation: completed in 84.218 ms, heap usage 414.339 MB -> 81.320 MB. [2026-02-04T23:01:28.151Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1452.501 ms) ====== [2026-02-04T23:01:28.151Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-02-04T23:01:28.151Z] GC before operation: completed in 90.720 ms, heap usage 477.679 MB -> 81.799 MB. [2026-02-04T23:01:29.722Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1250.135 ms) ====== [2026-02-04T23:01:29.722Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-02-04T23:01:29.722Z] GC before operation: completed in 89.420 ms, heap usage 472.253 MB -> 70.891 MB. [2026-02-04T23:01:31.148Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1347.173 ms) ====== [2026-02-04T23:01:31.148Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-02-04T23:01:31.148Z] GC before operation: completed in 94.889 ms, heap usage 295.211 MB -> 93.176 MB. [2026-02-04T23:01:32.564Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1294.707 ms) ====== [2026-02-04T23:01:32.564Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-02-04T23:01:32.564Z] GC before operation: completed in 119.136 ms, heap usage 370.165 MB -> 98.711 MB. [2026-02-04T23:01:32.564Z] 17:00:17.843 WARN [block-manager-storage-async-thread-pool-91] org.apache.spark.storage.BlockManager - Asked to remove block rdd_429_1, which does not exist [2026-02-04T23:01:33.441Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1314.840 ms) ====== [2026-02-04T23:01:33.441Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-02-04T23:01:34.116Z] GC before operation: completed in 90.630 ms, heap usage 304.514 MB -> 87.743 MB. [2026-02-04T23:01:34.116Z] 17:00:19.246 WARN [block-manager-storage-async-thread-pool-56] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_135_piece0, which does not exist [2026-02-04T23:01:34.791Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1272.409 ms) ====== [2026-02-04T23:01:34.791Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-02-04T23:01:35.473Z] GC before operation: completed in 90.891 ms, heap usage 414.962 MB -> 71.756 MB. [2026-02-04T23:01:36.862Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1342.226 ms) ====== [2026-02-04T23:01:36.862Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-02-04T23:01:36.862Z] GC before operation: completed in 98.662 ms, heap usage 318.417 MB -> 82.433 MB. [2026-02-04T23:01:37.586Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1240.760 ms) ====== [2026-02-04T23:01:37.586Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-02-04T23:01:38.303Z] GC before operation: completed in 96.099 ms, heap usage 157.581 MB -> 82.600 MB. [2026-02-04T23:01:38.303Z] 17:00:23.411 WARN [block-manager-storage-async-thread-pool-79] org.apache.spark.storage.BlockManager - Asked to remove block rdd_621_1, which does not exist [2026-02-04T23:01:38.978Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1286.047 ms) ====== [2026-02-04T23:01:38.978Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-02-04T23:01:39.655Z] GC before operation: completed in 135.397 ms, heap usage 390.286 MB -> 88.439 MB. [2026-02-04T23:01:41.159Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1397.059 ms) ====== [2026-02-04T23:01:41.159Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-02-04T23:01:41.159Z] GC before operation: completed in 102.048 ms, heap usage 383.378 MB -> 99.502 MB. [2026-02-04T23:01:42.716Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1412.142 ms) ====== [2026-02-04T23:01:42.716Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-02-04T23:01:42.716Z] GC before operation: completed in 97.424 ms, heap usage 303.347 MB -> 83.410 MB. [2026-02-04T23:01:43.379Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1244.333 ms) ====== [2026-02-04T23:01:43.379Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-02-04T23:01:44.071Z] GC before operation: completed in 123.094 ms, heap usage 508.021 MB -> 94.392 MB. [2026-02-04T23:01:45.480Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1413.698 ms) ====== [2026-02-04T23:01:45.480Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-02-04T23:01:45.480Z] GC before operation: completed in 104.877 ms, heap usage 341.706 MB -> 88.683 MB. [2026-02-04T23:01:45.481Z] 17:00:30.732 WARN [block-manager-storage-async-thread-pool-7] org.apache.spark.storage.BlockManager - Asked to remove block rdd_861_0, which does not exist [2026-02-04T23:01:46.923Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1234.176 ms) ====== [2026-02-04T23:01:46.923Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-02-04T23:01:46.923Z] GC before operation: completed in 123.192 ms, heap usage 403.765 MB -> 94.453 MB. [2026-02-04T23:01:48.352Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1299.970 ms) ====== [2026-02-04T23:01:48.352Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-02-04T23:01:48.352Z] GC before operation: completed in 117.437 ms, heap usage 344.289 MB -> 83.649 MB. [2026-02-04T23:01:49.767Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1496.386 ms) ====== [2026-02-04T23:01:49.767Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-02-04T23:01:49.767Z] GC before operation: completed in 129.767 ms, heap usage 445.016 MB -> 100.348 MB. [2026-02-04T23:01:51.151Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1292.434 ms) ====== [2026-02-04T23:01:51.151Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-02-04T23:01:51.151Z] GC before operation: completed in 113.074 ms, heap usage 474.578 MB -> 100.429 MB. [2026-02-04T23:01:52.599Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1370.339 ms) ====== [2026-02-04T23:01:52.599Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-02-04T23:01:52.599Z] GC before operation: completed in 117.907 ms, heap usage 475.327 MB -> 100.497 MB. [2026-02-04T23:01:54.014Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1121.261 ms) ====== [2026-02-04T23:01:54.014Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-02-04T23:01:54.014Z] GC before operation: completed in 107.685 ms, heap usage 442.649 MB -> 78.648 MB. [2026-02-04T23:01:55.392Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1479.106 ms) ====== [2026-02-04T23:01:55.392Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-02-04T23:01:55.393Z] GC before operation: completed in 131.497 ms, heap usage 370.104 MB -> 73.143 MB. [2026-02-04T23:01:56.790Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1218.058 ms) ====== [2026-02-04T23:01:56.790Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-02-04T23:01:56.790Z] GC before operation: completed in 105.926 ms, heap usage 286.617 MB -> 89.898 MB. [2026-02-04T23:01:56.790Z] 17:00:42.197 WARN [block-manager-storage-async-thread-pool-67] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1245_1, which does not exist [2026-02-04T23:01:58.160Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1203.691 ms) ====== [2026-02-04T23:01:58.160Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-02-04T23:01:58.160Z] GC before operation: completed in 126.607 ms, heap usage 416.761 MB -> 100.919 MB. [2026-02-04T23:01:59.562Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1429.103 ms) ====== [2026-02-04T23:01:59.563Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-02-04T23:01:59.563Z] GC before operation: completed in 110.575 ms, heap usage 288.508 MB -> 89.922 MB. [2026-02-04T23:02:00.997Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1447.151 ms) ====== [2026-02-04T23:02:00.997Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-02-04T23:02:00.997Z] GC before operation: completed in 110.543 ms, heap usage 250.183 MB -> 95.990 MB. [2026-02-04T23:02:02.454Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1177.726 ms) ====== [2026-02-04T23:02:02.455Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-02-04T23:02:02.455Z] GC before operation: completed in 116.885 ms, heap usage 365.192 MB -> 84.983 MB. [2026-02-04T23:02:03.988Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1517.972 ms) ====== [2026-02-04T23:02:03.988Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-02-04T23:02:03.988Z] GC before operation: completed in 120.678 ms, heap usage 469.974 MB -> 90.529 MB. [2026-02-04T23:02:05.407Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1487.962 ms) ====== [2026-02-04T23:02:05.407Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-02-04T23:02:06.623Z] GC before operation: completed in 110.308 ms, heap usage 375.230 MB -> 101.617 MB. [2026-02-04T23:02:07.417Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1448.047 ms) ====== [2026-02-04T23:02:07.417Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-02-04T23:02:07.417Z] GC before operation: completed in 102.530 ms, heap usage 282.847 MB -> 79.617 MB. [2026-02-04T23:02:07.417Z] 17:00:52.709 WARN [block-manager-storage-async-thread-pool-49] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_457_piece0, which does not exist [2026-02-04T23:02:08.794Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1431.427 ms) ====== [2026-02-04T23:02:08.794Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-02-04T23:02:08.794Z] GC before operation: completed in 102.812 ms, heap usage 167.150 MB -> 102.029 MB. [2026-02-04T23:02:08.794Z] 17:00:54.245 WARN [block-manager-storage-async-thread-pool-26] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_471, which does not exist [2026-02-04T23:02:10.191Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1408.321 ms) ====== [2026-02-04T23:02:10.191Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-02-04T23:02:10.191Z] GC before operation: completed in 94.474 ms, heap usage 271.148 MB -> 74.224 MB. [2026-02-04T23:02:11.672Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1357.184 ms) ====== [2026-02-04T23:02:11.672Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-02-04T23:02:11.672Z] GC before operation: completed in 98.753 ms, heap usage 293.686 MB -> 74.339 MB. [2026-02-04T23:02:13.074Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1253.232 ms) ====== [2026-02-04T23:02:13.074Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-02-04T23:02:13.074Z] GC before operation: completed in 115.789 ms, heap usage 403.938 MB -> 90.758 MB. [2026-02-04T23:02:14.521Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1449.551 ms) ====== [2026-02-04T23:02:14.521Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-02-04T23:02:14.521Z] GC before operation: completed in 133.356 ms, heap usage 375.826 MB -> 91.230 MB. [2026-02-04T23:02:15.905Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1213.277 ms) ====== [2026-02-04T23:02:15.905Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-02-04T23:02:15.905Z] GC before operation: completed in 113.245 ms, heap usage 375.129 MB -> 91.184 MB. [2026-02-04T23:02:17.453Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1269.494 ms) ====== [2026-02-04T23:02:17.453Z] ----------------------------------- [2026-02-04T23:02:17.453Z] renaissance-dec-tree_0_PASSED [2026-02-04T23:02:17.453Z] ----------------------------------- [2026-02-04T23:02:17.453Z] [2026-02-04T23:02:17.453Z] TEST TEARDOWN: [2026-02-04T23:02:17.453Z] Nothing to be done for teardown. [2026-02-04T23:02:18.113Z] renaissance-dec-tree_0 Finish Time: Wed Feb 4 17:01:03 2026 Epoch Time (ms): 1770246063213