[2024-06-26T23:59:25.603Z] Running test renaissance-dec-tree_0 ... [2024-06-26T23:59:25.603Z] =============================================== [2024-06-26T23:59:25.603Z] renaissance-dec-tree_0 Start Time: Wed Jun 26 23:59:25 2024 Epoch Time (ms): 1719446365176 [2024-06-26T23:59:25.603Z] variation: NoOptions [2024-06-26T23:59:25.603Z] JVM_OPTIONS: [2024-06-26T23:59:25.603Z] { \ [2024-06-26T23:59:25.603Z] echo ""; echo "TEST SETUP:"; \ [2024-06-26T23:59:25.603Z] echo "Nothing to be done for setup."; \ [2024-06-26T23:59:25.603Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17194459234443/renaissance-dec-tree_0"; \ [2024-06-26T23:59:25.603Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17194459234443/renaissance-dec-tree_0"; \ [2024-06-26T23:59:25.603Z] echo ""; echo "TESTING:"; \ [2024-06-26T23:59:25.603Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_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_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17194459234443/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-06-26T23:59:25.603Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17194459234443/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-06-26T23:59:25.603Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-06-26T23:59:25.603Z] echo "Nothing to be done for teardown."; \ [2024-06-26T23:59:25.603Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_17194459234443/TestTargetResult"; [2024-06-26T23:59:25.603Z] [2024-06-26T23:59:25.603Z] TEST SETUP: [2024-06-26T23:59:25.603Z] Nothing to be done for setup. [2024-06-26T23:59:25.603Z] [2024-06-26T23:59:25.603Z] TESTING: [2024-06-26T23:59:28.558Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-06-26T23:59:30.471Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-06-26T23:59:33.420Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-06-26T23:59:33.420Z] GC before operation: completed in 44.367 ms, heap usage 67.507 MB -> 35.198 MB. [2024-06-26T23:59:39.992Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6714.928 ms) ====== [2024-06-26T23:59:39.992Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-06-26T23:59:39.992Z] GC before operation: completed in 71.793 ms, heap usage 225.687 MB -> 64.603 MB. [2024-06-26T23:59:41.909Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2011.858 ms) ====== [2024-06-26T23:59:41.909Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-06-26T23:59:41.909Z] GC before operation: completed in 80.585 ms, heap usage 238.369 MB -> 64.994 MB. [2024-06-26T23:59:43.830Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1734.522 ms) ====== [2024-06-26T23:59:43.830Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-06-26T23:59:43.830Z] GC before operation: completed in 68.718 ms, heap usage 288.105 MB -> 65.299 MB. [2024-06-26T23:59:43.831Z] 24/06/26 23:59:43 WARN BlockManager: Asked to remove block broadcast_36, which does not exist [2024-06-26T23:59:45.747Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1623.104 ms) ====== [2024-06-26T23:59:45.747Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-06-26T23:59:45.747Z] GC before operation: completed in 85.856 ms, heap usage 255.281 MB -> 65.525 MB. [2024-06-26T23:59:47.665Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1652.586 ms) ====== [2024-06-26T23:59:47.665Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-06-26T23:59:47.665Z] GC before operation: completed in 68.980 ms, heap usage 130.964 MB -> 65.620 MB. [2024-06-26T23:59:48.599Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1597.881 ms) ====== [2024-06-26T23:59:48.599Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-06-26T23:59:49.529Z] GC before operation: completed in 71.750 ms, heap usage 299.426 MB -> 66.339 MB. [2024-06-26T23:59:50.588Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1554.387 ms) ====== [2024-06-26T23:59:50.588Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-06-26T23:59:50.588Z] GC before operation: completed in 93.521 ms, heap usage 327.819 MB -> 77.512 MB. [2024-06-26T23:59:52.499Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1501.816 ms) ====== [2024-06-26T23:59:52.499Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-06-26T23:59:52.499Z] GC before operation: completed in 79.076 ms, heap usage 214.976 MB -> 66.513 MB. [2024-06-26T23:59:53.428Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1471.339 ms) ====== [2024-06-26T23:59:53.428Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-06-26T23:59:53.428Z] GC before operation: completed in 87.296 ms, heap usage 324.494 MB -> 66.490 MB. [2024-06-26T23:59:55.361Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1515.305 ms) ====== [2024-06-26T23:59:55.361Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-06-26T23:59:55.361Z] GC before operation: completed in 94.006 ms, heap usage 110.375 MB -> 66.200 MB. [2024-06-26T23:59:57.271Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1529.822 ms) ====== [2024-06-26T23:59:57.271Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-06-26T23:59:57.271Z] GC before operation: completed in 80.866 ms, heap usage 174.895 MB -> 66.590 MB. [2024-06-26T23:59:58.202Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1460.389 ms) ====== [2024-06-26T23:59:58.202Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-06-26T23:59:58.202Z] GC before operation: completed in 83.568 ms, heap usage 337.373 MB -> 66.784 MB. [2024-06-27T00:00:00.124Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1452.844 ms) ====== [2024-06-27T00:00:00.124Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-06-27T00:00:00.124Z] GC before operation: completed in 94.897 ms, heap usage 314.234 MB -> 77.844 MB. [2024-06-27T00:00:02.847Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1463.222 ms) ====== [2024-06-27T00:00:02.847Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-06-27T00:00:02.847Z] GC before operation: completed in 89.175 ms, heap usage 217.271 MB -> 67.011 MB. [2024-06-27T00:00:03.780Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2093.934 ms) ====== [2024-06-27T00:00:03.780Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-06-27T00:00:03.780Z] GC before operation: completed in 93.038 ms, heap usage 314.962 MB -> 72.965 MB. [2024-06-27T00:00:05.703Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1470.632 ms) ====== [2024-06-27T00:00:05.703Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-06-27T00:00:05.703Z] GC before operation: completed in 90.068 ms, heap usage 263.613 MB -> 67.503 MB. [2024-06-27T00:00:07.499Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1447.451 ms) ====== [2024-06-27T00:00:07.499Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-06-27T00:00:07.499Z] GC before operation: completed in 89.488 ms, heap usage 315.005 MB -> 67.408 MB. [2024-06-27T00:00:08.640Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1417.309 ms) ====== [2024-06-27T00:00:08.640Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-06-27T00:00:08.640Z] GC before operation: completed in 87.263 ms, heap usage 342.601 MB -> 84.301 MB. [2024-06-27T00:00:09.570Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1410.832 ms) ====== [2024-06-27T00:00:09.570Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-06-27T00:00:09.570Z] GC before operation: completed in 81.110 ms, heap usage 123.694 MB -> 67.125 MB. [2024-06-27T00:00:11.487Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1409.808 ms) ====== [2024-06-27T00:00:11.487Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-06-27T00:00:11.487Z] GC before operation: completed in 79.465 ms, heap usage 111.891 MB -> 67.385 MB. [2024-06-27T00:00:13.403Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1400.606 ms) ====== [2024-06-27T00:00:13.403Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-06-27T00:00:13.403Z] GC before operation: completed in 85.268 ms, heap usage 150.154 MB -> 67.717 MB. [2024-06-27T00:00:14.339Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1413.576 ms) ====== [2024-06-27T00:00:14.339Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-06-27T00:00:14.339Z] GC before operation: completed in 93.027 ms, heap usage 260.628 MB -> 84.727 MB. [2024-06-27T00:00:16.251Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1472.367 ms) ====== [2024-06-27T00:00:16.251Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-06-27T00:00:16.251Z] GC before operation: completed in 109.112 ms, heap usage 433.937 MB -> 68.126 MB. [2024-06-27T00:00:17.182Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1399.490 ms) ====== [2024-06-27T00:00:17.182Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-06-27T00:00:17.182Z] GC before operation: completed in 88.936 ms, heap usage 319.419 MB -> 73.783 MB. [2024-06-27T00:00:19.095Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1389.328 ms) ====== [2024-06-27T00:00:19.095Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-06-27T00:00:19.095Z] GC before operation: completed in 95.691 ms, heap usage 239.518 MB -> 68.299 MB. [2024-06-27T00:00:21.008Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1436.669 ms) ====== [2024-06-27T00:00:21.008Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-06-27T00:00:21.008Z] GC before operation: completed in 100.205 ms, heap usage 295.693 MB -> 68.354 MB. [2024-06-27T00:00:21.939Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1402.300 ms) ====== [2024-06-27T00:00:21.939Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-06-27T00:00:21.939Z] GC before operation: completed in 88.728 ms, heap usage 288.393 MB -> 79.590 MB. [2024-06-27T00:00:23.850Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1433.480 ms) ====== [2024-06-27T00:00:23.850Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-06-27T00:00:23.850Z] GC before operation: completed in 87.077 ms, heap usage 170.086 MB -> 68.730 MB. [2024-06-27T00:00:24.782Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1399.984 ms) ====== [2024-06-27T00:00:24.782Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-06-27T00:00:24.782Z] GC before operation: completed in 87.105 ms, heap usage 269.266 MB -> 68.862 MB. [2024-06-27T00:00:26.692Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1378.069 ms) ====== [2024-06-27T00:00:26.692Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-06-27T00:00:26.692Z] GC before operation: completed in 90.619 ms, heap usage 284.011 MB -> 80.125 MB. [2024-06-27T00:00:27.628Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1390.339 ms) ====== [2024-06-27T00:00:27.628Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-06-27T00:00:27.628Z] GC before operation: completed in 99.255 ms, heap usage 128.612 MB -> 79.655 MB. [2024-06-27T00:00:29.568Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1449.605 ms) ====== [2024-06-27T00:00:29.568Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-06-27T00:00:29.568Z] GC before operation: completed in 94.769 ms, heap usage 332.281 MB -> 69.048 MB. [2024-06-27T00:00:31.478Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1379.515 ms) ====== [2024-06-27T00:00:31.478Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-06-27T00:00:31.478Z] GC before operation: completed in 92.690 ms, heap usage 300.516 MB -> 80.241 MB. [2024-06-27T00:00:32.408Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1379.265 ms) ====== [2024-06-27T00:00:32.408Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-06-27T00:00:32.408Z] GC before operation: completed in 91.309 ms, heap usage 170.125 MB -> 69.124 MB. [2024-06-27T00:00:34.319Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1388.135 ms) ====== [2024-06-27T00:00:34.319Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-06-27T00:00:34.319Z] GC before operation: completed in 89.233 ms, heap usage 252.209 MB -> 91.513 MB. [2024-06-27T00:00:34.319Z] 24/06/27 00:00:33 WARN BlockManager: Asked to remove block broadcast_484, which does not exist [2024-06-27T00:00:34.319Z] 24/06/27 00:00:33 WARN BlockManager: Asked to remove block broadcast_484_piece0, which does not exist [2024-06-27T00:00:35.254Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1373.853 ms) ====== [2024-06-27T00:00:35.254Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-06-27T00:00:35.254Z] GC before operation: completed in 89.392 ms, heap usage 341.284 MB -> 86.107 MB. [2024-06-27T00:00:37.167Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1384.013 ms) ====== [2024-06-27T00:00:37.167Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-06-27T00:00:37.167Z] GC before operation: completed in 92.804 ms, heap usage 424.759 MB -> 80.872 MB. [2024-06-27T00:00:38.097Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1373.564 ms) ====== [2024-06-27T00:00:38.097Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-06-27T00:00:38.097Z] GC before operation: completed in 87.582 ms, heap usage 208.582 MB -> 69.704 MB. [2024-06-27T00:00:40.010Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1347.068 ms) ====== [2024-06-27T00:00:40.010Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-06-27T00:00:40.010Z] GC before operation: completed in 85.111 ms, heap usage 285.473 MB -> 69.826 MB. [2024-06-27T00:00:40.941Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1350.507 ms) ====== [2024-06-27T00:00:41.872Z] ----------------------------------- [2024-06-27T00:00:41.872Z] renaissance-dec-tree_0_PASSED [2024-06-27T00:00:41.872Z] ----------------------------------- [2024-06-27T00:00:41.872Z] [2024-06-27T00:00:41.872Z] TEST TEARDOWN: [2024-06-27T00:00:41.872Z] Nothing to be done for teardown. [2024-06-27T00:00:41.872Z] renaissance-dec-tree_0 Finish Time: Thu Jun 27 00:00:40 2024 Epoch Time (ms): 1719446440878