[2025-08-01T21:47:45.442Z] Running test renaissance-dec-tree_0 ... [2025-08-01T21:47:45.442Z] =============================================== [2025-08-01T21:47:45.442Z] renaissance-dec-tree_0 Start Time: Fri Aug 1 21:47:44 2025 Epoch Time (ms): 1754084864573 [2025-08-01T21:47:45.442Z] variation: NoOptions [2025-08-01T21:47:45.442Z] JVM_OPTIONS: [2025-08-01T21:47:45.442Z] { \ [2025-08-01T21:47:45.442Z] echo ""; echo "TEST SETUP:"; \ [2025-08-01T21:47:45.442Z] echo "Nothing to be done for setup."; \ [2025-08-01T21:47:45.442Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17540842121046/renaissance-dec-tree_0"; \ [2025-08-01T21:47:45.442Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17540842121046/renaissance-dec-tree_0"; \ [2025-08-01T21:47:45.442Z] echo ""; echo "TESTING:"; \ [2025-08-01T21:47:45.442Z] "/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_17540842121046/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-08-01T21:47:45.442Z] 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_17540842121046/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-01T21:47:45.442Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-01T21:47:45.442Z] echo "Nothing to be done for teardown."; \ [2025-08-01T21:47:45.442Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17540842121046/TestTargetResult"; [2025-08-01T21:47:45.442Z] [2025-08-01T21:47:45.442Z] TEST SETUP: [2025-08-01T21:47:45.442Z] Nothing to be done for setup. [2025-08-01T21:47:45.442Z] [2025-08-01T21:47:45.442Z] TESTING: [2025-08-01T21:47:52.107Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-08-01T21:47:53.051Z] WARNING: An illegal reflective access operation has occurred [2025-08-01T21:47:53.051Z] 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_17540842121046/renaissance-dec-tree_0/harness-214745-17465074006111158812/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-08-01T21:47:53.051Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-08-01T21:47:53.051Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-08-01T21:47:53.051Z] WARNING: All illegal access operations will be denied in a future release [2025-08-01T21:47:53.995Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-08-01T21:47:53.995Z] GC before operation: completed in 59.436 ms, heap usage 87.309 MB -> 34.382 MB. [2025-08-01T21:48:05.452Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10687.145 ms) ====== [2025-08-01T21:48:05.452Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-08-01T21:48:05.452Z] GC before operation: completed in 128.541 ms, heap usage 306.366 MB -> 68.275 MB. [2025-08-01T21:48:07.389Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2451.140 ms) ====== [2025-08-01T21:48:07.389Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-08-01T21:48:07.389Z] GC before operation: completed in 153.527 ms, heap usage 304.515 MB -> 68.624 MB. [2025-08-01T21:48:10.402Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2198.971 ms) ====== [2025-08-01T21:48:10.402Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-08-01T21:48:10.402Z] GC before operation: completed in 117.869 ms, heap usage 251.277 MB -> 69.024 MB. [2025-08-01T21:48:12.348Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2088.265 ms) ====== [2025-08-01T21:48:12.348Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-08-01T21:48:12.348Z] GC before operation: completed in 130.691 ms, heap usage 236.642 MB -> 69.262 MB. [2025-08-01T21:48:14.314Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2001.498 ms) ====== [2025-08-01T21:48:14.314Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-08-01T21:48:14.314Z] GC before operation: completed in 122.272 ms, heap usage 261.760 MB -> 80.616 MB. [2025-08-01T21:48:16.257Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1999.252 ms) ====== [2025-08-01T21:48:16.257Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-08-01T21:48:16.257Z] GC before operation: completed in 125.784 ms, heap usage 181.218 MB -> 69.242 MB. [2025-08-01T21:48:18.194Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1994.224 ms) ====== [2025-08-01T21:48:18.194Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-08-01T21:48:19.140Z] GC before operation: completed in 128.013 ms, heap usage 174.778 MB -> 69.584 MB. [2025-08-01T21:48:21.099Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2046.898 ms) ====== [2025-08-01T21:48:21.099Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-08-01T21:48:21.100Z] GC before operation: completed in 139.152 ms, heap usage 101.203 MB -> 69.667 MB. [2025-08-01T21:48:23.038Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1923.370 ms) ====== [2025-08-01T21:48:23.038Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-08-01T21:48:23.038Z] GC before operation: completed in 136.179 ms, heap usage 114.985 MB -> 69.797 MB. [2025-08-01T21:48:25.019Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1891.442 ms) ====== [2025-08-01T21:48:25.019Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-08-01T21:48:25.019Z] GC before operation: completed in 124.542 ms, heap usage 182.148 MB -> 70.235 MB. [2025-08-01T21:48:26.961Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1811.109 ms) ====== [2025-08-01T21:48:26.961Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-08-01T21:48:26.961Z] GC before operation: completed in 129.837 ms, heap usage 181.127 MB -> 69.910 MB. [2025-08-01T21:48:28.900Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1877.534 ms) ====== [2025-08-01T21:48:28.900Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-08-01T21:48:28.900Z] GC before operation: completed in 137.442 ms, heap usage 252.696 MB -> 81.597 MB. [2025-08-01T21:48:30.848Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1862.130 ms) ====== [2025-08-01T21:48:30.848Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-08-01T21:48:30.848Z] GC before operation: completed in 138.628 ms, heap usage 199.174 MB -> 70.594 MB. [2025-08-01T21:48:32.793Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1905.795 ms) ====== [2025-08-01T21:48:32.793Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-08-01T21:48:32.793Z] GC before operation: completed in 127.186 ms, heap usage 234.155 MB -> 70.697 MB. [2025-08-01T21:48:34.739Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1880.797 ms) ====== [2025-08-01T21:48:34.739Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-08-01T21:48:34.739Z] GC before operation: completed in 140.032 ms, heap usage 224.531 MB -> 81.963 MB. [2025-08-01T21:48:36.680Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1795.318 ms) ====== [2025-08-01T21:48:36.680Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-08-01T21:48:36.680Z] GC before operation: completed in 135.928 ms, heap usage 267.574 MB -> 70.851 MB. [2025-08-01T21:48:38.621Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1776.976 ms) ====== [2025-08-01T21:48:38.621Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-08-01T21:48:38.621Z] GC before operation: completed in 148.872 ms, heap usage 214.595 MB -> 71.107 MB. [2025-08-01T21:48:40.672Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1833.152 ms) ====== [2025-08-01T21:48:40.672Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-08-01T21:48:40.672Z] GC before operation: completed in 151.935 ms, heap usage 287.686 MB -> 71.225 MB. [2025-08-01T21:48:42.615Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1909.241 ms) ====== [2025-08-01T21:48:42.615Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-08-01T21:48:42.615Z] GC before operation: completed in 140.714 ms, heap usage 104.440 MB -> 81.738 MB. [2025-08-01T21:48:45.308Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1780.526 ms) ====== [2025-08-01T21:48:45.308Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-08-01T21:48:45.308Z] GC before operation: completed in 134.082 ms, heap usage 187.741 MB -> 70.965 MB. [2025-08-01T21:48:46.248Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1820.061 ms) ====== [2025-08-01T21:48:46.248Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-08-01T21:48:47.184Z] GC before operation: completed in 137.023 ms, heap usage 233.534 MB -> 71.384 MB. [2025-08-01T21:48:49.106Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1917.385 ms) ====== [2025-08-01T21:48:49.106Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-08-01T21:48:49.106Z] GC before operation: completed in 144.755 ms, heap usage 301.057 MB -> 71.641 MB. [2025-08-01T21:48:51.037Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1829.198 ms) ====== [2025-08-01T21:48:51.037Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-08-01T21:48:51.037Z] GC before operation: completed in 143.215 ms, heap usage 182.745 MB -> 71.607 MB. [2025-08-01T21:48:52.961Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1814.369 ms) ====== [2025-08-01T21:48:52.961Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-08-01T21:48:52.961Z] GC before operation: completed in 150.250 ms, heap usage 163.628 MB -> 82.972 MB. [2025-08-01T21:48:54.894Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1784.235 ms) ====== [2025-08-01T21:48:54.894Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-08-01T21:48:54.894Z] GC before operation: completed in 145.929 ms, heap usage 117.857 MB -> 71.628 MB. [2025-08-01T21:48:56.817Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1776.336 ms) ====== [2025-08-01T21:48:56.817Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-08-01T21:48:56.817Z] GC before operation: completed in 144.058 ms, heap usage 243.750 MB -> 82.982 MB. [2025-08-01T21:48:58.741Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1764.457 ms) ====== [2025-08-01T21:48:58.741Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-08-01T21:48:58.741Z] GC before operation: completed in 148.525 ms, heap usage 235.819 MB -> 83.310 MB. [2025-08-01T21:49:00.672Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1780.419 ms) ====== [2025-08-01T21:49:00.672Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-08-01T21:49:00.672Z] GC before operation: completed in 152.077 ms, heap usage 124.261 MB -> 71.919 MB. [2025-08-01T21:49:02.606Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1772.379 ms) ====== [2025-08-01T21:49:02.606Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-08-01T21:49:02.606Z] GC before operation: completed in 157.007 ms, heap usage 112.228 MB -> 71.887 MB. [2025-08-01T21:49:04.558Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1795.346 ms) ====== [2025-08-01T21:49:04.558Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-08-01T21:49:04.558Z] GC before operation: completed in 157.790 ms, heap usage 333.684 MB -> 83.408 MB. [2025-08-01T21:49:06.498Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1728.301 ms) ====== [2025-08-01T21:49:06.498Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-08-01T21:49:06.498Z] GC before operation: completed in 152.783 ms, heap usage 221.891 MB -> 88.714 MB. [2025-08-01T21:49:08.420Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1743.871 ms) ====== [2025-08-01T21:49:08.420Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-08-01T21:49:08.420Z] GC before operation: completed in 156.042 ms, heap usage 247.656 MB -> 72.661 MB. [2025-08-01T21:49:10.344Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1773.499 ms) ====== [2025-08-01T21:49:10.344Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-08-01T21:49:10.344Z] GC before operation: completed in 154.937 ms, heap usage 332.097 MB -> 72.838 MB. [2025-08-01T21:49:12.126Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1782.522 ms) ====== [2025-08-01T21:49:12.126Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-08-01T21:49:12.126Z] GC before operation: completed in 156.480 ms, heap usage 121.011 MB -> 100.061 MB. [2025-08-01T21:49:14.071Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1690.378 ms) ====== [2025-08-01T21:49:14.071Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-08-01T21:49:14.071Z] GC before operation: completed in 164.766 ms, heap usage 185.348 MB -> 89.030 MB. [2025-08-01T21:49:16.015Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1723.005 ms) ====== [2025-08-01T21:49:16.015Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-08-01T21:49:16.015Z] GC before operation: completed in 157.613 ms, heap usage 256.902 MB -> 73.327 MB. [2025-08-01T21:49:17.953Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1846.617 ms) ====== [2025-08-01T21:49:17.953Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-08-01T21:49:17.953Z] GC before operation: completed in 152.722 ms, heap usage 198.564 MB -> 72.779 MB. [2025-08-01T21:49:19.898Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1768.241 ms) ====== [2025-08-01T21:49:19.898Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-08-01T21:49:19.898Z] GC before operation: completed in 148.203 ms, heap usage 183.940 MB -> 84.475 MB. [2025-08-01T21:49:21.851Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1669.354 ms) ====== [2025-08-01T21:49:21.851Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-08-01T21:49:21.851Z] GC before operation: completed in 156.615 ms, heap usage 294.796 MB -> 73.297 MB. [2025-08-01T21:49:23.791Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1777.574 ms) ====== [2025-08-01T21:49:23.791Z] ----------------------------------- [2025-08-01T21:49:23.791Z] renaissance-dec-tree_0_PASSED [2025-08-01T21:49:23.791Z] ----------------------------------- [2025-08-01T21:49:23.791Z] [2025-08-01T21:49:23.791Z] TEST TEARDOWN: [2025-08-01T21:49:23.791Z] Nothing to be done for teardown. [2025-08-01T21:49:23.791Z] renaissance-dec-tree_0 Finish Time: Fri Aug 1 21:49:23 2025 Epoch Time (ms): 1754084963108