[2024-08-10T10:07:00.439Z] Running test renaissance-dec-tree_0 ... [2024-08-10T10:07:00.439Z] =============================================== [2024-08-10T10:07:00.439Z] renaissance-dec-tree_0 Start Time: Sat Aug 10 10:07:00 2024 Epoch Time (ms): 1723284420090 [2024-08-10T10:07:00.439Z] variation: NoOptions [2024-08-10T10:07:00.439Z] JVM_OPTIONS: [2024-08-10T10:07:00.439Z] { \ [2024-08-10T10:07:00.439Z] echo ""; echo "TEST SETUP:"; \ [2024-08-10T10:07:00.439Z] echo "Nothing to be done for setup."; \ [2024-08-10T10:07:00.439Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232836225986/renaissance-dec-tree_0"; \ [2024-08-10T10:07:00.439Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232836225986/renaissance-dec-tree_0"; \ [2024-08-10T10:07:00.439Z] echo ""; echo "TESTING:"; \ [2024-08-10T10:07:00.439Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232836225986/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-10T10:07:00.439Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232836225986/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-10T10:07:00.439Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-10T10:07:00.439Z] echo "Nothing to be done for teardown."; \ [2024-08-10T10:07:00.439Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17232836225986/TestTargetResult"; [2024-08-10T10:07:00.439Z] [2024-08-10T10:07:00.439Z] TEST SETUP: [2024-08-10T10:07:00.439Z] Nothing to be done for setup. [2024-08-10T10:07:00.439Z] [2024-08-10T10:07:00.439Z] TESTING: [2024-08-10T10:07:03.931Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-10T10:07:07.442Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-10T10:07:12.407Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-10T10:07:12.407Z] GC before operation: completed in 90.999 ms, heap usage 41.466 MB -> 35.121 MB. [2024-08-10T10:07:28.811Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15274.346 ms) ====== [2024-08-10T10:07:28.811Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-10T10:07:28.811Z] GC before operation: completed in 185.678 ms, heap usage 190.393 MB -> 64.342 MB. [2024-08-10T10:07:32.373Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4179.830 ms) ====== [2024-08-10T10:07:32.373Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-10T10:07:32.373Z] GC before operation: completed in 214.301 ms, heap usage 135.795 MB -> 64.478 MB. [2024-08-10T10:07:35.903Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3598.510 ms) ====== [2024-08-10T10:07:35.903Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-10T10:07:35.903Z] GC before operation: completed in 154.958 ms, heap usage 335.882 MB -> 65.168 MB. [2024-08-10T10:07:39.427Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3510.819 ms) ====== [2024-08-10T10:07:39.427Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-10T10:07:39.427Z] GC before operation: completed in 174.747 ms, heap usage 233.552 MB -> 65.408 MB. [2024-08-10T10:07:42.944Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2859.005 ms) ====== [2024-08-10T10:07:42.944Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-10T10:07:42.944Z] GC before operation: completed in 177.085 ms, heap usage 211.258 MB -> 65.474 MB. [2024-08-10T10:07:45.678Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2557.400 ms) ====== [2024-08-10T10:07:45.678Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-10T10:07:45.678Z] GC before operation: completed in 166.669 ms, heap usage 101.137 MB -> 65.265 MB. [2024-08-10T10:07:48.198Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2655.322 ms) ====== [2024-08-10T10:07:48.198Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-10T10:07:48.198Z] GC before operation: completed in 147.363 ms, heap usage 261.860 MB -> 93.596 MB. [2024-08-10T10:07:50.738Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2705.953 ms) ====== [2024-08-10T10:07:50.738Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-10T10:07:51.526Z] GC before operation: completed in 166.931 ms, heap usage 355.156 MB -> 66.145 MB. [2024-08-10T10:07:54.065Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2642.179 ms) ====== [2024-08-10T10:07:54.065Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-10T10:07:54.065Z] GC before operation: completed in 183.689 ms, heap usage 336.201 MB -> 66.323 MB. [2024-08-10T10:07:56.603Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2930.358 ms) ====== [2024-08-10T10:07:56.603Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-10T10:07:57.393Z] GC before operation: completed in 173.560 ms, heap usage 316.882 MB -> 66.292 MB. [2024-08-10T10:07:59.967Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2491.194 ms) ====== [2024-08-10T10:07:59.967Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-10T10:07:59.967Z] GC before operation: completed in 187.538 ms, heap usage 172.138 MB -> 66.291 MB. [2024-08-10T10:08:02.507Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2533.179 ms) ====== [2024-08-10T10:08:02.507Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-10T10:08:02.507Z] GC before operation: completed in 186.217 ms, heap usage 311.154 MB -> 66.641 MB. [2024-08-10T10:08:05.044Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2256.120 ms) ====== [2024-08-10T10:08:05.044Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-10T10:08:05.044Z] GC before operation: completed in 200.993 ms, heap usage 159.597 MB -> 66.458 MB. [2024-08-10T10:08:07.577Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2240.229 ms) ====== [2024-08-10T10:08:07.577Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-10T10:08:07.577Z] GC before operation: completed in 206.700 ms, heap usage 200.339 MB -> 66.917 MB. [2024-08-10T10:08:10.685Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2466.855 ms) ====== [2024-08-10T10:08:10.685Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-10T10:08:10.685Z] GC before operation: completed in 210.105 ms, heap usage 266.798 MB -> 66.954 MB. [2024-08-10T10:08:12.335Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2281.453 ms) ====== [2024-08-10T10:08:12.335Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-10T10:08:12.335Z] GC before operation: completed in 205.941 ms, heap usage 111.830 MB -> 66.487 MB. [2024-08-10T10:08:14.873Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2421.810 ms) ====== [2024-08-10T10:08:14.873Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-10T10:08:14.873Z] GC before operation: completed in 223.317 ms, heap usage 482.109 MB -> 67.364 MB. [2024-08-10T10:08:17.399Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2451.655 ms) ====== [2024-08-10T10:08:17.399Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-10T10:08:18.195Z] GC before operation: completed in 223.044 ms, heap usage 282.702 MB -> 67.370 MB. [2024-08-10T10:08:20.743Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2404.170 ms) ====== [2024-08-10T10:08:20.743Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-10T10:08:20.743Z] GC before operation: completed in 212.508 ms, heap usage 185.717 MB -> 67.520 MB. [2024-08-10T10:08:23.287Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2247.778 ms) ====== [2024-08-10T10:08:23.287Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-10T10:08:23.287Z] GC before operation: completed in 241.647 ms, heap usage 246.621 MB -> 67.568 MB. [2024-08-10T10:08:24.917Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2158.016 ms) ====== [2024-08-10T10:08:24.917Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-10T10:08:25.712Z] GC before operation: completed in 197.016 ms, heap usage 242.567 MB -> 67.710 MB. [2024-08-10T10:08:28.267Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2400.353 ms) ====== [2024-08-10T10:08:28.267Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-10T10:08:28.267Z] GC before operation: completed in 129.113 ms, heap usage 278.079 MB -> 73.537 MB. [2024-08-10T10:08:29.895Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1598.407 ms) ====== [2024-08-10T10:08:29.895Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-10T10:08:29.895Z] GC before operation: completed in 123.499 ms, heap usage 232.773 MB -> 67.734 MB. [2024-08-10T10:08:31.521Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1563.942 ms) ====== [2024-08-10T10:08:31.521Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-10T10:08:31.521Z] GC before operation: completed in 123.739 ms, heap usage 146.901 MB -> 67.690 MB. [2024-08-10T10:08:33.148Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1617.719 ms) ====== [2024-08-10T10:08:33.148Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-10T10:08:33.148Z] GC before operation: completed in 94.706 ms, heap usage 223.760 MB -> 68.375 MB. [2024-08-10T10:08:34.775Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1631.646 ms) ====== [2024-08-10T10:08:34.775Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-10T10:08:34.775Z] GC before operation: completed in 128.322 ms, heap usage 299.622 MB -> 68.095 MB. [2024-08-10T10:08:36.405Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1624.803 ms) ====== [2024-08-10T10:08:36.406Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-10T10:08:36.406Z] GC before operation: completed in 151.860 ms, heap usage 286.813 MB -> 68.178 MB. [2024-08-10T10:08:38.031Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1585.419 ms) ====== [2024-08-10T10:08:38.031Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-10T10:08:38.031Z] GC before operation: completed in 124.606 ms, heap usage 302.206 MB -> 68.410 MB. [2024-08-10T10:08:39.653Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1623.484 ms) ====== [2024-08-10T10:08:39.653Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-10T10:08:40.450Z] GC before operation: completed in 147.835 ms, heap usage 284.021 MB -> 96.025 MB. [2024-08-10T10:08:42.098Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1722.542 ms) ====== [2024-08-10T10:08:42.098Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-10T10:08:42.098Z] GC before operation: completed in 140.628 ms, heap usage 325.104 MB -> 68.473 MB. [2024-08-10T10:08:44.032Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1594.062 ms) ====== [2024-08-10T10:08:44.032Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-10T10:08:44.032Z] GC before operation: completed in 194.742 ms, heap usage 310.475 MB -> 68.600 MB. [2024-08-10T10:08:45.655Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1522.530 ms) ====== [2024-08-10T10:08:45.655Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-10T10:08:45.655Z] GC before operation: completed in 142.080 ms, heap usage 294.212 MB -> 68.702 MB. [2024-08-10T10:08:46.446Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1446.763 ms) ====== [2024-08-10T10:08:46.446Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-10T10:08:47.232Z] GC before operation: completed in 100.970 ms, heap usage 286.583 MB -> 79.886 MB. [2024-08-10T10:08:48.018Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1222.424 ms) ====== [2024-08-10T10:08:48.018Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-10T10:08:48.018Z] GC before operation: completed in 103.289 ms, heap usage 145.778 MB -> 68.984 MB. [2024-08-10T10:08:49.644Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1237.814 ms) ====== [2024-08-10T10:08:49.644Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-10T10:08:49.644Z] GC before operation: completed in 101.192 ms, heap usage 131.449 MB -> 80.135 MB. [2024-08-10T10:08:51.266Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1385.096 ms) ====== [2024-08-10T10:08:51.266Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-10T10:08:51.266Z] GC before operation: completed in 106.034 ms, heap usage 234.878 MB -> 85.819 MB. [2024-08-10T10:08:52.050Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1268.195 ms) ====== [2024-08-10T10:08:52.050Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-10T10:08:52.836Z] GC before operation: completed in 107.051 ms, heap usage 432.110 MB -> 80.180 MB. [2024-08-10T10:08:53.622Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1193.174 ms) ====== [2024-08-10T10:08:53.622Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-10T10:08:53.622Z] GC before operation: completed in 103.462 ms, heap usage 169.842 MB -> 74.862 MB. [2024-08-10T10:08:53.622Z] 24/08/10 10:08:53 WARN BlockManager: Asked to remove block broadcast_526, which does not exist [2024-08-10T10:08:53.622Z] 24/08/10 10:08:53 WARN BlockManager: Asked to remove block broadcast_526_piece0, which does not exist [2024-08-10T10:08:55.242Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1386.243 ms) ====== [2024-08-10T10:08:55.242Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-10T10:08:55.242Z] GC before operation: completed in 101.054 ms, heap usage 313.314 MB -> 80.715 MB. [2024-08-10T10:08:56.028Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1168.197 ms) ====== [2024-08-10T10:08:56.814Z] ----------------------------------- [2024-08-10T10:08:56.814Z] renaissance-dec-tree_0_PASSED [2024-08-10T10:08:56.814Z] ----------------------------------- [2024-08-10T10:08:56.814Z] [2024-08-10T10:08:56.814Z] TEST TEARDOWN: [2024-08-10T10:08:56.814Z] Nothing to be done for teardown. [2024-08-10T10:08:56.814Z] renaissance-dec-tree_0 Finish Time: Sat Aug 10 10:08:56 2024 Epoch Time (ms): 1723284536195