[2026-01-24T15:31:53.991Z] Running test renaissance-dec-tree_0 ... [2026-01-24T15:31:53.991Z] =============================================== [2026-01-24T15:31:53.991Z] renaissance-dec-tree_0 Start Time: Sat Jan 24 15:31:53 2026 Epoch Time (ms): 1769268713496 [2026-01-24T15:31:53.991Z] variation: NoOptions [2026-01-24T15:31:53.991Z] JVM_OPTIONS: [2026-01-24T15:31:53.991Z] { \ [2026-01-24T15:31:53.991Z] echo ""; echo "TEST SETUP:"; \ [2026-01-24T15:31:53.991Z] echo "Nothing to be done for setup."; \ [2026-01-24T15:31:53.991Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17692679377638/renaissance-dec-tree_0"; \ [2026-01-24T15:31:53.991Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17692679377638/renaissance-dec-tree_0"; \ [2026-01-24T15:31:53.991Z] echo ""; echo "TESTING:"; \ [2026-01-24T15:31:53.992Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/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_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17692679377638/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-01-24T15:31:53.992Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17692679377638/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-01-24T15:31:53.992Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-01-24T15:31:53.992Z] echo "Nothing to be done for teardown."; \ [2026-01-24T15:31:53.992Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17692679377638/TestTargetResult"; [2026-01-24T15:31:53.992Z] [2026-01-24T15:31:53.992Z] TEST SETUP: [2026-01-24T15:31:53.992Z] Nothing to be done for setup. [2026-01-24T15:31:53.992Z] [2026-01-24T15:31:53.992Z] TESTING: [2026-01-24T15:31:55.603Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-01-24T15:31:55.603Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/output_17692679377638/renaissance-dec-tree_0/launcher-153153-15629679838732579908/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-01-24T15:31:55.603Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-01-24T15:31:55.603Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-01-24T15:32:21.558Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 16) threads. [2026-01-24T15:32:25.053Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-01-24T15:32:25.832Z] GC before operation: completed in 113.245 ms, heap usage 54.334 MB -> 34.591 MB. [2026-01-24T15:32:35.803Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9917.557 ms) ====== [2026-01-24T15:32:35.803Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-01-24T15:32:35.803Z] GC before operation: completed in 113.777 ms, heap usage 175.123 MB -> 70.183 MB. [2026-01-24T15:32:37.429Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2102.058 ms) ====== [2026-01-24T15:32:37.429Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-01-24T15:32:37.429Z] GC before operation: completed in 116.627 ms, heap usage 317.613 MB -> 70.679 MB. [2026-01-24T15:32:39.046Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1677.259 ms) ====== [2026-01-24T15:32:39.046Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-01-24T15:32:39.833Z] GC before operation: completed in 110.378 ms, heap usage 256.900 MB -> 71.261 MB. [2026-01-24T15:32:41.447Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1734.472 ms) ====== [2026-01-24T15:32:41.447Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-01-24T15:32:41.447Z] GC before operation: completed in 102.442 ms, heap usage 256.074 MB -> 71.271 MB. [2026-01-24T15:32:43.060Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1573.152 ms) ====== [2026-01-24T15:32:43.060Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-01-24T15:32:43.060Z] GC before operation: completed in 122.232 ms, heap usage 253.977 MB -> 71.369 MB. [2026-01-24T15:32:44.668Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1574.314 ms) ====== [2026-01-24T15:32:44.668Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-01-24T15:32:44.668Z] GC before operation: completed in 105.371 ms, heap usage 250.220 MB -> 71.711 MB. [2026-01-24T15:32:46.283Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1551.745 ms) ====== [2026-01-24T15:32:46.283Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-01-24T15:32:46.283Z] GC before operation: completed in 113.356 ms, heap usage 249.280 MB -> 71.914 MB. [2026-01-24T15:32:47.895Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1536.659 ms) ====== [2026-01-24T15:32:47.895Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-01-24T15:32:47.895Z] GC before operation: completed in 118.708 ms, heap usage 471.327 MB -> 72.157 MB. [2026-01-24T15:32:49.506Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1562.389 ms) ====== [2026-01-24T15:32:49.506Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-01-24T15:32:49.506Z] GC before operation: completed in 113.761 ms, heap usage 245.683 MB -> 72.032 MB. [2026-01-24T15:32:51.143Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1600.449 ms) ====== [2026-01-24T15:32:51.143Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-01-24T15:32:51.143Z] GC before operation: completed in 126.564 ms, heap usage 467.414 MB -> 72.516 MB. [2026-01-24T15:32:52.752Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1579.710 ms) ====== [2026-01-24T15:32:52.752Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-01-24T15:32:53.531Z] GC before operation: completed in 123.141 ms, heap usage 250.111 MB -> 72.421 MB. [2026-01-24T15:32:55.139Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1568.659 ms) ====== [2026-01-24T15:32:55.139Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-01-24T15:32:55.140Z] GC before operation: completed in 131.280 ms, heap usage 238.336 MB -> 72.405 MB. [2026-01-24T15:32:56.751Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1521.004 ms) ====== [2026-01-24T15:32:56.751Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-01-24T15:32:56.751Z] GC before operation: completed in 135.997 ms, heap usage 466.137 MB -> 73.138 MB. [2026-01-24T15:32:56.751Z] 15:32:56.056 WARN [block-manager-storage-async-thread-pool-55] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_177, which does not exist [2026-01-24T15:32:58.360Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1560.307 ms) ====== [2026-01-24T15:32:58.360Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-01-24T15:32:58.360Z] GC before operation: completed in 147.580 ms, heap usage 468.378 MB -> 100.466 MB. [2026-01-24T15:33:00.176Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1558.133 ms) ====== [2026-01-24T15:33:00.176Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-01-24T15:33:00.176Z] GC before operation: completed in 142.220 ms, heap usage 339.042 MB -> 72.924 MB. [2026-01-24T15:33:01.118Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1520.374 ms) ====== [2026-01-24T15:33:01.118Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-01-24T15:33:01.905Z] GC before operation: completed in 140.111 ms, heap usage 463.286 MB -> 73.301 MB. [2026-01-24T15:33:03.559Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1509.845 ms) ====== [2026-01-24T15:33:03.559Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-01-24T15:33:03.559Z] GC before operation: completed in 139.483 ms, heap usage 246.936 MB -> 73.190 MB. [2026-01-24T15:33:05.184Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1497.108 ms) ====== [2026-01-24T15:33:05.184Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-01-24T15:33:05.185Z] GC before operation: completed in 139.925 ms, heap usage 463.940 MB -> 84.253 MB. [2026-01-24T15:33:06.814Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1526.125 ms) ====== [2026-01-24T15:33:06.814Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-01-24T15:33:06.814Z] GC before operation: completed in 136.439 ms, heap usage 381.207 MB -> 73.347 MB. [2026-01-24T15:33:08.435Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1512.971 ms) ====== [2026-01-24T15:33:08.435Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-01-24T15:33:08.435Z] GC before operation: completed in 140.661 ms, heap usage 465.645 MB -> 73.569 MB. [2026-01-24T15:33:10.065Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1544.353 ms) ====== [2026-01-24T15:33:10.065Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-01-24T15:33:10.065Z] GC before operation: completed in 144.212 ms, heap usage 244.006 MB -> 73.788 MB. [2026-01-24T15:33:11.695Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1514.503 ms) ====== [2026-01-24T15:33:11.695Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-01-24T15:33:11.695Z] GC before operation: completed in 150.160 ms, heap usage 469.411 MB -> 79.584 MB. [2026-01-24T15:33:13.334Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1516.809 ms) ====== [2026-01-24T15:33:13.334Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-01-24T15:33:13.334Z] GC before operation: completed in 156.735 ms, heap usage 470.559 MB -> 74.033 MB. [2026-01-24T15:33:14.946Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1494.174 ms) ====== [2026-01-24T15:33:14.946Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-01-24T15:33:14.946Z] GC before operation: completed in 155.423 ms, heap usage 466.426 MB -> 79.429 MB. [2026-01-24T15:33:16.559Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1485.636 ms) ====== [2026-01-24T15:33:16.559Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-01-24T15:33:16.559Z] GC before operation: completed in 153.649 ms, heap usage 472.202 MB -> 79.750 MB. [2026-01-24T15:33:18.184Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1505.250 ms) ====== [2026-01-24T15:33:18.184Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-01-24T15:33:18.184Z] GC before operation: completed in 166.510 ms, heap usage 397.150 MB -> 85.253 MB. [2026-01-24T15:33:19.857Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1535.361 ms) ====== [2026-01-24T15:33:19.857Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-01-24T15:33:19.857Z] GC before operation: completed in 142.376 ms, heap usage 374.497 MB -> 74.439 MB. [2026-01-24T15:33:21.467Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1561.182 ms) ====== [2026-01-24T15:33:21.467Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-01-24T15:33:21.467Z] GC before operation: completed in 146.430 ms, heap usage 467.162 MB -> 85.692 MB. [2026-01-24T15:33:23.094Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1505.845 ms) ====== [2026-01-24T15:33:23.094Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-01-24T15:33:23.094Z] GC before operation: completed in 166.348 ms, heap usage 421.259 MB -> 101.915 MB. [2026-01-24T15:33:24.776Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1480.556 ms) ====== [2026-01-24T15:33:24.776Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-01-24T15:33:24.776Z] GC before operation: completed in 153.884 ms, heap usage 340.389 MB -> 74.396 MB. [2026-01-24T15:33:26.388Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1465.567 ms) ====== [2026-01-24T15:33:26.388Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-01-24T15:33:26.388Z] GC before operation: completed in 154.131 ms, heap usage 470.398 MB -> 80.164 MB. [2026-01-24T15:33:26.388Z] 15:33:26.033 WARN [block-manager-storage-async-thread-pool-95] org.apache.spark.storage.BlockManager - Asked to remove block rdd_1485_2, which does not exist [2026-01-24T15:33:28.002Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1490.753 ms) ====== [2026-01-24T15:33:28.002Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-01-24T15:33:28.002Z] GC before operation: completed in 154.753 ms, heap usage 416.851 MB -> 75.024 MB. [2026-01-24T15:33:29.611Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1482.525 ms) ====== [2026-01-24T15:33:29.611Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-01-24T15:33:29.611Z] GC before operation: completed in 157.992 ms, heap usage 468.887 MB -> 75.122 MB. [2026-01-24T15:33:31.244Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1509.727 ms) ====== [2026-01-24T15:33:31.244Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-01-24T15:33:31.244Z] GC before operation: completed in 163.706 ms, heap usage 465.676 MB -> 80.709 MB. [2026-01-24T15:33:32.867Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1495.567 ms) ====== [2026-01-24T15:33:32.867Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-01-24T15:33:32.867Z] GC before operation: completed in 159.826 ms, heap usage 249.987 MB -> 75.075 MB. [2026-01-24T15:33:34.491Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1428.014 ms) ====== [2026-01-24T15:33:34.491Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-01-24T15:33:34.491Z] GC before operation: completed in 178.737 ms, heap usage 466.711 MB -> 86.193 MB. [2026-01-24T15:33:36.101Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1440.844 ms) ====== [2026-01-24T15:33:36.101Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-01-24T15:33:36.101Z] GC before operation: completed in 140.159 ms, heap usage 381.012 MB -> 75.166 MB. [2026-01-24T15:33:37.711Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1555.378 ms) ====== [2026-01-24T15:33:37.711Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-01-24T15:33:37.711Z] GC before operation: completed in 131.120 ms, heap usage 467.556 MB -> 81.092 MB. [2026-01-24T15:33:39.321Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1409.982 ms) ====== [2026-01-24T15:33:39.321Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-01-24T15:33:39.321Z] GC before operation: completed in 150.675 ms, heap usage 474.817 MB -> 86.678 MB. [2026-01-24T15:33:40.933Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1435.354 ms) ====== [2026-01-24T15:33:41.713Z] ----------------------------------- [2026-01-24T15:33:41.713Z] renaissance-dec-tree_0_PASSED [2026-01-24T15:33:41.713Z] ----------------------------------- [2026-01-24T15:33:41.713Z] [2026-01-24T15:33:41.713Z] TEST TEARDOWN: [2026-01-24T15:33:41.713Z] Nothing to be done for teardown. [2026-01-24T15:33:41.713Z] renaissance-dec-tree_0 Finish Time: Sat Jan 24 15:33:40 2026 Epoch Time (ms): 1769268820940