[2025-02-19T21:38:05.130Z] Running test renaissance-dec-tree_0 ... [2025-02-19T21:38:05.130Z] =============================================== [2025-02-19T21:38:05.130Z] renaissance-dec-tree_0 Start Time: Wed Feb 19 16:38:04 2025 Epoch Time (ms): 1740001084772 [2025-02-19T21:38:05.130Z] variation: NoOptions [2025-02-19T21:38:05.130Z] JVM_OPTIONS: [2025-02-19T21:38:05.130Z] { \ [2025-02-19T21:38:05.130Z] echo ""; echo "TEST SETUP:"; \ [2025-02-19T21:38:05.130Z] echo "Nothing to be done for setup."; \ [2025-02-19T21:38:05.130Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17400009051873/renaissance-dec-tree_0"; \ [2025-02-19T21:38:05.130Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17400009051873/renaissance-dec-tree_0"; \ [2025-02-19T21:38:05.130Z] echo ""; echo "TESTING:"; \ [2025-02-19T21:38:05.131Z] "/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_17400009051873/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-19T21:38:05.131Z] 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_17400009051873/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-19T21:38:05.131Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-19T21:38:05.131Z] echo "Nothing to be done for teardown."; \ [2025-02-19T21:38:05.131Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17400009051873/TestTargetResult"; [2025-02-19T21:38:05.131Z] [2025-02-19T21:38:05.131Z] TEST SETUP: [2025-02-19T21:38:05.131Z] Nothing to be done for setup. [2025-02-19T21:38:05.131Z] [2025-02-19T21:38:05.131Z] TESTING: [2025-02-19T21:38:07.056Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-19T21:38:07.954Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-02-19T21:38:09.898Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-19T21:38:09.898Z] GC before operation: completed in 22.981 ms, heap usage 59.380 MB -> 35.085 MB. [2025-02-19T21:38:15.307Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (5165.222 ms) ====== [2025-02-19T21:38:15.307Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-19T21:38:15.307Z] GC before operation: completed in 43.470 ms, heap usage 197.650 MB -> 64.746 MB. [2025-02-19T21:38:16.688Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1330.114 ms) ====== [2025-02-19T21:38:16.688Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-19T21:38:16.688Z] GC before operation: completed in 49.407 ms, heap usage 324.565 MB -> 64.989 MB. [2025-02-19T21:38:17.553Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1043.908 ms) ====== [2025-02-19T21:38:17.553Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-19T21:38:17.553Z] GC before operation: completed in 46.196 ms, heap usage 397.877 MB -> 65.299 MB. [2025-02-19T21:38:18.437Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (940.707 ms) ====== [2025-02-19T21:38:18.437Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-19T21:38:18.437Z] GC before operation: completed in 45.766 ms, heap usage 168.538 MB -> 65.222 MB. [2025-02-19T21:38:19.796Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (895.542 ms) ====== [2025-02-19T21:38:19.796Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-19T21:38:19.796Z] GC before operation: completed in 39.659 ms, heap usage 106.528 MB -> 65.163 MB. [2025-02-19T21:38:20.678Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (939.635 ms) ====== [2025-02-19T21:38:20.678Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-19T21:38:20.678Z] GC before operation: completed in 46.406 ms, heap usage 166.549 MB -> 65.668 MB. [2025-02-19T21:38:21.562Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (906.006 ms) ====== [2025-02-19T21:38:21.562Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-19T21:38:21.562Z] GC before operation: completed in 45.638 ms, heap usage 246.991 MB -> 66.154 MB. [2025-02-19T21:38:22.429Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (885.349 ms) ====== [2025-02-19T21:38:22.429Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-19T21:38:22.429Z] GC before operation: completed in 48.028 ms, heap usage 247.928 MB -> 66.431 MB. [2025-02-19T21:38:23.268Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (910.024 ms) ====== [2025-02-19T21:38:23.268Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-19T21:38:23.268Z] GC before operation: completed in 45.789 ms, heap usage 101.055 MB -> 65.826 MB. [2025-02-19T21:38:24.131Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (909.541 ms) ====== [2025-02-19T21:38:24.131Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-19T21:38:24.131Z] GC before operation: completed in 54.376 ms, heap usage 368.966 MB -> 66.664 MB. [2025-02-19T21:38:25.048Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (910.613 ms) ====== [2025-02-19T21:38:25.048Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-19T21:38:25.446Z] GC before operation: completed in 51.011 ms, heap usage 198.816 MB -> 66.643 MB. [2025-02-19T21:38:26.288Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (890.003 ms) ====== [2025-02-19T21:38:26.288Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-19T21:38:26.288Z] GC before operation: completed in 54.071 ms, heap usage 234.625 MB -> 66.856 MB. [2025-02-19T21:38:27.170Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (842.260 ms) ====== [2025-02-19T21:38:27.170Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-19T21:38:27.170Z] GC before operation: completed in 47.367 ms, heap usage 231.734 MB -> 79.590 MB. [2025-02-19T21:38:28.001Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (901.191 ms) ====== [2025-02-19T21:38:28.001Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-19T21:38:28.001Z] GC before operation: completed in 53.130 ms, heap usage 349.165 MB -> 66.926 MB. [2025-02-19T21:38:28.857Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (846.629 ms) ====== [2025-02-19T21:38:28.857Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-19T21:38:28.857Z] GC before operation: completed in 56.386 ms, heap usage 318.059 MB -> 67.049 MB. [2025-02-19T21:38:29.707Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (786.906 ms) ====== [2025-02-19T21:38:29.707Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-19T21:38:29.707Z] GC before operation: completed in 63.876 ms, heap usage 210.249 MB -> 67.346 MB. [2025-02-19T21:38:30.589Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (860.961 ms) ====== [2025-02-19T21:38:30.589Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-19T21:38:30.589Z] GC before operation: completed in 55.789 ms, heap usage 331.547 MB -> 67.346 MB. [2025-02-19T21:38:31.424Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (860.608 ms) ====== [2025-02-19T21:38:31.424Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-19T21:38:31.849Z] GC before operation: completed in 61.385 ms, heap usage 308.910 MB -> 82.396 MB. [2025-02-19T21:38:32.698Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (890.409 ms) ====== [2025-02-19T21:38:32.698Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-19T21:38:32.698Z] GC before operation: completed in 55.135 ms, heap usage 211.612 MB -> 67.696 MB. [2025-02-19T21:38:33.571Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (886.023 ms) ====== [2025-02-19T21:38:33.571Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-19T21:38:33.571Z] GC before operation: completed in 56.551 ms, heap usage 201.073 MB -> 67.711 MB. [2025-02-19T21:38:34.462Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (865.391 ms) ====== [2025-02-19T21:38:34.462Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-19T21:38:34.462Z] GC before operation: completed in 59.382 ms, heap usage 340.077 MB -> 95.334 MB. [2025-02-19T21:38:35.339Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (824.010 ms) ====== [2025-02-19T21:38:35.339Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-19T21:38:35.339Z] GC before operation: completed in 69.181 ms, heap usage 362.337 MB -> 95.445 MB. [2025-02-19T21:38:36.177Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (792.700 ms) ====== [2025-02-19T21:38:36.177Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-19T21:38:36.177Z] GC before operation: completed in 55.468 ms, heap usage 336.635 MB -> 67.971 MB. [2025-02-19T21:38:37.026Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (807.847 ms) ====== [2025-02-19T21:38:37.026Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-19T21:38:37.026Z] GC before operation: completed in 52.112 ms, heap usage 200.700 MB -> 82.800 MB. [2025-02-19T21:38:37.884Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (848.575 ms) ====== [2025-02-19T21:38:37.884Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-19T21:38:37.884Z] GC before operation: completed in 60.153 ms, heap usage 324.374 MB -> 68.212 MB. [2025-02-19T21:38:38.794Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (769.721 ms) ====== [2025-02-19T21:38:38.794Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-19T21:38:38.794Z] GC before operation: completed in 52.635 ms, heap usage 285.554 MB -> 68.504 MB. [2025-02-19T21:38:39.675Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (818.059 ms) ====== [2025-02-19T21:38:39.675Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-19T21:38:39.675Z] GC before operation: completed in 79.160 ms, heap usage 309.668 MB -> 68.419 MB. [2025-02-19T21:38:41.051Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1113.289 ms) ====== [2025-02-19T21:38:41.051Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-19T21:38:41.051Z] GC before operation: completed in 63.383 ms, heap usage 169.931 MB -> 68.285 MB. [2025-02-19T21:38:41.894Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (858.517 ms) ====== [2025-02-19T21:38:41.894Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-19T21:38:41.894Z] GC before operation: completed in 68.215 ms, heap usage 141.872 MB -> 68.370 MB. [2025-02-19T21:38:42.763Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (993.167 ms) ====== [2025-02-19T21:38:42.763Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-19T21:38:42.763Z] GC before operation: completed in 58.953 ms, heap usage 159.657 MB -> 68.446 MB. [2025-02-19T21:38:43.627Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (853.183 ms) ====== [2025-02-19T21:38:43.627Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-19T21:38:43.627Z] GC before operation: completed in 66.978 ms, heap usage 278.611 MB -> 68.846 MB. [2025-02-19T21:38:44.479Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (799.434 ms) ====== [2025-02-19T21:38:44.479Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-19T21:38:44.479Z] GC before operation: completed in 64.667 ms, heap usage 206.472 MB -> 68.875 MB. [2025-02-19T21:38:45.844Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (970.836 ms) ====== [2025-02-19T21:38:45.844Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-19T21:38:45.844Z] GC before operation: completed in 57.066 ms, heap usage 133.900 MB -> 81.410 MB. [2025-02-19T21:38:46.725Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (843.153 ms) ====== [2025-02-19T21:38:46.725Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-19T21:38:46.725Z] GC before operation: completed in 63.510 ms, heap usage 281.712 MB -> 84.091 MB. [2025-02-19T21:38:47.583Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (974.276 ms) ====== [2025-02-19T21:38:47.583Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-19T21:38:47.583Z] GC before operation: completed in 56.346 ms, heap usage 302.068 MB -> 69.259 MB. [2025-02-19T21:38:48.454Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (789.972 ms) ====== [2025-02-19T21:38:48.454Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-19T21:38:48.454Z] GC before operation: completed in 60.738 ms, heap usage 197.437 MB -> 69.331 MB. [2025-02-19T21:38:49.296Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (860.647 ms) ====== [2025-02-19T21:38:49.296Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-19T21:38:49.296Z] GC before operation: completed in 56.274 ms, heap usage 264.839 MB -> 97.129 MB. [2025-02-19T21:38:50.147Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (748.704 ms) ====== [2025-02-19T21:38:50.147Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-19T21:38:50.147Z] GC before operation: completed in 60.117 ms, heap usage 288.905 MB -> 69.573 MB. [2025-02-19T21:38:51.026Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (844.235 ms) ====== [2025-02-19T21:38:51.026Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-19T21:38:51.026Z] GC before operation: completed in 59.398 ms, heap usage 354.626 MB -> 69.783 MB. [2025-02-19T21:38:51.875Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (778.020 ms) ====== [2025-02-19T21:38:52.268Z] ----------------------------------- [2025-02-19T21:38:52.268Z] renaissance-dec-tree_0_PASSED [2025-02-19T21:38:52.268Z] ----------------------------------- [2025-02-19T21:38:52.268Z] [2025-02-19T21:38:52.268Z] TEST TEARDOWN: [2025-02-19T21:38:52.268Z] Nothing to be done for teardown. [2025-02-19T21:38:52.268Z] renaissance-dec-tree_0 Finish Time: Wed Feb 19 16:38:51 2025 Epoch Time (ms): 1740001131865