[2024-10-03T08:10:33.388Z] Running test renaissance-als_0 ... [2024-10-03T08:10:33.388Z] =============================================== [2024-10-03T08:10:33.388Z] renaissance-als_0 Start Time: Thu Oct 3 08:10:33 2024 Epoch Time (ms): 1727943033288 [2024-10-03T08:10:33.388Z] variation: NoOptions [2024-10-03T08:10:33.709Z] JVM_OPTIONS: [2024-10-03T08:10:33.709Z] { \ [2024-10-03T08:10:33.709Z] echo ""; echo "TEST SETUP:"; \ [2024-10-03T08:10:33.709Z] echo "Nothing to be done for setup."; \ [2024-10-03T08:10:33.709Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17279429786926\\renaissance-als_0"; \ [2024-10-03T08:10:33.709Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17279429786926\\renaissance-als_0"; \ [2024-10-03T08:10:33.709Z] echo ""; echo "TESTING:"; \ [2024-10-03T08:10:33.709Z] "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_17279429786926\\renaissance-als_0"\\als.json" als; \ [2024-10-03T08:10:33.709Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_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_17279429786926\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-03T08:10:33.709Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-03T08:10:33.709Z] echo "Nothing to be done for teardown."; \ [2024-10-03T08:10:33.709Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17279429786926\\TestTargetResult"; [2024-10-03T08:10:33.709Z] [2024-10-03T08:10:33.709Z] TEST SETUP: [2024-10-03T08:10:33.709Z] Nothing to be done for setup. [2024-10-03T08:10:33.709Z] [2024-10-03T08:10:33.709Z] TESTING: [2024-10-03T08:10:44.383Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-03T08:10:45.987Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-10-03T08:10:48.881Z] WARNING: An illegal reflective access operation has occurred [2024-10-03T08:10:48.882Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17279429786926/renaissance-als_0/harness-081034-10011161397768928193/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-03T08:10:48.882Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-03T08:10:48.882Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-03T08:10:48.882Z] WARNING: All illegal access operations will be denied in a future release [2024-10-03T08:10:50.480Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-10-03T08:10:50.480Z] GC before operation: completed in 82.415 ms, heap usage 99.002 MB -> 34.299 MB. [2024-10-03T08:11:18.552Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:11:18.552Z] There is no way to check that no silent failure occurred. [2024-10-03T08:11:18.552Z] ====== als (apache-spark) [default], iteration 0 completed (26321.522 ms) ====== [2024-10-03T08:11:18.552Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-10-03T08:11:18.552Z] GC before operation: completed in 107.532 ms, heap usage 178.846 MB -> 56.378 MB. [2024-10-03T08:11:34.411Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:11:34.411Z] There is no way to check that no silent failure occurred. [2024-10-03T08:11:34.411Z] ====== als (apache-spark) [default], iteration 1 completed (16580.539 ms) ====== [2024-10-03T08:11:34.411Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-10-03T08:11:34.411Z] GC before operation: completed in 129.284 ms, heap usage 270.045 MB -> 59.246 MB. [2024-10-03T08:11:50.189Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:11:50.189Z] There is no way to check that no silent failure occurred. [2024-10-03T08:11:50.189Z] ====== als (apache-spark) [default], iteration 2 completed (16018.950 ms) ====== [2024-10-03T08:11:50.189Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-10-03T08:11:50.189Z] GC before operation: completed in 129.824 ms, heap usage 414.066 MB -> 59.869 MB. [2024-10-03T08:12:06.053Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:12:06.054Z] There is no way to check that no silent failure occurred. [2024-10-03T08:12:06.054Z] ====== als (apache-spark) [default], iteration 3 completed (15795.459 ms) ====== [2024-10-03T08:12:06.054Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-10-03T08:12:06.054Z] GC before operation: completed in 130.233 ms, heap usage 429.963 MB -> 59.945 MB. [2024-10-03T08:12:22.134Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:12:22.134Z] There is no way to check that no silent failure occurred. [2024-10-03T08:12:22.134Z] ====== als (apache-spark) [default], iteration 4 completed (15902.511 ms) ====== [2024-10-03T08:12:22.134Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-10-03T08:12:22.134Z] GC before operation: completed in 134.154 ms, heap usage 252.874 MB -> 60.069 MB. [2024-10-03T08:12:38.095Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:12:38.095Z] There is no way to check that no silent failure occurred. [2024-10-03T08:12:38.095Z] ====== als (apache-spark) [default], iteration 5 completed (15425.563 ms) ====== [2024-10-03T08:12:38.095Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-10-03T08:12:38.095Z] GC before operation: completed in 127.165 ms, heap usage 543.355 MB -> 60.918 MB. [2024-10-03T08:12:53.831Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:12:53.831Z] There is no way to check that no silent failure occurred. [2024-10-03T08:12:53.831Z] ====== als (apache-spark) [default], iteration 6 completed (15685.248 ms) ====== [2024-10-03T08:12:53.831Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-10-03T08:12:53.831Z] GC before operation: completed in 127.878 ms, heap usage 366.599 MB -> 61.014 MB. [2024-10-03T08:13:09.660Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:13:09.660Z] There is no way to check that no silent failure occurred. [2024-10-03T08:13:09.660Z] ====== als (apache-spark) [default], iteration 7 completed (15648.976 ms) ====== [2024-10-03T08:13:09.660Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-10-03T08:13:09.660Z] GC before operation: completed in 120.046 ms, heap usage 479.241 MB -> 61.453 MB. [2024-10-03T08:13:25.366Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:13:25.366Z] There is no way to check that no silent failure occurred. [2024-10-03T08:13:25.366Z] ====== als (apache-spark) [default], iteration 8 completed (15895.467 ms) ====== [2024-10-03T08:13:25.366Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-10-03T08:13:25.366Z] GC before operation: completed in 142.186 ms, heap usage 276.388 MB -> 61.593 MB. [2024-10-03T08:13:41.151Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:13:41.151Z] There is no way to check that no silent failure occurred. [2024-10-03T08:13:41.151Z] ====== als (apache-spark) [default], iteration 9 completed (15338.960 ms) ====== [2024-10-03T08:13:41.151Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-10-03T08:13:41.151Z] GC before operation: completed in 115.580 ms, heap usage 401.388 MB -> 62.179 MB. [2024-10-03T08:13:56.881Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:13:56.881Z] There is no way to check that no silent failure occurred. [2024-10-03T08:13:56.881Z] ====== als (apache-spark) [default], iteration 10 completed (15406.140 ms) ====== [2024-10-03T08:13:56.881Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-10-03T08:13:56.881Z] GC before operation: completed in 133.233 ms, heap usage 230.624 MB -> 62.090 MB. [2024-10-03T08:14:12.770Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:14:12.770Z] There is no way to check that no silent failure occurred. [2024-10-03T08:14:12.770Z] ====== als (apache-spark) [default], iteration 11 completed (15738.046 ms) ====== [2024-10-03T08:14:12.770Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-10-03T08:14:12.770Z] GC before operation: completed in 141.760 ms, heap usage 592.348 MB -> 62.906 MB. [2024-10-03T08:14:28.653Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:14:28.653Z] There is no way to check that no silent failure occurred. [2024-10-03T08:14:28.653Z] ====== als (apache-spark) [default], iteration 12 completed (15234.873 ms) ====== [2024-10-03T08:14:28.653Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-10-03T08:14:28.653Z] GC before operation: completed in 135.142 ms, heap usage 464.163 MB -> 63.155 MB. [2024-10-03T08:14:44.422Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:14:44.422Z] There is no way to check that no silent failure occurred. [2024-10-03T08:14:44.422Z] ====== als (apache-spark) [default], iteration 13 completed (14995.920 ms) ====== [2024-10-03T08:14:44.422Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-10-03T08:14:44.422Z] GC before operation: completed in 155.932 ms, heap usage 379.178 MB -> 63.471 MB. [2024-10-03T08:14:57.946Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:14:57.946Z] There is no way to check that no silent failure occurred. [2024-10-03T08:14:57.946Z] ====== als (apache-spark) [default], iteration 14 completed (15181.613 ms) ====== [2024-10-03T08:14:57.946Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-10-03T08:14:57.946Z] GC before operation: completed in 140.594 ms, heap usage 461.577 MB -> 63.986 MB. [2024-10-03T08:15:13.714Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:15:13.714Z] There is no way to check that no silent failure occurred. [2024-10-03T08:15:13.714Z] ====== als (apache-spark) [default], iteration 15 completed (15501.699 ms) ====== [2024-10-03T08:15:13.714Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-10-03T08:15:13.714Z] GC before operation: completed in 123.817 ms, heap usage 204.519 MB -> 63.890 MB. [2024-10-03T08:15:29.485Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:15:29.485Z] There is no way to check that no silent failure occurred. [2024-10-03T08:15:29.485Z] ====== als (apache-spark) [default], iteration 16 completed (15186.888 ms) ====== [2024-10-03T08:15:29.485Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-10-03T08:15:29.485Z] GC before operation: completed in 123.924 ms, heap usage 395.353 MB -> 64.439 MB. [2024-10-03T08:15:45.274Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:15:45.274Z] There is no way to check that no silent failure occurred. [2024-10-03T08:15:45.274Z] ====== als (apache-spark) [default], iteration 17 completed (15152.447 ms) ====== [2024-10-03T08:15:45.274Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-10-03T08:15:45.274Z] GC before operation: completed in 127.179 ms, heap usage 208.817 MB -> 64.488 MB. [2024-10-03T08:16:00.983Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:16:00.983Z] There is no way to check that no silent failure occurred. [2024-10-03T08:16:00.983Z] ====== als (apache-spark) [default], iteration 18 completed (15199.453 ms) ====== [2024-10-03T08:16:00.983Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-10-03T08:16:00.983Z] GC before operation: completed in 126.238 ms, heap usage 324.800 MB -> 64.764 MB. [2024-10-03T08:16:16.695Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:16:16.695Z] There is no way to check that no silent failure occurred. [2024-10-03T08:16:16.695Z] ====== als (apache-spark) [default], iteration 19 completed (15410.740 ms) ====== [2024-10-03T08:16:16.695Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-10-03T08:16:16.695Z] GC before operation: completed in 122.371 ms, heap usage 384.604 MB -> 65.327 MB. [2024-10-03T08:16:32.324Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:16:32.324Z] There is no way to check that no silent failure occurred. [2024-10-03T08:16:32.324Z] ====== als (apache-spark) [default], iteration 20 completed (15395.516 ms) ====== [2024-10-03T08:16:32.324Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-10-03T08:16:32.324Z] GC before operation: completed in 177.671 ms, heap usage 385.585 MB -> 65.374 MB. [2024-10-03T08:16:48.055Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:16:48.055Z] There is no way to check that no silent failure occurred. [2024-10-03T08:16:48.055Z] ====== als (apache-spark) [default], iteration 21 completed (15896.520 ms) ====== [2024-10-03T08:16:48.055Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-10-03T08:16:48.055Z] GC before operation: completed in 121.913 ms, heap usage 395.290 MB -> 65.634 MB. [2024-10-03T08:17:03.772Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:17:03.772Z] There is no way to check that no silent failure occurred. [2024-10-03T08:17:03.772Z] ====== als (apache-spark) [default], iteration 22 completed (15499.604 ms) ====== [2024-10-03T08:17:03.772Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-10-03T08:17:03.772Z] GC before operation: completed in 122.618 ms, heap usage 312.650 MB -> 65.692 MB. [2024-10-03T08:17:19.449Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:17:19.449Z] There is no way to check that no silent failure occurred. [2024-10-03T08:17:19.449Z] ====== als (apache-spark) [default], iteration 23 completed (15338.227 ms) ====== [2024-10-03T08:17:19.449Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-10-03T08:17:19.449Z] GC before operation: completed in 128.068 ms, heap usage 346.704 MB -> 66.048 MB. [2024-10-03T08:17:35.217Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:17:35.217Z] There is no way to check that no silent failure occurred. [2024-10-03T08:17:35.217Z] ====== als (apache-spark) [default], iteration 24 completed (15597.735 ms) ====== [2024-10-03T08:17:35.217Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-10-03T08:17:35.217Z] GC before operation: completed in 148.294 ms, heap usage 545.771 MB -> 66.353 MB. [2024-10-03T08:17:50.985Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:17:50.985Z] There is no way to check that no silent failure occurred. [2024-10-03T08:17:50.985Z] ====== als (apache-spark) [default], iteration 25 completed (15673.755 ms) ====== [2024-10-03T08:17:50.985Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-10-03T08:17:50.985Z] GC before operation: completed in 125.216 ms, heap usage 412.200 MB -> 66.242 MB. [2024-10-03T08:18:06.627Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:18:06.627Z] There is no way to check that no silent failure occurred. [2024-10-03T08:18:06.627Z] ====== als (apache-spark) [default], iteration 26 completed (15400.951 ms) ====== [2024-10-03T08:18:06.627Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-10-03T08:18:06.627Z] GC before operation: completed in 125.174 ms, heap usage 365.982 MB -> 66.641 MB. [2024-10-03T08:18:22.445Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:18:22.445Z] There is no way to check that no silent failure occurred. [2024-10-03T08:18:22.445Z] ====== als (apache-spark) [default], iteration 27 completed (15332.782 ms) ====== [2024-10-03T08:18:22.445Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-10-03T08:18:22.445Z] GC before operation: completed in 122.801 ms, heap usage 384.563 MB -> 66.655 MB. [2024-10-03T08:18:35.544Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:18:35.544Z] There is no way to check that no silent failure occurred. [2024-10-03T08:18:35.544Z] ====== als (apache-spark) [default], iteration 28 completed (15107.925 ms) ====== [2024-10-03T08:18:35.544Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-10-03T08:18:35.544Z] GC before operation: completed in 131.154 ms, heap usage 215.410 MB -> 66.769 MB. [2024-10-03T08:18:51.288Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T08:18:51.288Z] There is no way to check that no silent failure occurred. [2024-10-03T08:18:51.288Z] ====== als (apache-spark) [default], iteration 29 completed (15221.981 ms) ====== [2024-10-03T08:18:51.288Z] ----------------------------------- [2024-10-03T08:18:51.288Z] renaissance-als_0_PASSED [2024-10-03T08:18:51.288Z] ----------------------------------- [2024-10-03T08:18:51.599Z] [2024-10-03T08:18:51.599Z] TEST TEARDOWN: [2024-10-03T08:18:51.599Z] Nothing to be done for teardown. [2024-10-03T08:18:51.599Z] renaissance-als_0 Finish Time: Thu Oct 3 08:18:51 2024 Epoch Time (ms): 1727943531452