[2025-01-22T04:15:44.653Z] Running test renaissance-gauss-mix_0 ... [2025-01-22T04:15:44.653Z] =============================================== [2025-01-22T04:15:44.653Z] renaissance-gauss-mix_0 Start Time: Wed Jan 22 04:15:44 2025 Epoch Time (ms): 1737519344540 [2025-01-22T04:15:44.653Z] variation: NoOptions [2025-01-22T04:15:44.653Z] JVM_OPTIONS: [2025-01-22T04:15:44.653Z] { \ [2025-01-22T04:15:44.653Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T04:15:44.653Z] echo "Nothing to be done for setup."; \ [2025-01-22T04:15:44.653Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-gauss-mix_0"; \ [2025-01-22T04:15:44.653Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-gauss-mix_0"; \ [2025-01-22T04:15:44.653Z] echo ""; echo "TESTING:"; \ [2025-01-22T04:15:44.653Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-gauss-mix_0"/gauss-mix.json" gauss-mix; \ [2025-01-22T04:15:44.654Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T04:15:44.654Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T04:15:44.654Z] echo "Nothing to be done for teardown."; \ [2025-01-22T04:15:44.654Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/TestTargetResult"; [2025-01-22T04:15:44.654Z] [2025-01-22T04:15:44.654Z] TEST SETUP: [2025-01-22T04:15:44.654Z] Nothing to be done for setup. [2025-01-22T04:15:44.654Z] [2025-01-22T04:15:44.654Z] TESTING: [2025-01-22T04:15:47.543Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-22T04:15:48.972Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-01-22T04:15:49.610Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2025-01-22T04:15:49.610Z] GC before operation: completed in 32.143 ms, heap usage 42.828 MB -> 25.288 MB. [2025-01-22T04:15:59.900Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (9043.374 ms) ====== [2025-01-22T04:15:59.900Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2025-01-22T04:15:59.900Z] GC before operation: completed in 95.583 ms, heap usage 171.707 MB -> 31.181 MB. [2025-01-22T04:16:04.784Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (5616.729 ms) ====== [2025-01-22T04:16:04.784Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2025-01-22T04:16:04.784Z] GC before operation: completed in 67.039 ms, heap usage 128.065 MB -> 31.437 MB. [2025-01-22T04:16:09.574Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (5170.436 ms) ====== [2025-01-22T04:16:09.574Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2025-01-22T04:16:09.574Z] GC before operation: completed in 61.878 ms, heap usage 85.203 MB -> 32.366 MB. [2025-01-22T04:16:15.517Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (5480.652 ms) ====== [2025-01-22T04:16:15.517Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2025-01-22T04:16:15.517Z] GC before operation: completed in 70.265 ms, heap usage 175.025 MB -> 31.913 MB. [2025-01-22T04:16:21.430Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (5697.605 ms) ====== [2025-01-22T04:16:21.430Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2025-01-22T04:16:21.430Z] GC before operation: completed in 63.494 ms, heap usage 91.074 MB -> 32.130 MB. [2025-01-22T04:16:26.208Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (4662.268 ms) ====== [2025-01-22T04:16:26.208Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2025-01-22T04:16:26.208Z] GC before operation: completed in 72.448 ms, heap usage 73.449 MB -> 32.230 MB. [2025-01-22T04:16:31.016Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (4929.963 ms) ====== [2025-01-22T04:16:31.016Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2025-01-22T04:16:31.016Z] GC before operation: completed in 72.532 ms, heap usage 118.701 MB -> 32.329 MB. [2025-01-22T04:16:35.820Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (5119.831 ms) ====== [2025-01-22T04:16:35.820Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2025-01-22T04:16:35.820Z] GC before operation: completed in 61.956 ms, heap usage 37.233 MB -> 32.446 MB. [2025-01-22T04:16:40.725Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (5024.546 ms) ====== [2025-01-22T04:16:40.725Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2025-01-22T04:16:41.371Z] GC before operation: completed in 86.508 ms, heap usage 162.225 MB -> 32.547 MB. [2025-01-22T04:16:46.193Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (4648.288 ms) ====== [2025-01-22T04:16:46.193Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2025-01-22T04:16:46.193Z] GC before operation: completed in 66.161 ms, heap usage 35.194 MB -> 32.651 MB. [2025-01-22T04:16:49.975Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (4508.231 ms) ====== [2025-01-22T04:16:49.975Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2025-01-22T04:16:50.605Z] GC before operation: completed in 64.760 ms, heap usage 141.852 MB -> 32.757 MB. [2025-01-22T04:16:54.400Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (4247.476 ms) ====== [2025-01-22T04:16:54.400Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2025-01-22T04:16:54.400Z] GC before operation: completed in 82.290 ms, heap usage 102.895 MB -> 33.503 MB. [2025-01-22T04:16:59.180Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (4274.946 ms) ====== [2025-01-22T04:16:59.180Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2025-01-22T04:16:59.180Z] GC before operation: completed in 69.855 ms, heap usage 59.219 MB -> 32.942 MB. [2025-01-22T04:17:02.955Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (4112.790 ms) ====== [2025-01-22T04:17:02.956Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2025-01-22T04:17:02.956Z] GC before operation: completed in 110.081 ms, heap usage 136.077 MB -> 33.681 MB. [2025-01-22T04:17:08.850Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (4865.368 ms) ====== [2025-01-22T04:17:08.850Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2025-01-22T04:17:08.850Z] GC before operation: completed in 77.559 ms, heap usage 48.842 MB -> 33.138 MB. [2025-01-22T04:17:12.592Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (4058.184 ms) ====== [2025-01-22T04:17:12.592Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2025-01-22T04:17:12.592Z] GC before operation: completed in 81.294 ms, heap usage 130.249 MB -> 33.873 MB. [2025-01-22T04:17:16.393Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (4223.863 ms) ====== [2025-01-22T04:17:16.393Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2025-01-22T04:17:16.393Z] GC before operation: completed in 53.641 ms, heap usage 170.117 MB -> 33.326 MB. [2025-01-22T04:17:21.639Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (4517.111 ms) ====== [2025-01-22T04:17:21.639Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2025-01-22T04:17:21.639Z] GC before operation: completed in 69.239 ms, heap usage 192.997 MB -> 33.430 MB. [2025-01-22T04:17:25.436Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (4038.319 ms) ====== [2025-01-22T04:17:25.436Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2025-01-22T04:17:25.436Z] GC before operation: completed in 92.842 ms, heap usage 48.946 MB -> 34.169 MB. [2025-01-22T04:17:25.436Z] 25/01/22 04:17:24 WARN BlockManager: Asked to remove block broadcast_626, which does not exist [2025-01-22T04:17:30.240Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (4488.465 ms) ====== [2025-01-22T04:17:30.240Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2025-01-22T04:17:30.240Z] GC before operation: completed in 99.908 ms, heap usage 163.801 MB -> 33.623 MB. [2025-01-22T04:17:34.997Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (4619.338 ms) ====== [2025-01-22T04:17:34.997Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2025-01-22T04:17:34.997Z] GC before operation: completed in 83.170 ms, heap usage 108.351 MB -> 33.718 MB. [2025-01-22T04:17:39.904Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (4600.082 ms) ====== [2025-01-22T04:17:39.904Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2025-01-22T04:17:39.904Z] GC before operation: completed in 81.190 ms, heap usage 151.410 MB -> 33.826 MB. [2025-01-22T04:17:43.701Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (4289.235 ms) ====== [2025-01-22T04:17:43.701Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2025-01-22T04:17:43.701Z] GC before operation: completed in 80.086 ms, heap usage 109.952 MB -> 33.924 MB. [2025-01-22T04:17:48.496Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (4648.392 ms) ====== [2025-01-22T04:17:48.497Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2025-01-22T04:17:48.497Z] GC before operation: completed in 107.710 ms, heap usage 119.530 MB -> 34.013 MB. [2025-01-22T04:17:53.308Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (4568.417 ms) ====== [2025-01-22T04:17:53.308Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2025-01-22T04:17:53.308Z] GC before operation: completed in 110.714 ms, heap usage 49.099 MB -> 34.109 MB. [2025-01-22T04:17:58.168Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (4554.246 ms) ====== [2025-01-22T04:17:58.168Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2025-01-22T04:17:58.168Z] GC before operation: completed in 86.660 ms, heap usage 109.305 MB -> 34.515 MB. [2025-01-22T04:18:01.967Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (4316.778 ms) ====== [2025-01-22T04:18:01.967Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2025-01-22T04:18:01.967Z] GC before operation: completed in 98.105 ms, heap usage 188.637 MB -> 34.294 MB. [2025-01-22T04:18:06.798Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (4552.627 ms) ====== [2025-01-22T04:18:06.798Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2025-01-22T04:18:06.798Z] GC before operation: completed in 99.781 ms, heap usage 48.972 MB -> 34.380 MB. [2025-01-22T04:18:18.948Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (4512.643 ms) ====== [2025-01-22T04:18:18.948Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2025-01-22T04:18:18.948Z] GC before operation: completed in 85.002 ms, heap usage 93.625 MB -> 34.479 MB. [2025-01-22T04:18:18.948Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (4398.235 ms) ====== [2025-01-22T04:18:18.948Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2025-01-22T04:18:18.948Z] GC before operation: completed in 91.832 ms, heap usage 103.022 MB -> 35.220 MB. [2025-01-22T04:18:20.296Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (4641.611 ms) ====== [2025-01-22T04:18:20.296Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2025-01-22T04:18:20.944Z] GC before operation: completed in 94.926 ms, heap usage 177.942 MB -> 34.661 MB. [2025-01-22T04:18:25.846Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (4580.286 ms) ====== [2025-01-22T04:18:25.846Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2025-01-22T04:18:25.846Z] GC before operation: completed in 129.815 ms, heap usage 113.274 MB -> 34.759 MB. [2025-01-22T04:18:29.841Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (4452.821 ms) ====== [2025-01-22T04:18:29.841Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2025-01-22T04:18:29.841Z] GC before operation: completed in 107.835 ms, heap usage 154.392 MB -> 34.848 MB. [2025-01-22T04:18:34.767Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (4515.662 ms) ====== [2025-01-22T04:18:34.767Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2025-01-22T04:18:34.767Z] GC before operation: completed in 106.212 ms, heap usage 80.958 MB -> 34.944 MB. [2025-01-22T04:18:39.663Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (4618.116 ms) ====== [2025-01-22T04:18:39.663Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2025-01-22T04:18:39.663Z] GC before operation: completed in 110.335 ms, heap usage 64.044 MB -> 35.031 MB. [2025-01-22T04:18:44.140Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (4994.481 ms) ====== [2025-01-22T04:18:44.140Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2025-01-22T04:18:44.140Z] GC before operation: completed in 109.311 ms, heap usage 70.562 MB -> 35.446 MB. [2025-01-22T04:18:49.520Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (4594.642 ms) ====== [2025-01-22T04:18:49.520Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2025-01-22T04:18:49.520Z] GC before operation: completed in 93.107 ms, heap usage 106.610 MB -> 35.220 MB. [2025-01-22T04:18:54.882Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (4741.892 ms) ====== [2025-01-22T04:18:54.882Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2025-01-22T04:18:54.882Z] GC before operation: completed in 118.886 ms, heap usage 212.421 MB -> 35.318 MB. [2025-01-22T04:18:58.760Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (4701.993 ms) ====== [2025-01-22T04:18:58.760Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2025-01-22T04:18:58.760Z] GC before operation: completed in 111.245 ms, heap usage 200.056 MB -> 35.410 MB. [2025-01-22T04:19:03.589Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (4749.070 ms) ====== [2025-01-22T04:19:03.589Z] ----------------------------------- [2025-01-22T04:19:03.589Z] renaissance-gauss-mix_0_PASSED [2025-01-22T04:19:03.589Z] ----------------------------------- [2025-01-22T04:19:03.589Z] [2025-01-22T04:19:03.589Z] TEST TEARDOWN: [2025-01-22T04:19:03.589Z] Nothing to be done for teardown. [2025-01-22T04:19:03.589Z] renaissance-gauss-mix_0 Finish Time: Wed Jan 22 04:19:03 2025 Epoch Time (ms): 1737519543424