[2025-05-29T02:25:55.984Z] Running test renaissance-dec-tree_0 ... [2025-05-29T02:25:55.984Z] =============================================== [2025-05-29T02:25:55.984Z] renaissance-dec-tree_0 Start Time: Thu May 29 02:25:55 2025 Epoch Time (ms): 1748485555384 [2025-05-29T02:25:55.984Z] variation: NoOptions [2025-05-29T02:25:55.984Z] JVM_OPTIONS: [2025-05-29T02:25:55.984Z] { \ [2025-05-29T02:25:55.984Z] echo ""; echo "TEST SETUP:"; \ [2025-05-29T02:25:55.984Z] echo "Nothing to be done for setup."; \ [2025-05-29T02:25:55.984Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17484850835836/renaissance-dec-tree_0"; \ [2025-05-29T02:25:55.984Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17484850835836/renaissance-dec-tree_0"; \ [2025-05-29T02:25:55.984Z] echo ""; echo "TESTING:"; \ [2025-05-29T02:25:55.985Z] "/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_17484850835836/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-05-29T02:25:55.985Z] 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_17484850835836/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-29T02:25:55.985Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-29T02:25:55.985Z] echo "Nothing to be done for teardown."; \ [2025-05-29T02:25:55.985Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17484850835836/TestTargetResult"; [2025-05-29T02:25:55.985Z] [2025-05-29T02:25:55.985Z] TEST SETUP: [2025-05-29T02:25:55.985Z] Nothing to be done for setup. [2025-05-29T02:25:55.985Z] [2025-05-29T02:25:55.985Z] TESTING: [2025-05-29T02:26:04.214Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2025-05-29T02:26:05.810Z] WARNING: An illegal reflective access operation has occurred [2025-05-29T02:26:05.810Z] 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_17484850835836/renaissance-dec-tree_0/harness-022556-17860079210695367844/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-05-29T02:26:05.810Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-05-29T02:26:05.810Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-05-29T02:26:05.810Z] WARNING: All illegal access operations will be denied in a future release [2025-05-29T02:26:08.265Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-05-29T02:26:08.265Z] GC before operation: completed in 73.860 ms, heap usage 86.388 MB -> 35.126 MB. [2025-05-29T02:26:19.945Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11647.108 ms) ====== [2025-05-29T02:26:19.945Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-05-29T02:26:19.945Z] GC before operation: completed in 97.139 ms, heap usage 158.869 MB -> 70.786 MB. [2025-05-29T02:26:22.426Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2637.033 ms) ====== [2025-05-29T02:26:22.426Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-05-29T02:26:22.426Z] GC before operation: completed in 104.567 ms, heap usage 191.411 MB -> 71.591 MB. [2025-05-29T02:26:24.884Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2372.334 ms) ====== [2025-05-29T02:26:24.884Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-05-29T02:26:24.884Z] GC before operation: completed in 105.186 ms, heap usage 256.303 MB -> 71.837 MB. [2025-05-29T02:26:27.333Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2229.979 ms) ====== [2025-05-29T02:26:27.333Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-05-29T02:26:27.333Z] GC before operation: completed in 105.032 ms, heap usage 218.557 MB -> 99.528 MB. [2025-05-29T02:26:29.794Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2164.207 ms) ====== [2025-05-29T02:26:29.794Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-05-29T02:26:29.794Z] GC before operation: completed in 110.811 ms, heap usage 306.030 MB -> 72.292 MB. [2025-05-29T02:26:32.251Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2147.260 ms) ====== [2025-05-29T02:26:32.251Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-05-29T02:26:32.251Z] GC before operation: completed in 117.765 ms, heap usage 337.066 MB -> 99.961 MB. [2025-05-29T02:26:33.844Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1999.651 ms) ====== [2025-05-29T02:26:33.844Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-05-29T02:26:33.844Z] GC before operation: completed in 126.956 ms, heap usage 180.587 MB -> 72.636 MB. [2025-05-29T02:26:36.310Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2027.923 ms) ====== [2025-05-29T02:26:36.310Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-05-29T02:26:36.310Z] GC before operation: completed in 127.972 ms, heap usage 321.950 MB -> 72.818 MB. [2025-05-29T02:26:37.886Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1991.210 ms) ====== [2025-05-29T02:26:37.886Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-05-29T02:26:38.649Z] GC before operation: completed in 154.025 ms, heap usage 342.666 MB -> 72.934 MB. [2025-05-29T02:26:40.234Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2010.528 ms) ====== [2025-05-29T02:26:40.234Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-05-29T02:26:40.234Z] GC before operation: completed in 146.229 ms, heap usage 254.802 MB -> 72.903 MB. [2025-05-29T02:26:42.683Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2005.495 ms) ====== [2025-05-29T02:26:42.683Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-05-29T02:26:42.683Z] GC before operation: completed in 137.364 ms, heap usage 297.723 MB -> 73.186 MB. [2025-05-29T02:26:45.143Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1987.682 ms) ====== [2025-05-29T02:26:45.143Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-05-29T02:26:45.143Z] GC before operation: completed in 127.465 ms, heap usage 109.701 MB -> 73.125 MB. [2025-05-29T02:26:46.722Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1992.963 ms) ====== [2025-05-29T02:26:46.722Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-05-29T02:26:46.722Z] GC before operation: completed in 152.299 ms, heap usage 356.704 MB -> 73.398 MB. [2025-05-29T02:26:49.182Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1947.381 ms) ====== [2025-05-29T02:26:49.182Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-05-29T02:26:49.182Z] GC before operation: completed in 139.199 ms, heap usage 315.495 MB -> 73.512 MB. [2025-05-29T02:26:50.772Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1951.449 ms) ====== [2025-05-29T02:26:50.772Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-05-29T02:26:50.772Z] GC before operation: completed in 165.122 ms, heap usage 161.899 MB -> 73.161 MB. [2025-05-29T02:26:53.227Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1971.451 ms) ====== [2025-05-29T02:26:53.227Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-05-29T02:26:53.227Z] GC before operation: completed in 178.884 ms, heap usage 258.324 MB -> 73.810 MB. [2025-05-29T02:26:55.690Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1925.760 ms) ====== [2025-05-29T02:26:55.690Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-05-29T02:26:55.690Z] GC before operation: completed in 152.330 ms, heap usage 253.575 MB -> 73.753 MB. [2025-05-29T02:26:57.274Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1896.196 ms) ====== [2025-05-29T02:26:57.274Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-05-29T02:26:57.274Z] GC before operation: completed in 166.508 ms, heap usage 331.425 MB -> 84.768 MB. [2025-05-29T02:26:59.732Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2014.817 ms) ====== [2025-05-29T02:26:59.732Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-05-29T02:26:59.732Z] GC before operation: completed in 151.647 ms, heap usage 303.707 MB -> 74.326 MB. [2025-05-29T02:27:01.308Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1955.544 ms) ====== [2025-05-29T02:27:01.308Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-05-29T02:27:02.070Z] GC before operation: completed in 157.505 ms, heap usage 307.341 MB -> 74.087 MB. [2025-05-29T02:27:03.651Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1896.598 ms) ====== [2025-05-29T02:27:03.651Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-05-29T02:27:03.651Z] GC before operation: completed in 156.637 ms, heap usage 283.664 MB -> 74.374 MB. [2025-05-29T02:27:06.101Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1936.180 ms) ====== [2025-05-29T02:27:06.101Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-05-29T02:27:06.101Z] GC before operation: completed in 185.485 ms, heap usage 253.838 MB -> 79.847 MB. [2025-05-29T02:27:09.275Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1872.932 ms) ====== [2025-05-29T02:27:09.275Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-05-29T02:27:09.275Z] GC before operation: completed in 154.757 ms, heap usage 327.882 MB -> 74.543 MB. [2025-05-29T02:27:10.051Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1884.577 ms) ====== [2025-05-29T02:27:10.051Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-05-29T02:27:10.051Z] GC before operation: completed in 150.326 ms, heap usage 154.958 MB -> 74.329 MB. [2025-05-29T02:27:11.635Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1860.944 ms) ====== [2025-05-29T02:27:11.635Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-05-29T02:27:11.635Z] GC before operation: completed in 143.397 ms, heap usage 261.453 MB -> 80.035 MB. [2025-05-29T02:27:14.095Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1919.775 ms) ====== [2025-05-29T02:27:14.095Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-05-29T02:27:14.095Z] GC before operation: completed in 145.708 ms, heap usage 238.037 MB -> 74.841 MB. [2025-05-29T02:27:15.672Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1896.345 ms) ====== [2025-05-29T02:27:15.672Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-05-29T02:27:16.436Z] GC before operation: completed in 155.895 ms, heap usage 243.267 MB -> 74.933 MB. [2025-05-29T02:27:18.013Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1881.399 ms) ====== [2025-05-29T02:27:18.013Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-05-29T02:27:18.013Z] GC before operation: completed in 156.325 ms, heap usage 252.922 MB -> 85.788 MB. [2025-05-29T02:27:20.462Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1959.460 ms) ====== [2025-05-29T02:27:20.462Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-05-29T02:27:20.462Z] GC before operation: completed in 176.656 ms, heap usage 202.682 MB -> 85.994 MB. [2025-05-29T02:27:22.052Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1910.229 ms) ====== [2025-05-29T02:27:22.052Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-05-29T02:27:22.052Z] GC before operation: completed in 168.587 ms, heap usage 277.628 MB -> 86.150 MB. [2025-05-29T02:27:24.508Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1784.649 ms) ====== [2025-05-29T02:27:24.508Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-05-29T02:27:24.508Z] GC before operation: completed in 159.391 ms, heap usage 164.714 MB -> 75.037 MB. [2025-05-29T02:27:26.085Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1849.979 ms) ====== [2025-05-29T02:27:26.085Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-05-29T02:27:26.085Z] GC before operation: completed in 159.217 ms, heap usage 338.993 MB -> 75.316 MB. [2025-05-29T02:27:28.537Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1833.638 ms) ====== [2025-05-29T02:27:28.537Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-05-29T02:27:28.537Z] GC before operation: completed in 186.040 ms, heap usage 163.303 MB -> 75.239 MB. [2025-05-29T02:27:30.119Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1848.921 ms) ====== [2025-05-29T02:27:30.119Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-05-29T02:27:30.119Z] GC before operation: completed in 175.678 ms, heap usage 286.743 MB -> 86.598 MB. [2025-05-29T02:27:32.576Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1852.072 ms) ====== [2025-05-29T02:27:32.576Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-05-29T02:27:32.576Z] GC before operation: completed in 161.787 ms, heap usage 179.438 MB -> 75.490 MB. [2025-05-29T02:27:34.152Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1883.815 ms) ====== [2025-05-29T02:27:34.152Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-05-29T02:27:34.152Z] GC before operation: completed in 164.429 ms, heap usage 128.101 MB -> 75.153 MB. [2025-05-29T02:27:36.613Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1857.521 ms) ====== [2025-05-29T02:27:36.613Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-05-29T02:27:36.613Z] GC before operation: completed in 163.039 ms, heap usage 303.218 MB -> 86.905 MB. [2025-05-29T02:27:38.189Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1818.497 ms) ====== [2025-05-29T02:27:38.189Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-05-29T02:27:38.189Z] GC before operation: completed in 166.759 ms, heap usage 248.068 MB -> 76.126 MB. [2025-05-29T02:27:40.648Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1823.427 ms) ====== [2025-05-29T02:27:40.648Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-05-29T02:27:40.648Z] GC before operation: completed in 163.965 ms, heap usage 184.703 MB -> 75.787 MB. [2025-05-29T02:27:42.233Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1815.170 ms) ====== [2025-05-29T02:27:42.233Z] ----------------------------------- [2025-05-29T02:27:42.233Z] renaissance-dec-tree_0_PASSED [2025-05-29T02:27:42.233Z] ----------------------------------- [2025-05-29T02:27:42.233Z] [2025-05-29T02:27:42.233Z] TEST TEARDOWN: [2025-05-29T02:27:42.233Z] Nothing to be done for teardown. [2025-05-29T02:27:42.233Z] renaissance-dec-tree_0 Finish Time: Thu May 29 02:27:42 2025 Epoch Time (ms): 1748485662129