[2026-02-05T22:25:05.186Z] Running test renaissance-dec-tree_0 ... [2026-02-05T22:25:05.186Z] =============================================== [2026-02-05T22:25:05.186Z] renaissance-dec-tree_0 Start Time: Thu Feb 5 22:25:05 2026 Epoch Time (ms): 1770330305000 [2026-02-05T22:25:05.186Z] variation: NoOptions [2026-02-05T22:25:05.186Z] JVM_OPTIONS: [2026-02-05T22:25:05.186Z] { \ [2026-02-05T22:25:05.186Z] echo ""; echo "TEST SETUP:"; \ [2026-02-05T22:25:05.186Z] echo "Nothing to be done for setup."; \ [2026-02-05T22:25:05.186Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_177032968229/renaissance-dec-tree_0"; \ [2026-02-05T22:25:05.186Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_177032968229/renaissance-dec-tree_0"; \ [2026-02-05T22:25:05.186Z] echo ""; echo "TESTING:"; \ [2026-02-05T22:25:05.186Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-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_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_177032968229/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-02-05T22:25:05.186Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_177032968229/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-05T22:25:05.186Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-05T22:25:05.186Z] echo "Nothing to be done for teardown."; \ [2026-02-05T22:25:05.186Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_177032968229/TestTargetResult"; [2026-02-05T22:25:05.186Z] [2026-02-05T22:25:05.186Z] TEST SETUP: [2026-02-05T22:25:05.186Z] Nothing to be done for setup. [2026-02-05T22:25:05.186Z] [2026-02-05T22:25:05.186Z] TESTING: [2026-02-05T22:25:06.152Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-05T22:25:06.152Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/output_177032968229/renaissance-dec-tree_0/launcher-222505-13147426559817607935/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-05T22:25:06.152Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-05T22:25:06.152Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-05T22:25:22.069Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-05T22:25:25.173Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-02-05T22:25:25.173Z] GC before operation: completed in 74.473 ms, heap usage 50.376 MB -> 35.048 MB. [2026-02-05T22:25:36.873Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11257.989 ms) ====== [2026-02-05T22:25:36.873Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-02-05T22:25:36.873Z] GC before operation: completed in 106.863 ms, heap usage 114.404 MB -> 68.526 MB. [2026-02-05T22:25:38.876Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2258.730 ms) ====== [2026-02-05T22:25:38.876Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-02-05T22:25:38.876Z] GC before operation: completed in 92.374 ms, heap usage 210.046 MB -> 69.208 MB. [2026-02-05T22:25:40.873Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1855.075 ms) ====== [2026-02-05T22:25:40.873Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-02-05T22:25:40.873Z] GC before operation: completed in 98.131 ms, heap usage 256.464 MB -> 69.297 MB. [2026-02-05T22:25:42.866Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1749.926 ms) ====== [2026-02-05T22:25:42.866Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-02-05T22:25:42.866Z] GC before operation: completed in 126.120 ms, heap usage 209.439 MB -> 69.666 MB. [2026-02-05T22:25:43.834Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1581.889 ms) ====== [2026-02-05T22:25:43.834Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-02-05T22:25:44.810Z] GC before operation: completed in 103.597 ms, heap usage 247.558 MB -> 69.891 MB. [2026-02-05T22:25:45.812Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1559.454 ms) ====== [2026-02-05T22:25:45.812Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-02-05T22:25:45.812Z] GC before operation: completed in 121.525 ms, heap usage 231.645 MB -> 69.980 MB. [2026-02-05T22:25:47.804Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1484.168 ms) ====== [2026-02-05T22:25:47.804Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-02-05T22:25:47.804Z] GC before operation: completed in 108.939 ms, heap usage 245.526 MB -> 70.200 MB. [2026-02-05T22:25:48.771Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1448.945 ms) ====== [2026-02-05T22:25:48.771Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-02-05T22:25:48.771Z] GC before operation: completed in 110.932 ms, heap usage 154.992 MB -> 70.053 MB. [2026-02-05T22:25:50.757Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1431.758 ms) ====== [2026-02-05T22:25:50.757Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-02-05T22:25:50.757Z] GC before operation: completed in 120.827 ms, heap usage 232.981 MB -> 70.525 MB. [2026-02-05T22:25:52.748Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1500.624 ms) ====== [2026-02-05T22:25:52.748Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-02-05T22:25:52.748Z] GC before operation: completed in 125.980 ms, heap usage 155.184 MB -> 70.294 MB. [2026-02-05T22:25:53.720Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1435.000 ms) ====== [2026-02-05T22:25:53.720Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-02-05T22:25:53.720Z] GC before operation: completed in 134.635 ms, heap usage 142.207 MB -> 70.591 MB. [2026-02-05T22:25:55.716Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1458.023 ms) ====== [2026-02-05T22:25:55.716Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-02-05T22:25:55.716Z] GC before operation: completed in 128.511 ms, heap usage 334.693 MB -> 98.516 MB. [2026-02-05T22:25:56.689Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1372.036 ms) ====== [2026-02-05T22:25:56.689Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-02-05T22:25:56.689Z] GC before operation: completed in 119.159 ms, heap usage 274.005 MB -> 71.196 MB. [2026-02-05T22:25:58.674Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1298.670 ms) ====== [2026-02-05T22:25:58.674Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-02-05T22:25:58.674Z] GC before operation: completed in 127.869 ms, heap usage 140.883 MB -> 71.350 MB. [2026-02-05T22:25:59.642Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1289.483 ms) ====== [2026-02-05T22:25:59.642Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-02-05T22:25:59.642Z] GC before operation: completed in 126.475 ms, heap usage 246.687 MB -> 71.338 MB. [2026-02-05T22:26:00.981Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1342.758 ms) ====== [2026-02-05T22:26:00.981Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-02-05T22:26:00.981Z] GC before operation: completed in 134.791 ms, heap usage 187.464 MB -> 71.376 MB. [2026-02-05T22:26:02.988Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1283.267 ms) ====== [2026-02-05T22:26:02.988Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-02-05T22:26:02.988Z] GC before operation: completed in 133.149 ms, heap usage 242.124 MB -> 71.544 MB. [2026-02-05T22:26:03.955Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1286.710 ms) ====== [2026-02-05T22:26:03.955Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-02-05T22:26:03.955Z] GC before operation: completed in 126.451 ms, heap usage 243.146 MB -> 71.819 MB. [2026-02-05T22:26:05.948Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1273.552 ms) ====== [2026-02-05T22:26:05.948Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-02-05T22:26:05.948Z] GC before operation: completed in 148.897 ms, heap usage 156.096 MB -> 71.570 MB. [2026-02-05T22:26:06.917Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1214.271 ms) ====== [2026-02-05T22:26:06.917Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-02-05T22:26:06.917Z] GC before operation: completed in 137.558 ms, heap usage 354.342 MB -> 71.978 MB. [2026-02-05T22:26:08.917Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1410.506 ms) ====== [2026-02-05T22:26:08.917Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-02-05T22:26:08.917Z] GC before operation: completed in 138.070 ms, heap usage 239.667 MB -> 83.014 MB. [2026-02-05T22:26:09.888Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1410.549 ms) ====== [2026-02-05T22:26:09.889Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-02-05T22:26:09.889Z] GC before operation: completed in 150.187 ms, heap usage 214.070 MB -> 72.109 MB. [2026-02-05T22:26:11.880Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1317.606 ms) ====== [2026-02-05T22:26:11.880Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-02-05T22:26:11.880Z] GC before operation: completed in 148.786 ms, heap usage 142.640 MB -> 71.966 MB. [2026-02-05T22:26:12.848Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1173.100 ms) ====== [2026-02-05T22:26:12.848Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-02-05T22:26:12.848Z] GC before operation: completed in 165.019 ms, heap usage 310.523 MB -> 99.920 MB. [2026-02-05T22:26:12.848Z] 22:26:12.359 WARN [block-manager-storage-async-thread-pool-94] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1149_0, which does not exist [2026-02-05T22:26:13.818Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1254.168 ms) ====== [2026-02-05T22:26:13.818Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-02-05T22:26:14.790Z] GC before operation: completed in 142.113 ms, heap usage 213.465 MB -> 72.417 MB. [2026-02-05T22:26:15.766Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1280.789 ms) ====== [2026-02-05T22:26:15.766Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-02-05T22:26:15.766Z] GC before operation: completed in 162.514 ms, heap usage 291.071 MB -> 72.531 MB. [2026-02-05T22:26:16.733Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1274.953 ms) ====== [2026-02-05T22:26:16.733Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-02-05T22:26:16.733Z] GC before operation: completed in 146.790 ms, heap usage 243.828 MB -> 72.656 MB. [2026-02-05T22:26:18.726Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1355.911 ms) ====== [2026-02-05T22:26:18.726Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-02-05T22:26:18.726Z] GC before operation: completed in 147.974 ms, heap usage 245.532 MB -> 72.790 MB. [2026-02-05T22:26:19.695Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1249.367 ms) ====== [2026-02-05T22:26:19.695Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-02-05T22:26:19.695Z] GC before operation: completed in 172.837 ms, heap usage 174.382 MB -> 72.760 MB. [2026-02-05T22:26:21.688Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1316.760 ms) ====== [2026-02-05T22:26:21.688Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-02-05T22:26:21.688Z] GC before operation: completed in 187.451 ms, heap usage 245.216 MB -> 73.392 MB. [2026-02-05T22:26:22.655Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1163.864 ms) ====== [2026-02-05T22:26:22.655Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-02-05T22:26:22.655Z] GC before operation: completed in 153.759 ms, heap usage 523.965 MB -> 73.543 MB. [2026-02-05T22:26:24.646Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1335.744 ms) ====== [2026-02-05T22:26:24.646Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-02-05T22:26:24.646Z] GC before operation: completed in 149.858 ms, heap usage 280.319 MB -> 73.328 MB. [2026-02-05T22:26:25.613Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1179.237 ms) ====== [2026-02-05T22:26:25.613Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-02-05T22:26:25.613Z] GC before operation: completed in 160.814 ms, heap usage 243.551 MB -> 73.268 MB. [2026-02-05T22:26:26.584Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1245.362 ms) ====== [2026-02-05T22:26:26.584Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-02-05T22:26:27.554Z] GC before operation: completed in 159.176 ms, heap usage 244.733 MB -> 73.400 MB. [2026-02-05T22:26:28.519Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1191.874 ms) ====== [2026-02-05T22:26:28.519Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-02-05T22:26:28.519Z] GC before operation: completed in 160.230 ms, heap usage 310.597 MB -> 73.537 MB. [2026-02-05T22:26:29.488Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1334.431 ms) ====== [2026-02-05T22:26:29.488Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-02-05T22:26:30.458Z] GC before operation: completed in 152.792 ms, heap usage 247.730 MB -> 73.792 MB. [2026-02-05T22:26:31.431Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1489.829 ms) ====== [2026-02-05T22:26:31.431Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-02-05T22:26:31.431Z] GC before operation: completed in 161.466 ms, heap usage 248.695 MB -> 73.906 MB. [2026-02-05T22:26:32.402Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1205.642 ms) ====== [2026-02-05T22:26:32.402Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-02-05T22:26:33.372Z] GC before operation: completed in 162.606 ms, heap usage 201.051 MB -> 73.898 MB. [2026-02-05T22:26:34.344Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1498.293 ms) ====== [2026-02-05T22:26:34.344Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-02-05T22:26:34.344Z] GC before operation: completed in 163.325 ms, heap usage 247.412 MB -> 74.022 MB. [2026-02-05T22:26:36.333Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1396.679 ms) ====== [2026-02-05T22:26:36.333Z] ----------------------------------- [2026-02-05T22:26:36.333Z] renaissance-dec-tree_0_PASSED [2026-02-05T22:26:36.333Z] ----------------------------------- [2026-02-05T22:26:36.333Z] [2026-02-05T22:26:36.333Z] TEST TEARDOWN: [2026-02-05T22:26:36.333Z] Nothing to be done for teardown. [2026-02-05T22:26:36.333Z] renaissance-dec-tree_0 Finish Time: Thu Feb 5 22:26:35 2026 Epoch Time (ms): 1770330395971