[2025-01-22T03:34:30.384Z] Running test renaissance-dec-tree_0 ... [2025-01-22T03:34:30.384Z] =============================================== [2025-01-22T03:34:30.384Z] renaissance-dec-tree_0 Start Time: Tue Jan 21 22:34:30 2025 Epoch Time (ms): 1737516870321 [2025-01-22T03:34:30.384Z] variation: NoOptions [2025-01-22T03:34:30.384Z] JVM_OPTIONS: [2025-01-22T03:34:30.384Z] { \ [2025-01-22T03:34:30.384Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T03:34:30.384Z] echo "Nothing to be done for setup."; \ [2025-01-22T03:34:30.384Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17375166921655/renaissance-dec-tree_0"; \ [2025-01-22T03:34:30.384Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17375166921655/renaissance-dec-tree_0"; \ [2025-01-22T03:34:30.384Z] echo ""; echo "TESTING:"; \ [2025-01-22T03:34:30.384Z] "/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_17375166921655/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-01-22T03:34:30.384Z] 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_17375166921655/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T03:34:30.384Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T03:34:30.384Z] echo "Nothing to be done for teardown."; \ [2025-01-22T03:34:30.384Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17375166921655/TestTargetResult"; [2025-01-22T03:34:30.384Z] [2025-01-22T03:34:30.384Z] TEST SETUP: [2025-01-22T03:34:30.384Z] Nothing to be done for setup. [2025-01-22T03:34:30.384Z] [2025-01-22T03:34:30.384Z] TESTING: [2025-01-22T03:34:32.308Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-22T03:34:33.138Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-01-22T03:34:33.525Z] WARNING: An illegal reflective access operation has occurred [2025-01-22T03:34:33.526Z] 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_17375166921655/renaissance-dec-tree_0/harness-223430-13898806371198845502/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-01-22T03:34:33.526Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-01-22T03:34:33.526Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-01-22T03:34:33.526Z] WARNING: All illegal access operations will be denied in a future release [2025-01-22T03:34:34.353Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-01-22T03:34:34.742Z] GC before operation: completed in 26.257 ms, heap usage 40.433 MB -> 33.839 MB. [2025-01-22T03:34:39.011Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (4386.140 ms) ====== [2025-01-22T03:34:39.011Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-01-22T03:34:39.011Z] GC before operation: completed in 54.516 ms, heap usage 225.362 MB -> 63.670 MB. [2025-01-22T03:34:40.404Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1071.921 ms) ====== [2025-01-22T03:34:40.404Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-01-22T03:34:40.404Z] GC before operation: completed in 47.064 ms, heap usage 126.852 MB -> 64.143 MB. [2025-01-22T03:34:41.263Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1011.517 ms) ====== [2025-01-22T03:34:41.263Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-01-22T03:34:41.263Z] GC before operation: completed in 46.475 ms, heap usage 212.765 MB -> 64.421 MB. [2025-01-22T03:34:42.128Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1032.960 ms) ====== [2025-01-22T03:34:42.128Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-01-22T03:34:42.128Z] GC before operation: completed in 55.653 ms, heap usage 309.432 MB -> 64.871 MB. [2025-01-22T03:34:43.471Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (939.757 ms) ====== [2025-01-22T03:34:43.471Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-01-22T03:34:43.471Z] GC before operation: completed in 48.459 ms, heap usage 250.873 MB -> 64.861 MB. [2025-01-22T03:34:43.861Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (739.812 ms) ====== [2025-01-22T03:34:43.861Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-01-22T03:34:44.250Z] GC before operation: completed in 58.080 ms, heap usage 111.920 MB -> 64.781 MB. [2025-01-22T03:34:44.651Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (752.961 ms) ====== [2025-01-22T03:34:44.651Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-01-22T03:34:45.073Z] GC before operation: completed in 53.998 ms, heap usage 208.047 MB -> 65.316 MB. [2025-01-22T03:34:45.917Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (797.430 ms) ====== [2025-01-22T03:34:45.917Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-01-22T03:34:45.917Z] GC before operation: completed in 51.754 ms, heap usage 99.384 MB -> 64.987 MB. [2025-01-22T03:34:46.313Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (736.423 ms) ====== [2025-01-22T03:34:46.313Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-01-22T03:34:46.703Z] GC before operation: completed in 48.840 ms, heap usage 101.696 MB -> 65.103 MB. [2025-01-22T03:34:47.121Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (721.195 ms) ====== [2025-01-22T03:34:47.121Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-01-22T03:34:47.121Z] GC before operation: completed in 50.071 ms, heap usage 125.500 MB -> 65.485 MB. [2025-01-22T03:34:47.972Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (695.081 ms) ====== [2025-01-22T03:34:47.972Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-01-22T03:34:47.972Z] GC before operation: completed in 54.371 ms, heap usage 232.448 MB -> 65.610 MB. [2025-01-22T03:34:48.817Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (691.954 ms) ====== [2025-01-22T03:34:48.817Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-01-22T03:34:48.817Z] GC before operation: completed in 56.455 ms, heap usage 169.728 MB -> 65.447 MB. [2025-01-22T03:34:49.655Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (671.073 ms) ====== [2025-01-22T03:34:49.655Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-01-22T03:34:49.655Z] GC before operation: completed in 53.612 ms, heap usage 167.856 MB -> 65.971 MB. [2025-01-22T03:34:50.053Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (660.678 ms) ====== [2025-01-22T03:34:50.053Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-01-22T03:34:50.053Z] GC before operation: completed in 54.528 ms, heap usage 222.823 MB -> 65.937 MB. [2025-01-22T03:34:50.891Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (684.681 ms) ====== [2025-01-22T03:34:50.891Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-01-22T03:34:50.891Z] GC before operation: completed in 58.468 ms, heap usage 114.005 MB -> 65.755 MB. [2025-01-22T03:34:51.717Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (686.282 ms) ====== [2025-01-22T03:34:51.717Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-01-22T03:34:51.717Z] GC before operation: completed in 58.879 ms, heap usage 218.718 MB -> 66.212 MB. [2025-01-22T03:34:52.545Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (662.407 ms) ====== [2025-01-22T03:34:52.545Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-01-22T03:34:52.545Z] GC before operation: completed in 59.872 ms, heap usage 155.686 MB -> 66.318 MB. [2025-01-22T03:34:52.937Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (693.052 ms) ====== [2025-01-22T03:34:52.937Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-01-22T03:34:53.340Z] GC before operation: completed in 65.126 ms, heap usage 193.571 MB -> 66.421 MB. [2025-01-22T03:34:53.756Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (714.779 ms) ====== [2025-01-22T03:34:53.756Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-01-22T03:34:54.171Z] GC before operation: completed in 62.939 ms, heap usage 289.536 MB -> 66.515 MB. [2025-01-22T03:34:54.575Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (723.418 ms) ====== [2025-01-22T03:34:54.575Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-01-22T03:34:54.575Z] GC before operation: completed in 63.582 ms, heap usage 161.533 MB -> 66.573 MB. [2025-01-22T03:34:55.439Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (666.821 ms) ====== [2025-01-22T03:34:55.439Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-01-22T03:34:55.439Z] GC before operation: completed in 62.820 ms, heap usage 111.272 MB -> 66.388 MB. [2025-01-22T03:34:56.299Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (672.827 ms) ====== [2025-01-22T03:34:56.299Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-01-22T03:34:56.299Z] GC before operation: completed in 65.524 ms, heap usage 172.652 MB -> 66.773 MB. [2025-01-22T03:34:56.696Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (648.919 ms) ====== [2025-01-22T03:34:56.696Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-01-22T03:34:57.087Z] GC before operation: completed in 65.093 ms, heap usage 223.211 MB -> 66.877 MB. [2025-01-22T03:34:57.500Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (643.349 ms) ====== [2025-01-22T03:34:57.500Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-01-22T03:34:57.500Z] GC before operation: completed in 65.302 ms, heap usage 232.697 MB -> 67.128 MB. [2025-01-22T03:34:58.393Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (650.468 ms) ====== [2025-01-22T03:34:58.393Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-01-22T03:34:58.393Z] GC before operation: completed in 71.124 ms, heap usage 239.864 MB -> 79.808 MB. [2025-01-22T03:34:59.228Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (656.410 ms) ====== [2025-01-22T03:34:59.228Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-01-22T03:34:59.228Z] GC before operation: completed in 69.983 ms, heap usage 236.946 MB -> 67.216 MB. [2025-01-22T03:34:59.638Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (659.014 ms) ====== [2025-01-22T03:34:59.638Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-01-22T03:34:59.638Z] GC before operation: completed in 65.378 ms, heap usage 130.894 MB -> 67.304 MB. [2025-01-22T03:35:00.485Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (672.304 ms) ====== [2025-01-22T03:35:00.486Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-01-22T03:35:00.486Z] GC before operation: completed in 66.822 ms, heap usage 141.384 MB -> 67.402 MB. [2025-01-22T03:35:01.344Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (626.091 ms) ====== [2025-01-22T03:35:01.344Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-01-22T03:35:01.344Z] GC before operation: completed in 67.235 ms, heap usage 168.444 MB -> 67.517 MB. [2025-01-22T03:35:01.738Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (642.314 ms) ====== [2025-01-22T03:35:01.738Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-01-22T03:35:02.128Z] GC before operation: completed in 69.034 ms, heap usage 232.969 MB -> 67.617 MB. [2025-01-22T03:35:02.520Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (631.397 ms) ====== [2025-01-22T03:35:02.520Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-01-22T03:35:02.520Z] GC before operation: completed in 67.719 ms, heap usage 155.762 MB -> 67.723 MB. [2025-01-22T03:35:03.387Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (634.398 ms) ====== [2025-01-22T03:35:03.387Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-01-22T03:35:03.387Z] GC before operation: completed in 72.421 ms, heap usage 265.109 MB -> 67.821 MB. [2025-01-22T03:35:04.252Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (627.315 ms) ====== [2025-01-22T03:35:04.252Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-01-22T03:35:04.252Z] GC before operation: completed in 74.168 ms, heap usage 129.860 MB -> 67.624 MB. [2025-01-22T03:35:04.656Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (645.859 ms) ====== [2025-01-22T03:35:04.656Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-01-22T03:35:04.656Z] GC before operation: completed in 72.503 ms, heap usage 190.589 MB -> 67.973 MB. [2025-01-22T03:35:05.505Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (648.259 ms) ====== [2025-01-22T03:35:05.505Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-01-22T03:35:05.505Z] GC before operation: completed in 71.691 ms, heap usage 251.575 MB -> 68.088 MB. [2025-01-22T03:35:06.343Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (624.537 ms) ====== [2025-01-22T03:35:06.343Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-01-22T03:35:06.343Z] GC before operation: completed in 70.806 ms, heap usage 144.542 MB -> 68.168 MB. [2025-01-22T03:35:06.747Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (627.405 ms) ====== [2025-01-22T03:35:06.747Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-01-22T03:35:06.747Z] GC before operation: completed in 70.512 ms, heap usage 228.140 MB -> 68.286 MB. [2025-01-22T03:35:07.579Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (617.299 ms) ====== [2025-01-22T03:35:07.579Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-01-22T03:35:07.579Z] GC before operation: completed in 73.752 ms, heap usage 223.159 MB -> 68.387 MB. [2025-01-22T03:35:08.428Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (626.189 ms) ====== [2025-01-22T03:35:08.428Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-01-22T03:35:08.428Z] GC before operation: completed in 71.504 ms, heap usage 193.861 MB -> 68.485 MB. [2025-01-22T03:35:08.816Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (629.622 ms) ====== [2025-01-22T03:35:09.204Z] ----------------------------------- [2025-01-22T03:35:09.204Z] renaissance-dec-tree_0_PASSED [2025-01-22T03:35:09.204Z] ----------------------------------- [2025-01-22T03:35:09.204Z] [2025-01-22T03:35:09.204Z] TEST TEARDOWN: [2025-01-22T03:35:09.204Z] Nothing to be done for teardown. [2025-01-22T03:35:09.204Z] renaissance-dec-tree_0 Finish Time: Tue Jan 21 22:35:08 2025 Epoch Time (ms): 1737516908842