[2024-09-04T23:56:35.084Z] Running test renaissance-dec-tree_0 ... [2024-09-04T23:56:35.084Z] =============================================== [2024-09-04T23:56:35.084Z] renaissance-dec-tree_0 Start Time: Wed Sep 4 23:56:34 2024 Epoch Time (ms): 1725494194277 [2024-09-04T23:56:35.084Z] variation: NoOptions [2024-09-04T23:56:35.084Z] JVM_OPTIONS: [2024-09-04T23:56:35.084Z] { \ [2024-09-04T23:56:35.084Z] echo ""; echo "TEST SETUP:"; \ [2024-09-04T23:56:35.084Z] echo "Nothing to be done for setup."; \ [2024-09-04T23:56:35.084Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17254938239585/renaissance-dec-tree_0"; \ [2024-09-04T23:56:35.084Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17254938239585/renaissance-dec-tree_0"; \ [2024-09-04T23:56:35.084Z] echo ""; echo "TESTING:"; \ [2024-09-04T23:56:35.084Z] "/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_17254938239585/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-04T23:56:35.084Z] 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_17254938239585/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-04T23:56:35.084Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-04T23:56:35.084Z] echo "Nothing to be done for teardown."; \ [2024-09-04T23:56:35.084Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17254938239585/TestTargetResult"; [2024-09-04T23:56:35.084Z] [2024-09-04T23:56:35.084Z] TEST SETUP: [2024-09-04T23:56:35.084Z] Nothing to be done for setup. [2024-09-04T23:56:35.084Z] [2024-09-04T23:56:35.084Z] TESTING: [2024-09-04T23:56:39.525Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-04T23:56:41.100Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-09-04T23:56:44.524Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-04T23:56:45.286Z] GC before operation: completed in 52.404 ms, heap usage 58.703 MB -> 35.102 MB. [2024-09-04T23:56:52.101Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7396.307 ms) ====== [2024-09-04T23:56:52.101Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-04T23:56:52.101Z] GC before operation: completed in 92.848 ms, heap usage 319.416 MB -> 66.790 MB. [2024-09-04T23:56:54.574Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1833.226 ms) ====== [2024-09-04T23:56:54.574Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-04T23:56:54.574Z] GC before operation: completed in 79.016 ms, heap usage 323.761 MB -> 66.957 MB. [2024-09-04T23:56:56.146Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1590.587 ms) ====== [2024-09-04T23:56:56.146Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-04T23:56:56.146Z] GC before operation: completed in 80.207 ms, heap usage 255.595 MB -> 67.384 MB. [2024-09-04T23:56:57.723Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1551.421 ms) ====== [2024-09-04T23:56:57.723Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-04T23:56:57.723Z] GC before operation: completed in 88.546 ms, heap usage 379.331 MB -> 95.068 MB. [2024-09-04T23:56:59.299Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1548.555 ms) ====== [2024-09-04T23:56:59.299Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-04T23:56:59.299Z] GC before operation: completed in 91.813 ms, heap usage 235.268 MB -> 67.868 MB. [2024-09-04T23:57:00.878Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1509.133 ms) ====== [2024-09-04T23:57:00.878Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-04T23:57:00.878Z] GC before operation: completed in 92.312 ms, heap usage 324.967 MB -> 68.081 MB. [2024-09-04T23:57:02.453Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1468.993 ms) ====== [2024-09-04T23:57:02.453Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-04T23:57:02.453Z] GC before operation: completed in 95.001 ms, heap usage 288.065 MB -> 79.039 MB. [2024-09-04T23:57:04.026Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1471.813 ms) ====== [2024-09-04T23:57:04.026Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-04T23:57:04.026Z] GC before operation: completed in 103.910 ms, heap usage 444.174 MB -> 79.352 MB. [2024-09-04T23:57:05.598Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1455.459 ms) ====== [2024-09-04T23:57:05.599Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-04T23:57:05.599Z] GC before operation: completed in 95.832 ms, heap usage 438.401 MB -> 79.470 MB. [2024-09-04T23:57:07.204Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1442.137 ms) ====== [2024-09-04T23:57:07.204Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-04T23:57:07.204Z] GC before operation: completed in 98.923 ms, heap usage 217.841 MB -> 74.101 MB. [2024-09-04T23:57:08.798Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1446.694 ms) ====== [2024-09-04T23:57:08.798Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-04T23:57:08.799Z] GC before operation: completed in 104.977 ms, heap usage 303.627 MB -> 68.780 MB. [2024-09-04T23:57:10.385Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1433.721 ms) ====== [2024-09-04T23:57:10.385Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-04T23:57:10.385Z] GC before operation: completed in 97.926 ms, heap usage 258.002 MB -> 79.638 MB. [2024-09-04T23:57:11.964Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1457.404 ms) ====== [2024-09-04T23:57:11.964Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-04T23:57:11.964Z] GC before operation: completed in 104.872 ms, heap usage 133.958 MB -> 73.737 MB. [2024-09-04T23:57:13.538Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1460.192 ms) ====== [2024-09-04T23:57:13.538Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-04T23:57:13.538Z] GC before operation: completed in 113.014 ms, heap usage 556.993 MB -> 80.284 MB. [2024-09-04T23:57:15.124Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1381.978 ms) ====== [2024-09-04T23:57:15.124Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-04T23:57:15.124Z] GC before operation: completed in 106.117 ms, heap usage 258.987 MB -> 69.108 MB. [2024-09-04T23:57:15.895Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1399.610 ms) ====== [2024-09-04T23:57:15.895Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-04T23:57:16.663Z] GC before operation: completed in 101.745 ms, heap usage 238.322 MB -> 69.427 MB. [2024-09-04T23:57:17.425Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1421.116 ms) ====== [2024-09-04T23:57:17.425Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-04T23:57:18.196Z] GC before operation: completed in 113.482 ms, heap usage 302.077 MB -> 69.387 MB. [2024-09-04T23:57:18.958Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1402.354 ms) ====== [2024-09-04T23:57:18.958Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-04T23:57:19.723Z] GC before operation: completed in 113.067 ms, heap usage 359.235 MB -> 69.616 MB. [2024-09-04T23:57:20.491Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1417.574 ms) ====== [2024-09-04T23:57:20.491Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-04T23:57:21.253Z] GC before operation: completed in 115.239 ms, heap usage 170.245 MB -> 80.203 MB. [2024-09-04T23:57:22.014Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1395.268 ms) ====== [2024-09-04T23:57:22.014Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-04T23:57:22.780Z] GC before operation: completed in 115.240 ms, heap usage 384.139 MB -> 86.387 MB. [2024-09-04T23:57:23.543Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1396.772 ms) ====== [2024-09-04T23:57:23.543Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-04T23:57:24.306Z] GC before operation: completed in 110.565 ms, heap usage 476.022 MB -> 69.993 MB. [2024-09-04T23:57:25.221Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1426.383 ms) ====== [2024-09-04T23:57:25.221Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-04T23:57:25.983Z] GC before operation: completed in 115.472 ms, heap usage 248.788 MB -> 75.446 MB. [2024-09-04T23:57:26.936Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1409.074 ms) ====== [2024-09-04T23:57:26.936Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-04T23:57:26.936Z] GC before operation: completed in 119.849 ms, heap usage 444.623 MB -> 81.322 MB. [2024-09-04T23:57:28.794Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1384.098 ms) ====== [2024-09-04T23:57:28.794Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-04T23:57:28.794Z] GC before operation: completed in 115.162 ms, heap usage 409.489 MB -> 75.631 MB. [2024-09-04T23:57:29.567Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1363.953 ms) ====== [2024-09-04T23:57:29.567Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-04T23:57:30.329Z] GC before operation: completed in 124.776 ms, heap usage 398.214 MB -> 81.067 MB. [2024-09-04T23:57:31.091Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1396.844 ms) ====== [2024-09-04T23:57:31.091Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-04T23:57:31.853Z] GC before operation: completed in 110.067 ms, heap usage 377.803 MB -> 70.416 MB. [2024-09-04T23:57:32.616Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1410.615 ms) ====== [2024-09-04T23:57:32.616Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-04T23:57:33.398Z] GC before operation: completed in 118.779 ms, heap usage 259.519 MB -> 81.663 MB. [2024-09-04T23:57:34.168Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1401.640 ms) ====== [2024-09-04T23:57:34.168Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-04T23:57:34.929Z] GC before operation: completed in 117.794 ms, heap usage 215.785 MB -> 81.458 MB. [2024-09-04T23:57:35.690Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1358.694 ms) ====== [2024-09-04T23:57:35.690Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-04T23:57:35.690Z] GC before operation: completed in 120.052 ms, heap usage 147.596 MB -> 81.396 MB. [2024-09-04T23:57:37.267Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1363.879 ms) ====== [2024-09-04T23:57:37.267Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-04T23:57:37.267Z] GC before operation: completed in 118.174 ms, heap usage 265.150 MB -> 81.741 MB. [2024-09-04T23:57:38.842Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1370.567 ms) ====== [2024-09-04T23:57:38.842Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-04T23:57:38.842Z] GC before operation: completed in 121.955 ms, heap usage 134.939 MB -> 81.079 MB. [2024-09-04T23:57:40.417Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1448.506 ms) ====== [2024-09-04T23:57:40.417Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-04T23:57:40.417Z] GC before operation: completed in 127.587 ms, heap usage 127.450 MB -> 70.431 MB. [2024-09-04T23:57:42.006Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1387.148 ms) ====== [2024-09-04T23:57:42.006Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-04T23:57:42.006Z] GC before operation: completed in 125.089 ms, heap usage 348.367 MB -> 81.838 MB. [2024-09-04T23:57:43.585Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1379.977 ms) ====== [2024-09-04T23:57:43.585Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-04T23:57:43.585Z] GC before operation: completed in 116.638 ms, heap usage 168.436 MB -> 76.332 MB. [2024-09-04T23:57:45.179Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1390.438 ms) ====== [2024-09-04T23:57:45.179Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-04T23:57:45.179Z] GC before operation: completed in 116.103 ms, heap usage 332.633 MB -> 82.242 MB. [2024-09-04T23:57:46.764Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1360.119 ms) ====== [2024-09-04T23:57:46.764Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-04T23:57:46.764Z] GC before operation: completed in 118.775 ms, heap usage 329.830 MB -> 77.041 MB. [2024-09-04T23:57:48.351Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1360.931 ms) ====== [2024-09-04T23:57:48.351Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-04T23:57:48.351Z] GC before operation: completed in 130.366 ms, heap usage 437.757 MB -> 82.448 MB. [2024-09-04T23:57:49.113Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1349.154 ms) ====== [2024-09-04T23:57:49.113Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-04T23:57:49.877Z] GC before operation: completed in 130.399 ms, heap usage 386.243 MB -> 87.932 MB. [2024-09-04T23:57:50.639Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1377.248 ms) ====== [2024-09-04T23:57:50.640Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-04T23:57:51.402Z] GC before operation: completed in 128.122 ms, heap usage 283.834 MB -> 82.434 MB. [2024-09-04T23:57:52.171Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1371.758 ms) ====== [2024-09-04T23:57:52.936Z] ----------------------------------- [2024-09-04T23:57:52.936Z] renaissance-dec-tree_0_PASSED [2024-09-04T23:57:52.936Z] ----------------------------------- [2024-09-04T23:57:52.936Z] [2024-09-04T23:57:52.936Z] TEST TEARDOWN: [2024-09-04T23:57:52.936Z] Nothing to be done for teardown. [2024-09-04T23:57:52.936Z] renaissance-dec-tree_0 Finish Time: Wed Sep 4 23:57:52 2024 Epoch Time (ms): 1725494272269