[2024-10-15T22:39:02.245Z] Running test renaissance-dec-tree_0 ... [2024-10-15T22:39:02.245Z] =============================================== [2024-10-15T22:39:02.245Z] renaissance-dec-tree_0 Start Time: Tue Oct 15 18:39:02 2024 Epoch Time (ms): 1729031942019 [2024-10-15T22:39:02.245Z] variation: NoOptions [2024-10-15T22:39:02.245Z] JVM_OPTIONS: [2024-10-15T22:39:02.245Z] { \ [2024-10-15T22:39:02.245Z] echo ""; echo "TEST SETUP:"; \ [2024-10-15T22:39:02.245Z] echo "Nothing to be done for setup."; \ [2024-10-15T22:39:02.245Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17290317606717/renaissance-dec-tree_0"; \ [2024-10-15T22:39:02.245Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17290317606717/renaissance-dec-tree_0"; \ [2024-10-15T22:39:02.245Z] echo ""; echo "TESTING:"; \ [2024-10-15T22:39:02.245Z] "/Users/admin/workspace/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17290317606717/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-15T22:39:02.245Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17290317606717/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-15T22:39:02.245Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-15T22:39:02.245Z] echo "Nothing to be done for teardown."; \ [2024-10-15T22:39:02.245Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17290317606717/TestTargetResult"; [2024-10-15T22:39:02.245Z] [2024-10-15T22:39:02.245Z] TEST SETUP: [2024-10-15T22:39:02.245Z] Nothing to be done for setup. [2024-10-15T22:39:02.245Z] [2024-10-15T22:39:02.245Z] TESTING: [2024-10-15T22:39:04.042Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-15T22:39:04.834Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-10-15T22:39:05.208Z] WARNING: An illegal reflective access operation has occurred [2024-10-15T22:39:05.208Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_17290317606717/renaissance-dec-tree_0/harness-183902-11372635903945510098/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-15T22:39:05.208Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-15T22:39:05.208Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-15T22:39:05.208Z] WARNING: All illegal access operations will be denied in a future release [2024-10-15T22:39:06.448Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-15T22:39:06.448Z] GC before operation: completed in 28.141 ms, heap usage 76.801 MB -> 33.869 MB. [2024-10-15T22:39:10.585Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4106.002 ms) ====== [2024-10-15T22:39:10.585Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-15T22:39:10.585Z] GC before operation: completed in 42.978 ms, heap usage 229.738 MB -> 63.808 MB. [2024-10-15T22:39:11.849Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1348.528 ms) ====== [2024-10-15T22:39:11.849Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-15T22:39:11.849Z] GC before operation: completed in 48.170 ms, heap usage 191.200 MB -> 64.140 MB. [2024-10-15T22:39:13.140Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1203.215 ms) ====== [2024-10-15T22:39:13.140Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-15T22:39:13.140Z] GC before operation: completed in 48.286 ms, heap usage 105.575 MB -> 64.343 MB. [2024-10-15T22:39:13.970Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1016.489 ms) ====== [2024-10-15T22:39:13.970Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-15T22:39:13.970Z] GC before operation: completed in 51.840 ms, heap usage 306.715 MB -> 64.495 MB. [2024-10-15T22:39:15.281Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1017.238 ms) ====== [2024-10-15T22:39:15.281Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-15T22:39:15.281Z] GC before operation: completed in 47.472 ms, heap usage 228.530 MB -> 64.703 MB. [2024-10-15T22:39:16.066Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (927.764 ms) ====== [2024-10-15T22:39:16.066Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-15T22:39:16.066Z] GC before operation: completed in 68.604 ms, heap usage 172.943 MB -> 64.909 MB. [2024-10-15T22:39:17.332Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (914.625 ms) ====== [2024-10-15T22:39:17.332Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-15T22:39:17.332Z] GC before operation: completed in 47.852 ms, heap usage 180.993 MB -> 65.114 MB. [2024-10-15T22:39:17.753Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (711.192 ms) ====== [2024-10-15T22:39:17.753Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-15T22:39:17.753Z] GC before operation: completed in 55.663 ms, heap usage 157.449 MB -> 65.278 MB. [2024-10-15T22:39:18.580Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (726.174 ms) ====== [2024-10-15T22:39:18.580Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-15T22:39:18.580Z] GC before operation: completed in 51.691 ms, heap usage 146.813 MB -> 65.488 MB. [2024-10-15T22:39:19.381Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (702.386 ms) ====== [2024-10-15T22:39:19.381Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-15T22:39:19.382Z] GC before operation: completed in 52.129 ms, heap usage 105.711 MB -> 65.183 MB. [2024-10-15T22:39:20.149Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (665.643 ms) ====== [2024-10-15T22:39:20.149Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-15T22:39:20.149Z] GC before operation: completed in 52.100 ms, heap usage 102.681 MB -> 65.450 MB. [2024-10-15T22:39:20.943Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (777.409 ms) ====== [2024-10-15T22:39:20.943Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-15T22:39:20.943Z] GC before operation: completed in 75.583 ms, heap usage 156.412 MB -> 65.822 MB. [2024-10-15T22:39:21.719Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (775.169 ms) ====== [2024-10-15T22:39:21.719Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-15T22:39:21.719Z] GC before operation: completed in 59.114 ms, heap usage 211.357 MB -> 65.791 MB. [2024-10-15T22:39:22.513Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (876.442 ms) ====== [2024-10-15T22:39:22.513Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-15T22:39:22.886Z] GC before operation: completed in 74.310 ms, heap usage 201.377 MB -> 65.910 MB. [2024-10-15T22:39:23.665Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (957.215 ms) ====== [2024-10-15T22:39:23.665Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-15T22:39:23.665Z] GC before operation: completed in 72.777 ms, heap usage 209.364 MB -> 66.028 MB. [2024-10-15T22:39:24.444Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (826.631 ms) ====== [2024-10-15T22:39:24.444Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-15T22:39:24.835Z] GC before operation: completed in 62.298 ms, heap usage 124.072 MB -> 66.326 MB. [2024-10-15T22:39:25.231Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (666.375 ms) ====== [2024-10-15T22:39:25.231Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-15T22:39:25.231Z] GC before operation: completed in 62.816 ms, heap usage 199.070 MB -> 66.300 MB. [2024-10-15T22:39:26.023Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (758.717 ms) ====== [2024-10-15T22:39:26.023Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-15T22:39:26.382Z] GC before operation: completed in 71.604 ms, heap usage 139.964 MB -> 66.386 MB. [2024-10-15T22:39:26.741Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (669.624 ms) ====== [2024-10-15T22:39:26.741Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-15T22:39:27.122Z] GC before operation: completed in 69.770 ms, heap usage 218.191 MB -> 66.504 MB. [2024-10-15T22:39:27.890Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (715.809 ms) ====== [2024-10-15T22:39:27.890Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-15T22:39:27.890Z] GC before operation: completed in 66.543 ms, heap usage 111.802 MB -> 66.046 MB. [2024-10-15T22:39:28.278Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (638.189 ms) ====== [2024-10-15T22:39:28.278Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-15T22:39:28.637Z] GC before operation: completed in 64.288 ms, heap usage 190.843 MB -> 66.704 MB. [2024-10-15T22:39:29.010Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (632.981 ms) ====== [2024-10-15T22:39:29.010Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-15T22:39:29.010Z] GC before operation: completed in 67.523 ms, heap usage 238.811 MB -> 66.807 MB. [2024-10-15T22:39:29.788Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (650.983 ms) ====== [2024-10-15T22:39:29.788Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-15T22:39:29.788Z] GC before operation: completed in 66.792 ms, heap usage 171.608 MB -> 66.906 MB. [2024-10-15T22:39:30.563Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (681.754 ms) ====== [2024-10-15T22:39:30.563Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-15T22:39:30.563Z] GC before operation: completed in 69.578 ms, heap usage 129.060 MB -> 66.991 MB. [2024-10-15T22:39:31.327Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (669.849 ms) ====== [2024-10-15T22:39:31.327Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-15T22:39:31.327Z] GC before operation: completed in 71.594 ms, heap usage 227.517 MB -> 67.226 MB. [2024-10-15T22:39:32.103Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (699.469 ms) ====== [2024-10-15T22:39:32.103Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-15T22:39:32.103Z] GC before operation: completed in 82.942 ms, heap usage 142.697 MB -> 67.160 MB. [2024-10-15T22:39:32.885Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (709.552 ms) ====== [2024-10-15T22:39:32.885Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-15T22:39:32.885Z] GC before operation: completed in 75.359 ms, heap usage 104.267 MB -> 66.994 MB. [2024-10-15T22:39:33.665Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (694.582 ms) ====== [2024-10-15T22:39:33.665Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-15T22:39:33.665Z] GC before operation: completed in 80.535 ms, heap usage 108.754 MB -> 67.091 MB. [2024-10-15T22:39:34.455Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (703.861 ms) ====== [2024-10-15T22:39:34.455Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-15T22:39:34.455Z] GC before operation: completed in 80.037 ms, heap usage 264.011 MB -> 67.849 MB. [2024-10-15T22:39:35.269Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (745.478 ms) ====== [2024-10-15T22:39:35.269Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-15T22:39:35.269Z] GC before operation: completed in 78.990 ms, heap usage 141.869 MB -> 67.712 MB. [2024-10-15T22:39:36.039Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (716.050 ms) ====== [2024-10-15T22:39:36.039Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-15T22:39:36.039Z] GC before operation: completed in 78.562 ms, heap usage 198.989 MB -> 67.685 MB. [2024-10-15T22:39:36.804Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (730.806 ms) ====== [2024-10-15T22:39:36.804Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-15T22:39:36.804Z] GC before operation: completed in 80.955 ms, heap usage 134.198 MB -> 67.496 MB. [2024-10-15T22:39:37.570Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (697.753 ms) ====== [2024-10-15T22:39:37.571Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-15T22:39:37.571Z] GC before operation: completed in 80.302 ms, heap usage 119.555 MB -> 67.325 MB. [2024-10-15T22:39:38.347Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (713.179 ms) ====== [2024-10-15T22:39:38.348Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-15T22:39:38.348Z] GC before operation: completed in 85.528 ms, heap usage 119.840 MB -> 67.423 MB. [2024-10-15T22:39:39.116Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (659.633 ms) ====== [2024-10-15T22:39:39.116Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-15T22:39:39.116Z] GC before operation: completed in 81.544 ms, heap usage 230.029 MB -> 68.088 MB. [2024-10-15T22:39:39.904Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (712.504 ms) ====== [2024-10-15T22:39:39.904Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-15T22:39:39.904Z] GC before operation: completed in 83.765 ms, heap usage 191.796 MB -> 68.333 MB. [2024-10-15T22:39:40.726Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (745.431 ms) ====== [2024-10-15T22:39:40.726Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-15T22:39:40.726Z] GC before operation: completed in 74.152 ms, heap usage 171.939 MB -> 68.017 MB. [2024-10-15T22:39:41.529Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (579.620 ms) ====== [2024-10-15T22:39:41.529Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-15T22:39:41.529Z] GC before operation: completed in 73.511 ms, heap usage 100.057 MB -> 68.057 MB. [2024-10-15T22:39:42.319Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (574.547 ms) ====== [2024-10-15T22:39:42.319Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-15T22:39:42.319Z] GC before operation: completed in 71.437 ms, heap usage 188.524 MB -> 68.444 MB. [2024-10-15T22:39:43.102Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (708.949 ms) ====== [2024-10-15T22:39:43.102Z] ----------------------------------- [2024-10-15T22:39:43.102Z] renaissance-dec-tree_0_PASSED [2024-10-15T22:39:43.102Z] ----------------------------------- [2024-10-15T22:39:43.102Z] [2024-10-15T22:39:43.102Z] TEST TEARDOWN: [2024-10-15T22:39:43.102Z] Nothing to be done for teardown. [2024-10-15T22:39:43.102Z] renaissance-dec-tree_0 Finish Time: Tue Oct 15 18:39:42 2024 Epoch Time (ms): 1729031982780