[2025-02-07T03:59:49.032Z] Running test renaissance-als_0 ... [2025-02-07T03:59:49.032Z] =============================================== [2025-02-07T03:59:49.343Z] renaissance-als_0 Start Time: Fri Feb 7 03:59:49 2025 Epoch Time (ms): 1738900789083 [2025-02-07T03:59:49.343Z] variation: NoOptions [2025-02-07T03:59:49.343Z] JVM_OPTIONS: [2025-02-07T03:59:49.343Z] { \ [2025-02-07T03:59:49.343Z] echo ""; echo "TEST SETUP:"; \ [2025-02-07T03:59:49.343Z] echo "Nothing to be done for setup."; \ [2025-02-07T03:59:49.343Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17389007255844\\renaissance-als_0"; \ [2025-02-07T03:59:49.343Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17389007255844\\renaissance-als_0"; \ [2025-02-07T03:59:49.343Z] echo ""; echo "TESTING:"; \ [2025-02-07T03:59:49.343Z] "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_17389007255844\\renaissance-als_0"\\als.json" als; \ [2025-02-07T03:59:49.343Z] 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_17389007255844\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-07T03:59:49.343Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-07T03:59:49.343Z] echo "Nothing to be done for teardown."; \ [2025-02-07T03:59:49.343Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17389007255844\\TestTargetResult"; [2025-02-07T03:59:49.671Z] [2025-02-07T03:59:49.671Z] TEST SETUP: [2025-02-07T03:59:49.671Z] Nothing to be done for setup. [2025-02-07T03:59:49.671Z] [2025-02-07T03:59:49.671Z] TESTING: [2025-02-07T04:00:05.332Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-07T04:00:05.332Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-07T04:00:08.204Z] WARNING: An illegal reflective access operation has occurred [2025-02-07T04:00:08.204Z] 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_17389007255844/renaissance-als_0/harness-035950-3227171342842628860/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-07T04:00:08.204Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-07T04:00:08.204Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-07T04:00:08.204Z] WARNING: All illegal access operations will be denied in a future release [2025-02-07T04:00:09.803Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-02-07T04:00:10.112Z] GC before operation: completed in 110.476 ms, heap usage 99.500 MB -> 34.293 MB. [2025-02-07T04:00:43.540Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:00:43.540Z] There is no way to check that no silent failure occurred. [2025-02-07T04:00:43.540Z] ====== als (apache-spark) [default], iteration 0 completed (29513.651 ms) ====== [2025-02-07T04:00:43.540Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-02-07T04:00:43.540Z] GC before operation: completed in 111.598 ms, heap usage 199.747 MB -> 56.369 MB. [2025-02-07T04:00:59.271Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:00:59.271Z] There is no way to check that no silent failure occurred. [2025-02-07T04:00:59.271Z] ====== als (apache-spark) [default], iteration 1 completed (19216.557 ms) ====== [2025-02-07T04:00:59.271Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-02-07T04:00:59.271Z] GC before operation: completed in 139.434 ms, heap usage 194.522 MB -> 58.919 MB. [2025-02-07T04:01:18.217Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:01:18.217Z] There is no way to check that no silent failure occurred. [2025-02-07T04:01:18.217Z] ====== als (apache-spark) [default], iteration 2 completed (17889.984 ms) ====== [2025-02-07T04:01:18.217Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-02-07T04:01:18.217Z] GC before operation: completed in 144.702 ms, heap usage 160.271 MB -> 59.308 MB. [2025-02-07T04:01:37.459Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:01:37.459Z] There is no way to check that no silent failure occurred. [2025-02-07T04:01:37.459Z] ====== als (apache-spark) [default], iteration 3 completed (17532.231 ms) ====== [2025-02-07T04:01:37.459Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-02-07T04:01:37.459Z] GC before operation: completed in 157.391 ms, heap usage 625.133 MB -> 60.392 MB. [2025-02-07T04:01:53.131Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:01:53.131Z] There is no way to check that no silent failure occurred. [2025-02-07T04:01:53.131Z] ====== als (apache-spark) [default], iteration 4 completed (17152.321 ms) ====== [2025-02-07T04:01:53.131Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-02-07T04:01:53.131Z] GC before operation: completed in 136.899 ms, heap usage 202.839 MB -> 60.026 MB. [2025-02-07T04:02:08.853Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:02:08.853Z] There is no way to check that no silent failure occurred. [2025-02-07T04:02:08.853Z] ====== als (apache-spark) [default], iteration 5 completed (16876.580 ms) ====== [2025-02-07T04:02:08.853Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-02-07T04:02:09.195Z] GC before operation: completed in 171.852 ms, heap usage 415.917 MB -> 60.665 MB. [2025-02-07T04:02:28.289Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:02:28.289Z] There is no way to check that no silent failure occurred. [2025-02-07T04:02:28.289Z] ====== als (apache-spark) [default], iteration 6 completed (17340.507 ms) ====== [2025-02-07T04:02:28.289Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-02-07T04:02:28.289Z] GC before operation: completed in 157.980 ms, heap usage 339.185 MB -> 61.013 MB. [2025-02-07T04:02:43.988Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:02:43.988Z] There is no way to check that no silent failure occurred. [2025-02-07T04:02:43.988Z] ====== als (apache-spark) [default], iteration 7 completed (17396.248 ms) ====== [2025-02-07T04:02:43.988Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-02-07T04:02:43.988Z] GC before operation: completed in 137.845 ms, heap usage 358.847 MB -> 61.351 MB. [2025-02-07T04:03:03.062Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:03:03.062Z] There is no way to check that no silent failure occurred. [2025-02-07T04:03:03.062Z] ====== als (apache-spark) [default], iteration 8 completed (18037.083 ms) ====== [2025-02-07T04:03:03.062Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-02-07T04:03:03.062Z] GC before operation: completed in 158.071 ms, heap usage 595.585 MB -> 62.072 MB. [2025-02-07T04:03:22.143Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:03:22.143Z] There is no way to check that no silent failure occurred. [2025-02-07T04:03:22.143Z] ====== als (apache-spark) [default], iteration 9 completed (17586.547 ms) ====== [2025-02-07T04:03:22.143Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-02-07T04:03:22.143Z] GC before operation: completed in 160.856 ms, heap usage 442.718 MB -> 62.131 MB. [2025-02-07T04:03:37.994Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:03:37.994Z] There is no way to check that no silent failure occurred. [2025-02-07T04:03:37.994Z] ====== als (apache-spark) [default], iteration 10 completed (17171.976 ms) ====== [2025-02-07T04:03:37.994Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-02-07T04:03:37.994Z] GC before operation: completed in 162.859 ms, heap usage 507.925 MB -> 62.568 MB. [2025-02-07T04:03:57.168Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:03:57.168Z] There is no way to check that no silent failure occurred. [2025-02-07T04:03:57.168Z] ====== als (apache-spark) [default], iteration 11 completed (16909.788 ms) ====== [2025-02-07T04:03:57.168Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-02-07T04:03:57.168Z] GC before operation: completed in 139.521 ms, heap usage 181.067 MB -> 62.415 MB. [2025-02-07T04:04:12.896Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:04:12.896Z] There is no way to check that no silent failure occurred. [2025-02-07T04:04:12.896Z] ====== als (apache-spark) [default], iteration 12 completed (17190.951 ms) ====== [2025-02-07T04:04:12.896Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-02-07T04:04:12.896Z] GC before operation: completed in 164.599 ms, heap usage 223.907 MB -> 62.923 MB. [2025-02-07T04:04:31.778Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:04:31.778Z] There is no way to check that no silent failure occurred. [2025-02-07T04:04:31.778Z] ====== als (apache-spark) [default], iteration 13 completed (17356.602 ms) ====== [2025-02-07T04:04:31.778Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-02-07T04:04:31.778Z] GC before operation: completed in 144.043 ms, heap usage 306.773 MB -> 63.325 MB. [2025-02-07T04:04:47.396Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:04:47.396Z] There is no way to check that no silent failure occurred. [2025-02-07T04:04:47.396Z] ====== als (apache-spark) [default], iteration 14 completed (17043.678 ms) ====== [2025-02-07T04:04:47.396Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-02-07T04:04:47.396Z] GC before operation: completed in 164.203 ms, heap usage 556.077 MB -> 64.183 MB. [2025-02-07T04:05:03.253Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:05:03.253Z] There is no way to check that no silent failure occurred. [2025-02-07T04:05:03.253Z] ====== als (apache-spark) [default], iteration 15 completed (16630.472 ms) ====== [2025-02-07T04:05:03.253Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-02-07T04:05:03.253Z] GC before operation: completed in 150.900 ms, heap usage 566.307 MB -> 64.482 MB. [2025-02-07T04:05:22.209Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:05:22.209Z] There is no way to check that no silent failure occurred. [2025-02-07T04:05:22.209Z] ====== als (apache-spark) [default], iteration 16 completed (16761.074 ms) ====== [2025-02-07T04:05:22.209Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-02-07T04:05:22.209Z] GC before operation: completed in 149.826 ms, heap usage 522.538 MB -> 64.727 MB. [2025-02-07T04:05:37.958Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:05:37.958Z] There is no way to check that no silent failure occurred. [2025-02-07T04:05:37.958Z] ====== als (apache-spark) [default], iteration 17 completed (16843.639 ms) ====== [2025-02-07T04:05:37.958Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-02-07T04:05:37.958Z] GC before operation: completed in 153.986 ms, heap usage 423.406 MB -> 64.958 MB. [2025-02-07T04:05:56.858Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:05:56.858Z] There is no way to check that no silent failure occurred. [2025-02-07T04:05:56.858Z] ====== als (apache-spark) [default], iteration 18 completed (16881.404 ms) ====== [2025-02-07T04:05:56.858Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-02-07T04:05:56.858Z] GC before operation: completed in 148.710 ms, heap usage 384.492 MB -> 64.884 MB. [2025-02-07T04:06:12.585Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:06:12.585Z] There is no way to check that no silent failure occurred. [2025-02-07T04:06:12.585Z] ====== als (apache-spark) [default], iteration 19 completed (16901.930 ms) ====== [2025-02-07T04:06:12.585Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-02-07T04:06:12.585Z] GC before operation: completed in 153.595 ms, heap usage 528.036 MB -> 65.481 MB. [2025-02-07T04:06:28.594Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:06:28.594Z] There is no way to check that no silent failure occurred. [2025-02-07T04:06:28.594Z] ====== als (apache-spark) [default], iteration 20 completed (16834.447 ms) ====== [2025-02-07T04:06:28.594Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-02-07T04:06:28.594Z] GC before operation: completed in 160.598 ms, heap usage 473.251 MB -> 65.496 MB. [2025-02-07T04:06:47.783Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:06:47.783Z] There is no way to check that no silent failure occurred. [2025-02-07T04:06:47.783Z] ====== als (apache-spark) [default], iteration 21 completed (16959.122 ms) ====== [2025-02-07T04:06:47.783Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-02-07T04:06:47.783Z] GC before operation: completed in 168.288 ms, heap usage 169.580 MB -> 65.351 MB. [2025-02-07T04:07:03.609Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:07:03.609Z] There is no way to check that no silent failure occurred. [2025-02-07T04:07:03.609Z] ====== als (apache-spark) [default], iteration 22 completed (16851.776 ms) ====== [2025-02-07T04:07:03.609Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-02-07T04:07:03.609Z] GC before operation: completed in 140.912 ms, heap usage 417.764 MB -> 65.814 MB. [2025-02-07T04:07:19.512Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:07:19.512Z] There is no way to check that no silent failure occurred. [2025-02-07T04:07:19.512Z] ====== als (apache-spark) [default], iteration 23 completed (16585.075 ms) ====== [2025-02-07T04:07:19.512Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-02-07T04:07:19.512Z] GC before operation: completed in 145.954 ms, heap usage 232.818 MB -> 65.896 MB. [2025-02-07T04:07:38.621Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:07:38.621Z] There is no way to check that no silent failure occurred. [2025-02-07T04:07:38.621Z] ====== als (apache-spark) [default], iteration 24 completed (16522.597 ms) ====== [2025-02-07T04:07:38.621Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-02-07T04:07:38.621Z] GC before operation: completed in 158.345 ms, heap usage 538.597 MB -> 66.423 MB. [2025-02-07T04:07:54.409Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:07:54.409Z] There is no way to check that no silent failure occurred. [2025-02-07T04:07:54.409Z] ====== als (apache-spark) [default], iteration 25 completed (17082.225 ms) ====== [2025-02-07T04:07:54.409Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-02-07T04:07:54.409Z] GC before operation: completed in 163.184 ms, heap usage 501.644 MB -> 66.495 MB. [2025-02-07T04:08:10.336Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:08:10.336Z] There is no way to check that no silent failure occurred. [2025-02-07T04:08:10.336Z] ====== als (apache-spark) [default], iteration 26 completed (16910.531 ms) ====== [2025-02-07T04:08:10.336Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-02-07T04:08:10.336Z] GC before operation: completed in 160.706 ms, heap usage 582.068 MB -> 66.861 MB. [2025-02-07T04:08:29.366Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:08:29.366Z] There is no way to check that no silent failure occurred. [2025-02-07T04:08:29.366Z] ====== als (apache-spark) [default], iteration 27 completed (16842.247 ms) ====== [2025-02-07T04:08:29.366Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-02-07T04:08:29.366Z] GC before operation: completed in 146.262 ms, heap usage 480.622 MB -> 66.917 MB. [2025-02-07T04:08:45.093Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:08:45.093Z] There is no way to check that no silent failure occurred. [2025-02-07T04:08:45.093Z] ====== als (apache-spark) [default], iteration 28 completed (16598.036 ms) ====== [2025-02-07T04:08:45.093Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-02-07T04:08:45.093Z] GC before operation: completed in 141.958 ms, heap usage 156.582 MB -> 66.694 MB. [2025-02-07T04:09:00.969Z] WARNING: This benchmark provides no result that can be validated. [2025-02-07T04:09:00.969Z] There is no way to check that no silent failure occurred. [2025-02-07T04:09:00.969Z] ====== als (apache-spark) [default], iteration 29 completed (16430.931 ms) ====== [2025-02-07T04:09:01.292Z] ----------------------------------- [2025-02-07T04:09:01.292Z] renaissance-als_0_PASSED [2025-02-07T04:09:01.292Z] ----------------------------------- [2025-02-07T04:09:01.292Z] [2025-02-07T04:09:01.292Z] TEST TEARDOWN: [2025-02-07T04:09:01.292Z] Nothing to be done for teardown. [2025-02-07T04:09:01.292Z] renaissance-als_0 Finish Time: Fri Feb 7 04:09:01 2025 Epoch Time (ms): 1738901341258