[2024-08-28T21:36:58.607Z] Running test renaissance-dec-tree_0 ... [2024-08-28T21:36:58.607Z] =============================================== [2024-08-28T21:36:58.607Z] renaissance-dec-tree_0 Start Time: Wed Aug 28 21:36:58 2024 Epoch Time (ms): 1724881018160 [2024-08-28T21:36:58.607Z] variation: NoOptions [2024-08-28T21:36:58.607Z] JVM_OPTIONS: [2024-08-28T21:36:58.607Z] { \ [2024-08-28T21:36:58.607Z] echo ""; echo "TEST SETUP:"; \ [2024-08-28T21:36:58.607Z] echo "Nothing to be done for setup."; \ [2024-08-28T21:36:58.607Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248807774153/renaissance-dec-tree_0"; \ [2024-08-28T21:36:58.607Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248807774153/renaissance-dec-tree_0"; \ [2024-08-28T21:36:58.607Z] echo ""; echo "TESTING:"; \ [2024-08-28T21:36:58.607Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/jdkbinary/j2sdk-image/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 "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248807774153/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-28T21:36:58.607Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248807774153/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-28T21:36:58.607Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-28T21:36:58.607Z] echo "Nothing to be done for teardown."; \ [2024-08-28T21:36:58.607Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248807774153/TestTargetResult"; [2024-08-28T21:36:58.607Z] [2024-08-28T21:36:58.607Z] TEST SETUP: [2024-08-28T21:36:58.607Z] Nothing to be done for setup. [2024-08-28T21:36:58.607Z] [2024-08-28T21:36:58.607Z] TESTING: [2024-08-28T21:37:01.570Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-28T21:37:03.487Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-28T21:37:04.423Z] WARNING: An illegal reflective access operation has occurred [2024-08-28T21:37:04.423Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17248807774153/renaissance-dec-tree_0/harness-213658-4366056275452406756/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-28T21:37:04.423Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-28T21:37:04.423Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-28T21:37:04.423Z] WARNING: All illegal access operations will be denied in a future release [2024-08-28T21:37:06.343Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-28T21:37:06.343Z] GC before operation: completed in 42.276 ms, heap usage 113.644 MB -> 34.335 MB. [2024-08-28T21:37:14.412Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6819.097 ms) ====== [2024-08-28T21:37:14.412Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-28T21:37:14.412Z] GC before operation: completed in 95.795 ms, heap usage 254.571 MB -> 64.579 MB. [2024-08-28T21:37:15.347Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1694.944 ms) ====== [2024-08-28T21:37:15.347Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-28T21:37:15.347Z] GC before operation: completed in 83.860 ms, heap usage 165.732 MB -> 64.262 MB. [2024-08-28T21:37:16.456Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1391.259 ms) ====== [2024-08-28T21:37:16.456Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-28T21:37:16.456Z] GC before operation: completed in 89.438 ms, heap usage 195.610 MB -> 64.955 MB. [2024-08-28T21:37:18.377Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1276.440 ms) ====== [2024-08-28T21:37:18.377Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-28T21:37:18.377Z] GC before operation: completed in 89.680 ms, heap usage 130.222 MB -> 64.896 MB. [2024-08-28T21:37:19.312Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1284.686 ms) ====== [2024-08-28T21:37:19.312Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-28T21:37:19.312Z] GC before operation: completed in 98.324 ms, heap usage 181.428 MB -> 65.405 MB. [2024-08-28T21:37:21.230Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1236.364 ms) ====== [2024-08-28T21:37:21.230Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-28T21:37:21.230Z] GC before operation: completed in 93.915 ms, heap usage 248.184 MB -> 65.631 MB. [2024-08-28T21:37:22.163Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1201.810 ms) ====== [2024-08-28T21:37:22.163Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-28T21:37:22.163Z] GC before operation: completed in 100.617 ms, heap usage 202.689 MB -> 65.687 MB. [2024-08-28T21:37:23.096Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1155.927 ms) ====== [2024-08-28T21:37:23.096Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-28T21:37:23.097Z] GC before operation: completed in 103.762 ms, heap usage 214.792 MB -> 65.804 MB. [2024-08-28T21:37:25.017Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1162.429 ms) ====== [2024-08-28T21:37:25.017Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-28T21:37:25.017Z] GC before operation: completed in 109.581 ms, heap usage 250.580 MB -> 66.059 MB. [2024-08-28T21:37:25.951Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1137.140 ms) ====== [2024-08-28T21:37:25.951Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-28T21:37:25.951Z] GC before operation: completed in 115.327 ms, heap usage 219.761 MB -> 66.028 MB. [2024-08-28T21:37:26.885Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1104.452 ms) ====== [2024-08-28T21:37:26.885Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-28T21:37:26.885Z] GC before operation: completed in 113.778 ms, heap usage 211.811 MB -> 66.139 MB. [2024-08-28T21:37:29.197Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1104.364 ms) ====== [2024-08-28T21:37:29.197Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-28T21:37:29.197Z] GC before operation: completed in 112.183 ms, heap usage 246.479 MB -> 66.389 MB. [2024-08-28T21:37:29.197Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1116.203 ms) ====== [2024-08-28T21:37:29.197Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-28T21:37:29.197Z] GC before operation: completed in 111.639 ms, heap usage 192.912 MB -> 66.366 MB. [2024-08-28T21:37:31.121Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1092.698 ms) ====== [2024-08-28T21:37:31.121Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-28T21:37:31.121Z] GC before operation: completed in 112.776 ms, heap usage 201.762 MB -> 66.464 MB. [2024-08-28T21:37:32.055Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1118.176 ms) ====== [2024-08-28T21:37:32.055Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-28T21:37:32.055Z] GC before operation: completed in 133.390 ms, heap usage 237.536 MB -> 66.576 MB. [2024-08-28T21:37:32.989Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1073.657 ms) ====== [2024-08-28T21:37:32.989Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-28T21:37:32.989Z] GC before operation: completed in 129.708 ms, heap usage 216.647 MB -> 66.894 MB. [2024-08-28T21:37:33.934Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1071.841 ms) ====== [2024-08-28T21:37:33.934Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-28T21:37:34.868Z] GC before operation: completed in 131.072 ms, heap usage 185.691 MB -> 66.994 MB. [2024-08-28T21:37:35.804Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1079.285 ms) ====== [2024-08-28T21:37:35.804Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-28T21:37:35.804Z] GC before operation: completed in 132.428 ms, heap usage 229.738 MB -> 67.120 MB. [2024-08-28T21:37:36.741Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1093.752 ms) ====== [2024-08-28T21:37:36.741Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-28T21:37:36.741Z] GC before operation: completed in 143.961 ms, heap usage 144.401 MB -> 66.930 MB. [2024-08-28T21:37:37.675Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1066.849 ms) ====== [2024-08-28T21:37:37.675Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-28T21:37:38.610Z] GC before operation: completed in 137.000 ms, heap usage 195.593 MB -> 67.320 MB. [2024-08-28T21:37:39.544Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1042.928 ms) ====== [2024-08-28T21:37:39.544Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-28T21:37:39.544Z] GC before operation: completed in 139.146 ms, heap usage 190.231 MB -> 67.280 MB. [2024-08-28T21:37:40.478Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1044.467 ms) ====== [2024-08-28T21:37:40.478Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-28T21:37:40.478Z] GC before operation: completed in 142.118 ms, heap usage 189.070 MB -> 67.353 MB. [2024-08-28T21:37:41.412Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1022.759 ms) ====== [2024-08-28T21:37:41.412Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-28T21:37:41.412Z] GC before operation: completed in 139.893 ms, heap usage 238.023 MB -> 67.600 MB. [2024-08-28T21:37:42.345Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1018.910 ms) ====== [2024-08-28T21:37:42.345Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-28T21:37:43.279Z] GC before operation: completed in 144.948 ms, heap usage 220.083 MB -> 67.557 MB. [2024-08-28T21:37:44.215Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1022.380 ms) ====== [2024-08-28T21:37:44.215Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-28T21:37:44.215Z] GC before operation: completed in 144.739 ms, heap usage 168.054 MB -> 67.533 MB. [2024-08-28T21:37:45.161Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1023.572 ms) ====== [2024-08-28T21:37:45.161Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-28T21:37:45.161Z] GC before operation: completed in 146.092 ms, heap usage 217.529 MB -> 67.746 MB. [2024-08-28T21:37:46.097Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1046.377 ms) ====== [2024-08-28T21:37:46.097Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-28T21:37:46.097Z] GC before operation: completed in 144.182 ms, heap usage 184.359 MB -> 67.855 MB. [2024-08-28T21:37:47.031Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1067.036 ms) ====== [2024-08-28T21:37:47.032Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-28T21:37:47.980Z] GC before operation: completed in 169.854 ms, heap usage 209.384 MB -> 68.099 MB. [2024-08-28T21:37:48.914Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1044.862 ms) ====== [2024-08-28T21:37:48.914Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-28T21:37:48.914Z] GC before operation: completed in 147.617 ms, heap usage 119.417 MB -> 67.492 MB. [2024-08-28T21:37:49.848Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1023.490 ms) ====== [2024-08-28T21:37:49.848Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-28T21:37:49.848Z] GC before operation: completed in 140.115 ms, heap usage 157.393 MB -> 67.884 MB. [2024-08-28T21:37:50.783Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1028.055 ms) ====== [2024-08-28T21:37:50.783Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-28T21:37:50.783Z] GC before operation: completed in 142.394 ms, heap usage 148.458 MB -> 67.939 MB. [2024-08-28T21:37:52.701Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1032.196 ms) ====== [2024-08-28T21:37:52.701Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-28T21:37:52.701Z] GC before operation: completed in 142.956 ms, heap usage 132.335 MB -> 68.037 MB. [2024-08-28T21:37:53.637Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1023.514 ms) ====== [2024-08-28T21:37:53.637Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-28T21:37:53.637Z] GC before operation: completed in 145.726 ms, heap usage 148.074 MB -> 68.135 MB. [2024-08-28T21:37:54.571Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1010.817 ms) ====== [2024-08-28T21:37:54.571Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-28T21:37:54.571Z] GC before operation: completed in 147.510 ms, heap usage 273.237 MB -> 68.528 MB. [2024-08-28T21:37:55.509Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1022.150 ms) ====== [2024-08-28T21:37:55.509Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-28T21:37:55.509Z] GC before operation: completed in 150.633 ms, heap usage 176.257 MB -> 68.361 MB. [2024-08-28T21:37:57.431Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1080.538 ms) ====== [2024-08-28T21:37:57.431Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-28T21:37:57.431Z] GC before operation: completed in 150.406 ms, heap usage 288.502 MB -> 68.872 MB. [2024-08-28T21:37:58.367Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1029.351 ms) ====== [2024-08-28T21:37:58.367Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-28T21:37:58.367Z] GC before operation: completed in 158.086 ms, heap usage 233.544 MB -> 68.973 MB. [2024-08-28T21:37:59.474Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1025.521 ms) ====== [2024-08-28T21:37:59.474Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-28T21:37:59.474Z] GC before operation: completed in 151.874 ms, heap usage 250.586 MB -> 69.068 MB. [2024-08-28T21:38:00.411Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1048.312 ms) ====== [2024-08-28T21:38:00.411Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-28T21:38:00.411Z] GC before operation: completed in 150.038 ms, heap usage 104.488 MB -> 68.578 MB. [2024-08-28T21:38:01.346Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1057.658 ms) ====== [2024-08-28T21:38:02.282Z] ----------------------------------- [2024-08-28T21:38:02.282Z] renaissance-dec-tree_0_PASSED [2024-08-28T21:38:02.282Z] ----------------------------------- [2024-08-28T21:38:02.282Z] [2024-08-28T21:38:02.282Z] TEST TEARDOWN: [2024-08-28T21:38:02.282Z] Nothing to be done for teardown. [2024-08-28T21:38:02.282Z] renaissance-dec-tree_0 Finish Time: Wed Aug 28 21:38:01 2024 Epoch Time (ms): 1724881081437