[2025-02-26T21:26:23.218Z] Running test renaissance-dec-tree_0 ... [2025-02-26T21:26:23.218Z] =============================================== [2025-02-26T21:26:23.218Z] renaissance-dec-tree_0 Start Time: Wed Feb 26 21:26:22 2025 Epoch Time (ms): 1740605182393 [2025-02-26T21:26:23.218Z] variation: NoOptions [2025-02-26T21:26:23.218Z] JVM_OPTIONS: [2025-02-26T21:26:23.218Z] { \ [2025-02-26T21:26:23.218Z] echo ""; echo "TEST SETUP:"; \ [2025-02-26T21:26:23.218Z] echo "Nothing to be done for setup."; \ [2025-02-26T21:26:23.218Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17406047564400/renaissance-dec-tree_0"; \ [2025-02-26T21:26:23.218Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17406047564400/renaissance-dec-tree_0"; \ [2025-02-26T21:26:23.218Z] echo ""; echo "TESTING:"; \ [2025-02-26T21:26:23.218Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17406047564400/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-26T21:26:23.218Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17406047564400/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-26T21:26:23.218Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-26T21:26:23.218Z] echo "Nothing to be done for teardown."; \ [2025-02-26T21:26:23.218Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17406047564400/TestTargetResult"; [2025-02-26T21:26:23.218Z] [2025-02-26T21:26:23.218Z] TEST SETUP: [2025-02-26T21:26:23.218Z] Nothing to be done for setup. [2025-02-26T21:26:23.218Z] [2025-02-26T21:26:23.218Z] TESTING: [2025-02-26T21:26:26.246Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-26T21:26:27.201Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-26T21:26:30.224Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-26T21:26:30.224Z] GC before operation: completed in 90.420 ms, heap usage 45.765 MB -> 35.160 MB. [2025-02-26T21:26:36.947Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6640.605 ms) ====== [2025-02-26T21:26:36.947Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-26T21:26:36.947Z] GC before operation: completed in 118.222 ms, heap usage 96.545 MB -> 64.500 MB. [2025-02-26T21:26:38.917Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2288.782 ms) ====== [2025-02-26T21:26:38.917Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-26T21:26:39.883Z] GC before operation: completed in 83.940 ms, heap usage 192.221 MB -> 86.780 MB. [2025-02-26T21:26:41.846Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1865.577 ms) ====== [2025-02-26T21:26:41.846Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-26T21:26:41.846Z] GC before operation: completed in 90.116 ms, heap usage 455.017 MB -> 65.560 MB. [2025-02-26T21:26:42.800Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1717.283 ms) ====== [2025-02-26T21:26:42.800Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-26T21:26:42.800Z] GC before operation: completed in 79.941 ms, heap usage 204.560 MB -> 65.592 MB. [2025-02-26T21:26:44.764Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1686.448 ms) ====== [2025-02-26T21:26:44.764Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-26T21:26:44.764Z] GC before operation: completed in 79.127 ms, heap usage 351.712 MB -> 65.810 MB. [2025-02-26T21:26:46.726Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1609.134 ms) ====== [2025-02-26T21:26:46.726Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-26T21:26:46.726Z] GC before operation: completed in 84.703 ms, heap usage 135.358 MB -> 65.733 MB. [2025-02-26T21:26:48.684Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1589.497 ms) ====== [2025-02-26T21:26:48.684Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-26T21:26:48.684Z] GC before operation: completed in 85.816 ms, heap usage 283.161 MB -> 66.133 MB. [2025-02-26T21:26:49.644Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1587.242 ms) ====== [2025-02-26T21:26:49.644Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-26T21:26:49.644Z] GC before operation: completed in 96.887 ms, heap usage 340.693 MB -> 77.183 MB. [2025-02-26T21:26:51.604Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1555.947 ms) ====== [2025-02-26T21:26:51.604Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-26T21:26:51.604Z] GC before operation: completed in 93.339 ms, heap usage 247.759 MB -> 66.507 MB. [2025-02-26T21:26:53.564Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1540.881 ms) ====== [2025-02-26T21:26:53.564Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-26T21:26:53.564Z] GC before operation: completed in 97.039 ms, heap usage 333.693 MB -> 66.443 MB. [2025-02-26T21:26:54.518Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1541.859 ms) ====== [2025-02-26T21:26:54.518Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-26T21:26:54.518Z] GC before operation: completed in 91.377 ms, heap usage 124.478 MB -> 66.431 MB. [2025-02-26T21:26:56.476Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1558.037 ms) ====== [2025-02-26T21:26:56.476Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-26T21:26:56.476Z] GC before operation: completed in 92.500 ms, heap usage 215.166 MB -> 66.791 MB. [2025-02-26T21:26:58.435Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1522.781 ms) ====== [2025-02-26T21:26:58.435Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-26T21:26:58.435Z] GC before operation: completed in 95.098 ms, heap usage 320.996 MB -> 83.545 MB. [2025-02-26T21:26:59.390Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1551.171 ms) ====== [2025-02-26T21:26:59.390Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-26T21:27:00.354Z] GC before operation: completed in 95.481 ms, heap usage 151.526 MB -> 77.496 MB. [2025-02-26T21:27:01.308Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1547.804 ms) ====== [2025-02-26T21:27:01.308Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-26T21:27:01.308Z] GC before operation: completed in 102.995 ms, heap usage 453.834 MB -> 94.838 MB. [2025-02-26T21:27:03.265Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1535.755 ms) ====== [2025-02-26T21:27:03.265Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-26T21:27:03.266Z] GC before operation: completed in 102.857 ms, heap usage 334.111 MB -> 67.384 MB. [2025-02-26T21:27:04.220Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1496.566 ms) ====== [2025-02-26T21:27:04.220Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-26T21:27:05.176Z] GC before operation: completed in 96.872 ms, heap usage 301.163 MB -> 67.548 MB. [2025-02-26T21:27:06.132Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1493.181 ms) ====== [2025-02-26T21:27:06.132Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-26T21:27:06.132Z] GC before operation: completed in 106.250 ms, heap usage 318.422 MB -> 78.640 MB. [2025-02-26T21:27:08.093Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1530.306 ms) ====== [2025-02-26T21:27:08.093Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-26T21:27:08.093Z] GC before operation: completed in 97.307 ms, heap usage 196.665 MB -> 67.557 MB. [2025-02-26T21:27:09.071Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1501.837 ms) ====== [2025-02-26T21:27:09.071Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-26T21:27:10.025Z] GC before operation: completed in 98.676 ms, heap usage 322.998 MB -> 67.820 MB. [2025-02-26T21:27:10.981Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1490.985 ms) ====== [2025-02-26T21:27:10.981Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-26T21:27:10.981Z] GC before operation: completed in 108.821 ms, heap usage 305.707 MB -> 79.037 MB. [2025-02-26T21:27:12.941Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1514.991 ms) ====== [2025-02-26T21:27:12.941Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-26T21:27:12.941Z] GC before operation: completed in 102.599 ms, heap usage 169.289 MB -> 84.293 MB. [2025-02-26T21:27:14.955Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1524.558 ms) ====== [2025-02-26T21:27:14.955Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-26T21:27:14.955Z] GC before operation: completed in 113.576 ms, heap usage 385.752 MB -> 67.935 MB. [2025-02-26T21:27:16.066Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1506.223 ms) ====== [2025-02-26T21:27:16.066Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-26T21:27:16.066Z] GC before operation: completed in 108.329 ms, heap usage 293.355 MB -> 73.479 MB. [2025-02-26T21:27:18.039Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1510.928 ms) ====== [2025-02-26T21:27:18.039Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-26T21:27:18.039Z] GC before operation: completed in 102.670 ms, heap usage 228.262 MB -> 68.317 MB. [2025-02-26T21:27:18.993Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1496.175 ms) ====== [2025-02-26T21:27:18.993Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-26T21:27:18.993Z] GC before operation: completed in 96.492 ms, heap usage 306.700 MB -> 74.046 MB. [2025-02-26T21:27:20.951Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1482.707 ms) ====== [2025-02-26T21:27:20.951Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-26T21:27:20.951Z] GC before operation: completed in 116.820 ms, heap usage 204.096 MB -> 68.496 MB. [2025-02-26T21:27:21.965Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1508.312 ms) ====== [2025-02-26T21:27:21.965Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-26T21:27:22.919Z] GC before operation: completed in 101.866 ms, heap usage 291.255 MB -> 79.567 MB. [2025-02-26T21:27:23.873Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1499.137 ms) ====== [2025-02-26T21:27:23.873Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-26T21:27:23.873Z] GC before operation: completed in 98.755 ms, heap usage 153.467 MB -> 68.666 MB. [2025-02-26T21:27:25.829Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1484.825 ms) ====== [2025-02-26T21:27:25.829Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-26T21:27:25.829Z] GC before operation: completed in 100.037 ms, heap usage 332.609 MB -> 68.683 MB. [2025-02-26T21:27:26.787Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1490.532 ms) ====== [2025-02-26T21:27:26.787Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-26T21:27:27.739Z] GC before operation: completed in 106.216 ms, heap usage 291.549 MB -> 80.037 MB. [2025-02-26T21:27:28.693Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1476.352 ms) ====== [2025-02-26T21:27:28.693Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-26T21:27:28.693Z] GC before operation: completed in 101.670 ms, heap usage 123.944 MB -> 90.769 MB. [2025-02-26T21:27:30.650Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1485.303 ms) ====== [2025-02-26T21:27:30.650Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-26T21:27:30.650Z] GC before operation: completed in 101.284 ms, heap usage 233.726 MB -> 69.127 MB. [2025-02-26T21:27:31.603Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1477.615 ms) ====== [2025-02-26T21:27:31.603Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-26T21:27:31.603Z] GC before operation: completed in 113.844 ms, heap usage 189.866 MB -> 69.130 MB. [2025-02-26T21:27:33.559Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1468.447 ms) ====== [2025-02-26T21:27:33.559Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-26T21:27:33.559Z] GC before operation: completed in 110.935 ms, heap usage 297.333 MB -> 69.231 MB. [2025-02-26T21:27:35.517Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1451.936 ms) ====== [2025-02-26T21:27:35.517Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-26T21:27:35.517Z] GC before operation: completed in 117.540 ms, heap usage 285.416 MB -> 75.124 MB. [2025-02-26T21:27:36.481Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1492.466 ms) ====== [2025-02-26T21:27:36.481Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-26T21:27:36.481Z] GC before operation: completed in 106.586 ms, heap usage 209.279 MB -> 85.946 MB. [2025-02-26T21:27:38.439Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1473.891 ms) ====== [2025-02-26T21:27:38.439Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-26T21:27:38.439Z] GC before operation: completed in 108.956 ms, heap usage 424.543 MB -> 86.209 MB. [2025-02-26T21:27:39.392Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1480.236 ms) ====== [2025-02-26T21:27:39.392Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-26T21:27:40.345Z] GC before operation: completed in 113.813 ms, heap usage 397.321 MB -> 80.433 MB. [2025-02-26T21:27:41.327Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1497.236 ms) ====== [2025-02-26T21:27:41.327Z] ----------------------------------- [2025-02-26T21:27:41.327Z] renaissance-dec-tree_0_PASSED [2025-02-26T21:27:41.327Z] ----------------------------------- [2025-02-26T21:27:41.327Z] [2025-02-26T21:27:41.327Z] TEST TEARDOWN: [2025-02-26T21:27:41.327Z] Nothing to be done for teardown. [2025-02-26T21:27:41.327Z] renaissance-dec-tree_0 Finish Time: Wed Feb 26 21:27:41 2025 Epoch Time (ms): 1740605261140