[2024-11-21T16:33:44.475Z] Running test renaissance-dec-tree_0 ... [2024-11-21T16:33:44.475Z] =============================================== [2024-11-21T16:33:44.475Z] renaissance-dec-tree_0 Start Time: Thu Nov 21 08:33:44 2024 Epoch Time (ms): 1732206824359 [2024-11-21T16:33:44.882Z] variation: NoOptions [2024-11-21T16:33:44.882Z] JVM_OPTIONS: [2024-11-21T16:33:44.882Z] { \ [2024-11-21T16:33:44.882Z] echo ""; echo "TEST SETUP:"; \ [2024-11-21T16:33:44.882Z] echo "Nothing to be done for setup."; \ [2024-11-21T16:33:44.882Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17322063229215/renaissance-dec-tree_0"; \ [2024-11-21T16:33:44.882Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17322063229215/renaissance-dec-tree_0"; \ [2024-11-21T16:33:44.882Z] echo ""; echo "TESTING:"; \ [2024-11-21T16:33:44.882Z] "/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_17322063229215/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-21T16:33:44.882Z] 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_17322063229215/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-21T16:33:44.882Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-21T16:33:44.882Z] echo "Nothing to be done for teardown."; \ [2024-11-21T16:33:44.882Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17322063229215/TestTargetResult"; [2024-11-21T16:33:44.882Z] [2024-11-21T16:33:44.882Z] TEST SETUP: [2024-11-21T16:33:44.882Z] Nothing to be done for setup. [2024-11-21T16:33:44.882Z] [2024-11-21T16:33:44.882Z] TESTING: [2024-11-21T16:33:51.702Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-21T16:33:53.706Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-11-21T16:33:56.627Z] WARNING: An illegal reflective access operation has occurred [2024-11-21T16:33:56.627Z] 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_17322063229215/renaissance-dec-tree_0/harness-083345-16575015109015176167/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-11-21T16:33:56.627Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-11-21T16:33:56.627Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-11-21T16:33:56.627Z] WARNING: All illegal access operations will be denied in a future release [2024-11-21T16:33:59.371Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-21T16:33:59.372Z] GC before operation: completed in 100.790 ms, heap usage 60.624 MB -> 33.840 MB. [2024-11-21T16:34:16.813Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (15629.771 ms) ====== [2024-11-21T16:34:16.813Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-21T16:34:16.813Z] GC before operation: completed in 241.720 ms, heap usage 350.992 MB -> 63.745 MB. [2024-11-21T16:34:20.625Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4691.653 ms) ====== [2024-11-21T16:34:20.625Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-21T16:34:20.625Z] GC before operation: completed in 160.162 ms, heap usage 180.880 MB -> 63.918 MB. [2024-11-21T16:34:25.313Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4356.674 ms) ====== [2024-11-21T16:34:25.313Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-21T16:34:25.313Z] GC before operation: completed in 163.448 ms, heap usage 127.046 MB -> 91.617 MB. [2024-11-21T16:34:28.977Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4016.180 ms) ====== [2024-11-21T16:34:28.977Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-21T16:34:28.977Z] GC before operation: completed in 211.307 ms, heap usage 235.369 MB -> 64.525 MB. [2024-11-21T16:34:32.791Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3906.219 ms) ====== [2024-11-21T16:34:32.791Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-21T16:34:33.221Z] GC before operation: completed in 203.733 ms, heap usage 157.096 MB -> 64.474 MB. [2024-11-21T16:34:36.089Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2988.773 ms) ====== [2024-11-21T16:34:36.090Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-21T16:34:36.090Z] GC before operation: completed in 168.541 ms, heap usage 159.002 MB -> 64.830 MB. [2024-11-21T16:34:39.862Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3305.797 ms) ====== [2024-11-21T16:34:39.862Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-21T16:34:39.862Z] GC before operation: completed in 219.496 ms, heap usage 364.509 MB -> 65.305 MB. [2024-11-21T16:34:43.479Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3438.356 ms) ====== [2024-11-21T16:34:43.479Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-21T16:34:43.479Z] GC before operation: completed in 184.970 ms, heap usage 113.665 MB -> 92.300 MB. [2024-11-21T16:34:46.317Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2733.662 ms) ====== [2024-11-21T16:34:46.317Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-21T16:34:46.317Z] GC before operation: completed in 226.817 ms, heap usage 269.774 MB -> 90.766 MB. [2024-11-21T16:34:49.092Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2622.506 ms) ====== [2024-11-21T16:34:49.092Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-21T16:34:49.092Z] GC before operation: completed in 244.894 ms, heap usage 215.766 MB -> 65.626 MB. [2024-11-21T16:34:52.758Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (3179.845 ms) ====== [2024-11-21T16:34:52.758Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-21T16:34:52.758Z] GC before operation: completed in 222.272 ms, heap usage 361.020 MB -> 65.802 MB. [2024-11-21T16:34:55.574Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2656.237 ms) ====== [2024-11-21T16:34:55.574Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-21T16:34:55.574Z] GC before operation: completed in 198.271 ms, heap usage 267.606 MB -> 65.690 MB. [2024-11-21T16:34:58.411Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2607.059 ms) ====== [2024-11-21T16:34:58.411Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-21T16:34:58.411Z] GC before operation: completed in 262.506 ms, heap usage 193.820 MB -> 93.391 MB. [2024-11-21T16:35:01.359Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3109.821 ms) ====== [2024-11-21T16:35:01.359Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-21T16:35:01.881Z] GC before operation: completed in 205.722 ms, heap usage 400.827 MB -> 78.844 MB. [2024-11-21T16:35:03.997Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2386.087 ms) ====== [2024-11-21T16:35:03.997Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-21T16:35:04.419Z] GC before operation: completed in 283.464 ms, heap usage 320.604 MB -> 66.151 MB. [2024-11-21T16:35:07.300Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2474.759 ms) ====== [2024-11-21T16:35:07.300Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-21T16:35:07.300Z] GC before operation: completed in 215.264 ms, heap usage 157.402 MB -> 65.900 MB. [2024-11-21T16:35:10.139Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2879.607 ms) ====== [2024-11-21T16:35:10.139Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-21T16:35:10.139Z] GC before operation: completed in 228.452 ms, heap usage 204.141 MB -> 93.863 MB. [2024-11-21T16:35:12.900Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2608.801 ms) ====== [2024-11-21T16:35:12.900Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-21T16:35:12.900Z] GC before operation: completed in 183.692 ms, heap usage 423.324 MB -> 66.400 MB. [2024-11-21T16:35:15.759Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2521.039 ms) ====== [2024-11-21T16:35:15.759Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-21T16:35:15.759Z] GC before operation: completed in 221.184 ms, heap usage 193.683 MB -> 66.463 MB. [2024-11-21T16:35:18.475Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2653.825 ms) ====== [2024-11-21T16:35:18.475Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-21T16:35:18.475Z] GC before operation: completed in 195.440 ms, heap usage 210.843 MB -> 66.923 MB. [2024-11-21T16:35:21.348Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2582.598 ms) ====== [2024-11-21T16:35:21.348Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-21T16:35:21.348Z] GC before operation: completed in 204.252 ms, heap usage 307.223 MB -> 66.654 MB. [2024-11-21T16:35:24.216Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2755.316 ms) ====== [2024-11-21T16:35:24.216Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-21T16:35:24.216Z] GC before operation: completed in 210.023 ms, heap usage 204.525 MB -> 66.915 MB. [2024-11-21T16:35:27.001Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2220.673 ms) ====== [2024-11-21T16:35:27.001Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-21T16:35:27.001Z] GC before operation: completed in 195.944 ms, heap usage 143.294 MB -> 66.731 MB. [2024-11-21T16:35:29.060Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2252.386 ms) ====== [2024-11-21T16:35:29.060Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-21T16:35:29.060Z] GC before operation: completed in 181.701 ms, heap usage 251.515 MB -> 66.969 MB. [2024-11-21T16:35:31.844Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2503.811 ms) ====== [2024-11-21T16:35:31.844Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-21T16:35:31.844Z] GC before operation: completed in 232.879 ms, heap usage 271.932 MB -> 80.159 MB. [2024-11-21T16:35:33.906Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2151.350 ms) ====== [2024-11-21T16:35:33.906Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-21T16:35:34.327Z] GC before operation: completed in 180.419 ms, heap usage 170.097 MB -> 67.288 MB. [2024-11-21T16:35:37.112Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2651.382 ms) ====== [2024-11-21T16:35:37.112Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-21T16:35:37.112Z] GC before operation: completed in 199.665 ms, heap usage 182.188 MB -> 67.260 MB. [2024-11-21T16:35:39.287Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2128.705 ms) ====== [2024-11-21T16:35:39.287Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-21T16:35:39.287Z] GC before operation: completed in 191.602 ms, heap usage 108.240 MB -> 94.000 MB. [2024-11-21T16:35:42.111Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2562.758 ms) ====== [2024-11-21T16:35:42.111Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-21T16:35:42.111Z] GC before operation: completed in 229.323 ms, heap usage 371.015 MB -> 80.548 MB. [2024-11-21T16:35:44.888Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2299.178 ms) ====== [2024-11-21T16:35:44.888Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-21T16:35:44.889Z] GC before operation: completed in 223.329 ms, heap usage 224.606 MB -> 95.148 MB. [2024-11-21T16:35:46.964Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2144.191 ms) ====== [2024-11-21T16:35:46.964Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-21T16:35:46.964Z] GC before operation: completed in 205.884 ms, heap usage 339.332 MB -> 67.802 MB. [2024-11-21T16:35:50.168Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2996.327 ms) ====== [2024-11-21T16:35:50.168Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-21T16:35:50.168Z] GC before operation: completed in 256.326 ms, heap usage 321.909 MB -> 67.899 MB. [2024-11-21T16:35:52.859Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2318.178 ms) ====== [2024-11-21T16:35:52.859Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-21T16:35:52.859Z] GC before operation: completed in 248.713 ms, heap usage 363.491 MB -> 67.854 MB. [2024-11-21T16:35:55.706Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2454.683 ms) ====== [2024-11-21T16:35:55.706Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-21T16:35:55.706Z] GC before operation: completed in 211.675 ms, heap usage 201.815 MB -> 67.955 MB. [2024-11-21T16:35:57.864Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2299.850 ms) ====== [2024-11-21T16:35:57.864Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-21T16:35:58.301Z] GC before operation: completed in 205.177 ms, heap usage 199.994 MB -> 68.059 MB. [2024-11-21T16:36:00.400Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2230.637 ms) ====== [2024-11-21T16:36:00.400Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-21T16:36:00.400Z] GC before operation: completed in 199.738 ms, heap usage 194.435 MB -> 95.740 MB. [2024-11-21T16:36:03.176Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2317.591 ms) ====== [2024-11-21T16:36:03.176Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-21T16:36:03.176Z] GC before operation: completed in 204.733 ms, heap usage 133.980 MB -> 67.943 MB. [2024-11-21T16:36:06.017Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2478.275 ms) ====== [2024-11-21T16:36:06.017Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-21T16:36:06.017Z] GC before operation: completed in 254.467 ms, heap usage 291.305 MB -> 95.937 MB. [2024-11-21T16:36:08.243Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2278.011 ms) ====== [2024-11-21T16:36:08.243Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-21T16:36:08.243Z] GC before operation: completed in 235.817 ms, heap usage 219.923 MB -> 68.439 MB. [2024-11-21T16:36:10.927Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2503.876 ms) ====== [2024-11-21T16:36:11.315Z] ----------------------------------- [2024-11-21T16:36:11.315Z] renaissance-dec-tree_0_PASSED [2024-11-21T16:36:11.315Z] ----------------------------------- [2024-11-21T16:36:11.315Z] [2024-11-21T16:36:11.315Z] TEST TEARDOWN: [2024-11-21T16:36:11.315Z] Nothing to be done for teardown. [2024-11-21T16:36:11.704Z] renaissance-dec-tree_0 Finish Time: Thu Nov 21 08:36:11 2024 Epoch Time (ms): 1732206971334