[2024-05-30T16:26:04.024Z] Running test renaissance-gauss-mix_0 ... [2024-05-30T16:26:04.024Z] =============================================== [2024-05-30T16:26:04.024Z] renaissance-gauss-mix_0 Start Time: Thu May 30 16:26:03 2024 Epoch Time (ms): 1717086363126 [2024-05-30T16:26:04.024Z] variation: NoOptions [2024-05-30T16:26:04.024Z] JVM_OPTIONS: [2024-05-30T16:26:04.024Z] { \ [2024-05-30T16:26:04.024Z] echo ""; echo "TEST SETUP:"; \ [2024-05-30T16:26:04.024Z] echo "Nothing to be done for setup."; \ [2024-05-30T16:26:04.024Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17170856518844/renaissance-gauss-mix_0"; \ [2024-05-30T16:26:04.024Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17170856518844/renaissance-gauss-mix_0"; \ [2024-05-30T16:26:04.024Z] echo ""; echo "TESTING:"; \ [2024-05-30T16:26:04.024Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_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_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17170856518844/renaissance-gauss-mix_0"/gauss-mix.json" gauss-mix; \ [2024-05-30T16:26:04.024Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17170856518844/renaissance-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-05-30T16:26:04.024Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-05-30T16:26:04.024Z] echo "Nothing to be done for teardown."; \ [2024-05-30T16:26:04.024Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17170856518844/TestTargetResult"; [2024-05-30T16:26:04.024Z] [2024-05-30T16:26:04.024Z] TEST SETUP: [2024-05-30T16:26:04.024Z] Nothing to be done for setup. [2024-05-30T16:26:04.024Z] [2024-05-30T16:26:04.024Z] TESTING: [2024-05-30T16:26:08.577Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-05-30T16:26:11.009Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 4 (out of 24) threads. [2024-05-30T16:26:11.769Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2024-05-30T16:26:11.769Z] GC before operation: completed in 42.346 ms, heap usage 58.131 MB -> 26.592 MB. [2024-05-30T16:26:18.562Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (6283.032 ms) ====== [2024-05-30T16:26:18.562Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2024-05-30T16:26:18.562Z] GC before operation: completed in 53.548 ms, heap usage 137.657 MB -> 32.423 MB. [2024-05-30T16:26:21.952Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (3446.211 ms) ====== [2024-05-30T16:26:21.952Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2024-05-30T16:26:21.952Z] GC before operation: completed in 59.692 ms, heap usage 133.363 MB -> 33.288 MB. [2024-05-30T16:26:25.322Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (3281.250 ms) ====== [2024-05-30T16:26:25.322Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2024-05-30T16:26:25.322Z] GC before operation: completed in 68.239 ms, heap usage 223.835 MB -> 33.626 MB. [2024-05-30T16:26:28.700Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (3115.562 ms) ====== [2024-05-30T16:26:28.700Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2024-05-30T16:26:28.700Z] GC before operation: completed in 60.014 ms, heap usage 103.314 MB -> 33.820 MB. [2024-05-30T16:26:31.133Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (3077.461 ms) ====== [2024-05-30T16:26:31.133Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2024-05-30T16:26:31.133Z] GC before operation: completed in 66.243 ms, heap usage 61.577 MB -> 33.383 MB. [2024-05-30T16:26:36.407Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (3162.769 ms) ====== [2024-05-30T16:26:36.407Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2024-05-30T16:26:36.407Z] GC before operation: completed in 64.590 ms, heap usage 275.812 MB -> 33.835 MB. [2024-05-30T16:26:39.336Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (3081.393 ms) ====== [2024-05-30T16:26:39.336Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2024-05-30T16:26:39.336Z] GC before operation: completed in 62.792 ms, heap usage 206.275 MB -> 33.627 MB. [2024-05-30T16:26:40.954Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (3026.441 ms) ====== [2024-05-30T16:26:40.954Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2024-05-30T16:26:40.954Z] GC before operation: completed in 64.871 ms, heap usage 121.371 MB -> 34.014 MB. [2024-05-30T16:26:45.003Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (2985.582 ms) ====== [2024-05-30T16:26:45.003Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2024-05-30T16:26:45.003Z] GC before operation: completed in 62.546 ms, heap usage 122.655 MB -> 34.111 MB. [2024-05-30T16:26:46.598Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (2986.064 ms) ====== [2024-05-30T16:26:46.598Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2024-05-30T16:26:47.357Z] GC before operation: completed in 77.178 ms, heap usage 122.811 MB -> 34.217 MB. [2024-05-30T16:26:49.799Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (3079.574 ms) ====== [2024-05-30T16:26:49.799Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2024-05-30T16:26:49.799Z] GC before operation: completed in 66.983 ms, heap usage 37.142 MB -> 34.336 MB. [2024-05-30T16:26:53.182Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (3052.963 ms) ====== [2024-05-30T16:26:53.182Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2024-05-30T16:26:53.182Z] GC before operation: completed in 70.391 ms, heap usage 128.161 MB -> 34.430 MB. [2024-05-30T16:26:56.559Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (2954.305 ms) ====== [2024-05-30T16:26:56.559Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2024-05-30T16:26:56.559Z] GC before operation: completed in 71.365 ms, heap usage 125.155 MB -> 34.215 MB. [2024-05-30T16:26:58.992Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (2960.009 ms) ====== [2024-05-30T16:26:58.992Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2024-05-30T16:26:58.992Z] GC before operation: completed in 79.626 ms, heap usage 38.757 MB -> 34.623 MB. [2024-05-30T16:27:02.370Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (3058.434 ms) ====== [2024-05-30T16:27:02.370Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2024-05-30T16:27:02.370Z] GC before operation: completed in 78.126 ms, heap usage 274.019 MB -> 34.443 MB. [2024-05-30T16:27:05.746Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (3035.357 ms) ====== [2024-05-30T16:27:05.746Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2024-05-30T16:27:05.746Z] GC before operation: completed in 76.177 ms, heap usage 139.056 MB -> 34.492 MB. [2024-05-30T16:27:08.249Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (2984.913 ms) ====== [2024-05-30T16:27:08.249Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2024-05-30T16:27:09.009Z] GC before operation: completed in 81.976 ms, heap usage 121.305 MB -> 34.590 MB. [2024-05-30T16:27:11.565Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (2971.345 ms) ====== [2024-05-30T16:27:11.565Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2024-05-30T16:27:11.565Z] GC before operation: completed in 79.654 ms, heap usage 123.267 MB -> 35.005 MB. [2024-05-30T16:27:14.939Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (3052.737 ms) ====== [2024-05-30T16:27:14.939Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2024-05-30T16:27:14.939Z] GC before operation: completed in 84.299 ms, heap usage 274.464 MB -> 35.120 MB. [2024-05-30T16:27:17.437Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (2971.574 ms) ====== [2024-05-30T16:27:17.437Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2024-05-30T16:27:18.196Z] GC before operation: completed in 78.158 ms, heap usage 54.764 MB -> 35.180 MB. [2024-05-30T16:27:20.623Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (2948.021 ms) ====== [2024-05-30T16:27:20.623Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2024-05-30T16:27:20.623Z] GC before operation: completed in 76.770 ms, heap usage 62.784 MB -> 35.289 MB. [2024-05-30T16:27:20.623Z] 24/05/30 16:27:20 WARN BlockManager: Asked to remove block rdd_343_0, which does not exist [2024-05-30T16:27:24.025Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (3025.566 ms) ====== [2024-05-30T16:27:24.025Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2024-05-30T16:27:24.025Z] GC before operation: completed in 81.555 ms, heap usage 116.915 MB -> 35.389 MB. [2024-05-30T16:27:27.396Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (2972.404 ms) ====== [2024-05-30T16:27:27.396Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2024-05-30T16:27:27.396Z] GC before operation: completed in 81.191 ms, heap usage 207.760 MB -> 35.208 MB. [2024-05-30T16:27:29.823Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (2960.168 ms) ====== [2024-05-30T16:27:29.823Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2024-05-30T16:27:29.823Z] GC before operation: completed in 83.439 ms, heap usage 61.772 MB -> 35.588 MB. [2024-05-30T16:27:33.190Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (2987.034 ms) ====== [2024-05-30T16:27:33.190Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2024-05-30T16:27:33.190Z] GC before operation: completed in 76.641 ms, heap usage 208.976 MB -> 36.030 MB. [2024-05-30T16:27:36.588Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (2958.278 ms) ====== [2024-05-30T16:27:36.588Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2024-05-30T16:27:36.588Z] GC before operation: completed in 84.052 ms, heap usage 62.608 MB -> 35.457 MB. [2024-05-30T16:27:39.022Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (2945.714 ms) ====== [2024-05-30T16:27:39.022Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2024-05-30T16:27:39.022Z] GC before operation: completed in 85.159 ms, heap usage 124.119 MB -> 35.863 MB. [2024-05-30T16:27:42.388Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (2975.675 ms) ====== [2024-05-30T16:27:42.388Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2024-05-30T16:27:42.388Z] GC before operation: completed in 80.855 ms, heap usage 123.471 MB -> 35.960 MB. [2024-05-30T16:27:45.753Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (2956.850 ms) ====== [2024-05-30T16:27:45.753Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2024-05-30T16:27:45.753Z] GC before operation: completed in 86.262 ms, heap usage 209.284 MB -> 36.078 MB. [2024-05-30T16:27:48.193Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (2948.189 ms) ====== [2024-05-30T16:27:48.193Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2024-05-30T16:27:48.193Z] GC before operation: completed in 84.154 ms, heap usage 67.642 MB -> 36.455 MB. [2024-05-30T16:27:51.573Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (2940.161 ms) ====== [2024-05-30T16:27:51.573Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2024-05-30T16:27:51.573Z] GC before operation: completed in 81.476 ms, heap usage 129.110 MB -> 36.238 MB. [2024-05-30T16:27:54.014Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (2953.505 ms) ====== [2024-05-30T16:27:54.014Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2024-05-30T16:27:54.773Z] GC before operation: completed in 74.960 ms, heap usage 62.833 MB -> 36.321 MB. [2024-05-30T16:27:57.204Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (2980.782 ms) ====== [2024-05-30T16:27:57.204Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2024-05-30T16:27:57.204Z] GC before operation: completed in 82.199 ms, heap usage 122.914 MB -> 36.421 MB. [2024-05-30T16:28:00.576Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (2937.942 ms) ====== [2024-05-30T16:28:00.576Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2024-05-30T16:28:00.576Z] GC before operation: completed in 80.009 ms, heap usage 125.012 MB -> 36.210 MB. [2024-05-30T16:28:03.941Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (2966.682 ms) ====== [2024-05-30T16:28:03.941Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2024-05-30T16:28:03.941Z] GC before operation: completed in 85.090 ms, heap usage 124.793 MB -> 36.608 MB. [2024-05-30T16:28:03.941Z] 24/05/30 16:28:03 WARN BlockManager: Asked to remove block broadcast_1154_piece0, which does not exist [2024-05-30T16:28:06.373Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (2965.036 ms) ====== [2024-05-30T16:28:06.373Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2024-05-30T16:28:06.373Z] GC before operation: completed in 87.915 ms, heap usage 87.422 MB -> 36.697 MB. [2024-05-30T16:28:09.817Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (2950.089 ms) ====== [2024-05-30T16:28:09.817Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2024-05-30T16:28:09.817Z] GC before operation: completed in 89.313 ms, heap usage 63.301 MB -> 36.796 MB. [2024-05-30T16:28:12.257Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (2957.304 ms) ====== [2024-05-30T16:28:12.257Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2024-05-30T16:28:13.018Z] GC before operation: completed in 89.048 ms, heap usage 117.453 MB -> 36.582 MB. [2024-05-30T16:28:15.449Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (2954.710 ms) ====== [2024-05-30T16:28:15.449Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2024-05-30T16:28:15.449Z] GC before operation: completed in 84.929 ms, heap usage 131.291 MB -> 36.666 MB. [2024-05-30T16:28:18.824Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (2938.940 ms) ====== [2024-05-30T16:28:18.824Z] ----------------------------------- [2024-05-30T16:28:18.824Z] renaissance-gauss-mix_0_PASSED [2024-05-30T16:28:18.824Z] ----------------------------------- [2024-05-30T16:28:18.824Z] [2024-05-30T16:28:18.824Z] TEST TEARDOWN: [2024-05-30T16:28:18.824Z] Nothing to be done for teardown. [2024-05-30T16:28:18.824Z] renaissance-gauss-mix_0 Finish Time: Thu May 30 16:28:18 2024 Epoch Time (ms): 1717086498539