[2025-06-27T20:48:44.856Z] Running test renaissance-dec-tree_0 ... [2025-06-27T20:48:44.856Z] =============================================== [2025-06-27T20:48:44.856Z] renaissance-dec-tree_0 Start Time: Fri Jun 27 20:48:44 2025 Epoch Time (ms): 1751057324565 [2025-06-27T20:48:44.856Z] variation: NoOptions [2025-06-27T20:48:44.856Z] JVM_OPTIONS: [2025-06-27T20:48:44.856Z] { \ [2025-06-27T20:48:44.856Z] echo ""; echo "TEST SETUP:"; \ [2025-06-27T20:48:44.856Z] echo "Nothing to be done for setup."; \ [2025-06-27T20:48:44.856Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17510568032680/renaissance-dec-tree_0"; \ [2025-06-27T20:48:44.856Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17510568032680/renaissance-dec-tree_0"; \ [2025-06-27T20:48:44.856Z] echo ""; echo "TESTING:"; \ [2025-06-27T20:48:44.856Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17510568032680/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-06-27T20:48:44.857Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17510568032680/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-27T20:48:44.857Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-27T20:48:44.857Z] echo "Nothing to be done for teardown."; \ [2025-06-27T20:48:44.857Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17510568032680/TestTargetResult"; [2025-06-27T20:48:44.857Z] [2025-06-27T20:48:44.857Z] TEST SETUP: [2025-06-27T20:48:44.857Z] Nothing to be done for setup. [2025-06-27T20:48:44.857Z] [2025-06-27T20:48:44.857Z] TESTING: [2025-06-27T20:48:50.146Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-06-27T20:48:53.125Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-06-27T20:48:53.125Z] GC before operation: completed in 60.834 ms, heap usage 50.914 MB -> 35.096 MB. [2025-06-27T20:49:01.176Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8919.675 ms) ====== [2025-06-27T20:49:01.176Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-06-27T20:49:02.118Z] GC before operation: completed in 92.455 ms, heap usage 175.612 MB -> 68.892 MB. [2025-06-27T20:49:04.039Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2056.754 ms) ====== [2025-06-27T20:49:04.040Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-06-27T20:49:04.040Z] GC before operation: completed in 111.350 ms, heap usage 296.392 MB -> 86.435 MB. [2025-06-27T20:49:04.040Z] 20:49:03.265 WARN [block-manager-storage-async-thread-pool-10] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_23_piece0, which does not exist [2025-06-27T20:49:05.961Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1765.701 ms) ====== [2025-06-27T20:49:05.961Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-06-27T20:49:05.961Z] GC before operation: completed in 94.320 ms, heap usage 365.677 MB -> 70.094 MB. [2025-06-27T20:49:07.884Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1713.053 ms) ====== [2025-06-27T20:49:07.884Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-06-27T20:49:07.884Z] GC before operation: completed in 95.245 ms, heap usage 234.863 MB -> 70.109 MB. [2025-06-27T20:49:08.820Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1707.463 ms) ====== [2025-06-27T20:49:08.820Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-06-27T20:49:09.758Z] GC before operation: completed in 114.111 ms, heap usage 145.987 MB -> 70.051 MB. [2025-06-27T20:49:10.693Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1657.857 ms) ====== [2025-06-27T20:49:10.693Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-06-27T20:49:10.693Z] GC before operation: completed in 92.890 ms, heap usage 336.797 MB -> 70.455 MB. [2025-06-27T20:49:12.613Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1626.114 ms) ====== [2025-06-27T20:49:12.613Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-06-27T20:49:12.613Z] GC before operation: completed in 97.430 ms, heap usage 111.313 MB -> 70.386 MB. [2025-06-27T20:49:14.538Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1669.935 ms) ====== [2025-06-27T20:49:14.538Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-06-27T20:49:14.538Z] GC before operation: completed in 116.354 ms, heap usage 241.510 MB -> 70.807 MB. [2025-06-27T20:49:16.462Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1572.748 ms) ====== [2025-06-27T20:49:16.462Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-06-27T20:49:16.462Z] GC before operation: completed in 104.020 ms, heap usage 111.296 MB -> 70.315 MB. [2025-06-27T20:49:18.384Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1650.186 ms) ====== [2025-06-27T20:49:18.385Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-06-27T20:49:18.385Z] GC before operation: completed in 117.075 ms, heap usage 234.569 MB -> 71.072 MB. [2025-06-27T20:49:19.324Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1610.961 ms) ====== [2025-06-27T20:49:19.324Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-06-27T20:49:19.324Z] GC before operation: completed in 110.634 ms, heap usage 112.575 MB -> 70.695 MB. [2025-06-27T20:49:21.306Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1594.530 ms) ====== [2025-06-27T20:49:21.306Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-06-27T20:49:22.240Z] GC before operation: completed in 119.037 ms, heap usage 256.334 MB -> 71.328 MB. [2025-06-27T20:49:23.185Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1546.562 ms) ====== [2025-06-27T20:49:23.186Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-06-27T20:49:23.186Z] GC before operation: completed in 108.411 ms, heap usage 108.490 MB -> 70.829 MB. [2025-06-27T20:49:25.106Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1552.428 ms) ====== [2025-06-27T20:49:25.106Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-06-27T20:49:25.106Z] GC before operation: completed in 118.876 ms, heap usage 227.663 MB -> 71.703 MB. [2025-06-27T20:49:26.042Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1569.756 ms) ====== [2025-06-27T20:49:26.043Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-06-27T20:49:26.043Z] GC before operation: completed in 110.920 ms, heap usage 395.540 MB -> 71.736 MB. [2025-06-27T20:49:27.963Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1594.644 ms) ====== [2025-06-27T20:49:27.963Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-06-27T20:49:27.963Z] GC before operation: completed in 118.149 ms, heap usage 395.789 MB -> 82.805 MB. [2025-06-27T20:49:29.887Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1536.534 ms) ====== [2025-06-27T20:49:29.887Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-06-27T20:49:29.887Z] GC before operation: completed in 118.262 ms, heap usage 281.323 MB -> 71.910 MB. [2025-06-27T20:49:31.809Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1574.821 ms) ====== [2025-06-27T20:49:31.809Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-06-27T20:49:31.809Z] GC before operation: completed in 125.738 ms, heap usage 396.907 MB -> 72.348 MB. [2025-06-27T20:49:32.746Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1510.618 ms) ====== [2025-06-27T20:49:32.746Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-06-27T20:49:32.746Z] GC before operation: completed in 126.438 ms, heap usage 383.005 MB -> 83.243 MB. [2025-06-27T20:49:34.668Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1536.085 ms) ====== [2025-06-27T20:49:34.668Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-06-27T20:49:34.668Z] GC before operation: completed in 129.438 ms, heap usage 222.261 MB -> 72.443 MB. [2025-06-27T20:49:36.590Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1540.236 ms) ====== [2025-06-27T20:49:36.590Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-06-27T20:49:36.590Z] GC before operation: completed in 126.745 ms, heap usage 384.535 MB -> 89.163 MB. [2025-06-27T20:49:38.513Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1503.393 ms) ====== [2025-06-27T20:49:38.513Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-06-27T20:49:38.513Z] GC before operation: completed in 131.994 ms, heap usage 472.213 MB -> 89.212 MB. [2025-06-27T20:49:39.447Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1554.988 ms) ====== [2025-06-27T20:49:39.447Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-06-27T20:49:39.447Z] GC before operation: completed in 123.215 ms, heap usage 162.771 MB -> 83.235 MB. [2025-06-27T20:49:41.370Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1515.617 ms) ====== [2025-06-27T20:49:41.370Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-06-27T20:49:41.370Z] GC before operation: completed in 117.908 ms, heap usage 506.348 MB -> 83.854 MB. [2025-06-27T20:49:43.316Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1489.148 ms) ====== [2025-06-27T20:49:43.317Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-06-27T20:49:43.317Z] GC before operation: completed in 136.925 ms, heap usage 247.447 MB -> 72.857 MB. [2025-06-27T20:49:44.253Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1520.029 ms) ====== [2025-06-27T20:49:44.253Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-06-27T20:49:45.186Z] GC before operation: completed in 132.143 ms, heap usage 372.782 MB -> 72.982 MB. [2025-06-27T20:49:46.119Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1480.304 ms) ====== [2025-06-27T20:49:46.119Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-06-27T20:49:46.119Z] GC before operation: completed in 139.341 ms, heap usage 385.077 MB -> 84.017 MB. [2025-06-27T20:49:48.057Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1504.214 ms) ====== [2025-06-27T20:49:48.057Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-06-27T20:49:48.057Z] GC before operation: completed in 136.420 ms, heap usage 223.859 MB -> 84.425 MB. [2025-06-27T20:49:50.036Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1528.646 ms) ====== [2025-06-27T20:49:50.036Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-06-27T20:49:50.036Z] GC before operation: completed in 141.057 ms, heap usage 176.022 MB -> 72.961 MB. [2025-06-27T20:49:50.971Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1483.835 ms) ====== [2025-06-27T20:49:50.971Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-06-27T20:49:50.971Z] GC before operation: completed in 137.809 ms, heap usage 309.905 MB -> 84.314 MB. [2025-06-27T20:49:52.924Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1485.464 ms) ====== [2025-06-27T20:49:52.925Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-06-27T20:49:52.925Z] GC before operation: completed in 126.286 ms, heap usage 194.354 MB -> 73.254 MB. [2025-06-27T20:49:54.845Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1516.589 ms) ====== [2025-06-27T20:49:54.845Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-06-27T20:49:54.845Z] GC before operation: completed in 153.107 ms, heap usage 320.583 MB -> 90.184 MB. [2025-06-27T20:49:55.780Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1502.966 ms) ====== [2025-06-27T20:49:55.780Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-06-27T20:49:55.780Z] GC before operation: completed in 155.543 ms, heap usage 460.335 MB -> 90.300 MB. [2025-06-27T20:49:57.743Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1484.856 ms) ====== [2025-06-27T20:49:57.743Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-06-27T20:49:57.743Z] GC before operation: completed in 144.503 ms, heap usage 467.993 MB -> 85.131 MB. [2025-06-27T20:49:59.664Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1543.109 ms) ====== [2025-06-27T20:49:59.664Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-06-27T20:49:59.664Z] GC before operation: completed in 146.328 ms, heap usage 134.166 MB -> 73.478 MB. [2025-06-27T20:50:00.600Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1483.268 ms) ====== [2025-06-27T20:50:00.600Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-06-27T20:50:01.538Z] GC before operation: completed in 128.523 ms, heap usage 215.029 MB -> 74.105 MB. [2025-06-27T20:50:02.479Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1466.697 ms) ====== [2025-06-27T20:50:02.479Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-06-27T20:50:02.479Z] GC before operation: completed in 145.293 ms, heap usage 366.921 MB -> 90.750 MB. [2025-06-27T20:50:04.397Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1476.513 ms) ====== [2025-06-27T20:50:04.397Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-06-27T20:50:04.397Z] GC before operation: completed in 144.557 ms, heap usage 451.320 MB -> 74.427 MB. [2025-06-27T20:50:05.512Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1472.073 ms) ====== [2025-06-27T20:50:05.512Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-06-27T20:50:06.450Z] GC before operation: completed in 139.946 ms, heap usage 359.179 MB -> 85.706 MB. [2025-06-27T20:50:07.394Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1460.946 ms) ====== [2025-06-27T20:50:07.394Z] ----------------------------------- [2025-06-27T20:50:07.394Z] renaissance-dec-tree_0_PASSED [2025-06-27T20:50:07.394Z] ----------------------------------- [2025-06-27T20:50:07.394Z] [2025-06-27T20:50:07.394Z] TEST TEARDOWN: [2025-06-27T20:50:07.394Z] Nothing to be done for teardown. [2025-06-27T20:50:07.394Z] renaissance-dec-tree_0 Finish Time: Fri Jun 27 20:50:07 2025 Epoch Time (ms): 1751057407189