[2024-08-21T21:14:42.918Z] Running test renaissance-dec-tree_0 ... [2024-08-21T21:14:42.918Z] =============================================== [2024-08-21T21:14:42.918Z] renaissance-dec-tree_0 Start Time: Wed Aug 21 21:14:41 2024 Epoch Time (ms): 1724274881985 [2024-08-21T21:14:42.918Z] variation: NoOptions [2024-08-21T21:14:42.918Z] JVM_OPTIONS: [2024-08-21T21:14:42.918Z] { \ [2024-08-21T21:14:42.918Z] echo ""; echo "TEST SETUP:"; \ [2024-08-21T21:14:42.918Z] echo "Nothing to be done for setup."; \ [2024-08-21T21:14:42.918Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17242745915982/renaissance-dec-tree_0"; \ [2024-08-21T21:14:42.918Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17242745915982/renaissance-dec-tree_0"; \ [2024-08-21T21:14:42.918Z] echo ""; echo "TESTING:"; \ [2024-08-21T21:14:42.918Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17242745915982/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-21T21:14:42.918Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17242745915982/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-21T21:14:42.918Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-21T21:14:42.918Z] echo "Nothing to be done for teardown."; \ [2024-08-21T21:14:42.918Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17242745915982/TestTargetResult"; [2024-08-21T21:14:42.918Z] [2024-08-21T21:14:42.918Z] TEST SETUP: [2024-08-21T21:14:42.918Z] Nothing to be done for setup. [2024-08-21T21:14:42.918Z] [2024-08-21T21:14:42.918Z] TESTING: [2024-08-21T21:14:45.894Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-21T21:14:48.871Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-21T21:14:54.353Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-21T21:14:54.353Z] GC before operation: completed in 47.265 ms, heap usage 68.350 MB -> 37.048 MB. [2024-08-21T21:15:04.021Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10205.003 ms) ====== [2024-08-21T21:15:04.021Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-21T21:15:04.021Z] GC before operation: completed in 123.705 ms, heap usage 291.650 MB -> 68.580 MB. [2024-08-21T21:15:07.004Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2377.555 ms) ====== [2024-08-21T21:15:07.004Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-21T21:15:07.004Z] GC before operation: completed in 130.333 ms, heap usage 105.245 MB -> 68.936 MB. [2024-08-21T21:15:08.931Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1955.167 ms) ====== [2024-08-21T21:15:08.931Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-21T21:15:08.931Z] GC before operation: completed in 129.919 ms, heap usage 244.533 MB -> 69.246 MB. [2024-08-21T21:15:10.859Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1804.371 ms) ====== [2024-08-21T21:15:10.859Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-21T21:15:10.859Z] GC before operation: completed in 140.222 ms, heap usage 206.850 MB -> 69.616 MB. [2024-08-21T21:15:12.790Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1731.737 ms) ====== [2024-08-21T21:15:12.790Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-21T21:15:12.790Z] GC before operation: completed in 142.404 ms, heap usage 184.903 MB -> 69.412 MB. [2024-08-21T21:15:14.772Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1710.486 ms) ====== [2024-08-21T21:15:14.772Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-21T21:15:14.772Z] GC before operation: completed in 140.155 ms, heap usage 118.013 MB -> 69.340 MB. [2024-08-21T21:15:16.711Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1733.412 ms) ====== [2024-08-21T21:15:16.711Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-21T21:15:16.711Z] GC before operation: completed in 162.742 ms, heap usage 356.331 MB -> 70.286 MB. [2024-08-21T21:15:18.639Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1677.307 ms) ====== [2024-08-21T21:15:18.639Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-21T21:15:18.639Z] GC before operation: completed in 149.236 ms, heap usage 193.031 MB -> 70.353 MB. [2024-08-21T21:15:19.579Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1600.368 ms) ====== [2024-08-21T21:15:19.579Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-21T21:15:20.521Z] GC before operation: completed in 150.956 ms, heap usage 104.892 MB -> 70.079 MB. [2024-08-21T21:15:21.461Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1593.495 ms) ====== [2024-08-21T21:15:21.461Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-21T21:15:21.461Z] GC before operation: completed in 154.502 ms, heap usage 337.528 MB -> 81.327 MB. [2024-08-21T21:15:23.389Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1599.705 ms) ====== [2024-08-21T21:15:23.389Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-21T21:15:23.389Z] GC before operation: completed in 155.875 ms, heap usage 368.776 MB -> 81.674 MB. [2024-08-21T21:15:25.315Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1586.742 ms) ====== [2024-08-21T21:15:25.315Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-21T21:15:25.315Z] GC before operation: completed in 158.919 ms, heap usage 355.239 MB -> 70.846 MB. [2024-08-21T21:15:27.256Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1542.527 ms) ====== [2024-08-21T21:15:27.256Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-21T21:15:27.256Z] GC before operation: completed in 170.455 ms, heap usage 120.834 MB -> 70.232 MB. [2024-08-21T21:15:28.195Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1575.182 ms) ====== [2024-08-21T21:15:28.195Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-21T21:15:29.134Z] GC before operation: completed in 171.341 ms, heap usage 379.993 MB -> 81.975 MB. [2024-08-21T21:15:30.074Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1536.081 ms) ====== [2024-08-21T21:15:30.074Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-21T21:15:30.074Z] GC before operation: completed in 178.890 ms, heap usage 355.238 MB -> 76.429 MB. [2024-08-21T21:15:32.002Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1557.052 ms) ====== [2024-08-21T21:15:32.002Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-21T21:15:32.002Z] GC before operation: completed in 171.369 ms, heap usage 347.205 MB -> 71.356 MB. [2024-08-21T21:15:33.929Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1486.405 ms) ====== [2024-08-21T21:15:33.929Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-21T21:15:33.929Z] GC before operation: completed in 175.968 ms, heap usage 123.587 MB -> 70.799 MB. [2024-08-21T21:15:35.859Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1497.234 ms) ====== [2024-08-21T21:15:35.859Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-21T21:15:35.859Z] GC before operation: completed in 183.645 ms, heap usage 323.868 MB -> 82.505 MB. [2024-08-21T21:15:36.798Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1509.238 ms) ====== [2024-08-21T21:15:36.798Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-21T21:15:37.740Z] GC before operation: completed in 169.556 ms, heap usage 320.964 MB -> 71.554 MB. [2024-08-21T21:15:38.678Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1483.887 ms) ====== [2024-08-21T21:15:38.678Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-21T21:15:38.678Z] GC before operation: completed in 176.324 ms, heap usage 104.490 MB -> 71.546 MB. [2024-08-21T21:15:40.610Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1485.719 ms) ====== [2024-08-21T21:15:40.610Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-21T21:15:40.610Z] GC before operation: completed in 178.559 ms, heap usage 336.092 MB -> 71.916 MB. [2024-08-21T21:15:42.537Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1481.888 ms) ====== [2024-08-21T21:15:42.537Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-21T21:15:42.537Z] GC before operation: completed in 177.920 ms, heap usage 449.288 MB -> 77.652 MB. [2024-08-21T21:15:43.476Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1449.370 ms) ====== [2024-08-21T21:15:43.476Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-21T21:15:43.476Z] GC before operation: completed in 185.878 ms, heap usage 344.667 MB -> 83.056 MB. [2024-08-21T21:15:45.406Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1405.326 ms) ====== [2024-08-21T21:15:45.406Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-21T21:15:45.406Z] GC before operation: completed in 182.285 ms, heap usage 305.172 MB -> 72.303 MB. [2024-08-21T21:15:47.336Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1468.297 ms) ====== [2024-08-21T21:15:47.336Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-21T21:15:47.336Z] GC before operation: completed in 186.326 ms, heap usage 224.503 MB -> 72.254 MB. [2024-08-21T21:15:48.277Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1407.575 ms) ====== [2024-08-21T21:15:48.277Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-21T21:15:49.217Z] GC before operation: completed in 196.670 ms, heap usage 434.000 MB -> 89.063 MB. [2024-08-21T21:15:50.160Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1417.342 ms) ====== [2024-08-21T21:15:50.160Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-21T21:15:50.160Z] GC before operation: completed in 180.721 ms, heap usage 245.504 MB -> 72.771 MB. [2024-08-21T21:15:52.092Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1433.527 ms) ====== [2024-08-21T21:15:52.092Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-21T21:15:52.092Z] GC before operation: completed in 191.533 ms, heap usage 401.896 MB -> 83.468 MB. [2024-08-21T21:15:53.032Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1414.025 ms) ====== [2024-08-21T21:15:53.032Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-21T21:15:53.972Z] GC before operation: completed in 199.933 ms, heap usage 339.062 MB -> 83.696 MB. [2024-08-21T21:15:54.913Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1387.439 ms) ====== [2024-08-21T21:15:54.913Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-21T21:15:54.913Z] GC before operation: completed in 194.607 ms, heap usage 324.512 MB -> 84.077 MB. [2024-08-21T21:15:57.384Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1381.883 ms) ====== [2024-08-21T21:15:57.384Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-21T21:15:57.384Z] GC before operation: completed in 193.216 ms, heap usage 310.506 MB -> 83.869 MB. [2024-08-21T21:15:58.324Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1419.653 ms) ====== [2024-08-21T21:15:58.324Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-21T21:15:58.324Z] GC before operation: completed in 190.094 ms, heap usage 291.389 MB -> 72.827 MB. [2024-08-21T21:16:00.260Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1454.972 ms) ====== [2024-08-21T21:16:00.260Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-21T21:16:00.260Z] GC before operation: completed in 197.311 ms, heap usage 217.431 MB -> 72.931 MB. [2024-08-21T21:16:01.200Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1418.184 ms) ====== [2024-08-21T21:16:01.200Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-21T21:16:01.200Z] GC before operation: completed in 198.397 ms, heap usage 180.172 MB -> 72.785 MB. [2024-08-21T21:16:03.130Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1418.984 ms) ====== [2024-08-21T21:16:03.130Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-21T21:16:03.131Z] GC before operation: completed in 194.290 ms, heap usage 125.348 MB -> 72.619 MB. [2024-08-21T21:16:05.062Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1401.454 ms) ====== [2024-08-21T21:16:05.062Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-21T21:16:05.062Z] GC before operation: completed in 196.941 ms, heap usage 473.003 MB -> 73.495 MB. [2024-08-21T21:16:06.002Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1410.731 ms) ====== [2024-08-21T21:16:06.002Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-21T21:16:06.002Z] GC before operation: completed in 200.681 ms, heap usage 263.187 MB -> 73.393 MB. [2024-08-21T21:16:07.929Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1422.144 ms) ====== [2024-08-21T21:16:07.929Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-21T21:16:07.929Z] GC before operation: completed in 197.831 ms, heap usage 231.121 MB -> 73.470 MB. [2024-08-21T21:16:09.856Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1424.784 ms) ====== [2024-08-21T21:16:09.856Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-21T21:16:09.856Z] GC before operation: completed in 193.472 ms, heap usage 171.948 MB -> 73.449 MB. [2024-08-21T21:16:10.797Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1403.507 ms) ====== [2024-08-21T21:16:11.738Z] ----------------------------------- [2024-08-21T21:16:11.738Z] renaissance-dec-tree_0_PASSED [2024-08-21T21:16:11.738Z] ----------------------------------- [2024-08-21T21:16:11.738Z] [2024-08-21T21:16:11.738Z] TEST TEARDOWN: [2024-08-21T21:16:11.738Z] Nothing to be done for teardown. [2024-08-21T21:16:11.738Z] renaissance-dec-tree_0 Finish Time: Wed Aug 21 21:16:10 2024 Epoch Time (ms): 1724274970954