[2024-08-17T07:46:40.692Z] Running test renaissance-dec-tree_0 ... [2024-08-17T07:46:40.692Z] =============================================== [2024-08-17T07:46:40.692Z] renaissance-dec-tree_0 Start Time: Sat Aug 17 07:46:40 2024 Epoch Time (ms): 1723880800044 [2024-08-17T07:46:40.692Z] variation: NoOptions [2024-08-17T07:46:40.692Z] JVM_OPTIONS: [2024-08-17T07:46:40.692Z] { \ [2024-08-17T07:46:40.692Z] echo ""; echo "TEST SETUP:"; \ [2024-08-17T07:46:40.692Z] echo "Nothing to be done for setup."; \ [2024-08-17T07:46:40.692Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_1723880075761/renaissance-dec-tree_0"; \ [2024-08-17T07:46:40.692Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_1723880075761/renaissance-dec-tree_0"; \ [2024-08-17T07:46:40.692Z] echo ""; echo "TESTING:"; \ [2024-08-17T07:46:40.692Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/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_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_1723880075761/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-17T07:46:40.692Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_1723880075761/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-17T07:46:40.692Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-17T07:46:40.692Z] echo "Nothing to be done for teardown."; \ [2024-08-17T07:46:40.692Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_1723880075761/TestTargetResult"; [2024-08-17T07:46:40.692Z] [2024-08-17T07:46:40.692Z] TEST SETUP: [2024-08-17T07:46:40.692Z] Nothing to be done for setup. [2024-08-17T07:46:40.692Z] [2024-08-17T07:46:40.692Z] TESTING: [2024-08-17T07:46:59.623Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-17T07:47:02.117Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 16) threads. [2024-08-17T07:47:07.772Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-17T07:47:07.772Z] GC before operation: completed in 71.460 ms, heap usage 87.171 MB -> 34.779 MB. [2024-08-17T07:47:14.705Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7668.751 ms) ====== [2024-08-17T07:47:14.706Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-17T07:47:14.706Z] GC before operation: completed in 88.813 ms, heap usage 360.253 MB -> 66.376 MB. [2024-08-17T07:47:17.224Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1994.983 ms) ====== [2024-08-17T07:47:17.224Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-17T07:47:17.224Z] GC before operation: completed in 87.008 ms, heap usage 211.485 MB -> 66.985 MB. [2024-08-17T07:47:18.835Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1755.296 ms) ====== [2024-08-17T07:47:18.835Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-17T07:47:18.835Z] GC before operation: completed in 83.279 ms, heap usage 360.394 MB -> 67.019 MB. [2024-08-17T07:47:20.442Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1689.503 ms) ====== [2024-08-17T07:47:20.442Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-17T07:47:20.442Z] GC before operation: completed in 98.193 ms, heap usage 103.606 MB -> 66.689 MB. [2024-08-17T07:47:22.055Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1692.809 ms) ====== [2024-08-17T07:47:22.055Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-17T07:47:22.055Z] GC before operation: completed in 103.480 ms, heap usage 442.274 MB -> 67.484 MB. [2024-08-17T07:47:23.660Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1625.307 ms) ====== [2024-08-17T07:47:23.660Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-17T07:47:24.437Z] GC before operation: completed in 93.452 ms, heap usage 379.358 MB -> 67.655 MB. [2024-08-17T07:47:26.042Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1585.726 ms) ====== [2024-08-17T07:47:26.042Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-17T07:47:26.042Z] GC before operation: completed in 102.632 ms, heap usage 278.252 MB -> 67.779 MB. [2024-08-17T07:47:27.647Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1646.741 ms) ====== [2024-08-17T07:47:27.647Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-17T07:47:27.647Z] GC before operation: completed in 104.441 ms, heap usage 273.413 MB -> 68.250 MB. [2024-08-17T07:47:29.254Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1599.215 ms) ====== [2024-08-17T07:47:29.254Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-17T07:47:29.254Z] GC before operation: completed in 100.058 ms, heap usage 347.956 MB -> 68.159 MB. [2024-08-17T07:47:30.861Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1521.214 ms) ====== [2024-08-17T07:47:30.862Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-17T07:47:30.862Z] GC before operation: completed in 98.011 ms, heap usage 238.154 MB -> 68.160 MB. [2024-08-17T07:47:32.469Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1589.758 ms) ====== [2024-08-17T07:47:32.469Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-17T07:47:32.469Z] GC before operation: completed in 106.055 ms, heap usage 275.076 MB -> 68.277 MB. [2024-08-17T07:47:34.072Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1549.070 ms) ====== [2024-08-17T07:47:34.072Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-17T07:47:34.072Z] GC before operation: completed in 110.936 ms, heap usage 279.929 MB -> 68.610 MB. [2024-08-17T07:47:35.832Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1501.426 ms) ====== [2024-08-17T07:47:35.832Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-17T07:47:35.832Z] GC before operation: completed in 105.968 ms, heap usage 349.806 MB -> 79.573 MB. [2024-08-17T07:47:37.467Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1520.773 ms) ====== [2024-08-17T07:47:37.468Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-17T07:47:37.468Z] GC before operation: completed in 107.022 ms, heap usage 318.912 MB -> 79.696 MB. [2024-08-17T07:47:39.077Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1571.176 ms) ====== [2024-08-17T07:47:39.077Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-17T07:47:39.077Z] GC before operation: completed in 117.716 ms, heap usage 234.935 MB -> 68.874 MB. [2024-08-17T07:47:40.691Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1549.899 ms) ====== [2024-08-17T07:47:40.691Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-17T07:47:40.692Z] GC before operation: completed in 123.476 ms, heap usage 180.128 MB -> 68.787 MB. [2024-08-17T07:47:42.306Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1513.241 ms) ====== [2024-08-17T07:47:42.306Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-17T07:47:42.306Z] GC before operation: completed in 109.843 ms, heap usage 276.337 MB -> 69.014 MB. [2024-08-17T07:47:43.912Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1480.465 ms) ====== [2024-08-17T07:47:43.912Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-17T07:47:43.912Z] GC before operation: completed in 111.327 ms, heap usage 380.513 MB -> 74.531 MB. [2024-08-17T07:47:45.522Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1679.828 ms) ====== [2024-08-17T07:47:45.522Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-17T07:47:45.522Z] GC before operation: completed in 125.736 ms, heap usage 157.994 MB -> 69.310 MB. [2024-08-17T07:47:47.132Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1542.580 ms) ====== [2024-08-17T07:47:47.132Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-17T07:47:47.132Z] GC before operation: completed in 115.101 ms, heap usage 277.618 MB -> 69.669 MB. [2024-08-17T07:47:48.737Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1519.174 ms) ====== [2024-08-17T07:47:48.737Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-17T07:47:49.520Z] GC before operation: completed in 121.555 ms, heap usage 329.488 MB -> 69.636 MB. [2024-08-17T07:47:51.127Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1613.379 ms) ====== [2024-08-17T07:47:51.127Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-17T07:47:51.127Z] GC before operation: completed in 126.997 ms, heap usage 141.305 MB -> 69.224 MB. [2024-08-17T07:47:52.750Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1586.405 ms) ====== [2024-08-17T07:47:52.750Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-17T07:47:52.750Z] GC before operation: completed in 133.936 ms, heap usage 480.464 MB -> 69.842 MB. [2024-08-17T07:47:54.352Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1548.045 ms) ====== [2024-08-17T07:47:54.353Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-17T07:47:54.353Z] GC before operation: completed in 123.654 ms, heap usage 349.564 MB -> 69.729 MB. [2024-08-17T07:47:55.979Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1523.967 ms) ====== [2024-08-17T07:47:55.979Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-17T07:47:55.979Z] GC before operation: completed in 131.121 ms, heap usage 265.068 MB -> 69.958 MB. [2024-08-17T07:47:57.603Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1630.759 ms) ====== [2024-08-17T07:47:57.603Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-17T07:47:57.603Z] GC before operation: completed in 130.958 ms, heap usage 348.310 MB -> 70.051 MB. [2024-08-17T07:47:59.214Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1575.093 ms) ====== [2024-08-17T07:47:59.214Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-17T07:47:59.214Z] GC before operation: completed in 129.310 ms, heap usage 383.382 MB -> 70.012 MB. [2024-08-17T07:48:00.833Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1589.442 ms) ====== [2024-08-17T07:48:00.833Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-17T07:48:00.833Z] GC before operation: completed in 132.195 ms, heap usage 162.535 MB -> 69.822 MB. [2024-08-17T07:48:02.437Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1521.326 ms) ====== [2024-08-17T07:48:02.438Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-17T07:48:02.438Z] GC before operation: completed in 129.544 ms, heap usage 197.934 MB -> 70.211 MB. [2024-08-17T07:48:04.045Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1504.346 ms) ====== [2024-08-17T07:48:04.045Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-17T07:48:04.045Z] GC before operation: completed in 135.198 ms, heap usage 465.584 MB -> 70.922 MB. [2024-08-17T07:48:06.373Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1643.313 ms) ====== [2024-08-17T07:48:06.373Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-17T07:48:06.373Z] GC before operation: completed in 130.212 ms, heap usage 182.143 MB -> 70.122 MB. [2024-08-17T07:48:08.141Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1589.081 ms) ====== [2024-08-17T07:48:08.141Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-17T07:48:08.141Z] GC before operation: completed in 139.902 ms, heap usage 245.621 MB -> 70.856 MB. [2024-08-17T07:48:09.747Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1462.037 ms) ====== [2024-08-17T07:48:09.747Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-17T07:48:09.747Z] GC before operation: completed in 134.264 ms, heap usage 304.722 MB -> 70.589 MB. [2024-08-17T07:48:11.360Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1463.069 ms) ====== [2024-08-17T07:48:11.361Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-17T07:48:11.361Z] GC before operation: completed in 147.164 ms, heap usage 344.898 MB -> 70.710 MB. [2024-08-17T07:48:12.971Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1525.099 ms) ====== [2024-08-17T07:48:12.971Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-17T07:48:12.971Z] GC before operation: completed in 139.332 ms, heap usage 298.122 MB -> 81.855 MB. [2024-08-17T07:48:14.601Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1482.089 ms) ====== [2024-08-17T07:48:14.601Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-17T07:48:14.601Z] GC before operation: completed in 136.295 ms, heap usage 201.584 MB -> 70.790 MB. [2024-08-17T07:48:16.211Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1536.124 ms) ====== [2024-08-17T07:48:16.211Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-17T07:48:16.211Z] GC before operation: completed in 133.349 ms, heap usage 249.448 MB -> 82.426 MB. [2024-08-17T07:48:17.847Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1517.029 ms) ====== [2024-08-17T07:48:17.847Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-17T07:48:17.847Z] GC before operation: completed in 146.276 ms, heap usage 150.847 MB -> 70.808 MB. [2024-08-17T07:48:19.472Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1498.814 ms) ====== [2024-08-17T07:48:19.472Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-17T07:48:19.472Z] GC before operation: completed in 140.669 ms, heap usage 185.620 MB -> 70.923 MB. [2024-08-17T07:48:21.080Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1647.089 ms) ====== [2024-08-17T07:48:21.080Z] ----------------------------------- [2024-08-17T07:48:21.080Z] renaissance-dec-tree_0_PASSED [2024-08-17T07:48:21.080Z] ----------------------------------- [2024-08-17T07:48:21.080Z] [2024-08-17T07:48:21.080Z] TEST TEARDOWN: [2024-08-17T07:48:21.080Z] Nothing to be done for teardown. [2024-08-17T07:48:21.080Z] renaissance-dec-tree_0 Finish Time: Sat Aug 17 07:48:20 2024 Epoch Time (ms): 1723880900862