[2026-01-10T10:26:52.130Z] Running test renaissance-dec-tree_0 ... [2026-01-10T10:26:52.493Z] =============================================== [2026-01-10T10:26:52.493Z] renaissance-dec-tree_0 Start Time: Sat Jan 10 10:26:52 2026 Epoch Time (ms): 1768040812265 [2026-01-10T10:26:52.493Z] variation: NoOptions [2026-01-10T10:26:52.855Z] JVM_OPTIONS: [2026-01-10T10:26:52.855Z] { \ [2026-01-10T10:26:52.855Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T10:26:52.855Z] echo "Nothing to be done for setup."; \ [2026-01-10T10:26:52.855Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680397902078\\renaissance-dec-tree_0"; \ [2026-01-10T10:26:52.855Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680397902078\\renaissance-dec-tree_0"; \ [2026-01-10T10:26:52.855Z] echo ""; echo "TESTING:"; \ [2026-01-10T10:26:52.855Z] "c:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680397902078\\renaissance-dec-tree_0"\\dec-tree.json" dec-tree; \ [2026-01-10T10:26:52.855Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680397902078\\renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T10:26:52.855Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T10:26:52.855Z] echo "Nothing to be done for teardown."; \ [2026-01-10T10:26:52.856Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17680397902078\\TestTargetResult"; [2026-01-10T10:26:52.856Z] [2026-01-10T10:26:52.856Z] TEST SETUP: [2026-01-10T10:26:52.856Z] Nothing to be done for setup. [2026-01-10T10:26:52.856Z] [2026-01-10T10:26:52.856Z] TESTING: [2026-01-10T10:27:08.863Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T10:27:08.863Z] WARNING: An illegal reflective access operation has occurred [2026-01-10T10:27:08.863Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17680397902078/renaissance-dec-tree_0/harness-102653-845794651204102583/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-01-10T10:27:08.863Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-01-10T10:27:08.863Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-01-10T10:27:08.863Z] WARNING: All illegal access operations will be denied in a future release [2026-01-10T10:27:09.617Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-10T10:27:09.617Z] GC before operation: completed in 56.194 ms, heap usage 70.331 MB -> 34.896 MB. [2026-01-10T10:27:20.910Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11184.162 ms) ====== [2026-01-10T10:27:20.910Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-10T10:27:21.342Z] GC before operation: completed in 164.098 ms, heap usage 298.987 MB -> 68.752 MB. [2026-01-10T10:27:24.161Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2970.969 ms) ====== [2026-01-10T10:27:24.161Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-10T10:27:24.161Z] GC before operation: completed in 129.500 ms, heap usage 255.461 MB -> 69.089 MB. [2026-01-10T10:27:26.710Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2522.553 ms) ====== [2026-01-10T10:27:26.710Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-10T10:27:26.710Z] GC before operation: completed in 131.668 ms, heap usage 214.710 MB -> 69.347 MB. [2026-01-10T10:27:29.231Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2238.404 ms) ====== [2026-01-10T10:27:29.231Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-10T10:27:29.231Z] GC before operation: completed in 118.093 ms, heap usage 274.069 MB -> 80.647 MB. [2026-01-10T10:27:31.159Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1979.578 ms) ====== [2026-01-10T10:27:31.159Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-10T10:27:31.159Z] GC before operation: completed in 134.365 ms, heap usage 350.721 MB -> 80.677 MB. [2026-01-10T10:27:33.578Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1900.274 ms) ====== [2026-01-10T10:27:33.578Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-10T10:27:33.578Z] GC before operation: completed in 127.724 ms, heap usage 231.164 MB -> 69.992 MB. [2026-01-10T10:27:35.347Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1753.673 ms) ====== [2026-01-10T10:27:35.347Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-10T10:27:35.347Z] GC before operation: completed in 123.449 ms, heap usage 189.621 MB -> 70.051 MB. [2026-01-10T10:27:37.107Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1685.857 ms) ====== [2026-01-10T10:27:37.107Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-10T10:27:37.107Z] GC before operation: completed in 115.853 ms, heap usage 117.419 MB -> 70.005 MB. [2026-01-10T10:27:38.854Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1661.363 ms) ====== [2026-01-10T10:27:38.854Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-10T10:27:38.854Z] GC before operation: completed in 125.650 ms, heap usage 185.265 MB -> 75.574 MB. [2026-01-10T10:27:40.648Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1593.090 ms) ====== [2026-01-10T10:27:40.648Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-10T10:27:40.648Z] GC before operation: completed in 123.078 ms, heap usage 118.094 MB -> 70.235 MB. [2026-01-10T10:27:42.512Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1624.723 ms) ====== [2026-01-10T10:27:42.512Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-10T10:27:42.512Z] GC before operation: completed in 124.143 ms, heap usage 195.509 MB -> 76.263 MB. [2026-01-10T10:27:43.727Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1458.761 ms) ====== [2026-01-10T10:27:43.727Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-10T10:27:43.727Z] GC before operation: completed in 121.498 ms, heap usage 228.291 MB -> 81.668 MB. [2026-01-10T10:27:45.540Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1518.580 ms) ====== [2026-01-10T10:27:45.540Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-10T10:27:45.540Z] GC before operation: completed in 127.290 ms, heap usage 273.159 MB -> 87.451 MB. [2026-01-10T10:27:47.389Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1434.862 ms) ====== [2026-01-10T10:27:47.389Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-10T10:27:47.389Z] GC before operation: completed in 130.826 ms, heap usage 135.199 MB -> 81.287 MB. [2026-01-10T10:27:48.619Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1539.134 ms) ====== [2026-01-10T10:27:48.619Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-10T10:27:48.619Z] GC before operation: completed in 130.546 ms, heap usage 111.424 MB -> 81.711 MB. [2026-01-10T10:27:50.410Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1460.392 ms) ====== [2026-01-10T10:27:50.410Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-10T10:27:50.410Z] GC before operation: completed in 161.799 ms, heap usage 322.782 MB -> 71.485 MB. [2026-01-10T10:27:52.173Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1448.434 ms) ====== [2026-01-10T10:27:52.173Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-10T10:27:52.173Z] GC before operation: completed in 127.645 ms, heap usage 223.698 MB -> 82.481 MB. [2026-01-10T10:27:53.399Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1415.153 ms) ====== [2026-01-10T10:27:53.399Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-10T10:27:53.399Z] GC before operation: completed in 147.842 ms, heap usage 313.168 MB -> 82.577 MB. [2026-01-10T10:27:55.216Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1366.381 ms) ====== [2026-01-10T10:27:55.217Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-10T10:27:55.217Z] GC before operation: completed in 134.177 ms, heap usage 229.057 MB -> 82.534 MB. [2026-01-10T10:27:56.457Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1463.247 ms) ====== [2026-01-10T10:27:56.457Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-10T10:27:56.457Z] GC before operation: completed in 142.672 ms, heap usage 230.763 MB -> 82.860 MB. [2026-01-10T10:27:58.262Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1471.646 ms) ====== [2026-01-10T10:27:58.262Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-10T10:27:58.262Z] GC before operation: completed in 135.311 ms, heap usage 318.272 MB -> 88.365 MB. [2026-01-10T10:27:58.262Z] 10:27:58.015 WARN [block-manager-storage-async-thread-pool-22] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1005_1, which does not exist [2026-01-10T10:28:00.027Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1498.578 ms) ====== [2026-01-10T10:28:00.027Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-10T10:28:00.027Z] GC before operation: completed in 162.268 ms, heap usage 284.018 MB -> 88.537 MB. [2026-01-10T10:28:01.336Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1421.462 ms) ====== [2026-01-10T10:28:01.336Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-10T10:28:01.336Z] GC before operation: completed in 133.922 ms, heap usage 268.441 MB -> 82.992 MB. [2026-01-10T10:28:03.059Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1406.385 ms) ====== [2026-01-10T10:28:03.059Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-10T10:28:03.059Z] GC before operation: completed in 140.569 ms, heap usage 260.748 MB -> 88.752 MB. [2026-01-10T10:28:03.059Z] 10:28:02.776 WARN [block-manager-storage-async-thread-pool-25] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1149_1, which does not exist [2026-01-10T10:28:04.895Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1487.342 ms) ====== [2026-01-10T10:28:04.895Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-10T10:28:04.895Z] GC before operation: completed in 165.461 ms, heap usage 128.302 MB -> 77.309 MB. [2026-01-10T10:28:06.113Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1500.067 ms) ====== [2026-01-10T10:28:06.113Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-10T10:28:06.113Z] GC before operation: completed in 143.046 ms, heap usage 255.805 MB -> 83.532 MB. [2026-01-10T10:28:07.869Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1350.589 ms) ====== [2026-01-10T10:28:07.869Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-10T10:28:07.869Z] GC before operation: completed in 142.028 ms, heap usage 237.149 MB -> 83.421 MB. [2026-01-10T10:28:09.092Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1349.343 ms) ====== [2026-01-10T10:28:09.092Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-10T10:28:09.461Z] GC before operation: completed in 143.031 ms, heap usage 229.365 MB -> 83.523 MB. [2026-01-10T10:28:10.663Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1337.692 ms) ====== [2026-01-10T10:28:10.663Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-10T10:28:10.663Z] GC before operation: completed in 149.039 ms, heap usage 241.136 MB -> 83.636 MB. [2026-01-10T10:28:12.248Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1370.625 ms) ====== [2026-01-10T10:28:12.249Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-10T10:28:12.628Z] GC before operation: completed in 152.296 ms, heap usage 231.356 MB -> 83.961 MB. [2026-01-10T10:28:13.843Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1424.731 ms) ====== [2026-01-10T10:28:13.843Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-10T10:28:13.843Z] GC before operation: completed in 146.871 ms, heap usage 285.254 MB -> 89.451 MB. [2026-01-10T10:28:15.240Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1467.781 ms) ====== [2026-01-10T10:28:15.240Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-10T10:28:15.863Z] GC before operation: completed in 173.353 ms, heap usage 253.004 MB -> 84.059 MB. [2026-01-10T10:28:15.863Z] 10:28:15.285 WARN [block-manager-storage-async-thread-pool-82] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1533_0, which does not exist [2026-01-10T10:28:17.079Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1376.757 ms) ====== [2026-01-10T10:28:17.079Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-10T10:28:17.079Z] GC before operation: completed in 146.618 ms, heap usage 197.054 MB -> 89.687 MB. [2026-01-10T10:28:18.322Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1319.712 ms) ====== [2026-01-10T10:28:18.322Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-10T10:28:18.727Z] GC before operation: completed in 154.847 ms, heap usage 295.791 MB -> 89.797 MB. [2026-01-10T10:28:18.727Z] 10:28:18.285 WARN [block-manager-storage-async-thread-pool-24] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_471, which does not exist [2026-01-10T10:28:20.081Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1444.198 ms) ====== [2026-01-10T10:28:20.081Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-10T10:28:20.081Z] GC before operation: completed in 148.450 ms, heap usage 253.182 MB -> 89.885 MB. [2026-01-10T10:28:21.618Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1588.858 ms) ====== [2026-01-10T10:28:21.618Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-10T10:28:21.991Z] GC before operation: completed in 147.733 ms, heap usage 308.588 MB -> 95.618 MB. [2026-01-10T10:28:21.991Z] 10:28:21.616 WARN [block-manager-storage-async-thread-pool-47] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1725_0, which does not exist [2026-01-10T10:28:23.220Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1381.339 ms) ====== [2026-01-10T10:28:23.220Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-10T10:28:23.220Z] GC before operation: completed in 155.260 ms, heap usage 169.580 MB -> 84.456 MB. [2026-01-10T10:28:25.322Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1339.150 ms) ====== [2026-01-10T10:28:25.322Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-10T10:28:25.322Z] GC before operation: completed in 145.713 ms, heap usage 118.673 MB -> 73.390 MB. [2026-01-10T10:28:26.550Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1414.986 ms) ====== [2026-01-10T10:28:26.550Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-10T10:28:26.550Z] GC before operation: completed in 144.801 ms, heap usage 203.697 MB -> 84.689 MB. [2026-01-10T10:28:27.742Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1308.976 ms) ====== [2026-01-10T10:28:28.099Z] ----------------------------------- [2026-01-10T10:28:28.099Z] renaissance-dec-tree_0_PASSED [2026-01-10T10:28:28.099Z] ----------------------------------- [2026-01-10T10:28:28.099Z] [2026-01-10T10:28:28.099Z] TEST TEARDOWN: [2026-01-10T10:28:28.099Z] Nothing to be done for teardown. [2026-01-10T10:28:28.437Z] renaissance-dec-tree_0 Finish Time: Sat Jan 10 10:28:28 2026 Epoch Time (ms): 1768040908186