[2024-08-08T05:10:23.306Z] Running test renaissance-dec-tree_0 ... [2024-08-08T05:10:23.306Z] =============================================== [2024-08-08T05:10:23.306Z] renaissance-dec-tree_0 Start Time: Thu Aug 8 05:10:22 2024 Epoch Time (ms): 1723093822948 [2024-08-08T05:10:23.306Z] variation: NoOptions [2024-08-08T05:10:23.306Z] JVM_OPTIONS: [2024-08-08T05:10:23.306Z] { \ [2024-08-08T05:10:23.306Z] echo ""; echo "TEST SETUP:"; \ [2024-08-08T05:10:23.306Z] echo "Nothing to be done for setup."; \ [2024-08-08T05:10:23.306Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17230927128773/renaissance-dec-tree_0"; \ [2024-08-08T05:10:23.306Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17230927128773/renaissance-dec-tree_0"; \ [2024-08-08T05:10:23.306Z] echo ""; echo "TESTING:"; \ [2024-08-08T05:10:23.306Z] "/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_17230927128773/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-08T05:10:23.306Z] 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_17230927128773/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-08T05:10:23.306Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-08T05:10:23.306Z] echo "Nothing to be done for teardown."; \ [2024-08-08T05:10:23.306Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17230927128773/TestTargetResult"; [2024-08-08T05:10:23.306Z] [2024-08-08T05:10:23.306Z] TEST SETUP: [2024-08-08T05:10:23.306Z] Nothing to be done for setup. [2024-08-08T05:10:23.306Z] [2024-08-08T05:10:23.306Z] TESTING: [2024-08-08T05:10:58.482Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-08T05:11:01.897Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 16) threads. [2024-08-08T05:11:13.559Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-08T05:11:13.559Z] GC before operation: completed in 126.347 ms, heap usage 48.531 MB -> 35.039 MB. [2024-08-08T05:11:25.248Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (13039.878 ms) ====== [2024-08-08T05:11:25.248Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-08T05:11:26.017Z] GC before operation: completed in 126.640 ms, heap usage 198.210 MB -> 66.235 MB. [2024-08-08T05:11:27.620Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2273.282 ms) ====== [2024-08-08T05:11:27.620Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-08T05:11:28.388Z] GC before operation: completed in 133.349 ms, heap usage 115.893 MB -> 66.556 MB. [2024-08-08T05:11:29.975Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1969.601 ms) ====== [2024-08-08T05:11:29.976Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-08T05:11:29.976Z] GC before operation: completed in 139.054 ms, heap usage 108.909 MB -> 66.591 MB. [2024-08-08T05:11:32.445Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1925.174 ms) ====== [2024-08-08T05:11:32.445Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-08T05:11:32.445Z] GC before operation: completed in 125.747 ms, heap usage 372.618 MB -> 67.354 MB. [2024-08-08T05:11:34.042Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1899.772 ms) ====== [2024-08-08T05:11:34.042Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-08T05:11:34.042Z] GC before operation: completed in 142.711 ms, heap usage 204.699 MB -> 67.563 MB. [2024-08-08T05:11:36.504Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1814.062 ms) ====== [2024-08-08T05:11:36.504Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-08T05:11:36.504Z] GC before operation: completed in 142.217 ms, heap usage 385.173 MB -> 67.776 MB. [2024-08-08T05:11:38.095Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1776.413 ms) ====== [2024-08-08T05:11:38.095Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-08T05:11:38.095Z] GC before operation: completed in 145.912 ms, heap usage 157.343 MB -> 67.875 MB. [2024-08-08T05:11:39.690Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1757.525 ms) ====== [2024-08-08T05:11:39.690Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-08T05:11:40.455Z] GC before operation: completed in 148.003 ms, heap usage 240.478 MB -> 78.926 MB. [2024-08-08T05:11:42.039Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1711.877 ms) ====== [2024-08-08T05:11:42.039Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-08T05:11:42.039Z] GC before operation: completed in 150.943 ms, heap usage 146.995 MB -> 79.013 MB. [2024-08-08T05:11:43.622Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1744.511 ms) ====== [2024-08-08T05:11:43.622Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-08T05:11:43.622Z] GC before operation: completed in 142.517 ms, heap usage 474.590 MB -> 68.705 MB. [2024-08-08T05:11:46.129Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1760.086 ms) ====== [2024-08-08T05:11:46.129Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-08T05:11:46.129Z] GC before operation: completed in 152.719 ms, heap usage 229.363 MB -> 68.638 MB. [2024-08-08T05:11:47.714Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1800.576 ms) ====== [2024-08-08T05:11:47.714Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-08T05:11:47.714Z] GC before operation: completed in 160.260 ms, heap usage 448.802 MB -> 79.330 MB. [2024-08-08T05:11:49.310Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1756.309 ms) ====== [2024-08-08T05:11:49.310Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-08T05:11:49.310Z] GC before operation: completed in 154.676 ms, heap usage 331.081 MB -> 68.681 MB. [2024-08-08T05:11:51.782Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1901.908 ms) ====== [2024-08-08T05:11:51.782Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-08T05:11:51.782Z] GC before operation: completed in 161.280 ms, heap usage 159.544 MB -> 90.875 MB. [2024-08-08T05:11:53.380Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1695.329 ms) ====== [2024-08-08T05:11:53.380Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-08T05:11:53.380Z] GC before operation: completed in 153.411 ms, heap usage 415.295 MB -> 85.269 MB. [2024-08-08T05:11:55.141Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1766.870 ms) ====== [2024-08-08T05:11:55.141Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-08T05:11:55.141Z] GC before operation: completed in 164.550 ms, heap usage 346.828 MB -> 69.064 MB. [2024-08-08T05:11:57.605Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1615.551 ms) ====== [2024-08-08T05:11:57.605Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-08T05:11:57.605Z] GC before operation: completed in 135.797 ms, heap usage 431.758 MB -> 69.205 MB. [2024-08-08T05:11:59.198Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1536.755 ms) ====== [2024-08-08T05:11:59.198Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-08T05:11:59.198Z] GC before operation: completed in 118.545 ms, heap usage 141.416 MB -> 68.990 MB. [2024-08-08T05:12:00.784Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1480.188 ms) ====== [2024-08-08T05:12:00.784Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-08T05:12:00.784Z] GC before operation: completed in 123.028 ms, heap usage 476.339 MB -> 80.323 MB. [2024-08-08T05:12:02.370Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1478.809 ms) ====== [2024-08-08T05:12:02.370Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-08T05:12:02.370Z] GC before operation: completed in 119.749 ms, heap usage 272.160 MB -> 69.466 MB. [2024-08-08T05:12:03.959Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1463.301 ms) ====== [2024-08-08T05:12:03.959Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-08T05:12:03.959Z] GC before operation: completed in 116.488 ms, heap usage 230.541 MB -> 69.431 MB. [2024-08-08T05:12:05.554Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1508.765 ms) ====== [2024-08-08T05:12:05.554Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-08T05:12:05.554Z] GC before operation: completed in 136.688 ms, heap usage 305.053 MB -> 69.523 MB. [2024-08-08T05:12:07.149Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1504.593 ms) ====== [2024-08-08T05:12:07.149Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-08T05:12:07.149Z] GC before operation: completed in 130.528 ms, heap usage 305.143 MB -> 69.624 MB. [2024-08-08T05:12:08.755Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1541.321 ms) ====== [2024-08-08T05:12:08.755Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-08T05:12:08.755Z] GC before operation: completed in 138.408 ms, heap usage 308.509 MB -> 69.726 MB. [2024-08-08T05:12:10.336Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1488.018 ms) ====== [2024-08-08T05:12:10.336Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-08T05:12:10.336Z] GC before operation: completed in 122.365 ms, heap usage 298.337 MB -> 69.812 MB. [2024-08-08T05:12:12.308Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1459.092 ms) ====== [2024-08-08T05:12:12.308Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-08T05:12:12.308Z] GC before operation: completed in 122.720 ms, heap usage 307.025 MB -> 75.715 MB. [2024-08-08T05:12:13.076Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1522.663 ms) ====== [2024-08-08T05:12:13.076Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-08T05:12:13.841Z] GC before operation: completed in 129.029 ms, heap usage 306.185 MB -> 81.301 MB. [2024-08-08T05:12:15.424Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1511.835 ms) ====== [2024-08-08T05:12:15.424Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-08T05:12:15.424Z] GC before operation: completed in 121.716 ms, heap usage 225.201 MB -> 70.100 MB. [2024-08-08T05:12:17.008Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1482.276 ms) ====== [2024-08-08T05:12:17.008Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-08T05:12:17.008Z] GC before operation: completed in 137.112 ms, heap usage 303.907 MB -> 70.598 MB. [2024-08-08T05:12:18.593Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1477.855 ms) ====== [2024-08-08T05:12:18.593Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-08T05:12:18.593Z] GC before operation: completed in 143.776 ms, heap usage 300.532 MB -> 81.592 MB. [2024-08-08T05:12:20.186Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1498.967 ms) ====== [2024-08-08T05:12:20.186Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-08T05:12:20.186Z] GC before operation: completed in 135.387 ms, heap usage 124.556 MB -> 69.839 MB. [2024-08-08T05:12:21.768Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1557.138 ms) ====== [2024-08-08T05:12:21.768Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-08T05:12:21.768Z] GC before operation: completed in 138.590 ms, heap usage 441.694 MB -> 70.879 MB. [2024-08-08T05:12:23.352Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1486.810 ms) ====== [2024-08-08T05:12:23.352Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-08T05:12:23.352Z] GC before operation: completed in 139.861 ms, heap usage 229.187 MB -> 70.575 MB. [2024-08-08T05:12:24.950Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1470.801 ms) ====== [2024-08-08T05:12:24.950Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-08T05:12:24.950Z] GC before operation: completed in 140.034 ms, heap usage 345.775 MB -> 76.236 MB. [2024-08-08T05:12:26.561Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1478.083 ms) ====== [2024-08-08T05:12:26.561Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-08T05:12:26.562Z] GC before operation: completed in 133.103 ms, heap usage 269.648 MB -> 70.778 MB. [2024-08-08T05:12:28.161Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1478.538 ms) ====== [2024-08-08T05:12:28.161Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-08T05:12:28.161Z] GC before operation: completed in 146.903 ms, heap usage 304.979 MB -> 71.093 MB. [2024-08-08T05:12:29.743Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1480.186 ms) ====== [2024-08-08T05:12:29.743Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-08T05:12:29.743Z] GC before operation: completed in 127.795 ms, heap usage 294.355 MB -> 81.871 MB. [2024-08-08T05:12:31.330Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1463.443 ms) ====== [2024-08-08T05:12:31.330Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-08T05:12:31.330Z] GC before operation: completed in 141.184 ms, heap usage 134.428 MB -> 70.491 MB. [2024-08-08T05:12:32.911Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1471.195 ms) ====== [2024-08-08T05:12:32.912Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-08T05:12:32.912Z] GC before operation: completed in 145.792 ms, heap usage 497.697 MB -> 82.255 MB. [2024-08-08T05:12:34.492Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1528.919 ms) ====== [2024-08-08T05:12:36.100Z] ----------------------------------- [2024-08-08T05:12:36.100Z] renaissance-dec-tree_0_PASSED [2024-08-08T05:12:36.100Z] ----------------------------------- [2024-08-08T05:12:36.100Z] [2024-08-08T05:12:36.100Z] TEST TEARDOWN: [2024-08-08T05:12:36.100Z] Nothing to be done for teardown. [2024-08-08T05:12:36.100Z] renaissance-dec-tree_0 Finish Time: Thu Aug 8 05:12:35 2024 Epoch Time (ms): 1723093955273