[2024-08-22T00:16:36.978Z] Running test renaissance-gauss-mix_0 ... [2024-08-22T00:16:36.978Z] =============================================== [2024-08-22T00:16:36.978Z] renaissance-gauss-mix_0 Start Time: Thu Aug 22 00:16:36 2024 Epoch Time (ms): 1724285796867 [2024-08-22T00:16:36.978Z] variation: NoOptions [2024-08-22T00:16:36.978Z] JVM_OPTIONS: [2024-08-22T00:16:36.978Z] { \ [2024-08-22T00:16:36.978Z] echo ""; echo "TEST SETUP:"; \ [2024-08-22T00:16:36.978Z] echo "Nothing to be done for setup."; \ [2024-08-22T00:16:36.978Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/renaissance-gauss-mix_0"; \ [2024-08-22T00:16:36.978Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/renaissance-gauss-mix_0"; \ [2024-08-22T00:16:36.978Z] echo ""; echo "TESTING:"; \ [2024-08-22T00:16:36.978Z] "/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-gauss-mix_0"/gauss-mix.json" gauss-mix; \ [2024-08-22T00:16:36.978Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_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-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-22T00:16:36.978Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-22T00:16:36.978Z] echo "Nothing to be done for teardown."; \ [2024-08-22T00:16:36.978Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17242848193106/TestTargetResult"; [2024-08-22T00:16:36.978Z] [2024-08-22T00:16:36.978Z] TEST SETUP: [2024-08-22T00:16:36.978Z] Nothing to be done for setup. [2024-08-22T00:16:36.978Z] [2024-08-22T00:16:36.978Z] TESTING: [2024-08-22T00:16:42.987Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-22T00:16:44.249Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-08-22T00:16:44.249Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2024-08-22T00:16:44.864Z] GC before operation: completed in 56.180 ms, heap usage 61.647 MB -> 25.860 MB. [2024-08-22T00:16:55.244Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (9612.129 ms) ====== [2024-08-22T00:16:55.244Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2024-08-22T00:16:55.244Z] GC before operation: completed in 158.650 ms, heap usage 55.324 MB -> 31.862 MB. [2024-08-22T00:16:59.041Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (4648.896 ms) ====== [2024-08-22T00:16:59.041Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2024-08-22T00:16:59.041Z] GC before operation: completed in 93.815 ms, heap usage 99.250 MB -> 32.166 MB. [2024-08-22T00:17:03.807Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (4251.810 ms) ====== [2024-08-22T00:17:03.807Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2024-08-22T00:17:03.807Z] GC before operation: completed in 56.446 ms, heap usage 54.957 MB -> 32.407 MB. [2024-08-22T00:17:07.549Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (4326.157 ms) ====== [2024-08-22T00:17:07.549Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2024-08-22T00:17:08.182Z] GC before operation: completed in 123.141 ms, heap usage 157.244 MB -> 33.251 MB. [2024-08-22T00:17:08.182Z] 24/08/22 00:17:07 WARN BlockManager: Asked to remove block rdd_54_1, which does not exist [2024-08-22T00:17:08.182Z] 24/08/22 00:17:07 WARN BlockManager: Asked to remove block rdd_54_0, which does not exist [2024-08-22T00:17:13.255Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (4822.511 ms) ====== [2024-08-22T00:17:13.255Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2024-08-22T00:17:13.255Z] GC before operation: completed in 138.785 ms, heap usage 92.788 MB -> 32.847 MB. [2024-08-22T00:17:17.208Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (3866.571 ms) ====== [2024-08-22T00:17:17.208Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2024-08-22T00:17:17.208Z] GC before operation: completed in 80.443 ms, heap usage 123.854 MB -> 33.289 MB. [2024-08-22T00:17:21.106Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (4137.699 ms) ====== [2024-08-22T00:17:21.106Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2024-08-22T00:17:21.106Z] GC before operation: completed in 114.320 ms, heap usage 71.460 MB -> 33.033 MB. [2024-08-22T00:17:26.255Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (4903.804 ms) ====== [2024-08-22T00:17:26.255Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2024-08-22T00:17:26.255Z] GC before operation: completed in 98.602 ms, heap usage 179.605 MB -> 33.196 MB. [2024-08-22T00:17:30.100Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (3548.874 ms) ====== [2024-08-22T00:17:30.100Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2024-08-22T00:17:30.100Z] GC before operation: completed in 151.662 ms, heap usage 120.869 MB -> 33.895 MB. [2024-08-22T00:17:33.875Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (3728.851 ms) ====== [2024-08-22T00:17:33.876Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2024-08-22T00:17:33.876Z] GC before operation: completed in 80.145 ms, heap usage 100.712 MB -> 33.476 MB. [2024-08-22T00:17:37.666Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (3997.486 ms) ====== [2024-08-22T00:17:37.666Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2024-08-22T00:17:37.666Z] GC before operation: completed in 138.575 ms, heap usage 141.330 MB -> 33.483 MB. [2024-08-22T00:17:41.606Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (3780.650 ms) ====== [2024-08-22T00:17:41.606Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2024-08-22T00:17:41.606Z] GC before operation: completed in 225.352 ms, heap usage 86.268 MB -> 33.630 MB. [2024-08-22T00:17:46.517Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (4956.918 ms) ====== [2024-08-22T00:17:46.517Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2024-08-22T00:17:46.517Z] GC before operation: completed in 96.388 ms, heap usage 111.860 MB -> 33.694 MB. [2024-08-22T00:17:50.316Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (3706.506 ms) ====== [2024-08-22T00:17:50.316Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2024-08-22T00:17:50.316Z] GC before operation: completed in 97.340 ms, heap usage 64.272 MB -> 33.832 MB. [2024-08-22T00:17:53.991Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (3305.745 ms) ====== [2024-08-22T00:17:53.991Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2024-08-22T00:17:53.991Z] GC before operation: completed in 75.032 ms, heap usage 54.992 MB -> 34.222 MB. [2024-08-22T00:17:56.879Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (3021.130 ms) ====== [2024-08-22T00:17:56.879Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2024-08-22T00:17:56.879Z] GC before operation: completed in 86.783 ms, heap usage 95.112 MB -> 33.965 MB. [2024-08-22T00:18:01.176Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (3819.448 ms) ====== [2024-08-22T00:18:01.176Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2024-08-22T00:18:01.176Z] GC before operation: completed in 69.226 ms, heap usage 118.793 MB -> 34.090 MB. [2024-08-22T00:18:05.176Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (3611.389 ms) ====== [2024-08-22T00:18:05.176Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2024-08-22T00:18:05.176Z] GC before operation: completed in 93.613 ms, heap usage 225.410 MB -> 34.223 MB. [2024-08-22T00:18:08.961Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (3963.886 ms) ====== [2024-08-22T00:18:08.961Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2024-08-22T00:18:08.961Z] GC before operation: completed in 54.866 ms, heap usage 176.098 MB -> 34.300 MB. [2024-08-22T00:18:12.943Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (3774.597 ms) ====== [2024-08-22T00:18:12.943Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2024-08-22T00:18:12.943Z] GC before operation: completed in 87.450 ms, heap usage 145.628 MB -> 34.416 MB. [2024-08-22T00:18:16.897Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (3829.639 ms) ====== [2024-08-22T00:18:16.897Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2024-08-22T00:18:16.897Z] GC before operation: completed in 105.685 ms, heap usage 84.450 MB -> 34.458 MB. [2024-08-22T00:18:20.666Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (3763.846 ms) ====== [2024-08-22T00:18:20.666Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2024-08-22T00:18:20.666Z] GC before operation: completed in 205.746 ms, heap usage 136.155 MB -> 35.229 MB. [2024-08-22T00:18:24.588Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (4332.939 ms) ====== [2024-08-22T00:18:24.588Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2024-08-22T00:18:24.588Z] GC before operation: completed in 112.006 ms, heap usage 187.650 MB -> 34.747 MB. [2024-08-22T00:18:28.606Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (3578.566 ms) ====== [2024-08-22T00:18:28.606Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2024-08-22T00:18:28.606Z] GC before operation: completed in 76.548 ms, heap usage 157.397 MB -> 34.821 MB. [2024-08-22T00:18:32.550Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (3948.712 ms) ====== [2024-08-22T00:18:32.550Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2024-08-22T00:18:32.550Z] GC before operation: completed in 113.774 ms, heap usage 190.729 MB -> 35.588 MB. [2024-08-22T00:18:37.386Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (4150.109 ms) ====== [2024-08-22T00:18:37.386Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2024-08-22T00:18:37.386Z] GC before operation: completed in 95.225 ms, heap usage 86.195 MB -> 34.946 MB. [2024-08-22T00:18:40.645Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (4011.162 ms) ====== [2024-08-22T00:18:40.645Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2024-08-22T00:18:40.645Z] GC before operation: completed in 64.754 ms, heap usage 190.409 MB -> 35.761 MB. [2024-08-22T00:18:45.444Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (3997.773 ms) ====== [2024-08-22T00:18:45.444Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2024-08-22T00:18:45.444Z] GC before operation: completed in 66.689 ms, heap usage 70.424 MB -> 35.201 MB. [2024-08-22T00:18:49.790Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (4128.579 ms) ====== [2024-08-22T00:18:49.790Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2024-08-22T00:18:49.790Z] GC before operation: completed in 89.383 ms, heap usage 146.324 MB -> 35.301 MB. [2024-08-22T00:18:53.767Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (3959.065 ms) ====== [2024-08-22T00:18:53.767Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2024-08-22T00:18:53.767Z] GC before operation: completed in 70.155 ms, heap usage 57.533 MB -> 35.440 MB. [2024-08-22T00:18:56.621Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (3359.787 ms) ====== [2024-08-22T00:18:56.621Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2024-08-22T00:18:56.621Z] GC before operation: completed in 88.555 ms, heap usage 134.826 MB -> 35.442 MB. [2024-08-22T00:19:00.592Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (4128.065 ms) ====== [2024-08-22T00:19:00.592Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2024-08-22T00:19:01.224Z] GC before operation: completed in 122.927 ms, heap usage 131.092 MB -> 35.576 MB. [2024-08-22T00:19:05.085Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (3761.538 ms) ====== [2024-08-22T00:19:05.085Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2024-08-22T00:19:05.085Z] GC before operation: completed in 156.830 ms, heap usage 212.420 MB -> 35.679 MB. [2024-08-22T00:19:09.107Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (4187.484 ms) ====== [2024-08-22T00:19:09.107Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2024-08-22T00:19:09.107Z] GC before operation: completed in 61.103 ms, heap usage 185.658 MB -> 35.791 MB. [2024-08-22T00:19:12.886Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (3211.691 ms) ====== [2024-08-22T00:19:12.886Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2024-08-22T00:19:12.886Z] GC before operation: completed in 95.376 ms, heap usage 112.494 MB -> 35.882 MB. [2024-08-22T00:19:15.754Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (3080.496 ms) ====== [2024-08-22T00:19:15.754Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2024-08-22T00:19:15.754Z] GC before operation: completed in 96.737 ms, heap usage 45.569 MB -> 35.992 MB. [2024-08-22T00:19:18.599Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (2951.314 ms) ====== [2024-08-22T00:19:18.599Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2024-08-22T00:19:18.599Z] GC before operation: completed in 91.236 ms, heap usage 55.172 MB -> 36.111 MB. [2024-08-22T00:19:21.523Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (3029.346 ms) ====== [2024-08-22T00:19:21.523Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2024-08-22T00:19:21.523Z] GC before operation: completed in 54.777 ms, heap usage 91.465 MB -> 36.234 MB. [2024-08-22T00:19:25.356Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (3596.576 ms) ====== [2024-08-22T00:19:25.356Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2024-08-22T00:19:25.356Z] GC before operation: completed in 108.393 ms, heap usage 41.791 MB -> 36.298 MB. [2024-08-22T00:19:29.184Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (3148.103 ms) ====== [2024-08-22T00:19:29.184Z] ----------------------------------- [2024-08-22T00:19:29.184Z] renaissance-gauss-mix_0_PASSED [2024-08-22T00:19:29.184Z] ----------------------------------- [2024-08-22T00:19:29.184Z] [2024-08-22T00:19:29.184Z] TEST TEARDOWN: [2024-08-22T00:19:29.184Z] Nothing to be done for teardown. [2024-08-22T00:19:29.184Z] renaissance-gauss-mix_0 Finish Time: Thu Aug 22 00:19:28 2024 Epoch Time (ms): 1724285968648