[2025-11-06T03:45:03.590Z] Running test renaissance-dec-tree_0 ... [2025-11-06T03:45:03.590Z] =============================================== [2025-11-06T03:45:03.590Z] renaissance-dec-tree_0 Start Time: Thu Nov 6 03:45:03 2025 Epoch Time (ms): 1762400703266 [2025-11-06T03:45:03.590Z] variation: NoOptions [2025-11-06T03:45:03.590Z] JVM_OPTIONS: [2025-11-06T03:45:03.590Z] { \ [2025-11-06T03:45:03.590Z] echo ""; echo "TEST SETUP:"; \ [2025-11-06T03:45:03.590Z] echo "Nothing to be done for setup."; \ [2025-11-06T03:45:03.590Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_1762399642806/renaissance-dec-tree_0"; \ [2025-11-06T03:45:03.590Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_1762399642806/renaissance-dec-tree_0"; \ [2025-11-06T03:45:03.590Z] echo ""; echo "TESTING:"; \ [2025-11-06T03:45:03.590Z] "/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_1762399642806/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-06T03:45:03.590Z] 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_1762399642806/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-06T03:45:03.590Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-06T03:45:03.590Z] echo "Nothing to be done for teardown."; \ [2025-11-06T03:45:03.590Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux_testList_1/aqa-tests/TKG/../TKG/output_1762399642806/TestTargetResult"; [2025-11-06T03:45:03.590Z] [2025-11-06T03:45:03.590Z] TEST SETUP: [2025-11-06T03:45:03.590Z] Nothing to be done for setup. [2025-11-06T03:45:03.590Z] [2025-11-06T03:45:03.590Z] TESTING: [2025-11-06T03:45:10.996Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-11-06T03:45:11.360Z] WARNING: An illegal reflective access operation has occurred [2025-11-06T03:45:11.361Z] 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_1762399642806/renaissance-dec-tree_0/harness-034503-15640128034161786411/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-11-06T03:45:11.361Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-11-06T03:45:11.361Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-11-06T03:45:11.361Z] WARNING: All illegal access operations will be denied in a future release [2025-11-06T03:45:13.044Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-06T03:45:13.044Z] GC before operation: completed in 61.631 ms, heap usage 52.266 MB -> 34.156 MB. [2025-11-06T03:45:29.023Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (14702.248 ms) ====== [2025-11-06T03:45:29.023Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-06T03:45:29.023Z] GC before operation: completed in 194.980 ms, heap usage 353.331 MB -> 66.910 MB. [2025-11-06T03:45:32.018Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4342.721 ms) ====== [2025-11-06T03:45:32.018Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-06T03:45:32.018Z] GC before operation: completed in 128.398 ms, heap usage 201.294 MB -> 67.348 MB. [2025-11-06T03:45:35.863Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3301.532 ms) ====== [2025-11-06T03:45:35.863Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-06T03:45:35.863Z] GC before operation: completed in 183.187 ms, heap usage 286.069 MB -> 67.429 MB. [2025-11-06T03:45:38.905Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3021.307 ms) ====== [2025-11-06T03:45:38.905Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-06T03:45:38.905Z] GC before operation: completed in 153.595 ms, heap usage 194.077 MB -> 67.647 MB. [2025-11-06T03:45:41.907Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2725.100 ms) ====== [2025-11-06T03:45:41.907Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-06T03:45:41.907Z] GC before operation: completed in 143.739 ms, heap usage 258.858 MB -> 95.434 MB. [2025-11-06T03:45:44.200Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2479.199 ms) ====== [2025-11-06T03:45:44.200Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-06T03:45:44.200Z] GC before operation: completed in 145.391 ms, heap usage 224.118 MB -> 68.172 MB. [2025-11-06T03:45:47.294Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2437.896 ms) ====== [2025-11-06T03:45:47.294Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-06T03:45:47.294Z] GC before operation: completed in 146.580 ms, heap usage 202.996 MB -> 68.240 MB. [2025-11-06T03:45:49.592Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2339.612 ms) ====== [2025-11-06T03:45:49.592Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-06T03:45:49.592Z] GC before operation: completed in 145.312 ms, heap usage 284.192 MB -> 68.429 MB. [2025-11-06T03:45:51.882Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2089.905 ms) ====== [2025-11-06T03:45:51.882Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-06T03:45:51.882Z] GC before operation: completed in 149.923 ms, heap usage 113.738 MB -> 68.217 MB. [2025-11-06T03:45:54.187Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2147.913 ms) ====== [2025-11-06T03:45:54.187Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-06T03:45:54.187Z] GC before operation: completed in 149.210 ms, heap usage 319.591 MB -> 68.797 MB. [2025-11-06T03:45:56.487Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2169.486 ms) ====== [2025-11-06T03:45:56.487Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-06T03:45:56.487Z] GC before operation: completed in 151.879 ms, heap usage 200.635 MB -> 68.899 MB. [2025-11-06T03:45:58.179Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2010.801 ms) ====== [2025-11-06T03:45:58.179Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-06T03:45:58.519Z] GC before operation: completed in 151.813 ms, heap usage 146.189 MB -> 68.991 MB. [2025-11-06T03:46:00.814Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2072.828 ms) ====== [2025-11-06T03:46:00.814Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-06T03:46:00.814Z] GC before operation: completed in 149.633 ms, heap usage 172.083 MB -> 69.339 MB. [2025-11-06T03:46:02.496Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1995.384 ms) ====== [2025-11-06T03:46:02.496Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-06T03:46:02.834Z] GC before operation: completed in 152.632 ms, heap usage 206.788 MB -> 69.482 MB. [2025-11-06T03:46:05.124Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2032.454 ms) ====== [2025-11-06T03:46:05.124Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-06T03:46:05.124Z] GC before operation: completed in 155.460 ms, heap usage 249.311 MB -> 69.354 MB. [2025-11-06T03:46:07.432Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2016.005 ms) ====== [2025-11-06T03:46:07.432Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-06T03:46:07.432Z] GC before operation: completed in 154.352 ms, heap usage 269.614 MB -> 69.513 MB. [2025-11-06T03:46:09.194Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2097.858 ms) ====== [2025-11-06T03:46:09.195Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-06T03:46:09.533Z] GC before operation: completed in 160.234 ms, heap usage 251.164 MB -> 69.623 MB. [2025-11-06T03:46:11.826Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1988.177 ms) ====== [2025-11-06T03:46:11.826Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-06T03:46:11.826Z] GC before operation: completed in 157.585 ms, heap usage 167.062 MB -> 69.590 MB. [2025-11-06T03:46:13.514Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1924.613 ms) ====== [2025-11-06T03:46:13.514Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-06T03:46:13.514Z] GC before operation: completed in 160.271 ms, heap usage 168.242 MB -> 69.391 MB. [2025-11-06T03:46:15.811Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2010.281 ms) ====== [2025-11-06T03:46:15.811Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-06T03:46:15.811Z] GC before operation: completed in 155.630 ms, heap usage 112.505 MB -> 69.627 MB. [2025-11-06T03:46:18.112Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1910.912 ms) ====== [2025-11-06T03:46:18.112Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-06T03:46:18.112Z] GC before operation: completed in 164.859 ms, heap usage 215.709 MB -> 97.521 MB. [2025-11-06T03:46:19.798Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1872.086 ms) ====== [2025-11-06T03:46:19.798Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-06T03:46:19.798Z] GC before operation: completed in 159.910 ms, heap usage 253.558 MB -> 70.024 MB. [2025-11-06T03:46:22.093Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1851.514 ms) ====== [2025-11-06T03:46:22.093Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-06T03:46:22.093Z] GC before operation: completed in 160.048 ms, heap usage 200.019 MB -> 70.270 MB. [2025-11-06T03:46:23.782Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1902.614 ms) ====== [2025-11-06T03:46:23.782Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-06T03:46:24.120Z] GC before operation: completed in 166.044 ms, heap usage 161.118 MB -> 78.745 MB. [2025-11-06T03:46:25.812Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1835.421 ms) ====== [2025-11-06T03:46:25.812Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-06T03:46:26.149Z] GC before operation: completed in 161.468 ms, heap usage 117.889 MB -> 70.177 MB. [2025-11-06T03:46:27.834Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1848.124 ms) ====== [2025-11-06T03:46:27.834Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-06T03:46:28.174Z] GC before operation: completed in 168.970 ms, heap usage 292.804 MB -> 70.557 MB. [2025-11-06T03:46:29.882Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1981.003 ms) ====== [2025-11-06T03:46:29.882Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-06T03:46:30.219Z] GC before operation: completed in 177.139 ms, heap usage 307.740 MB -> 98.129 MB. [2025-11-06T03:46:32.510Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2125.915 ms) ====== [2025-11-06T03:46:32.510Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-06T03:46:32.510Z] GC before operation: completed in 175.536 ms, heap usage 241.300 MB -> 98.215 MB. [2025-11-06T03:46:34.197Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1853.154 ms) ====== [2025-11-06T03:46:34.198Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-06T03:46:34.538Z] GC before operation: completed in 176.745 ms, heap usage 347.783 MB -> 79.279 MB. [2025-11-06T03:46:36.226Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1849.303 ms) ====== [2025-11-06T03:46:36.226Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-06T03:46:36.567Z] GC before operation: completed in 168.302 ms, heap usage 242.320 MB -> 71.175 MB. [2025-11-06T03:46:38.252Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1830.604 ms) ====== [2025-11-06T03:46:38.252Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-06T03:46:38.592Z] GC before operation: completed in 181.263 ms, heap usage 313.579 MB -> 90.366 MB. [2025-11-06T03:46:40.279Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1831.499 ms) ====== [2025-11-06T03:46:40.279Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-06T03:46:40.617Z] GC before operation: completed in 176.044 ms, heap usage 274.055 MB -> 90.479 MB. [2025-11-06T03:46:40.617Z] 03:46:40.401 WARN [block-manager-storage-async-thread-pool-30] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_443, which does not exist [2025-11-06T03:46:42.305Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1860.048 ms) ====== [2025-11-06T03:46:42.305Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-06T03:46:42.642Z] GC before operation: completed in 176.222 ms, heap usage 307.994 MB -> 71.154 MB. [2025-11-06T03:46:44.331Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1798.005 ms) ====== [2025-11-06T03:46:44.331Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-06T03:46:44.673Z] GC before operation: completed in 173.973 ms, heap usage 192.452 MB -> 71.256 MB. [2025-11-06T03:46:46.364Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1866.832 ms) ====== [2025-11-06T03:46:46.364Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-06T03:46:46.698Z] GC before operation: completed in 172.941 ms, heap usage 247.962 MB -> 71.351 MB. [2025-11-06T03:46:48.385Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1721.234 ms) ====== [2025-11-06T03:46:48.385Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-06T03:46:48.385Z] GC before operation: completed in 173.104 ms, heap usage 254.052 MB -> 71.457 MB. [2025-11-06T03:46:50.735Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1977.153 ms) ====== [2025-11-06T03:46:50.735Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-06T03:46:50.735Z] GC before operation: completed in 174.184 ms, heap usage 175.903 MB -> 79.863 MB. [2025-11-06T03:46:52.534Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1999.688 ms) ====== [2025-11-06T03:46:52.534Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-06T03:46:52.868Z] GC before operation: completed in 172.533 ms, heap usage 145.844 MB -> 79.804 MB. [2025-11-06T03:46:55.161Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1916.672 ms) ====== [2025-11-06T03:46:55.161Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-06T03:46:55.161Z] GC before operation: completed in 181.541 ms, heap usage 317.479 MB -> 99.341 MB. [2025-11-06T03:46:56.846Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1754.032 ms) ====== [2025-11-06T03:46:56.846Z] ----------------------------------- [2025-11-06T03:46:56.846Z] renaissance-dec-tree_0_PASSED [2025-11-06T03:46:56.846Z] ----------------------------------- [2025-11-06T03:46:56.846Z] [2025-11-06T03:46:56.846Z] TEST TEARDOWN: [2025-11-06T03:46:56.846Z] Nothing to be done for teardown. [2025-11-06T03:46:56.846Z] renaissance-dec-tree_0 Finish Time: Thu Nov 6 03:46:56 2025 Epoch Time (ms): 1762400816791