[2025-03-05T22:17:42.610Z] Running test renaissance-dec-tree_0 ... [2025-03-05T22:17:42.610Z] =============================================== [2025-03-05T22:17:42.610Z] renaissance-dec-tree_0 Start Time: Wed Mar 5 22:17:42 2025 Epoch Time (ms): 1741213062267 [2025-03-05T22:17:42.610Z] variation: NoOptions [2025-03-05T22:17:42.610Z] JVM_OPTIONS: [2025-03-05T22:17:42.610Z] { \ [2025-03-05T22:17:42.610Z] echo ""; echo "TEST SETUP:"; \ [2025-03-05T22:17:42.610Z] echo "Nothing to be done for setup."; \ [2025-03-05T22:17:42.610Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17412127394101/renaissance-dec-tree_0"; \ [2025-03-05T22:17:42.610Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17412127394101/renaissance-dec-tree_0"; \ [2025-03-05T22:17:42.610Z] echo ""; echo "TESTING:"; \ [2025-03-05T22:17:42.610Z] "/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_17412127394101/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-03-05T22:17:42.610Z] 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_17412127394101/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-05T22:17:42.610Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-05T22:17:42.610Z] echo "Nothing to be done for teardown."; \ [2025-03-05T22:17:42.610Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17412127394101/TestTargetResult"; [2025-03-05T22:17:42.610Z] [2025-03-05T22:17:42.610Z] TEST SETUP: [2025-03-05T22:17:42.610Z] Nothing to be done for setup. [2025-03-05T22:17:42.610Z] [2025-03-05T22:17:42.610Z] TESTING: [2025-03-05T22:17:48.813Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-05T22:17:54.240Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2025-03-05T22:17:56.222Z] WARNING: An illegal reflective access operation has occurred [2025-03-05T22:17:56.222Z] 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_17412127394101/renaissance-dec-tree_0/harness-221743-5772396651797091707/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-05T22:17:56.222Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-05T22:17:56.222Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-05T22:17:56.222Z] WARNING: All illegal access operations will be denied in a future release [2025-03-05T22:18:00.417Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-03-05T22:18:00.417Z] GC before operation: completed in 62.353 ms, heap usage 73.748 MB -> 34.314 MB. [2025-03-05T22:18:16.267Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15437.066 ms) ====== [2025-03-05T22:18:16.267Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-03-05T22:18:16.267Z] GC before operation: completed in 163.420 ms, heap usage 219.209 MB -> 64.400 MB. [2025-03-05T22:18:23.843Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (6847.404 ms) ====== [2025-03-05T22:18:23.843Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-03-05T22:18:23.843Z] GC before operation: completed in 175.167 ms, heap usage 180.056 MB -> 64.818 MB. [2025-03-05T22:18:25.826Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2742.337 ms) ====== [2025-03-05T22:18:25.826Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-03-05T22:18:25.826Z] GC before operation: completed in 182.184 ms, heap usage 103.188 MB -> 64.563 MB. [2025-03-05T22:18:28.914Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2735.541 ms) ====== [2025-03-05T22:18:28.914Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-03-05T22:18:28.914Z] GC before operation: completed in 194.005 ms, heap usage 163.771 MB -> 64.944 MB. [2025-03-05T22:18:31.046Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2039.534 ms) ====== [2025-03-05T22:18:31.046Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-03-05T22:18:31.046Z] GC before operation: completed in 185.320 ms, heap usage 132.835 MB -> 64.976 MB. [2025-03-05T22:18:33.021Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2115.143 ms) ====== [2025-03-05T22:18:33.021Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-03-05T22:18:33.021Z] GC before operation: completed in 209.423 ms, heap usage 181.982 MB -> 65.846 MB. [2025-03-05T22:18:34.993Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1935.042 ms) ====== [2025-03-05T22:18:34.993Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-03-05T22:18:34.993Z] GC before operation: completed in 191.586 ms, heap usage 182.297 MB -> 65.837 MB. [2025-03-05T22:18:36.966Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1639.999 ms) ====== [2025-03-05T22:18:36.966Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-03-05T22:18:36.966Z] GC before operation: completed in 151.569 ms, heap usage 144.074 MB -> 65.503 MB. [2025-03-05T22:18:38.936Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1612.052 ms) ====== [2025-03-05T22:18:38.936Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-03-05T22:18:38.936Z] GC before operation: completed in 150.028 ms, heap usage 169.773 MB -> 87.641 MB. [2025-03-05T22:18:40.068Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1546.015 ms) ====== [2025-03-05T22:18:40.068Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-03-05T22:18:41.027Z] GC before operation: completed in 142.817 ms, heap usage 273.298 MB -> 66.017 MB. [2025-03-05T22:18:41.982Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1398.237 ms) ====== [2025-03-05T22:18:41.982Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-03-05T22:18:41.982Z] GC before operation: completed in 141.238 ms, heap usage 255.573 MB -> 66.275 MB. [2025-03-05T22:18:43.947Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1434.679 ms) ====== [2025-03-05T22:18:43.947Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-03-05T22:18:43.947Z] GC before operation: completed in 155.987 ms, heap usage 197.919 MB -> 66.363 MB. [2025-03-05T22:18:44.903Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1345.481 ms) ====== [2025-03-05T22:18:44.903Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-03-05T22:18:44.903Z] GC before operation: completed in 154.248 ms, heap usage 193.362 MB -> 66.330 MB. [2025-03-05T22:18:46.868Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1363.461 ms) ====== [2025-03-05T22:18:46.868Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-03-05T22:18:46.868Z] GC before operation: completed in 146.057 ms, heap usage 186.437 MB -> 66.444 MB. [2025-03-05T22:18:47.830Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1346.790 ms) ====== [2025-03-05T22:18:47.830Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-03-05T22:18:48.787Z] GC before operation: completed in 153.086 ms, heap usage 113.850 MB -> 66.147 MB. [2025-03-05T22:18:49.743Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1331.705 ms) ====== [2025-03-05T22:18:49.743Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-03-05T22:18:49.743Z] GC before operation: completed in 164.483 ms, heap usage 158.814 MB -> 66.606 MB. [2025-03-05T22:18:50.703Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1277.020 ms) ====== [2025-03-05T22:18:50.703Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-03-05T22:18:51.662Z] GC before operation: completed in 157.820 ms, heap usage 144.504 MB -> 66.689 MB. [2025-03-05T22:18:52.617Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1293.474 ms) ====== [2025-03-05T22:18:52.617Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-03-05T22:18:52.617Z] GC before operation: completed in 153.982 ms, heap usage 146.601 MB -> 66.641 MB. [2025-03-05T22:18:53.571Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1314.631 ms) ====== [2025-03-05T22:18:53.572Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-03-05T22:18:54.530Z] GC before operation: completed in 168.214 ms, heap usage 145.472 MB -> 66.755 MB. [2025-03-05T22:18:55.487Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1305.544 ms) ====== [2025-03-05T22:18:55.487Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-03-05T22:18:55.487Z] GC before operation: completed in 157.661 ms, heap usage 155.756 MB -> 67.019 MB. [2025-03-05T22:18:57.460Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1304.989 ms) ====== [2025-03-05T22:18:57.460Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-03-05T22:18:57.460Z] GC before operation: completed in 158.977 ms, heap usage 147.851 MB -> 66.957 MB. [2025-03-05T22:18:58.418Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1309.996 ms) ====== [2025-03-05T22:18:58.418Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-03-05T22:18:58.418Z] GC before operation: completed in 178.676 ms, heap usage 173.501 MB -> 67.082 MB. [2025-03-05T22:19:00.387Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1352.565 ms) ====== [2025-03-05T22:19:00.387Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-03-05T22:19:00.387Z] GC before operation: completed in 192.101 ms, heap usage 288.582 MB -> 89.275 MB. [2025-03-05T22:19:01.412Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1258.728 ms) ====== [2025-03-05T22:19:01.412Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-03-05T22:19:01.412Z] GC before operation: completed in 192.985 ms, heap usage 284.835 MB -> 67.583 MB. [2025-03-05T22:19:03.375Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1283.665 ms) ====== [2025-03-05T22:19:03.375Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-03-05T22:19:03.375Z] GC before operation: completed in 171.630 ms, heap usage 229.314 MB -> 67.808 MB. [2025-03-05T22:19:04.341Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1223.515 ms) ====== [2025-03-05T22:19:04.341Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-03-05T22:19:04.341Z] GC before operation: completed in 175.482 ms, heap usage 291.663 MB -> 67.937 MB. [2025-03-05T22:19:05.298Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1259.268 ms) ====== [2025-03-05T22:19:05.298Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-03-05T22:19:06.273Z] GC before operation: completed in 180.733 ms, heap usage 185.875 MB -> 68.002 MB. [2025-03-05T22:19:07.231Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1267.152 ms) ====== [2025-03-05T22:19:07.231Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-03-05T22:19:07.231Z] GC before operation: completed in 165.231 ms, heap usage 164.493 MB -> 67.687 MB. [2025-03-05T22:19:08.190Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1309.467 ms) ====== [2025-03-05T22:19:08.190Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-03-05T22:19:09.151Z] GC before operation: completed in 191.014 ms, heap usage 191.802 MB -> 68.057 MB. [2025-03-05T22:19:10.110Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1262.744 ms) ====== [2025-03-05T22:19:10.110Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-03-05T22:19:10.110Z] GC before operation: completed in 193.884 ms, heap usage 276.504 MB -> 68.154 MB. [2025-03-05T22:19:12.079Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1255.605 ms) ====== [2025-03-05T22:19:12.079Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-03-05T22:19:12.079Z] GC before operation: completed in 186.583 ms, heap usage 184.585 MB -> 68.262 MB. [2025-03-05T22:19:13.036Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1319.590 ms) ====== [2025-03-05T22:19:13.036Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-03-05T22:19:13.036Z] GC before operation: completed in 178.192 ms, heap usage 269.163 MB -> 68.486 MB. [2025-03-05T22:19:14.999Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1229.704 ms) ====== [2025-03-05T22:19:14.999Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-03-05T22:19:14.999Z] GC before operation: completed in 186.771 ms, heap usage 235.490 MB -> 68.436 MB. [2025-03-05T22:19:15.956Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1245.555 ms) ====== [2025-03-05T22:19:15.956Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-03-05T22:19:15.956Z] GC before operation: completed in 180.290 ms, heap usage 297.602 MB -> 74.117 MB. [2025-03-05T22:19:16.912Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1189.072 ms) ====== [2025-03-05T22:19:16.912Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-03-05T22:19:17.870Z] GC before operation: completed in 177.530 ms, heap usage 257.723 MB -> 68.806 MB. [2025-03-05T22:19:18.827Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1188.333 ms) ====== [2025-03-05T22:19:18.827Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-03-05T22:19:18.827Z] GC before operation: completed in 183.639 ms, heap usage 229.590 MB -> 68.904 MB. [2025-03-05T22:19:19.784Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1214.628 ms) ====== [2025-03-05T22:19:19.785Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-03-05T22:19:19.785Z] GC before operation: completed in 186.418 ms, heap usage 273.298 MB -> 69.010 MB. [2025-03-05T22:19:21.752Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1229.881 ms) ====== [2025-03-05T22:19:21.753Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-03-05T22:19:21.753Z] GC before operation: completed in 174.757 ms, heap usage 131.232 MB -> 68.813 MB. [2025-03-05T22:19:22.709Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1241.891 ms) ====== [2025-03-05T22:19:22.709Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-03-05T22:19:22.709Z] GC before operation: completed in 178.407 ms, heap usage 160.595 MB -> 68.760 MB. [2025-03-05T22:19:24.714Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1232.092 ms) ====== [2025-03-05T22:19:24.714Z] ----------------------------------- [2025-03-05T22:19:24.714Z] renaissance-dec-tree_0_PASSED [2025-03-05T22:19:24.714Z] ----------------------------------- [2025-03-05T22:19:24.714Z] [2025-03-05T22:19:24.714Z] TEST TEARDOWN: [2025-03-05T22:19:24.714Z] Nothing to be done for teardown. [2025-03-05T22:19:24.714Z] renaissance-dec-tree_0 Finish Time: Wed Mar 5 22:19:24 2025 Epoch Time (ms): 1741213164048