[2024-08-14T21:13:31.635Z] Running test renaissance-dec-tree_0 ... [2024-08-14T21:13:31.635Z] =============================================== [2024-08-14T21:13:31.635Z] renaissance-dec-tree_0 Start Time: Wed Aug 14 21:13:30 2024 Epoch Time (ms): 1723670010668 [2024-08-14T21:13:31.635Z] variation: NoOptions [2024-08-14T21:13:31.635Z] JVM_OPTIONS: [2024-08-14T21:13:31.635Z] { \ [2024-08-14T21:13:31.635Z] echo ""; echo "TEST SETUP:"; \ [2024-08-14T21:13:31.635Z] echo "Nothing to be done for setup."; \ [2024-08-14T21:13:31.635Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17236697185467/renaissance-dec-tree_0"; \ [2024-08-14T21:13:31.635Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17236697185467/renaissance-dec-tree_0"; \ [2024-08-14T21:13:31.635Z] echo ""; echo "TESTING:"; \ [2024-08-14T21:13:31.635Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17236697185467/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-14T21:13:31.635Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17236697185467/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-14T21:13:31.635Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-14T21:13:31.635Z] echo "Nothing to be done for teardown."; \ [2024-08-14T21:13:31.635Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17236697185467/TestTargetResult"; [2024-08-14T21:13:31.635Z] [2024-08-14T21:13:31.635Z] TEST SETUP: [2024-08-14T21:13:31.635Z] Nothing to be done for setup. [2024-08-14T21:13:31.635Z] [2024-08-14T21:13:31.635Z] TESTING: [2024-08-14T21:13:34.617Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-14T21:13:37.608Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-14T21:13:43.094Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-14T21:13:43.094Z] GC before operation: completed in 41.793 ms, heap usage 59.783 MB -> 37.156 MB. [2024-08-14T21:13:52.735Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9905.563 ms) ====== [2024-08-14T21:13:52.735Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-14T21:13:52.735Z] GC before operation: completed in 110.573 ms, heap usage 287.133 MB -> 68.754 MB. [2024-08-14T21:13:54.669Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2245.043 ms) ====== [2024-08-14T21:13:54.669Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-14T21:13:55.609Z] GC before operation: completed in 123.958 ms, heap usage 284.844 MB -> 69.490 MB. [2024-08-14T21:13:56.552Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1744.763 ms) ====== [2024-08-14T21:13:56.552Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-14T21:13:57.492Z] GC before operation: completed in 127.549 ms, heap usage 375.022 MB -> 69.411 MB. [2024-08-14T21:13:58.431Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1682.594 ms) ====== [2024-08-14T21:13:58.431Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-14T21:13:58.431Z] GC before operation: completed in 128.642 ms, heap usage 203.807 MB -> 69.770 MB. [2024-08-14T21:14:00.367Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1643.400 ms) ====== [2024-08-14T21:14:00.367Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-14T21:14:00.367Z] GC before operation: completed in 131.721 ms, heap usage 134.204 MB -> 69.691 MB. [2024-08-14T21:14:02.297Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1677.010 ms) ====== [2024-08-14T21:14:02.297Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-14T21:14:02.297Z] GC before operation: completed in 128.428 ms, heap usage 418.447 MB -> 70.223 MB. [2024-08-14T21:14:04.240Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1544.203 ms) ====== [2024-08-14T21:14:04.240Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-14T21:14:04.240Z] GC before operation: completed in 130.011 ms, heap usage 226.225 MB -> 70.248 MB. [2024-08-14T21:14:06.168Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1705.118 ms) ====== [2024-08-14T21:14:06.168Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-14T21:14:06.168Z] GC before operation: completed in 139.669 ms, heap usage 198.777 MB -> 70.514 MB. [2024-08-14T21:14:07.109Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1503.177 ms) ====== [2024-08-14T21:14:07.109Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-14T21:14:08.049Z] GC before operation: completed in 138.253 ms, heap usage 135.353 MB -> 70.370 MB. [2024-08-14T21:14:08.989Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1515.577 ms) ====== [2024-08-14T21:14:08.989Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-14T21:14:08.989Z] GC before operation: completed in 146.722 ms, heap usage 421.528 MB -> 76.100 MB. [2024-08-14T21:14:11.044Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1538.516 ms) ====== [2024-08-14T21:14:11.044Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-14T21:14:11.044Z] GC before operation: completed in 142.085 ms, heap usage 396.976 MB -> 70.914 MB. [2024-08-14T21:14:12.975Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1616.326 ms) ====== [2024-08-14T21:14:12.975Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-14T21:14:12.975Z] GC before operation: completed in 148.054 ms, heap usage 140.607 MB -> 70.683 MB. [2024-08-14T21:14:13.956Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1517.320 ms) ====== [2024-08-14T21:14:13.957Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-14T21:14:13.957Z] GC before operation: completed in 149.290 ms, heap usage 423.735 MB -> 71.136 MB. [2024-08-14T21:14:15.886Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1412.237 ms) ====== [2024-08-14T21:14:15.886Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-14T21:14:15.886Z] GC before operation: completed in 185.848 ms, heap usage 192.843 MB -> 71.074 MB. [2024-08-14T21:14:17.815Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1446.219 ms) ====== [2024-08-14T21:14:17.815Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-14T21:14:17.815Z] GC before operation: completed in 190.894 ms, heap usage 262.227 MB -> 71.341 MB. [2024-08-14T21:14:18.753Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1404.022 ms) ====== [2024-08-14T21:14:18.753Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-14T21:14:18.753Z] GC before operation: completed in 151.674 ms, heap usage 154.724 MB -> 71.328 MB. [2024-08-14T21:14:20.682Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1410.088 ms) ====== [2024-08-14T21:14:20.682Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-14T21:14:20.682Z] GC before operation: completed in 161.202 ms, heap usage 165.614 MB -> 71.113 MB. [2024-08-14T21:14:22.609Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1420.151 ms) ====== [2024-08-14T21:14:22.609Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-14T21:14:22.609Z] GC before operation: completed in 156.052 ms, heap usage 220.032 MB -> 71.469 MB. [2024-08-14T21:14:23.548Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1525.463 ms) ====== [2024-08-14T21:14:23.548Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-14T21:14:24.487Z] GC before operation: completed in 155.150 ms, heap usage 149.011 MB -> 87.810 MB. [2024-08-14T21:14:24.487Z] 24/08/14 21:14:23 WARN BlockManager: Asked to remove block rdd_928_2, which does not exist [2024-08-14T21:14:25.427Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1484.280 ms) ====== [2024-08-14T21:14:25.427Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-14T21:14:25.427Z] GC before operation: completed in 164.926 ms, heap usage 249.916 MB -> 71.711 MB. [2024-08-14T21:14:27.357Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1336.432 ms) ====== [2024-08-14T21:14:27.357Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-14T21:14:27.357Z] GC before operation: completed in 162.394 ms, heap usage 281.581 MB -> 71.813 MB. [2024-08-14T21:14:28.296Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1354.315 ms) ====== [2024-08-14T21:14:28.296Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-14T21:14:28.296Z] GC before operation: completed in 166.178 ms, heap usage 276.011 MB -> 72.095 MB. [2024-08-14T21:14:30.228Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1699.547 ms) ====== [2024-08-14T21:14:30.228Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-14T21:14:30.228Z] GC before operation: completed in 164.177 ms, heap usage 148.623 MB -> 71.766 MB. [2024-08-14T21:14:32.851Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1354.521 ms) ====== [2024-08-14T21:14:32.851Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-14T21:14:32.851Z] GC before operation: completed in 168.711 ms, heap usage 386.292 MB -> 77.563 MB. [2024-08-14T21:14:33.792Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1735.199 ms) ====== [2024-08-14T21:14:33.792Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-14T21:14:33.792Z] GC before operation: completed in 167.676 ms, heap usage 366.360 MB -> 72.390 MB. [2024-08-14T21:14:35.728Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1338.712 ms) ====== [2024-08-14T21:14:35.728Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-14T21:14:35.728Z] GC before operation: completed in 169.550 ms, heap usage 138.912 MB -> 72.059 MB. [2024-08-14T21:14:36.670Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1530.220 ms) ====== [2024-08-14T21:14:36.670Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-14T21:14:37.613Z] GC before operation: completed in 174.607 ms, heap usage 373.636 MB -> 83.760 MB. [2024-08-14T21:14:38.559Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1409.026 ms) ====== [2024-08-14T21:14:38.559Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-14T21:14:38.559Z] GC before operation: completed in 172.922 ms, heap usage 325.166 MB -> 72.583 MB. [2024-08-14T21:14:40.489Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1351.727 ms) ====== [2024-08-14T21:14:40.489Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-14T21:14:40.489Z] GC before operation: completed in 178.649 ms, heap usage 447.349 MB -> 84.022 MB. [2024-08-14T21:14:41.428Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1307.369 ms) ====== [2024-08-14T21:14:41.428Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-14T21:14:41.428Z] GC before operation: completed in 180.210 ms, heap usage 307.117 MB -> 83.673 MB. [2024-08-14T21:14:43.356Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1380.118 ms) ====== [2024-08-14T21:14:43.356Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-14T21:14:43.356Z] GC before operation: completed in 175.742 ms, heap usage 302.391 MB -> 72.902 MB. [2024-08-14T21:14:45.285Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1506.897 ms) ====== [2024-08-14T21:14:45.285Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-14T21:14:45.285Z] GC before operation: completed in 184.394 ms, heap usage 447.583 MB -> 73.588 MB. [2024-08-14T21:14:46.224Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1326.399 ms) ====== [2024-08-14T21:14:46.224Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-14T21:14:46.224Z] GC before operation: completed in 182.024 ms, heap usage 442.468 MB -> 84.398 MB. [2024-08-14T21:14:48.151Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1300.399 ms) ====== [2024-08-14T21:14:48.151Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-14T21:14:48.151Z] GC before operation: completed in 183.799 ms, heap usage 300.685 MB -> 73.235 MB. [2024-08-14T21:14:49.089Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1320.033 ms) ====== [2024-08-14T21:14:49.089Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-14T21:14:49.089Z] GC before operation: completed in 182.555 ms, heap usage 435.491 MB -> 84.459 MB. [2024-08-14T21:14:51.040Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1319.144 ms) ====== [2024-08-14T21:14:51.040Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-14T21:14:51.040Z] GC before operation: completed in 181.499 ms, heap usage 325.179 MB -> 78.845 MB. [2024-08-14T21:14:51.978Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1348.334 ms) ====== [2024-08-14T21:14:51.978Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-14T21:14:52.916Z] GC before operation: completed in 184.002 ms, heap usage 139.868 MB -> 73.246 MB. [2024-08-14T21:14:53.854Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1332.307 ms) ====== [2024-08-14T21:14:53.854Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-14T21:14:53.854Z] GC before operation: completed in 189.645 ms, heap usage 522.666 MB -> 79.261 MB. [2024-08-14T21:14:55.781Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1374.516 ms) ====== [2024-08-14T21:14:55.781Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-14T21:14:55.781Z] GC before operation: completed in 190.641 ms, heap usage 349.355 MB -> 84.635 MB. [2024-08-14T21:14:56.722Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1299.446 ms) ====== [2024-08-14T21:14:57.662Z] ----------------------------------- [2024-08-14T21:14:57.662Z] renaissance-dec-tree_0_PASSED [2024-08-14T21:14:57.662Z] ----------------------------------- [2024-08-14T21:14:57.662Z] [2024-08-14T21:14:57.662Z] TEST TEARDOWN: [2024-08-14T21:14:57.662Z] Nothing to be done for teardown. [2024-08-14T21:14:57.662Z] renaissance-dec-tree_0 Finish Time: Wed Aug 14 21:14:56 2024 Epoch Time (ms): 1723670096835