[2024-10-02T20:43:20.831Z] Running test renaissance-dec-tree_0 ... [2024-10-02T20:43:20.831Z] =============================================== [2024-10-02T20:43:20.831Z] renaissance-dec-tree_0 Start Time: Wed Oct 2 20:43:20 2024 Epoch Time (ms): 1727901800183 [2024-10-02T20:43:20.831Z] variation: NoOptions [2024-10-02T20:43:20.831Z] JVM_OPTIONS: [2024-10-02T20:43:20.831Z] { \ [2024-10-02T20:43:20.831Z] echo ""; echo "TEST SETUP:"; \ [2024-10-02T20:43:20.831Z] echo "Nothing to be done for setup."; \ [2024-10-02T20:43:20.831Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279014208235/renaissance-dec-tree_0"; \ [2024-10-02T20:43:20.831Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279014208235/renaissance-dec-tree_0"; \ [2024-10-02T20:43:20.831Z] echo ""; echo "TESTING:"; \ [2024-10-02T20:43:20.831Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/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/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279014208235/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-02T20:43:20.831Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279014208235/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-02T20:43:20.831Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-02T20:43:20.831Z] echo "Nothing to be done for teardown."; \ [2024-10-02T20:43:20.831Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279014208235/TestTargetResult"; [2024-10-02T20:43:20.831Z] [2024-10-02T20:43:20.831Z] TEST SETUP: [2024-10-02T20:43:20.831Z] Nothing to be done for setup. [2024-10-02T20:43:20.831Z] [2024-10-02T20:43:20.831Z] TESTING: [2024-10-02T20:43:25.392Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-02T20:43:26.967Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-10-02T20:43:31.429Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-02T20:43:31.429Z] GC before operation: completed in 55.671 ms, heap usage 81.246 MB -> 35.036 MB. [2024-10-02T20:43:38.273Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7604.529 ms) ====== [2024-10-02T20:43:38.273Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-02T20:43:38.273Z] GC before operation: completed in 94.046 ms, heap usage 323.744 MB -> 66.803 MB. [2024-10-02T20:43:40.718Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1915.886 ms) ====== [2024-10-02T20:43:40.718Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-02T20:43:40.718Z] GC before operation: completed in 79.016 ms, heap usage 204.073 MB -> 67.136 MB. [2024-10-02T20:43:42.296Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1649.065 ms) ====== [2024-10-02T20:43:42.296Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-02T20:43:42.296Z] GC before operation: completed in 83.093 ms, heap usage 152.822 MB -> 67.133 MB. [2024-10-02T20:43:43.868Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1584.607 ms) ====== [2024-10-02T20:43:43.868Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-02T20:43:43.868Z] GC before operation: completed in 86.308 ms, heap usage 321.947 MB -> 78.584 MB. [2024-10-02T20:43:45.449Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1583.883 ms) ====== [2024-10-02T20:43:45.449Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-02T20:43:45.449Z] GC before operation: completed in 86.269 ms, heap usage 370.866 MB -> 67.773 MB. [2024-10-02T20:43:47.022Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1559.460 ms) ====== [2024-10-02T20:43:47.022Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-02T20:43:47.022Z] GC before operation: completed in 97.254 ms, heap usage 232.951 MB -> 96.134 MB. [2024-10-02T20:43:48.595Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1525.829 ms) ====== [2024-10-02T20:43:48.595Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-02T20:43:48.595Z] GC before operation: completed in 100.014 ms, heap usage 258.988 MB -> 68.324 MB. [2024-10-02T20:43:50.169Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1542.224 ms) ====== [2024-10-02T20:43:50.169Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-02T20:43:50.930Z] GC before operation: completed in 105.632 ms, heap usage 203.538 MB -> 68.297 MB. [2024-10-02T20:43:52.500Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1511.046 ms) ====== [2024-10-02T20:43:52.500Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-02T20:43:52.500Z] GC before operation: completed in 92.837 ms, heap usage 341.603 MB -> 79.445 MB. [2024-10-02T20:43:54.083Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1482.679 ms) ====== [2024-10-02T20:43:54.083Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-02T20:43:54.083Z] GC before operation: completed in 99.824 ms, heap usage 147.454 MB -> 68.209 MB. [2024-10-02T20:43:55.653Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1469.850 ms) ====== [2024-10-02T20:43:55.653Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-02T20:43:55.653Z] GC before operation: completed in 113.686 ms, heap usage 157.050 MB -> 68.319 MB. [2024-10-02T20:43:57.596Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1470.432 ms) ====== [2024-10-02T20:43:57.596Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-02T20:43:57.596Z] GC before operation: completed in 106.415 ms, heap usage 214.718 MB -> 68.746 MB. [2024-10-02T20:43:58.360Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1473.581 ms) ====== [2024-10-02T20:43:58.360Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-02T20:43:58.360Z] GC before operation: completed in 103.012 ms, heap usage 295.746 MB -> 68.867 MB. [2024-10-02T20:43:59.941Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1461.941 ms) ====== [2024-10-02T20:43:59.941Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-02T20:43:59.941Z] GC before operation: completed in 104.539 ms, heap usage 233.705 MB -> 68.974 MB. [2024-10-02T20:44:01.512Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1438.242 ms) ====== [2024-10-02T20:44:01.512Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-02T20:44:01.512Z] GC before operation: completed in 111.715 ms, heap usage 348.481 MB -> 85.779 MB. [2024-10-02T20:44:03.083Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1469.839 ms) ====== [2024-10-02T20:44:03.083Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-02T20:44:03.083Z] GC before operation: completed in 118.118 ms, heap usage 250.230 MB -> 69.423 MB. [2024-10-02T20:44:04.659Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1431.469 ms) ====== [2024-10-02T20:44:04.659Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-02T20:44:04.659Z] GC before operation: completed in 118.256 ms, heap usage 300.210 MB -> 69.527 MB. [2024-10-02T20:44:06.236Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1409.731 ms) ====== [2024-10-02T20:44:06.236Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-02T20:44:06.236Z] GC before operation: completed in 118.503 ms, heap usage 361.188 MB -> 86.012 MB. [2024-10-02T20:44:07.809Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1457.338 ms) ====== [2024-10-02T20:44:07.809Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-02T20:44:07.809Z] GC before operation: completed in 111.546 ms, heap usage 229.629 MB -> 75.003 MB. [2024-10-02T20:44:09.381Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1427.583 ms) ====== [2024-10-02T20:44:09.381Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-02T20:44:09.381Z] GC before operation: completed in 115.268 ms, heap usage 259.715 MB -> 80.792 MB. [2024-10-02T20:44:10.972Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1452.077 ms) ====== [2024-10-02T20:44:10.972Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-02T20:44:10.972Z] GC before operation: completed in 112.759 ms, heap usage 144.487 MB -> 69.510 MB. [2024-10-02T20:44:12.558Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1488.982 ms) ====== [2024-10-02T20:44:12.558Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-02T20:44:12.558Z] GC before operation: completed in 113.434 ms, heap usage 232.655 MB -> 86.376 MB. [2024-10-02T20:44:14.137Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1439.512 ms) ====== [2024-10-02T20:44:14.137Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-02T20:44:14.137Z] GC before operation: completed in 116.892 ms, heap usage 480.987 MB -> 70.342 MB. [2024-10-02T20:44:15.709Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1430.987 ms) ====== [2024-10-02T20:44:15.709Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-02T20:44:15.709Z] GC before operation: completed in 115.523 ms, heap usage 373.894 MB -> 75.657 MB. [2024-10-02T20:44:17.308Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1452.883 ms) ====== [2024-10-02T20:44:17.308Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-02T20:44:17.308Z] GC before operation: completed in 126.555 ms, heap usage 272.114 MB -> 97.784 MB. [2024-10-02T20:44:18.910Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1442.534 ms) ====== [2024-10-02T20:44:18.910Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-02T20:44:18.910Z] GC before operation: completed in 126.982 ms, heap usage 243.825 MB -> 75.882 MB. [2024-10-02T20:44:20.489Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1460.369 ms) ====== [2024-10-02T20:44:20.489Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-02T20:44:20.490Z] GC before operation: completed in 115.425 ms, heap usage 208.078 MB -> 81.287 MB. [2024-10-02T20:44:22.067Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1465.127 ms) ====== [2024-10-02T20:44:22.067Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-02T20:44:22.067Z] GC before operation: completed in 126.886 ms, heap usage 312.102 MB -> 81.536 MB. [2024-10-02T20:44:23.638Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1464.386 ms) ====== [2024-10-02T20:44:23.638Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-02T20:44:23.638Z] GC before operation: completed in 127.300 ms, heap usage 192.984 MB -> 70.298 MB. [2024-10-02T20:44:25.219Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1450.878 ms) ====== [2024-10-02T20:44:25.219Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-02T20:44:25.219Z] GC before operation: completed in 127.244 ms, heap usage 319.211 MB -> 81.563 MB. [2024-10-02T20:44:26.788Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1426.466 ms) ====== [2024-10-02T20:44:26.788Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-02T20:44:26.788Z] GC before operation: completed in 131.956 ms, heap usage 526.821 MB -> 82.052 MB. [2024-10-02T20:44:28.363Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1446.411 ms) ====== [2024-10-02T20:44:28.363Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-02T20:44:28.363Z] GC before operation: completed in 127.777 ms, heap usage 222.321 MB -> 70.864 MB. [2024-10-02T20:44:29.947Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1432.622 ms) ====== [2024-10-02T20:44:29.947Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-02T20:44:29.947Z] GC before operation: completed in 139.864 ms, heap usage 233.892 MB -> 71.368 MB. [2024-10-02T20:44:31.517Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1413.934 ms) ====== [2024-10-02T20:44:31.517Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-02T20:44:31.517Z] GC before operation: completed in 136.859 ms, heap usage 283.195 MB -> 76.625 MB. [2024-10-02T20:44:33.088Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1418.934 ms) ====== [2024-10-02T20:44:33.088Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-02T20:44:33.088Z] GC before operation: completed in 123.801 ms, heap usage 257.557 MB -> 82.037 MB. [2024-10-02T20:44:34.686Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1390.817 ms) ====== [2024-10-02T20:44:34.686Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-02T20:44:34.686Z] GC before operation: completed in 133.429 ms, heap usage 215.605 MB -> 76.656 MB. [2024-10-02T20:44:36.259Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1404.410 ms) ====== [2024-10-02T20:44:36.259Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-02T20:44:36.259Z] GC before operation: completed in 121.504 ms, heap usage 248.870 MB -> 71.344 MB. [2024-10-02T20:44:37.836Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1409.079 ms) ====== [2024-10-02T20:44:37.836Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-02T20:44:37.836Z] GC before operation: completed in 135.374 ms, heap usage 255.290 MB -> 77.005 MB. [2024-10-02T20:44:38.602Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1398.544 ms) ====== [2024-10-02T20:44:38.602Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-02T20:44:39.536Z] GC before operation: completed in 135.857 ms, heap usage 261.097 MB -> 71.689 MB. [2024-10-02T20:44:40.296Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1431.370 ms) ====== [2024-10-02T20:44:41.056Z] ----------------------------------- [2024-10-02T20:44:41.056Z] renaissance-dec-tree_0_PASSED [2024-10-02T20:44:41.056Z] ----------------------------------- [2024-10-02T20:44:41.056Z] [2024-10-02T20:44:41.056Z] TEST TEARDOWN: [2024-10-02T20:44:41.056Z] Nothing to be done for teardown. [2024-10-02T20:44:41.056Z] renaissance-dec-tree_0 Finish Time: Wed Oct 2 20:44:40 2024 Epoch Time (ms): 1727901880382