[2025-02-06T02:26:33.804Z] Running test renaissance-dec-tree_0 ... [2025-02-06T02:26:33.804Z] =============================================== [2025-02-06T02:26:33.804Z] renaissance-dec-tree_0 Start Time: Thu Feb 6 02:26:33 2025 Epoch Time (ms): 1738808793694 [2025-02-06T02:26:33.804Z] variation: NoOptions [2025-02-06T02:26:33.804Z] JVM_OPTIONS: [2025-02-06T02:26:33.804Z] { \ [2025-02-06T02:26:33.804Z] echo ""; echo "TEST SETUP:"; \ [2025-02-06T02:26:33.804Z] echo "Nothing to be done for setup."; \ [2025-02-06T02:26:33.804Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17388083385047/renaissance-dec-tree_0"; \ [2025-02-06T02:26:33.804Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17388083385047/renaissance-dec-tree_0"; \ [2025-02-06T02:26:33.804Z] echo ""; echo "TESTING:"; \ [2025-02-06T02:26:33.804Z] "/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_17388083385047/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-06T02:26:33.804Z] 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_17388083385047/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-06T02:26:33.804Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-06T02:26:33.804Z] echo "Nothing to be done for teardown."; \ [2025-02-06T02:26:33.804Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17388083385047/TestTargetResult"; [2025-02-06T02:26:34.575Z] [2025-02-06T02:26:34.575Z] TEST SETUP: [2025-02-06T02:26:34.575Z] Nothing to be done for setup. [2025-02-06T02:26:34.575Z] [2025-02-06T02:26:34.575Z] TESTING: [2025-02-06T02:26:39.029Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-06T02:26:41.506Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2025-02-06T02:26:43.116Z] WARNING: An illegal reflective access operation has occurred [2025-02-06T02:26:43.116Z] 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_17388083385047/renaissance-dec-tree_0/harness-022634-14876867997382487731/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-06T02:26:43.116Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-06T02:26:43.116Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-06T02:26:43.116Z] WARNING: All illegal access operations will be denied in a future release [2025-02-06T02:26:45.589Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-06T02:26:46.360Z] GC before operation: completed in 66.208 ms, heap usage 202.343 MB -> 35.185 MB. [2025-02-06T02:26:56.241Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9551.494 ms) ====== [2025-02-06T02:26:56.241Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-06T02:26:56.241Z] GC before operation: completed in 84.903 ms, heap usage 283.324 MB -> 67.222 MB. [2025-02-06T02:26:57.836Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2378.294 ms) ====== [2025-02-06T02:26:57.836Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-06T02:26:57.836Z] GC before operation: completed in 88.959 ms, heap usage 206.044 MB -> 67.534 MB. [2025-02-06T02:27:00.305Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2152.384 ms) ====== [2025-02-06T02:27:00.305Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-06T02:27:00.305Z] GC before operation: completed in 99.039 ms, heap usage 204.556 MB -> 67.805 MB. [2025-02-06T02:27:02.773Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2047.433 ms) ====== [2025-02-06T02:27:02.773Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-06T02:27:02.773Z] GC before operation: completed in 94.100 ms, heap usage 180.498 MB -> 67.762 MB. [2025-02-06T02:27:04.364Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2058.149 ms) ====== [2025-02-06T02:27:04.364Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-06T02:27:04.364Z] GC before operation: completed in 94.956 ms, heap usage 214.411 MB -> 68.228 MB. [2025-02-06T02:27:06.843Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1932.884 ms) ====== [2025-02-06T02:27:06.843Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-06T02:27:06.843Z] GC before operation: completed in 113.175 ms, heap usage 151.339 MB -> 68.401 MB. [2025-02-06T02:27:08.437Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1903.403 ms) ====== [2025-02-06T02:27:08.437Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-06T02:27:08.437Z] GC before operation: completed in 113.407 ms, heap usage 221.453 MB -> 68.641 MB. [2025-02-06T02:27:10.910Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1880.572 ms) ====== [2025-02-06T02:27:10.910Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-06T02:27:10.910Z] GC before operation: completed in 114.276 ms, heap usage 177.187 MB -> 68.744 MB. [2025-02-06T02:27:12.499Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1885.268 ms) ====== [2025-02-06T02:27:12.499Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-06T02:27:12.499Z] GC before operation: completed in 104.822 ms, heap usage 264.078 MB -> 68.875 MB. [2025-02-06T02:27:14.984Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1855.174 ms) ====== [2025-02-06T02:27:14.984Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-06T02:27:14.984Z] GC before operation: completed in 113.986 ms, heap usage 168.797 MB -> 68.586 MB. [2025-02-06T02:27:16.572Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1850.717 ms) ====== [2025-02-06T02:27:16.572Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-06T02:27:16.572Z] GC before operation: completed in 129.846 ms, heap usage 142.948 MB -> 69.096 MB. [2025-02-06T02:27:18.558Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1808.693 ms) ====== [2025-02-06T02:27:18.558Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-06T02:27:18.558Z] GC before operation: completed in 125.530 ms, heap usage 200.795 MB -> 69.432 MB. [2025-02-06T02:27:20.147Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1776.977 ms) ====== [2025-02-06T02:27:20.147Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-06T02:27:20.147Z] GC before operation: completed in 110.096 ms, heap usage 132.808 MB -> 69.049 MB. [2025-02-06T02:27:22.631Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1762.090 ms) ====== [2025-02-06T02:27:22.631Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-06T02:27:22.631Z] GC before operation: completed in 122.381 ms, heap usage 117.915 MB -> 68.741 MB. [2025-02-06T02:27:24.231Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1749.942 ms) ====== [2025-02-06T02:27:24.231Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-06T02:27:24.231Z] GC before operation: completed in 119.096 ms, heap usage 132.148 MB -> 69.248 MB. [2025-02-06T02:27:25.844Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1728.367 ms) ====== [2025-02-06T02:27:25.844Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-06T02:27:25.844Z] GC before operation: completed in 127.343 ms, heap usage 298.724 MB -> 69.711 MB. [2025-02-06T02:27:28.312Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1748.593 ms) ====== [2025-02-06T02:27:28.312Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-06T02:27:28.312Z] GC before operation: completed in 159.186 ms, heap usage 103.138 MB -> 69.102 MB. [2025-02-06T02:27:29.911Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1778.362 ms) ====== [2025-02-06T02:27:29.911Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-06T02:27:29.911Z] GC before operation: completed in 122.901 ms, heap usage 130.307 MB -> 69.622 MB. [2025-02-06T02:27:31.536Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1759.111 ms) ====== [2025-02-06T02:27:31.536Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-06T02:27:31.536Z] GC before operation: completed in 126.981 ms, heap usage 111.064 MB -> 75.124 MB. [2025-02-06T02:27:34.016Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1738.565 ms) ====== [2025-02-06T02:27:34.016Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-06T02:27:34.016Z] GC before operation: completed in 129.819 ms, heap usage 239.382 MB -> 70.363 MB. [2025-02-06T02:27:35.617Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1707.314 ms) ====== [2025-02-06T02:27:35.617Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-06T02:27:35.617Z] GC before operation: completed in 137.885 ms, heap usage 177.218 MB -> 75.345 MB. [2025-02-06T02:27:37.242Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1756.635 ms) ====== [2025-02-06T02:27:37.242Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-06T02:27:37.242Z] GC before operation: completed in 140.675 ms, heap usage 107.896 MB -> 69.745 MB. [2025-02-06T02:27:38.853Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1770.118 ms) ====== [2025-02-06T02:27:38.853Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-06T02:27:39.627Z] GC before operation: completed in 135.168 ms, heap usage 104.494 MB -> 69.873 MB. [2025-02-06T02:27:41.216Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1766.442 ms) ====== [2025-02-06T02:27:41.216Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-06T02:27:41.216Z] GC before operation: completed in 146.202 ms, heap usage 325.757 MB -> 75.985 MB. [2025-02-06T02:27:42.828Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1728.010 ms) ====== [2025-02-06T02:27:42.828Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-06T02:27:42.828Z] GC before operation: completed in 158.738 ms, heap usage 275.833 MB -> 81.531 MB. [2025-02-06T02:27:45.300Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1706.735 ms) ====== [2025-02-06T02:27:45.300Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-06T02:27:45.300Z] GC before operation: completed in 132.548 ms, heap usage 252.687 MB -> 70.565 MB. [2025-02-06T02:27:46.890Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1712.004 ms) ====== [2025-02-06T02:27:46.890Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-06T02:27:46.890Z] GC before operation: completed in 147.679 ms, heap usage 285.796 MB -> 81.707 MB. [2025-02-06T02:27:48.481Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1733.726 ms) ====== [2025-02-06T02:27:48.481Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-06T02:27:48.481Z] GC before operation: completed in 141.131 ms, heap usage 164.788 MB -> 70.480 MB. [2025-02-06T02:27:50.073Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1682.836 ms) ====== [2025-02-06T02:27:50.073Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-06T02:27:50.842Z] GC before operation: completed in 145.527 ms, heap usage 224.758 MB -> 81.981 MB. [2025-02-06T02:27:52.441Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1692.279 ms) ====== [2025-02-06T02:27:52.441Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-06T02:27:52.441Z] GC before operation: completed in 151.055 ms, heap usage 145.503 MB -> 81.758 MB. [2025-02-06T02:27:54.035Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1746.117 ms) ====== [2025-02-06T02:27:54.035Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-06T02:27:54.035Z] GC before operation: completed in 146.177 ms, heap usage 342.873 MB -> 71.045 MB. [2025-02-06T02:27:55.625Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1725.057 ms) ====== [2025-02-06T02:27:55.625Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-06T02:27:56.400Z] GC before operation: completed in 137.655 ms, heap usage 312.272 MB -> 71.299 MB. [2025-02-06T02:27:57.992Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1660.074 ms) ====== [2025-02-06T02:27:57.992Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-06T02:27:57.992Z] GC before operation: completed in 147.936 ms, heap usage 202.055 MB -> 82.285 MB. [2025-02-06T02:27:59.587Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1649.641 ms) ====== [2025-02-06T02:27:59.587Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-06T02:27:59.587Z] GC before operation: completed in 152.109 ms, heap usage 238.385 MB -> 76.777 MB. [2025-02-06T02:28:01.182Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1770.630 ms) ====== [2025-02-06T02:28:01.182Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-06T02:28:01.955Z] GC before operation: completed in 160.413 ms, heap usage 289.482 MB -> 71.860 MB. [2025-02-06T02:28:03.559Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1688.615 ms) ====== [2025-02-06T02:28:03.559Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-06T02:28:03.559Z] GC before operation: completed in 136.292 ms, heap usage 107.063 MB -> 82.306 MB. [2025-02-06T02:28:05.160Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1711.322 ms) ====== [2025-02-06T02:28:05.160Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-06T02:28:05.160Z] GC before operation: completed in 170.003 ms, heap usage 179.399 MB -> 71.386 MB. [2025-02-06T02:28:06.760Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1659.444 ms) ====== [2025-02-06T02:28:06.760Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-06T02:28:07.532Z] GC before operation: completed in 156.068 ms, heap usage 136.475 MB -> 77.056 MB. [2025-02-06T02:28:09.129Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1693.475 ms) ====== [2025-02-06T02:28:09.129Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-06T02:28:09.129Z] GC before operation: completed in 154.594 ms, heap usage 208.685 MB -> 71.847 MB. [2025-02-06T02:28:10.730Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1734.297 ms) ====== [2025-02-06T02:28:10.730Z] ----------------------------------- [2025-02-06T02:28:10.730Z] renaissance-dec-tree_0_PASSED [2025-02-06T02:28:10.730Z] ----------------------------------- [2025-02-06T02:28:11.501Z] [2025-02-06T02:28:11.501Z] TEST TEARDOWN: [2025-02-06T02:28:11.501Z] Nothing to be done for teardown. [2025-02-06T02:28:11.501Z] renaissance-dec-tree_0 Finish Time: Thu Feb 6 02:28:10 2025 Epoch Time (ms): 1738808890682