[2025-01-22T04:46:19.300Z] Running test renaissance-als_0 ... [2025-01-22T04:46:19.300Z] =============================================== [2025-01-22T04:46:19.300Z] renaissance-als_0 Start Time: Tue Jan 21 22:46:19 2025 Epoch Time (ms): 1737521179345 [2025-01-22T04:46:19.300Z] variation: NoOptions [2025-01-22T04:46:19.300Z] JVM_OPTIONS: [2025-01-22T04:46:19.300Z] { \ [2025-01-22T04:46:19.300Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T04:46:19.300Z] echo "Nothing to be done for setup."; \ [2025-01-22T04:46:19.300Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17375211786911/renaissance-als_0"; \ [2025-01-22T04:46:19.300Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17375211786911/renaissance-als_0"; \ [2025-01-22T04:46:19.300Z] echo ""; echo "TESTING:"; \ [2025-01-22T04:46:19.300Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_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_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17375211786911/renaissance-als_0"/als.json" als; \ [2025-01-22T04:46:19.300Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17375211786911/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T04:46:19.300Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T04:46:19.300Z] echo "Nothing to be done for teardown."; \ [2025-01-22T04:46:19.300Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17375211786911/TestTargetResult"; [2025-01-22T04:46:19.300Z] [2025-01-22T04:46:19.300Z] TEST SETUP: [2025-01-22T04:46:19.300Z] Nothing to be done for setup. [2025-01-22T04:46:19.300Z] [2025-01-22T04:46:19.300Z] TESTING: [2025-01-22T04:46:22.387Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-22T04:46:23.791Z] NOTE: 'als' benchmark uses Spark local executor with 8 (out of 8) threads. [2025-01-22T04:46:26.870Z] WARNING: An illegal reflective access operation has occurred [2025-01-22T04:46:26.870Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17375211786911/renaissance-als_0/harness-224620-8983684101769588695/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-01-22T04:46:26.870Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-01-22T04:46:26.870Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-01-22T04:46:26.870Z] WARNING: All illegal access operations will be denied in a future release [2025-01-22T04:46:29.085Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-01-22T04:46:29.085Z] GC before operation: completed in 103.904 ms, heap usage 108.509 MB -> 34.493 MB. [2025-01-22T04:46:44.281Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:46:44.281Z] There is no way to check that no silent failure occurred. [2025-01-22T04:46:44.281Z] ====== als (apache-spark) [default], iteration 0 completed (13932.733 ms) ====== [2025-01-22T04:46:44.281Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-01-22T04:46:44.281Z] GC before operation: completed in 140.733 ms, heap usage 584.659 MB -> 57.070 MB. [2025-01-22T04:46:49.410Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:46:49.410Z] There is no way to check that no silent failure occurred. [2025-01-22T04:46:49.410Z] ====== als (apache-spark) [default], iteration 1 completed (6697.299 ms) ====== [2025-01-22T04:46:49.410Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-01-22T04:46:50.089Z] GC before operation: completed in 211.646 ms, heap usage 702.542 MB -> 59.850 MB. [2025-01-22T04:46:56.425Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:46:56.425Z] There is no way to check that no silent failure occurred. [2025-01-22T04:46:56.425Z] ====== als (apache-spark) [default], iteration 2 completed (6066.980 ms) ====== [2025-01-22T04:46:56.425Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-01-22T04:46:56.425Z] GC before operation: completed in 169.652 ms, heap usage 201.578 MB -> 59.628 MB. [2025-01-22T04:47:02.773Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:02.773Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:02.773Z] ====== als (apache-spark) [default], iteration 3 completed (6158.339 ms) ====== [2025-01-22T04:47:02.773Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-01-22T04:47:02.773Z] GC before operation: completed in 193.483 ms, heap usage 388.659 MB -> 60.170 MB. [2025-01-22T04:47:09.093Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:09.093Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:09.093Z] ====== als (apache-spark) [default], iteration 4 completed (5931.126 ms) ====== [2025-01-22T04:47:09.093Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-01-22T04:47:09.093Z] GC before operation: completed in 171.879 ms, heap usage 707.747 MB -> 60.916 MB. [2025-01-22T04:47:14.177Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:14.177Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:14.177Z] ====== als (apache-spark) [default], iteration 5 completed (5524.037 ms) ====== [2025-01-22T04:47:14.177Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-01-22T04:47:14.177Z] GC before operation: completed in 208.811 ms, heap usage 893.625 MB -> 61.533 MB. [2025-01-22T04:47:20.496Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:20.496Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:20.496Z] ====== als (apache-spark) [default], iteration 6 completed (5969.561 ms) ====== [2025-01-22T04:47:20.496Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-01-22T04:47:20.496Z] GC before operation: completed in 164.170 ms, heap usage 573.168 MB -> 61.448 MB. [2025-01-22T04:47:26.733Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:26.733Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:26.733Z] ====== als (apache-spark) [default], iteration 7 completed (6047.022 ms) ====== [2025-01-22T04:47:26.733Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-01-22T04:47:26.733Z] GC before operation: completed in 178.042 ms, heap usage 445.982 MB -> 61.668 MB. [2025-01-22T04:47:33.104Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:33.104Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:33.104Z] ====== als (apache-spark) [default], iteration 8 completed (6028.135 ms) ====== [2025-01-22T04:47:33.104Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-01-22T04:47:33.104Z] GC before operation: completed in 184.374 ms, heap usage 384.123 MB -> 61.946 MB. [2025-01-22T04:47:39.422Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:39.422Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:39.422Z] ====== als (apache-spark) [default], iteration 9 completed (5803.595 ms) ====== [2025-01-22T04:47:39.422Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-01-22T04:47:39.422Z] GC before operation: completed in 161.851 ms, heap usage 401.929 MB -> 62.311 MB. [2025-01-22T04:47:44.556Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:44.556Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:44.556Z] ====== als (apache-spark) [default], iteration 10 completed (5786.347 ms) ====== [2025-01-22T04:47:44.556Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-01-22T04:47:44.556Z] GC before operation: completed in 134.980 ms, heap usage 194.667 MB -> 62.578 MB. [2025-01-22T04:47:50.892Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:50.892Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:50.892Z] ====== als (apache-spark) [default], iteration 11 completed (5714.260 ms) ====== [2025-01-22T04:47:50.892Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-01-22T04:47:50.892Z] GC before operation: completed in 195.912 ms, heap usage 698.182 MB -> 63.388 MB. [2025-01-22T04:47:57.306Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:47:57.306Z] There is no way to check that no silent failure occurred. [2025-01-22T04:47:57.306Z] ====== als (apache-spark) [default], iteration 12 completed (6101.986 ms) ====== [2025-01-22T04:47:57.306Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-01-22T04:47:57.306Z] GC before operation: completed in 194.843 ms, heap usage 403.988 MB -> 63.475 MB. [2025-01-22T04:48:03.643Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:03.643Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:03.643Z] ====== als (apache-spark) [default], iteration 13 completed (6103.505 ms) ====== [2025-01-22T04:48:03.643Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-01-22T04:48:03.643Z] GC before operation: completed in 176.033 ms, heap usage 242.864 MB -> 63.523 MB. [2025-01-22T04:48:08.891Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:08.891Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:08.891Z] ====== als (apache-spark) [default], iteration 14 completed (5871.036 ms) ====== [2025-01-22T04:48:08.891Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-01-22T04:48:08.891Z] GC before operation: completed in 155.028 ms, heap usage 290.015 MB -> 64.009 MB. [2025-01-22T04:48:15.252Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:15.252Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:15.252Z] ====== als (apache-spark) [default], iteration 15 completed (5790.431 ms) ====== [2025-01-22T04:48:15.252Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-01-22T04:48:15.252Z] GC before operation: completed in 172.775 ms, heap usage 621.284 MB -> 64.674 MB. [2025-01-22T04:48:21.602Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:21.602Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:21.602Z] ====== als (apache-spark) [default], iteration 16 completed (5737.262 ms) ====== [2025-01-22T04:48:21.602Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-01-22T04:48:21.602Z] GC before operation: completed in 152.555 ms, heap usage 337.517 MB -> 64.626 MB. [2025-01-22T04:48:26.720Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:26.720Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:26.720Z] ====== als (apache-spark) [default], iteration 17 completed (5629.582 ms) ====== [2025-01-22T04:48:26.720Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-01-22T04:48:26.720Z] GC before operation: completed in 135.644 ms, heap usage 407.163 MB -> 65.059 MB. [2025-01-22T04:48:33.143Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:33.143Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:33.143Z] ====== als (apache-spark) [default], iteration 18 completed (5940.397 ms) ====== [2025-01-22T04:48:33.143Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-01-22T04:48:33.143Z] GC before operation: completed in 150.675 ms, heap usage 376.301 MB -> 65.367 MB. [2025-01-22T04:48:38.227Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:38.227Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:38.227Z] ====== als (apache-spark) [default], iteration 19 completed (5547.225 ms) ====== [2025-01-22T04:48:38.227Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-01-22T04:48:38.922Z] GC before operation: completed in 153.121 ms, heap usage 352.671 MB -> 65.470 MB. [2025-01-22T04:48:44.014Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:44.014Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:44.014Z] ====== als (apache-spark) [default], iteration 20 completed (5695.538 ms) ====== [2025-01-22T04:48:44.014Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-01-22T04:48:44.691Z] GC before operation: completed in 139.793 ms, heap usage 562.376 MB -> 65.836 MB. [2025-01-22T04:48:49.881Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:49.881Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:49.881Z] ====== als (apache-spark) [default], iteration 21 completed (5675.476 ms) ====== [2025-01-22T04:48:49.881Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-01-22T04:48:50.558Z] GC before operation: completed in 164.996 ms, heap usage 451.410 MB -> 65.919 MB. [2025-01-22T04:48:56.293Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:48:56.293Z] There is no way to check that no silent failure occurred. [2025-01-22T04:48:56.293Z] ====== als (apache-spark) [default], iteration 22 completed (5874.987 ms) ====== [2025-01-22T04:48:56.293Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-01-22T04:48:56.293Z] GC before operation: completed in 163.671 ms, heap usage 638.414 MB -> 66.375 MB. [2025-01-22T04:49:02.634Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:02.634Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:02.634Z] ====== als (apache-spark) [default], iteration 23 completed (5673.334 ms) ====== [2025-01-22T04:49:02.635Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-01-22T04:49:02.635Z] GC before operation: completed in 170.051 ms, heap usage 408.176 MB -> 66.365 MB. [2025-01-22T04:49:07.736Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:07.736Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:07.737Z] ====== als (apache-spark) [default], iteration 24 completed (5739.885 ms) ====== [2025-01-22T04:49:07.737Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-01-22T04:49:08.417Z] GC before operation: completed in 173.159 ms, heap usage 576.012 MB -> 66.637 MB. [2025-01-22T04:49:13.522Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:13.522Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:13.522Z] ====== als (apache-spark) [default], iteration 25 completed (5551.346 ms) ====== [2025-01-22T04:49:13.522Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-01-22T04:49:13.522Z] GC before operation: completed in 149.137 ms, heap usage 277.112 MB -> 66.417 MB. [2025-01-22T04:49:19.861Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:19.861Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:19.861Z] ====== als (apache-spark) [default], iteration 26 completed (5641.973 ms) ====== [2025-01-22T04:49:19.861Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-01-22T04:49:19.861Z] GC before operation: completed in 155.846 ms, heap usage 210.603 MB -> 66.576 MB. [2025-01-22T04:49:33.874Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:33.874Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:33.874Z] ====== als (apache-spark) [default], iteration 27 completed (5513.380 ms) ====== [2025-01-22T04:49:33.874Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-01-22T04:49:33.874Z] GC before operation: completed in 165.129 ms, heap usage 292.676 MB -> 66.915 MB. [2025-01-22T04:49:33.874Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:33.874Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:33.874Z] ====== als (apache-spark) [default], iteration 28 completed (5779.190 ms) ====== [2025-01-22T04:49:33.874Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-01-22T04:49:33.874Z] GC before operation: completed in 147.955 ms, heap usage 203.715 MB -> 67.066 MB. [2025-01-22T04:49:36.974Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:49:36.974Z] There is no way to check that no silent failure occurred. [2025-01-22T04:49:36.974Z] ====== als (apache-spark) [default], iteration 29 completed (5799.338 ms) ====== [2025-01-22T04:49:37.652Z] ----------------------------------- [2025-01-22T04:49:37.652Z] renaissance-als_0_PASSED [2025-01-22T04:49:37.652Z] ----------------------------------- [2025-01-22T04:49:37.652Z] [2025-01-22T04:49:37.652Z] TEST TEARDOWN: [2025-01-22T04:49:37.652Z] Nothing to be done for teardown. [2025-01-22T04:49:37.652Z] renaissance-als_0 Finish Time: Tue Jan 21 22:49:37 2025 Epoch Time (ms): 1737521377413