[2024-08-16T16:22:22.829Z] Running test renaissance-dec-tree_0 ... [2024-08-16T16:22:22.829Z] =============================================== [2024-08-16T16:22:23.280Z] renaissance-dec-tree_0 Start Time: Fri Aug 16 09:22:22 2024 Epoch Time (ms): 1723825342731 [2024-08-16T16:22:23.280Z] variation: NoOptions [2024-08-16T16:22:23.280Z] JVM_OPTIONS: [2024-08-16T16:22:23.280Z] { \ [2024-08-16T16:22:23.280Z] echo ""; echo "TEST SETUP:"; \ [2024-08-16T16:22:23.280Z] echo "Nothing to be done for setup."; \ [2024-08-16T16:22:23.280Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17238249671784/renaissance-dec-tree_0"; \ [2024-08-16T16:22:23.280Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17238249671784/renaissance-dec-tree_0"; \ [2024-08-16T16:22:23.280Z] echo ""; echo "TESTING:"; \ [2024-08-16T16:22:23.280Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17238249671784/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-16T16:22:23.280Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17238249671784/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-16T16:22:23.280Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-16T16:22:23.280Z] echo "Nothing to be done for teardown."; \ [2024-08-16T16:22:23.280Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17238249671784/TestTargetResult"; [2024-08-16T16:22:23.280Z] [2024-08-16T16:22:23.280Z] TEST SETUP: [2024-08-16T16:22:23.280Z] Nothing to be done for setup. [2024-08-16T16:22:23.280Z] [2024-08-16T16:22:23.280Z] TESTING: [2024-08-16T16:22:38.747Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-16T16:22:43.740Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-08-16T16:23:02.016Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-16T16:23:02.016Z] GC before operation: completed in 116.895 ms, heap usage 47.414 MB -> 35.708 MB. [2024-08-16T16:23:47.590Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (45350.949 ms) ====== [2024-08-16T16:23:47.590Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-16T16:23:47.590Z] GC before operation: completed in 180.696 ms, heap usage 291.845 MB -> 65.167 MB. [2024-08-16T16:23:59.761Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (13389.695 ms) ====== [2024-08-16T16:23:59.761Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-16T16:23:59.761Z] GC before operation: completed in 223.228 ms, heap usage 207.184 MB -> 65.304 MB. [2024-08-16T16:24:09.603Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (10389.443 ms) ====== [2024-08-16T16:24:09.603Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-16T16:24:09.603Z] GC before operation: completed in 308.673 ms, heap usage 224.844 MB -> 93.384 MB. [2024-08-16T16:24:21.840Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (11733.347 ms) ====== [2024-08-16T16:24:21.840Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-16T16:24:21.840Z] GC before operation: completed in 300.989 ms, heap usage 183.560 MB -> 78.619 MB. [2024-08-16T16:24:32.335Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (10654.907 ms) ====== [2024-08-16T16:24:32.335Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-16T16:24:33.088Z] GC before operation: completed in 612.632 ms, heap usage 384.764 MB -> 93.625 MB. [2024-08-16T16:24:40.806Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (8106.700 ms) ====== [2024-08-16T16:24:40.806Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-16T16:24:41.439Z] GC before operation: completed in 356.691 ms, heap usage 466.409 MB -> 66.442 MB. [2024-08-16T16:24:48.429Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6599.266 ms) ====== [2024-08-16T16:24:48.429Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-16T16:24:48.429Z] GC before operation: completed in 338.879 ms, heap usage 310.482 MB -> 94.063 MB. [2024-08-16T16:24:56.752Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (8542.345 ms) ====== [2024-08-16T16:24:56.752Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-16T16:24:57.383Z] GC before operation: completed in 373.353 ms, heap usage 451.342 MB -> 66.647 MB. [2024-08-16T16:25:06.967Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (8492.638 ms) ====== [2024-08-16T16:25:06.967Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-16T16:25:06.967Z] GC before operation: completed in 400.018 ms, heap usage 287.393 MB -> 94.386 MB. [2024-08-16T16:25:14.558Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (8434.635 ms) ====== [2024-08-16T16:25:14.558Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-16T16:25:15.037Z] GC before operation: completed in 348.131 ms, heap usage 306.177 MB -> 94.526 MB. [2024-08-16T16:25:22.907Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (7420.045 ms) ====== [2024-08-16T16:25:22.907Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-16T16:25:23.362Z] GC before operation: completed in 1004.773 ms, heap usage 478.083 MB -> 67.359 MB. [2024-08-16T16:25:31.563Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (7535.831 ms) ====== [2024-08-16T16:25:31.563Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-16T16:25:31.563Z] GC before operation: completed in 393.647 ms, heap usage 469.056 MB -> 67.211 MB. [2024-08-16T16:25:37.037Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (5339.561 ms) ====== [2024-08-16T16:25:37.037Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-16T16:25:37.037Z] GC before operation: completed in 215.489 ms, heap usage 381.666 MB -> 67.614 MB. [2024-08-16T16:25:46.376Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (8850.458 ms) ====== [2024-08-16T16:25:46.376Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-16T16:25:46.376Z] GC before operation: completed in 405.288 ms, heap usage 165.829 MB -> 66.960 MB. [2024-08-16T16:25:54.546Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (7670.064 ms) ====== [2024-08-16T16:25:54.546Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-16T16:25:54.546Z] GC before operation: completed in 273.649 ms, heap usage 296.365 MB -> 67.479 MB. [2024-08-16T16:26:00.617Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5983.351 ms) ====== [2024-08-16T16:26:00.617Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-16T16:26:00.617Z] GC before operation: completed in 188.948 ms, heap usage 310.591 MB -> 67.571 MB. [2024-08-16T16:26:07.572Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (6783.684 ms) ====== [2024-08-16T16:26:07.572Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-16T16:26:07.572Z] GC before operation: completed in 167.279 ms, heap usage 233.293 MB -> 67.775 MB. [2024-08-16T16:26:13.992Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6558.195 ms) ====== [2024-08-16T16:26:13.992Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-16T16:26:13.993Z] GC before operation: completed in 153.354 ms, heap usage 283.108 MB -> 67.739 MB. [2024-08-16T16:26:21.738Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (7207.347 ms) ====== [2024-08-16T16:26:21.738Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-16T16:26:21.738Z] GC before operation: completed in 192.974 ms, heap usage 282.577 MB -> 67.986 MB. [2024-08-16T16:26:26.912Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4723.318 ms) ====== [2024-08-16T16:26:26.912Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-16T16:26:26.912Z] GC before operation: completed in 321.435 ms, heap usage 213.960 MB -> 70.165 MB. [2024-08-16T16:26:33.495Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (6935.655 ms) ====== [2024-08-16T16:26:33.495Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-16T16:26:33.495Z] GC before operation: completed in 218.692 ms, heap usage 113.068 MB -> 68.037 MB. [2024-08-16T16:26:41.260Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (7052.317 ms) ====== [2024-08-16T16:26:41.260Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-16T16:26:41.260Z] GC before operation: completed in 208.712 ms, heap usage 281.427 MB -> 68.287 MB. [2024-08-16T16:26:48.719Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (6997.440 ms) ====== [2024-08-16T16:26:48.719Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-16T16:26:48.719Z] GC before operation: completed in 715.098 ms, heap usage 298.558 MB -> 68.428 MB. [2024-08-16T16:26:55.161Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (5890.309 ms) ====== [2024-08-16T16:26:55.161Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-16T16:26:55.161Z] GC before operation: completed in 311.443 ms, heap usage 256.872 MB -> 68.432 MB. [2024-08-16T16:26:59.242Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (4382.359 ms) ====== [2024-08-16T16:26:59.242Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-16T16:26:59.773Z] GC before operation: completed in 487.743 ms, heap usage 131.543 MB -> 68.263 MB. [2024-08-16T16:27:07.703Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (7818.904 ms) ====== [2024-08-16T16:27:07.703Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-16T16:27:07.703Z] GC before operation: completed in 301.245 ms, heap usage 362.332 MB -> 96.165 MB. [2024-08-16T16:27:15.449Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (7945.512 ms) ====== [2024-08-16T16:27:15.449Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-16T16:27:15.875Z] GC before operation: completed in 227.991 ms, heap usage 288.057 MB -> 68.718 MB. [2024-08-16T16:27:22.056Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (6292.193 ms) ====== [2024-08-16T16:27:22.056Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-16T16:27:22.474Z] GC before operation: completed in 201.798 ms, heap usage 152.928 MB -> 68.545 MB. [2024-08-16T16:27:28.815Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (5392.187 ms) ====== [2024-08-16T16:27:28.815Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-16T16:27:28.815Z] GC before operation: completed in 494.644 ms, heap usage 334.082 MB -> 96.630 MB. [2024-08-16T16:27:36.611Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (8139.232 ms) ====== [2024-08-16T16:27:36.611Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-16T16:27:36.611Z] GC before operation: completed in 308.539 ms, heap usage 440.133 MB -> 96.704 MB. [2024-08-16T16:27:43.081Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (5605.926 ms) ====== [2024-08-16T16:27:43.081Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-16T16:27:43.081Z] GC before operation: completed in 370.606 ms, heap usage 436.484 MB -> 69.154 MB. [2024-08-16T16:27:47.954Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (5167.017 ms) ====== [2024-08-16T16:27:47.954Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-16T16:27:47.954Z] GC before operation: completed in 262.358 ms, heap usage 279.657 MB -> 69.575 MB. [2024-08-16T16:27:55.148Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (6985.538 ms) ====== [2024-08-16T16:27:55.148Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-16T16:27:55.148Z] GC before operation: completed in 234.882 ms, heap usage 261.229 MB -> 69.370 MB. [2024-08-16T16:28:01.879Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (6212.365 ms) ====== [2024-08-16T16:28:01.880Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-16T16:28:01.880Z] GC before operation: completed in 225.497 ms, heap usage 261.387 MB -> 69.526 MB. [2024-08-16T16:28:08.174Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (6250.491 ms) ====== [2024-08-16T16:28:08.174Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-16T16:28:08.174Z] GC before operation: completed in 261.077 ms, heap usage 442.955 MB -> 69.912 MB. [2024-08-16T16:28:14.663Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (6521.964 ms) ====== [2024-08-16T16:28:14.663Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-16T16:28:15.292Z] GC before operation: completed in 260.404 ms, heap usage 436.283 MB -> 69.876 MB. [2024-08-16T16:28:20.551Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (5089.168 ms) ====== [2024-08-16T16:28:20.551Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-16T16:28:20.551Z] GC before operation: completed in 314.926 ms, heap usage 313.691 MB -> 69.810 MB. [2024-08-16T16:28:26.721Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6107.824 ms) ====== [2024-08-16T16:28:26.721Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-16T16:28:26.721Z] GC before operation: completed in 216.635 ms, heap usage 211.959 MB -> 69.952 MB. [2024-08-16T16:28:31.700Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4570.271 ms) ====== [2024-08-16T16:28:31.701Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-16T16:28:32.174Z] GC before operation: completed in 868.027 ms, heap usage 254.354 MB -> 69.881 MB. [2024-08-16T16:28:38.229Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5301.691 ms) ====== [2024-08-16T16:28:39.848Z] ----------------------------------- [2024-08-16T16:28:39.848Z] renaissance-dec-tree_0_PASSED [2024-08-16T16:28:39.848Z] ----------------------------------- [2024-08-16T16:28:39.848Z] [2024-08-16T16:28:39.848Z] TEST TEARDOWN: [2024-08-16T16:28:39.848Z] Nothing to be done for teardown. [2024-08-16T16:28:39.848Z] renaissance-dec-tree_0 Finish Time: Fri Aug 16 09:28:39 2024 Epoch Time (ms): 1723825719286