[2023-04-19T00:04:50.452Z] Running test renaissance-gauss-mix_0 ... [2023-04-19T00:04:50.452Z] =============================================== [2023-04-19T00:04:50.452Z] renaissance-gauss-mix_0 Start Time: Tue Apr 18 19:04:46 2023 Epoch Time (ms): 1681862686695 [2023-04-19T00:04:50.452Z] variation: NoOptions [2023-04-19T00:04:50.452Z] JVM_OPTIONS: [2023-04-19T00:04:50.452Z] { \ [2023-04-19T00:04:50.452Z] echo ""; echo "TEST SETUP:"; \ [2023-04-19T00:04:50.452Z] echo "Nothing to be done for setup."; \ [2023-04-19T00:04:50.452Z] mkdir -p "E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_16818620773696\\renaissance-gauss-mix_0"; \ [2023-04-19T00:04:50.452Z] cd "E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_16818620773696\\renaissance-gauss-mix_0"; \ [2023-04-19T00:04:50.452Z] echo ""; echo "TESTING:"; \ [2023-04-19T00:04:50.452Z] "E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/openjdkbinary/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 "E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_16818620773696\\renaissance-gauss-mix_0"\\gauss-mix.json" gauss-mix; \ [2023-04-19T00:04:50.453Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_PASSED"; echo "-----------------------------------"; cd E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_16818620773696\\renaissance-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-19T00:04:50.453Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-19T00:04:50.453Z] echo "Nothing to be done for teardown."; \ [2023-04-19T00:04:50.453Z] } 2>&1 | tee -a "E:/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_16818620773696\\TestTargetResult"; [2023-04-19T00:04:50.453Z] [2023-04-19T00:04:50.453Z] TEST SETUP: [2023-04-19T00:04:50.453Z] Nothing to be done for setup. [2023-04-19T00:04:50.453Z] [2023-04-19T00:04:50.453Z] TESTING: [2023-04-19T00:04:54.681Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2023-04-19T00:04:58.001Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 4 (out of 8) threads. [2023-04-19T00:04:59.136Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2023-04-19T00:04:59.136Z] GC before operation: completed in 52.553 ms, heap usage 33.239 MB -> 26.671 MB. [2023-04-19T00:05:06.949Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (8079.075 ms) ====== [2023-04-19T00:05:06.949Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2023-04-19T00:05:06.949Z] GC before operation: completed in 74.162 ms, heap usage 116.767 MB -> 32.649 MB. [2023-04-19T00:05:09.459Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (2259.533 ms) ====== [2023-04-19T00:05:09.459Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2023-04-19T00:05:09.459Z] GC before operation: completed in 39.822 ms, heap usage 63.953 MB -> 32.891 MB. [2023-04-19T00:05:11.245Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (2051.099 ms) ====== [2023-04-19T00:05:11.245Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2023-04-19T00:05:11.245Z] GC before operation: completed in 60.352 ms, heap usage 218.557 MB -> 33.151 MB. [2023-04-19T00:05:13.758Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (2101.600 ms) ====== [2023-04-19T00:05:13.758Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2023-04-19T00:05:13.758Z] GC before operation: completed in 49.565 ms, heap usage 116.820 MB -> 34.052 MB. [2023-04-19T00:05:13.758Z] 23/04/18 19:05:09 WARN BlockManager: Asked to remove block rdd_54_0, which does not exist [2023-04-19T00:05:15.546Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (1899.749 ms) ====== [2023-04-19T00:05:15.546Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2023-04-19T00:05:15.546Z] GC before operation: completed in 55.194 ms, heap usage 124.160 MB -> 33.634 MB. [2023-04-19T00:05:18.075Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (2055.586 ms) ====== [2023-04-19T00:05:18.075Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2023-04-19T00:05:18.075Z] GC before operation: completed in 50.143 ms, heap usage 139.175 MB -> 33.775 MB. [2023-04-19T00:05:19.858Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (1958.043 ms) ====== [2023-04-19T00:05:19.858Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2023-04-19T00:05:19.858Z] GC before operation: completed in 50.295 ms, heap usage 128.419 MB -> 34.171 MB. [2023-04-19T00:05:21.643Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (1987.656 ms) ====== [2023-04-19T00:05:21.643Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2023-04-19T00:05:21.643Z] GC before operation: completed in 49.094 ms, heap usage 282.363 MB -> 34.061 MB. [2023-04-19T00:05:24.155Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (2021.874 ms) ====== [2023-04-19T00:05:24.155Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2023-04-19T00:05:24.155Z] GC before operation: completed in 43.579 ms, heap usage 232.005 MB -> 34.096 MB. [2023-04-19T00:05:25.938Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (2130.799 ms) ====== [2023-04-19T00:05:25.938Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2023-04-19T00:05:25.938Z] GC before operation: completed in 53.912 ms, heap usage 47.539 MB -> 34.484 MB. [2023-04-19T00:05:27.726Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (1899.478 ms) ====== [2023-04-19T00:05:27.726Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2023-04-19T00:05:27.726Z] GC before operation: completed in 46.703 ms, heap usage 283.484 MB -> 34.333 MB. [2023-04-19T00:05:30.234Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (1902.322 ms) ====== [2023-04-19T00:05:30.234Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2023-04-19T00:05:30.234Z] GC before operation: completed in 58.913 ms, heap usage 275.760 MB -> 34.772 MB. [2023-04-19T00:05:32.022Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (1953.329 ms) ====== [2023-04-19T00:05:32.022Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2023-04-19T00:05:32.022Z] GC before operation: completed in 54.307 ms, heap usage 188.397 MB -> 34.559 MB. [2023-04-19T00:05:33.809Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (1873.469 ms) ====== [2023-04-19T00:05:33.809Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2023-04-19T00:05:33.809Z] GC before operation: completed in 56.498 ms, heap usage 162.608 MB -> 34.605 MB. [2023-04-19T00:05:35.595Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (1961.364 ms) ====== [2023-04-19T00:05:35.595Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2023-04-19T00:05:36.137Z] GC before operation: completed in 82.431 ms, heap usage 262.509 MB -> 35.067 MB. [2023-04-19T00:05:37.927Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (1893.149 ms) ====== [2023-04-19T00:05:37.927Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2023-04-19T00:05:37.927Z] GC before operation: completed in 65.133 ms, heap usage 90.475 MB -> 35.132 MB. [2023-04-19T00:05:39.713Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (1877.467 ms) ====== [2023-04-19T00:05:39.713Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2023-04-19T00:05:39.713Z] GC before operation: completed in 56.629 ms, heap usage 236.501 MB -> 34.957 MB. [2023-04-19T00:05:41.499Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (1899.404 ms) ====== [2023-04-19T00:05:41.499Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2023-04-19T00:05:42.042Z] GC before operation: completed in 59.056 ms, heap usage 150.279 MB -> 35.020 MB. [2023-04-19T00:05:43.828Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (1931.980 ms) ====== [2023-04-19T00:05:43.828Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2023-04-19T00:05:43.828Z] GC before operation: completed in 51.971 ms, heap usage 146.402 MB -> 35.102 MB. [2023-04-19T00:05:45.612Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (1953.422 ms) ====== [2023-04-19T00:05:45.612Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2023-04-19T00:05:45.612Z] GC before operation: completed in 51.740 ms, heap usage 138.388 MB -> 35.207 MB. [2023-04-19T00:05:48.123Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (1959.371 ms) ====== [2023-04-19T00:05:48.123Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2023-04-19T00:05:48.123Z] GC before operation: completed in 64.962 ms, heap usage 126.989 MB -> 35.668 MB. [2023-04-19T00:05:49.910Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (1856.103 ms) ====== [2023-04-19T00:05:49.910Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2023-04-19T00:05:49.910Z] GC before operation: completed in 63.628 ms, heap usage 305.532 MB -> 35.857 MB. [2023-04-19T00:05:51.701Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (1710.825 ms) ====== [2023-04-19T00:05:51.701Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2023-04-19T00:05:51.701Z] GC before operation: completed in 49.845 ms, heap usage 131.668 MB -> 35.522 MB. [2023-04-19T00:05:53.487Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (1860.097 ms) ====== [2023-04-19T00:05:53.487Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2023-04-19T00:05:53.487Z] GC before operation: completed in 62.081 ms, heap usage 61.920 MB -> 35.595 MB. [2023-04-19T00:05:55.273Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (1842.329 ms) ====== [2023-04-19T00:05:55.273Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2023-04-19T00:05:55.273Z] GC before operation: completed in 60.249 ms, heap usage 210.036 MB -> 35.748 MB. [2023-04-19T00:05:57.062Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (1830.066 ms) ====== [2023-04-19T00:05:57.062Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2023-04-19T00:05:57.062Z] GC before operation: completed in 57.251 ms, heap usage 147.540 MB -> 35.817 MB. [2023-04-19T00:05:58.849Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (1847.304 ms) ====== [2023-04-19T00:05:58.849Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2023-04-19T00:05:59.389Z] GC before operation: completed in 63.026 ms, heap usage 135.205 MB -> 36.237 MB. [2023-04-19T00:06:01.173Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (1874.128 ms) ====== [2023-04-19T00:06:01.173Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2023-04-19T00:06:01.173Z] GC before operation: completed in 61.339 ms, heap usage 53.571 MB -> 36.339 MB. [2023-04-19T00:06:02.979Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (2041.180 ms) ====== [2023-04-19T00:06:02.979Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2023-04-19T00:06:02.979Z] GC before operation: completed in 58.863 ms, heap usage 64.585 MB -> 36.100 MB. [2023-04-19T00:06:04.768Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (1761.395 ms) ====== [2023-04-19T00:06:04.768Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2023-04-19T00:06:04.768Z] GC before operation: completed in 61.511 ms, heap usage 205.852 MB -> 36.506 MB. [2023-04-19T00:06:07.275Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (1849.277 ms) ====== [2023-04-19T00:06:07.275Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2023-04-19T00:06:07.275Z] GC before operation: completed in 62.981 ms, heap usage 154.250 MB -> 36.576 MB. [2023-04-19T00:06:08.418Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (1773.514 ms) ====== [2023-04-19T00:06:08.418Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2023-04-19T00:06:08.958Z] GC before operation: completed in 64.685 ms, heap usage 313.377 MB -> 36.430 MB. [2023-04-19T00:06:10.741Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (1875.843 ms) ====== [2023-04-19T00:06:10.741Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2023-04-19T00:06:10.741Z] GC before operation: completed in 61.943 ms, heap usage 51.746 MB -> 36.462 MB. [2023-04-19T00:06:12.527Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (1998.238 ms) ====== [2023-04-19T00:06:12.527Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2023-04-19T00:06:12.527Z] GC before operation: completed in 60.988 ms, heap usage 237.274 MB -> 36.893 MB. [2023-04-19T00:06:15.032Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (1847.876 ms) ====== [2023-04-19T00:06:15.032Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2023-04-19T00:06:15.032Z] GC before operation: completed in 56.839 ms, heap usage 120.254 MB -> 36.957 MB. [2023-04-19T00:06:15.032Z] 23/04/18 19:06:10 WARN BlockManager: Asked to remove block rdd_581_1, which does not exist [2023-04-19T00:06:16.821Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (1847.214 ms) ====== [2023-04-19T00:06:16.821Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2023-04-19T00:06:16.821Z] GC before operation: completed in 62.760 ms, heap usage 236.718 MB -> 37.100 MB. [2023-04-19T00:06:18.612Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (1758.917 ms) ====== [2023-04-19T00:06:18.612Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2023-04-19T00:06:18.612Z] GC before operation: completed in 59.397 ms, heap usage 188.399 MB -> 37.524 MB. [2023-04-19T00:06:20.396Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (1776.545 ms) ====== [2023-04-19T00:06:20.396Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2023-04-19T00:06:20.396Z] GC before operation: completed in 60.496 ms, heap usage 51.842 MB -> 37.274 MB. [2023-04-19T00:06:22.184Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (1959.418 ms) ====== [2023-04-19T00:06:22.184Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2023-04-19T00:06:22.184Z] GC before operation: completed in 54.898 ms, heap usage 45.185 MB -> 37.380 MB. [2023-04-19T00:06:22.184Z] 23/04/18 19:06:18 WARN BlockManager: Asked to remove block rdd_649_1, which does not exist [2023-04-19T00:06:23.972Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (1902.933 ms) ====== [2023-04-19T00:06:24.515Z] ----------------------------------- [2023-04-19T00:06:24.515Z] renaissance-gauss-mix_0_PASSED [2023-04-19T00:06:24.515Z] ----------------------------------- [2023-04-19T00:06:24.515Z] [2023-04-19T00:06:24.515Z] TEST TEARDOWN: [2023-04-19T00:06:24.515Z] Nothing to be done for teardown. [2023-04-19T00:06:24.515Z] renaissance-gauss-mix_0 Finish Time: Tue Apr 18 19:06:21 2023 Epoch Time (ms): 1681862781004