[2025-03-05T23:04:46.489Z] Running test renaissance-dec-tree_0 ... [2025-03-05T23:04:46.489Z] =============================================== [2025-03-05T23:04:46.489Z] renaissance-dec-tree_0 Start Time: Wed Mar 5 15:04:43 2025 Epoch Time (ms): 1741215883374 [2025-03-05T23:04:46.489Z] variation: NoOptions [2025-03-05T23:04:46.489Z] JVM_OPTIONS: [2025-03-05T23:04:46.489Z] { \ [2025-03-05T23:04:46.489Z] echo ""; echo "TEST SETUP:"; \ [2025-03-05T23:04:46.489Z] echo "Nothing to be done for setup."; \ [2025-03-05T23:04:46.489Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17412147256252/renaissance-dec-tree_0"; \ [2025-03-05T23:04:46.489Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17412147256252/renaissance-dec-tree_0"; \ [2025-03-05T23:04:46.489Z] echo ""; echo "TESTING:"; \ [2025-03-05T23:04:46.489Z] "/Users/admin/workspace/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17412147256252/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-03-05T23:04:46.489Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17412147256252/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-05T23:04:46.489Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-05T23:04:46.489Z] echo "Nothing to be done for teardown."; \ [2025-03-05T23:04:46.489Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17412147256252/TestTargetResult"; [2025-03-05T23:04:46.489Z] [2025-03-05T23:04:46.489Z] TEST SETUP: [2025-03-05T23:04:46.489Z] Nothing to be done for setup. [2025-03-05T23:04:46.489Z] [2025-03-05T23:04:46.489Z] TESTING: [2025-03-05T23:04:55.310Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-05T23:05:02.321Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-03-05T23:05:06.955Z] WARNING: An illegal reflective access operation has occurred [2025-03-05T23:05:06.955Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/output_17412147256252/renaissance-dec-tree_0/harness-150446-13113526629405522533/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-05T23:05:06.955Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-05T23:05:06.955Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-05T23:05:06.955Z] WARNING: All illegal access operations will be denied in a future release [2025-03-05T23:05:14.126Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-03-05T23:05:14.126Z] GC before operation: completed in 166.271 ms, heap usage 49.048 MB -> 33.870 MB. [2025-03-05T23:05:50.552Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (30952.954 ms) ====== [2025-03-05T23:05:50.552Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-03-05T23:05:50.552Z] GC before operation: completed in 264.644 ms, heap usage 163.991 MB -> 63.781 MB. [2025-03-05T23:05:55.097Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (9339.597 ms) ====== [2025-03-05T23:05:55.097Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-03-05T23:05:55.097Z] GC before operation: completed in 323.550 ms, heap usage 135.930 MB -> 63.740 MB. [2025-03-05T23:06:03.950Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (8876.725 ms) ====== [2025-03-05T23:06:03.950Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-03-05T23:06:03.950Z] GC before operation: completed in 249.825 ms, heap usage 251.663 MB -> 64.683 MB. [2025-03-05T23:06:12.990Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9227.220 ms) ====== [2025-03-05T23:06:12.990Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-03-05T23:06:13.412Z] GC before operation: completed in 247.585 ms, heap usage 120.153 MB -> 64.094 MB. [2025-03-05T23:06:22.337Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (7026.831 ms) ====== [2025-03-05T23:06:22.337Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-03-05T23:06:22.337Z] GC before operation: completed in 498.697 ms, heap usage 265.402 MB -> 64.709 MB. [2025-03-05T23:06:28.633Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (7445.981 ms) ====== [2025-03-05T23:06:28.633Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-03-05T23:06:28.633Z] GC before operation: completed in 316.332 ms, heap usage 198.582 MB -> 65.277 MB. [2025-03-05T23:06:36.366Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (7078.794 ms) ====== [2025-03-05T23:06:36.366Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-03-05T23:06:36.366Z] GC before operation: completed in 221.435 ms, heap usage 309.834 MB -> 92.912 MB. [2025-03-05T23:06:41.558Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5264.045 ms) ====== [2025-03-05T23:06:41.558Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-03-05T23:06:41.558Z] GC before operation: completed in 326.594 ms, heap usage 287.678 MB -> 65.601 MB. [2025-03-05T23:06:48.919Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (6314.657 ms) ====== [2025-03-05T23:06:48.919Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-03-05T23:06:48.919Z] GC before operation: completed in 291.616 ms, heap usage 157.088 MB -> 92.922 MB. [2025-03-05T23:06:54.209Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6151.669 ms) ====== [2025-03-05T23:06:54.209Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-03-05T23:06:54.647Z] GC before operation: completed in 263.568 ms, heap usage 283.313 MB -> 65.575 MB. [2025-03-05T23:06:59.835Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4893.585 ms) ====== [2025-03-05T23:06:59.835Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-03-05T23:07:01.427Z] GC before operation: completed in 1331.281 ms, heap usage 144.748 MB -> 65.250 MB. [2025-03-05T23:07:06.976Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (6296.445 ms) ====== [2025-03-05T23:07:06.976Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-03-05T23:07:07.427Z] GC before operation: completed in 272.091 ms, heap usage 236.876 MB -> 66.001 MB. [2025-03-05T23:07:13.874Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (6379.956 ms) ====== [2025-03-05T23:07:13.874Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-03-05T23:07:14.375Z] GC before operation: completed in 268.629 ms, heap usage 191.416 MB -> 65.740 MB. [2025-03-05T23:07:20.789Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (6343.237 ms) ====== [2025-03-05T23:07:20.789Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-03-05T23:07:20.789Z] GC before operation: completed in 280.811 ms, heap usage 208.230 MB -> 65.853 MB. [2025-03-05T23:07:27.052Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5719.654 ms) ====== [2025-03-05T23:07:27.052Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-03-05T23:07:27.052Z] GC before operation: completed in 337.382 ms, heap usage 205.107 MB -> 66.102 MB. [2025-03-05T23:07:33.123Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5777.990 ms) ====== [2025-03-05T23:07:33.123Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-03-05T23:07:33.123Z] GC before operation: completed in 220.771 ms, heap usage 220.059 MB -> 66.135 MB. [2025-03-05T23:07:36.999Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4084.156 ms) ====== [2025-03-05T23:07:36.999Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-03-05T23:07:37.540Z] GC before operation: completed in 753.889 ms, heap usage 225.243 MB -> 66.239 MB. [2025-03-05T23:07:42.498Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4074.528 ms) ====== [2025-03-05T23:07:42.499Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-03-05T23:07:42.499Z] GC before operation: completed in 330.570 ms, heap usage 280.655 MB -> 66.348 MB. [2025-03-05T23:07:48.777Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (6186.843 ms) ====== [2025-03-05T23:07:48.777Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-03-05T23:07:48.777Z] GC before operation: completed in 362.911 ms, heap usage 104.040 MB -> 80.933 MB. [2025-03-05T23:07:54.907Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (5510.787 ms) ====== [2025-03-05T23:07:54.907Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-03-05T23:07:54.907Z] GC before operation: completed in 229.470 ms, heap usage 206.924 MB -> 94.155 MB. [2025-03-05T23:07:59.887Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (5150.118 ms) ====== [2025-03-05T23:07:59.887Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-03-05T23:07:59.887Z] GC before operation: completed in 263.338 ms, heap usage 258.751 MB -> 66.654 MB. [2025-03-05T23:08:05.952Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5473.000 ms) ====== [2025-03-05T23:08:05.952Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-03-05T23:08:05.952Z] GC before operation: completed in 290.085 ms, heap usage 214.353 MB -> 66.896 MB. [2025-03-05T23:08:10.333Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4795.079 ms) ====== [2025-03-05T23:08:10.333Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-03-05T23:08:10.851Z] GC before operation: completed in 526.397 ms, heap usage 211.525 MB -> 66.856 MB. [2025-03-05T23:08:23.955Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (11199.218 ms) ====== [2025-03-05T23:08:23.955Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-03-05T23:08:23.955Z] GC before operation: completed in 1346.296 ms, heap usage 381.626 MB -> 94.393 MB. [2025-03-05T23:08:30.089Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5863.805 ms) ====== [2025-03-05T23:08:30.089Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-03-05T23:08:30.089Z] GC before operation: completed in 285.418 ms, heap usage 331.831 MB -> 67.039 MB. [2025-03-05T23:08:35.126Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (5024.507 ms) ====== [2025-03-05T23:08:35.126Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-03-05T23:08:35.126Z] GC before operation: completed in 245.714 ms, heap usage 267.407 MB -> 94.582 MB. [2025-03-05T23:08:39.674Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4329.548 ms) ====== [2025-03-05T23:08:39.674Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-03-05T23:08:39.674Z] GC before operation: completed in 341.872 ms, heap usage 429.329 MB -> 94.871 MB. [2025-03-05T23:08:43.698Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4005.582 ms) ====== [2025-03-05T23:08:43.698Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-03-05T23:08:45.072Z] GC before operation: completed in 1351.092 ms, heap usage 352.429 MB -> 67.337 MB. [2025-03-05T23:08:50.302Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (5131.651 ms) ====== [2025-03-05T23:08:50.302Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-03-05T23:08:50.302Z] GC before operation: completed in 282.315 ms, heap usage 314.372 MB -> 67.438 MB. [2025-03-05T23:08:55.030Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (4289.878 ms) ====== [2025-03-05T23:08:55.030Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-03-05T23:08:55.030Z] GC before operation: completed in 340.983 ms, heap usage 193.195 MB -> 95.128 MB. [2025-03-05T23:08:58.751Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3323.777 ms) ====== [2025-03-05T23:08:58.751Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-03-05T23:08:58.751Z] GC before operation: completed in 333.321 ms, heap usage 192.398 MB -> 67.395 MB. [2025-03-05T23:09:04.599Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (5640.075 ms) ====== [2025-03-05T23:09:04.599Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-03-05T23:09:04.599Z] GC before operation: completed in 251.742 ms, heap usage 98.859 MB -> 67.194 MB. [2025-03-05T23:09:10.801Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (6137.475 ms) ====== [2025-03-05T23:09:10.801Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-03-05T23:09:10.801Z] GC before operation: completed in 286.152 ms, heap usage 99.019 MB -> 67.300 MB. [2025-03-05T23:09:16.830Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (5330.684 ms) ====== [2025-03-05T23:09:16.830Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-03-05T23:09:16.830Z] GC before operation: completed in 255.206 ms, heap usage 319.825 MB -> 68.114 MB. [2025-03-05T23:09:22.902Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (5627.102 ms) ====== [2025-03-05T23:09:22.902Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-03-05T23:09:22.902Z] GC before operation: completed in 324.502 ms, heap usage 305.191 MB -> 68.204 MB. [2025-03-05T23:09:26.776Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4006.879 ms) ====== [2025-03-05T23:09:26.776Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-03-05T23:09:26.776Z] GC before operation: completed in 295.556 ms, heap usage 238.000 MB -> 68.147 MB. [2025-03-05T23:09:31.735Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4968.749 ms) ====== [2025-03-05T23:09:31.735Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-03-05T23:09:31.735Z] GC before operation: completed in 259.473 ms, heap usage 206.021 MB -> 81.344 MB. [2025-03-05T23:09:37.788Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4991.624 ms) ====== [2025-03-05T23:09:37.788Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-03-05T23:09:37.788Z] GC before operation: completed in 279.222 ms, heap usage 312.682 MB -> 68.341 MB. [2025-03-05T23:09:41.718Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (3965.400 ms) ====== [2025-03-05T23:09:41.718Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-03-05T23:09:41.718Z] GC before operation: completed in 263.179 ms, heap usage 103.490 MB -> 68.094 MB. [2025-03-05T23:09:46.595Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5179.998 ms) ====== [2025-03-05T23:09:47.470Z] ----------------------------------- [2025-03-05T23:09:47.470Z] renaissance-dec-tree_0_PASSED [2025-03-05T23:09:47.470Z] ----------------------------------- [2025-03-05T23:09:47.470Z] [2025-03-05T23:09:47.470Z] TEST TEARDOWN: [2025-03-05T23:09:47.470Z] Nothing to be done for teardown. [2025-03-05T23:09:47.470Z] renaissance-dec-tree_0 Finish Time: Wed Mar 5 15:09:46 2025 Epoch Time (ms): 1741216186915