[2024-08-28T20:50:44.941Z] Running test renaissance-dec-tree_0 ... [2024-08-28T20:50:44.941Z] =============================================== [2024-08-28T20:50:44.941Z] renaissance-dec-tree_0 Start Time: Wed Aug 28 20:50:44 2024 Epoch Time (ms): 1724878244234 [2024-08-28T20:50:44.941Z] variation: NoOptions [2024-08-28T20:50:44.941Z] JVM_OPTIONS: [2024-08-28T20:50:44.941Z] { \ [2024-08-28T20:50:44.941Z] echo ""; echo "TEST SETUP:"; \ [2024-08-28T20:50:44.941Z] echo "Nothing to be done for setup."; \ [2024-08-28T20:50:44.941Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248779586869/renaissance-dec-tree_0"; \ [2024-08-28T20:50:44.941Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248779586869/renaissance-dec-tree_0"; \ [2024-08-28T20:50:44.941Z] echo ""; echo "TESTING:"; \ [2024-08-28T20:50:44.941Z] "/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_17248779586869/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-28T20:50:44.941Z] 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_17248779586869/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-28T20:50:44.941Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-28T20:50:44.941Z] echo "Nothing to be done for teardown."; \ [2024-08-28T20:50:44.941Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17248779586869/TestTargetResult"; [2024-08-28T20:50:44.941Z] [2024-08-28T20:50:44.941Z] TEST SETUP: [2024-08-28T20:50:44.941Z] Nothing to be done for setup. [2024-08-28T20:50:44.941Z] [2024-08-28T20:50:44.941Z] TESTING: [2024-08-28T20:50:47.902Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-28T20:50:50.863Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-28T20:50:54.981Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-28T20:50:54.981Z] GC before operation: completed in 56.524 ms, heap usage 80.771 MB -> 37.077 MB. [2024-08-28T20:51:04.790Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8667.463 ms) ====== [2024-08-28T20:51:04.790Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-28T20:51:04.790Z] GC before operation: completed in 79.402 ms, heap usage 304.536 MB -> 68.728 MB. [2024-08-28T20:51:06.714Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2123.629 ms) ====== [2024-08-28T20:51:06.714Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-28T20:51:06.714Z] GC before operation: completed in 84.383 ms, heap usage 319.068 MB -> 80.011 MB. [2024-08-28T20:51:07.648Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1647.096 ms) ====== [2024-08-28T20:51:07.648Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-28T20:51:07.648Z] GC before operation: completed in 89.951 ms, heap usage 423.240 MB -> 69.444 MB. [2024-08-28T20:51:10.655Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2682.433 ms) ====== [2024-08-28T20:51:10.655Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-28T20:51:10.655Z] GC before operation: completed in 92.520 ms, heap usage 208.448 MB -> 69.648 MB. [2024-08-28T20:51:12.573Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1535.647 ms) ====== [2024-08-28T20:51:12.573Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-28T20:51:12.573Z] GC before operation: completed in 97.410 ms, heap usage 300.869 MB -> 69.856 MB. [2024-08-28T20:51:13.507Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1455.184 ms) ====== [2024-08-28T20:51:13.507Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-28T20:51:14.442Z] GC before operation: completed in 93.322 ms, heap usage 180.741 MB -> 69.800 MB. [2024-08-28T20:51:15.376Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1434.085 ms) ====== [2024-08-28T20:51:15.376Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-28T20:51:15.376Z] GC before operation: completed in 96.250 ms, heap usage 207.479 MB -> 70.133 MB. [2024-08-28T20:51:17.298Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1472.625 ms) ====== [2024-08-28T20:51:17.298Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-28T20:51:17.298Z] GC before operation: completed in 109.116 ms, heap usage 199.170 MB -> 70.262 MB. [2024-08-28T20:51:18.248Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1378.114 ms) ====== [2024-08-28T20:51:18.248Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-28T20:51:18.248Z] GC before operation: completed in 103.862 ms, heap usage 103.148 MB -> 69.868 MB. [2024-08-28T20:51:20.176Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1454.213 ms) ====== [2024-08-28T20:51:20.176Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-28T20:51:20.176Z] GC before operation: completed in 107.122 ms, heap usage 354.421 MB -> 70.729 MB. [2024-08-28T20:51:21.112Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1384.294 ms) ====== [2024-08-28T20:51:21.112Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-28T20:51:22.047Z] GC before operation: completed in 114.397 ms, heap usage 155.354 MB -> 70.468 MB. [2024-08-28T20:51:22.982Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1358.220 ms) ====== [2024-08-28T20:51:22.982Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-28T20:51:22.982Z] GC before operation: completed in 112.416 ms, heap usage 465.978 MB -> 70.931 MB. [2024-08-28T20:51:24.901Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1344.249 ms) ====== [2024-08-28T20:51:24.901Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-28T20:51:24.901Z] GC before operation: completed in 115.655 ms, heap usage 105.735 MB -> 70.374 MB. [2024-08-28T20:51:25.836Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1392.929 ms) ====== [2024-08-28T20:51:25.836Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-28T20:51:25.836Z] GC before operation: completed in 117.426 ms, heap usage 323.367 MB -> 71.163 MB. [2024-08-28T20:51:27.755Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1403.862 ms) ====== [2024-08-28T20:51:27.755Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-28T20:51:27.755Z] GC before operation: completed in 120.800 ms, heap usage 120.992 MB -> 70.619 MB. [2024-08-28T20:51:28.690Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1361.894 ms) ====== [2024-08-28T20:51:28.690Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-28T20:51:28.690Z] GC before operation: completed in 121.862 ms, heap usage 326.773 MB -> 71.392 MB. [2024-08-28T20:51:30.638Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1268.154 ms) ====== [2024-08-28T20:51:30.638Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-28T20:51:30.638Z] GC before operation: completed in 127.180 ms, heap usage 156.850 MB -> 71.205 MB. [2024-08-28T20:51:31.573Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1305.802 ms) ====== [2024-08-28T20:51:31.573Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-28T20:51:31.573Z] GC before operation: completed in 129.693 ms, heap usage 452.933 MB -> 71.569 MB. [2024-08-28T20:51:33.608Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1289.950 ms) ====== [2024-08-28T20:51:33.608Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-28T20:51:33.608Z] GC before operation: completed in 134.949 ms, heap usage 152.421 MB -> 71.364 MB. [2024-08-28T20:51:34.572Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1272.510 ms) ====== [2024-08-28T20:51:34.572Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-28T20:51:34.572Z] GC before operation: completed in 128.443 ms, heap usage 445.205 MB -> 71.856 MB. [2024-08-28T20:51:36.491Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1255.246 ms) ====== [2024-08-28T20:51:36.491Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-28T20:51:36.491Z] GC before operation: completed in 127.184 ms, heap usage 106.739 MB -> 71.233 MB. [2024-08-28T20:51:37.426Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1351.661 ms) ====== [2024-08-28T20:51:37.427Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-28T20:51:37.427Z] GC before operation: completed in 127.092 ms, heap usage 306.588 MB -> 71.931 MB. [2024-08-28T20:51:39.413Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1265.561 ms) ====== [2024-08-28T20:51:39.413Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-28T20:51:39.413Z] GC before operation: completed in 129.156 ms, heap usage 120.196 MB -> 71.370 MB. [2024-08-28T20:51:40.350Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1319.934 ms) ====== [2024-08-28T20:51:40.350Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-28T20:51:40.350Z] GC before operation: completed in 141.605 ms, heap usage 500.748 MB -> 72.268 MB. [2024-08-28T20:51:41.285Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1249.174 ms) ====== [2024-08-28T20:51:41.285Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-28T20:51:42.219Z] GC before operation: completed in 141.926 ms, heap usage 112.057 MB -> 71.765 MB. [2024-08-28T20:51:43.158Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1401.407 ms) ====== [2024-08-28T20:51:43.158Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-28T20:51:43.158Z] GC before operation: completed in 143.398 ms, heap usage 314.149 MB -> 72.298 MB. [2024-08-28T20:51:45.077Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1280.887 ms) ====== [2024-08-28T20:51:45.077Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-28T20:51:45.077Z] GC before operation: completed in 139.404 ms, heap usage 123.921 MB -> 71.868 MB. [2024-08-28T20:51:46.016Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1322.992 ms) ====== [2024-08-28T20:51:46.016Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-28T20:51:46.016Z] GC before operation: completed in 136.096 ms, heap usage 512.363 MB -> 72.760 MB. [2024-08-28T20:51:47.936Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1292.646 ms) ====== [2024-08-28T20:51:47.936Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-28T20:51:47.936Z] GC before operation: completed in 134.232 ms, heap usage 113.333 MB -> 71.977 MB. [2024-08-28T20:51:48.873Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1308.239 ms) ====== [2024-08-28T20:51:48.873Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-28T20:51:48.873Z] GC before operation: completed in 142.651 ms, heap usage 328.732 MB -> 83.546 MB. [2024-08-28T20:51:50.794Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1293.712 ms) ====== [2024-08-28T20:51:50.794Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-28T20:51:50.794Z] GC before operation: completed in 141.825 ms, heap usage 345.721 MB -> 72.768 MB. [2024-08-28T20:51:51.733Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1217.222 ms) ====== [2024-08-28T20:51:51.733Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-28T20:51:51.733Z] GC before operation: completed in 137.361 ms, heap usage 291.692 MB -> 73.031 MB. [2024-08-28T20:51:53.652Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1299.671 ms) ====== [2024-08-28T20:51:53.652Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-28T20:51:53.652Z] GC before operation: completed in 143.781 ms, heap usage 108.232 MB -> 72.436 MB. [2024-08-28T20:51:54.587Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1311.910 ms) ====== [2024-08-28T20:51:54.588Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-28T20:51:54.588Z] GC before operation: completed in 137.948 ms, heap usage 487.156 MB -> 73.341 MB. [2024-08-28T20:51:56.506Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1234.685 ms) ====== [2024-08-28T20:51:56.506Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-28T20:51:56.506Z] GC before operation: completed in 141.639 ms, heap usage 252.833 MB -> 73.332 MB. [2024-08-28T20:51:57.441Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1235.966 ms) ====== [2024-08-28T20:51:57.441Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-28T20:51:57.441Z] GC before operation: completed in 146.042 ms, heap usage 259.632 MB -> 73.625 MB. [2024-08-28T20:51:59.375Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1228.697 ms) ====== [2024-08-28T20:51:59.375Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-28T20:51:59.375Z] GC before operation: completed in 148.751 ms, heap usage 252.538 MB -> 73.599 MB. [2024-08-28T20:52:00.309Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1184.911 ms) ====== [2024-08-28T20:52:00.309Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-28T20:52:00.309Z] GC before operation: completed in 143.832 ms, heap usage 253.616 MB -> 73.471 MB. [2024-08-28T20:52:01.243Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1174.564 ms) ====== [2024-08-28T20:52:01.243Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-28T20:52:01.243Z] GC before operation: completed in 149.067 ms, heap usage 277.730 MB -> 73.643 MB. [2024-08-28T20:52:03.162Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1201.939 ms) ====== [2024-08-28T20:52:03.162Z] ----------------------------------- [2024-08-28T20:52:03.162Z] renaissance-dec-tree_0_PASSED [2024-08-28T20:52:03.162Z] ----------------------------------- [2024-08-28T20:52:03.162Z] [2024-08-28T20:52:03.162Z] TEST TEARDOWN: [2024-08-28T20:52:03.162Z] Nothing to be done for teardown. [2024-08-28T20:52:03.162Z] renaissance-dec-tree_0 Finish Time: Wed Aug 28 20:52:02 2024 Epoch Time (ms): 1724878322709