[2024-08-22T00:12:45.306Z] Running test renaissance-dec-tree_0 ... [2024-08-22T00:12:45.306Z] =============================================== [2024-08-22T00:12:45.306Z] renaissance-dec-tree_0 Start Time: Thu Aug 22 00:12:44 2024 Epoch Time (ms): 1724285564682 [2024-08-22T00:12:45.306Z] variation: NoOptions [2024-08-22T00:12:45.306Z] JVM_OPTIONS: [2024-08-22T00:12:45.306Z] { \ [2024-08-22T00:12:45.306Z] echo ""; echo "TEST SETUP:"; \ [2024-08-22T00:12:45.306Z] echo "Nothing to be done for setup."; \ [2024-08-22T00:12:45.306Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/renaissance-dec-tree_0"; \ [2024-08-22T00:12:45.306Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/renaissance-dec-tree_0"; \ [2024-08-22T00:12:45.306Z] echo ""; echo "TESTING:"; \ [2024-08-22T00:12:45.306Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-22T00:12:45.306Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-22T00:12:45.306Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-22T00:12:45.306Z] echo "Nothing to be done for teardown."; \ [2024-08-22T00:12:45.306Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/TestTargetResult"; [2024-08-22T00:12:45.306Z] [2024-08-22T00:12:45.306Z] TEST SETUP: [2024-08-22T00:12:45.306Z] Nothing to be done for setup. [2024-08-22T00:12:45.306Z] [2024-08-22T00:12:45.306Z] TESTING: [2024-08-22T00:12:51.132Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-22T00:12:53.164Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-22T00:12:57.045Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-22T00:12:57.045Z] GC before operation: completed in 74.591 ms, heap usage 59.156 MB -> 34.952 MB. [2024-08-22T00:13:08.514Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (12118.447 ms) ====== [2024-08-22T00:13:08.514Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-22T00:13:09.152Z] GC before operation: completed in 151.545 ms, heap usage 293.577 MB -> 90.953 MB. [2024-08-22T00:13:12.978Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (4090.112 ms) ====== [2024-08-22T00:13:12.978Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-22T00:13:12.978Z] GC before operation: completed in 237.171 ms, heap usage 224.963 MB -> 63.924 MB. [2024-08-22T00:13:16.878Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3574.668 ms) ====== [2024-08-22T00:13:16.878Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-22T00:13:16.878Z] GC before operation: completed in 272.886 ms, heap usage 277.342 MB -> 91.952 MB. [2024-08-22T00:13:22.063Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4351.919 ms) ====== [2024-08-22T00:13:22.063Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-22T00:13:22.063Z] GC before operation: completed in 180.307 ms, heap usage 316.388 MB -> 64.604 MB. [2024-08-22T00:13:24.894Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3218.686 ms) ====== [2024-08-22T00:13:24.894Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-22T00:13:24.894Z] GC before operation: completed in 230.943 ms, heap usage 266.151 MB -> 64.435 MB. [2024-08-22T00:13:27.765Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2723.528 ms) ====== [2024-08-22T00:13:27.765Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-22T00:13:27.765Z] GC before operation: completed in 200.340 ms, heap usage 188.782 MB -> 92.595 MB. [2024-08-22T00:13:31.529Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3036.190 ms) ====== [2024-08-22T00:13:31.529Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-22T00:13:31.529Z] GC before operation: completed in 190.606 ms, heap usage 238.069 MB -> 92.599 MB. [2024-08-22T00:13:34.338Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2892.445 ms) ====== [2024-08-22T00:13:34.338Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-22T00:13:34.338Z] GC before operation: completed in 156.539 ms, heap usage 179.138 MB -> 92.382 MB. [2024-08-22T00:13:37.199Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2557.780 ms) ====== [2024-08-22T00:13:37.199Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-22T00:13:37.199Z] GC before operation: completed in 185.661 ms, heap usage 279.480 MB -> 65.499 MB. [2024-08-22T00:13:40.181Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (3237.144 ms) ====== [2024-08-22T00:13:40.181Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-22T00:13:40.181Z] GC before operation: completed in 239.391 ms, heap usage 276.561 MB -> 65.268 MB. [2024-08-22T00:13:44.995Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4012.885 ms) ====== [2024-08-22T00:13:44.995Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-22T00:13:44.995Z] GC before operation: completed in 208.278 ms, heap usage 128.467 MB -> 65.054 MB. [2024-08-22T00:13:47.960Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3200.842 ms) ====== [2024-08-22T00:13:47.960Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-22T00:13:47.960Z] GC before operation: completed in 193.552 ms, heap usage 259.990 MB -> 65.628 MB. [2024-08-22T00:13:51.002Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2671.073 ms) ====== [2024-08-22T00:13:51.002Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-22T00:13:51.002Z] GC before operation: completed in 196.614 ms, heap usage 155.264 MB -> 65.299 MB. [2024-08-22T00:13:53.939Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2599.943 ms) ====== [2024-08-22T00:13:53.939Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-22T00:13:53.940Z] GC before operation: completed in 214.157 ms, heap usage 211.586 MB -> 65.701 MB. [2024-08-22T00:13:56.955Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (3211.024 ms) ====== [2024-08-22T00:13:56.955Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-22T00:13:56.955Z] GC before operation: completed in 233.911 ms, heap usage 218.382 MB -> 65.876 MB. [2024-08-22T00:13:59.846Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2624.882 ms) ====== [2024-08-22T00:13:59.846Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-22T00:13:59.846Z] GC before operation: completed in 139.096 ms, heap usage 151.336 MB -> 65.847 MB. [2024-08-22T00:14:02.909Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2908.111 ms) ====== [2024-08-22T00:14:02.909Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-22T00:14:02.909Z] GC before operation: completed in 238.251 ms, heap usage 329.358 MB -> 66.456 MB. [2024-08-22T00:14:05.820Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2794.001 ms) ====== [2024-08-22T00:14:05.820Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-22T00:14:05.820Z] GC before operation: completed in 139.718 ms, heap usage 112.422 MB -> 66.071 MB. [2024-08-22T00:14:08.730Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2610.811 ms) ====== [2024-08-22T00:14:08.730Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-22T00:14:08.730Z] GC before operation: completed in 217.634 ms, heap usage 241.394 MB -> 66.376 MB. [2024-08-22T00:14:11.847Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3025.947 ms) ====== [2024-08-22T00:14:11.847Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-22T00:14:12.467Z] GC before operation: completed in 237.759 ms, heap usage 178.198 MB -> 66.330 MB. [2024-08-22T00:14:15.369Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (3150.432 ms) ====== [2024-08-22T00:14:15.369Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-22T00:14:15.369Z] GC before operation: completed in 179.563 ms, heap usage 151.319 MB -> 66.221 MB. [2024-08-22T00:14:18.219Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2579.566 ms) ====== [2024-08-22T00:14:18.219Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-22T00:14:18.219Z] GC before operation: completed in 250.382 ms, heap usage 327.742 MB -> 66.558 MB. [2024-08-22T00:14:23.224Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4450.106 ms) ====== [2024-08-22T00:14:23.224Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-22T00:14:23.225Z] GC before operation: completed in 197.881 ms, heap usage 116.314 MB -> 66.514 MB. [2024-08-22T00:14:26.081Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3217.123 ms) ====== [2024-08-22T00:14:26.081Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-22T00:14:26.736Z] GC before operation: completed in 331.780 ms, heap usage 389.514 MB -> 66.866 MB. [2024-08-22T00:14:29.685Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2691.709 ms) ====== [2024-08-22T00:14:29.685Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-22T00:14:29.685Z] GC before operation: completed in 279.024 ms, heap usage 104.378 MB -> 66.743 MB. [2024-08-22T00:14:32.592Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2576.977 ms) ====== [2024-08-22T00:14:32.592Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-22T00:14:32.592Z] GC before operation: completed in 186.529 ms, heap usage 195.882 MB -> 67.189 MB. [2024-08-22T00:14:35.080Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2626.635 ms) ====== [2024-08-22T00:14:35.080Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-22T00:14:35.776Z] GC before operation: completed in 192.155 ms, heap usage 102.654 MB -> 66.741 MB. [2024-08-22T00:14:37.915Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2563.320 ms) ====== [2024-08-22T00:14:37.915Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-22T00:14:37.915Z] GC before operation: completed in 308.753 ms, heap usage 225.971 MB -> 67.417 MB. [2024-08-22T00:14:41.071Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2550.754 ms) ====== [2024-08-22T00:14:41.071Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-22T00:14:41.071Z] GC before operation: completed in 303.922 ms, heap usage 237.240 MB -> 67.721 MB. [2024-08-22T00:14:44.241Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3187.579 ms) ====== [2024-08-22T00:14:44.241Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-22T00:14:44.241Z] GC before operation: completed in 374.668 ms, heap usage 128.975 MB -> 67.296 MB. [2024-08-22T00:14:47.475Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3248.593 ms) ====== [2024-08-22T00:14:47.475Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-22T00:14:48.124Z] GC before operation: completed in 268.540 ms, heap usage 157.625 MB -> 67.231 MB. [2024-08-22T00:14:51.248Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3390.621 ms) ====== [2024-08-22T00:14:51.248Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-22T00:14:51.859Z] GC before operation: completed in 211.880 ms, heap usage 276.742 MB -> 67.638 MB. [2024-08-22T00:14:53.925Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2415.349 ms) ====== [2024-08-22T00:14:53.925Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-22T00:14:53.925Z] GC before operation: completed in 159.547 ms, heap usage 156.002 MB -> 67.581 MB. [2024-08-22T00:14:56.777Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2268.136 ms) ====== [2024-08-22T00:14:56.777Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-22T00:14:56.777Z] GC before operation: completed in 345.746 ms, heap usage 288.315 MB -> 67.933 MB. [2024-08-22T00:14:59.796Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3177.820 ms) ====== [2024-08-22T00:14:59.796Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-22T00:14:59.796Z] GC before operation: completed in 138.384 ms, heap usage 317.527 MB -> 67.910 MB. [2024-08-22T00:15:02.639Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2445.694 ms) ====== [2024-08-22T00:15:02.639Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-22T00:15:02.639Z] GC before operation: completed in 168.801 ms, heap usage 102.876 MB -> 67.496 MB. [2024-08-22T00:15:05.443Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2329.495 ms) ====== [2024-08-22T00:15:05.443Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-22T00:15:05.443Z] GC before operation: completed in 297.911 ms, heap usage 183.060 MB -> 95.882 MB. [2024-08-22T00:15:08.336Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2803.322 ms) ====== [2024-08-22T00:15:08.336Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-22T00:15:08.336Z] GC before operation: completed in 149.875 ms, heap usage 205.736 MB -> 95.987 MB. [2024-08-22T00:15:11.287Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2533.145 ms) ====== [2024-08-22T00:15:11.287Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-22T00:15:11.287Z] GC before operation: completed in 181.110 ms, heap usage 216.555 MB -> 68.321 MB. [2024-08-22T00:15:13.299Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2117.607 ms) ====== [2024-08-22T00:15:14.022Z] ----------------------------------- [2024-08-22T00:15:14.022Z] renaissance-dec-tree_0_PASSED [2024-08-22T00:15:14.022Z] ----------------------------------- [2024-08-22T00:15:14.022Z] [2024-08-22T00:15:14.022Z] TEST TEARDOWN: [2024-08-22T00:15:14.022Z] Nothing to be done for teardown. [2024-08-22T00:15:14.022Z] renaissance-dec-tree_0 Finish Time: Thu Aug 22 00:15:13 2024 Epoch Time (ms): 1724285713305