[2025-06-11T23:28:30.923Z] Running test renaissance-log-regression_0 ... [2025-06-11T23:28:30.923Z] =============================================== [2025-06-11T23:28:30.923Z] renaissance-log-regression_0 Start Time: Wed Jun 11 19:28:30 2025 Epoch Time (ms): 1749684510479 [2025-06-11T23:28:30.923Z] variation: NoOptions [2025-06-11T23:28:30.923Z] JVM_OPTIONS: [2025-06-11T23:28:30.923Z] { \ [2025-06-11T23:28:30.923Z] echo ""; echo "TEST SETUP:"; \ [2025-06-11T23:28:30.923Z] echo "Nothing to be done for setup."; \ [2025-06-11T23:28:30.923Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17496839143366/renaissance-log-regression_0"; \ [2025-06-11T23:28:30.923Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17496839143366/renaissance-log-regression_0"; \ [2025-06-11T23:28:30.923Z] echo ""; echo "TESTING:"; \ [2025-06-11T23:28:30.923Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/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 "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17496839143366/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-06-11T23:28:30.923Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17496839143366/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-11T23:28:30.923Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-11T23:28:30.923Z] echo "Nothing to be done for teardown."; \ [2025-06-11T23:28:30.923Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17496839143366/TestTargetResult"; [2025-06-11T23:28:30.923Z] [2025-06-11T23:28:30.923Z] TEST SETUP: [2025-06-11T23:28:30.923Z] Nothing to be done for setup. [2025-06-11T23:28:30.923Z] [2025-06-11T23:28:30.923Z] TESTING: [2025-06-11T23:28:34.929Z] NOTE: 'log-regression' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-06-11T23:28:35.713Z] WARNING: An illegal reflective access operation has occurred [2025-06-11T23:28:35.713Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_17496839143366/renaissance-log-regression_0/harness-192830-13113304812684091978/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-06-11T23:28:35.713Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-06-11T23:28:35.713Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-06-11T23:28:35.713Z] WARNING: All illegal access operations will be denied in a future release [2025-06-11T23:28:36.476Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-06-11T23:28:36.476Z] GC before operation: completed in 42.612 ms, heap usage 60.737 MB -> 34.495 MB. [2025-06-11T23:28:44.128Z] ====== log-regression (apache-spark) [default], iteration 0 completed (7299.669 ms) ====== [2025-06-11T23:28:44.128Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-06-11T23:28:44.128Z] GC before operation: completed in 62.147 ms, heap usage 265.405 MB -> 115.859 MB. [2025-06-11T23:28:45.429Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1651.467 ms) ====== [2025-06-11T23:28:45.430Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-06-11T23:28:45.783Z] GC before operation: completed in 69.530 ms, heap usage 301.844 MB -> 116.469 MB. [2025-06-11T23:28:47.039Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1213.925 ms) ====== [2025-06-11T23:28:47.039Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-06-11T23:28:47.039Z] GC before operation: completed in 57.941 ms, heap usage 293.465 MB -> 116.814 MB. [2025-06-11T23:28:48.273Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1255.121 ms) ====== [2025-06-11T23:28:48.273Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-06-11T23:28:48.273Z] GC before operation: completed in 58.263 ms, heap usage 334.325 MB -> 117.223 MB. [2025-06-11T23:28:49.561Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1222.516 ms) ====== [2025-06-11T23:28:49.561Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-06-11T23:28:49.561Z] GC before operation: completed in 58.203 ms, heap usage 291.042 MB -> 117.270 MB. [2025-06-11T23:28:50.806Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1187.545 ms) ====== [2025-06-11T23:28:50.806Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-06-11T23:28:50.806Z] GC before operation: completed in 54.681 ms, heap usage 304.422 MB -> 117.557 MB. [2025-06-11T23:28:52.077Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1206.173 ms) ====== [2025-06-11T23:28:52.077Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-06-11T23:28:52.077Z] GC before operation: completed in 64.450 ms, heap usage 325.987 MB -> 117.839 MB. [2025-06-11T23:28:53.311Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1096.377 ms) ====== [2025-06-11T23:28:53.311Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-06-11T23:28:53.311Z] GC before operation: completed in 64.143 ms, heap usage 231.775 MB -> 117.710 MB. [2025-06-11T23:28:54.083Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1003.114 ms) ====== [2025-06-11T23:28:54.083Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-06-11T23:28:54.083Z] GC before operation: completed in 60.265 ms, heap usage 281.298 MB -> 118.067 MB. [2025-06-11T23:28:55.353Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1162.822 ms) ====== [2025-06-11T23:28:55.353Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-06-11T23:28:55.353Z] GC before operation: completed in 71.824 ms, heap usage 281.670 MB -> 118.263 MB. [2025-06-11T23:28:56.597Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1147.706 ms) ====== [2025-06-11T23:28:56.597Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-06-11T23:28:56.597Z] GC before operation: completed in 65.569 ms, heap usage 238.884 MB -> 118.285 MB. [2025-06-11T23:28:57.847Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1102.806 ms) ====== [2025-06-11T23:28:57.847Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-06-11T23:28:57.847Z] GC before operation: completed in 62.697 ms, heap usage 299.909 MB -> 118.731 MB. [2025-06-11T23:28:59.075Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1083.811 ms) ====== [2025-06-11T23:28:59.075Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-06-11T23:28:59.075Z] GC before operation: completed in 64.776 ms, heap usage 337.931 MB -> 119.004 MB. [2025-06-11T23:29:00.365Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1114.403 ms) ====== [2025-06-11T23:29:00.365Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-06-11T23:29:00.365Z] GC before operation: completed in 66.090 ms, heap usage 330.494 MB -> 119.190 MB. [2025-06-11T23:29:01.160Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1037.032 ms) ====== [2025-06-11T23:29:01.160Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-06-11T23:29:01.160Z] GC before operation: completed in 64.752 ms, heap usage 338.783 MB -> 119.334 MB. [2025-06-11T23:29:02.441Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1054.949 ms) ====== [2025-06-11T23:29:02.441Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-06-11T23:29:02.441Z] GC before operation: completed in 70.495 ms, heap usage 252.406 MB -> 119.313 MB. [2025-06-11T23:29:03.254Z] ====== log-regression (apache-spark) [default], iteration 16 completed (999.447 ms) ====== [2025-06-11T23:29:03.254Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-06-11T23:29:03.639Z] GC before operation: completed in 66.025 ms, heap usage 253.864 MB -> 119.516 MB. [2025-06-11T23:29:04.425Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1045.876 ms) ====== [2025-06-11T23:29:04.425Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-06-11T23:29:04.425Z] GC before operation: completed in 66.622 ms, heap usage 240.403 MB -> 119.623 MB. [2025-06-11T23:29:05.746Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1106.493 ms) ====== [2025-06-11T23:29:05.746Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-06-11T23:29:05.746Z] GC before operation: completed in 70.928 ms, heap usage 307.079 MB -> 120.055 MB. [2025-06-11T23:29:06.992Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1158.218 ms) ====== [2025-06-11T23:29:06.992Z] ----------------------------------- [2025-06-11T23:29:06.992Z] renaissance-log-regression_0_PASSED [2025-06-11T23:29:06.992Z] ----------------------------------- [2025-06-11T23:29:06.992Z] [2025-06-11T23:29:06.992Z] TEST TEARDOWN: [2025-06-11T23:29:06.992Z] Nothing to be done for teardown. [2025-06-11T23:29:07.348Z] renaissance-log-regression_0 Finish Time: Wed Jun 11 19:29:06 2025 Epoch Time (ms): 1749684546880