[2024-09-26T01:00:47.029Z] Running test renaissance-gauss-mix_0 ... [2024-09-26T01:00:47.029Z] =============================================== [2024-09-26T01:00:47.029Z] renaissance-gauss-mix_0 Start Time: Thu Sep 26 01:00:46 2024 Epoch Time (ms): 1727312446230 [2024-09-26T01:00:47.029Z] variation: NoOptions [2024-09-26T01:00:47.029Z] JVM_OPTIONS: [2024-09-26T01:00:47.029Z] { \ [2024-09-26T01:00:47.029Z] echo ""; echo "TEST SETUP:"; \ [2024-09-26T01:00:47.029Z] echo "Nothing to be done for setup."; \ [2024-09-26T01:00:47.029Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273117559386/renaissance-gauss-mix_0"; \ [2024-09-26T01:00:47.029Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273117559386/renaissance-gauss-mix_0"; \ [2024-09-26T01:00:47.029Z] echo ""; echo "TESTING:"; \ [2024-09-26T01:00:47.029Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/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/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273117559386/renaissance-gauss-mix_0"/gauss-mix.json" gauss-mix; \ [2024-09-26T01:00:47.029Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273117559386/renaissance-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-26T01:00:47.029Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-26T01:00:47.029Z] echo "Nothing to be done for teardown."; \ [2024-09-26T01:00:47.029Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17273117559386/TestTargetResult"; [2024-09-26T01:00:47.029Z] [2024-09-26T01:00:47.029Z] TEST SETUP: [2024-09-26T01:00:47.029Z] Nothing to be done for setup. [2024-09-26T01:00:47.029Z] [2024-09-26T01:00:47.029Z] TESTING: [2024-09-26T01:00:51.442Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-26T01:00:53.889Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 4 (out of 24) threads. [2024-09-26T01:00:54.651Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2024-09-26T01:00:54.651Z] GC before operation: completed in 31.526 ms, heap usage 77.440 MB -> 26.590 MB. [2024-09-26T01:01:01.488Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (6770.619 ms) ====== [2024-09-26T01:01:01.488Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2024-09-26T01:01:01.488Z] GC before operation: completed in 53.024 ms, heap usage 181.113 MB -> 32.441 MB. [2024-09-26T01:01:05.897Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (3920.319 ms) ====== [2024-09-26T01:01:05.897Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2024-09-26T01:01:05.897Z] GC before operation: completed in 59.146 ms, heap usage 108.331 MB -> 33.271 MB. [2024-09-26T01:01:09.288Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (3764.915 ms) ====== [2024-09-26T01:01:09.288Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2024-09-26T01:01:09.288Z] GC before operation: completed in 63.504 ms, heap usage 145.618 MB -> 32.955 MB. [2024-09-26T01:01:13.719Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (3604.294 ms) ====== [2024-09-26T01:01:13.719Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2024-09-26T01:01:13.719Z] GC before operation: completed in 57.176 ms, heap usage 190.444 MB -> 33.855 MB. [2024-09-26T01:01:17.102Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (3553.891 ms) ====== [2024-09-26T01:01:17.102Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2024-09-26T01:01:17.102Z] GC before operation: completed in 53.263 ms, heap usage 184.666 MB -> 33.420 MB. [2024-09-26T01:01:20.489Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (3619.950 ms) ====== [2024-09-26T01:01:20.489Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2024-09-26T01:01:20.489Z] GC before operation: completed in 60.927 ms, heap usage 253.105 MB -> 33.833 MB. [2024-09-26T01:01:23.870Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (3486.991 ms) ====== [2024-09-26T01:01:23.870Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2024-09-26T01:01:23.870Z] GC before operation: completed in 61.666 ms, heap usage 49.651 MB -> 33.588 MB. [2024-09-26T01:01:28.285Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (3600.124 ms) ====== [2024-09-26T01:01:28.285Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2024-09-26T01:01:28.285Z] GC before operation: completed in 59.961 ms, heap usage 253.217 MB -> 34.048 MB. [2024-09-26T01:01:31.669Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (3473.132 ms) ====== [2024-09-26T01:01:31.669Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2024-09-26T01:01:31.669Z] GC before operation: completed in 65.717 ms, heap usage 38.021 MB -> 34.105 MB. [2024-09-26T01:01:35.057Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (3511.788 ms) ====== [2024-09-26T01:01:35.057Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2024-09-26T01:01:35.057Z] GC before operation: completed in 65.232 ms, heap usage 149.186 MB -> 33.899 MB. [2024-09-26T01:01:38.448Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (3458.343 ms) ====== [2024-09-26T01:01:38.448Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2024-09-26T01:01:38.448Z] GC before operation: completed in 65.133 ms, heap usage 149.020 MB -> 34.340 MB. [2024-09-26T01:01:41.861Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (3476.209 ms) ====== [2024-09-26T01:01:41.861Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2024-09-26T01:01:41.861Z] GC before operation: completed in 72.963 ms, heap usage 185.770 MB -> 34.464 MB. [2024-09-26T01:01:45.252Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (3430.032 ms) ====== [2024-09-26T01:01:45.252Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2024-09-26T01:01:45.252Z] GC before operation: completed in 73.755 ms, heap usage 58.261 MB -> 34.209 MB. [2024-09-26T01:01:48.639Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (3442.016 ms) ====== [2024-09-26T01:01:48.639Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2024-09-26T01:01:48.639Z] GC before operation: completed in 72.624 ms, heap usage 60.080 MB -> 34.310 MB. [2024-09-26T01:01:53.054Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (3435.570 ms) ====== [2024-09-26T01:01:53.054Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2024-09-26T01:01:53.054Z] GC before operation: completed in 70.606 ms, heap usage 207.726 MB -> 34.747 MB. [2024-09-26T01:01:56.446Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (3437.832 ms) ====== [2024-09-26T01:01:56.447Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2024-09-26T01:01:56.447Z] GC before operation: completed in 71.639 ms, heap usage 130.798 MB -> 34.496 MB. [2024-09-26T01:01:59.873Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (3434.021 ms) ====== [2024-09-26T01:01:59.873Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2024-09-26T01:01:59.873Z] GC before operation: completed in 73.417 ms, heap usage 59.476 MB -> 34.577 MB. [2024-09-26T01:02:03.267Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (3421.443 ms) ====== [2024-09-26T01:02:03.267Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2024-09-26T01:02:03.267Z] GC before operation: completed in 77.566 ms, heap usage 116.343 MB -> 34.687 MB. [2024-09-26T01:02:06.650Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (3416.974 ms) ====== [2024-09-26T01:02:06.650Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2024-09-26T01:02:06.651Z] GC before operation: completed in 70.860 ms, heap usage 114.447 MB -> 35.100 MB. [2024-09-26T01:02:10.048Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (3410.430 ms) ====== [2024-09-26T01:02:10.048Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2024-09-26T01:02:10.048Z] GC before operation: completed in 74.175 ms, heap usage 116.919 MB -> 35.179 MB. [2024-09-26T01:02:13.455Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (3448.884 ms) ====== [2024-09-26T01:02:13.455Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2024-09-26T01:02:13.455Z] GC before operation: completed in 73.698 ms, heap usage 60.924 MB -> 35.279 MB. [2024-09-26T01:02:16.846Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (3439.183 ms) ====== [2024-09-26T01:02:16.846Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2024-09-26T01:02:16.846Z] GC before operation: completed in 75.314 ms, heap usage 207.722 MB -> 35.126 MB. [2024-09-26T01:02:20.248Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (3435.157 ms) ====== [2024-09-26T01:02:20.248Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2024-09-26T01:02:20.248Z] GC before operation: completed in 76.572 ms, heap usage 56.890 MB -> 35.484 MB. [2024-09-26T01:02:23.647Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (3445.404 ms) ====== [2024-09-26T01:02:23.647Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2024-09-26T01:02:24.408Z] GC before operation: completed in 77.004 ms, heap usage 131.368 MB -> 35.584 MB. [2024-09-26T01:02:24.409Z] 24/09/26 01:02:23 WARN BlockManager: Asked to remove block broadcast_791, which does not exist [2024-09-26T01:02:27.810Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (3462.856 ms) ====== [2024-09-26T01:02:27.810Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2024-09-26T01:02:27.810Z] GC before operation: completed in 68.756 ms, heap usage 59.333 MB -> 35.680 MB. [2024-09-26T01:02:31.200Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (3440.909 ms) ====== [2024-09-26T01:02:31.200Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2024-09-26T01:02:31.200Z] GC before operation: completed in 67.612 ms, heap usage 59.473 MB -> 35.763 MB. [2024-09-26T01:02:34.591Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (3425.973 ms) ====== [2024-09-26T01:02:34.591Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2024-09-26T01:02:34.591Z] GC before operation: completed in 74.925 ms, heap usage 61.532 MB -> 35.862 MB. [2024-09-26T01:02:37.986Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (3497.620 ms) ====== [2024-09-26T01:02:37.986Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2024-09-26T01:02:37.986Z] GC before operation: completed in 80.210 ms, heap usage 262.447 MB -> 35.999 MB. [2024-09-26T01:02:41.386Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (3418.544 ms) ====== [2024-09-26T01:02:41.386Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2024-09-26T01:02:41.386Z] GC before operation: completed in 85.410 ms, heap usage 85.754 MB -> 36.047 MB. [2024-09-26T01:02:44.788Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (3413.715 ms) ====== [2024-09-26T01:02:44.789Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2024-09-26T01:02:45.553Z] GC before operation: completed in 78.678 ms, heap usage 221.392 MB -> 36.183 MB. [2024-09-26T01:02:48.941Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (3414.481 ms) ====== [2024-09-26T01:02:48.941Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2024-09-26T01:02:48.941Z] GC before operation: completed in 70.967 ms, heap usage 175.641 MB -> 35.965 MB. [2024-09-26T01:02:52.327Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (3407.526 ms) ====== [2024-09-26T01:02:52.327Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2024-09-26T01:02:52.327Z] GC before operation: completed in 78.320 ms, heap usage 179.553 MB -> 36.364 MB. [2024-09-26T01:02:55.714Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (3415.010 ms) ====== [2024-09-26T01:02:55.714Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2024-09-26T01:02:55.714Z] GC before operation: completed in 76.332 ms, heap usage 78.193 MB -> 36.120 MB. [2024-09-26T01:02:59.113Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (3421.845 ms) ====== [2024-09-26T01:02:59.113Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2024-09-26T01:02:59.113Z] GC before operation: completed in 80.361 ms, heap usage 60.901 MB -> 36.211 MB. [2024-09-26T01:03:02.495Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (3398.715 ms) ====== [2024-09-26T01:03:02.495Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2024-09-26T01:03:02.495Z] GC before operation: completed in 76.691 ms, heap usage 205.668 MB -> 36.645 MB. [2024-09-26T01:03:05.893Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (3433.599 ms) ====== [2024-09-26T01:03:05.893Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2024-09-26T01:03:05.893Z] GC before operation: completed in 74.713 ms, heap usage 127.553 MB -> 36.710 MB. [2024-09-26T01:03:09.276Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (3412.184 ms) ====== [2024-09-26T01:03:09.276Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2024-09-26T01:03:09.276Z] GC before operation: completed in 78.567 ms, heap usage 130.594 MB -> 36.793 MB. [2024-09-26T01:03:13.701Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (3438.213 ms) ====== [2024-09-26T01:03:13.701Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2024-09-26T01:03:13.701Z] GC before operation: completed in 80.913 ms, heap usage 66.591 MB -> 36.894 MB. [2024-09-26T01:03:13.701Z] 24/09/26 01:03:12 WARN BlockManager: Asked to remove block rdd_632_0, which does not exist [2024-09-26T01:03:17.098Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (3419.955 ms) ====== [2024-09-26T01:03:17.098Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2024-09-26T01:03:17.098Z] GC before operation: completed in 78.864 ms, heap usage 202.293 MB -> 36.718 MB. [2024-09-26T01:03:20.487Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (3425.806 ms) ====== [2024-09-26T01:03:20.487Z] ----------------------------------- [2024-09-26T01:03:20.487Z] renaissance-gauss-mix_0_PASSED [2024-09-26T01:03:20.487Z] ----------------------------------- [2024-09-26T01:03:20.487Z] [2024-09-26T01:03:20.487Z] TEST TEARDOWN: [2024-09-26T01:03:20.487Z] Nothing to be done for teardown. [2024-09-26T01:03:20.487Z] renaissance-gauss-mix_0 Finish Time: Thu Sep 26 01:03:19 2024 Epoch Time (ms): 1727312599928