[2025-08-01T21:43:00.959Z] Running test renaissance-dec-tree_0 ... [2025-08-01T21:43:00.959Z] =============================================== [2025-08-01T21:43:00.959Z] renaissance-dec-tree_0 Start Time: Fri Aug 1 21:43:00 2025 Epoch Time (ms): 1754084580359 [2025-08-01T21:43:00.959Z] variation: NoOptions [2025-08-01T21:43:00.959Z] JVM_OPTIONS: [2025-08-01T21:43:00.959Z] { \ [2025-08-01T21:43:00.959Z] echo ""; echo "TEST SETUP:"; \ [2025-08-01T21:43:00.959Z] echo "Nothing to be done for setup."; \ [2025-08-01T21:43:00.959Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17540840498387/renaissance-dec-tree_0"; \ [2025-08-01T21:43:00.959Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17540840498387/renaissance-dec-tree_0"; \ [2025-08-01T21:43:00.959Z] echo ""; echo "TESTING:"; \ [2025-08-01T21:43:00.959Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/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_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17540840498387/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-08-01T21:43:00.959Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17540840498387/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-01T21:43:00.959Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-01T21:43:00.959Z] echo "Nothing to be done for teardown."; \ [2025-08-01T21:43:00.959Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17540840498387/TestTargetResult"; [2025-08-01T21:43:00.959Z] [2025-08-01T21:43:00.959Z] TEST SETUP: [2025-08-01T21:43:00.959Z] Nothing to be done for setup. [2025-08-01T21:43:00.959Z] [2025-08-01T21:43:00.959Z] TESTING: [2025-08-01T21:43:09.335Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2025-08-01T21:43:10.944Z] WARNING: An illegal reflective access operation has occurred [2025-08-01T21:43:10.944Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/output_17540840498387/renaissance-dec-tree_0/harness-214301-17098029469771065193/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-08-01T21:43:10.944Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-08-01T21:43:10.944Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-08-01T21:43:10.944Z] WARNING: All illegal access operations will be denied in a future release [2025-08-01T21:43:12.556Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-08-01T21:43:13.339Z] GC before operation: completed in 79.895 ms, heap usage 223.634 MB -> 35.228 MB. [2025-08-01T21:43:25.134Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11493.454 ms) ====== [2025-08-01T21:43:25.134Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-08-01T21:43:25.135Z] GC before operation: completed in 101.732 ms, heap usage 189.134 MB -> 70.926 MB. [2025-08-01T21:43:26.923Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2626.563 ms) ====== [2025-08-01T21:43:26.923Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-08-01T21:43:27.700Z] GC before operation: completed in 103.307 ms, heap usage 217.289 MB -> 71.572 MB. [2025-08-01T21:43:29.323Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2342.430 ms) ====== [2025-08-01T21:43:29.323Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-08-01T21:43:30.100Z] GC before operation: completed in 114.412 ms, heap usage 251.122 MB -> 88.388 MB. [2025-08-01T21:43:31.706Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2205.003 ms) ====== [2025-08-01T21:43:31.706Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-08-01T21:43:32.484Z] GC before operation: completed in 116.190 ms, heap usage 169.427 MB -> 82.643 MB. [2025-08-01T21:43:34.294Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2212.903 ms) ====== [2025-08-01T21:43:34.294Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-08-01T21:43:34.294Z] GC before operation: completed in 110.106 ms, heap usage 252.399 MB -> 72.289 MB. [2025-08-01T21:43:36.803Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2124.362 ms) ====== [2025-08-01T21:43:36.803Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-08-01T21:43:36.803Z] GC before operation: completed in 120.922 ms, heap usage 152.095 MB -> 99.640 MB. [2025-08-01T21:43:38.425Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2039.216 ms) ====== [2025-08-01T21:43:38.425Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-08-01T21:43:39.201Z] GC before operation: completed in 159.014 ms, heap usage 175.053 MB -> 72.384 MB. [2025-08-01T21:43:40.804Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2033.778 ms) ====== [2025-08-01T21:43:40.804Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-08-01T21:43:40.804Z] GC before operation: completed in 126.243 ms, heap usage 112.340 MB -> 72.503 MB. [2025-08-01T21:43:43.301Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2007.596 ms) ====== [2025-08-01T21:43:43.301Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-08-01T21:43:43.301Z] GC before operation: completed in 135.544 ms, heap usage 358.602 MB -> 72.786 MB. [2025-08-01T21:43:44.914Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1981.157 ms) ====== [2025-08-01T21:43:44.914Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-08-01T21:43:45.695Z] GC before operation: completed in 143.291 ms, heap usage 283.829 MB -> 73.053 MB. [2025-08-01T21:43:47.308Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1985.371 ms) ====== [2025-08-01T21:43:47.308Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-08-01T21:43:47.308Z] GC before operation: completed in 133.580 ms, heap usage 112.145 MB -> 72.857 MB. [2025-08-01T21:43:49.813Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1980.024 ms) ====== [2025-08-01T21:43:49.813Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-08-01T21:43:49.813Z] GC before operation: completed in 137.850 ms, heap usage 224.184 MB -> 73.292 MB. [2025-08-01T21:43:51.422Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1907.935 ms) ====== [2025-08-01T21:43:51.422Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-08-01T21:43:51.422Z] GC before operation: completed in 128.376 ms, heap usage 304.585 MB -> 73.612 MB. [2025-08-01T21:43:53.919Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1936.082 ms) ====== [2025-08-01T21:43:53.919Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-08-01T21:43:53.919Z] GC before operation: completed in 143.130 ms, heap usage 161.858 MB -> 73.181 MB. [2025-08-01T21:43:55.546Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1920.490 ms) ====== [2025-08-01T21:43:55.546Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-08-01T21:43:55.546Z] GC before operation: completed in 166.548 ms, heap usage 236.872 MB -> 73.625 MB. [2025-08-01T21:43:58.048Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1925.573 ms) ====== [2025-08-01T21:43:58.048Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-08-01T21:43:58.048Z] GC before operation: completed in 162.633 ms, heap usage 236.753 MB -> 73.803 MB. [2025-08-01T21:43:59.652Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1918.042 ms) ====== [2025-08-01T21:43:59.652Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-08-01T21:43:59.652Z] GC before operation: completed in 149.165 ms, heap usage 180.416 MB -> 73.464 MB. [2025-08-01T21:44:02.179Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1892.970 ms) ====== [2025-08-01T21:44:02.179Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-08-01T21:44:02.179Z] GC before operation: completed in 178.254 ms, heap usage 243.212 MB -> 74.012 MB. [2025-08-01T21:44:03.988Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1914.236 ms) ====== [2025-08-01T21:44:03.988Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-08-01T21:44:03.988Z] GC before operation: completed in 167.145 ms, heap usage 274.024 MB -> 74.119 MB. [2025-08-01T21:44:05.610Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1905.395 ms) ====== [2025-08-01T21:44:05.610Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-08-01T21:44:06.387Z] GC before operation: completed in 175.958 ms, heap usage 263.257 MB -> 74.482 MB. [2025-08-01T21:44:08.003Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1848.004 ms) ====== [2025-08-01T21:44:08.003Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-08-01T21:44:08.003Z] GC before operation: completed in 156.354 ms, heap usage 218.030 MB -> 74.338 MB. [2025-08-01T21:44:10.504Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1883.697 ms) ====== [2025-08-01T21:44:10.504Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-08-01T21:44:10.504Z] GC before operation: completed in 146.300 ms, heap usage 155.184 MB -> 74.124 MB. [2025-08-01T21:44:12.292Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1881.488 ms) ====== [2025-08-01T21:44:12.292Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-08-01T21:44:12.292Z] GC before operation: completed in 181.961 ms, heap usage 220.085 MB -> 85.445 MB. [2025-08-01T21:44:13.899Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1871.007 ms) ====== [2025-08-01T21:44:13.899Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-08-01T21:44:13.899Z] GC before operation: completed in 153.790 ms, heap usage 295.343 MB -> 85.800 MB. [2025-08-01T21:44:16.393Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1921.354 ms) ====== [2025-08-01T21:44:16.394Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-08-01T21:44:16.394Z] GC before operation: completed in 159.806 ms, heap usage 177.400 MB -> 74.290 MB. [2025-08-01T21:44:18.006Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1837.945 ms) ====== [2025-08-01T21:44:18.007Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-08-01T21:44:18.007Z] GC before operation: completed in 177.659 ms, heap usage 149.963 MB -> 74.362 MB. [2025-08-01T21:44:20.513Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1875.470 ms) ====== [2025-08-01T21:44:20.513Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-08-01T21:44:20.513Z] GC before operation: completed in 154.149 ms, heap usage 219.484 MB -> 74.943 MB. [2025-08-01T21:44:22.119Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1875.563 ms) ====== [2025-08-01T21:44:22.120Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-08-01T21:44:22.120Z] GC before operation: completed in 185.571 ms, heap usage 153.301 MB -> 74.565 MB. [2025-08-01T21:44:24.625Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1855.688 ms) ====== [2025-08-01T21:44:24.625Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-08-01T21:44:24.625Z] GC before operation: completed in 189.155 ms, heap usage 239.783 MB -> 75.185 MB. [2025-08-01T21:44:26.241Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1850.176 ms) ====== [2025-08-01T21:44:26.241Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-08-01T21:44:26.241Z] GC before operation: completed in 155.857 ms, heap usage 116.185 MB -> 74.622 MB. [2025-08-01T21:44:28.747Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1831.711 ms) ====== [2025-08-01T21:44:28.747Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-08-01T21:44:28.747Z] GC before operation: completed in 171.812 ms, heap usage 240.825 MB -> 75.214 MB. [2025-08-01T21:44:30.351Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1885.433 ms) ====== [2025-08-01T21:44:30.351Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-08-01T21:44:30.351Z] GC before operation: completed in 184.940 ms, heap usage 183.305 MB -> 102.626 MB. [2025-08-01T21:44:32.850Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1759.067 ms) ====== [2025-08-01T21:44:32.850Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-08-01T21:44:32.850Z] GC before operation: completed in 171.851 ms, heap usage 371.346 MB -> 81.228 MB. [2025-08-01T21:44:34.663Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1853.601 ms) ====== [2025-08-01T21:44:34.664Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-08-01T21:44:34.664Z] GC before operation: completed in 193.101 ms, heap usage 304.790 MB -> 86.593 MB. [2025-08-01T21:44:36.278Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1836.293 ms) ====== [2025-08-01T21:44:36.278Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-08-01T21:44:36.278Z] GC before operation: completed in 188.277 ms, heap usage 314.695 MB -> 75.852 MB. [2025-08-01T21:44:38.776Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1891.912 ms) ====== [2025-08-01T21:44:38.776Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-08-01T21:44:38.776Z] GC before operation: completed in 172.156 ms, heap usage 285.804 MB -> 76.170 MB. [2025-08-01T21:44:40.516Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1863.023 ms) ====== [2025-08-01T21:44:40.516Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-08-01T21:44:40.516Z] GC before operation: completed in 196.920 ms, heap usage 365.155 MB -> 86.915 MB. [2025-08-01T21:44:42.155Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1773.377 ms) ====== [2025-08-01T21:44:42.155Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-08-01T21:44:42.932Z] GC before operation: completed in 170.505 ms, heap usage 179.496 MB -> 75.787 MB. [2025-08-01T21:44:44.544Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1846.759 ms) ====== [2025-08-01T21:44:44.544Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-08-01T21:44:44.544Z] GC before operation: completed in 198.585 ms, heap usage 323.237 MB -> 87.371 MB. [2025-08-01T21:44:46.157Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1804.095 ms) ====== [2025-08-01T21:44:46.935Z] ----------------------------------- [2025-08-01T21:44:46.935Z] renaissance-dec-tree_0_PASSED [2025-08-01T21:44:46.935Z] ----------------------------------- [2025-08-01T21:44:46.935Z] [2025-08-01T21:44:46.935Z] TEST TEARDOWN: [2025-08-01T21:44:46.935Z] Nothing to be done for teardown. [2025-08-01T21:44:46.935Z] renaissance-dec-tree_0 Finish Time: Fri Aug 1 21:44:46 2025 Epoch Time (ms): 1754084686445