[2024-09-25T22:35:04.803Z] Running test renaissance-gauss-mix_0 ... [2024-09-25T22:35:04.803Z] =============================================== [2024-09-25T22:35:04.803Z] renaissance-gauss-mix_0 Start Time: Wed Sep 25 22:35:04 2024 Epoch Time (ms): 1727303704763 [2024-09-25T22:35:05.118Z] variation: NoOptions [2024-09-25T22:35:05.118Z] JVM_OPTIONS: [2024-09-25T22:35:05.118Z] { \ [2024-09-25T22:35:05.118Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T22:35:05.118Z] echo "Nothing to be done for setup."; \ [2024-09-25T22:35:05.118Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273026372534\\renaissance-gauss-mix_0"; \ [2024-09-25T22:35:05.118Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273026372534\\renaissance-gauss-mix_0"; \ [2024-09-25T22:35:05.118Z] echo ""; echo "TESTING:"; \ [2024-09-25T22:35:05.119Z] "c:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273026372534\\renaissance-gauss-mix_0"\\gauss-mix.json" gauss-mix; \ [2024-09-25T22:35:05.119Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273026372534\\renaissance-gauss-mix_0"; else echo "-----------------------------------"; echo "renaissance-gauss-mix_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T22:35:05.119Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T22:35:05.119Z] echo "Nothing to be done for teardown."; \ [2024-09-25T22:35:05.119Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17273026372534\\TestTargetResult"; [2024-09-25T22:35:05.119Z] [2024-09-25T22:35:05.119Z] TEST SETUP: [2024-09-25T22:35:05.119Z] Nothing to be done for setup. [2024-09-25T22:35:05.119Z] [2024-09-25T22:35:05.119Z] TESTING: [2024-09-25T22:35:15.653Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T22:35:17.222Z] NOTE: 'gauss-mix' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-25T22:35:17.540Z] ====== gauss-mix (apache-spark) [default], iteration 0 started ====== [2024-09-25T22:35:17.866Z] GC before operation: completed in 31.907 ms, heap usage 27.500 MB -> 25.805 MB. [2024-09-25T22:35:23.618Z] ====== gauss-mix (apache-spark) [default], iteration 0 completed (6008.701 ms) ====== [2024-09-25T22:35:23.618Z] ====== gauss-mix (apache-spark) [default], iteration 1 started ====== [2024-09-25T22:35:23.937Z] GC before operation: completed in 68.612 ms, heap usage 227.524 MB -> 31.669 MB. [2024-09-25T22:35:27.563Z] ====== gauss-mix (apache-spark) [default], iteration 1 completed (3321.543 ms) ====== [2024-09-25T22:35:27.563Z] ====== gauss-mix (apache-spark) [default], iteration 2 started ====== [2024-09-25T22:35:27.563Z] GC before operation: completed in 62.072 ms, heap usage 101.648 MB -> 32.209 MB. [2024-09-25T22:35:30.387Z] ====== gauss-mix (apache-spark) [default], iteration 2 completed (3251.118 ms) ====== [2024-09-25T22:35:30.387Z] ====== gauss-mix (apache-spark) [default], iteration 3 started ====== [2024-09-25T22:35:30.387Z] GC before operation: completed in 62.013 ms, heap usage 219.292 MB -> 32.486 MB. [2024-09-25T22:35:33.235Z] ====== gauss-mix (apache-spark) [default], iteration 3 completed (2867.623 ms) ====== [2024-09-25T22:35:33.235Z] ====== gauss-mix (apache-spark) [default], iteration 4 started ====== [2024-09-25T22:35:33.550Z] GC before operation: completed in 67.737 ms, heap usage 199.734 MB -> 32.718 MB. [2024-09-25T22:35:36.371Z] ====== gauss-mix (apache-spark) [default], iteration 4 completed (2758.516 ms) ====== [2024-09-25T22:35:36.371Z] ====== gauss-mix (apache-spark) [default], iteration 5 started ====== [2024-09-25T22:35:36.371Z] GC before operation: completed in 69.237 ms, heap usage 163.031 MB -> 32.617 MB. [2024-09-25T22:35:39.242Z] ====== gauss-mix (apache-spark) [default], iteration 5 completed (2896.787 ms) ====== [2024-09-25T22:35:39.242Z] ====== gauss-mix (apache-spark) [default], iteration 6 started ====== [2024-09-25T22:35:39.242Z] GC before operation: completed in 66.956 ms, heap usage 220.438 MB -> 32.733 MB. [2024-09-25T22:35:42.179Z] ====== gauss-mix (apache-spark) [default], iteration 6 completed (2873.421 ms) ====== [2024-09-25T22:35:42.179Z] ====== gauss-mix (apache-spark) [default], iteration 7 started ====== [2024-09-25T22:35:42.179Z] GC before operation: completed in 66.150 ms, heap usage 172.427 MB -> 33.137 MB. [2024-09-25T22:35:45.008Z] ====== gauss-mix (apache-spark) [default], iteration 7 completed (2815.935 ms) ====== [2024-09-25T22:35:45.008Z] ====== gauss-mix (apache-spark) [default], iteration 8 started ====== [2024-09-25T22:35:45.008Z] GC before operation: completed in 64.590 ms, heap usage 101.879 MB -> 33.245 MB. [2024-09-25T22:35:47.838Z] ====== gauss-mix (apache-spark) [default], iteration 8 completed (2714.635 ms) ====== [2024-09-25T22:35:47.838Z] ====== gauss-mix (apache-spark) [default], iteration 9 started ====== [2024-09-25T22:35:47.838Z] GC before operation: completed in 67.182 ms, heap usage 40.412 MB -> 33.354 MB. [2024-09-25T22:35:50.654Z] ====== gauss-mix (apache-spark) [default], iteration 9 completed (2657.755 ms) ====== [2024-09-25T22:35:50.654Z] ====== gauss-mix (apache-spark) [default], iteration 10 started ====== [2024-09-25T22:35:50.654Z] GC before operation: completed in 68.607 ms, heap usage 50.053 MB -> 33.447 MB. [2024-09-25T22:35:53.469Z] ====== gauss-mix (apache-spark) [default], iteration 10 completed (2655.179 ms) ====== [2024-09-25T22:35:53.469Z] ====== gauss-mix (apache-spark) [default], iteration 11 started ====== [2024-09-25T22:35:53.469Z] GC before operation: completed in 71.759 ms, heap usage 146.620 MB -> 33.569 MB. [2024-09-25T22:35:53.469Z] 24/09/25 22:35:53 WARN BlockManager: Asked to remove block rdd_173_0, which does not exist [2024-09-25T22:35:56.314Z] ====== gauss-mix (apache-spark) [default], iteration 11 completed (2755.555 ms) ====== [2024-09-25T22:35:56.314Z] ====== gauss-mix (apache-spark) [default], iteration 12 started ====== [2024-09-25T22:35:56.314Z] GC before operation: completed in 69.722 ms, heap usage 117.725 MB -> 33.674 MB. [2024-09-25T22:35:59.118Z] ====== gauss-mix (apache-spark) [default], iteration 12 completed (2626.334 ms) ====== [2024-09-25T22:35:59.118Z] ====== gauss-mix (apache-spark) [default], iteration 13 started ====== [2024-09-25T22:35:59.118Z] GC before operation: completed in 69.976 ms, heap usage 74.853 MB -> 33.772 MB. [2024-09-25T22:36:01.921Z] ====== gauss-mix (apache-spark) [default], iteration 13 completed (2661.923 ms) ====== [2024-09-25T22:36:01.921Z] ====== gauss-mix (apache-spark) [default], iteration 14 started ====== [2024-09-25T22:36:01.921Z] GC before operation: completed in 73.225 ms, heap usage 130.454 MB -> 33.850 MB. [2024-09-25T22:36:04.072Z] ====== gauss-mix (apache-spark) [default], iteration 14 completed (2641.847 ms) ====== [2024-09-25T22:36:04.072Z] ====== gauss-mix (apache-spark) [default], iteration 15 started ====== [2024-09-25T22:36:04.388Z] GC before operation: completed in 75.485 ms, heap usage 216.522 MB -> 33.950 MB. [2024-09-25T22:36:07.213Z] ====== gauss-mix (apache-spark) [default], iteration 15 completed (2637.181 ms) ====== [2024-09-25T22:36:07.213Z] ====== gauss-mix (apache-spark) [default], iteration 16 started ====== [2024-09-25T22:36:07.213Z] GC before operation: completed in 73.195 ms, heap usage 125.736 MB -> 34.049 MB. [2024-09-25T22:36:10.027Z] ====== gauss-mix (apache-spark) [default], iteration 16 completed (2613.977 ms) ====== [2024-09-25T22:36:10.027Z] ====== gauss-mix (apache-spark) [default], iteration 17 started ====== [2024-09-25T22:36:10.027Z] GC before operation: completed in 72.823 ms, heap usage 61.097 MB -> 33.834 MB. [2024-09-25T22:36:12.176Z] ====== gauss-mix (apache-spark) [default], iteration 17 completed (2626.505 ms) ====== [2024-09-25T22:36:12.176Z] ====== gauss-mix (apache-spark) [default], iteration 18 started ====== [2024-09-25T22:36:12.491Z] GC before operation: completed in 74.690 ms, heap usage 172.987 MB -> 34.228 MB. [2024-09-25T22:36:15.312Z] ====== gauss-mix (apache-spark) [default], iteration 18 completed (2720.202 ms) ====== [2024-09-25T22:36:15.312Z] ====== gauss-mix (apache-spark) [default], iteration 19 started ====== [2024-09-25T22:36:15.313Z] GC before operation: completed in 75.035 ms, heap usage 110.351 MB -> 34.334 MB. [2024-09-25T22:36:18.129Z] ====== gauss-mix (apache-spark) [default], iteration 19 completed (2664.625 ms) ====== [2024-09-25T22:36:18.129Z] ====== gauss-mix (apache-spark) [default], iteration 20 started ====== [2024-09-25T22:36:18.129Z] GC before operation: completed in 83.788 ms, heap usage 261.028 MB -> 34.124 MB. [2024-09-25T22:36:20.948Z] ====== gauss-mix (apache-spark) [default], iteration 20 completed (2600.482 ms) ====== [2024-09-25T22:36:20.948Z] ====== gauss-mix (apache-spark) [default], iteration 21 started ====== [2024-09-25T22:36:20.948Z] GC before operation: completed in 72.149 ms, heap usage 129.906 MB -> 34.509 MB. [2024-09-25T22:36:23.092Z] ====== gauss-mix (apache-spark) [default], iteration 21 completed (2575.782 ms) ====== [2024-09-25T22:36:23.092Z] ====== gauss-mix (apache-spark) [default], iteration 22 started ====== [2024-09-25T22:36:23.092Z] GC before operation: completed in 74.406 ms, heap usage 153.319 MB -> 34.630 MB. [2024-09-25T22:36:25.902Z] ====== gauss-mix (apache-spark) [default], iteration 22 completed (2562.825 ms) ====== [2024-09-25T22:36:25.902Z] ====== gauss-mix (apache-spark) [default], iteration 23 started ====== [2024-09-25T22:36:25.902Z] GC before operation: completed in 73.337 ms, heap usage 120.888 MB -> 34.728 MB. [2024-09-25T22:36:28.725Z] ====== gauss-mix (apache-spark) [default], iteration 23 completed (2670.021 ms) ====== [2024-09-25T22:36:28.725Z] ====== gauss-mix (apache-spark) [default], iteration 24 started ====== [2024-09-25T22:36:28.725Z] GC before operation: completed in 81.841 ms, heap usage 75.326 MB -> 34.826 MB. [2024-09-25T22:36:31.543Z] ====== gauss-mix (apache-spark) [default], iteration 24 completed (2651.469 ms) ====== [2024-09-25T22:36:31.543Z] ====== gauss-mix (apache-spark) [default], iteration 25 started ====== [2024-09-25T22:36:31.543Z] GC before operation: completed in 71.041 ms, heap usage 229.104 MB -> 34.904 MB. [2024-09-25T22:36:34.362Z] ====== gauss-mix (apache-spark) [default], iteration 25 completed (2665.413 ms) ====== [2024-09-25T22:36:34.362Z] ====== gauss-mix (apache-spark) [default], iteration 26 started ====== [2024-09-25T22:36:34.362Z] GC before operation: completed in 73.999 ms, heap usage 204.656 MB -> 35.002 MB. [2024-09-25T22:36:37.179Z] ====== gauss-mix (apache-spark) [default], iteration 26 completed (2647.983 ms) ====== [2024-09-25T22:36:37.179Z] ====== gauss-mix (apache-spark) [default], iteration 27 started ====== [2024-09-25T22:36:37.179Z] GC before operation: completed in 75.310 ms, heap usage 210.768 MB -> 35.099 MB. [2024-09-25T22:36:37.179Z] 24/09/25 22:36:36 WARN BlockManager: Asked to remove block rdd_445_1, which does not exist [2024-09-25T22:36:39.334Z] ====== gauss-mix (apache-spark) [default], iteration 27 completed (2650.390 ms) ====== [2024-09-25T22:36:39.334Z] ====== gauss-mix (apache-spark) [default], iteration 28 started ====== [2024-09-25T22:36:39.649Z] GC before operation: completed in 77.598 ms, heap usage 261.213 MB -> 35.198 MB. [2024-09-25T22:36:42.461Z] ====== gauss-mix (apache-spark) [default], iteration 28 completed (2590.983 ms) ====== [2024-09-25T22:36:42.461Z] ====== gauss-mix (apache-spark) [default], iteration 29 started ====== [2024-09-25T22:36:42.461Z] GC before operation: completed in 72.105 ms, heap usage 93.338 MB -> 35.276 MB. [2024-09-25T22:36:45.329Z] ====== gauss-mix (apache-spark) [default], iteration 29 completed (2692.057 ms) ====== [2024-09-25T22:36:45.329Z] ====== gauss-mix (apache-spark) [default], iteration 30 started ====== [2024-09-25T22:36:45.329Z] GC before operation: completed in 79.283 ms, heap usage 105.857 MB -> 35.375 MB. [2024-09-25T22:36:48.128Z] ====== gauss-mix (apache-spark) [default], iteration 30 completed (2696.849 ms) ====== [2024-09-25T22:36:48.128Z] ====== gauss-mix (apache-spark) [default], iteration 31 started ====== [2024-09-25T22:36:48.128Z] GC before operation: completed in 74.043 ms, heap usage 209.141 MB -> 35.473 MB. [2024-09-25T22:36:50.300Z] ====== gauss-mix (apache-spark) [default], iteration 31 completed (2666.747 ms) ====== [2024-09-25T22:36:50.300Z] ====== gauss-mix (apache-spark) [default], iteration 32 started ====== [2024-09-25T22:36:50.617Z] GC before operation: completed in 75.416 ms, heap usage 201.095 MB -> 35.555 MB. [2024-09-25T22:36:53.444Z] ====== gauss-mix (apache-spark) [default], iteration 32 completed (2713.140 ms) ====== [2024-09-25T22:36:53.444Z] ====== gauss-mix (apache-spark) [default], iteration 33 started ====== [2024-09-25T22:36:53.444Z] GC before operation: completed in 76.406 ms, heap usage 147.162 MB -> 35.658 MB. [2024-09-25T22:36:56.259Z] ====== gauss-mix (apache-spark) [default], iteration 33 completed (2567.862 ms) ====== [2024-09-25T22:36:56.259Z] ====== gauss-mix (apache-spark) [default], iteration 34 started ====== [2024-09-25T22:36:56.259Z] GC before operation: completed in 75.657 ms, heap usage 214.893 MB -> 35.755 MB. [2024-09-25T22:36:59.072Z] ====== gauss-mix (apache-spark) [default], iteration 34 completed (2642.960 ms) ====== [2024-09-25T22:36:59.072Z] ====== gauss-mix (apache-spark) [default], iteration 35 started ====== [2024-09-25T22:36:59.072Z] GC before operation: completed in 75.098 ms, heap usage 137.822 MB -> 35.857 MB. [2024-09-25T22:37:01.214Z] ====== gauss-mix (apache-spark) [default], iteration 35 completed (2622.821 ms) ====== [2024-09-25T22:37:01.214Z] ====== gauss-mix (apache-spark) [default], iteration 36 started ====== [2024-09-25T22:37:01.214Z] GC before operation: completed in 73.700 ms, heap usage 122.495 MB -> 35.932 MB. [2024-09-25T22:37:04.031Z] ====== gauss-mix (apache-spark) [default], iteration 36 completed (2616.399 ms) ====== [2024-09-25T22:37:04.032Z] ====== gauss-mix (apache-spark) [default], iteration 37 started ====== [2024-09-25T22:37:04.032Z] GC before operation: completed in 77.778 ms, heap usage 82.015 MB -> 36.030 MB. [2024-09-25T22:37:04.032Z] 24/09/25 22:37:03 WARN BlockManager: Asked to remove block rdd_615_0, which does not exist [2024-09-25T22:37:06.856Z] ====== gauss-mix (apache-spark) [default], iteration 37 completed (2601.993 ms) ====== [2024-09-25T22:37:06.856Z] ====== gauss-mix (apache-spark) [default], iteration 38 started ====== [2024-09-25T22:37:06.856Z] GC before operation: completed in 74.965 ms, heap usage 145.779 MB -> 36.132 MB. [2024-09-25T22:37:06.856Z] 24/09/25 22:37:06 WARN BlockManager: Asked to remove block rdd_632_0, which does not exist [2024-09-25T22:37:09.674Z] ====== gauss-mix (apache-spark) [default], iteration 38 completed (2508.694 ms) ====== [2024-09-25T22:37:09.674Z] ====== gauss-mix (apache-spark) [default], iteration 39 started ====== [2024-09-25T22:37:09.674Z] GC before operation: completed in 84.479 ms, heap usage 260.390 MB -> 36.232 MB. [2024-09-25T22:37:11.812Z] ====== gauss-mix (apache-spark) [default], iteration 39 completed (2650.402 ms) ====== [2024-09-25T22:37:12.126Z] ----------------------------------- [2024-09-25T22:37:12.126Z] renaissance-gauss-mix_0_PASSED [2024-09-25T22:37:12.126Z] ----------------------------------- [2024-09-25T22:37:12.428Z] [2024-09-25T22:37:12.429Z] TEST TEARDOWN: [2024-09-25T22:37:12.429Z] Nothing to be done for teardown. [2024-09-25T22:37:12.429Z] renaissance-gauss-mix_0 Finish Time: Wed Sep 25 22:37:12 2024 Epoch Time (ms): 1727303832237