[2024-11-20T21:18:45.957Z] Running test renaissance-dec-tree_0 ... [2024-11-20T21:18:45.957Z] =============================================== [2024-11-20T21:18:45.957Z] renaissance-dec-tree_0 Start Time: Wed Nov 20 21:18:45 2024 Epoch Time (ms): 1732137525533 [2024-11-20T21:18:45.957Z] variation: NoOptions [2024-11-20T21:18:45.957Z] JVM_OPTIONS: [2024-11-20T21:18:45.957Z] { \ [2024-11-20T21:18:45.957Z] echo ""; echo "TEST SETUP:"; \ [2024-11-20T21:18:45.957Z] echo "Nothing to be done for setup."; \ [2024-11-20T21:18:45.957Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1732137086767/renaissance-dec-tree_0"; \ [2024-11-20T21:18:45.957Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1732137086767/renaissance-dec-tree_0"; \ [2024-11-20T21:18:45.957Z] echo ""; echo "TESTING:"; \ [2024-11-20T21:18:45.957Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_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_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1732137086767/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-20T21:18:45.958Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1732137086767/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-20T21:18:45.958Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-20T21:18:45.958Z] echo "Nothing to be done for teardown."; \ [2024-11-20T21:18:45.958Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1732137086767/TestTargetResult"; [2024-11-20T21:18:45.958Z] [2024-11-20T21:18:45.958Z] TEST SETUP: [2024-11-20T21:18:45.958Z] Nothing to be done for setup. [2024-11-20T21:18:45.958Z] [2024-11-20T21:18:45.958Z] TESTING: [2024-11-20T21:18:48.920Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-20T21:18:50.843Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-20T21:18:53.809Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-20T21:18:53.809Z] GC before operation: completed in 71.195 ms, heap usage 84.907 MB -> 35.171 MB. [2024-11-20T21:19:01.846Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7158.383 ms) ====== [2024-11-20T21:19:01.846Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-20T21:19:01.846Z] GC before operation: completed in 111.175 ms, heap usage 109.964 MB -> 64.687 MB. [2024-11-20T21:19:03.775Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2190.783 ms) ====== [2024-11-20T21:19:03.775Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-20T21:19:03.775Z] GC before operation: completed in 91.651 ms, heap usage 231.031 MB -> 75.953 MB. [2024-11-20T21:19:04.711Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1745.340 ms) ====== [2024-11-20T21:19:04.711Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-20T21:19:05.648Z] GC before operation: completed in 79.272 ms, heap usage 170.948 MB -> 65.065 MB. [2024-11-20T21:19:06.585Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1722.505 ms) ====== [2024-11-20T21:19:06.585Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-20T21:19:06.585Z] GC before operation: completed in 85.314 ms, heap usage 109.542 MB -> 65.166 MB. [2024-11-20T21:19:08.512Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1704.492 ms) ====== [2024-11-20T21:19:08.512Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-20T21:19:08.512Z] GC before operation: completed in 94.407 ms, heap usage 206.114 MB -> 76.942 MB. [2024-11-20T21:19:10.437Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1676.074 ms) ====== [2024-11-20T21:19:10.437Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-20T21:19:10.437Z] GC before operation: completed in 98.236 ms, heap usage 208.051 MB -> 66.040 MB. [2024-11-20T21:19:12.372Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1614.547 ms) ====== [2024-11-20T21:19:12.372Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-20T21:19:12.372Z] GC before operation: completed in 85.522 ms, heap usage 341.586 MB -> 77.318 MB. [2024-11-20T21:19:14.298Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1575.529 ms) ====== [2024-11-20T21:19:14.298Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-20T21:19:14.298Z] GC before operation: completed in 97.049 ms, heap usage 252.988 MB -> 66.503 MB. [2024-11-20T21:19:15.239Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1613.256 ms) ====== [2024-11-20T21:19:15.239Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-20T21:19:15.239Z] GC before operation: completed in 89.420 ms, heap usage 331.470 MB -> 66.517 MB. [2024-11-20T21:19:17.175Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1545.349 ms) ====== [2024-11-20T21:19:17.175Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-20T21:19:17.175Z] GC before operation: completed in 100.449 ms, heap usage 331.760 MB -> 66.810 MB. [2024-11-20T21:19:19.116Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1540.566 ms) ====== [2024-11-20T21:19:19.116Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-20T21:19:19.116Z] GC before operation: completed in 94.336 ms, heap usage 326.961 MB -> 66.871 MB. [2024-11-20T21:19:20.052Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1552.873 ms) ====== [2024-11-20T21:19:20.052Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-20T21:19:20.987Z] GC before operation: completed in 95.740 ms, heap usage 329.401 MB -> 66.868 MB. [2024-11-20T21:19:21.923Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1552.591 ms) ====== [2024-11-20T21:19:21.923Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-20T21:19:21.923Z] GC before operation: completed in 97.554 ms, heap usage 335.559 MB -> 78.029 MB. [2024-11-20T21:19:23.849Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1514.397 ms) ====== [2024-11-20T21:19:23.849Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-20T21:19:23.849Z] GC before operation: completed in 93.625 ms, heap usage 201.995 MB -> 67.085 MB. [2024-11-20T21:19:25.774Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1488.144 ms) ====== [2024-11-20T21:19:25.774Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-20T21:19:25.774Z] GC before operation: completed in 108.770 ms, heap usage 321.247 MB -> 83.916 MB. [2024-11-20T21:19:26.709Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1516.019 ms) ====== [2024-11-20T21:19:26.710Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-20T21:19:26.710Z] GC before operation: completed in 94.173 ms, heap usage 434.386 MB -> 67.620 MB. [2024-11-20T21:19:28.639Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1473.215 ms) ====== [2024-11-20T21:19:28.639Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-20T21:19:28.639Z] GC before operation: completed in 100.939 ms, heap usage 316.480 MB -> 67.655 MB. [2024-11-20T21:19:30.567Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1485.887 ms) ====== [2024-11-20T21:19:30.567Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-20T21:19:30.567Z] GC before operation: completed in 91.956 ms, heap usage 287.475 MB -> 73.259 MB. [2024-11-20T21:19:33.283Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1506.546 ms) ====== [2024-11-20T21:19:33.283Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-20T21:19:33.283Z] GC before operation: completed in 100.552 ms, heap usage 226.043 MB -> 84.267 MB. [2024-11-20T21:19:33.283Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1504.544 ms) ====== [2024-11-20T21:19:33.283Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-20T21:19:33.283Z] GC before operation: completed in 111.297 ms, heap usage 420.401 MB -> 78.887 MB. [2024-11-20T21:19:35.211Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1495.359 ms) ====== [2024-11-20T21:19:35.211Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-20T21:19:35.211Z] GC before operation: completed in 91.777 ms, heap usage 219.088 MB -> 68.084 MB. [2024-11-20T21:19:36.260Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1490.358 ms) ====== [2024-11-20T21:19:36.260Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-20T21:19:36.260Z] GC before operation: completed in 101.143 ms, heap usage 307.425 MB -> 68.005 MB. [2024-11-20T21:19:38.215Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1468.420 ms) ====== [2024-11-20T21:19:38.215Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-20T21:19:38.215Z] GC before operation: completed in 116.642 ms, heap usage 308.345 MB -> 68.047 MB. [2024-11-20T21:19:40.140Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1449.970 ms) ====== [2024-11-20T21:19:40.140Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-20T21:19:40.140Z] GC before operation: completed in 102.328 ms, heap usage 304.231 MB -> 73.810 MB. [2024-11-20T21:19:41.075Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1473.950 ms) ====== [2024-11-20T21:19:41.075Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-20T21:19:41.075Z] GC before operation: completed in 110.291 ms, heap usage 226.534 MB -> 68.721 MB. [2024-11-20T21:19:42.998Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1473.478 ms) ====== [2024-11-20T21:19:42.998Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-20T21:19:42.998Z] GC before operation: completed in 108.123 ms, heap usage 308.275 MB -> 68.451 MB. [2024-11-20T21:19:44.949Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1505.009 ms) ====== [2024-11-20T21:19:44.949Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-20T21:19:44.949Z] GC before operation: completed in 114.264 ms, heap usage 290.805 MB -> 96.116 MB. [2024-11-20T21:19:45.885Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1501.981 ms) ====== [2024-11-20T21:19:45.885Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-20T21:19:45.885Z] GC before operation: completed in 102.590 ms, heap usage 307.854 MB -> 85.358 MB. [2024-11-20T21:19:47.813Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1435.333 ms) ====== [2024-11-20T21:19:47.813Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-20T21:19:47.813Z] GC before operation: completed in 108.493 ms, heap usage 414.633 MB -> 79.699 MB. [2024-11-20T21:19:48.750Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1448.774 ms) ====== [2024-11-20T21:19:48.750Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-20T21:19:49.686Z] GC before operation: completed in 110.638 ms, heap usage 181.770 MB -> 68.716 MB. [2024-11-20T21:19:50.625Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1442.340 ms) ====== [2024-11-20T21:19:50.625Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-20T21:19:50.625Z] GC before operation: completed in 102.992 ms, heap usage 266.903 MB -> 69.387 MB. [2024-11-20T21:19:52.549Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1464.472 ms) ====== [2024-11-20T21:19:52.549Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-20T21:19:52.549Z] GC before operation: completed in 106.019 ms, heap usage 279.388 MB -> 85.633 MB. [2024-11-20T21:19:53.489Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1443.287 ms) ====== [2024-11-20T21:19:53.489Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-20T21:19:53.489Z] GC before operation: completed in 105.391 ms, heap usage 383.757 MB -> 69.327 MB. [2024-11-20T21:19:55.415Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1438.632 ms) ====== [2024-11-20T21:19:55.415Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-20T21:19:55.415Z] GC before operation: completed in 103.831 ms, heap usage 288.015 MB -> 69.395 MB. [2024-11-20T21:19:57.345Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1428.869 ms) ====== [2024-11-20T21:19:57.345Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-20T21:19:57.345Z] GC before operation: completed in 134.755 ms, heap usage 283.105 MB -> 69.542 MB. [2024-11-20T21:19:58.282Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1432.562 ms) ====== [2024-11-20T21:19:58.282Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-20T21:19:58.282Z] GC before operation: completed in 122.998 ms, heap usage 287.141 MB -> 86.080 MB. [2024-11-20T21:20:00.217Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1434.677 ms) ====== [2024-11-20T21:20:00.217Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-20T21:20:00.217Z] GC before operation: completed in 144.091 ms, heap usage 363.691 MB -> 86.363 MB. [2024-11-20T21:20:01.154Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1449.281 ms) ====== [2024-11-20T21:20:01.154Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-20T21:20:02.093Z] GC before operation: completed in 134.847 ms, heap usage 356.459 MB -> 86.344 MB. [2024-11-20T21:20:03.027Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1438.796 ms) ====== [2024-11-20T21:20:03.027Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-20T21:20:03.027Z] GC before operation: completed in 133.724 ms, heap usage 363.092 MB -> 91.930 MB. [2024-11-20T21:20:04.952Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1431.724 ms) ====== [2024-11-20T21:20:04.952Z] ----------------------------------- [2024-11-20T21:20:04.952Z] renaissance-dec-tree_0_PASSED [2024-11-20T21:20:04.952Z] ----------------------------------- [2024-11-20T21:20:04.952Z] [2024-11-20T21:20:04.952Z] TEST TEARDOWN: [2024-11-20T21:20:04.952Z] Nothing to be done for teardown. [2024-11-20T21:20:04.952Z] renaissance-dec-tree_0 Finish Time: Wed Nov 20 21:20:04 2024 Epoch Time (ms): 1732137604456