[2024-08-09T22:20:46.898Z] Running test renaissance-dec-tree_0 ... [2024-08-09T22:20:46.898Z] =============================================== [2024-08-09T22:20:46.898Z] renaissance-dec-tree_0 Start Time: Fri Aug 9 22:20:46 2024 Epoch Time (ms): 1723242046337 [2024-08-09T22:20:46.898Z] variation: NoOptions [2024-08-09T22:20:46.898Z] JVM_OPTIONS: [2024-08-09T22:20:46.898Z] { \ [2024-08-09T22:20:46.898Z] echo ""; echo "TEST SETUP:"; \ [2024-08-09T22:20:46.898Z] echo "Nothing to be done for setup."; \ [2024-08-09T22:20:46.898Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17232416127160/renaissance-dec-tree_0"; \ [2024-08-09T22:20:46.898Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17232416127160/renaissance-dec-tree_0"; \ [2024-08-09T22:20:46.898Z] echo ""; echo "TESTING:"; \ [2024-08-09T22:20:46.898Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/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_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17232416127160/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-09T22:20:46.898Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17232416127160/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-09T22:20:46.898Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-09T22:20:46.898Z] echo "Nothing to be done for teardown."; \ [2024-08-09T22:20:46.898Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17232416127160/TestTargetResult"; [2024-08-09T22:20:46.898Z] [2024-08-09T22:20:46.898Z] TEST SETUP: [2024-08-09T22:20:46.898Z] Nothing to be done for setup. [2024-08-09T22:20:46.898Z] [2024-08-09T22:20:46.898Z] TESTING: [2024-08-09T22:20:49.885Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-09T22:20:50.824Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-09T22:20:53.814Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-09T22:20:53.814Z] GC before operation: completed in 49.508 ms, heap usage 70.601 MB -> 35.095 MB. [2024-08-09T22:21:02.060Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7010.887 ms) ====== [2024-08-09T22:21:02.060Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-09T22:21:02.060Z] GC before operation: completed in 89.819 ms, heap usage 122.973 MB -> 65.027 MB. [2024-08-09T22:21:03.021Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2090.229 ms) ====== [2024-08-09T22:21:03.021Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-09T22:21:03.962Z] GC before operation: completed in 103.838 ms, heap usage 286.837 MB -> 64.913 MB. [2024-08-09T22:21:04.903Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1748.680 ms) ====== [2024-08-09T22:21:04.903Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-09T22:21:04.903Z] GC before operation: completed in 75.888 ms, heap usage 297.160 MB -> 65.352 MB. [2024-08-09T22:21:06.835Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1623.287 ms) ====== [2024-08-09T22:21:06.835Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-09T22:21:06.835Z] GC before operation: completed in 88.299 ms, heap usage 159.743 MB -> 65.351 MB. [2024-08-09T22:21:08.773Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1595.425 ms) ====== [2024-08-09T22:21:08.773Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-09T22:21:08.773Z] GC before operation: completed in 78.007 ms, heap usage 328.843 MB -> 65.700 MB. [2024-08-09T22:21:10.706Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1602.658 ms) ====== [2024-08-09T22:21:10.706Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-09T22:21:10.707Z] GC before operation: completed in 83.199 ms, heap usage 145.652 MB -> 65.784 MB. [2024-08-09T22:21:11.648Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1565.217 ms) ====== [2024-08-09T22:21:11.648Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-09T22:21:11.648Z] GC before operation: completed in 97.816 ms, heap usage 308.207 MB -> 77.667 MB. [2024-08-09T22:21:13.591Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1566.117 ms) ====== [2024-08-09T22:21:13.591Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-09T22:21:13.591Z] GC before operation: completed in 96.742 ms, heap usage 207.931 MB -> 77.594 MB. [2024-08-09T22:21:15.562Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1510.367 ms) ====== [2024-08-09T22:21:15.562Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-09T22:21:15.562Z] GC before operation: completed in 84.444 ms, heap usage 153.246 MB -> 66.079 MB. [2024-08-09T22:21:16.504Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1506.525 ms) ====== [2024-08-09T22:21:16.504Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-09T22:21:16.504Z] GC before operation: completed in 96.509 ms, heap usage 275.942 MB -> 66.642 MB. [2024-08-09T22:21:18.449Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1515.269 ms) ====== [2024-08-09T22:21:18.449Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-09T22:21:18.449Z] GC before operation: completed in 106.263 ms, heap usage 332.499 MB -> 66.653 MB. [2024-08-09T22:21:20.382Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1843.802 ms) ====== [2024-08-09T22:21:20.382Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-09T22:21:20.382Z] GC before operation: completed in 98.683 ms, heap usage 286.434 MB -> 83.218 MB. [2024-08-09T22:21:22.314Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1538.172 ms) ====== [2024-08-09T22:21:22.314Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-09T22:21:22.314Z] GC before operation: completed in 98.938 ms, heap usage 210.041 MB -> 66.730 MB. [2024-08-09T22:21:23.265Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1494.646 ms) ====== [2024-08-09T22:21:23.265Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-09T22:21:23.265Z] GC before operation: completed in 102.705 ms, heap usage 322.668 MB -> 77.949 MB. [2024-08-09T22:21:25.209Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1512.303 ms) ====== [2024-08-09T22:21:25.209Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-09T22:21:25.209Z] GC before operation: completed in 90.029 ms, heap usage 196.747 MB -> 67.095 MB. [2024-08-09T22:21:27.141Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1455.677 ms) ====== [2024-08-09T22:21:27.141Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-09T22:21:27.141Z] GC before operation: completed in 112.797 ms, heap usage 310.845 MB -> 67.355 MB. [2024-08-09T22:21:28.082Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1495.377 ms) ====== [2024-08-09T22:21:28.082Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-09T22:21:28.083Z] GC before operation: completed in 101.432 ms, heap usage 294.722 MB -> 67.289 MB. [2024-08-09T22:21:30.017Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1511.587 ms) ====== [2024-08-09T22:21:30.017Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-09T22:21:30.017Z] GC before operation: completed in 97.384 ms, heap usage 304.212 MB -> 67.447 MB. [2024-08-09T22:21:31.981Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1498.548 ms) ====== [2024-08-09T22:21:31.981Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-09T22:21:31.981Z] GC before operation: completed in 91.005 ms, heap usage 295.321 MB -> 72.925 MB. [2024-08-09T22:21:32.922Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1467.189 ms) ====== [2024-08-09T22:21:32.922Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-09T22:21:32.922Z] GC before operation: completed in 99.841 ms, heap usage 247.259 MB -> 78.785 MB. [2024-08-09T22:21:34.855Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1462.116 ms) ====== [2024-08-09T22:21:34.856Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-09T22:21:34.856Z] GC before operation: completed in 105.042 ms, heap usage 173.050 MB -> 73.254 MB. [2024-08-09T22:21:36.829Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1455.160 ms) ====== [2024-08-09T22:21:36.829Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-09T22:21:36.829Z] GC before operation: completed in 91.027 ms, heap usage 193.224 MB -> 67.858 MB. [2024-08-09T22:21:37.787Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1401.786 ms) ====== [2024-08-09T22:21:37.787Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-09T22:21:37.787Z] GC before operation: completed in 102.886 ms, heap usage 298.506 MB -> 68.117 MB. [2024-08-09T22:21:39.724Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1441.631 ms) ====== [2024-08-09T22:21:39.724Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-09T22:21:39.724Z] GC before operation: completed in 105.536 ms, heap usage 288.185 MB -> 68.155 MB. [2024-08-09T22:21:40.667Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1435.441 ms) ====== [2024-08-09T22:21:40.667Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-09T22:21:40.667Z] GC before operation: completed in 97.780 ms, heap usage 303.197 MB -> 79.465 MB. [2024-08-09T22:21:42.596Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1424.708 ms) ====== [2024-08-09T22:21:42.596Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-09T22:21:42.596Z] GC before operation: completed in 92.106 ms, heap usage 198.252 MB -> 68.374 MB. [2024-08-09T22:21:43.539Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1438.485 ms) ====== [2024-08-09T22:21:43.539Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-09T22:21:44.479Z] GC before operation: completed in 92.171 ms, heap usage 297.614 MB -> 68.508 MB. [2024-08-09T22:21:45.422Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1424.440 ms) ====== [2024-08-09T22:21:45.422Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-09T22:21:45.422Z] GC before operation: completed in 104.575 ms, heap usage 289.244 MB -> 68.619 MB. [2024-08-09T22:21:47.355Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1436.936 ms) ====== [2024-08-09T22:21:47.355Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-09T22:21:47.356Z] GC before operation: completed in 102.506 ms, heap usage 285.502 MB -> 79.910 MB. [2024-08-09T22:21:48.330Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1425.878 ms) ====== [2024-08-09T22:21:48.330Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-09T22:21:48.330Z] GC before operation: completed in 98.221 ms, heap usage 118.555 MB -> 68.144 MB. [2024-08-09T22:21:50.266Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1436.106 ms) ====== [2024-08-09T22:21:50.266Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-09T22:21:50.266Z] GC before operation: completed in 106.459 ms, heap usage 463.906 MB -> 90.943 MB. [2024-08-09T22:21:51.207Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1452.916 ms) ====== [2024-08-09T22:21:51.207Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-09T22:21:52.167Z] GC before operation: completed in 95.669 ms, heap usage 353.855 MB -> 68.817 MB. [2024-08-09T22:21:53.119Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1432.773 ms) ====== [2024-08-09T22:21:53.119Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-09T22:21:53.119Z] GC before operation: completed in 98.891 ms, heap usage 271.335 MB -> 68.938 MB. [2024-08-09T22:21:55.057Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1442.021 ms) ====== [2024-08-09T22:21:55.057Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-09T22:21:55.057Z] GC before operation: completed in 100.364 ms, heap usage 117.243 MB -> 68.663 MB. [2024-08-09T22:21:56.014Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1447.437 ms) ====== [2024-08-09T22:21:56.014Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-09T22:21:56.014Z] GC before operation: completed in 108.990 ms, heap usage 112.326 MB -> 79.942 MB. [2024-08-09T22:21:57.951Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1450.065 ms) ====== [2024-08-09T22:21:57.951Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-09T22:21:57.951Z] GC before operation: completed in 100.670 ms, heap usage 333.235 MB -> 85.891 MB. [2024-08-09T22:21:58.893Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1454.931 ms) ====== [2024-08-09T22:21:58.893Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-09T22:22:00.539Z] GC before operation: completed in 95.958 ms, heap usage 221.589 MB -> 80.684 MB. [2024-08-09T22:22:01.676Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1465.329 ms) ====== [2024-08-09T22:22:01.676Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-09T22:22:01.676Z] GC before operation: completed in 110.928 ms, heap usage 309.056 MB -> 97.120 MB. [2024-08-09T22:22:01.676Z] 24/08/09 22:22:00 WARN BlockManager: Asked to remove block broadcast_526, which does not exist [2024-08-09T22:22:01.676Z] 24/08/09 22:22:00 WARN BlockManager: Asked to remove block broadcast_526_piece0, which does not exist [2024-08-09T22:22:02.654Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1423.942 ms) ====== [2024-08-09T22:22:02.654Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-09T22:22:02.654Z] GC before operation: completed in 93.310 ms, heap usage 313.485 MB -> 69.789 MB. [2024-08-09T22:22:03.595Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1397.085 ms) ====== [2024-08-09T22:22:04.537Z] ----------------------------------- [2024-08-09T22:22:04.537Z] renaissance-dec-tree_0_PASSED [2024-08-09T22:22:04.537Z] ----------------------------------- [2024-08-09T22:22:04.537Z] [2024-08-09T22:22:04.537Z] TEST TEARDOWN: [2024-08-09T22:22:04.537Z] Nothing to be done for teardown. [2024-08-09T22:22:04.537Z] renaissance-dec-tree_0 Finish Time: Fri Aug 9 22:22:03 2024 Epoch Time (ms): 1723242123613