[2025-02-05T23:47:20.419Z] Running test renaissance-als_0 ... [2025-02-05T23:47:20.419Z] =============================================== [2025-02-05T23:47:20.419Z] renaissance-als_0 Start Time: Wed Feb 5 23:47:20 2025 Epoch Time (ms): 1738799240075 [2025-02-05T23:47:20.419Z] variation: NoOptions [2025-02-05T23:47:20.419Z] JVM_OPTIONS: [2025-02-05T23:47:20.419Z] { \ [2025-02-05T23:47:20.419Z] echo ""; echo "TEST SETUP:"; \ [2025-02-05T23:47:20.419Z] echo "Nothing to be done for setup."; \ [2025-02-05T23:47:20.419Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17387991961701/renaissance-als_0"; \ [2025-02-05T23:47:20.419Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17387991961701/renaissance-als_0"; \ [2025-02-05T23:47:20.419Z] echo ""; echo "TESTING:"; \ [2025-02-05T23:47:20.419Z] "/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_17387991961701/renaissance-als_0"/als.json" als; \ [2025-02-05T23:47:20.419Z] 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_17387991961701/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-05T23:47:20.419Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-05T23:47:20.419Z] echo "Nothing to be done for teardown."; \ [2025-02-05T23:47:20.419Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17387991961701/TestTargetResult"; [2025-02-05T23:47:20.419Z] [2025-02-05T23:47:20.419Z] TEST SETUP: [2025-02-05T23:47:20.419Z] Nothing to be done for setup. [2025-02-05T23:47:20.419Z] [2025-02-05T23:47:20.419Z] TESTING: [2025-02-05T23:47:25.274Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-05T23:47:25.274Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-05T23:47:29.430Z] WARNING: An illegal reflective access operation has occurred [2025-02-05T23:47:29.430Z] 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_17387991961701/renaissance-als_0/harness-234720-14718181237037510851/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-05T23:47:29.430Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-05T23:47:29.430Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-05T23:47:29.430Z] WARNING: All illegal access operations will be denied in a future release [2025-02-05T23:47:31.382Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-02-05T23:47:31.383Z] GC before operation: completed in 54.826 ms, heap usage 85.502 MB -> 33.798 MB. [2025-02-05T23:47:49.781Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:47:49.781Z] There is no way to check that no silent failure occurred. [2025-02-05T23:47:49.781Z] ====== als (apache-spark) [default], iteration 0 completed (17688.883 ms) ====== [2025-02-05T23:47:49.781Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-02-05T23:47:49.781Z] GC before operation: completed in 95.422 ms, heap usage 334.091 MB -> 56.080 MB. [2025-02-05T23:47:57.934Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:47:57.934Z] There is no way to check that no silent failure occurred. [2025-02-05T23:47:57.934Z] ====== als (apache-spark) [default], iteration 1 completed (8396.001 ms) ====== [2025-02-05T23:47:57.934Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-02-05T23:47:57.934Z] GC before operation: completed in 109.208 ms, heap usage 512.945 MB -> 58.903 MB. [2025-02-05T23:48:06.089Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:06.089Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:06.089Z] ====== als (apache-spark) [default], iteration 2 completed (8028.753 ms) ====== [2025-02-05T23:48:06.089Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-02-05T23:48:06.089Z] GC before operation: completed in 102.404 ms, heap usage 329.332 MB -> 59.048 MB. [2025-02-05T23:48:12.807Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:12.807Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:12.807Z] ====== als (apache-spark) [default], iteration 3 completed (7847.661 ms) ====== [2025-02-05T23:48:12.807Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-02-05T23:48:13.760Z] GC before operation: completed in 102.108 ms, heap usage 132.393 MB -> 59.139 MB. [2025-02-05T23:48:21.933Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:21.933Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:21.933Z] ====== als (apache-spark) [default], iteration 4 completed (7693.771 ms) ====== [2025-02-05T23:48:21.933Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-02-05T23:48:21.933Z] GC before operation: completed in 117.751 ms, heap usage 445.638 MB -> 59.903 MB. [2025-02-05T23:48:28.623Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:28.623Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:28.623Z] ====== als (apache-spark) [default], iteration 5 completed (7709.945 ms) ====== [2025-02-05T23:48:28.623Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-02-05T23:48:28.623Z] GC before operation: completed in 140.180 ms, heap usage 441.725 MB -> 60.145 MB. [2025-02-05T23:48:36.767Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:36.767Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:36.767Z] ====== als (apache-spark) [default], iteration 6 completed (7763.084 ms) ====== [2025-02-05T23:48:36.767Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-02-05T23:48:36.767Z] GC before operation: completed in 117.526 ms, heap usage 192.134 MB -> 60.257 MB. [2025-02-05T23:48:44.185Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:44.185Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:44.185Z] ====== als (apache-spark) [default], iteration 7 completed (7721.629 ms) ====== [2025-02-05T23:48:44.185Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-02-05T23:48:45.138Z] GC before operation: completed in 129.492 ms, heap usage 312.124 MB -> 60.776 MB. [2025-02-05T23:48:53.298Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:48:53.298Z] There is no way to check that no silent failure occurred. [2025-02-05T23:48:53.298Z] ====== als (apache-spark) [default], iteration 8 completed (7619.661 ms) ====== [2025-02-05T23:48:53.298Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-02-05T23:48:53.298Z] GC before operation: completed in 113.353 ms, heap usage 427.912 MB -> 61.225 MB. [2025-02-05T23:49:00.006Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:00.006Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:00.006Z] ====== als (apache-spark) [default], iteration 9 completed (7639.361 ms) ====== [2025-02-05T23:49:00.006Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-02-05T23:49:00.006Z] GC before operation: completed in 119.051 ms, heap usage 475.942 MB -> 61.715 MB. [2025-02-05T23:49:08.140Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:08.140Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:08.140Z] ====== als (apache-spark) [default], iteration 10 completed (7742.362 ms) ====== [2025-02-05T23:49:08.140Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-02-05T23:49:08.140Z] GC before operation: completed in 102.596 ms, heap usage 538.909 MB -> 62.082 MB. [2025-02-05T23:49:16.362Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:16.362Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:16.362Z] ====== als (apache-spark) [default], iteration 11 completed (7451.804 ms) ====== [2025-02-05T23:49:16.362Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-02-05T23:49:16.362Z] GC before operation: completed in 105.077 ms, heap usage 388.698 MB -> 62.224 MB. [2025-02-05T23:49:23.066Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:23.066Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:23.066Z] ====== als (apache-spark) [default], iteration 12 completed (7418.361 ms) ====== [2025-02-05T23:49:23.066Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-02-05T23:49:23.066Z] GC before operation: completed in 101.856 ms, heap usage 233.259 MB -> 62.365 MB. [2025-02-05T23:49:31.211Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:31.211Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:31.211Z] ====== als (apache-spark) [default], iteration 13 completed (7401.646 ms) ====== [2025-02-05T23:49:31.211Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-02-05T23:49:31.211Z] GC before operation: completed in 100.491 ms, heap usage 367.571 MB -> 62.980 MB. [2025-02-05T23:49:37.919Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:37.919Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:37.919Z] ====== als (apache-spark) [default], iteration 14 completed (7310.722 ms) ====== [2025-02-05T23:49:37.919Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-02-05T23:49:37.919Z] GC before operation: completed in 109.127 ms, heap usage 285.386 MB -> 63.248 MB. [2025-02-05T23:49:46.168Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:46.168Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:46.168Z] ====== als (apache-spark) [default], iteration 15 completed (7355.024 ms) ====== [2025-02-05T23:49:46.168Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-02-05T23:49:46.168Z] GC before operation: completed in 100.230 ms, heap usage 547.027 MB -> 64.016 MB. [2025-02-05T23:49:52.873Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:49:52.873Z] There is no way to check that no silent failure occurred. [2025-02-05T23:49:52.873Z] ====== als (apache-spark) [default], iteration 16 completed (7519.127 ms) ====== [2025-02-05T23:49:52.873Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-02-05T23:49:52.873Z] GC before operation: completed in 99.324 ms, heap usage 384.870 MB -> 63.949 MB. [2025-02-05T23:50:00.267Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:00.267Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:00.267Z] ====== als (apache-spark) [default], iteration 17 completed (7221.245 ms) ====== [2025-02-05T23:50:00.267Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-02-05T23:50:00.267Z] GC before operation: completed in 108.658 ms, heap usage 454.138 MB -> 64.593 MB. [2025-02-05T23:50:08.425Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:08.425Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:08.425Z] ====== als (apache-spark) [default], iteration 18 completed (7359.441 ms) ====== [2025-02-05T23:50:08.425Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-02-05T23:50:08.425Z] GC before operation: completed in 110.498 ms, heap usage 268.995 MB -> 64.364 MB. [2025-02-05T23:50:15.116Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:15.116Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:15.116Z] ====== als (apache-spark) [default], iteration 19 completed (7374.706 ms) ====== [2025-02-05T23:50:15.116Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-02-05T23:50:15.116Z] GC before operation: completed in 115.553 ms, heap usage 432.432 MB -> 64.725 MB. [2025-02-05T23:50:23.263Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:23.263Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:23.263Z] ====== als (apache-spark) [default], iteration 20 completed (7279.155 ms) ====== [2025-02-05T23:50:23.263Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-02-05T23:50:23.263Z] GC before operation: completed in 104.840 ms, heap usage 526.451 MB -> 65.132 MB. [2025-02-05T23:50:29.958Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:29.958Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:29.958Z] ====== als (apache-spark) [default], iteration 21 completed (7513.762 ms) ====== [2025-02-05T23:50:29.958Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-02-05T23:50:30.910Z] GC before operation: completed in 108.616 ms, heap usage 182.703 MB -> 64.910 MB. [2025-02-05T23:50:37.630Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:37.630Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:37.630Z] ====== als (apache-spark) [default], iteration 22 completed (7325.009 ms) ====== [2025-02-05T23:50:37.630Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-02-05T23:50:37.630Z] GC before operation: completed in 113.462 ms, heap usage 293.713 MB -> 65.119 MB. [2025-02-05T23:50:45.802Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:45.802Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:45.802Z] ====== als (apache-spark) [default], iteration 23 completed (7286.218 ms) ====== [2025-02-05T23:50:45.802Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-02-05T23:50:45.802Z] GC before operation: completed in 111.727 ms, heap usage 401.775 MB -> 65.549 MB. [2025-02-05T23:50:52.492Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:50:52.492Z] There is no way to check that no silent failure occurred. [2025-02-05T23:50:52.492Z] ====== als (apache-spark) [default], iteration 24 completed (7494.831 ms) ====== [2025-02-05T23:50:52.492Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-02-05T23:50:52.492Z] GC before operation: completed in 111.678 ms, heap usage 200.393 MB -> 65.361 MB. [2025-02-05T23:51:00.650Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:51:00.650Z] There is no way to check that no silent failure occurred. [2025-02-05T23:51:00.650Z] ====== als (apache-spark) [default], iteration 25 completed (7398.785 ms) ====== [2025-02-05T23:51:00.650Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-02-05T23:51:00.650Z] GC before operation: completed in 137.941 ms, heap usage 400.867 MB -> 65.719 MB. [2025-02-05T23:51:08.795Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:51:08.795Z] There is no way to check that no silent failure occurred. [2025-02-05T23:51:08.795Z] ====== als (apache-spark) [default], iteration 26 completed (7414.811 ms) ====== [2025-02-05T23:51:08.795Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-02-05T23:51:08.795Z] GC before operation: completed in 119.206 ms, heap usage 313.737 MB -> 65.966 MB. [2025-02-05T23:51:15.752Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:51:15.752Z] There is no way to check that no silent failure occurred. [2025-02-05T23:51:15.752Z] ====== als (apache-spark) [default], iteration 27 completed (7281.988 ms) ====== [2025-02-05T23:51:15.752Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-02-05T23:51:15.752Z] GC before operation: completed in 121.053 ms, heap usage 187.479 MB -> 66.063 MB. [2025-02-05T23:51:22.443Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:51:22.443Z] There is no way to check that no silent failure occurred. [2025-02-05T23:51:22.443Z] ====== als (apache-spark) [default], iteration 28 completed (7377.534 ms) ====== [2025-02-05T23:51:22.443Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-02-05T23:51:22.443Z] GC before operation: completed in 114.464 ms, heap usage 418.101 MB -> 66.475 MB. [2025-02-05T23:51:30.608Z] WARNING: This benchmark provides no result that can be validated. [2025-02-05T23:51:30.608Z] There is no way to check that no silent failure occurred. [2025-02-05T23:51:30.608Z] ====== als (apache-spark) [default], iteration 29 completed (7184.234 ms) ====== [2025-02-05T23:51:30.608Z] ----------------------------------- [2025-02-05T23:51:30.608Z] renaissance-als_0_PASSED [2025-02-05T23:51:30.608Z] ----------------------------------- [2025-02-05T23:51:30.608Z] [2025-02-05T23:51:30.608Z] TEST TEARDOWN: [2025-02-05T23:51:30.608Z] Nothing to be done for teardown. [2025-02-05T23:51:30.608Z] renaissance-als_0 Finish Time: Wed Feb 5 23:51:29 2025 Epoch Time (ms): 1738799489908