[2025-07-15T11:11:32.958Z] Running test renaissance-dec-tree_0 ... [2025-07-15T11:11:32.958Z] =============================================== [2025-07-15T11:11:32.958Z] renaissance-dec-tree_0 Start Time: Tue Jul 15 11:11:31 2025 Epoch Time (ms): 1752577891978 [2025-07-15T11:11:32.958Z] variation: NoOptions [2025-07-15T11:11:32.958Z] JVM_OPTIONS: [2025-07-15T11:11:32.958Z] { \ [2025-07-15T11:11:32.958Z] echo ""; echo "TEST SETUP:"; \ [2025-07-15T11:11:32.958Z] echo "Nothing to be done for setup."; \ [2025-07-15T11:11:32.958Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17525773643189/renaissance-dec-tree_0"; \ [2025-07-15T11:11:32.958Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17525773643189/renaissance-dec-tree_0"; \ [2025-07-15T11:11:32.958Z] echo ""; echo "TESTING:"; \ [2025-07-15T11:11:32.958Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17525773643189/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-07-15T11:11:32.958Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17525773643189/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-07-15T11:11:32.958Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-07-15T11:11:32.958Z] echo "Nothing to be done for teardown."; \ [2025-07-15T11:11:32.958Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17525773643189/TestTargetResult"; [2025-07-15T11:11:32.958Z] [2025-07-15T11:11:32.958Z] TEST SETUP: [2025-07-15T11:11:32.958Z] Nothing to be done for setup. [2025-07-15T11:11:32.958Z] [2025-07-15T11:11:32.958Z] TESTING: [2025-07-15T11:11:38.456Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-07-15T11:11:40.414Z] WARNING: An illegal reflective access operation has occurred [2025-07-15T11:11:40.414Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17525773643189/renaissance-dec-tree_0/harness-111132-13667430348902269057/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-07-15T11:11:40.414Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-07-15T11:11:40.414Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-07-15T11:11:40.414Z] WARNING: All illegal access operations will be denied in a future release [2025-07-15T11:11:41.371Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-07-15T11:11:42.325Z] GC before operation: completed in 60.544 ms, heap usage 71.490 MB -> 34.402 MB. [2025-07-15T11:11:52.851Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10304.549 ms) ====== [2025-07-15T11:11:52.851Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-07-15T11:11:52.851Z] GC before operation: completed in 148.074 ms, heap usage 300.339 MB -> 68.254 MB. [2025-07-15T11:11:54.814Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2628.840 ms) ====== [2025-07-15T11:11:54.814Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-07-15T11:11:54.814Z] GC before operation: completed in 126.682 ms, heap usage 248.803 MB -> 85.109 MB. [2025-07-15T11:11:56.770Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2061.974 ms) ====== [2025-07-15T11:11:56.770Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-07-15T11:11:57.723Z] GC before operation: completed in 108.723 ms, heap usage 190.080 MB -> 68.582 MB. [2025-07-15T11:11:59.691Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2011.753 ms) ====== [2025-07-15T11:11:59.691Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-07-15T11:11:59.691Z] GC before operation: completed in 124.554 ms, heap usage 260.195 MB -> 69.269 MB. [2025-07-15T11:12:01.652Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1985.219 ms) ====== [2025-07-15T11:12:01.652Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-07-15T11:12:01.652Z] GC before operation: completed in 116.241 ms, heap usage 289.801 MB -> 69.766 MB. [2025-07-15T11:12:03.610Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1997.119 ms) ====== [2025-07-15T11:12:03.610Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-07-15T11:12:03.610Z] GC before operation: completed in 123.995 ms, heap usage 214.470 MB -> 69.703 MB. [2025-07-15T11:12:05.571Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1918.203 ms) ====== [2025-07-15T11:12:05.571Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-07-15T11:12:05.571Z] GC before operation: completed in 123.071 ms, heap usage 183.422 MB -> 69.757 MB. [2025-07-15T11:12:07.529Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1897.036 ms) ====== [2025-07-15T11:12:07.529Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-07-15T11:12:07.529Z] GC before operation: completed in 127.940 ms, heap usage 200.876 MB -> 80.949 MB. [2025-07-15T11:12:09.486Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1825.297 ms) ====== [2025-07-15T11:12:09.486Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-07-15T11:12:09.486Z] GC before operation: completed in 141.038 ms, heap usage 188.700 MB -> 69.692 MB. [2025-07-15T11:12:11.453Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1881.906 ms) ====== [2025-07-15T11:12:11.453Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-07-15T11:12:11.453Z] GC before operation: completed in 134.941 ms, heap usage 190.102 MB -> 75.223 MB. [2025-07-15T11:12:13.413Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1865.477 ms) ====== [2025-07-15T11:12:13.413Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-07-15T11:12:13.413Z] GC before operation: completed in 140.255 ms, heap usage 219.971 MB -> 70.218 MB. [2025-07-15T11:12:15.375Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1839.248 ms) ====== [2025-07-15T11:12:15.375Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-07-15T11:12:15.375Z] GC before operation: completed in 139.954 ms, heap usage 187.213 MB -> 81.351 MB. [2025-07-15T11:12:17.343Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1804.938 ms) ====== [2025-07-15T11:12:17.343Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-07-15T11:12:17.343Z] GC before operation: completed in 153.167 ms, heap usage 261.542 MB -> 81.759 MB. [2025-07-15T11:12:19.305Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1761.559 ms) ====== [2025-07-15T11:12:19.305Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-07-15T11:12:19.305Z] GC before operation: completed in 141.669 ms, heap usage 309.169 MB -> 70.729 MB. [2025-07-15T11:12:21.272Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1825.330 ms) ====== [2025-07-15T11:12:21.272Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-07-15T11:12:21.272Z] GC before operation: completed in 140.150 ms, heap usage 230.492 MB -> 70.886 MB. [2025-07-15T11:12:23.245Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1792.633 ms) ====== [2025-07-15T11:12:23.245Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-07-15T11:12:23.245Z] GC before operation: completed in 135.646 ms, heap usage 268.401 MB -> 71.019 MB. [2025-07-15T11:12:25.207Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1754.679 ms) ====== [2025-07-15T11:12:25.207Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-07-15T11:12:25.207Z] GC before operation: completed in 129.632 ms, heap usage 163.580 MB -> 71.364 MB. [2025-07-15T11:12:27.164Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1813.227 ms) ====== [2025-07-15T11:12:27.164Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-07-15T11:12:27.164Z] GC before operation: completed in 140.050 ms, heap usage 175.002 MB -> 70.942 MB. [2025-07-15T11:12:29.133Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1767.586 ms) ====== [2025-07-15T11:12:29.133Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-07-15T11:12:29.133Z] GC before operation: completed in 136.404 ms, heap usage 223.991 MB -> 82.245 MB. [2025-07-15T11:12:31.140Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1834.708 ms) ====== [2025-07-15T11:12:31.140Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-07-15T11:12:31.140Z] GC before operation: completed in 131.972 ms, heap usage 246.966 MB -> 82.626 MB. [2025-07-15T11:12:33.110Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1744.285 ms) ====== [2025-07-15T11:12:33.110Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-07-15T11:12:33.110Z] GC before operation: completed in 129.490 ms, heap usage 253.243 MB -> 71.557 MB. [2025-07-15T11:12:35.067Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1774.470 ms) ====== [2025-07-15T11:12:35.067Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-07-15T11:12:35.067Z] GC before operation: completed in 140.735 ms, heap usage 236.431 MB -> 71.666 MB. [2025-07-15T11:12:37.030Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1747.883 ms) ====== [2025-07-15T11:12:37.030Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-07-15T11:12:37.030Z] GC before operation: completed in 142.020 ms, heap usage 271.666 MB -> 82.922 MB. [2025-07-15T11:12:39.714Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1754.085 ms) ====== [2025-07-15T11:12:39.714Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-07-15T11:12:39.715Z] GC before operation: completed in 142.145 ms, heap usage 267.273 MB -> 71.735 MB. [2025-07-15T11:12:40.669Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1739.396 ms) ====== [2025-07-15T11:12:40.669Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-07-15T11:12:40.669Z] GC before operation: completed in 144.414 ms, heap usage 230.910 MB -> 71.839 MB. [2025-07-15T11:12:42.635Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1743.804 ms) ====== [2025-07-15T11:12:42.635Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-07-15T11:12:42.635Z] GC before operation: completed in 147.886 ms, heap usage 227.931 MB -> 71.942 MB. [2025-07-15T11:12:44.594Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1789.593 ms) ====== [2025-07-15T11:12:44.594Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-07-15T11:12:44.594Z] GC before operation: completed in 132.631 ms, heap usage 156.699 MB -> 71.861 MB. [2025-07-15T11:12:45.724Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1742.035 ms) ====== [2025-07-15T11:12:45.724Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-07-15T11:12:46.685Z] GC before operation: completed in 155.206 ms, heap usage 300.999 MB -> 72.113 MB. [2025-07-15T11:12:47.641Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1749.165 ms) ====== [2025-07-15T11:12:47.641Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-07-15T11:12:48.596Z] GC before operation: completed in 147.943 ms, heap usage 161.620 MB -> 71.897 MB. [2025-07-15T11:12:49.551Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1735.789 ms) ====== [2025-07-15T11:12:49.551Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-07-15T11:12:50.511Z] GC before operation: completed in 146.813 ms, heap usage 184.495 MB -> 72.472 MB. [2025-07-15T11:12:51.476Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1699.406 ms) ====== [2025-07-15T11:12:51.476Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-07-15T11:12:51.476Z] GC before operation: completed in 148.098 ms, heap usage 115.666 MB -> 72.261 MB. [2025-07-15T11:12:53.434Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1750.355 ms) ====== [2025-07-15T11:12:53.434Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-07-15T11:12:53.434Z] GC before operation: completed in 146.780 ms, heap usage 293.887 MB -> 72.674 MB. [2025-07-15T11:12:56.084Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1704.203 ms) ====== [2025-07-15T11:12:56.084Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-07-15T11:12:56.084Z] GC before operation: completed in 165.598 ms, heap usage 321.888 MB -> 73.003 MB. [2025-07-15T11:12:57.039Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1704.835 ms) ====== [2025-07-15T11:12:57.039Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-07-15T11:12:58.006Z] GC before operation: completed in 144.409 ms, heap usage 147.066 MB -> 72.758 MB. [2025-07-15T11:12:58.961Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1763.001 ms) ====== [2025-07-15T11:12:58.961Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-07-15T11:12:59.922Z] GC before operation: completed in 141.402 ms, heap usage 265.822 MB -> 72.888 MB. [2025-07-15T11:13:00.887Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1718.729 ms) ====== [2025-07-15T11:13:00.887Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-07-15T11:13:00.887Z] GC before operation: completed in 146.558 ms, heap usage 123.121 MB -> 72.821 MB. [2025-07-15T11:13:02.852Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1725.274 ms) ====== [2025-07-15T11:13:02.852Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-07-15T11:13:02.852Z] GC before operation: completed in 149.612 ms, heap usage 286.195 MB -> 73.234 MB. [2025-07-15T11:13:04.818Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1719.368 ms) ====== [2025-07-15T11:13:04.818Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-07-15T11:13:04.818Z] GC before operation: completed in 157.079 ms, heap usage 164.261 MB -> 73.317 MB. [2025-07-15T11:13:06.779Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1708.367 ms) ====== [2025-07-15T11:13:06.779Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-07-15T11:13:06.779Z] GC before operation: completed in 147.189 ms, heap usage 272.644 MB -> 73.443 MB. [2025-07-15T11:13:08.745Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1721.725 ms) ====== [2025-07-15T11:13:08.745Z] ----------------------------------- [2025-07-15T11:13:08.745Z] renaissance-dec-tree_0_PASSED [2025-07-15T11:13:08.745Z] ----------------------------------- [2025-07-15T11:13:08.745Z] [2025-07-15T11:13:08.745Z] TEST TEARDOWN: [2025-07-15T11:13:08.745Z] Nothing to be done for teardown. [2025-07-15T11:13:08.745Z] renaissance-dec-tree_0 Finish Time: Tue Jul 15 11:13:08 2025 Epoch Time (ms): 1752577988430