[2025-11-20T03:48:19.501Z] Running test renaissance-dec-tree_0 ... [2025-11-20T03:48:19.501Z] =============================================== [2025-11-20T03:48:19.501Z] renaissance-dec-tree_0 Start Time: Thu Nov 20 03:48:18 2025 Epoch Time (ms): 1763610498506 [2025-11-20T03:48:19.501Z] variation: NoOptions [2025-11-20T03:48:19.501Z] JVM_OPTIONS: [2025-11-20T03:48:19.501Z] { \ [2025-11-20T03:48:19.501Z] echo ""; echo "TEST SETUP:"; \ [2025-11-20T03:48:19.501Z] echo "Nothing to be done for setup."; \ [2025-11-20T03:48:19.501Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17636098849891/renaissance-dec-tree_0"; \ [2025-11-20T03:48:19.501Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17636098849891/renaissance-dec-tree_0"; \ [2025-11-20T03:48:19.501Z] echo ""; echo "TESTING:"; \ [2025-11-20T03:48:19.501Z] "/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_17636098849891/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-11-20T03:48:19.501Z] 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_17636098849891/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-20T03:48:19.501Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-20T03:48:19.501Z] echo "Nothing to be done for teardown."; \ [2025-11-20T03:48:19.501Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17636098849891/TestTargetResult"; [2025-11-20T03:48:19.501Z] [2025-11-20T03:48:19.501Z] TEST SETUP: [2025-11-20T03:48:19.501Z] Nothing to be done for setup. [2025-11-20T03:48:19.501Z] [2025-11-20T03:48:19.501Z] TESTING: [2025-11-20T03:48:24.875Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-11-20T03:48:26.834Z] WARNING: An illegal reflective access operation has occurred [2025-11-20T03:48:26.834Z] 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_17636098849891/renaissance-dec-tree_0/harness-034819-17197104031589666029/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-11-20T03:48:26.834Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-11-20T03:48:26.834Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-11-20T03:48:26.834Z] WARNING: All illegal access operations will be denied in a future release [2025-11-20T03:48:29.692Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-11-20T03:48:29.692Z] GC before operation: completed in 63.040 ms, heap usage 68.025 MB -> 34.370 MB. [2025-11-20T03:48:39.441Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9891.260 ms) ====== [2025-11-20T03:48:39.441Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-11-20T03:48:39.441Z] GC before operation: completed in 127.450 ms, heap usage 286.865 MB -> 68.284 MB. [2025-11-20T03:48:41.394Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2561.907 ms) ====== [2025-11-20T03:48:41.394Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-11-20T03:48:41.394Z] GC before operation: completed in 127.621 ms, heap usage 249.844 MB -> 85.306 MB. [2025-11-20T03:48:43.356Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2220.766 ms) ====== [2025-11-20T03:48:43.356Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-11-20T03:48:43.356Z] GC before operation: completed in 118.931 ms, heap usage 260.027 MB -> 68.871 MB. [2025-11-20T03:48:46.385Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2179.045 ms) ====== [2025-11-20T03:48:46.385Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-11-20T03:48:46.385Z] GC before operation: completed in 119.340 ms, heap usage 156.614 MB -> 69.090 MB. [2025-11-20T03:48:48.349Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2084.824 ms) ====== [2025-11-20T03:48:48.349Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-11-20T03:48:48.349Z] GC before operation: completed in 136.401 ms, heap usage 211.817 MB -> 69.469 MB. [2025-11-20T03:48:50.301Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2020.133 ms) ====== [2025-11-20T03:48:50.301Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-11-20T03:48:50.301Z] GC before operation: completed in 131.615 ms, heap usage 225.857 MB -> 80.836 MB. [2025-11-20T03:48:52.259Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1943.999 ms) ====== [2025-11-20T03:48:52.259Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-11-20T03:48:52.259Z] GC before operation: completed in 116.608 ms, heap usage 225.013 MB -> 69.892 MB. [2025-11-20T03:48:54.216Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1900.826 ms) ====== [2025-11-20T03:48:54.216Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-11-20T03:48:54.216Z] GC before operation: completed in 115.513 ms, heap usage 300.318 MB -> 70.010 MB. [2025-11-20T03:48:56.186Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1835.069 ms) ====== [2025-11-20T03:48:56.186Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-11-20T03:48:56.186Z] GC before operation: completed in 115.821 ms, heap usage 288.255 MB -> 70.163 MB. [2025-11-20T03:48:58.170Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1868.537 ms) ====== [2025-11-20T03:48:58.170Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-11-20T03:48:58.170Z] GC before operation: completed in 118.922 ms, heap usage 242.437 MB -> 70.099 MB. [2025-11-20T03:49:00.143Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1805.095 ms) ====== [2025-11-20T03:49:00.143Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-11-20T03:49:00.143Z] GC before operation: completed in 116.113 ms, heap usage 183.647 MB -> 69.914 MB. [2025-11-20T03:49:02.130Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1843.658 ms) ====== [2025-11-20T03:49:02.130Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-11-20T03:49:02.130Z] GC before operation: completed in 131.998 ms, heap usage 235.611 MB -> 70.476 MB. [2025-11-20T03:49:04.107Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1853.938 ms) ====== [2025-11-20T03:49:04.107Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-11-20T03:49:04.107Z] GC before operation: completed in 130.945 ms, heap usage 244.000 MB -> 70.572 MB. [2025-11-20T03:49:06.138Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1810.523 ms) ====== [2025-11-20T03:49:06.138Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-11-20T03:49:06.138Z] GC before operation: completed in 135.484 ms, heap usage 253.399 MB -> 87.216 MB. [2025-11-20T03:49:08.111Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1796.805 ms) ====== [2025-11-20T03:49:08.111Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-11-20T03:49:08.111Z] GC before operation: completed in 139.801 ms, heap usage 189.269 MB -> 81.261 MB. [2025-11-20T03:49:10.090Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1883.319 ms) ====== [2025-11-20T03:49:10.090Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-11-20T03:49:10.090Z] GC before operation: completed in 142.442 ms, heap usage 349.259 MB -> 70.997 MB. [2025-11-20T03:49:12.070Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1857.656 ms) ====== [2025-11-20T03:49:12.070Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-11-20T03:49:12.070Z] GC before operation: completed in 141.473 ms, heap usage 249.197 MB -> 82.259 MB. [2025-11-20T03:49:14.048Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1788.715 ms) ====== [2025-11-20T03:49:14.048Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-11-20T03:49:14.048Z] GC before operation: completed in 142.880 ms, heap usage 270.654 MB -> 71.081 MB. [2025-11-20T03:49:16.052Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1830.115 ms) ====== [2025-11-20T03:49:16.052Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-11-20T03:49:16.052Z] GC before operation: completed in 144.659 ms, heap usage 303.113 MB -> 82.224 MB. [2025-11-20T03:49:18.023Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1768.157 ms) ====== [2025-11-20T03:49:18.023Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-11-20T03:49:18.023Z] GC before operation: completed in 133.057 ms, heap usage 158.860 MB -> 71.278 MB. [2025-11-20T03:49:19.995Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1804.932 ms) ====== [2025-11-20T03:49:19.995Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-11-20T03:49:19.995Z] GC before operation: completed in 140.804 ms, heap usage 231.428 MB -> 77.212 MB. [2025-11-20T03:49:21.967Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1792.201 ms) ====== [2025-11-20T03:49:21.967Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-11-20T03:49:21.967Z] GC before operation: completed in 146.318 ms, heap usage 296.826 MB -> 88.041 MB. [2025-11-20T03:49:23.942Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1738.805 ms) ====== [2025-11-20T03:49:23.942Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-11-20T03:49:23.942Z] GC before operation: completed in 138.861 ms, heap usage 286.087 MB -> 82.906 MB. [2025-11-20T03:49:25.915Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1749.822 ms) ====== [2025-11-20T03:49:25.915Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-11-20T03:49:25.915Z] GC before operation: completed in 141.676 ms, heap usage 313.207 MB -> 82.755 MB. [2025-11-20T03:49:26.876Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1738.063 ms) ====== [2025-11-20T03:49:26.876Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-11-20T03:49:27.870Z] GC before operation: completed in 148.096 ms, heap usage 300.916 MB -> 77.637 MB. [2025-11-20T03:49:28.829Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1797.521 ms) ====== [2025-11-20T03:49:28.829Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-11-20T03:49:29.789Z] GC before operation: completed in 140.043 ms, heap usage 151.142 MB -> 71.910 MB. [2025-11-20T03:49:30.749Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1773.783 ms) ====== [2025-11-20T03:49:30.749Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-11-20T03:49:31.710Z] GC before operation: completed in 140.847 ms, heap usage 256.929 MB -> 72.184 MB. [2025-11-20T03:49:32.669Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1787.877 ms) ====== [2025-11-20T03:49:32.669Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-11-20T03:49:33.628Z] GC before operation: completed in 141.765 ms, heap usage 143.271 MB -> 72.093 MB. [2025-11-20T03:49:35.604Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1803.351 ms) ====== [2025-11-20T03:49:35.604Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-11-20T03:49:35.604Z] GC before operation: completed in 156.528 ms, heap usage 345.682 MB -> 94.393 MB. [2025-11-20T03:49:36.564Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1707.960 ms) ====== [2025-11-20T03:49:36.564Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-11-20T03:49:37.572Z] GC before operation: completed in 152.660 ms, heap usage 331.699 MB -> 83.606 MB. [2025-11-20T03:49:38.536Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1758.690 ms) ====== [2025-11-20T03:49:38.536Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-11-20T03:49:38.536Z] GC before operation: completed in 147.737 ms, heap usage 222.423 MB -> 72.563 MB. [2025-11-20T03:49:40.508Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1754.838 ms) ====== [2025-11-20T03:49:40.508Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-11-20T03:49:40.508Z] GC before operation: completed in 166.701 ms, heap usage 251.134 MB -> 89.238 MB. [2025-11-20T03:49:40.508Z] 03:49:40.353 WARN [block-manager-storage-async-thread-pool-68] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1533_0, which does not exist [2025-11-20T03:49:42.478Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1701.063 ms) ====== [2025-11-20T03:49:42.478Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-11-20T03:49:42.478Z] GC before operation: completed in 149.759 ms, heap usage 155.681 MB -> 77.760 MB. [2025-11-20T03:49:44.450Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1760.595 ms) ====== [2025-11-20T03:49:44.450Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-11-20T03:49:44.450Z] GC before operation: completed in 143.665 ms, heap usage 166.714 MB -> 72.595 MB. [2025-11-20T03:49:46.423Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1723.737 ms) ====== [2025-11-20T03:49:46.423Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-11-20T03:49:46.423Z] GC before operation: completed in 145.368 ms, heap usage 328.491 MB -> 72.887 MB. [2025-11-20T03:49:48.395Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1758.761 ms) ====== [2025-11-20T03:49:48.395Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-11-20T03:49:48.395Z] GC before operation: completed in 156.887 ms, heap usage 230.530 MB -> 95.148 MB. [2025-11-20T03:49:50.369Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1696.062 ms) ====== [2025-11-20T03:49:50.369Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-11-20T03:49:50.369Z] GC before operation: completed in 152.402 ms, heap usage 331.843 MB -> 73.101 MB. [2025-11-20T03:49:52.355Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1769.713 ms) ====== [2025-11-20T03:49:52.355Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-11-20T03:49:52.355Z] GC before operation: completed in 148.673 ms, heap usage 247.485 MB -> 73.355 MB. [2025-11-20T03:49:54.931Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1762.235 ms) ====== [2025-11-20T03:49:54.931Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-11-20T03:49:54.931Z] GC before operation: completed in 170.378 ms, heap usage 254.225 MB -> 73.299 MB. [2025-11-20T03:49:55.894Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1745.034 ms) ====== [2025-11-20T03:49:55.894Z] ----------------------------------- [2025-11-20T03:49:55.894Z] renaissance-dec-tree_0_PASSED [2025-11-20T03:49:55.894Z] ----------------------------------- [2025-11-20T03:49:55.894Z] [2025-11-20T03:49:55.894Z] TEST TEARDOWN: [2025-11-20T03:49:55.894Z] Nothing to be done for teardown. [2025-11-20T03:49:55.894Z] renaissance-dec-tree_0 Finish Time: Thu Nov 20 03:49:55 2025 Epoch Time (ms): 1763610595695