[2025-02-06T06:45:38.593Z] Running test renaissance-als_0 ... [2025-02-06T06:45:38.593Z] =============================================== [2025-02-06T06:45:38.593Z] renaissance-als_0 Start Time: Thu Feb 6 01:45:37 2025 Epoch Time (ms): 1738824337681 [2025-02-06T06:45:38.593Z] variation: NoOptions [2025-02-06T06:45:38.593Z] JVM_OPTIONS: [2025-02-06T06:45:38.593Z] { \ [2025-02-06T06:45:38.593Z] echo ""; echo "TEST SETUP:"; \ [2025-02-06T06:45:38.593Z] echo "Nothing to be done for setup."; \ [2025-02-06T06:45:38.593Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/renaissance-als_0"; \ [2025-02-06T06:45:38.593Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/renaissance-als_0"; \ [2025-02-06T06:45:38.593Z] echo ""; echo "TESTING:"; \ [2025-02-06T06:45:38.593Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/renaissance-als_0"/als.json" als; \ [2025-02-06T06:45:38.593Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-06T06:45:38.593Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-06T06:45:38.593Z] echo "Nothing to be done for teardown."; \ [2025-02-06T06:45:38.593Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17388242733326/TestTargetResult"; [2025-02-06T06:45:38.593Z] [2025-02-06T06:45:38.593Z] TEST SETUP: [2025-02-06T06:45:38.593Z] Nothing to be done for setup. [2025-02-06T06:45:38.593Z] [2025-02-06T06:45:38.593Z] TESTING: [2025-02-06T06:45:43.857Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-06T06:45:46.980Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-02-06T06:45:52.221Z] WARNING: An illegal reflective access operation has occurred [2025-02-06T06:45:52.221Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17388242733326/renaissance-als_0/harness-014538-2017463754947322918/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-06T06:45:52.221Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-06T06:45:52.221Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-06T06:45:52.221Z] WARNING: All illegal access operations will be denied in a future release [2025-02-06T06:45:56.967Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-02-06T06:45:56.967Z] GC before operation: completed in 424.822 ms, heap usage 83.000 MB -> 33.795 MB. [2025-02-06T06:46:37.628Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:46:37.628Z] There is no way to check that no silent failure occurred. [2025-02-06T06:46:37.628Z] ====== als (apache-spark) [default], iteration 0 completed (37071.223 ms) ====== [2025-02-06T06:46:37.628Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-02-06T06:46:37.628Z] GC before operation: completed in 324.569 ms, heap usage 403.553 MB -> 56.184 MB. [2025-02-06T06:46:55.656Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:46:55.656Z] There is no way to check that no silent failure occurred. [2025-02-06T06:46:55.656Z] ====== als (apache-spark) [default], iteration 1 completed (21720.871 ms) ====== [2025-02-06T06:46:55.656Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-02-06T06:46:56.345Z] GC before operation: completed in 493.829 ms, heap usage 340.755 MB -> 58.722 MB. [2025-02-06T06:47:21.144Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:47:21.144Z] There is no way to check that no silent failure occurred. [2025-02-06T06:47:21.144Z] ====== als (apache-spark) [default], iteration 2 completed (21614.001 ms) ====== [2025-02-06T06:47:21.144Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-02-06T06:47:21.144Z] GC before operation: completed in 382.311 ms, heap usage 195.222 MB -> 58.870 MB. [2025-02-06T06:47:42.753Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:47:42.753Z] There is no way to check that no silent failure occurred. [2025-02-06T06:47:42.753Z] ====== als (apache-spark) [default], iteration 3 completed (21931.646 ms) ====== [2025-02-06T06:47:42.753Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-02-06T06:47:42.753Z] GC before operation: completed in 277.165 ms, heap usage 148.238 MB -> 59.160 MB. [2025-02-06T06:48:07.872Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:48:07.872Z] There is no way to check that no silent failure occurred. [2025-02-06T06:48:07.872Z] ====== als (apache-spark) [default], iteration 4 completed (25173.877 ms) ====== [2025-02-06T06:48:07.872Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-02-06T06:48:07.872Z] GC before operation: completed in 799.030 ms, heap usage 242.036 MB -> 59.683 MB. [2025-02-06T06:48:29.725Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:48:29.725Z] There is no way to check that no silent failure occurred. [2025-02-06T06:48:29.725Z] ====== als (apache-spark) [default], iteration 5 completed (22805.318 ms) ====== [2025-02-06T06:48:29.725Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-02-06T06:48:29.725Z] GC before operation: completed in 450.560 ms, heap usage 285.691 MB -> 60.266 MB. [2025-02-06T06:48:54.889Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:48:54.889Z] There is no way to check that no silent failure occurred. [2025-02-06T06:48:54.889Z] ====== als (apache-spark) [default], iteration 6 completed (23641.883 ms) ====== [2025-02-06T06:48:54.889Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-02-06T06:48:54.889Z] GC before operation: completed in 359.112 ms, heap usage 385.272 MB -> 60.577 MB. [2025-02-06T06:49:16.679Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:49:16.679Z] There is no way to check that no silent failure occurred. [2025-02-06T06:49:16.679Z] ====== als (apache-spark) [default], iteration 7 completed (22049.911 ms) ====== [2025-02-06T06:49:16.679Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-02-06T06:49:16.679Z] GC before operation: completed in 388.620 ms, heap usage 238.991 MB -> 60.818 MB. [2025-02-06T06:49:42.060Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:49:42.060Z] There is no way to check that no silent failure occurred. [2025-02-06T06:49:42.060Z] ====== als (apache-spark) [default], iteration 8 completed (24666.594 ms) ====== [2025-02-06T06:49:42.060Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-02-06T06:49:42.060Z] GC before operation: completed in 432.470 ms, heap usage 223.478 MB -> 61.027 MB. [2025-02-06T06:50:03.586Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:50:03.586Z] There is no way to check that no silent failure occurred. [2025-02-06T06:50:03.586Z] ====== als (apache-spark) [default], iteration 9 completed (21680.641 ms) ====== [2025-02-06T06:50:03.586Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-02-06T06:50:03.586Z] GC before operation: completed in 603.974 ms, heap usage 227.068 MB -> 61.293 MB. [2025-02-06T06:50:28.810Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:50:28.810Z] There is no way to check that no silent failure occurred. [2025-02-06T06:50:28.810Z] ====== als (apache-spark) [default], iteration 10 completed (22109.623 ms) ====== [2025-02-06T06:50:28.810Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-02-06T06:50:28.810Z] GC before operation: completed in 338.394 ms, heap usage 173.825 MB -> 61.691 MB. [2025-02-06T06:50:47.112Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:50:47.112Z] There is no way to check that no silent failure occurred. [2025-02-06T06:50:47.112Z] ====== als (apache-spark) [default], iteration 11 completed (21175.886 ms) ====== [2025-02-06T06:50:47.112Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-02-06T06:50:47.833Z] GC before operation: completed in 351.346 ms, heap usage 362.259 MB -> 62.255 MB. [2025-02-06T06:51:09.119Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:51:09.119Z] There is no way to check that no silent failure occurred. [2025-02-06T06:51:09.119Z] ====== als (apache-spark) [default], iteration 12 completed (19267.555 ms) ====== [2025-02-06T06:51:09.119Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-02-06T06:51:09.119Z] GC before operation: completed in 613.348 ms, heap usage 200.036 MB -> 62.245 MB. [2025-02-06T06:51:31.296Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:51:31.296Z] There is no way to check that no silent failure occurred. [2025-02-06T06:51:31.296Z] ====== als (apache-spark) [default], iteration 13 completed (22344.565 ms) ====== [2025-02-06T06:51:31.296Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-02-06T06:51:31.296Z] GC before operation: completed in 339.061 ms, heap usage 348.858 MB -> 62.940 MB. [2025-02-06T06:51:52.836Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:51:52.836Z] There is no way to check that no silent failure occurred. [2025-02-06T06:51:52.836Z] ====== als (apache-spark) [default], iteration 14 completed (21761.488 ms) ====== [2025-02-06T06:51:52.836Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-02-06T06:51:52.836Z] GC before operation: completed in 329.687 ms, heap usage 316.918 MB -> 63.247 MB. [2025-02-06T06:52:17.763Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:52:17.763Z] There is no way to check that no silent failure occurred. [2025-02-06T06:52:17.763Z] ====== als (apache-spark) [default], iteration 15 completed (23610.865 ms) ====== [2025-02-06T06:52:17.763Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-02-06T06:52:17.763Z] GC before operation: completed in 387.903 ms, heap usage 356.748 MB -> 63.697 MB. [2025-02-06T06:52:39.244Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:52:39.244Z] There is no way to check that no silent failure occurred. [2025-02-06T06:52:39.244Z] ====== als (apache-spark) [default], iteration 16 completed (21514.686 ms) ====== [2025-02-06T06:52:39.244Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-02-06T06:52:39.244Z] GC before operation: completed in 525.897 ms, heap usage 316.198 MB -> 63.898 MB. [2025-02-06T06:52:58.022Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:52:58.022Z] There is no way to check that no silent failure occurred. [2025-02-06T06:52:58.022Z] ====== als (apache-spark) [default], iteration 17 completed (18875.789 ms) ====== [2025-02-06T06:52:58.022Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-02-06T06:52:58.022Z] GC before operation: completed in 542.803 ms, heap usage 485.348 MB -> 64.561 MB. [2025-02-06T06:53:19.450Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:53:19.450Z] There is no way to check that no silent failure occurred. [2025-02-06T06:53:19.451Z] ====== als (apache-spark) [default], iteration 18 completed (21084.561 ms) ====== [2025-02-06T06:53:19.451Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-02-06T06:53:19.451Z] GC before operation: completed in 659.698 ms, heap usage 246.255 MB -> 64.237 MB. [2025-02-06T06:53:44.645Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:53:44.645Z] There is no way to check that no silent failure occurred. [2025-02-06T06:53:44.645Z] ====== als (apache-spark) [default], iteration 19 completed (22760.264 ms) ====== [2025-02-06T06:53:44.645Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-02-06T06:53:44.645Z] GC before operation: completed in 359.327 ms, heap usage 385.234 MB -> 64.735 MB. [2025-02-06T06:54:06.377Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:54:06.377Z] There is no way to check that no silent failure occurred. [2025-02-06T06:54:06.377Z] ====== als (apache-spark) [default], iteration 20 completed (22706.698 ms) ====== [2025-02-06T06:54:06.377Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-02-06T06:54:06.377Z] GC before operation: completed in 423.553 ms, heap usage 186.969 MB -> 64.520 MB. [2025-02-06T06:54:28.290Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:54:28.290Z] There is no way to check that no silent failure occurred. [2025-02-06T06:54:28.290Z] ====== als (apache-spark) [default], iteration 21 completed (20328.498 ms) ====== [2025-02-06T06:54:28.290Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-02-06T06:54:28.290Z] GC before operation: completed in 753.939 ms, heap usage 261.309 MB -> 65.037 MB. [2025-02-06T06:54:49.696Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:54:49.696Z] There is no way to check that no silent failure occurred. [2025-02-06T06:54:49.696Z] ====== als (apache-spark) [default], iteration 22 completed (23150.008 ms) ====== [2025-02-06T06:54:49.696Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-02-06T06:54:50.551Z] GC before operation: completed in 476.528 ms, heap usage 473.096 MB -> 65.406 MB. [2025-02-06T06:55:11.949Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:55:11.949Z] There is no way to check that no silent failure occurred. [2025-02-06T06:55:11.949Z] ====== als (apache-spark) [default], iteration 23 completed (21571.790 ms) ====== [2025-02-06T06:55:11.949Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-02-06T06:55:12.650Z] GC before operation: completed in 472.430 ms, heap usage 357.313 MB -> 65.549 MB. [2025-02-06T06:55:34.206Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:55:34.206Z] There is no way to check that no silent failure occurred. [2025-02-06T06:55:34.206Z] ====== als (apache-spark) [default], iteration 24 completed (20641.290 ms) ====== [2025-02-06T06:55:34.206Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-02-06T06:55:34.206Z] GC before operation: completed in 566.798 ms, heap usage 194.471 MB -> 65.295 MB. [2025-02-06T06:55:56.494Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:55:56.494Z] There is no way to check that no silent failure occurred. [2025-02-06T06:55:56.494Z] ====== als (apache-spark) [default], iteration 25 completed (20743.444 ms) ====== [2025-02-06T06:55:56.494Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-02-06T06:55:56.494Z] GC before operation: completed in 550.825 ms, heap usage 229.580 MB -> 65.495 MB. [2025-02-06T06:56:17.889Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:56:17.889Z] There is no way to check that no silent failure occurred. [2025-02-06T06:56:17.889Z] ====== als (apache-spark) [default], iteration 26 completed (22644.550 ms) ====== [2025-02-06T06:56:17.889Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-02-06T06:56:17.889Z] GC before operation: completed in 390.092 ms, heap usage 364.769 MB -> 66.057 MB. [2025-02-06T06:56:42.881Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:56:42.881Z] There is no way to check that no silent failure occurred. [2025-02-06T06:56:42.881Z] ====== als (apache-spark) [default], iteration 27 completed (21710.639 ms) ====== [2025-02-06T06:56:42.882Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-02-06T06:56:42.882Z] GC before operation: completed in 358.536 ms, heap usage 428.155 MB -> 66.233 MB. [2025-02-06T06:57:01.039Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:57:01.039Z] There is no way to check that no silent failure occurred. [2025-02-06T06:57:01.039Z] ====== als (apache-spark) [default], iteration 28 completed (20060.227 ms) ====== [2025-02-06T06:57:01.039Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-02-06T06:57:01.039Z] GC before operation: completed in 379.672 ms, heap usage 331.665 MB -> 66.466 MB. [2025-02-06T06:57:23.123Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T06:57:23.123Z] There is no way to check that no silent failure occurred. [2025-02-06T06:57:23.123Z] ====== als (apache-spark) [default], iteration 29 completed (21115.369 ms) ====== [2025-02-06T06:57:23.123Z] ----------------------------------- [2025-02-06T06:57:23.123Z] renaissance-als_0_PASSED [2025-02-06T06:57:23.123Z] ----------------------------------- [2025-02-06T06:57:23.123Z] [2025-02-06T06:57:23.123Z] TEST TEARDOWN: [2025-02-06T06:57:23.123Z] Nothing to be done for teardown. [2025-02-06T06:57:23.123Z] renaissance-als_0 Finish Time: Thu Feb 6 01:57:22 2025 Epoch Time (ms): 1738825042427