[2024-10-03T01:25:45.439Z] Running test renaissance-als_0 ... [2024-10-03T01:25:45.439Z] =============================================== [2024-10-03T01:25:45.439Z] renaissance-als_0 Start Time: Thu Oct 3 01:25:45 2024 Epoch Time (ms): 1727918745147 [2024-10-03T01:25:45.439Z] variation: NoOptions [2024-10-03T01:25:45.439Z] JVM_OPTIONS: [2024-10-03T01:25:45.439Z] { \ [2024-10-03T01:25:45.439Z] echo ""; echo "TEST SETUP:"; \ [2024-10-03T01:25:45.439Z] echo "Nothing to be done for setup."; \ [2024-10-03T01:25:45.439Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279186985186/renaissance-als_0"; \ [2024-10-03T01:25:45.439Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279186985186/renaissance-als_0"; \ [2024-10-03T01:25:45.439Z] echo ""; echo "TESTING:"; \ [2024-10-03T01:25:45.439Z] "/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_17279186985186/renaissance-als_0"/als.json" als; \ [2024-10-03T01:25:45.439Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_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_17279186985186/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-03T01:25:45.439Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-03T01:25:45.439Z] echo "Nothing to be done for teardown."; \ [2024-10-03T01:25:45.439Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17279186985186/TestTargetResult"; [2024-10-03T01:25:45.439Z] [2024-10-03T01:25:45.439Z] TEST SETUP: [2024-10-03T01:25:45.439Z] Nothing to be done for setup. [2024-10-03T01:25:45.439Z] [2024-10-03T01:25:45.439Z] TESTING: [2024-10-03T01:25:51.050Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-03T01:25:53.658Z] NOTE: 'als' benchmark uses Spark local executor with 12 (out of 24) threads. [2024-10-03T01:25:57.080Z] WARNING: An illegal reflective access operation has occurred [2024-10-03T01:25:57.080Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/output_17279186985186/renaissance-als_0/harness-012546-13032949996789778009/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-03T01:25:57.080Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-03T01:25:57.080Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-03T01:25:57.080Z] WARNING: All illegal access operations will be denied in a future release [2024-10-03T01:25:59.556Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-10-03T01:25:59.556Z] GC before operation: completed in 69.259 ms, heap usage 237.091 MB -> 35.340 MB. [2024-10-03T01:26:13.439Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:13.439Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:13.439Z] ====== als (apache-spark) [default], iteration 0 completed (13868.780 ms) ====== [2024-10-03T01:26:13.439Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-10-03T01:26:13.439Z] GC before operation: completed in 109.388 ms, heap usage 547.521 MB -> 57.867 MB. [2024-10-03T01:26:19.064Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:19.064Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:19.064Z] ====== als (apache-spark) [default], iteration 1 completed (5540.129 ms) ====== [2024-10-03T01:26:19.064Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-10-03T01:26:19.064Z] GC before operation: completed in 132.327 ms, heap usage 624.559 MB -> 60.477 MB. [2024-10-03T01:26:24.707Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:24.707Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:24.707Z] ====== als (apache-spark) [default], iteration 2 completed (5435.251 ms) ====== [2024-10-03T01:26:24.707Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-10-03T01:26:24.708Z] GC before operation: completed in 122.425 ms, heap usage 831.128 MB -> 61.197 MB. [2024-10-03T01:26:30.322Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:30.322Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:30.322Z] ====== als (apache-spark) [default], iteration 3 completed (5270.370 ms) ====== [2024-10-03T01:26:30.322Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-10-03T01:26:30.322Z] GC before operation: completed in 106.706 ms, heap usage 575.416 MB -> 61.157 MB. [2024-10-03T01:26:35.940Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:35.940Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:35.940Z] ====== als (apache-spark) [default], iteration 4 completed (5305.755 ms) ====== [2024-10-03T01:26:35.940Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-10-03T01:26:35.940Z] GC before operation: completed in 132.439 ms, heap usage 1.329 GB -> 62.368 MB. [2024-10-03T01:26:41.003Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:41.003Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:41.003Z] ====== als (apache-spark) [default], iteration 5 completed (5195.776 ms) ====== [2024-10-03T01:26:41.003Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-10-03T01:26:41.003Z] GC before operation: completed in 135.107 ms, heap usage 288.253 MB -> 61.608 MB. [2024-10-03T01:26:46.623Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:46.623Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:46.623Z] ====== als (apache-spark) [default], iteration 6 completed (5048.342 ms) ====== [2024-10-03T01:26:46.623Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-10-03T01:26:46.623Z] GC before operation: completed in 114.232 ms, heap usage 572.756 MB -> 62.264 MB. [2024-10-03T01:26:51.089Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:51.089Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:51.089Z] ====== als (apache-spark) [default], iteration 7 completed (5168.847 ms) ====== [2024-10-03T01:26:51.089Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-10-03T01:26:51.089Z] GC before operation: completed in 117.578 ms, heap usage 863.100 MB -> 62.974 MB. [2024-10-03T01:26:56.709Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:26:56.709Z] There is no way to check that no silent failure occurred. [2024-10-03T01:26:56.709Z] ====== als (apache-spark) [default], iteration 8 completed (5120.186 ms) ====== [2024-10-03T01:26:56.709Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-10-03T01:26:56.709Z] GC before operation: completed in 109.554 ms, heap usage 307.853 MB -> 62.656 MB. [2024-10-03T01:27:02.323Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:02.323Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:02.323Z] ====== als (apache-spark) [default], iteration 9 completed (5021.674 ms) ====== [2024-10-03T01:27:02.323Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-10-03T01:27:02.323Z] GC before operation: completed in 112.839 ms, heap usage 441.247 MB -> 63.104 MB. [2024-10-03T01:27:06.794Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:06.794Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:06.794Z] ====== als (apache-spark) [default], iteration 10 completed (5131.343 ms) ====== [2024-10-03T01:27:06.794Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-10-03T01:27:06.794Z] GC before operation: completed in 133.750 ms, heap usage 498.198 MB -> 63.559 MB. [2024-10-03T01:27:12.418Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:12.418Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:12.418Z] ====== als (apache-spark) [default], iteration 11 completed (5017.506 ms) ====== [2024-10-03T01:27:12.418Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-10-03T01:27:12.418Z] GC before operation: completed in 141.586 ms, heap usage 1.291 GB -> 64.858 MB. [2024-10-03T01:27:18.038Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:18.038Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:18.038Z] ====== als (apache-spark) [default], iteration 12 completed (5244.805 ms) ====== [2024-10-03T01:27:18.038Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-10-03T01:27:18.038Z] GC before operation: completed in 167.552 ms, heap usage 250.290 MB -> 63.847 MB. [2024-10-03T01:27:22.512Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:22.512Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:22.512Z] ====== als (apache-spark) [default], iteration 13 completed (5206.925 ms) ====== [2024-10-03T01:27:22.512Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-10-03T01:27:23.291Z] GC before operation: completed in 143.817 ms, heap usage 327.500 MB -> 64.448 MB. [2024-10-03T01:27:27.761Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:27.761Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:27.761Z] ====== als (apache-spark) [default], iteration 14 completed (5032.998 ms) ====== [2024-10-03T01:27:27.761Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-10-03T01:27:28.541Z] GC before operation: completed in 133.097 ms, heap usage 1003.772 MB -> 65.556 MB. [2024-10-03T01:27:33.006Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:33.006Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:33.006Z] ====== als (apache-spark) [default], iteration 15 completed (4855.790 ms) ====== [2024-10-03T01:27:33.006Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-10-03T01:27:33.006Z] GC before operation: completed in 124.121 ms, heap usage 464.236 MB -> 65.121 MB. [2024-10-03T01:27:38.624Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:38.624Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:38.624Z] ====== als (apache-spark) [default], iteration 16 completed (5101.851 ms) ====== [2024-10-03T01:27:38.624Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-10-03T01:27:38.624Z] GC before operation: completed in 123.734 ms, heap usage 864.107 MB -> 66.136 MB. [2024-10-03T01:27:44.240Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:44.241Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:44.241Z] ====== als (apache-spark) [default], iteration 17 completed (5105.817 ms) ====== [2024-10-03T01:27:44.241Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-10-03T01:27:44.241Z] GC before operation: completed in 129.941 ms, heap usage 918.734 MB -> 66.510 MB. [2024-10-03T01:27:48.729Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:48.729Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:48.729Z] ====== als (apache-spark) [default], iteration 18 completed (4934.072 ms) ====== [2024-10-03T01:27:48.729Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-10-03T01:27:48.729Z] GC before operation: completed in 121.929 ms, heap usage 551.352 MB -> 66.155 MB. [2024-10-03T01:27:54.331Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:54.331Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:54.331Z] ====== als (apache-spark) [default], iteration 19 completed (5090.096 ms) ====== [2024-10-03T01:27:54.331Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-10-03T01:27:54.331Z] GC before operation: completed in 142.955 ms, heap usage 1.469 GB -> 67.443 MB. [2024-10-03T01:27:58.811Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:27:58.812Z] There is no way to check that no silent failure occurred. [2024-10-03T01:27:58.812Z] ====== als (apache-spark) [default], iteration 20 completed (5130.274 ms) ====== [2024-10-03T01:27:58.812Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-10-03T01:27:58.812Z] GC before operation: completed in 140.801 ms, heap usage 358.396 MB -> 66.353 MB. [2024-10-03T01:28:04.543Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:04.544Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:04.544Z] ====== als (apache-spark) [default], iteration 21 completed (5127.059 ms) ====== [2024-10-03T01:28:04.544Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-10-03T01:28:04.544Z] GC before operation: completed in 143.647 ms, heap usage 753.080 MB -> 67.041 MB. [2024-10-03T01:28:10.152Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:10.152Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:10.152Z] ====== als (apache-spark) [default], iteration 22 completed (5131.367 ms) ====== [2024-10-03T01:28:10.152Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-10-03T01:28:10.152Z] GC before operation: completed in 151.388 ms, heap usage 218.361 MB -> 66.449 MB. [2024-10-03T01:28:14.628Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:14.628Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:14.628Z] ====== als (apache-spark) [default], iteration 23 completed (5042.795 ms) ====== [2024-10-03T01:28:14.628Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-10-03T01:28:14.628Z] GC before operation: completed in 142.416 ms, heap usage 389.736 MB -> 67.116 MB. [2024-10-03T01:28:20.240Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:20.240Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:20.240Z] ====== als (apache-spark) [default], iteration 24 completed (4947.315 ms) ====== [2024-10-03T01:28:20.240Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-10-03T01:28:20.240Z] GC before operation: completed in 139.685 ms, heap usage 763.462 MB -> 67.729 MB. [2024-10-03T01:28:24.712Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:24.712Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:24.712Z] ====== als (apache-spark) [default], iteration 25 completed (4933.028 ms) ====== [2024-10-03T01:28:24.712Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-10-03T01:28:24.712Z] GC before operation: completed in 138.551 ms, heap usage 634.512 MB -> 67.702 MB. [2024-10-03T01:28:30.320Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:30.320Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:30.320Z] ====== als (apache-spark) [default], iteration 26 completed (4983.319 ms) ====== [2024-10-03T01:28:30.320Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-10-03T01:28:30.320Z] GC before operation: completed in 130.712 ms, heap usage 562.819 MB -> 67.830 MB. [2024-10-03T01:28:35.945Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:35.945Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:35.945Z] ====== als (apache-spark) [default], iteration 27 completed (5004.722 ms) ====== [2024-10-03T01:28:35.945Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-10-03T01:28:35.945Z] GC before operation: completed in 118.641 ms, heap usage 567.644 MB -> 67.915 MB. [2024-10-03T01:28:40.424Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:40.424Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:40.424Z] ====== als (apache-spark) [default], iteration 28 completed (5025.316 ms) ====== [2024-10-03T01:28:40.424Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-10-03T01:28:40.424Z] GC before operation: completed in 138.776 ms, heap usage 841.838 MB -> 68.673 MB. [2024-10-03T01:28:46.041Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T01:28:46.041Z] There is no way to check that no silent failure occurred. [2024-10-03T01:28:46.041Z] ====== als (apache-spark) [default], iteration 29 completed (4976.233 ms) ====== [2024-10-03T01:28:46.041Z] ----------------------------------- [2024-10-03T01:28:46.041Z] renaissance-als_0_PASSED [2024-10-03T01:28:46.041Z] ----------------------------------- [2024-10-03T01:28:46.041Z] [2024-10-03T01:28:46.041Z] TEST TEARDOWN: [2024-10-03T01:28:46.041Z] Nothing to be done for teardown. [2024-10-03T01:28:46.041Z] renaissance-als_0 Finish Time: Thu Oct 3 01:28:45 2024 Epoch Time (ms): 1727918925727