[2026-01-10T15:47:09.381Z] Running test renaissance-dec-tree_0 ... [2026-01-10T15:47:09.381Z] =============================================== [2026-01-10T15:47:09.381Z] renaissance-dec-tree_0 Start Time: Sat Jan 10 10:47:08 2026 Epoch Time (ms): 1768060028839 [2026-01-10T15:47:09.381Z] variation: NoOptions [2026-01-10T15:47:09.381Z] JVM_OPTIONS: [2026-01-10T15:47:09.381Z] { \ [2026-01-10T15:47:09.381Z] echo ""; echo "TEST SETUP:"; \ [2026-01-10T15:47:09.381Z] echo "Nothing to be done for setup."; \ [2026-01-10T15:47:09.381Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17680583032959/renaissance-dec-tree_0"; \ [2026-01-10T15:47:09.381Z] cd "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17680583032959/renaissance-dec-tree_0"; \ [2026-01-10T15:47:09.381Z] echo ""; echo "TESTING:"; \ [2026-01-10T15:47:09.381Z] "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17680583032959/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-10T15:47:09.381Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17680583032959/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-10T15:47:09.381Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-10T15:47:09.381Z] echo "Nothing to be done for teardown."; \ [2026-01-10T15:47:09.381Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_17680583032959/TestTargetResult"; [2026-01-10T15:47:09.381Z] [2026-01-10T15:47:09.381Z] TEST SETUP: [2026-01-10T15:47:09.381Z] Nothing to be done for setup. [2026-01-10T15:47:09.381Z] [2026-01-10T15:47:09.381Z] TESTING: [2026-01-10T15:47:11.712Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-10T15:47:11.712Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/Users/admin/workspace/workspace/Test_openjdk25_hs_extended.perf_x86-64_mac/aqa-tests/TKG/output_17680583032959/renaissance-dec-tree_0/launcher-104709-10911290231225119198/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-10T15:47:11.712Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-10T15:47:11.712Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-10T15:47:29.686Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-10T15:47:37.236Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-10T15:47:37.752Z] GC before operation: completed in 370.830 ms, heap usage 68.665 MB -> 34.229 MB. [2026-01-10T15:48:14.709Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (34504.644 ms) ====== [2026-01-10T15:48:14.709Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-10T15:48:14.709Z] GC before operation: completed in 387.054 ms, heap usage 307.268 MB -> 70.110 MB. [2026-01-10T15:48:22.605Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (9908.998 ms) ====== [2026-01-10T15:48:22.605Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-10T15:48:22.605Z] GC before operation: completed in 290.906 ms, heap usage 363.231 MB -> 70.258 MB. [2026-01-10T15:48:29.099Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5668.006 ms) ====== [2026-01-10T15:48:29.099Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-10T15:48:29.099Z] GC before operation: completed in 251.790 ms, heap usage 281.749 MB -> 70.504 MB. [2026-01-10T15:48:34.279Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (5629.528 ms) ====== [2026-01-10T15:48:34.279Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-10T15:48:34.739Z] GC before operation: completed in 246.675 ms, heap usage 111.197 MB -> 70.227 MB. [2026-01-10T15:48:41.021Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (5906.417 ms) ====== [2026-01-10T15:48:41.021Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-10T15:48:41.547Z] GC before operation: completed in 861.238 ms, heap usage 460.527 MB -> 71.177 MB. [2026-01-10T15:48:47.641Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (5492.248 ms) ====== [2026-01-10T15:48:47.641Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-10T15:48:47.641Z] GC before operation: completed in 624.769 ms, heap usage 382.195 MB -> 98.692 MB. [2026-01-10T15:48:52.802Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (5274.919 ms) ====== [2026-01-10T15:48:52.802Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-10T15:48:53.242Z] GC before operation: completed in 366.382 ms, heap usage 217.726 MB -> 99.144 MB. [2026-01-10T15:48:59.381Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (6210.201 ms) ====== [2026-01-10T15:48:59.381Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-10T15:48:59.951Z] GC before operation: completed in 352.994 ms, heap usage 727.782 MB -> 99.331 MB. [2026-01-10T15:49:05.031Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (5035.148 ms) ====== [2026-01-10T15:49:05.031Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-10T15:49:05.031Z] GC before operation: completed in 244.748 ms, heap usage 277.177 MB -> 72.006 MB. [2026-01-10T15:49:10.296Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4635.971 ms) ====== [2026-01-10T15:49:10.296Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-10T15:49:10.296Z] GC before operation: completed in 217.308 ms, heap usage 349.467 MB -> 71.745 MB. [2026-01-10T15:49:14.323Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4192.527 ms) ====== [2026-01-10T15:49:14.323Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-10T15:49:14.323Z] GC before operation: completed in 263.885 ms, heap usage 212.008 MB -> 71.876 MB. [2026-01-10T15:49:18.115Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3811.106 ms) ====== [2026-01-10T15:49:18.115Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-10T15:49:18.650Z] GC before operation: completed in 193.587 ms, heap usage 330.141 MB -> 72.129 MB. [2026-01-10T15:49:23.730Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4686.978 ms) ====== [2026-01-10T15:49:23.730Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-10T15:49:23.730Z] GC before operation: completed in 254.442 ms, heap usage 141.011 MB -> 71.918 MB. [2026-01-10T15:49:28.756Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (5014.487 ms) ====== [2026-01-10T15:49:28.756Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-10T15:49:28.756Z] GC before operation: completed in 266.198 ms, heap usage 417.025 MB -> 72.395 MB. [2026-01-10T15:49:33.726Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5289.343 ms) ====== [2026-01-10T15:49:33.726Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-10T15:49:34.190Z] GC before operation: completed in 206.512 ms, heap usage 421.252 MB -> 72.529 MB. [2026-01-10T15:49:39.534Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5159.484 ms) ====== [2026-01-10T15:49:39.534Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-10T15:49:39.534Z] GC before operation: completed in 278.291 ms, heap usage 129.382 MB -> 72.167 MB. [2026-01-10T15:49:44.678Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4704.264 ms) ====== [2026-01-10T15:49:44.678Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-10T15:49:44.678Z] GC before operation: completed in 301.392 ms, heap usage 324.199 MB -> 72.575 MB. [2026-01-10T15:49:51.248Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (5586.111 ms) ====== [2026-01-10T15:49:51.248Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-10T15:49:51.248Z] GC before operation: completed in 391.312 ms, heap usage 416.077 MB -> 72.885 MB. [2026-01-10T15:49:56.159Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5599.220 ms) ====== [2026-01-10T15:49:56.159Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-10T15:49:56.579Z] GC before operation: completed in 326.885 ms, heap usage 358.941 MB -> 72.968 MB. [2026-01-10T15:50:00.933Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4122.794 ms) ====== [2026-01-10T15:50:00.933Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-10T15:50:01.856Z] GC before operation: completed in 1073.080 ms, heap usage 471.272 MB -> 73.208 MB. [2026-01-10T15:50:06.819Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4677.618 ms) ====== [2026-01-10T15:50:06.819Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-10T15:50:07.323Z] GC before operation: completed in 786.763 ms, heap usage 308.185 MB -> 73.209 MB. [2026-01-10T15:50:11.125Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (4197.056 ms) ====== [2026-01-10T15:50:11.125Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-10T15:50:12.128Z] GC before operation: completed in 687.836 ms, heap usage 344.574 MB -> 73.216 MB. [2026-01-10T15:50:15.942Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (3607.465 ms) ====== [2026-01-10T15:50:15.942Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-10T15:50:16.458Z] GC before operation: completed in 814.677 ms, heap usage 369.154 MB -> 73.329 MB. [2026-01-10T15:50:20.420Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3737.932 ms) ====== [2026-01-10T15:50:20.420Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-10T15:50:20.868Z] GC before operation: completed in 685.049 ms, heap usage 321.977 MB -> 73.579 MB. [2026-01-10T15:50:26.005Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (4340.219 ms) ====== [2026-01-10T15:50:26.005Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-10T15:50:26.005Z] GC before operation: completed in 308.439 ms, heap usage 324.840 MB -> 101.141 MB. [2026-01-10T15:50:29.908Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (4236.228 ms) ====== [2026-01-10T15:50:29.909Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-10T15:50:29.909Z] GC before operation: completed in 173.992 ms, heap usage 493.975 MB -> 73.918 MB. [2026-01-10T15:50:34.739Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4164.967 ms) ====== [2026-01-10T15:50:34.739Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-10T15:50:34.739Z] GC before operation: completed in 203.349 ms, heap usage 293.744 MB -> 73.798 MB. [2026-01-10T15:50:38.533Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4077.441 ms) ====== [2026-01-10T15:50:38.533Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-10T15:50:38.533Z] GC before operation: completed in 230.730 ms, heap usage 369.952 MB -> 101.493 MB. [2026-01-10T15:50:43.408Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (4065.559 ms) ====== [2026-01-10T15:50:43.408Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-10T15:50:43.408Z] GC before operation: completed in 204.691 ms, heap usage 314.601 MB -> 74.023 MB. [2026-01-10T15:50:47.160Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3651.552 ms) ====== [2026-01-10T15:50:47.160Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-10T15:50:47.160Z] GC before operation: completed in 239.368 ms, heap usage 370.516 MB -> 101.716 MB. [2026-01-10T15:50:51.044Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3683.911 ms) ====== [2026-01-10T15:50:51.044Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-10T15:50:51.045Z] GC before operation: completed in 254.751 ms, heap usage 438.593 MB -> 74.675 MB. [2026-01-10T15:50:54.212Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3480.604 ms) ====== [2026-01-10T15:50:54.212Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-10T15:50:54.805Z] GC before operation: completed in 342.515 ms, heap usage 310.606 MB -> 74.371 MB. [2026-01-10T15:50:58.971Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3992.407 ms) ====== [2026-01-10T15:50:58.971Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-10T15:50:58.971Z] GC before operation: completed in 180.755 ms, heap usage 428.138 MB -> 74.515 MB. [2026-01-10T15:51:01.958Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3307.086 ms) ====== [2026-01-10T15:51:01.958Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-10T15:51:02.546Z] GC before operation: completed in 685.469 ms, heap usage 455.539 MB -> 102.422 MB. [2026-01-10T15:51:06.445Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3452.383 ms) ====== [2026-01-10T15:51:06.445Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-10T15:51:06.445Z] GC before operation: completed in 332.966 ms, heap usage 393.502 MB -> 102.287 MB. [2026-01-10T15:51:06.445Z] 10:51:06.189 WARN [block-manager-storage-async-thread-pool-112] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1677_1, which does not exist [2026-01-10T15:51:10.459Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (3306.903 ms) ====== [2026-01-10T15:51:10.460Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-10T15:51:10.460Z] GC before operation: completed in 239.557 ms, heap usage 210.924 MB -> 74.338 MB. [2026-01-10T15:51:14.504Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4349.896 ms) ====== [2026-01-10T15:51:14.504Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-10T15:51:14.504Z] GC before operation: completed in 234.149 ms, heap usage 257.070 MB -> 74.878 MB. [2026-01-10T15:51:19.510Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4138.145 ms) ====== [2026-01-10T15:51:19.510Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-10T15:51:19.510Z] GC before operation: completed in 321.601 ms, heap usage 410.306 MB -> 91.193 MB. [2026-01-10T15:51:23.438Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4175.754 ms) ====== [2026-01-10T15:51:23.438Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-10T15:51:23.866Z] GC before operation: completed in 519.416 ms, heap usage 534.839 MB -> 75.586 MB. [2026-01-10T15:51:27.552Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3399.490 ms) ====== [2026-01-10T15:51:27.965Z] ----------------------------------- [2026-01-10T15:51:27.966Z] renaissance-dec-tree_0_PASSED [2026-01-10T15:51:27.966Z] ----------------------------------- [2026-01-10T15:51:27.966Z] [2026-01-10T15:51:27.966Z] TEST TEARDOWN: [2026-01-10T15:51:27.966Z] Nothing to be done for teardown. [2026-01-10T15:51:28.447Z] renaissance-dec-tree_0 Finish Time: Sat Jan 10 10:51:27 2026 Epoch Time (ms): 1768060287889