[2026-01-21T12:02:32.847Z] Running test renaissance-dec-tree_0 ... [2026-01-21T12:02:32.847Z] =============================================== [2026-01-21T12:02:32.847Z] renaissance-dec-tree_0 Start Time: Wed Jan 21 12:02:32 2026 Epoch Time (ms): 1768996952155 [2026-01-21T12:02:32.847Z] variation: NoOptions [2026-01-21T12:02:32.847Z] JVM_OPTIONS: [2026-01-21T12:02:32.847Z] { \ [2026-01-21T12:02:32.847Z] echo ""; echo "TEST SETUP:"; \ [2026-01-21T12:02:32.847Z] echo "Nothing to be done for setup."; \ [2026-01-21T12:02:32.847Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689963894637/renaissance-dec-tree_0"; \ [2026-01-21T12:02:32.847Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689963894637/renaissance-dec-tree_0"; \ [2026-01-21T12:02:32.847Z] echo ""; echo "TESTING:"; \ [2026-01-21T12:02:32.848Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689963894637/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-21T12:02:32.848Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689963894637/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-21T12:02:32.848Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-21T12:02:32.848Z] echo "Nothing to be done for teardown."; \ [2026-01-21T12:02:32.848Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17689963894637/TestTargetResult"; [2026-01-21T12:02:32.848Z] [2026-01-21T12:02:32.848Z] TEST SETUP: [2026-01-21T12:02:32.848Z] Nothing to be done for setup. [2026-01-21T12:02:32.848Z] [2026-01-21T12:02:32.848Z] TESTING: [2026-01-21T12:02:32.848Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-21T12:02:32.848Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17689963894637/renaissance-dec-tree_0/launcher-120232-8409734528133910761/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-21T12:02:32.848Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-21T12:02:32.848Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-21T12:02:38.309Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-01-21T12:02:40.298Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-21T12:02:40.298Z] GC before operation: completed in 45.695 ms, heap usage 38.640 MB -> 34.968 MB. [2026-01-21T12:02:48.580Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8557.318 ms) ====== [2026-01-21T12:02:48.580Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-21T12:02:48.580Z] GC before operation: completed in 96.180 ms, heap usage 202.991 MB -> 68.645 MB. [2026-01-21T12:02:50.569Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2082.522 ms) ====== [2026-01-21T12:02:50.569Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-21T12:02:50.569Z] GC before operation: completed in 78.255 ms, heap usage 120.946 MB -> 69.383 MB. [2026-01-21T12:02:52.560Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1723.569 ms) ====== [2026-01-21T12:02:52.560Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-21T12:02:52.560Z] GC before operation: completed in 71.622 ms, heap usage 347.083 MB -> 69.533 MB. [2026-01-21T12:02:54.550Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1705.617 ms) ====== [2026-01-21T12:02:54.550Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-21T12:02:54.550Z] GC before operation: completed in 71.493 ms, heap usage 110.948 MB -> 69.275 MB. [2026-01-21T12:02:56.549Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1600.679 ms) ====== [2026-01-21T12:02:56.549Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-21T12:02:56.549Z] GC before operation: completed in 90.308 ms, heap usage 167.192 MB -> 69.640 MB. [2026-01-21T12:02:57.520Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1692.420 ms) ====== [2026-01-21T12:02:57.520Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-21T12:02:58.491Z] GC before operation: completed in 85.114 ms, heap usage 106.101 MB -> 69.859 MB. [2026-01-21T12:02:59.462Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1568.073 ms) ====== [2026-01-21T12:02:59.462Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-21T12:02:59.462Z] GC before operation: completed in 87.242 ms, heap usage 525.723 MB -> 70.507 MB. [2026-01-21T12:03:01.452Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1612.129 ms) ====== [2026-01-21T12:03:01.452Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-21T12:03:01.452Z] GC before operation: completed in 82.185 ms, heap usage 207.456 MB -> 98.153 MB. [2026-01-21T12:03:02.422Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1486.025 ms) ====== [2026-01-21T12:03:02.422Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-21T12:03:03.395Z] GC before operation: completed in 86.984 ms, heap usage 410.837 MB -> 81.689 MB. [2026-01-21T12:03:04.364Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1532.940 ms) ====== [2026-01-21T12:03:04.364Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-21T12:03:04.364Z] GC before operation: completed in 70.404 ms, heap usage 258.107 MB -> 70.828 MB. [2026-01-21T12:03:06.354Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1496.583 ms) ====== [2026-01-21T12:03:06.354Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-21T12:03:06.354Z] GC before operation: completed in 72.796 ms, heap usage 159.000 MB -> 70.677 MB. [2026-01-21T12:03:07.324Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1554.723 ms) ====== [2026-01-21T12:03:07.324Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-21T12:03:07.324Z] GC before operation: completed in 75.984 ms, heap usage 252.493 MB -> 71.101 MB. [2026-01-21T12:03:09.315Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1603.029 ms) ====== [2026-01-21T12:03:09.315Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-21T12:03:09.315Z] GC before operation: completed in 98.288 ms, heap usage 105.814 MB -> 70.496 MB. [2026-01-21T12:03:11.488Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1587.122 ms) ====== [2026-01-21T12:03:11.488Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-21T12:03:11.488Z] GC before operation: completed in 89.813 ms, heap usage 254.223 MB -> 71.262 MB. [2026-01-21T12:03:12.472Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1519.096 ms) ====== [2026-01-21T12:03:12.472Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-21T12:03:12.472Z] GC before operation: completed in 91.334 ms, heap usage 413.930 MB -> 71.791 MB. [2026-01-21T12:03:14.464Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1605.353 ms) ====== [2026-01-21T12:03:14.464Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-21T12:03:14.464Z] GC before operation: completed in 96.162 ms, heap usage 207.108 MB -> 71.542 MB. [2026-01-21T12:03:16.455Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1553.108 ms) ====== [2026-01-21T12:03:16.455Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-21T12:03:16.456Z] GC before operation: completed in 98.870 ms, heap usage 258.012 MB -> 71.564 MB. [2026-01-21T12:03:17.426Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1465.445 ms) ====== [2026-01-21T12:03:17.426Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-21T12:03:17.426Z] GC before operation: completed in 117.080 ms, heap usage 106.601 MB -> 71.464 MB. [2026-01-21T12:03:19.416Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1554.704 ms) ====== [2026-01-21T12:03:19.416Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-21T12:03:19.416Z] GC before operation: completed in 99.256 ms, heap usage 255.057 MB -> 71.913 MB. [2026-01-21T12:03:20.386Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1449.357 ms) ====== [2026-01-21T12:03:20.386Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-21T12:03:21.356Z] GC before operation: completed in 94.081 ms, heap usage 158.044 MB -> 71.931 MB. [2026-01-21T12:03:22.327Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1538.824 ms) ====== [2026-01-21T12:03:22.327Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-21T12:03:22.327Z] GC before operation: completed in 94.347 ms, heap usage 253.139 MB -> 83.297 MB. [2026-01-21T12:03:24.325Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1450.241 ms) ====== [2026-01-21T12:03:24.325Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-21T12:03:24.325Z] GC before operation: completed in 100.023 ms, heap usage 280.617 MB -> 72.299 MB. [2026-01-21T12:03:26.015Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1594.457 ms) ====== [2026-01-21T12:03:26.015Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-21T12:03:26.015Z] GC before operation: completed in 98.487 ms, heap usage 254.121 MB -> 72.662 MB. [2026-01-21T12:03:26.984Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1401.415 ms) ====== [2026-01-21T12:03:26.984Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-21T12:03:26.984Z] GC before operation: completed in 100.287 ms, heap usage 358.854 MB -> 72.358 MB. [2026-01-21T12:03:28.978Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1563.634 ms) ====== [2026-01-21T12:03:28.978Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-21T12:03:28.978Z] GC before operation: completed in 100.594 ms, heap usage 202.211 MB -> 72.376 MB. [2026-01-21T12:03:29.949Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1427.837 ms) ====== [2026-01-21T12:03:29.949Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-21T12:03:30.918Z] GC before operation: completed in 109.136 ms, heap usage 456.654 MB -> 72.824 MB. [2026-01-21T12:03:31.888Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1526.537 ms) ====== [2026-01-21T12:03:31.888Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-21T12:03:31.888Z] GC before operation: completed in 99.542 ms, heap usage 175.351 MB -> 72.402 MB. [2026-01-21T12:03:33.903Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1547.071 ms) ====== [2026-01-21T12:03:33.903Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-21T12:03:33.903Z] GC before operation: completed in 117.441 ms, heap usage 240.372 MB -> 72.875 MB. [2026-01-21T12:03:34.875Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1538.063 ms) ====== [2026-01-21T12:03:34.875Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-21T12:03:35.845Z] GC before operation: completed in 96.830 ms, heap usage 209.625 MB -> 72.812 MB. [2026-01-21T12:03:36.838Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1513.190 ms) ====== [2026-01-21T12:03:36.838Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-21T12:03:36.838Z] GC before operation: completed in 116.892 ms, heap usage 256.604 MB -> 84.224 MB. [2026-01-21T12:03:38.835Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1516.946 ms) ====== [2026-01-21T12:03:38.835Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-21T12:03:38.835Z] GC before operation: completed in 107.270 ms, heap usage 113.122 MB -> 72.577 MB. [2026-01-21T12:03:39.804Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1497.751 ms) ====== [2026-01-21T12:03:39.804Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-21T12:03:39.804Z] GC before operation: completed in 100.072 ms, heap usage 176.528 MB -> 72.870 MB. [2026-01-21T12:03:41.793Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1488.974 ms) ====== [2026-01-21T12:03:41.793Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-21T12:03:41.793Z] GC before operation: completed in 104.330 ms, heap usage 253.222 MB -> 90.058 MB. [2026-01-21T12:03:43.785Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1491.723 ms) ====== [2026-01-21T12:03:43.785Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-21T12:03:43.785Z] GC before operation: completed in 107.477 ms, heap usage 263.432 MB -> 73.535 MB. [2026-01-21T12:03:44.778Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1503.492 ms) ====== [2026-01-21T12:03:44.778Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-21T12:03:44.778Z] GC before operation: completed in 112.508 ms, heap usage 144.532 MB -> 101.203 MB. [2026-01-21T12:03:44.778Z] 12:03:44.496 WARN [block-manager-storage-async-thread-pool-85] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1677_1, which does not exist [2026-01-21T12:03:46.779Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1478.567 ms) ====== [2026-01-21T12:03:46.779Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-21T12:03:46.779Z] GC before operation: completed in 110.548 ms, heap usage 123.288 MB -> 73.151 MB. [2026-01-21T12:03:47.762Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1409.598 ms) ====== [2026-01-21T12:03:47.762Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-21T12:03:47.762Z] GC before operation: completed in 83.014 ms, heap usage 249.337 MB -> 85.056 MB. [2026-01-21T12:03:49.773Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1458.379 ms) ====== [2026-01-21T12:03:49.773Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-21T12:03:49.773Z] GC before operation: completed in 104.049 ms, heap usage 215.602 MB -> 73.910 MB. [2026-01-21T12:03:51.767Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1526.115 ms) ====== [2026-01-21T12:03:51.767Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-21T12:03:51.767Z] GC before operation: completed in 97.955 ms, heap usage 133.140 MB -> 73.727 MB. [2026-01-21T12:03:52.737Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1449.465 ms) ====== [2026-01-21T12:03:52.737Z] ----------------------------------- [2026-01-21T12:03:52.737Z] renaissance-dec-tree_0_PASSED [2026-01-21T12:03:52.737Z] ----------------------------------- [2026-01-21T12:03:52.737Z] [2026-01-21T12:03:52.737Z] TEST TEARDOWN: [2026-01-21T12:03:52.737Z] Nothing to be done for teardown. [2026-01-21T12:03:52.737Z] renaissance-dec-tree_0 Finish Time: Wed Jan 21 12:03:52 2026 Epoch Time (ms): 1768997032457