[2025-05-16T23:28:54.799Z] Running test renaissance-dec-tree_0 ... [2025-05-16T23:28:54.800Z] =============================================== [2025-05-16T23:28:54.800Z] renaissance-dec-tree_0 Start Time: Fri May 16 23:28:53 2025 Epoch Time (ms): 1747438133836 [2025-05-16T23:28:54.800Z] variation: NoOptions [2025-05-16T23:28:54.800Z] JVM_OPTIONS: [2025-05-16T23:28:54.800Z] { \ [2025-05-16T23:28:54.800Z] echo ""; echo "TEST SETUP:"; \ [2025-05-16T23:28:54.800Z] echo "Nothing to be done for setup."; \ [2025-05-16T23:28:54.800Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17474376101704/renaissance-dec-tree_0"; \ [2025-05-16T23:28:54.800Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17474376101704/renaissance-dec-tree_0"; \ [2025-05-16T23:28:54.800Z] echo ""; echo "TESTING:"; \ [2025-05-16T23:28:54.800Z] "/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_17474376101704/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-05-16T23:28:54.800Z] 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_17474376101704/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-16T23:28:54.800Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-16T23:28:54.800Z] echo "Nothing to be done for teardown."; \ [2025-05-16T23:28:54.800Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17474376101704/TestTargetResult"; [2025-05-16T23:28:54.800Z] [2025-05-16T23:28:54.800Z] TEST SETUP: [2025-05-16T23:28:54.800Z] Nothing to be done for setup. [2025-05-16T23:28:54.800Z] [2025-05-16T23:28:54.800Z] TESTING: [2025-05-16T23:29:00.162Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-05-16T23:29:02.112Z] WARNING: An illegal reflective access operation has occurred [2025-05-16T23:29:02.112Z] 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_17474376101704/renaissance-dec-tree_0/harness-232854-2086135151937901473/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-05-16T23:29:02.112Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-05-16T23:29:02.112Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-05-16T23:29:02.112Z] WARNING: All illegal access operations will be denied in a future release [2025-05-16T23:29:04.096Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-05-16T23:29:04.096Z] GC before operation: completed in 60.908 ms, heap usage 70.017 MB -> 34.439 MB. [2025-05-16T23:29:13.880Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10367.395 ms) ====== [2025-05-16T23:29:13.880Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-05-16T23:29:13.880Z] GC before operation: completed in 127.955 ms, heap usage 129.817 MB -> 67.673 MB. [2025-05-16T23:29:16.901Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2753.967 ms) ====== [2025-05-16T23:29:16.901Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-05-16T23:29:16.901Z] GC before operation: completed in 106.219 ms, heap usage 176.854 MB -> 68.324 MB. [2025-05-16T23:29:18.852Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2231.415 ms) ====== [2025-05-16T23:29:18.852Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-05-16T23:29:19.805Z] GC before operation: completed in 112.582 ms, heap usage 286.974 MB -> 79.782 MB. [2025-05-16T23:29:21.755Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2188.475 ms) ====== [2025-05-16T23:29:21.755Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-05-16T23:29:21.755Z] GC before operation: completed in 118.020 ms, heap usage 252.898 MB -> 69.111 MB. [2025-05-16T23:29:23.724Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2062.860 ms) ====== [2025-05-16T23:29:23.724Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-05-16T23:29:23.724Z] GC before operation: completed in 115.435 ms, heap usage 222.030 MB -> 69.484 MB. [2025-05-16T23:29:25.672Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2091.693 ms) ====== [2025-05-16T23:29:25.672Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-05-16T23:29:25.672Z] GC before operation: completed in 113.050 ms, heap usage 273.193 MB -> 80.833 MB. [2025-05-16T23:29:27.639Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1980.963 ms) ====== [2025-05-16T23:29:27.639Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-05-16T23:29:28.592Z] GC before operation: completed in 126.983 ms, heap usage 257.304 MB -> 69.884 MB. [2025-05-16T23:29:30.545Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1959.952 ms) ====== [2025-05-16T23:29:30.545Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-05-16T23:29:30.545Z] GC before operation: completed in 124.912 ms, heap usage 210.797 MB -> 70.265 MB. [2025-05-16T23:29:32.501Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1904.418 ms) ====== [2025-05-16T23:29:32.501Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-05-16T23:29:32.501Z] GC before operation: completed in 125.417 ms, heap usage 261.666 MB -> 75.418 MB. [2025-05-16T23:29:34.450Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1959.104 ms) ====== [2025-05-16T23:29:34.450Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-05-16T23:29:34.450Z] GC before operation: completed in 130.256 ms, heap usage 162.168 MB -> 70.098 MB. [2025-05-16T23:29:36.404Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1954.660 ms) ====== [2025-05-16T23:29:36.404Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-05-16T23:29:36.404Z] GC before operation: completed in 134.560 ms, heap usage 113.848 MB -> 70.049 MB. [2025-05-16T23:29:39.582Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1882.468 ms) ====== [2025-05-16T23:29:39.582Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-05-16T23:29:39.582Z] GC before operation: completed in 138.168 ms, heap usage 276.805 MB -> 86.862 MB. [2025-05-16T23:29:40.533Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1827.922 ms) ====== [2025-05-16T23:29:40.533Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-05-16T23:29:40.533Z] GC before operation: completed in 133.829 ms, heap usage 216.973 MB -> 70.459 MB. [2025-05-16T23:29:42.484Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1892.238 ms) ====== [2025-05-16T23:29:42.484Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-05-16T23:29:42.484Z] GC before operation: completed in 136.669 ms, heap usage 175.890 MB -> 81.563 MB. [2025-05-16T23:29:44.437Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1834.185 ms) ====== [2025-05-16T23:29:44.437Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-05-16T23:29:44.437Z] GC before operation: completed in 131.741 ms, heap usage 117.735 MB -> 70.370 MB. [2025-05-16T23:29:46.387Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1988.086 ms) ====== [2025-05-16T23:29:46.387Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-05-16T23:29:46.387Z] GC before operation: completed in 128.077 ms, heap usage 186.523 MB -> 70.999 MB. [2025-05-16T23:29:48.344Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1860.894 ms) ====== [2025-05-16T23:29:48.344Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-05-16T23:29:48.344Z] GC before operation: completed in 129.605 ms, heap usage 143.863 MB -> 70.636 MB. [2025-05-16T23:29:50.307Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1920.940 ms) ====== [2025-05-16T23:29:50.307Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-05-16T23:29:50.307Z] GC before operation: completed in 140.865 ms, heap usage 253.600 MB -> 71.237 MB. [2025-05-16T23:29:52.258Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1949.428 ms) ====== [2025-05-16T23:29:52.258Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-05-16T23:29:52.258Z] GC before operation: completed in 133.063 ms, heap usage 260.380 MB -> 82.275 MB. [2025-05-16T23:29:54.210Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1971.180 ms) ====== [2025-05-16T23:29:54.210Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-05-16T23:29:55.262Z] GC before operation: completed in 152.852 ms, heap usage 238.735 MB -> 71.302 MB. [2025-05-16T23:29:57.231Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1881.665 ms) ====== [2025-05-16T23:29:57.231Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-05-16T23:29:57.231Z] GC before operation: completed in 134.995 ms, heap usage 328.733 MB -> 82.471 MB. [2025-05-16T23:29:59.185Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1851.435 ms) ====== [2025-05-16T23:29:59.185Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-05-16T23:29:59.185Z] GC before operation: completed in 134.236 ms, heap usage 225.205 MB -> 71.650 MB. [2025-05-16T23:30:01.137Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1789.060 ms) ====== [2025-05-16T23:30:01.137Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-05-16T23:30:01.137Z] GC before operation: completed in 140.570 ms, heap usage 176.224 MB -> 82.604 MB. [2025-05-16T23:30:02.087Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1749.898 ms) ====== [2025-05-16T23:30:02.087Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-05-16T23:30:03.040Z] GC before operation: completed in 144.566 ms, heap usage 291.764 MB -> 71.863 MB. [2025-05-16T23:30:04.992Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1856.189 ms) ====== [2025-05-16T23:30:04.992Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-05-16T23:30:04.992Z] GC before operation: completed in 150.854 ms, heap usage 163.190 MB -> 88.205 MB. [2025-05-16T23:30:06.944Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1773.576 ms) ====== [2025-05-16T23:30:06.944Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-05-16T23:30:06.944Z] GC before operation: completed in 148.499 ms, heap usage 249.674 MB -> 83.210 MB. [2025-05-16T23:30:07.895Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1766.345 ms) ====== [2025-05-16T23:30:07.895Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-05-16T23:30:08.847Z] GC before operation: completed in 146.795 ms, heap usage 347.599 MB -> 71.995 MB. [2025-05-16T23:30:10.801Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1838.656 ms) ====== [2025-05-16T23:30:10.801Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-05-16T23:30:10.801Z] GC before operation: completed in 143.416 ms, heap usage 177.909 MB -> 72.107 MB. [2025-05-16T23:30:12.755Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1789.522 ms) ====== [2025-05-16T23:30:12.755Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-05-16T23:30:12.755Z] GC before operation: completed in 157.323 ms, heap usage 112.212 MB -> 82.937 MB. [2025-05-16T23:30:13.897Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1741.245 ms) ====== [2025-05-16T23:30:13.897Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-05-16T23:30:13.897Z] GC before operation: completed in 149.238 ms, heap usage 232.803 MB -> 72.468 MB. [2025-05-16T23:30:15.854Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1868.373 ms) ====== [2025-05-16T23:30:15.854Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-05-16T23:30:16.805Z] GC before operation: completed in 150.841 ms, heap usage 273.974 MB -> 88.722 MB. [2025-05-16T23:30:17.755Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1786.767 ms) ====== [2025-05-16T23:30:17.755Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-05-16T23:30:18.706Z] GC before operation: completed in 153.803 ms, heap usage 242.194 MB -> 72.524 MB. [2025-05-16T23:30:19.657Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1783.044 ms) ====== [2025-05-16T23:30:19.657Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-05-16T23:30:20.607Z] GC before operation: completed in 151.045 ms, heap usage 321.529 MB -> 89.336 MB. [2025-05-16T23:30:21.557Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1752.671 ms) ====== [2025-05-16T23:30:21.557Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-05-16T23:30:22.510Z] GC before operation: completed in 154.226 ms, heap usage 336.656 MB -> 72.882 MB. [2025-05-16T23:30:24.463Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1882.358 ms) ====== [2025-05-16T23:30:24.463Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-05-16T23:30:24.463Z] GC before operation: completed in 153.886 ms, heap usage 254.185 MB -> 72.991 MB. [2025-05-16T23:30:26.414Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1914.690 ms) ====== [2025-05-16T23:30:26.414Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-05-16T23:30:26.414Z] GC before operation: completed in 148.617 ms, heap usage 289.870 MB -> 84.198 MB. [2025-05-16T23:30:28.368Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1747.853 ms) ====== [2025-05-16T23:30:28.368Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-05-16T23:30:28.368Z] GC before operation: completed in 156.464 ms, heap usage 337.782 MB -> 100.608 MB. [2025-05-16T23:30:30.706Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1742.860 ms) ====== [2025-05-16T23:30:30.706Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-05-16T23:30:30.706Z] GC before operation: completed in 157.804 ms, heap usage 436.879 MB -> 73.296 MB. [2025-05-16T23:30:31.657Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1820.065 ms) ====== [2025-05-16T23:30:31.657Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-05-16T23:30:31.657Z] GC before operation: completed in 151.189 ms, heap usage 281.030 MB -> 84.371 MB. [2025-05-16T23:30:33.609Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1720.331 ms) ====== [2025-05-16T23:30:33.609Z] ----------------------------------- [2025-05-16T23:30:33.609Z] renaissance-dec-tree_0_PASSED [2025-05-16T23:30:33.609Z] ----------------------------------- [2025-05-16T23:30:33.609Z] [2025-05-16T23:30:33.609Z] TEST TEARDOWN: [2025-05-16T23:30:33.609Z] Nothing to be done for teardown. [2025-05-16T23:30:33.609Z] renaissance-dec-tree_0 Finish Time: Fri May 16 23:30:33 2025 Epoch Time (ms): 1747438233505