[2025-11-20T00:35:37.118Z] Running test renaissance-dec-tree_0 ... [2025-11-20T00:35:37.118Z] =============================================== [2025-11-20T00:35:37.118Z] renaissance-dec-tree_0 Start Time: Thu Nov 20 00:35:36 2025 Epoch Time (ms): 1763598936703 [2025-11-20T00:35:37.118Z] variation: NoOptions [2025-11-20T00:35:37.118Z] JVM_OPTIONS: [2025-11-20T00:35:37.118Z] { \ [2025-11-20T00:35:37.118Z] echo ""; echo "TEST SETUP:"; \ [2025-11-20T00:35:37.118Z] echo "Nothing to be done for setup."; \ [2025-11-20T00:35:37.118Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17635980277696/renaissance-dec-tree_0"; \ [2025-11-20T00:35:37.118Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17635980277696/renaissance-dec-tree_0"; \ [2025-11-20T00:35:37.118Z] echo ""; echo "TESTING:"; \ [2025-11-20T00:35:37.118Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/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_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17635980277696/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-20T00:35:37.118Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17635980277696/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-20T00:35:37.118Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-20T00:35:37.118Z] echo "Nothing to be done for teardown."; \ [2025-11-20T00:35:37.118Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_17635980277696/TestTargetResult"; [2025-11-20T00:35:37.118Z] [2025-11-20T00:35:37.118Z] TEST SETUP: [2025-11-20T00:35:37.118Z] Nothing to be done for setup. [2025-11-20T00:35:37.118Z] [2025-11-20T00:35:37.118Z] TESTING: [2025-11-20T00:35:43.074Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-11-20T00:35:47.124Z] WARNING: An illegal reflective access operation has occurred [2025-11-20T00:35:47.124Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/output_17635980277696/renaissance-dec-tree_0/harness-003537-5957079294806444378/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-11-20T00:35:47.124Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-11-20T00:35:47.124Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-11-20T00:35:47.124Z] WARNING: All illegal access operations will be denied in a future release [2025-11-20T00:35:47.124Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-20T00:35:47.124Z] GC before operation: completed in 58.784 ms, heap usage 103.327 MB -> 34.195 MB. [2025-11-20T00:35:58.097Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (12851.132 ms) ====== [2025-11-20T00:35:58.097Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-20T00:35:58.097Z] GC before operation: completed in 174.796 ms, heap usage 97.910 MB -> 67.073 MB. [2025-11-20T00:36:01.865Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3681.068 ms) ====== [2025-11-20T00:36:01.865Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-20T00:36:01.865Z] GC before operation: completed in 125.319 ms, heap usage 312.075 MB -> 67.512 MB. [2025-11-20T00:36:04.855Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2889.887 ms) ====== [2025-11-20T00:36:04.855Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-20T00:36:04.855Z] GC before operation: completed in 112.930 ms, heap usage 196.562 MB -> 67.575 MB. [2025-11-20T00:36:07.270Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2635.844 ms) ====== [2025-11-20T00:36:07.270Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-20T00:36:07.599Z] GC before operation: completed in 156.606 ms, heap usage 147.452 MB -> 67.768 MB. [2025-11-20T00:36:09.871Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2445.259 ms) ====== [2025-11-20T00:36:09.871Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-20T00:36:10.202Z] GC before operation: completed in 127.519 ms, heap usage 253.200 MB -> 67.987 MB. [2025-11-20T00:36:12.459Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2347.300 ms) ====== [2025-11-20T00:36:12.459Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-20T00:36:12.459Z] GC before operation: completed in 127.000 ms, heap usage 229.234 MB -> 68.180 MB. [2025-11-20T00:36:15.427Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2352.553 ms) ====== [2025-11-20T00:36:15.427Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-20T00:36:15.427Z] GC before operation: completed in 123.842 ms, heap usage 262.948 MB -> 68.626 MB. [2025-11-20T00:36:15.427Z] 00:36:14.893 WARN [block-manager-storage-async-thread-pool-49] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_93_piece0, which does not exist [2025-11-20T00:36:17.094Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2137.838 ms) ====== [2025-11-20T00:36:17.094Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-20T00:36:17.424Z] GC before operation: completed in 123.808 ms, heap usage 220.886 MB -> 68.580 MB. [2025-11-20T00:36:19.076Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1881.853 ms) ====== [2025-11-20T00:36:19.076Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-20T00:36:19.403Z] GC before operation: completed in 127.667 ms, heap usage 227.817 MB -> 68.539 MB. [2025-11-20T00:36:21.651Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1957.835 ms) ====== [2025-11-20T00:36:21.651Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-20T00:36:21.651Z] GC before operation: completed in 124.308 ms, heap usage 188.948 MB -> 68.648 MB. [2025-11-20T00:36:23.312Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1864.086 ms) ====== [2025-11-20T00:36:23.312Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-20T00:36:23.312Z] GC before operation: completed in 134.905 ms, heap usage 301.650 MB -> 68.979 MB. [2025-11-20T00:36:25.660Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1834.851 ms) ====== [2025-11-20T00:36:25.660Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-20T00:36:25.660Z] GC before operation: completed in 128.346 ms, heap usage 211.629 MB -> 69.026 MB. [2025-11-20T00:36:27.313Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1907.644 ms) ====== [2025-11-20T00:36:27.313Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-20T00:36:27.313Z] GC before operation: completed in 131.173 ms, heap usage 297.603 MB -> 68.989 MB. [2025-11-20T00:36:29.563Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1804.386 ms) ====== [2025-11-20T00:36:29.563Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-20T00:36:29.563Z] GC before operation: completed in 132.851 ms, heap usage 254.438 MB -> 69.085 MB. [2025-11-20T00:36:31.214Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1962.233 ms) ====== [2025-11-20T00:36:31.214Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-20T00:36:31.542Z] GC before operation: completed in 136.224 ms, heap usage 129.730 MB -> 69.326 MB. [2025-11-20T00:36:33.206Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1805.169 ms) ====== [2025-11-20T00:36:33.206Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-20T00:36:33.538Z] GC before operation: completed in 140.505 ms, heap usage 302.827 MB -> 69.533 MB. [2025-11-20T00:36:35.193Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1749.167 ms) ====== [2025-11-20T00:36:35.193Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-20T00:36:35.193Z] GC before operation: completed in 130.442 ms, heap usage 228.034 MB -> 69.497 MB. [2025-11-20T00:36:37.532Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1907.189 ms) ====== [2025-11-20T00:36:37.532Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-20T00:36:37.532Z] GC before operation: completed in 134.745 ms, heap usage 219.827 MB -> 69.753 MB. [2025-11-20T00:36:39.259Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1747.383 ms) ====== [2025-11-20T00:36:39.260Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-20T00:36:39.260Z] GC before operation: completed in 134.595 ms, heap usage 286.351 MB -> 69.845 MB. [2025-11-20T00:36:40.911Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1774.079 ms) ====== [2025-11-20T00:36:40.911Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-20T00:36:41.240Z] GC before operation: completed in 141.722 ms, heap usage 148.824 MB -> 69.948 MB. [2025-11-20T00:36:42.899Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1942.216 ms) ====== [2025-11-20T00:36:42.899Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-20T00:36:43.230Z] GC before operation: completed in 143.815 ms, heap usage 289.533 MB -> 69.927 MB. [2025-11-20T00:36:44.892Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1828.295 ms) ====== [2025-11-20T00:36:44.892Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-20T00:36:45.220Z] GC before operation: completed in 137.454 ms, heap usage 207.943 MB -> 70.033 MB. [2025-11-20T00:36:46.941Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1715.344 ms) ====== [2025-11-20T00:36:46.941Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-20T00:36:46.941Z] GC before operation: completed in 150.319 ms, heap usage 317.032 MB -> 97.738 MB. [2025-11-20T00:36:49.187Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1817.636 ms) ====== [2025-11-20T00:36:49.188Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-20T00:36:49.188Z] GC before operation: completed in 153.175 ms, heap usage 231.478 MB -> 70.372 MB. [2025-11-20T00:36:50.840Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1627.163 ms) ====== [2025-11-20T00:36:50.840Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-20T00:36:50.840Z] GC before operation: completed in 147.111 ms, heap usage 299.013 MB -> 70.475 MB. [2025-11-20T00:36:52.500Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1735.536 ms) ====== [2025-11-20T00:36:52.500Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-20T00:36:52.827Z] GC before operation: completed in 149.316 ms, heap usage 173.195 MB -> 70.577 MB. [2025-11-20T00:36:54.481Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1668.244 ms) ====== [2025-11-20T00:36:54.481Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-20T00:36:54.481Z] GC before operation: completed in 144.924 ms, heap usage 271.265 MB -> 70.751 MB. [2025-11-20T00:36:56.729Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1840.519 ms) ====== [2025-11-20T00:36:56.729Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-20T00:36:56.729Z] GC before operation: completed in 154.484 ms, heap usage 169.280 MB -> 70.779 MB. [2025-11-20T00:36:58.384Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2033.754 ms) ====== [2025-11-20T00:36:58.384Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-20T00:36:58.711Z] GC before operation: completed in 143.509 ms, heap usage 137.961 MB -> 70.708 MB. [2025-11-20T00:37:00.360Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1667.347 ms) ====== [2025-11-20T00:37:00.360Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-20T00:37:00.360Z] GC before operation: completed in 149.662 ms, heap usage 263.341 MB -> 70.969 MB. [2025-11-20T00:37:02.018Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1626.532 ms) ====== [2025-11-20T00:37:02.018Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-20T00:37:02.345Z] GC before operation: completed in 148.140 ms, heap usage 298.013 MB -> 70.928 MB. [2025-11-20T00:37:04.002Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1650.738 ms) ====== [2025-11-20T00:37:04.003Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-20T00:37:04.003Z] GC before operation: completed in 145.158 ms, heap usage 104.160 MB -> 70.721 MB. [2025-11-20T00:37:06.247Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1816.916 ms) ====== [2025-11-20T00:37:06.247Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-20T00:37:06.247Z] GC before operation: completed in 150.241 ms, heap usage 260.948 MB -> 71.303 MB. [2025-11-20T00:37:07.900Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1657.530 ms) ====== [2025-11-20T00:37:07.900Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-20T00:37:07.900Z] GC before operation: completed in 146.248 ms, heap usage 212.809 MB -> 71.243 MB. [2025-11-20T00:37:09.553Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1673.331 ms) ====== [2025-11-20T00:37:09.553Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-20T00:37:09.553Z] GC before operation: completed in 147.446 ms, heap usage 193.335 MB -> 71.350 MB. [2025-11-20T00:37:11.207Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1591.104 ms) ====== [2025-11-20T00:37:11.207Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-20T00:37:11.535Z] GC before operation: completed in 153.262 ms, heap usage 250.460 MB -> 71.815 MB. [2025-11-20T00:37:13.188Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1690.933 ms) ====== [2025-11-20T00:37:13.188Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-20T00:37:13.188Z] GC before operation: completed in 151.641 ms, heap usage 162.788 MB -> 71.696 MB. [2025-11-20T00:37:14.906Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1645.837 ms) ====== [2025-11-20T00:37:14.906Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-20T00:37:14.906Z] GC before operation: completed in 152.590 ms, heap usage 136.145 MB -> 71.781 MB. [2025-11-20T00:37:16.562Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1650.957 ms) ====== [2025-11-20T00:37:16.562Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-20T00:37:16.968Z] GC before operation: completed in 152.194 ms, heap usage 149.410 MB -> 71.741 MB. [2025-11-20T00:37:18.655Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1611.361 ms) ====== [2025-11-20T00:37:18.656Z] ----------------------------------- [2025-11-20T00:37:18.656Z] renaissance-dec-tree_0_PASSED [2025-11-20T00:37:18.656Z] ----------------------------------- [2025-11-20T00:37:18.656Z] [2025-11-20T00:37:18.656Z] TEST TEARDOWN: [2025-11-20T00:37:18.656Z] Nothing to be done for teardown. [2025-11-20T00:37:18.656Z] renaissance-dec-tree_0 Finish Time: Thu Nov 20 00:37:18 2025 Epoch Time (ms): 1763599038606