[2024-08-29T02:41:27.505Z] Running test renaissance-dec-tree_0 ... [2024-08-29T02:41:27.505Z] =============================================== [2024-08-29T02:41:27.505Z] renaissance-dec-tree_0 Start Time: Wed Aug 28 19:41:25 2024 Epoch Time (ms): 1724899285535 [2024-08-29T02:41:27.505Z] variation: NoOptions [2024-08-29T02:41:27.505Z] JVM_OPTIONS: [2024-08-29T02:41:27.505Z] { \ [2024-08-29T02:41:27.505Z] echo ""; echo "TEST SETUP:"; \ [2024-08-29T02:41:27.505Z] echo "Nothing to be done for setup."; \ [2024-08-29T02:41:27.505Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17248981116111/renaissance-dec-tree_0"; \ [2024-08-29T02:41:27.505Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17248981116111/renaissance-dec-tree_0"; \ [2024-08-29T02:41:27.505Z] echo ""; echo "TESTING:"; \ [2024-08-29T02:41:27.505Z] "/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_17248981116111/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-29T02:41:27.505Z] 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_17248981116111/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-29T02:41:27.505Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-29T02:41:27.505Z] echo "Nothing to be done for teardown."; \ [2024-08-29T02:41:27.505Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17248981116111/TestTargetResult"; [2024-08-29T02:41:27.505Z] [2024-08-29T02:41:27.505Z] TEST SETUP: [2024-08-29T02:41:27.505Z] Nothing to be done for setup. [2024-08-29T02:41:27.505Z] [2024-08-29T02:41:27.505Z] TESTING: [2024-08-29T02:41:36.395Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-29T02:41:38.502Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-08-29T02:41:39.798Z] WARNING: An illegal reflective access operation has occurred [2024-08-29T02:41:39.798Z] 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_17248981116111/renaissance-dec-tree_0/harness-194127-13130326860391713338/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-29T02:41:39.798Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-29T02:41:39.798Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-29T02:41:39.798Z] WARNING: All illegal access operations will be denied in a future release [2024-08-29T02:41:42.583Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-29T02:41:42.583Z] GC before operation: completed in 49.064 ms, heap usage 126.720 MB -> 33.849 MB. [2024-08-29T02:41:54.804Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (11232.479 ms) ====== [2024-08-29T02:41:54.804Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-29T02:41:54.804Z] GC before operation: completed in 183.893 ms, heap usage 141.704 MB -> 63.802 MB. [2024-08-29T02:42:00.563Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (5836.203 ms) ====== [2024-08-29T02:42:00.564Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-29T02:42:00.564Z] GC before operation: completed in 179.796 ms, heap usage 235.463 MB -> 89.557 MB. [2024-08-29T02:42:05.407Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5387.029 ms) ====== [2024-08-29T02:42:05.407Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-29T02:42:05.407Z] GC before operation: completed in 98.773 ms, heap usage 321.390 MB -> 64.507 MB. [2024-08-29T02:42:09.159Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3730.332 ms) ====== [2024-08-29T02:42:09.159Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-29T02:42:09.159Z] GC before operation: completed in 128.714 ms, heap usage 145.977 MB -> 91.836 MB. [2024-08-29T02:42:12.746Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3530.091 ms) ====== [2024-08-29T02:42:12.746Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-29T02:42:12.746Z] GC before operation: completed in 107.317 ms, heap usage 202.160 MB -> 64.610 MB. [2024-08-29T02:42:15.713Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2984.437 ms) ====== [2024-08-29T02:42:15.713Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-29T02:42:16.149Z] GC before operation: completed in 72.746 ms, heap usage 278.905 MB -> 65.083 MB. [2024-08-29T02:42:18.989Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2684.057 ms) ====== [2024-08-29T02:42:18.989Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-29T02:42:18.989Z] GC before operation: completed in 85.497 ms, heap usage 361.383 MB -> 65.276 MB. [2024-08-29T02:42:21.009Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1986.546 ms) ====== [2024-08-29T02:42:21.009Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-29T02:42:21.009Z] GC before operation: completed in 72.892 ms, heap usage 200.354 MB -> 65.799 MB. [2024-08-29T02:42:22.457Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1503.944 ms) ====== [2024-08-29T02:42:22.457Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-29T02:42:22.457Z] GC before operation: completed in 111.499 ms, heap usage 236.165 MB -> 65.495 MB. [2024-08-29T02:42:25.467Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2921.141 ms) ====== [2024-08-29T02:42:25.467Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-29T02:42:25.467Z] GC before operation: completed in 129.009 ms, heap usage 286.812 MB -> 93.083 MB. [2024-08-29T02:42:25.467Z] 24/08/28 19:42:24 WARN BlockManager: Asked to remove block broadcast_138, which does not exist [2024-08-29T02:42:28.116Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2322.749 ms) ====== [2024-08-29T02:42:28.117Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-29T02:42:28.117Z] GC before operation: completed in 120.390 ms, heap usage 191.014 MB -> 65.309 MB. [2024-08-29T02:42:30.292Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1941.239 ms) ====== [2024-08-29T02:42:30.292Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-29T02:42:30.698Z] GC before operation: completed in 750.384 ms, heap usage 189.114 MB -> 65.662 MB. [2024-08-29T02:42:34.957Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3848.582 ms) ====== [2024-08-29T02:42:34.957Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-29T02:42:34.957Z] GC before operation: completed in 192.873 ms, heap usage 450.961 MB -> 65.772 MB. [2024-08-29T02:42:37.877Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3230.081 ms) ====== [2024-08-29T02:42:37.877Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-29T02:42:37.877Z] GC before operation: completed in 122.040 ms, heap usage 168.497 MB -> 78.458 MB. [2024-08-29T02:42:53.036Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (13335.312 ms) ====== [2024-08-29T02:42:53.036Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-29T02:42:53.037Z] GC before operation: completed in 136.726 ms, heap usage 315.341 MB -> 93.590 MB. [2024-08-29T02:42:53.446Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1870.458 ms) ====== [2024-08-29T02:42:53.446Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-29T02:42:53.446Z] GC before operation: completed in 153.310 ms, heap usage 235.907 MB -> 66.304 MB. [2024-08-29T02:42:56.200Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2655.255 ms) ====== [2024-08-29T02:42:56.200Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-29T02:42:56.200Z] GC before operation: completed in 202.428 ms, heap usage 333.501 MB -> 66.258 MB. [2024-08-29T02:43:00.993Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4665.368 ms) ====== [2024-08-29T02:43:00.993Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-29T02:43:01.627Z] GC before operation: completed in 272.254 ms, heap usage 238.970 MB -> 93.952 MB. [2024-08-29T02:43:06.715Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (4811.674 ms) ====== [2024-08-29T02:43:06.715Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-29T02:43:06.715Z] GC before operation: completed in 195.209 ms, heap usage 340.642 MB -> 66.454 MB. [2024-08-29T02:43:09.648Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3009.541 ms) ====== [2024-08-29T02:43:09.648Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-29T02:43:09.648Z] GC before operation: completed in 296.207 ms, heap usage 327.871 MB -> 66.700 MB. [2024-08-29T02:43:11.102Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1538.869 ms) ====== [2024-08-29T02:43:11.102Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-29T02:43:11.102Z] GC before operation: completed in 86.445 ms, heap usage 287.263 MB -> 66.660 MB. [2024-08-29T02:43:13.742Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2140.041 ms) ====== [2024-08-29T02:43:13.742Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-29T02:43:13.742Z] GC before operation: completed in 87.564 ms, heap usage 103.495 MB -> 66.385 MB. [2024-08-29T02:43:14.579Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1061.401 ms) ====== [2024-08-29T02:43:14.579Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-29T02:43:14.579Z] GC before operation: completed in 84.159 ms, heap usage 107.378 MB -> 66.573 MB. [2024-08-29T02:43:17.406Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2457.133 ms) ====== [2024-08-29T02:43:17.406Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-29T02:43:17.406Z] GC before operation: completed in 83.420 ms, heap usage 304.440 MB -> 81.648 MB. [2024-08-29T02:43:18.230Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1053.241 ms) ====== [2024-08-29T02:43:18.230Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-29T02:43:18.230Z] GC before operation: completed in 85.212 ms, heap usage 296.190 MB -> 79.980 MB. [2024-08-29T02:43:19.757Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1375.758 ms) ====== [2024-08-29T02:43:19.757Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-29T02:43:20.797Z] GC before operation: completed in 965.859 ms, heap usage 285.849 MB -> 92.947 MB. [2024-08-29T02:43:22.762Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1772.463 ms) ====== [2024-08-29T02:43:22.762Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-29T02:43:22.762Z] GC before operation: completed in 88.948 ms, heap usage 235.328 MB -> 80.176 MB. [2024-08-29T02:43:24.110Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1673.347 ms) ====== [2024-08-29T02:43:24.110Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-29T02:43:24.110Z] GC before operation: completed in 95.669 ms, heap usage 335.315 MB -> 67.365 MB. [2024-08-29T02:43:25.464Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1027.948 ms) ====== [2024-08-29T02:43:25.464Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-29T02:43:25.464Z] GC before operation: completed in 97.555 ms, heap usage 264.501 MB -> 80.518 MB. [2024-08-29T02:43:28.256Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2760.982 ms) ====== [2024-08-29T02:43:28.256Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-29T02:43:28.256Z] GC before operation: completed in 161.170 ms, heap usage 179.146 MB -> 67.293 MB. [2024-08-29T02:43:31.056Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2629.474 ms) ====== [2024-08-29T02:43:31.056Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-29T02:43:31.056Z] GC before operation: completed in 145.069 ms, heap usage 188.290 MB -> 67.638 MB. [2024-08-29T02:43:32.372Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1193.805 ms) ====== [2024-08-29T02:43:32.372Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-29T02:43:32.372Z] GC before operation: completed in 84.762 ms, heap usage 214.957 MB -> 67.888 MB. [2024-08-29T02:43:34.346Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1853.693 ms) ====== [2024-08-29T02:43:34.346Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-29T02:43:34.346Z] GC before operation: completed in 105.182 ms, heap usage 108.971 MB -> 67.427 MB. [2024-08-29T02:43:35.738Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1201.267 ms) ====== [2024-08-29T02:43:35.738Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-29T02:43:35.738Z] GC before operation: completed in 93.739 ms, heap usage 206.444 MB -> 68.335 MB. [2024-08-29T02:43:37.140Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1170.377 ms) ====== [2024-08-29T02:43:37.140Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-29T02:43:37.140Z] GC before operation: completed in 293.008 ms, heap usage 145.032 MB -> 95.353 MB. [2024-08-29T02:43:39.119Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1807.972 ms) ====== [2024-08-29T02:43:39.119Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-29T02:43:39.119Z] GC before operation: completed in 137.085 ms, heap usage 160.867 MB -> 67.835 MB. [2024-08-29T02:43:41.168Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1871.175 ms) ====== [2024-08-29T02:43:41.168Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-29T02:43:41.570Z] GC before operation: completed in 444.245 ms, heap usage 359.835 MB -> 83.129 MB. [2024-08-29T02:43:42.937Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1559.412 ms) ====== [2024-08-29T02:43:42.937Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-29T02:43:42.937Z] GC before operation: completed in 161.022 ms, heap usage 424.899 MB -> 68.468 MB. [2024-08-29T02:43:45.767Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2512.299 ms) ====== [2024-08-29T02:43:45.767Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-29T02:43:45.767Z] GC before operation: completed in 123.229 ms, heap usage 164.962 MB -> 95.498 MB. [2024-08-29T02:43:47.162Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1344.258 ms) ====== [2024-08-29T02:43:47.162Z] ----------------------------------- [2024-08-29T02:43:47.162Z] renaissance-dec-tree_0_PASSED [2024-08-29T02:43:47.162Z] ----------------------------------- [2024-08-29T02:43:47.162Z] [2024-08-29T02:43:47.162Z] TEST TEARDOWN: [2024-08-29T02:43:47.162Z] Nothing to be done for teardown. [2024-08-29T02:43:47.528Z] renaissance-dec-tree_0 Finish Time: Wed Aug 28 19:43:46 2024 Epoch Time (ms): 1724899426208