[2025-01-22T03:55:54.952Z] Running test renaissance-dec-tree_0 ... [2025-01-22T03:55:54.952Z] =============================================== [2025-01-22T03:55:54.952Z] renaissance-dec-tree_0 Start Time: Wed Jan 22 03:55:54 2025 Epoch Time (ms): 1737518154137 [2025-01-22T03:55:54.952Z] variation: NoOptions [2025-01-22T03:55:54.952Z] JVM_OPTIONS: [2025-01-22T03:55:54.952Z] { \ [2025-01-22T03:55:54.952Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T03:55:54.952Z] echo "Nothing to be done for setup."; \ [2025-01-22T03:55:54.952Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17375178061341/renaissance-dec-tree_0"; \ [2025-01-22T03:55:54.952Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17375178061341/renaissance-dec-tree_0"; \ [2025-01-22T03:55:54.952Z] echo ""; echo "TESTING:"; \ [2025-01-22T03:55:54.952Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17375178061341/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-01-22T03:55:54.952Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17375178061341/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T03:55:54.952Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T03:55:54.952Z] echo "Nothing to be done for teardown."; \ [2025-01-22T03:55:54.952Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17375178061341/TestTargetResult"; [2025-01-22T03:55:54.952Z] [2025-01-22T03:55:54.952Z] TEST SETUP: [2025-01-22T03:55:54.952Z] Nothing to be done for setup. [2025-01-22T03:55:54.952Z] [2025-01-22T03:55:54.952Z] TESTING: [2025-01-22T03:55:57.985Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-22T03:56:02.137Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2025-01-22T03:56:04.086Z] WARNING: An illegal reflective access operation has occurred [2025-01-22T03:56:04.086Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17375178061341/renaissance-dec-tree_0/harness-035555-7327745765326941046/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-01-22T03:56:04.086Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-01-22T03:56:04.086Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-01-22T03:56:04.086Z] WARNING: All illegal access operations will be denied in a future release [2025-01-22T03:56:08.226Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-01-22T03:56:08.226Z] GC before operation: completed in 74.783 ms, heap usage 85.397 MB -> 34.317 MB. [2025-01-22T03:56:24.695Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15003.343 ms) ====== [2025-01-22T03:56:24.695Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-01-22T03:56:24.695Z] GC before operation: completed in 166.679 ms, heap usage 204.515 MB -> 64.389 MB. [2025-01-22T03:56:26.643Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3338.743 ms) ====== [2025-01-22T03:56:26.644Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-01-22T03:56:26.644Z] GC before operation: completed in 155.059 ms, heap usage 147.426 MB -> 64.696 MB. [2025-01-22T03:56:29.664Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2453.623 ms) ====== [2025-01-22T03:56:29.664Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-01-22T03:56:29.664Z] GC before operation: completed in 155.668 ms, heap usage 203.782 MB -> 64.848 MB. [2025-01-22T03:56:31.615Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2262.313 ms) ====== [2025-01-22T03:56:31.615Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-01-22T03:56:31.615Z] GC before operation: completed in 170.129 ms, heap usage 154.709 MB -> 64.803 MB. [2025-01-22T03:56:34.629Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2118.111 ms) ====== [2025-01-22T03:56:34.630Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-01-22T03:56:34.630Z] GC before operation: completed in 151.822 ms, heap usage 146.410 MB -> 65.133 MB. [2025-01-22T03:56:36.598Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1958.117 ms) ====== [2025-01-22T03:56:36.598Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-01-22T03:56:36.598Z] GC before operation: completed in 163.625 ms, heap usage 152.342 MB -> 65.368 MB. [2025-01-22T03:56:38.550Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1975.123 ms) ====== [2025-01-22T03:56:38.550Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-01-22T03:56:38.550Z] GC before operation: completed in 173.414 ms, heap usage 166.191 MB -> 65.570 MB. [2025-01-22T03:56:40.503Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1977.608 ms) ====== [2025-01-22T03:56:40.503Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-01-22T03:56:40.503Z] GC before operation: completed in 169.517 ms, heap usage 163.362 MB -> 65.669 MB. [2025-01-22T03:56:42.459Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1950.172 ms) ====== [2025-01-22T03:56:42.459Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-01-22T03:56:42.459Z] GC before operation: completed in 176.589 ms, heap usage 110.760 MB -> 65.491 MB. [2025-01-22T03:56:44.410Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2024.090 ms) ====== [2025-01-22T03:56:44.410Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-01-22T03:56:45.361Z] GC before operation: completed in 208.232 ms, heap usage 165.103 MB -> 65.744 MB. [2025-01-22T03:56:47.311Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1810.127 ms) ====== [2025-01-22T03:56:47.311Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-01-22T03:56:47.311Z] GC before operation: completed in 187.099 ms, heap usage 201.651 MB -> 66.124 MB. [2025-01-22T03:56:49.261Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1825.436 ms) ====== [2025-01-22T03:56:49.261Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-01-22T03:56:49.261Z] GC before operation: completed in 219.756 ms, heap usage 189.953 MB -> 66.213 MB. [2025-01-22T03:56:51.210Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1813.547 ms) ====== [2025-01-22T03:56:51.211Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-01-22T03:56:51.211Z] GC before operation: completed in 183.684 ms, heap usage 168.932 MB -> 66.052 MB. [2025-01-22T03:56:53.161Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1883.527 ms) ====== [2025-01-22T03:56:53.161Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-01-22T03:56:53.161Z] GC before operation: completed in 181.435 ms, heap usage 166.205 MB -> 66.162 MB. [2025-01-22T03:56:55.113Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1817.297 ms) ====== [2025-01-22T03:56:55.113Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-01-22T03:56:55.113Z] GC before operation: completed in 189.597 ms, heap usage 167.907 MB -> 66.416 MB. [2025-01-22T03:56:57.067Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1929.039 ms) ====== [2025-01-22T03:56:57.067Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-01-22T03:56:57.067Z] GC before operation: completed in 188.936 ms, heap usage 155.268 MB -> 66.625 MB. [2025-01-22T03:56:59.019Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1788.557 ms) ====== [2025-01-22T03:56:59.019Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-01-22T03:56:59.019Z] GC before operation: completed in 196.502 ms, heap usage 144.689 MB -> 66.701 MB. [2025-01-22T03:57:00.971Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1731.085 ms) ====== [2025-01-22T03:57:00.971Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-01-22T03:57:00.971Z] GC before operation: completed in 194.276 ms, heap usage 179.834 MB -> 66.944 MB. [2025-01-22T03:57:02.924Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1870.386 ms) ====== [2025-01-22T03:57:02.924Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-01-22T03:57:02.924Z] GC before operation: completed in 190.204 ms, heap usage 113.462 MB -> 66.490 MB. [2025-01-22T03:57:04.874Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1748.171 ms) ====== [2025-01-22T03:57:04.874Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-01-22T03:57:04.874Z] GC before operation: completed in 198.832 ms, heap usage 268.572 MB -> 67.146 MB. [2025-01-22T03:57:06.825Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1785.389 ms) ====== [2025-01-22T03:57:06.825Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-01-22T03:57:06.825Z] GC before operation: completed in 198.088 ms, heap usage 189.573 MB -> 67.392 MB. [2025-01-22T03:57:08.778Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1762.798 ms) ====== [2025-01-22T03:57:08.778Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-01-22T03:57:08.778Z] GC before operation: completed in 194.579 ms, heap usage 174.150 MB -> 67.063 MB. [2025-01-22T03:57:10.728Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1702.082 ms) ====== [2025-01-22T03:57:10.728Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-01-22T03:57:10.728Z] GC before operation: completed in 196.285 ms, heap usage 240.705 MB -> 67.433 MB. [2025-01-22T03:57:12.676Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1799.449 ms) ====== [2025-01-22T03:57:12.676Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-01-22T03:57:12.676Z] GC before operation: completed in 198.059 ms, heap usage 173.891 MB -> 67.261 MB. [2025-01-22T03:57:14.627Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1674.667 ms) ====== [2025-01-22T03:57:14.627Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-01-22T03:57:14.627Z] GC before operation: completed in 199.020 ms, heap usage 195.240 MB -> 67.775 MB. [2025-01-22T03:57:16.576Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1735.448 ms) ====== [2025-01-22T03:57:16.576Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-01-22T03:57:16.576Z] GC before operation: completed in 197.914 ms, heap usage 162.290 MB -> 67.460 MB. [2025-01-22T03:57:18.529Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1698.244 ms) ====== [2025-01-22T03:57:18.529Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-01-22T03:57:18.530Z] GC before operation: completed in 209.490 ms, heap usage 190.204 MB -> 67.812 MB. [2025-01-22T03:57:20.171Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1709.408 ms) ====== [2025-01-22T03:57:20.171Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-01-22T03:57:20.171Z] GC before operation: completed in 210.440 ms, heap usage 117.580 MB -> 67.353 MB. [2025-01-22T03:57:22.120Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1689.544 ms) ====== [2025-01-22T03:57:22.120Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-01-22T03:57:22.120Z] GC before operation: completed in 203.647 ms, heap usage 189.100 MB -> 68.012 MB. [2025-01-22T03:57:24.075Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1697.408 ms) ====== [2025-01-22T03:57:24.075Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-01-22T03:57:24.075Z] GC before operation: completed in 204.752 ms, heap usage 124.665 MB -> 67.815 MB. [2025-01-22T03:57:26.023Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1625.174 ms) ====== [2025-01-22T03:57:26.023Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-01-22T03:57:26.023Z] GC before operation: completed in 204.450 ms, heap usage 159.196 MB -> 67.939 MB. [2025-01-22T03:57:27.976Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1662.423 ms) ====== [2025-01-22T03:57:27.976Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-01-22T03:57:27.976Z] GC before operation: completed in 210.427 ms, heap usage 265.862 MB -> 68.316 MB. [2025-01-22T03:57:29.929Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1700.605 ms) ====== [2025-01-22T03:57:29.929Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-01-22T03:57:29.929Z] GC before operation: completed in 217.189 ms, heap usage 230.488 MB -> 68.537 MB. [2025-01-22T03:57:31.877Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1613.347 ms) ====== [2025-01-22T03:57:31.877Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-01-22T03:57:31.877Z] GC before operation: completed in 207.254 ms, heap usage 258.810 MB -> 68.494 MB. [2025-01-22T03:57:33.856Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1658.688 ms) ====== [2025-01-22T03:57:33.856Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-01-22T03:57:33.856Z] GC before operation: completed in 203.326 ms, heap usage 173.255 MB -> 68.332 MB. [2025-01-22T03:57:35.823Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1657.071 ms) ====== [2025-01-22T03:57:35.823Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-01-22T03:57:35.823Z] GC before operation: completed in 230.918 ms, heap usage 213.273 MB -> 68.848 MB. [2025-01-22T03:57:37.770Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1654.972 ms) ====== [2025-01-22T03:57:37.770Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-01-22T03:57:37.770Z] GC before operation: completed in 206.582 ms, heap usage 191.413 MB -> 68.801 MB. [2025-01-22T03:57:38.719Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1615.658 ms) ====== [2025-01-22T03:57:38.719Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-01-22T03:57:39.680Z] GC before operation: completed in 210.540 ms, heap usage 276.525 MB -> 68.882 MB. [2025-01-22T03:57:40.629Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1625.816 ms) ====== [2025-01-22T03:57:40.629Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-01-22T03:57:41.580Z] GC before operation: completed in 209.127 ms, heap usage 263.443 MB -> 69.127 MB. [2025-01-22T03:57:42.533Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1615.043 ms) ====== [2025-01-22T03:57:43.484Z] ----------------------------------- [2025-01-22T03:57:43.484Z] renaissance-dec-tree_0_PASSED [2025-01-22T03:57:43.484Z] ----------------------------------- [2025-01-22T03:57:43.484Z] [2025-01-22T03:57:43.484Z] TEST TEARDOWN: [2025-01-22T03:57:43.484Z] Nothing to be done for teardown. [2025-01-22T03:57:43.484Z] renaissance-dec-tree_0 Finish Time: Wed Jan 22 03:57:42 2025 Epoch Time (ms): 1737518262700