[2024-09-25T21:56:18.161Z] Running test renaissance-als_0 ... [2024-09-25T21:56:18.161Z] =============================================== [2024-09-25T21:56:18.161Z] renaissance-als_0 Start Time: Wed Sep 25 21:56:17 2024 Epoch Time (ms): 1727301377618 [2024-09-25T21:56:18.161Z] variation: NoOptions [2024-09-25T21:56:18.161Z] JVM_OPTIONS: [2024-09-25T21:56:18.161Z] { \ [2024-09-25T21:56:18.161Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T21:56:18.161Z] echo "Nothing to be done for setup."; \ [2024-09-25T21:56:18.161Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17273013765094/renaissance-als_0"; \ [2024-09-25T21:56:18.161Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17273013765094/renaissance-als_0"; \ [2024-09-25T21:56:18.161Z] echo ""; echo "TESTING:"; \ [2024-09-25T21:56:18.161Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-11.0.25+7/bin/..//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_17273013765094/renaissance-als_0"/als.json" als; \ [2024-09-25T21:56:18.161Z] 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_17273013765094/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T21:56:18.161Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T21:56:18.161Z] echo "Nothing to be done for teardown."; \ [2024-09-25T21:56:18.161Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17273013765094/TestTargetResult"; [2024-09-25T21:56:18.161Z] [2024-09-25T21:56:18.161Z] TEST SETUP: [2024-09-25T21:56:18.161Z] Nothing to be done for setup. [2024-09-25T21:56:18.161Z] [2024-09-25T21:56:18.161Z] TESTING: [2024-09-25T21:56:29.634Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T21:56:39.387Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-25T21:56:58.074Z] WARNING: An illegal reflective access operation has occurred [2024-09-25T21:56:58.074Z] 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_17273013765094/renaissance-als_0/harness-215620-17126550659940154257/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-09-25T21:56:58.074Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-09-25T21:56:58.074Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-09-25T21:56:58.074Z] WARNING: All illegal access operations will be denied in a future release [2024-09-25T21:57:09.551Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-09-25T21:57:10.304Z] GC before operation: completed in 594.267 ms, heap usage 91.000 MB -> 34.036 MB. [2024-09-25T21:59:45.845Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:59:45.845Z] There is no way to check that no silent failure occurred. [2024-09-25T21:59:45.845Z] ====== als (apache-spark) [default], iteration 0 completed (150514.509 ms) ====== [2024-09-25T21:59:45.845Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-09-25T21:59:45.845Z] GC before operation: completed in 801.629 ms, heap usage 412.304 MB -> 56.253 MB. [2024-09-25T22:00:54.111Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:00:54.111Z] There is no way to check that no silent failure occurred. [2024-09-25T22:00:54.111Z] ====== als (apache-spark) [default], iteration 1 completed (70746.168 ms) ====== [2024-09-25T22:00:54.111Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-09-25T22:00:54.111Z] GC before operation: completed in 603.538 ms, heap usage 209.721 MB -> 58.559 MB. [2024-09-25T22:01:50.902Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:01:50.902Z] There is no way to check that no silent failure occurred. [2024-09-25T22:01:50.902Z] ====== als (apache-spark) [default], iteration 2 completed (57229.278 ms) ====== [2024-09-25T22:01:50.902Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-09-25T22:01:50.902Z] GC before operation: completed in 646.961 ms, heap usage 233.224 MB -> 59.177 MB. [2024-09-25T22:02:57.581Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:02:57.581Z] There is no way to check that no silent failure occurred. [2024-09-25T22:02:57.581Z] ====== als (apache-spark) [default], iteration 3 completed (58275.778 ms) ====== [2024-09-25T22:02:57.581Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-09-25T22:02:57.581Z] GC before operation: completed in 967.864 ms, heap usage 379.201 MB -> 59.752 MB. [2024-09-25T22:04:04.338Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:04:04.338Z] There is no way to check that no silent failure occurred. [2024-09-25T22:04:04.338Z] ====== als (apache-spark) [default], iteration 4 completed (70591.770 ms) ====== [2024-09-25T22:04:04.338Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-09-25T22:04:04.338Z] GC before operation: completed in 701.000 ms, heap usage 220.659 MB -> 59.682 MB. [2024-09-25T22:05:01.510Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:05:01.510Z] There is no way to check that no silent failure occurred. [2024-09-25T22:05:01.510Z] ====== als (apache-spark) [default], iteration 5 completed (59770.552 ms) ====== [2024-09-25T22:05:01.510Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-09-25T22:05:01.510Z] GC before operation: completed in 630.311 ms, heap usage 501.116 MB -> 60.552 MB. [2024-09-25T22:05:58.108Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:05:58.108Z] There is no way to check that no silent failure occurred. [2024-09-25T22:05:58.108Z] ====== als (apache-spark) [default], iteration 6 completed (55423.276 ms) ====== [2024-09-25T22:05:58.108Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-09-25T22:05:58.108Z] GC before operation: completed in 781.874 ms, heap usage 507.056 MB -> 60.833 MB. [2024-09-25T22:07:05.433Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:07:05.433Z] There is no way to check that no silent failure occurred. [2024-09-25T22:07:05.433Z] ====== als (apache-spark) [default], iteration 7 completed (59743.561 ms) ====== [2024-09-25T22:07:05.433Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-09-25T22:07:05.433Z] GC before operation: completed in 810.939 ms, heap usage 414.604 MB -> 60.979 MB. [2024-09-25T22:08:12.495Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:08:12.495Z] There is no way to check that no silent failure occurred. [2024-09-25T22:08:12.495Z] ====== als (apache-spark) [default], iteration 8 completed (71620.721 ms) ====== [2024-09-25T22:08:12.495Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-09-25T22:08:12.495Z] GC before operation: completed in 788.732 ms, heap usage 323.415 MB -> 61.247 MB. [2024-09-25T22:09:19.720Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:09:19.720Z] There is no way to check that no silent failure occurred. [2024-09-25T22:09:19.720Z] ====== als (apache-spark) [default], iteration 9 completed (67926.581 ms) ====== [2024-09-25T22:09:19.720Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-09-25T22:09:19.720Z] GC before operation: completed in 781.056 ms, heap usage 460.532 MB -> 61.781 MB. [2024-09-25T22:10:26.913Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:10:26.913Z] There is no way to check that no silent failure occurred. [2024-09-25T22:10:26.913Z] ====== als (apache-spark) [default], iteration 10 completed (65279.902 ms) ====== [2024-09-25T22:10:26.913Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-09-25T22:10:26.913Z] GC before operation: completed in 1317.997 ms, heap usage 354.166 MB -> 61.947 MB. [2024-09-25T22:11:46.984Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:11:46.984Z] There is no way to check that no silent failure occurred. [2024-09-25T22:11:46.984Z] ====== als (apache-spark) [default], iteration 11 completed (71463.261 ms) ====== [2024-09-25T22:11:46.984Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-09-25T22:11:46.984Z] GC before operation: completed in 929.235 ms, heap usage 267.706 MB -> 62.093 MB. [2024-09-25T22:12:53.800Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:12:53.800Z] There is no way to check that no silent failure occurred. [2024-09-25T22:12:53.800Z] ====== als (apache-spark) [default], iteration 12 completed (65566.948 ms) ====== [2024-09-25T22:12:53.800Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-09-25T22:12:53.800Z] GC before operation: completed in 752.636 ms, heap usage 301.350 MB -> 62.559 MB. [2024-09-25T22:13:50.648Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:13:50.648Z] There is no way to check that no silent failure occurred. [2024-09-25T22:13:50.648Z] ====== als (apache-spark) [default], iteration 13 completed (64203.701 ms) ====== [2024-09-25T22:13:50.648Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-09-25T22:13:50.648Z] GC before operation: completed in 1055.773 ms, heap usage 486.239 MB -> 63.090 MB. [2024-09-25T22:15:10.557Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:15:10.557Z] There is no way to check that no silent failure occurred. [2024-09-25T22:15:10.557Z] ====== als (apache-spark) [default], iteration 14 completed (73006.916 ms) ====== [2024-09-25T22:15:10.557Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-09-25T22:15:10.557Z] GC before operation: completed in 1088.302 ms, heap usage 349.452 MB -> 63.508 MB. [2024-09-25T22:16:17.695Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:16:17.695Z] There is no way to check that no silent failure occurred. [2024-09-25T22:16:17.695Z] ====== als (apache-spark) [default], iteration 15 completed (66567.263 ms) ====== [2024-09-25T22:16:17.695Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-09-25T22:16:17.695Z] GC before operation: completed in 1379.459 ms, heap usage 466.570 MB -> 63.840 MB. [2024-09-25T22:17:24.961Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:17:24.961Z] There is no way to check that no silent failure occurred. [2024-09-25T22:17:24.961Z] ====== als (apache-spark) [default], iteration 16 completed (68674.336 ms) ====== [2024-09-25T22:17:24.961Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-09-25T22:17:24.961Z] GC before operation: completed in 826.466 ms, heap usage 340.618 MB -> 64.178 MB. [2024-09-25T22:18:31.808Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:18:31.809Z] There is no way to check that no silent failure occurred. [2024-09-25T22:18:31.809Z] ====== als (apache-spark) [default], iteration 17 completed (66688.130 ms) ====== [2024-09-25T22:18:31.809Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-09-25T22:18:31.809Z] GC before operation: completed in 919.702 ms, heap usage 402.688 MB -> 64.477 MB. [2024-09-25T22:19:38.572Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:19:38.572Z] There is no way to check that no silent failure occurred. [2024-09-25T22:19:38.572Z] ====== als (apache-spark) [default], iteration 18 completed (64339.078 ms) ====== [2024-09-25T22:19:38.572Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-09-25T22:19:38.572Z] GC before operation: completed in 967.377 ms, heap usage 251.866 MB -> 63.849 MB. [2024-09-25T22:20:45.664Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:20:45.664Z] There is no way to check that no silent failure occurred. [2024-09-25T22:20:45.664Z] ====== als (apache-spark) [default], iteration 19 completed (64870.055 ms) ====== [2024-09-25T22:20:45.664Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-09-25T22:20:45.664Z] GC before operation: completed in 871.177 ms, heap usage 480.532 MB -> 62.230 MB. [2024-09-25T22:21:42.578Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:21:42.578Z] There is no way to check that no silent failure occurred. [2024-09-25T22:21:42.578Z] ====== als (apache-spark) [default], iteration 20 completed (61972.880 ms) ====== [2024-09-25T22:21:42.578Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-09-25T22:21:44.148Z] GC before operation: completed in 1086.050 ms, heap usage 477.543 MB -> 62.326 MB. [2024-09-25T22:23:03.346Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:23:03.346Z] There is no way to check that no silent failure occurred. [2024-09-25T22:23:03.346Z] ====== als (apache-spark) [default], iteration 21 completed (68214.525 ms) ====== [2024-09-25T22:23:03.346Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-09-25T22:23:03.346Z] GC before operation: completed in 940.812 ms, heap usage 416.469 MB -> 62.406 MB. [2024-09-25T22:24:00.476Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:24:00.476Z] There is no way to check that no silent failure occurred. [2024-09-25T22:24:00.476Z] ====== als (apache-spark) [default], iteration 22 completed (64194.750 ms) ====== [2024-09-25T22:24:00.476Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-09-25T22:24:00.476Z] GC before operation: completed in 1133.118 ms, heap usage 399.295 MB -> 62.553 MB. [2024-09-25T22:25:08.625Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:25:08.625Z] There is no way to check that no silent failure occurred. [2024-09-25T22:25:08.625Z] ====== als (apache-spark) [default], iteration 23 completed (64054.351 ms) ====== [2024-09-25T22:25:08.625Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-09-25T22:25:08.625Z] GC before operation: completed in 748.253 ms, heap usage 253.473 MB -> 62.632 MB. [2024-09-25T22:26:15.887Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:26:15.887Z] There is no way to check that no silent failure occurred. [2024-09-25T22:26:15.888Z] ====== als (apache-spark) [default], iteration 24 completed (66582.960 ms) ====== [2024-09-25T22:26:15.888Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-09-25T22:26:15.888Z] GC before operation: completed in 1037.862 ms, heap usage 395.799 MB -> 62.930 MB. [2024-09-25T22:27:22.932Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:27:22.932Z] There is no way to check that no silent failure occurred. [2024-09-25T22:27:22.932Z] ====== als (apache-spark) [default], iteration 25 completed (67714.017 ms) ====== [2024-09-25T22:27:22.932Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-09-25T22:27:22.932Z] GC before operation: completed in 1064.157 ms, heap usage 256.048 MB -> 62.981 MB. [2024-09-25T22:28:30.104Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:28:30.104Z] There is no way to check that no silent failure occurred. [2024-09-25T22:28:30.104Z] ====== als (apache-spark) [default], iteration 26 completed (67259.950 ms) ====== [2024-09-25T22:28:30.104Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-09-25T22:28:30.104Z] GC before operation: completed in 1027.514 ms, heap usage 274.478 MB -> 63.130 MB. [2024-09-25T22:29:37.126Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:29:37.126Z] There is no way to check that no silent failure occurred. [2024-09-25T22:29:37.126Z] ====== als (apache-spark) [default], iteration 27 completed (65527.717 ms) ====== [2024-09-25T22:29:37.126Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-09-25T22:29:37.126Z] GC before operation: completed in 803.396 ms, heap usage 475.280 MB -> 63.585 MB. [2024-09-25T22:30:44.346Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:30:44.346Z] There is no way to check that no silent failure occurred. [2024-09-25T22:30:44.346Z] ====== als (apache-spark) [default], iteration 28 completed (68287.625 ms) ====== [2024-09-25T22:30:44.346Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-09-25T22:30:44.346Z] GC before operation: completed in 773.295 ms, heap usage 388.027 MB -> 63.756 MB. [2024-09-25T22:31:51.700Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T22:31:51.700Z] There is no way to check that no silent failure occurred. [2024-09-25T22:31:51.700Z] ====== als (apache-spark) [default], iteration 29 completed (68016.568 ms) ====== [2024-09-25T22:31:53.258Z] ----------------------------------- [2024-09-25T22:31:53.258Z] renaissance-als_0_PASSED [2024-09-25T22:31:53.258Z] ----------------------------------- [2024-09-25T22:31:53.258Z] [2024-09-25T22:31:53.258Z] TEST TEARDOWN: [2024-09-25T22:31:53.258Z] Nothing to be done for teardown. [2024-09-25T22:31:53.258Z] renaissance-als_0 Finish Time: Wed Sep 25 22:31:52 2024 Epoch Time (ms): 1727303512652