[2024-10-02T20:24:03.510Z] Running test renaissance-dec-tree_0 ... [2024-10-02T20:24:03.510Z] =============================================== [2024-10-02T20:24:03.510Z] renaissance-dec-tree_0 Start Time: Wed Oct 2 16:24:03 2024 Epoch Time (ms): 1727900643433 [2024-10-02T20:24:03.510Z] variation: NoOptions [2024-10-02T20:24:03.510Z] JVM_OPTIONS: [2024-10-02T20:24:03.510Z] { \ [2024-10-02T20:24:03.510Z] echo ""; echo "TEST SETUP:"; \ [2024-10-02T20:24:03.510Z] echo "Nothing to be done for setup."; \ [2024-10-02T20:24:03.510Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17279005025415/renaissance-dec-tree_0"; \ [2024-10-02T20:24:03.510Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17279005025415/renaissance-dec-tree_0"; \ [2024-10-02T20:24:03.510Z] echo ""; echo "TESTING:"; \ [2024-10-02T20:24:03.510Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/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_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17279005025415/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-02T20:24:03.510Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17279005025415/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-02T20:24:03.510Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-02T20:24:03.510Z] echo "Nothing to be done for teardown."; \ [2024-10-02T20:24:03.510Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17279005025415/TestTargetResult"; [2024-10-02T20:24:03.510Z] [2024-10-02T20:24:03.510Z] TEST SETUP: [2024-10-02T20:24:03.510Z] Nothing to be done for setup. [2024-10-02T20:24:03.510Z] [2024-10-02T20:24:03.510Z] TESTING: [2024-10-02T20:24:05.981Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-02T20:24:06.753Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-10-02T20:24:09.187Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-02T20:24:09.187Z] GC before operation: completed in 31.441 ms, heap usage 51.622 MB -> 35.105 MB. [2024-10-02T20:24:14.166Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5006.639 ms) ====== [2024-10-02T20:24:14.166Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-02T20:24:14.166Z] GC before operation: completed in 30.177 ms, heap usage 193.306 MB -> 64.693 MB. [2024-10-02T20:24:14.943Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (983.846 ms) ====== [2024-10-02T20:24:14.943Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-02T20:24:14.943Z] GC before operation: completed in 30.244 ms, heap usage 251.716 MB -> 65.013 MB. [2024-10-02T20:24:15.690Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (753.272 ms) ====== [2024-10-02T20:24:15.690Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-02T20:24:16.047Z] GC before operation: completed in 29.767 ms, heap usage 195.836 MB -> 65.138 MB. [2024-10-02T20:24:16.822Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (814.957 ms) ====== [2024-10-02T20:24:16.822Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-02T20:24:16.822Z] GC before operation: completed in 33.621 ms, heap usage 301.497 MB -> 65.509 MB. [2024-10-02T20:24:17.639Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (872.754 ms) ====== [2024-10-02T20:24:17.639Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-02T20:24:17.639Z] GC before operation: completed in 39.057 ms, heap usage 293.485 MB -> 65.610 MB. [2024-10-02T20:24:18.419Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (885.236 ms) ====== [2024-10-02T20:24:18.419Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-02T20:24:18.419Z] GC before operation: completed in 36.002 ms, heap usage 279.101 MB -> 65.961 MB. [2024-10-02T20:24:19.233Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (804.903 ms) ====== [2024-10-02T20:24:19.233Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-02T20:24:19.585Z] GC before operation: completed in 36.761 ms, heap usage 161.391 MB -> 65.759 MB. [2024-10-02T20:24:20.389Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (747.524 ms) ====== [2024-10-02T20:24:20.389Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-02T20:24:20.389Z] GC before operation: completed in 38.306 ms, heap usage 234.947 MB -> 66.237 MB. [2024-10-02T20:24:21.176Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (780.465 ms) ====== [2024-10-02T20:24:21.176Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-02T20:24:21.176Z] GC before operation: completed in 35.945 ms, heap usage 133.612 MB -> 65.984 MB. [2024-10-02T20:24:21.526Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (655.211 ms) ====== [2024-10-02T20:24:21.526Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-02T20:24:21.888Z] GC before operation: completed in 35.559 ms, heap usage 282.515 MB -> 66.454 MB. [2024-10-02T20:24:22.644Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (732.111 ms) ====== [2024-10-02T20:24:22.644Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-02T20:24:22.644Z] GC before operation: completed in 35.675 ms, heap usage 338.707 MB -> 66.697 MB. [2024-10-02T20:24:23.011Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (642.321 ms) ====== [2024-10-02T20:24:23.011Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-02T20:24:23.011Z] GC before operation: completed in 37.193 ms, heap usage 256.798 MB -> 66.694 MB. [2024-10-02T20:24:23.767Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (754.947 ms) ====== [2024-10-02T20:24:23.767Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-02T20:24:24.119Z] GC before operation: completed in 36.520 ms, heap usage 337.725 MB -> 66.737 MB. [2024-10-02T20:24:24.475Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (643.694 ms) ====== [2024-10-02T20:24:24.475Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-02T20:24:24.475Z] GC before operation: completed in 36.659 ms, heap usage 129.681 MB -> 66.591 MB. [2024-10-02T20:24:25.230Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (686.726 ms) ====== [2024-10-02T20:24:25.230Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-02T20:24:25.230Z] GC before operation: completed in 37.497 ms, heap usage 99.723 MB -> 67.319 MB. [2024-10-02T20:24:26.020Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (586.093 ms) ====== [2024-10-02T20:24:26.020Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-02T20:24:26.020Z] GC before operation: completed in 38.022 ms, heap usage 343.497 MB -> 67.352 MB. [2024-10-02T20:24:26.771Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (603.177 ms) ====== [2024-10-02T20:24:26.771Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-02T20:24:26.771Z] GC before operation: completed in 41.395 ms, heap usage 218.437 MB -> 67.477 MB. [2024-10-02T20:24:27.127Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (596.039 ms) ====== [2024-10-02T20:24:27.127Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-02T20:24:27.127Z] GC before operation: completed in 37.765 ms, heap usage 215.901 MB -> 67.378 MB. [2024-10-02T20:24:27.959Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (642.651 ms) ====== [2024-10-02T20:24:27.959Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-02T20:24:27.959Z] GC before operation: completed in 39.288 ms, heap usage 213.891 MB -> 67.424 MB. [2024-10-02T20:24:28.729Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (673.275 ms) ====== [2024-10-02T20:24:28.729Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-02T20:24:28.729Z] GC before operation: completed in 42.708 ms, heap usage 224.331 MB -> 67.715 MB. [2024-10-02T20:24:29.495Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (712.678 ms) ====== [2024-10-02T20:24:29.495Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-02T20:24:29.495Z] GC before operation: completed in 47.590 ms, heap usage 223.742 MB -> 67.650 MB. [2024-10-02T20:24:30.287Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (718.661 ms) ====== [2024-10-02T20:24:30.287Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-02T20:24:30.287Z] GC before operation: completed in 45.133 ms, heap usage 215.129 MB -> 67.788 MB. [2024-10-02T20:24:31.083Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (701.681 ms) ====== [2024-10-02T20:24:31.083Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-02T20:24:31.083Z] GC before operation: completed in 66.817 ms, heap usage 323.089 MB -> 67.869 MB. [2024-10-02T20:24:31.902Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (739.498 ms) ====== [2024-10-02T20:24:31.902Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-02T20:24:31.902Z] GC before operation: completed in 50.237 ms, heap usage 189.904 MB -> 68.004 MB. [2024-10-02T20:24:32.262Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (685.477 ms) ====== [2024-10-02T20:24:32.262Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-02T20:24:32.622Z] GC before operation: completed in 57.816 ms, heap usage 216.002 MB -> 68.140 MB. [2024-10-02T20:24:33.434Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (872.943 ms) ====== [2024-10-02T20:24:33.434Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-02T20:24:33.434Z] GC before operation: completed in 61.184 ms, heap usage 209.464 MB -> 68.211 MB. [2024-10-02T20:24:34.217Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (789.233 ms) ====== [2024-10-02T20:24:34.217Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-02T20:24:34.217Z] GC before operation: completed in 40.236 ms, heap usage 214.410 MB -> 68.346 MB. [2024-10-02T20:24:35.039Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (748.065 ms) ====== [2024-10-02T20:24:35.039Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-02T20:24:35.039Z] GC before operation: completed in 60.331 ms, heap usage 222.867 MB -> 68.475 MB. [2024-10-02T20:24:35.810Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (811.444 ms) ====== [2024-10-02T20:24:35.810Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-02T20:24:35.810Z] GC before operation: completed in 53.118 ms, heap usage 214.211 MB -> 68.696 MB. [2024-10-02T20:24:36.576Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (627.085 ms) ====== [2024-10-02T20:24:36.576Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-02T20:24:36.576Z] GC before operation: completed in 52.385 ms, heap usage 207.529 MB -> 68.652 MB. [2024-10-02T20:24:37.348Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (726.084 ms) ====== [2024-10-02T20:24:37.348Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-02T20:24:37.348Z] GC before operation: completed in 40.368 ms, heap usage 200.702 MB -> 68.779 MB. [2024-10-02T20:24:38.146Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (711.039 ms) ====== [2024-10-02T20:24:38.146Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-02T20:24:38.146Z] GC before operation: completed in 45.904 ms, heap usage 268.277 MB -> 68.780 MB. [2024-10-02T20:24:38.919Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (654.060 ms) ====== [2024-10-02T20:24:38.919Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-02T20:24:38.920Z] GC before operation: completed in 42.690 ms, heap usage 306.162 MB -> 68.926 MB. [2024-10-02T20:24:39.678Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (655.209 ms) ====== [2024-10-02T20:24:39.678Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-02T20:24:39.678Z] GC before operation: completed in 48.472 ms, heap usage 219.311 MB -> 83.946 MB. [2024-10-02T20:24:40.036Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (617.317 ms) ====== [2024-10-02T20:24:40.036Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-02T20:24:40.036Z] GC before operation: completed in 44.199 ms, heap usage 161.711 MB -> 69.133 MB. [2024-10-02T20:24:40.791Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (685.779 ms) ====== [2024-10-02T20:24:40.791Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-02T20:24:40.791Z] GC before operation: completed in 42.782 ms, heap usage 119.562 MB -> 68.715 MB. [2024-10-02T20:24:41.553Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (636.195 ms) ====== [2024-10-02T20:24:41.553Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-02T20:24:41.553Z] GC before operation: completed in 65.274 ms, heap usage 355.732 MB -> 82.444 MB. [2024-10-02T20:24:42.368Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (614.123 ms) ====== [2024-10-02T20:24:42.368Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-02T20:24:42.368Z] GC before operation: completed in 41.581 ms, heap usage 249.195 MB -> 69.462 MB. [2024-10-02T20:24:43.121Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (654.786 ms) ====== [2024-10-02T20:24:43.121Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-02T20:24:43.121Z] GC before operation: completed in 43.558 ms, heap usage 327.555 MB -> 69.588 MB. [2024-10-02T20:24:43.473Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (585.289 ms) ====== [2024-10-02T20:24:43.834Z] ----------------------------------- [2024-10-02T20:24:43.834Z] renaissance-dec-tree_0_PASSED [2024-10-02T20:24:43.834Z] ----------------------------------- [2024-10-02T20:24:43.834Z] [2024-10-02T20:24:43.834Z] TEST TEARDOWN: [2024-10-02T20:24:43.834Z] Nothing to be done for teardown. [2024-10-02T20:24:43.834Z] renaissance-dec-tree_0 Finish Time: Wed Oct 2 16:24:43 2024 Epoch Time (ms): 1727900683493