[2024-10-30T21:35:28.554Z] Running test renaissance-dec-tree_0 ... [2024-10-30T21:35:28.554Z] =============================================== [2024-10-30T21:35:28.554Z] renaissance-dec-tree_0 Start Time: Wed Oct 30 17:35:28 2024 Epoch Time (ms): 1730324128435 [2024-10-30T21:35:28.554Z] variation: NoOptions [2024-10-30T21:35:28.554Z] JVM_OPTIONS: [2024-10-30T21:35:28.554Z] { \ [2024-10-30T21:35:28.554Z] echo ""; echo "TEST SETUP:"; \ [2024-10-30T21:35:28.554Z] echo "Nothing to be done for setup."; \ [2024-10-30T21:35:28.554Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17303239888217/renaissance-dec-tree_0"; \ [2024-10-30T21:35:28.554Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17303239888217/renaissance-dec-tree_0"; \ [2024-10-30T21:35:28.554Z] echo ""; echo "TESTING:"; \ [2024-10-30T21:35:28.555Z] "/Users/admin/workspace/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17303239888217/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-30T21:35:28.555Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17303239888217/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-30T21:35:28.555Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-30T21:35:28.555Z] echo "Nothing to be done for teardown."; \ [2024-10-30T21:35:28.555Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17303239888217/TestTargetResult"; [2024-10-30T21:35:28.555Z] [2024-10-30T21:35:28.555Z] TEST SETUP: [2024-10-30T21:35:28.555Z] Nothing to be done for setup. [2024-10-30T21:35:28.555Z] [2024-10-30T21:35:28.555Z] TESTING: [2024-10-30T21:35:30.373Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-30T21:35:30.742Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-10-30T21:35:32.010Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-30T21:35:32.010Z] GC before operation: completed in 18.912 ms, heap usage 51.226 MB -> 35.152 MB. [2024-10-30T21:35:35.248Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (3256.949 ms) ====== [2024-10-30T21:35:35.249Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-30T21:35:35.249Z] GC before operation: completed in 31.152 ms, heap usage 145.050 MB -> 64.683 MB. [2024-10-30T21:35:36.057Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1045.867 ms) ====== [2024-10-30T21:35:36.057Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-30T21:35:36.057Z] GC before operation: completed in 29.705 ms, heap usage 217.967 MB -> 64.892 MB. [2024-10-30T21:35:36.889Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (809.173 ms) ====== [2024-10-30T21:35:36.890Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-30T21:35:36.890Z] GC before operation: completed in 28.444 ms, heap usage 110.536 MB -> 64.602 MB. [2024-10-30T21:35:37.677Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (708.369 ms) ====== [2024-10-30T21:35:37.677Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-30T21:35:37.677Z] GC before operation: completed in 28.699 ms, heap usage 196.602 MB -> 65.390 MB. [2024-10-30T21:35:38.533Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (668.165 ms) ====== [2024-10-30T21:35:38.533Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-30T21:35:38.533Z] GC before operation: completed in 32.509 ms, heap usage 275.749 MB -> 65.757 MB. [2024-10-30T21:35:38.921Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (634.343 ms) ====== [2024-10-30T21:35:38.921Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-30T21:35:39.297Z] GC before operation: completed in 30.239 ms, heap usage 96.725 MB -> 65.516 MB. [2024-10-30T21:35:39.687Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (632.587 ms) ====== [2024-10-30T21:35:39.687Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-30T21:35:39.687Z] GC before operation: completed in 32.372 ms, heap usage 396.347 MB -> 66.087 MB. [2024-10-30T21:35:40.544Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (621.947 ms) ====== [2024-10-30T21:35:40.544Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-30T21:35:40.544Z] GC before operation: completed in 32.876 ms, heap usage 251.225 MB -> 66.210 MB. [2024-10-30T21:35:40.938Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (605.699 ms) ====== [2024-10-30T21:35:40.938Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-30T21:35:40.938Z] GC before operation: completed in 33.702 ms, heap usage 228.963 MB -> 66.253 MB. [2024-10-30T21:35:41.854Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (654.443 ms) ====== [2024-10-30T21:35:41.854Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-30T21:35:41.854Z] GC before operation: completed in 45.926 ms, heap usage 246.984 MB -> 66.415 MB. [2024-10-30T21:35:42.642Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (656.542 ms) ====== [2024-10-30T21:35:42.642Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-30T21:35:42.642Z] GC before operation: completed in 32.302 ms, heap usage 236.219 MB -> 66.535 MB. [2024-10-30T21:35:43.015Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (621.611 ms) ====== [2024-10-30T21:35:43.015Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-30T21:35:43.015Z] GC before operation: completed in 37.722 ms, heap usage 230.627 MB -> 66.701 MB. [2024-10-30T21:35:43.864Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (710.865 ms) ====== [2024-10-30T21:35:43.864Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-30T21:35:43.864Z] GC before operation: completed in 43.860 ms, heap usage 235.455 MB -> 66.995 MB. [2024-10-30T21:35:44.712Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (653.883 ms) ====== [2024-10-30T21:35:44.712Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-30T21:35:44.712Z] GC before operation: completed in 36.144 ms, heap usage 233.599 MB -> 66.945 MB. [2024-10-30T21:35:45.089Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (630.331 ms) ====== [2024-10-30T21:35:45.089Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-30T21:35:45.089Z] GC before operation: completed in 53.382 ms, heap usage 330.544 MB -> 67.020 MB. [2024-10-30T21:35:45.888Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (664.357 ms) ====== [2024-10-30T21:35:45.888Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-30T21:35:45.888Z] GC before operation: completed in 37.578 ms, heap usage 321.301 MB -> 67.378 MB. [2024-10-30T21:35:46.681Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (582.850 ms) ====== [2024-10-30T21:35:46.681Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-30T21:35:46.681Z] GC before operation: completed in 41.643 ms, heap usage 324.262 MB -> 67.343 MB. [2024-10-30T21:35:47.056Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (610.644 ms) ====== [2024-10-30T21:35:47.056Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-30T21:35:47.056Z] GC before operation: completed in 35.105 ms, heap usage 303.835 MB -> 67.440 MB. [2024-10-30T21:35:47.859Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (636.894 ms) ====== [2024-10-30T21:35:47.859Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-30T21:35:47.859Z] GC before operation: completed in 42.609 ms, heap usage 201.442 MB -> 95.341 MB. [2024-10-30T21:35:48.663Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (581.793 ms) ====== [2024-10-30T21:35:48.663Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-30T21:35:48.663Z] GC before operation: completed in 35.331 ms, heap usage 146.421 MB -> 67.040 MB. [2024-10-30T21:35:49.031Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (617.102 ms) ====== [2024-10-30T21:35:49.031Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-30T21:35:49.031Z] GC before operation: completed in 40.386 ms, heap usage 202.060 MB -> 67.732 MB. [2024-10-30T21:35:49.884Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (575.427 ms) ====== [2024-10-30T21:35:49.884Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-30T21:35:49.884Z] GC before operation: completed in 41.320 ms, heap usage 320.338 MB -> 67.860 MB. [2024-10-30T21:35:50.679Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (648.808 ms) ====== [2024-10-30T21:35:50.679Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-30T21:35:50.679Z] GC before operation: completed in 44.037 ms, heap usage 199.204 MB -> 68.135 MB. [2024-10-30T21:35:51.055Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (592.364 ms) ====== [2024-10-30T21:35:51.055Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-30T21:35:51.055Z] GC before operation: completed in 56.811 ms, heap usage 277.511 MB -> 68.211 MB. [2024-10-30T21:35:51.866Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (620.891 ms) ====== [2024-10-30T21:35:51.866Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-30T21:35:51.866Z] GC before operation: completed in 51.709 ms, heap usage 301.725 MB -> 80.895 MB. [2024-10-30T21:35:52.246Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (553.902 ms) ====== [2024-10-30T21:35:52.246Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-30T21:35:52.246Z] GC before operation: completed in 39.667 ms, heap usage 224.515 MB -> 68.309 MB. [2024-10-30T21:35:53.061Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (626.858 ms) ====== [2024-10-30T21:35:53.061Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-30T21:35:53.061Z] GC before operation: completed in 39.414 ms, heap usage 184.410 MB -> 68.633 MB. [2024-10-30T21:35:53.852Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (569.848 ms) ====== [2024-10-30T21:35:53.852Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-30T21:35:53.852Z] GC before operation: completed in 41.879 ms, heap usage 288.195 MB -> 68.466 MB. [2024-10-30T21:35:54.224Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (601.088 ms) ====== [2024-10-30T21:35:54.224Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-30T21:35:54.224Z] GC before operation: completed in 45.042 ms, heap usage 203.946 MB -> 68.590 MB. [2024-10-30T21:35:55.052Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (583.505 ms) ====== [2024-10-30T21:35:55.052Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-30T21:35:55.052Z] GC before operation: completed in 43.002 ms, heap usage 321.299 MB -> 68.712 MB. [2024-10-30T21:35:55.434Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (588.199 ms) ====== [2024-10-30T21:35:55.434Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-30T21:35:55.434Z] GC before operation: completed in 43.118 ms, heap usage 292.200 MB -> 68.979 MB. [2024-10-30T21:35:56.260Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (576.890 ms) ====== [2024-10-30T21:35:56.260Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-30T21:35:56.260Z] GC before operation: completed in 43.707 ms, heap usage 185.862 MB -> 68.930 MB. [2024-10-30T21:35:56.632Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (561.247 ms) ====== [2024-10-30T21:35:56.632Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-30T21:35:57.002Z] GC before operation: completed in 42.884 ms, heap usage 173.264 MB -> 68.921 MB. [2024-10-30T21:35:57.385Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (567.750 ms) ====== [2024-10-30T21:35:57.385Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-30T21:35:57.385Z] GC before operation: completed in 42.857 ms, heap usage 108.631 MB -> 68.727 MB. [2024-10-30T21:35:58.174Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (564.663 ms) ====== [2024-10-30T21:35:58.174Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-30T21:35:58.174Z] GC before operation: completed in 44.736 ms, heap usage 332.602 MB -> 69.244 MB. [2024-10-30T21:35:58.545Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (551.535 ms) ====== [2024-10-30T21:35:58.545Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-30T21:35:58.545Z] GC before operation: completed in 42.478 ms, heap usage 169.519 MB -> 69.097 MB. [2024-10-30T21:35:59.336Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (553.468 ms) ====== [2024-10-30T21:35:59.336Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-30T21:35:59.336Z] GC before operation: completed in 40.578 ms, heap usage 119.141 MB -> 68.929 MB. [2024-10-30T21:35:59.711Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (539.074 ms) ====== [2024-10-30T21:35:59.711Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-30T21:35:59.711Z] GC before operation: completed in 61.516 ms, heap usage 346.976 MB -> 97.201 MB. [2024-10-30T21:36:00.508Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (694.696 ms) ====== [2024-10-30T21:36:00.508Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-30T21:36:00.508Z] GC before operation: completed in 46.894 ms, heap usage 257.227 MB -> 82.824 MB. [2024-10-30T21:36:01.306Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (527.520 ms) ====== [2024-10-30T21:36:01.306Z] ----------------------------------- [2024-10-30T21:36:01.306Z] renaissance-dec-tree_0_PASSED [2024-10-30T21:36:01.306Z] ----------------------------------- [2024-10-30T21:36:01.306Z] [2024-10-30T21:36:01.306Z] TEST TEARDOWN: [2024-10-30T21:36:01.306Z] Nothing to be done for teardown. [2024-10-30T21:36:01.306Z] renaissance-dec-tree_0 Finish Time: Wed Oct 30 17:36:01 2024 Epoch Time (ms): 1730324161019