[2025-01-22T00:32:13.552Z] Running test renaissance-dec-tree_0 ... [2025-01-22T00:32:13.552Z] =============================================== [2025-01-22T00:32:13.552Z] renaissance-dec-tree_0 Start Time: Wed Jan 22 00:32:13 2025 Epoch Time (ms): 1737505933177 [2025-01-22T00:32:13.552Z] variation: NoOptions [2025-01-22T00:32:13.552Z] JVM_OPTIONS: [2025-01-22T00:32:13.552Z] { \ [2025-01-22T00:32:13.552Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T00:32:13.552Z] echo "Nothing to be done for setup."; \ [2025-01-22T00:32:13.552Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17375054946497/renaissance-dec-tree_0"; \ [2025-01-22T00:32:13.552Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17375054946497/renaissance-dec-tree_0"; \ [2025-01-22T00:32:13.552Z] echo ""; echo "TESTING:"; \ [2025-01-22T00:32:13.552Z] "/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_17375054946497/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-01-22T00:32:13.552Z] 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_17375054946497/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T00:32:13.552Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T00:32:13.552Z] echo "Nothing to be done for teardown."; \ [2025-01-22T00:32:13.552Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17375054946497/TestTargetResult"; [2025-01-22T00:32:13.552Z] [2025-01-22T00:32:13.552Z] TEST SETUP: [2025-01-22T00:32:13.552Z] Nothing to be done for setup. [2025-01-22T00:32:13.552Z] [2025-01-22T00:32:13.552Z] TESTING: [2025-01-22T00:32:16.564Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-22T00:32:18.516Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-01-22T00:32:21.529Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-01-22T00:32:21.529Z] GC before operation: completed in 57.331 ms, heap usage 88.091 MB -> 35.266 MB. [2025-01-22T00:32:28.969Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6966.188 ms) ====== [2025-01-22T00:32:28.969Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-01-22T00:32:28.969Z] GC before operation: completed in 81.253 ms, heap usage 179.665 MB -> 64.548 MB. [2025-01-22T00:32:30.922Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2171.685 ms) ====== [2025-01-22T00:32:30.922Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-01-22T00:32:30.922Z] GC before operation: completed in 77.002 ms, heap usage 193.475 MB -> 65.269 MB. [2025-01-22T00:32:32.875Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1718.887 ms) ====== [2025-01-22T00:32:32.875Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-01-22T00:32:32.875Z] GC before operation: completed in 81.306 ms, heap usage 275.851 MB -> 65.697 MB. [2025-01-22T00:32:33.828Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1615.792 ms) ====== [2025-01-22T00:32:33.828Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-01-22T00:32:33.828Z] GC before operation: completed in 79.425 ms, heap usage 149.656 MB -> 65.638 MB. [2025-01-22T00:32:35.785Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1596.761 ms) ====== [2025-01-22T00:32:35.785Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-01-22T00:32:35.785Z] GC before operation: completed in 82.010 ms, heap usage 302.128 MB -> 66.137 MB. [2025-01-22T00:32:37.737Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1553.696 ms) ====== [2025-01-22T00:32:37.737Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-01-22T00:32:37.737Z] GC before operation: completed in 81.896 ms, heap usage 339.748 MB -> 66.224 MB. [2025-01-22T00:32:38.688Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1524.950 ms) ====== [2025-01-22T00:32:38.688Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-01-22T00:32:38.688Z] GC before operation: completed in 86.807 ms, heap usage 332.820 MB -> 66.613 MB. [2025-01-22T00:32:40.642Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1471.600 ms) ====== [2025-01-22T00:32:40.643Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-01-22T00:32:40.643Z] GC before operation: completed in 86.903 ms, heap usage 296.345 MB -> 77.720 MB. [2025-01-22T00:32:42.595Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1514.928 ms) ====== [2025-01-22T00:32:42.595Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-01-22T00:32:42.595Z] GC before operation: completed in 91.188 ms, heap usage 144.928 MB -> 77.439 MB. [2025-01-22T00:32:43.549Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1507.103 ms) ====== [2025-01-22T00:32:43.549Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-01-22T00:32:43.549Z] GC before operation: completed in 96.861 ms, heap usage 438.565 MB -> 78.365 MB. [2025-01-22T00:32:45.499Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1459.100 ms) ====== [2025-01-22T00:32:45.499Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-01-22T00:32:45.499Z] GC before operation: completed in 102.387 ms, heap usage 216.172 MB -> 78.295 MB. [2025-01-22T00:32:46.468Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1503.758 ms) ====== [2025-01-22T00:32:46.468Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-01-22T00:32:47.418Z] GC before operation: completed in 93.435 ms, heap usage 170.721 MB -> 77.685 MB. [2025-01-22T00:32:48.369Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1496.015 ms) ====== [2025-01-22T00:32:48.369Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-01-22T00:32:48.369Z] GC before operation: completed in 101.379 ms, heap usage 129.134 MB -> 66.635 MB. [2025-01-22T00:32:50.321Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1506.727 ms) ====== [2025-01-22T00:32:50.321Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-01-22T00:32:50.321Z] GC before operation: completed in 98.325 ms, heap usage 161.088 MB -> 67.035 MB. [2025-01-22T00:32:51.271Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1482.735 ms) ====== [2025-01-22T00:32:51.271Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-01-22T00:32:52.222Z] GC before operation: completed in 99.723 ms, heap usage 294.651 MB -> 67.585 MB. [2025-01-22T00:32:53.173Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1459.928 ms) ====== [2025-01-22T00:32:53.173Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-01-22T00:32:53.173Z] GC before operation: completed in 117.772 ms, heap usage 288.490 MB -> 67.800 MB. [2025-01-22T00:32:55.125Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1426.855 ms) ====== [2025-01-22T00:32:55.125Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-01-22T00:32:55.125Z] GC before operation: completed in 105.912 ms, heap usage 303.142 MB -> 67.775 MB. [2025-01-22T00:32:56.075Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1434.771 ms) ====== [2025-01-22T00:32:56.075Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-01-22T00:32:56.075Z] GC before operation: completed in 99.269 ms, heap usage 296.544 MB -> 67.792 MB. [2025-01-22T00:32:58.028Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1475.940 ms) ====== [2025-01-22T00:32:58.028Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-01-22T00:32:58.028Z] GC before operation: completed in 108.499 ms, heap usage 298.388 MB -> 68.050 MB. [2025-01-22T00:32:58.991Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1411.381 ms) ====== [2025-01-22T00:32:58.991Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-01-22T00:32:59.943Z] GC before operation: completed in 104.516 ms, heap usage 296.472 MB -> 67.986 MB. [2025-01-22T00:33:00.894Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1425.558 ms) ====== [2025-01-22T00:33:00.894Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-01-22T00:33:00.894Z] GC before operation: completed in 106.607 ms, heap usage 158.745 MB -> 67.836 MB. [2025-01-22T00:33:02.844Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1422.985 ms) ====== [2025-01-22T00:33:02.844Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-01-22T00:33:02.844Z] GC before operation: completed in 102.235 ms, heap usage 264.542 MB -> 68.210 MB. [2025-01-22T00:33:03.795Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1437.048 ms) ====== [2025-01-22T00:33:03.795Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-01-22T00:33:03.795Z] GC before operation: completed in 108.123 ms, heap usage 295.085 MB -> 79.403 MB. [2025-01-22T00:33:05.748Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1424.213 ms) ====== [2025-01-22T00:33:05.748Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-01-22T00:33:05.748Z] GC before operation: completed in 105.763 ms, heap usage 122.300 MB -> 67.864 MB. [2025-01-22T00:33:06.699Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1416.910 ms) ====== [2025-01-22T00:33:06.699Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-01-22T00:33:07.650Z] GC before operation: completed in 102.369 ms, heap usage 110.676 MB -> 68.354 MB. [2025-01-22T00:33:08.602Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1415.977 ms) ====== [2025-01-22T00:33:08.603Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-01-22T00:33:08.603Z] GC before operation: completed in 103.887 ms, heap usage 228.860 MB -> 68.843 MB. [2025-01-22T00:33:10.553Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1395.835 ms) ====== [2025-01-22T00:33:10.553Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-01-22T00:33:10.553Z] GC before operation: completed in 119.959 ms, heap usage 172.395 MB -> 79.346 MB. [2025-01-22T00:33:11.504Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1411.920 ms) ====== [2025-01-22T00:33:11.504Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-01-22T00:33:11.504Z] GC before operation: completed in 120.879 ms, heap usage 442.279 MB -> 80.131 MB. [2025-01-22T00:33:13.461Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1425.244 ms) ====== [2025-01-22T00:33:13.461Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-01-22T00:33:13.461Z] GC before operation: completed in 122.797 ms, heap usage 172.752 MB -> 68.829 MB. [2025-01-22T00:33:14.413Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1397.442 ms) ====== [2025-01-22T00:33:14.413Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-01-22T00:33:14.413Z] GC before operation: completed in 112.403 ms, heap usage 243.995 MB -> 80.394 MB. [2025-01-22T00:33:16.365Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1422.557 ms) ====== [2025-01-22T00:33:16.365Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-01-22T00:33:16.365Z] GC before operation: completed in 99.136 ms, heap usage 126.220 MB -> 68.788 MB. [2025-01-22T00:33:17.315Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1420.414 ms) ====== [2025-01-22T00:33:17.315Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-01-22T00:33:18.266Z] GC before operation: completed in 101.693 ms, heap usage 472.225 MB -> 69.566 MB. [2025-01-22T00:33:19.221Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1391.719 ms) ====== [2025-01-22T00:33:19.221Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-01-22T00:33:19.221Z] GC before operation: completed in 109.699 ms, heap usage 273.075 MB -> 80.754 MB. [2025-01-22T00:33:21.174Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1400.467 ms) ====== [2025-01-22T00:33:21.174Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-01-22T00:33:21.174Z] GC before operation: completed in 109.958 ms, heap usage 449.054 MB -> 69.781 MB. [2025-01-22T00:33:22.130Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1440.989 ms) ====== [2025-01-22T00:33:22.130Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-01-22T00:33:22.130Z] GC before operation: completed in 111.375 ms, heap usage 256.326 MB -> 69.717 MB. [2025-01-22T00:33:24.083Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1410.404 ms) ====== [2025-01-22T00:33:24.083Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-01-22T00:33:24.083Z] GC before operation: completed in 139.787 ms, heap usage 271.696 MB -> 69.853 MB. [2025-01-22T00:33:25.501Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1428.624 ms) ====== [2025-01-22T00:33:25.501Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-01-22T00:33:25.501Z] GC before operation: completed in 130.342 ms, heap usage 103.557 MB -> 97.063 MB. [2025-01-22T00:33:27.454Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1426.587 ms) ====== [2025-01-22T00:33:27.454Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-01-22T00:33:27.454Z] GC before operation: completed in 127.711 ms, heap usage 669.339 MB -> 86.593 MB. [2025-01-22T00:33:28.405Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1377.247 ms) ====== [2025-01-22T00:33:28.405Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-01-22T00:33:28.405Z] GC before operation: completed in 131.170 ms, heap usage 267.392 MB -> 81.299 MB. [2025-01-22T00:33:30.357Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1411.586 ms) ====== [2025-01-22T00:33:30.357Z] ----------------------------------- [2025-01-22T00:33:30.357Z] renaissance-dec-tree_0_PASSED [2025-01-22T00:33:30.357Z] ----------------------------------- [2025-01-22T00:33:30.357Z] [2025-01-22T00:33:30.357Z] TEST TEARDOWN: [2025-01-22T00:33:30.357Z] Nothing to be done for teardown. [2025-01-22T00:33:30.357Z] renaissance-dec-tree_0 Finish Time: Wed Jan 22 00:33:29 2025 Epoch Time (ms): 1737506009717