[2025-07-16T04:30:02.425Z] Running test renaissance-dec-tree_0 ... [2025-07-16T04:30:02.425Z] =============================================== [2025-07-16T04:30:02.425Z] renaissance-dec-tree_0 Start Time: Wed Jul 16 04:30:01 2025 Epoch Time (ms): 1752640201940 [2025-07-16T04:30:02.425Z] variation: NoOptions [2025-07-16T04:30:02.425Z] JVM_OPTIONS: [2025-07-16T04:30:02.425Z] { \ [2025-07-16T04:30:02.425Z] echo ""; echo "TEST SETUP:"; \ [2025-07-16T04:30:02.425Z] echo "Nothing to be done for setup."; \ [2025-07-16T04:30:02.425Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17526397241551/renaissance-dec-tree_0"; \ [2025-07-16T04:30:02.425Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17526397241551/renaissance-dec-tree_0"; \ [2025-07-16T04:30:02.425Z] echo ""; echo "TESTING:"; \ [2025-07-16T04:30:02.425Z] "/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_17526397241551/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-07-16T04:30:02.425Z] 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_17526397241551/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-07-16T04:30:02.425Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-07-16T04:30:02.425Z] echo "Nothing to be done for teardown."; \ [2025-07-16T04:30:02.425Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17526397241551/TestTargetResult"; [2025-07-16T04:30:02.425Z] [2025-07-16T04:30:02.425Z] TEST SETUP: [2025-07-16T04:30:02.425Z] Nothing to be done for setup. [2025-07-16T04:30:02.425Z] [2025-07-16T04:30:02.425Z] TESTING: [2025-07-16T04:30:09.138Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-07-16T04:30:10.092Z] WARNING: An illegal reflective access operation has occurred [2025-07-16T04:30:10.093Z] 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_17526397241551/renaissance-dec-tree_0/harness-043002-11367154943803939155/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-07-16T04:30:10.093Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-07-16T04:30:10.093Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-07-16T04:30:10.093Z] WARNING: All illegal access operations will be denied in a future release [2025-07-16T04:30:12.051Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-07-16T04:30:12.051Z] GC before operation: completed in 69.188 ms, heap usage 91.600 MB -> 34.445 MB. [2025-07-16T04:30:21.810Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10055.457 ms) ====== [2025-07-16T04:30:21.810Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-07-16T04:30:21.810Z] GC before operation: completed in 126.024 ms, heap usage 226.196 MB -> 68.294 MB. [2025-07-16T04:30:24.833Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2415.613 ms) ====== [2025-07-16T04:30:24.833Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-07-16T04:30:24.833Z] GC before operation: completed in 139.058 ms, heap usage 243.823 MB -> 68.629 MB. [2025-07-16T04:30:26.792Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2135.775 ms) ====== [2025-07-16T04:30:26.792Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-07-16T04:30:26.792Z] GC before operation: completed in 117.374 ms, heap usage 263.531 MB -> 69.035 MB. [2025-07-16T04:30:28.750Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2069.715 ms) ====== [2025-07-16T04:30:28.750Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-07-16T04:30:28.750Z] GC before operation: completed in 124.374 ms, heap usage 243.662 MB -> 69.278 MB. [2025-07-16T04:30:30.716Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1995.765 ms) ====== [2025-07-16T04:30:30.716Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-07-16T04:30:30.716Z] GC before operation: completed in 141.941 ms, heap usage 228.734 MB -> 69.353 MB. [2025-07-16T04:30:32.682Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2001.165 ms) ====== [2025-07-16T04:30:32.682Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-07-16T04:30:32.682Z] GC before operation: completed in 124.470 ms, heap usage 303.492 MB -> 80.666 MB. [2025-07-16T04:30:35.708Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1996.853 ms) ====== [2025-07-16T04:30:35.708Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-07-16T04:30:35.708Z] GC before operation: completed in 132.320 ms, heap usage 291.474 MB -> 81.043 MB. [2025-07-16T04:30:36.665Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1832.985 ms) ====== [2025-07-16T04:30:36.665Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-07-16T04:30:37.620Z] GC before operation: completed in 133.596 ms, heap usage 348.662 MB -> 81.163 MB. [2025-07-16T04:30:39.583Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1918.055 ms) ====== [2025-07-16T04:30:39.583Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-07-16T04:30:39.583Z] GC before operation: completed in 131.483 ms, heap usage 120.850 MB -> 69.827 MB. [2025-07-16T04:30:41.542Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1840.843 ms) ====== [2025-07-16T04:30:41.542Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-07-16T04:30:41.542Z] GC before operation: completed in 119.804 ms, heap usage 229.152 MB -> 70.118 MB. [2025-07-16T04:30:43.504Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1859.404 ms) ====== [2025-07-16T04:30:43.504Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-07-16T04:30:43.504Z] GC before operation: completed in 132.521 ms, heap usage 277.166 MB -> 70.367 MB. [2025-07-16T04:30:45.470Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1845.240 ms) ====== [2025-07-16T04:30:45.470Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-07-16T04:30:45.470Z] GC before operation: completed in 118.865 ms, heap usage 210.933 MB -> 70.338 MB. [2025-07-16T04:30:48.022Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1856.440 ms) ====== [2025-07-16T04:30:48.022Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-07-16T04:30:48.022Z] GC before operation: completed in 126.374 ms, heap usage 108.427 MB -> 70.281 MB. [2025-07-16T04:30:49.018Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1759.654 ms) ====== [2025-07-16T04:30:49.018Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-07-16T04:30:49.018Z] GC before operation: completed in 121.176 ms, heap usage 160.204 MB -> 70.393 MB. [2025-07-16T04:30:50.978Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1808.812 ms) ====== [2025-07-16T04:30:50.978Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-07-16T04:30:50.978Z] GC before operation: completed in 126.821 ms, heap usage 207.951 MB -> 81.992 MB. [2025-07-16T04:30:52.948Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1796.217 ms) ====== [2025-07-16T04:30:52.948Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-07-16T04:30:52.948Z] GC before operation: completed in 128.452 ms, heap usage 275.267 MB -> 71.001 MB. [2025-07-16T04:30:54.917Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1778.103 ms) ====== [2025-07-16T04:30:54.917Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-07-16T04:30:54.917Z] GC before operation: completed in 125.045 ms, heap usage 110.725 MB -> 71.041 MB. [2025-07-16T04:30:56.877Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1738.633 ms) ====== [2025-07-16T04:30:56.877Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-07-16T04:30:56.877Z] GC before operation: completed in 125.117 ms, heap usage 111.726 MB -> 70.771 MB. [2025-07-16T04:30:58.836Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1760.313 ms) ====== [2025-07-16T04:30:58.836Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-07-16T04:30:58.836Z] GC before operation: completed in 124.881 ms, heap usage 109.451 MB -> 71.021 MB. [2025-07-16T04:31:00.796Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1714.921 ms) ====== [2025-07-16T04:31:00.796Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-07-16T04:31:00.796Z] GC before operation: completed in 126.092 ms, heap usage 164.023 MB -> 82.267 MB. [2025-07-16T04:31:01.751Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1672.720 ms) ====== [2025-07-16T04:31:01.751Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-07-16T04:31:02.705Z] GC before operation: completed in 134.052 ms, heap usage 285.837 MB -> 71.550 MB. [2025-07-16T04:31:03.661Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1794.903 ms) ====== [2025-07-16T04:31:03.661Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-07-16T04:31:04.616Z] GC before operation: completed in 143.591 ms, heap usage 216.953 MB -> 71.513 MB. [2025-07-16T04:31:05.574Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1766.197 ms) ====== [2025-07-16T04:31:05.574Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-07-16T04:31:06.532Z] GC before operation: completed in 136.580 ms, heap usage 268.350 MB -> 71.766 MB. [2025-07-16T04:31:07.494Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1705.972 ms) ====== [2025-07-16T04:31:07.494Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-07-16T04:31:07.494Z] GC before operation: completed in 139.837 ms, heap usage 227.342 MB -> 71.873 MB. [2025-07-16T04:31:09.455Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1708.592 ms) ====== [2025-07-16T04:31:09.455Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-07-16T04:31:09.455Z] GC before operation: completed in 134.857 ms, heap usage 249.780 MB -> 71.832 MB. [2025-07-16T04:31:11.416Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1728.795 ms) ====== [2025-07-16T04:31:11.416Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-07-16T04:31:11.416Z] GC before operation: completed in 127.800 ms, heap usage 227.309 MB -> 72.325 MB. [2025-07-16T04:31:13.378Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1716.612 ms) ====== [2025-07-16T04:31:13.378Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-07-16T04:31:13.378Z] GC before operation: completed in 141.667 ms, heap usage 215.070 MB -> 72.041 MB. [2025-07-16T04:31:15.367Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1767.442 ms) ====== [2025-07-16T04:31:15.367Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-07-16T04:31:15.367Z] GC before operation: completed in 138.421 ms, heap usage 302.364 MB -> 83.432 MB. [2025-07-16T04:31:17.347Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1631.562 ms) ====== [2025-07-16T04:31:17.347Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-07-16T04:31:17.347Z] GC before operation: completed in 152.848 ms, heap usage 286.878 MB -> 72.372 MB. [2025-07-16T04:31:19.306Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1762.145 ms) ====== [2025-07-16T04:31:19.306Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-07-16T04:31:19.306Z] GC before operation: completed in 135.923 ms, heap usage 213.387 MB -> 83.625 MB. [2025-07-16T04:31:21.264Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1654.736 ms) ====== [2025-07-16T04:31:21.264Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-07-16T04:31:21.264Z] GC before operation: completed in 152.647 ms, heap usage 117.834 MB -> 72.265 MB. [2025-07-16T04:31:22.219Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1747.000 ms) ====== [2025-07-16T04:31:22.219Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-07-16T04:31:23.174Z] GC before operation: completed in 143.242 ms, heap usage 264.933 MB -> 72.533 MB. [2025-07-16T04:31:24.128Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1740.447 ms) ====== [2025-07-16T04:31:24.128Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-07-16T04:31:25.082Z] GC before operation: completed in 143.014 ms, heap usage 120.912 MB -> 72.313 MB. [2025-07-16T04:31:26.037Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1696.363 ms) ====== [2025-07-16T04:31:26.037Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-07-16T04:31:26.037Z] GC before operation: completed in 138.809 ms, heap usage 301.625 MB -> 72.771 MB. [2025-07-16T04:31:28.009Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1782.170 ms) ====== [2025-07-16T04:31:28.009Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-07-16T04:31:28.009Z] GC before operation: completed in 148.167 ms, heap usage 159.002 MB -> 72.558 MB. [2025-07-16T04:31:29.969Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1806.589 ms) ====== [2025-07-16T04:31:29.969Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-07-16T04:31:29.969Z] GC before operation: completed in 149.038 ms, heap usage 246.462 MB -> 73.136 MB. [2025-07-16T04:31:31.930Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1690.765 ms) ====== [2025-07-16T04:31:31.930Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-07-16T04:31:31.930Z] GC before operation: completed in 146.716 ms, heap usage 124.512 MB -> 72.456 MB. [2025-07-16T04:31:33.897Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1755.689 ms) ====== [2025-07-16T04:31:33.897Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-07-16T04:31:33.897Z] GC before operation: completed in 148.171 ms, heap usage 253.266 MB -> 84.080 MB. [2025-07-16T04:31:35.858Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1679.446 ms) ====== [2025-07-16T04:31:35.858Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-07-16T04:31:35.858Z] GC before operation: completed in 145.842 ms, heap usage 128.508 MB -> 72.665 MB. [2025-07-16T04:31:37.818Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1673.114 ms) ====== [2025-07-16T04:31:37.818Z] ----------------------------------- [2025-07-16T04:31:37.818Z] renaissance-dec-tree_0_PASSED [2025-07-16T04:31:37.818Z] ----------------------------------- [2025-07-16T04:31:37.818Z] [2025-07-16T04:31:37.818Z] TEST TEARDOWN: [2025-07-16T04:31:37.818Z] Nothing to be done for teardown. [2025-07-16T04:31:37.818Z] renaissance-dec-tree_0 Finish Time: Wed Jul 16 04:31:37 2025 Epoch Time (ms): 1752640297421