[2024-09-25T21:09:15.323Z] Running test renaissance-gauss-mix_0 ... [2024-09-25T21:09:15.323Z] =============================================== [2024-09-25T21:09:15.323Z] renaissance-gauss-mix_0 Start Time: Wed Sep 25 17:09:15 2024 Epoch Time (ms): 1727298555156 [2024-09-25T21:09:15.323Z] variation: NoOptions [2024-09-25T21:09:15.323Z] JVM_OPTIONS: [2024-09-25T21:09:15.323Z] { \ [2024-09-25T21:09:15.323Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T21:09:15.323Z] echo "Nothing to be done for setup."; \ [2024-09-25T21:09:15.323Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-gauss-mix_0"; \ [2024-09-25T21:09:15.323Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-gauss-mix_0"; \ [2024-09-25T21:09:15.323Z] echo ""; echo "TESTING:"; \ [2024-09-25T21:09:15.323Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-gauss-mix_0"/gauss-mix.json" gauss-mix; \ [2024-09-25T21:09:15.323Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T21:09:15.323Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T21:09:15.323Z] echo "Nothing to be done for teardown."; \ [2024-09-25T21:09:15.323Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/TestTargetResult"; [2024-09-25T21:09:15.323Z] [2024-09-25T21:09:15.323Z] TEST SETUP: [2024-09-25T21:09:15.323Z] Nothing to be done for setup. [2024-09-25T21:09:15.323Z] [2024-09-25T21:09:15.323Z] TESTING: [2024-09-25T21:09:17.766Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T21:09:19.005Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-09-25T21:09:19.368Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2024-09-25T21:09:19.368Z] GC before operation: completed in 26.083 ms, heap usage 55.619 MB -> 25.494 MB. [2024-09-25T21:09:23.457Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (3592.607 ms) ====== [2024-09-25T21:09:23.457Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2024-09-25T21:09:23.457Z] GC before operation: completed in 36.588 ms, heap usage 90.350 MB -> 31.323 MB. [2024-09-25T21:09:25.288Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (2037.015 ms) ====== [2024-09-25T21:09:25.288Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2024-09-25T21:09:25.288Z] GC before operation: completed in 32.244 ms, heap usage 63.637 MB -> 31.548 MB. [2024-09-25T21:09:27.105Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (1851.057 ms) ====== [2024-09-25T21:09:27.105Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2024-09-25T21:09:27.105Z] GC before operation: completed in 35.768 ms, heap usage 92.785 MB -> 32.090 MB. [2024-09-25T21:09:28.991Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (1819.772 ms) ====== [2024-09-25T21:09:28.991Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2024-09-25T21:09:28.991Z] GC before operation: completed in 31.222 ms, heap usage 142.780 MB -> 32.001 MB. [2024-09-25T21:09:30.803Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (1990.192 ms) ====== [2024-09-25T21:09:30.803Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2024-09-25T21:09:30.803Z] GC before operation: completed in 47.674 ms, heap usage 164.358 MB -> 32.263 MB. [2024-09-25T21:09:32.581Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (1874.214 ms) ====== [2024-09-25T21:09:32.581Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2024-09-25T21:09:32.581Z] GC before operation: completed in 38.446 ms, heap usage 48.984 MB -> 32.391 MB. [2024-09-25T21:09:34.398Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (1782.709 ms) ====== [2024-09-25T21:09:34.398Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2024-09-25T21:09:34.398Z] GC before operation: completed in 37.560 ms, heap usage 156.600 MB -> 32.497 MB. [2024-09-25T21:09:36.825Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (1888.812 ms) ====== [2024-09-25T21:09:36.825Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2024-09-25T21:09:36.825Z] GC before operation: completed in 37.721 ms, heap usage 170.193 MB -> 32.608 MB. [2024-09-25T21:09:38.611Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (1829.817 ms) ====== [2024-09-25T21:09:38.611Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2024-09-25T21:09:38.611Z] GC before operation: completed in 43.483 ms, heap usage 223.291 MB -> 32.716 MB. [2024-09-25T21:09:40.397Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (1749.808 ms) ====== [2024-09-25T21:09:40.397Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2024-09-25T21:09:40.397Z] GC before operation: completed in 34.842 ms, heap usage 72.890 MB -> 33.113 MB. [2024-09-25T21:09:42.171Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (1720.501 ms) ====== [2024-09-25T21:09:42.171Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2024-09-25T21:09:42.171Z] GC before operation: completed in 36.862 ms, heap usage 164.791 MB -> 32.912 MB. [2024-09-25T21:09:43.416Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (1617.347 ms) ====== [2024-09-25T21:09:43.416Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2024-09-25T21:09:43.416Z] GC before operation: completed in 45.635 ms, heap usage 99.563 MB -> 33.339 MB. [2024-09-25T21:09:45.200Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (1592.951 ms) ====== [2024-09-25T21:09:45.200Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2024-09-25T21:09:45.200Z] GC before operation: completed in 42.235 ms, heap usage 96.978 MB -> 33.123 MB. [2024-09-25T21:09:46.976Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (1709.080 ms) ====== [2024-09-25T21:09:46.976Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2024-09-25T21:09:46.976Z] GC before operation: completed in 39.759 ms, heap usage 163.209 MB -> 33.223 MB. [2024-09-25T21:09:48.798Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (1621.828 ms) ====== [2024-09-25T21:09:48.798Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2024-09-25T21:09:48.798Z] GC before operation: completed in 29.322 ms, heap usage 95.860 MB -> 33.326 MB. [2024-09-25T21:09:50.600Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (1679.238 ms) ====== [2024-09-25T21:09:50.600Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2024-09-25T21:09:50.600Z] GC before operation: completed in 42.521 ms, heap usage 227.028 MB -> 33.392 MB. [2024-09-25T21:09:51.876Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (1751.524 ms) ====== [2024-09-25T21:09:51.876Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2024-09-25T21:09:52.308Z] GC before operation: completed in 48.195 ms, heap usage 285.649 MB -> 33.500 MB. [2024-09-25T21:09:54.086Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (1717.467 ms) ====== [2024-09-25T21:09:54.086Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2024-09-25T21:09:54.086Z] GC before operation: completed in 41.167 ms, heap usage 109.581 MB -> 33.596 MB. [2024-09-25T21:09:55.871Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (1923.943 ms) ====== [2024-09-25T21:09:55.871Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2024-09-25T21:09:55.871Z] GC before operation: completed in 43.570 ms, heap usage 285.254 MB -> 34.326 MB. [2024-09-25T21:09:57.645Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (1802.184 ms) ====== [2024-09-25T21:09:57.646Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2024-09-25T21:09:57.646Z] GC before operation: completed in 47.322 ms, heap usage 235.424 MB -> 33.793 MB. [2024-09-25T21:09:59.434Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (1767.039 ms) ====== [2024-09-25T21:09:59.434Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2024-09-25T21:09:59.434Z] GC before operation: completed in 45.332 ms, heap usage 103.038 MB -> 33.892 MB. [2024-09-25T21:10:01.205Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (1800.526 ms) ====== [2024-09-25T21:10:01.205Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2024-09-25T21:10:01.205Z] GC before operation: completed in 44.096 ms, heap usage 65.571 MB -> 33.988 MB. [2024-09-25T21:10:03.009Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (1724.121 ms) ====== [2024-09-25T21:10:03.009Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2024-09-25T21:10:03.009Z] GC before operation: completed in 36.725 ms, heap usage 107.178 MB -> 34.088 MB. [2024-09-25T21:10:04.790Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (1748.992 ms) ====== [2024-09-25T21:10:04.790Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2024-09-25T21:10:04.790Z] GC before operation: completed in 38.364 ms, heap usage 113.197 MB -> 34.820 MB. [2024-09-25T21:10:06.572Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (1739.830 ms) ====== [2024-09-25T21:10:06.572Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2024-09-25T21:10:06.572Z] GC before operation: completed in 43.123 ms, heap usage 95.894 MB -> 34.283 MB. [2024-09-25T21:10:08.362Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (1820.430 ms) ====== [2024-09-25T21:10:08.362Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2024-09-25T21:10:08.362Z] GC before operation: completed in 39.803 ms, heap usage 63.340 MB -> 34.380 MB. [2024-09-25T21:10:10.152Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (1703.734 ms) ====== [2024-09-25T21:10:10.152Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2024-09-25T21:10:10.152Z] GC before operation: completed in 41.490 ms, heap usage 215.481 MB -> 34.765 MB. [2024-09-25T21:10:11.951Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (1720.379 ms) ====== [2024-09-25T21:10:11.951Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2024-09-25T21:10:11.951Z] GC before operation: completed in 40.365 ms, heap usage 293.321 MB -> 34.547 MB. [2024-09-25T21:10:13.737Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (1759.098 ms) ====== [2024-09-25T21:10:13.737Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2024-09-25T21:10:13.737Z] GC before operation: completed in 39.747 ms, heap usage 128.719 MB -> 34.963 MB. [2024-09-25T21:10:15.524Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (1679.467 ms) ====== [2024-09-25T21:10:15.524Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2024-09-25T21:10:15.524Z] GC before operation: completed in 41.701 ms, heap usage 248.059 MB -> 34.748 MB. [2024-09-25T21:10:17.317Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (1752.431 ms) ====== [2024-09-25T21:10:17.317Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2024-09-25T21:10:17.317Z] GC before operation: completed in 39.405 ms, heap usage 58.371 MB -> 34.843 MB. [2024-09-25T21:10:19.156Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (1722.829 ms) ====== [2024-09-25T21:10:19.156Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2024-09-25T21:10:19.156Z] GC before operation: completed in 35.919 ms, heap usage 55.931 MB -> 35.259 MB. [2024-09-25T21:10:20.945Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (1757.014 ms) ====== [2024-09-25T21:10:20.945Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2024-09-25T21:10:20.945Z] GC before operation: completed in 45.076 ms, heap usage 274.552 MB -> 35.015 MB. [2024-09-25T21:10:22.727Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (1753.879 ms) ====== [2024-09-25T21:10:22.727Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2024-09-25T21:10:22.727Z] GC before operation: completed in 39.110 ms, heap usage 225.545 MB -> 35.749 MB. [2024-09-25T21:10:24.528Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (1726.251 ms) ====== [2024-09-25T21:10:24.528Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2024-09-25T21:10:24.528Z] GC before operation: completed in 43.465 ms, heap usage 191.328 MB -> 35.215 MB. [2024-09-25T21:10:26.328Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (1732.647 ms) ====== [2024-09-25T21:10:26.328Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2024-09-25T21:10:26.328Z] GC before operation: completed in 43.343 ms, heap usage 120.893 MB -> 35.313 MB. [2024-09-25T21:10:28.139Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (1801.080 ms) ====== [2024-09-25T21:10:28.139Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2024-09-25T21:10:28.139Z] GC before operation: completed in 36.482 ms, heap usage 136.391 MB -> 35.410 MB. [2024-09-25T21:10:29.960Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (1777.945 ms) ====== [2024-09-25T21:10:29.960Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2024-09-25T21:10:29.960Z] GC before operation: completed in 48.149 ms, heap usage 269.507 MB -> 35.477 MB. [2024-09-25T21:10:31.751Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (1783.394 ms) ====== [2024-09-25T21:10:31.751Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2024-09-25T21:10:31.751Z] GC before operation: completed in 41.983 ms, heap usage 208.535 MB -> 35.907 MB. [2024-09-25T21:10:31.751Z] 24/09/25 17:10:31 WARN BlockManager: Asked to remove block broadcast_1286_piece0, which does not exist [2024-09-25T21:10:33.536Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (1746.723 ms) ====== [2024-09-25T21:10:33.537Z] ----------------------------------- [2024-09-25T21:10:33.537Z] renaissance-gauss-mix_0_PASSED [2024-09-25T21:10:33.537Z] ----------------------------------- [2024-09-25T21:10:33.537Z] [2024-09-25T21:10:33.537Z] TEST TEARDOWN: [2024-09-25T21:10:33.537Z] Nothing to be done for teardown. [2024-09-25T21:10:33.537Z] renaissance-gauss-mix_0 Finish Time: Wed Sep 25 17:10:33 2024 Epoch Time (ms): 1727298633391