[2025-04-09T21:39:40.801Z] Running test renaissance-dec-tree_0 ... [2025-04-09T21:39:40.801Z] =============================================== [2025-04-09T21:39:40.801Z] renaissance-dec-tree_0 Start Time: Wed Apr 9 21:39:40 2025 Epoch Time (ms): 1744234780291 [2025-04-09T21:39:40.801Z] variation: NoOptions [2025-04-09T21:39:40.801Z] JVM_OPTIONS: [2025-04-09T21:39:40.801Z] { \ [2025-04-09T21:39:40.801Z] echo ""; echo "TEST SETUP:"; \ [2025-04-09T21:39:40.801Z] echo "Nothing to be done for setup."; \ [2025-04-09T21:39:40.801Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17442340591361/renaissance-dec-tree_0"; \ [2025-04-09T21:39:40.801Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17442340591361/renaissance-dec-tree_0"; \ [2025-04-09T21:39:40.801Z] echo ""; echo "TESTING:"; \ [2025-04-09T21:39:40.801Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_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_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17442340591361/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-04-09T21:39:40.801Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17442340591361/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-04-09T21:39:40.801Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-04-09T21:39:40.801Z] echo "Nothing to be done for teardown."; \ [2025-04-09T21:39:40.801Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17442340591361/TestTargetResult"; [2025-04-09T21:39:40.801Z] [2025-04-09T21:39:40.801Z] TEST SETUP: [2025-04-09T21:39:40.801Z] Nothing to be done for setup. [2025-04-09T21:39:40.801Z] [2025-04-09T21:39:40.801Z] TESTING: [2025-04-09T21:39:46.954Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2025-04-09T21:39:48.927Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-04-09T21:39:48.927Z] GC before operation: completed in 58.654 ms, heap usage 52.076 MB -> 36.424 MB. [2025-04-09T21:40:00.488Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10479.740 ms) ====== [2025-04-09T21:40:00.488Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-04-09T21:40:00.488Z] GC before operation: completed in 140.770 ms, heap usage 561.463 MB -> 72.906 MB. [2025-04-09T21:40:02.456Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2881.276 ms) ====== [2025-04-09T21:40:02.456Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-04-09T21:40:02.456Z] GC before operation: completed in 110.492 ms, heap usage 157.518 MB -> 72.577 MB. [2025-04-09T21:40:05.496Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2870.445 ms) ====== [2025-04-09T21:40:05.497Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-04-09T21:40:05.497Z] GC before operation: completed in 124.451 ms, heap usage 332.667 MB -> 73.302 MB. [2025-04-09T21:40:07.463Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2309.382 ms) ====== [2025-04-09T21:40:07.463Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-04-09T21:40:07.463Z] GC before operation: completed in 115.727 ms, heap usage 402.091 MB -> 73.389 MB. [2025-04-09T21:40:09.433Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1573.526 ms) ====== [2025-04-09T21:40:09.433Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-04-09T21:40:09.433Z] GC before operation: completed in 111.907 ms, heap usage 201.165 MB -> 73.453 MB. [2025-04-09T21:40:11.412Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1463.902 ms) ====== [2025-04-09T21:40:11.412Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-04-09T21:40:11.412Z] GC before operation: completed in 128.511 ms, heap usage 296.869 MB -> 73.967 MB. [2025-04-09T21:40:12.399Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1487.108 ms) ====== [2025-04-09T21:40:12.399Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-04-09T21:40:12.399Z] GC before operation: completed in 120.301 ms, heap usage 378.422 MB -> 74.203 MB. [2025-04-09T21:40:14.384Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1406.242 ms) ====== [2025-04-09T21:40:14.384Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-04-09T21:40:14.384Z] GC before operation: completed in 130.366 ms, heap usage 120.921 MB -> 73.682 MB. [2025-04-09T21:40:16.359Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1980.878 ms) ====== [2025-04-09T21:40:16.359Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-04-09T21:40:16.359Z] GC before operation: completed in 159.856 ms, heap usage 525.981 MB -> 74.690 MB. [2025-04-09T21:40:18.333Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1993.191 ms) ====== [2025-04-09T21:40:18.333Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-04-09T21:40:18.333Z] GC before operation: completed in 148.447 ms, heap usage 373.890 MB -> 74.585 MB. [2025-04-09T21:40:21.375Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2235.017 ms) ====== [2025-04-09T21:40:21.375Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-04-09T21:40:21.375Z] GC before operation: completed in 143.675 ms, heap usage 303.183 MB -> 74.976 MB. [2025-04-09T21:40:22.338Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1295.973 ms) ====== [2025-04-09T21:40:22.338Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-04-09T21:40:22.338Z] GC before operation: completed in 151.332 ms, heap usage 353.299 MB -> 102.457 MB. [2025-04-09T21:40:24.316Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1925.161 ms) ====== [2025-04-09T21:40:24.316Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-04-09T21:40:24.316Z] GC before operation: completed in 154.037 ms, heap usage 547.200 MB -> 97.719 MB. [2025-04-09T21:40:26.295Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1779.492 ms) ====== [2025-04-09T21:40:26.295Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-04-09T21:40:26.295Z] GC before operation: completed in 248.315 ms, heap usage 230.793 MB -> 75.204 MB. [2025-04-09T21:40:28.277Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1556.981 ms) ====== [2025-04-09T21:40:28.277Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-04-09T21:40:28.277Z] GC before operation: completed in 182.060 ms, heap usage 120.815 MB -> 74.412 MB. [2025-04-09T21:40:30.244Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1517.508 ms) ====== [2025-04-09T21:40:30.244Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-04-09T21:40:30.244Z] GC before operation: completed in 186.700 ms, heap usage 287.286 MB -> 75.388 MB. [2025-04-09T21:40:32.206Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1896.427 ms) ====== [2025-04-09T21:40:32.207Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-04-09T21:40:32.207Z] GC before operation: completed in 139.175 ms, heap usage 289.458 MB -> 97.453 MB. [2025-04-09T21:40:33.166Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1236.313 ms) ====== [2025-04-09T21:40:33.166Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-04-09T21:40:33.166Z] GC before operation: completed in 149.644 ms, heap usage 339.867 MB -> 75.634 MB. [2025-04-09T21:40:35.139Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1267.401 ms) ====== [2025-04-09T21:40:35.139Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-04-09T21:40:35.139Z] GC before operation: completed in 173.803 ms, heap usage 403.140 MB -> 75.958 MB. [2025-04-09T21:40:36.099Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1177.587 ms) ====== [2025-04-09T21:40:36.099Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-04-09T21:40:36.099Z] GC before operation: completed in 147.881 ms, heap usage 483.431 MB -> 75.725 MB. [2025-04-09T21:40:37.055Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1229.046 ms) ====== [2025-04-09T21:40:37.055Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-04-09T21:40:38.012Z] GC before operation: completed in 159.898 ms, heap usage 322.585 MB -> 76.210 MB. [2025-04-09T21:40:38.968Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1197.681 ms) ====== [2025-04-09T21:40:38.968Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-04-09T21:40:38.968Z] GC before operation: completed in 190.852 ms, heap usage 448.377 MB -> 76.174 MB. [2025-04-09T21:40:39.931Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1233.988 ms) ====== [2025-04-09T21:40:39.931Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-04-09T21:40:39.931Z] GC before operation: completed in 142.658 ms, heap usage 422.440 MB -> 76.200 MB. [2025-04-09T21:40:41.918Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1451.004 ms) ====== [2025-04-09T21:40:41.919Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-04-09T21:40:41.919Z] GC before operation: completed in 138.942 ms, heap usage 409.910 MB -> 76.179 MB. [2025-04-09T21:40:42.886Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1336.552 ms) ====== [2025-04-09T21:40:42.886Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-04-09T21:40:43.850Z] GC before operation: completed in 139.216 ms, heap usage 421.576 MB -> 76.523 MB. [2025-04-09T21:40:44.815Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1200.639 ms) ====== [2025-04-09T21:40:44.815Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-04-09T21:40:44.815Z] GC before operation: completed in 154.710 ms, heap usage 466.776 MB -> 76.569 MB. [2025-04-09T21:40:45.775Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1183.061 ms) ====== [2025-04-09T21:40:45.775Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-04-09T21:40:45.775Z] GC before operation: completed in 273.178 ms, heap usage 349.596 MB -> 76.714 MB. [2025-04-09T21:40:47.768Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1162.562 ms) ====== [2025-04-09T21:40:47.768Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-04-09T21:40:47.768Z] GC before operation: completed in 156.293 ms, heap usage 273.746 MB -> 76.604 MB. [2025-04-09T21:40:48.731Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1283.409 ms) ====== [2025-04-09T21:40:48.731Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-04-09T21:40:48.731Z] GC before operation: completed in 164.297 ms, heap usage 533.011 MB -> 88.196 MB. [2025-04-09T21:40:50.704Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1413.742 ms) ====== [2025-04-09T21:40:50.704Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-04-09T21:40:50.704Z] GC before operation: completed in 156.517 ms, heap usage 625.375 MB -> 104.856 MB. [2025-04-09T21:40:52.683Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1711.819 ms) ====== [2025-04-09T21:40:52.683Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-04-09T21:40:52.683Z] GC before operation: completed in 164.788 ms, heap usage 548.586 MB -> 77.288 MB. [2025-04-09T21:40:53.652Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1270.008 ms) ====== [2025-04-09T21:40:53.652Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-04-09T21:40:53.652Z] GC before operation: completed in 169.918 ms, heap usage 271.906 MB -> 77.189 MB. [2025-04-09T21:40:54.618Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1155.999 ms) ====== [2025-04-09T21:40:54.618Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-04-09T21:40:55.575Z] GC before operation: completed in 172.146 ms, heap usage 173.524 MB -> 76.889 MB. [2025-04-09T21:40:56.532Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1328.628 ms) ====== [2025-04-09T21:40:56.532Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-04-09T21:40:56.532Z] GC before operation: completed in 166.381 ms, heap usage 541.473 MB -> 77.675 MB. [2025-04-09T21:40:57.493Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1224.399 ms) ====== [2025-04-09T21:40:57.493Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-04-09T21:40:58.450Z] GC before operation: completed in 156.763 ms, heap usage 410.174 MB -> 77.575 MB. [2025-04-09T21:40:59.413Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1477.864 ms) ====== [2025-04-09T21:40:59.413Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-04-09T21:40:59.413Z] GC before operation: completed in 198.587 ms, heap usage 371.545 MB -> 77.698 MB. [2025-04-09T21:41:01.391Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1181.317 ms) ====== [2025-04-09T21:41:01.391Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-04-09T21:41:01.391Z] GC before operation: completed in 156.966 ms, heap usage 415.693 MB -> 77.729 MB. [2025-04-09T21:41:02.355Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1160.025 ms) ====== [2025-04-09T21:41:02.355Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-04-09T21:41:02.355Z] GC before operation: completed in 168.401 ms, heap usage 368.099 MB -> 77.697 MB. [2025-04-09T21:41:03.320Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1123.375 ms) ====== [2025-04-09T21:41:03.320Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-04-09T21:41:03.320Z] GC before operation: completed in 150.588 ms, heap usage 369.969 MB -> 105.488 MB. [2025-04-09T21:41:03.320Z] 21:41:03.112 WARN [block-manager-storage-async-thread-pool-60] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_541_piece0, which does not exist [2025-04-09T21:41:05.298Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1385.581 ms) ====== [2025-04-09T21:41:05.298Z] ----------------------------------- [2025-04-09T21:41:05.298Z] renaissance-dec-tree_0_PASSED [2025-04-09T21:41:05.298Z] ----------------------------------- [2025-04-09T21:41:05.298Z] [2025-04-09T21:41:05.298Z] TEST TEARDOWN: [2025-04-09T21:41:05.298Z] Nothing to be done for teardown. [2025-04-09T21:41:05.298Z] renaissance-dec-tree_0 Finish Time: Wed Apr 9 21:41:04 2025 Epoch Time (ms): 1744234864863