[2025-08-13T23:28:50.052Z] Running test renaissance-dec-tree_0 ... [2025-08-13T23:28:50.052Z] =============================================== [2025-08-13T23:28:50.052Z] renaissance-dec-tree_0 Start Time: Wed Aug 13 23:28:49 2025 Epoch Time (ms): 1755127729580 [2025-08-13T23:28:50.052Z] variation: NoOptions [2025-08-13T23:28:50.052Z] JVM_OPTIONS: [2025-08-13T23:28:50.052Z] { \ [2025-08-13T23:28:50.052Z] echo ""; echo "TEST SETUP:"; \ [2025-08-13T23:28:50.052Z] echo "Nothing to be done for setup."; \ [2025-08-13T23:28:50.052Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17551271249815/renaissance-dec-tree_0"; \ [2025-08-13T23:28:50.052Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17551271249815/renaissance-dec-tree_0"; \ [2025-08-13T23:28:50.052Z] echo ""; echo "TESTING:"; \ [2025-08-13T23:28:50.052Z] "/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_17551271249815/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-08-13T23:28:50.052Z] 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_17551271249815/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-13T23:28:50.052Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-13T23:28:50.052Z] echo "Nothing to be done for teardown."; \ [2025-08-13T23:28:50.052Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17551271249815/TestTargetResult"; [2025-08-13T23:28:50.052Z] [2025-08-13T23:28:50.052Z] TEST SETUP: [2025-08-13T23:28:50.052Z] Nothing to be done for setup. [2025-08-13T23:28:50.052Z] [2025-08-13T23:28:50.052Z] TESTING: [2025-08-13T23:28:56.718Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-08-13T23:28:57.663Z] WARNING: An illegal reflective access operation has occurred [2025-08-13T23:28:57.663Z] 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_17551271249815/renaissance-dec-tree_0/harness-232850-5252198171589902859/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-08-13T23:28:57.663Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-08-13T23:28:57.663Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-08-13T23:28:57.663Z] WARNING: All illegal access operations will be denied in a future release [2025-08-13T23:28:59.678Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-08-13T23:28:59.678Z] GC before operation: completed in 62.139 ms, heap usage 96.459 MB -> 34.391 MB. [2025-08-13T23:29:09.372Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10319.202 ms) ====== [2025-08-13T23:29:09.372Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-08-13T23:29:09.372Z] GC before operation: completed in 145.937 ms, heap usage 115.743 MB -> 67.929 MB. [2025-08-13T23:29:12.372Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2644.570 ms) ====== [2025-08-13T23:29:12.372Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-08-13T23:29:12.372Z] GC before operation: completed in 138.405 ms, heap usage 127.530 MB -> 68.433 MB. [2025-08-13T23:29:15.375Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2284.860 ms) ====== [2025-08-13T23:29:15.375Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-08-13T23:29:15.375Z] GC before operation: completed in 116.179 ms, heap usage 284.150 MB -> 68.859 MB. [2025-08-13T23:29:17.322Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2129.341 ms) ====== [2025-08-13T23:29:17.322Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-08-13T23:29:17.322Z] GC before operation: completed in 117.511 ms, heap usage 218.648 MB -> 69.096 MB. [2025-08-13T23:29:19.269Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2136.467 ms) ====== [2025-08-13T23:29:19.269Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-08-13T23:29:19.269Z] GC before operation: completed in 118.750 ms, heap usage 178.814 MB -> 69.457 MB. [2025-08-13T23:29:21.962Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2052.576 ms) ====== [2025-08-13T23:29:21.962Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-08-13T23:29:21.962Z] GC before operation: completed in 118.217 ms, heap usage 120.071 MB -> 69.616 MB. [2025-08-13T23:29:23.907Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2031.756 ms) ====== [2025-08-13T23:29:23.907Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-08-13T23:29:23.907Z] GC before operation: completed in 123.559 ms, heap usage 213.734 MB -> 81.039 MB. [2025-08-13T23:29:25.849Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1944.564 ms) ====== [2025-08-13T23:29:25.849Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-08-13T23:29:25.849Z] GC before operation: completed in 130.514 ms, heap usage 193.659 MB -> 80.617 MB. [2025-08-13T23:29:27.794Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1951.882 ms) ====== [2025-08-13T23:29:27.794Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-08-13T23:29:27.794Z] GC before operation: completed in 128.633 ms, heap usage 114.244 MB -> 69.788 MB. [2025-08-13T23:29:29.737Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1961.278 ms) ====== [2025-08-13T23:29:29.737Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-08-13T23:29:29.737Z] GC before operation: completed in 149.439 ms, heap usage 225.195 MB -> 70.081 MB. [2025-08-13T23:29:31.680Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2010.248 ms) ====== [2025-08-13T23:29:31.680Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-08-13T23:29:32.631Z] GC before operation: completed in 135.992 ms, heap usage 162.269 MB -> 70.020 MB. [2025-08-13T23:29:34.578Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1886.111 ms) ====== [2025-08-13T23:29:34.578Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-08-13T23:29:34.578Z] GC before operation: completed in 136.568 ms, heap usage 181.140 MB -> 81.301 MB. [2025-08-13T23:29:36.522Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1957.962 ms) ====== [2025-08-13T23:29:36.522Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-08-13T23:29:36.522Z] GC before operation: completed in 143.036 ms, heap usage 178.902 MB -> 81.424 MB. [2025-08-13T23:29:36.522Z] 23:29:35.780 WARN [block-manager-storage-async-thread-pool-71] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_177_piece0, which does not exist [2025-08-13T23:29:38.464Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1891.434 ms) ====== [2025-08-13T23:29:38.464Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-08-13T23:29:38.464Z] GC before operation: completed in 130.889 ms, heap usage 281.593 MB -> 70.574 MB. [2025-08-13T23:29:40.465Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1861.174 ms) ====== [2025-08-13T23:29:40.465Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-08-13T23:29:40.465Z] GC before operation: completed in 134.078 ms, heap usage 162.100 MB -> 70.363 MB. [2025-08-13T23:29:42.410Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1902.284 ms) ====== [2025-08-13T23:29:42.410Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-08-13T23:29:42.410Z] GC before operation: completed in 133.437 ms, heap usage 265.001 MB -> 70.858 MB. [2025-08-13T23:29:44.353Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1952.220 ms) ====== [2025-08-13T23:29:44.353Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-08-13T23:29:44.353Z] GC before operation: completed in 133.140 ms, heap usage 256.279 MB -> 70.963 MB. [2025-08-13T23:29:46.296Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1827.618 ms) ====== [2025-08-13T23:29:46.296Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-08-13T23:29:46.296Z] GC before operation: completed in 138.439 ms, heap usage 280.111 MB -> 82.380 MB. [2025-08-13T23:29:48.239Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1919.312 ms) ====== [2025-08-13T23:29:48.239Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-08-13T23:29:48.239Z] GC before operation: completed in 135.623 ms, heap usage 120.242 MB -> 70.703 MB. [2025-08-13T23:29:50.180Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1847.544 ms) ====== [2025-08-13T23:29:50.180Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-08-13T23:29:50.180Z] GC before operation: completed in 142.359 ms, heap usage 288.050 MB -> 71.442 MB. [2025-08-13T23:29:52.120Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1794.145 ms) ====== [2025-08-13T23:29:52.120Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-08-13T23:29:52.120Z] GC before operation: completed in 135.873 ms, heap usage 274.949 MB -> 82.434 MB. [2025-08-13T23:29:54.064Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1808.460 ms) ====== [2025-08-13T23:29:54.064Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-08-13T23:29:54.064Z] GC before operation: completed in 144.299 ms, heap usage 249.573 MB -> 88.035 MB. [2025-08-13T23:29:56.006Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1810.170 ms) ====== [2025-08-13T23:29:56.006Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-08-13T23:29:56.006Z] GC before operation: completed in 139.101 ms, heap usage 228.964 MB -> 71.631 MB. [2025-08-13T23:29:57.946Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1859.082 ms) ====== [2025-08-13T23:29:57.946Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-08-13T23:29:57.946Z] GC before operation: completed in 130.428 ms, heap usage 107.469 MB -> 71.783 MB. [2025-08-13T23:29:59.896Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1804.422 ms) ====== [2025-08-13T23:29:59.896Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-08-13T23:29:59.896Z] GC before operation: completed in 137.143 ms, heap usage 223.691 MB -> 71.845 MB. [2025-08-13T23:30:01.860Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1846.264 ms) ====== [2025-08-13T23:30:01.860Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-08-13T23:30:01.860Z] GC before operation: completed in 150.614 ms, heap usage 184.270 MB -> 83.020 MB. [2025-08-13T23:30:03.830Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1770.089 ms) ====== [2025-08-13T23:30:03.830Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-08-13T23:30:03.830Z] GC before operation: completed in 134.308 ms, heap usage 190.764 MB -> 71.854 MB. [2025-08-13T23:30:05.772Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1766.292 ms) ====== [2025-08-13T23:30:05.772Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-08-13T23:30:05.772Z] GC before operation: completed in 132.371 ms, heap usage 318.345 MB -> 83.029 MB. [2025-08-13T23:30:07.715Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1688.561 ms) ====== [2025-08-13T23:30:07.715Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-08-13T23:30:07.715Z] GC before operation: completed in 118.387 ms, heap usage 271.573 MB -> 83.308 MB. [2025-08-13T23:30:09.656Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1741.335 ms) ====== [2025-08-13T23:30:09.656Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-08-13T23:30:09.656Z] GC before operation: completed in 135.552 ms, heap usage 332.153 MB -> 72.335 MB. [2025-08-13T23:30:11.597Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1770.009 ms) ====== [2025-08-13T23:30:11.597Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-08-13T23:30:11.597Z] GC before operation: completed in 123.496 ms, heap usage 294.221 MB -> 72.445 MB. [2025-08-13T23:30:14.419Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1737.544 ms) ====== [2025-08-13T23:30:14.419Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-08-13T23:30:14.419Z] GC before operation: completed in 130.975 ms, heap usage 231.176 MB -> 72.683 MB. [2025-08-13T23:30:15.365Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1890.905 ms) ====== [2025-08-13T23:30:15.365Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-08-13T23:30:15.365Z] GC before operation: completed in 131.567 ms, heap usage 113.352 MB -> 77.430 MB. [2025-08-13T23:30:17.307Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1799.927 ms) ====== [2025-08-13T23:30:17.307Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-08-13T23:30:17.307Z] GC before operation: completed in 133.307 ms, heap usage 218.273 MB -> 72.905 MB. [2025-08-13T23:30:19.306Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1824.957 ms) ====== [2025-08-13T23:30:19.306Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-08-13T23:30:19.306Z] GC before operation: completed in 151.005 ms, heap usage 392.768 MB -> 89.360 MB. [2025-08-13T23:30:21.248Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1720.489 ms) ====== [2025-08-13T23:30:21.248Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-08-13T23:30:21.248Z] GC before operation: completed in 145.647 ms, heap usage 282.264 MB -> 84.293 MB. [2025-08-13T23:30:23.190Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1702.467 ms) ====== [2025-08-13T23:30:23.190Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-08-13T23:30:23.190Z] GC before operation: completed in 136.257 ms, heap usage 309.473 MB -> 83.949 MB. [2025-08-13T23:30:25.131Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1710.735 ms) ====== [2025-08-13T23:30:25.131Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-08-13T23:30:25.132Z] GC before operation: completed in 140.901 ms, heap usage 264.067 MB -> 84.245 MB. [2025-08-13T23:30:27.094Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1711.933 ms) ====== [2025-08-13T23:30:27.094Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-08-13T23:30:27.094Z] GC before operation: completed in 140.755 ms, heap usage 289.734 MB -> 84.567 MB. [2025-08-13T23:30:29.036Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1698.818 ms) ====== [2025-08-13T23:30:29.036Z] ----------------------------------- [2025-08-13T23:30:29.036Z] renaissance-dec-tree_0_PASSED [2025-08-13T23:30:29.036Z] ----------------------------------- [2025-08-13T23:30:29.036Z] [2025-08-13T23:30:29.036Z] TEST TEARDOWN: [2025-08-13T23:30:29.036Z] Nothing to be done for teardown. [2025-08-13T23:30:29.036Z] renaissance-dec-tree_0 Finish Time: Wed Aug 13 23:30:28 2025 Epoch Time (ms): 1755127828324