[2024-10-02T20:52:55.995Z] Running test renaissance-als_0 ... [2024-10-02T20:52:55.995Z] =============================================== [2024-10-02T20:52:55.995Z] renaissance-als_0 Start Time: Wed Oct 2 20:52:55 2024 Epoch Time (ms): 1727902375418 [2024-10-02T20:52:55.995Z] variation: NoOptions [2024-10-02T20:52:55.995Z] JVM_OPTIONS: [2024-10-02T20:52:55.995Z] { \ [2024-10-02T20:52:55.995Z] echo ""; echo "TEST SETUP:"; \ [2024-10-02T20:52:55.995Z] echo "Nothing to be done for setup."; \ [2024-10-02T20:52:55.995Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17279023323367/renaissance-als_0"; \ [2024-10-02T20:52:55.995Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17279023323367/renaissance-als_0"; \ [2024-10-02T20:52:55.995Z] echo ""; echo "TESTING:"; \ [2024-10-02T20:52:55.996Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17279023323367/renaissance-als_0"/als.json" als; \ [2024-10-02T20:52:55.996Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17279023323367/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-02T20:52:55.996Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-02T20:52:55.996Z] echo "Nothing to be done for teardown."; \ [2024-10-02T20:52:55.996Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17279023323367/TestTargetResult"; [2024-10-02T20:52:55.996Z] [2024-10-02T20:52:55.996Z] TEST SETUP: [2024-10-02T20:52:55.996Z] Nothing to be done for setup. [2024-10-02T20:52:55.996Z] [2024-10-02T20:52:55.996Z] TESTING: [2024-10-02T20:52:59.028Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-02T20:53:01.031Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-10-02T20:53:04.022Z] WARNING: An illegal reflective access operation has occurred [2024-10-02T20:53:04.022Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17279023323367/renaissance-als_0/harness-205256-4823415905495800670/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-02T20:53:04.022Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-02T20:53:04.022Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-02T20:53:04.022Z] WARNING: All illegal access operations will be denied in a future release [2024-10-02T20:53:05.962Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-10-02T20:53:05.962Z] GC before operation: completed in 56.066 ms, heap usage 93.500 MB -> 33.798 MB. [2024-10-02T20:53:23.772Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:53:23.772Z] There is no way to check that no silent failure occurred. [2024-10-02T20:53:23.772Z] ====== als (apache-spark) [default], iteration 0 completed (16918.710 ms) ====== [2024-10-02T20:53:23.772Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-10-02T20:53:23.772Z] GC before operation: completed in 105.988 ms, heap usage 342.492 MB -> 56.078 MB. [2024-10-02T20:53:32.021Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:53:32.021Z] There is no way to check that no silent failure occurred. [2024-10-02T20:53:32.021Z] ====== als (apache-spark) [default], iteration 1 completed (8180.580 ms) ====== [2024-10-02T20:53:32.021Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-10-02T20:53:32.021Z] GC before operation: completed in 99.432 ms, heap usage 612.084 MB -> 59.206 MB. [2024-10-02T20:53:38.658Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:53:38.658Z] There is no way to check that no silent failure occurred. [2024-10-02T20:53:38.658Z] ====== als (apache-spark) [default], iteration 2 completed (7543.107 ms) ====== [2024-10-02T20:53:38.658Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-10-02T20:53:38.658Z] GC before operation: completed in 98.890 ms, heap usage 519.544 MB -> 59.301 MB. [2024-10-02T20:53:46.718Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:53:46.718Z] There is no way to check that no silent failure occurred. [2024-10-02T20:53:46.718Z] ====== als (apache-spark) [default], iteration 3 completed (7514.531 ms) ====== [2024-10-02T20:53:46.718Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-10-02T20:53:46.718Z] GC before operation: completed in 94.414 ms, heap usage 325.220 MB -> 59.459 MB. [2024-10-02T20:53:54.787Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:53:54.787Z] There is no way to check that no silent failure occurred. [2024-10-02T20:53:54.788Z] ====== als (apache-spark) [default], iteration 4 completed (7525.118 ms) ====== [2024-10-02T20:53:54.788Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-10-02T20:53:54.788Z] GC before operation: completed in 116.135 ms, heap usage 452.461 MB -> 59.987 MB. [2024-10-02T20:54:01.533Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:01.533Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:01.533Z] ====== als (apache-spark) [default], iteration 5 completed (7473.939 ms) ====== [2024-10-02T20:54:01.533Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-10-02T20:54:01.533Z] GC before operation: completed in 106.922 ms, heap usage 625.966 MB -> 60.588 MB. [2024-10-02T20:54:09.657Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:09.657Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:09.657Z] ====== als (apache-spark) [default], iteration 6 completed (7432.173 ms) ====== [2024-10-02T20:54:09.657Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-10-02T20:54:09.657Z] GC before operation: completed in 103.172 ms, heap usage 178.503 MB -> 60.218 MB. [2024-10-02T20:54:17.755Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:17.755Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:17.755Z] ====== als (apache-spark) [default], iteration 7 completed (7422.243 ms) ====== [2024-10-02T20:54:17.755Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-10-02T20:54:17.755Z] GC before operation: completed in 110.148 ms, heap usage 242.033 MB -> 60.552 MB. [2024-10-02T20:54:24.416Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:24.416Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:24.416Z] ====== als (apache-spark) [default], iteration 8 completed (7422.881 ms) ====== [2024-10-02T20:54:24.416Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-10-02T20:54:24.416Z] GC before operation: completed in 108.057 ms, heap usage 362.443 MB -> 61.179 MB. [2024-10-02T20:54:32.478Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:32.478Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:32.478Z] ====== als (apache-spark) [default], iteration 9 completed (7510.501 ms) ====== [2024-10-02T20:54:32.478Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-10-02T20:54:32.478Z] GC before operation: completed in 116.425 ms, heap usage 266.538 MB -> 61.460 MB. [2024-10-02T20:54:40.547Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:40.547Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:40.547Z] ====== als (apache-spark) [default], iteration 10 completed (7539.560 ms) ====== [2024-10-02T20:54:40.547Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-10-02T20:54:40.547Z] GC before operation: completed in 113.417 ms, heap usage 211.440 MB -> 61.607 MB. [2024-10-02T20:54:47.205Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:47.205Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:47.205Z] ====== als (apache-spark) [default], iteration 11 completed (7502.053 ms) ====== [2024-10-02T20:54:47.205Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-10-02T20:54:47.205Z] GC before operation: completed in 114.842 ms, heap usage 525.841 MB -> 62.418 MB. [2024-10-02T20:54:55.284Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:54:55.284Z] There is no way to check that no silent failure occurred. [2024-10-02T20:54:55.284Z] ====== als (apache-spark) [default], iteration 12 completed (7444.753 ms) ====== [2024-10-02T20:54:55.284Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-10-02T20:54:55.284Z] GC before operation: completed in 114.501 ms, heap usage 324.046 MB -> 62.570 MB. [2024-10-02T20:55:03.380Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:03.380Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:03.380Z] ====== als (apache-spark) [default], iteration 13 completed (7462.776 ms) ====== [2024-10-02T20:55:03.380Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-10-02T20:55:03.380Z] GC before operation: completed in 114.940 ms, heap usage 338.961 MB -> 62.922 MB. [2024-10-02T20:55:10.015Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:10.015Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:10.015Z] ====== als (apache-spark) [default], iteration 14 completed (7341.640 ms) ====== [2024-10-02T20:55:10.015Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-10-02T20:55:10.015Z] GC before operation: completed in 108.391 ms, heap usage 195.227 MB -> 63.045 MB. [2024-10-02T20:55:18.106Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:18.106Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:18.106Z] ====== als (apache-spark) [default], iteration 15 completed (7313.195 ms) ====== [2024-10-02T20:55:18.106Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-10-02T20:55:18.106Z] GC before operation: completed in 114.664 ms, heap usage 426.725 MB -> 63.715 MB. [2024-10-02T20:55:24.798Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:24.798Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:24.798Z] ====== als (apache-spark) [default], iteration 16 completed (7252.673 ms) ====== [2024-10-02T20:55:24.798Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-10-02T20:55:24.798Z] GC before operation: completed in 103.033 ms, heap usage 183.487 MB -> 63.665 MB. [2024-10-02T20:55:32.878Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:32.878Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:32.878Z] ====== als (apache-spark) [default], iteration 17 completed (7317.508 ms) ====== [2024-10-02T20:55:32.878Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-10-02T20:55:32.878Z] GC before operation: completed in 102.382 ms, heap usage 352.519 MB -> 64.277 MB. [2024-10-02T20:55:39.522Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:39.522Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:39.522Z] ====== als (apache-spark) [default], iteration 18 completed (7242.719 ms) ====== [2024-10-02T20:55:39.522Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-10-02T20:55:39.522Z] GC before operation: completed in 101.457 ms, heap usage 387.999 MB -> 64.373 MB. [2024-10-02T20:55:47.694Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:47.694Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:47.694Z] ====== als (apache-spark) [default], iteration 19 completed (7182.874 ms) ====== [2024-10-02T20:55:47.694Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-10-02T20:55:47.694Z] GC before operation: completed in 100.959 ms, heap usage 426.084 MB -> 64.806 MB. [2024-10-02T20:55:54.330Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:55:54.330Z] There is no way to check that no silent failure occurred. [2024-10-02T20:55:54.330Z] ====== als (apache-spark) [default], iteration 20 completed (7248.813 ms) ====== [2024-10-02T20:55:54.330Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-10-02T20:55:54.330Z] GC before operation: completed in 100.132 ms, heap usage 315.538 MB -> 64.681 MB. [2024-10-02T20:56:02.435Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:02.435Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:02.435Z] ====== als (apache-spark) [default], iteration 21 completed (7482.388 ms) ====== [2024-10-02T20:56:02.435Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-10-02T20:56:02.435Z] GC before operation: completed in 115.263 ms, heap usage 611.225 MB -> 65.578 MB. [2024-10-02T20:56:11.492Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:11.492Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:11.492Z] ====== als (apache-spark) [default], iteration 22 completed (7230.618 ms) ====== [2024-10-02T20:56:11.492Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-10-02T20:56:11.492Z] GC before operation: completed in 108.786 ms, heap usage 567.628 MB -> 65.633 MB. [2024-10-02T20:56:16.864Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:16.864Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:16.864Z] ====== als (apache-spark) [default], iteration 23 completed (7165.626 ms) ====== [2024-10-02T20:56:16.864Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-10-02T20:56:16.864Z] GC before operation: completed in 103.904 ms, heap usage 441.070 MB -> 65.641 MB. [2024-10-02T20:56:23.499Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:23.499Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:23.499Z] ====== als (apache-spark) [default], iteration 24 completed (7140.780 ms) ====== [2024-10-02T20:56:23.499Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-10-02T20:56:23.499Z] GC before operation: completed in 100.920 ms, heap usage 207.062 MB -> 65.358 MB. [2024-10-02T20:56:31.571Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:31.571Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:31.571Z] ====== als (apache-spark) [default], iteration 25 completed (7146.966 ms) ====== [2024-10-02T20:56:31.571Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-10-02T20:56:31.571Z] GC before operation: completed in 103.813 ms, heap usage 192.598 MB -> 65.442 MB. [2024-10-02T20:56:38.370Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:38.370Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:38.370Z] ====== als (apache-spark) [default], iteration 26 completed (7137.058 ms) ====== [2024-10-02T20:56:38.370Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-10-02T20:56:38.370Z] GC before operation: completed in 105.429 ms, heap usage 225.950 MB -> 65.782 MB. [2024-10-02T20:56:45.003Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:45.003Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:45.003Z] ====== als (apache-spark) [default], iteration 27 completed (7144.697 ms) ====== [2024-10-02T20:56:45.003Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-10-02T20:56:45.003Z] GC before operation: completed in 104.204 ms, heap usage 202.284 MB -> 65.861 MB. [2024-10-02T20:56:53.300Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:53.300Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:53.300Z] ====== als (apache-spark) [default], iteration 28 completed (7143.673 ms) ====== [2024-10-02T20:56:53.300Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-10-02T20:56:53.300Z] GC before operation: completed in 111.508 ms, heap usage 261.398 MB -> 66.372 MB. [2024-10-02T20:56:59.932Z] WARNING: This benchmark provides no result that can be validated. [2024-10-02T20:56:59.932Z] There is no way to check that no silent failure occurred. [2024-10-02T20:56:59.932Z] ====== als (apache-spark) [default], iteration 29 completed (7190.501 ms) ====== [2024-10-02T20:56:59.932Z] ----------------------------------- [2024-10-02T20:56:59.932Z] renaissance-als_0_PASSED [2024-10-02T20:56:59.932Z] ----------------------------------- [2024-10-02T20:56:59.932Z] [2024-10-02T20:56:59.932Z] TEST TEARDOWN: [2024-10-02T20:56:59.932Z] Nothing to be done for teardown. [2024-10-02T20:56:59.932Z] renaissance-als_0 Finish Time: Wed Oct 2 20:56:59 2024 Epoch Time (ms): 1727902619783