renaissance-log-regression_0
[2024-08-24T02:16:49.952Z] Running test renaissance-log-regression_0 ...
[2024-08-24T02:16:50.256Z] ===============================================
[2024-08-24T02:16:50.256Z] renaissance-log-regression_0 Start Time: Sat Aug 24 02:16:50 2024 Epoch Time (ms): 1724465810208
[2024-08-24T02:16:50.572Z] variation: NoOptions
[2024-08-24T02:16:50.572Z] JVM_OPTIONS:
[2024-08-24T02:16:50.572Z] { \
[2024-08-24T02:16:50.572Z] echo ""; echo "TEST SETUP:"; \
[2024-08-24T02:16:50.572Z] echo "Nothing to be done for setup."; \
[2024-08-24T02:16:50.572Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\renaissance-log-regression_0"; \
[2024-08-24T02:16:50.572Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\renaissance-log-regression_0"; \
[2024-08-24T02:16:50.572Z] echo ""; echo "TESTING:"; \
[2024-08-24T02:16:50.572Z] "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_17244646614105\\renaissance-log-regression_0"\\log-regression.json" log-regression; \
[2024-08-24T02:16:50.572Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_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_17244646614105\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \
[2024-08-24T02:16:50.572Z] echo ""; echo "TEST TEARDOWN:"; \
[2024-08-24T02:16:50.572Z] echo "Nothing to be done for teardown."; \
[2024-08-24T02:16:50.572Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\TestTargetResult";
[2024-08-24T02:16:50.875Z]
[2024-08-24T02:16:50.875Z] TEST SETUP:
[2024-08-24T02:16:50.875Z] Nothing to be done for setup.
[2024-08-24T02:16:50.875Z]
[2024-08-24T02:16:50.875Z] TESTING:
[2024-08-24T02:17:01.429Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties
[2024-08-24T02:17:03.022Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads.
[2024-08-24T02:17:04.592Z] WARNING: An illegal reflective access operation has occurred
[2024-08-24T02:17:04.592Z] 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_17244646614105/renaissance-log-regression_0/harness-021651-15734484159417472238/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme
[2024-08-24T02:17:04.592Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$
[2024-08-24T02:17:04.592Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
[2024-08-24T02:17:04.592Z] WARNING: All illegal access operations will be denied in a future release
[2024-08-24T02:17:06.774Z] ====== log-regression (apache-spark) [default], iteration 0 started ======
[2024-08-24T02:17:06.775Z] GC before operation: completed in 46.980 ms, heap usage 66.996 MB -> 34.271 MB.
[2024-08-24T02:17:16.041Z] ====== log-regression (apache-spark) [default], iteration 0 completed (7747.186 ms) ======
[2024-08-24T02:17:16.041Z] ====== log-regression (apache-spark) [default], iteration 1 started ======
[2024-08-24T02:17:16.041Z] GC before operation: completed in 98.169 ms, heap usage 255.349 MB -> 112.389 MB.
[2024-08-24T02:17:17.728Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2979.425 ms) ======
[2024-08-24T02:17:17.728Z] ====== log-regression (apache-spark) [default], iteration 2 started ======
[2024-08-24T02:17:17.728Z] GC before operation: completed in 93.888 ms, heap usage 250.333 MB -> 112.966 MB.
[2024-08-24T02:17:19.519Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1652.859 ms) ======
[2024-08-24T02:17:19.519Z] ====== log-regression (apache-spark) [default], iteration 3 started ======
[2024-08-24T02:17:19.519Z] GC before operation: completed in 95.187 ms, heap usage 330.680 MB -> 113.540 MB.
[2024-08-24T02:17:21.382Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1722.110 ms) ======
[2024-08-24T02:17:21.382Z] ====== log-regression (apache-spark) [default], iteration 4 started ======
[2024-08-24T02:17:21.382Z] GC before operation: completed in 87.928 ms, heap usage 234.760 MB -> 113.541 MB.
[2024-08-24T02:17:22.570Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1582.233 ms) ======
[2024-08-24T02:17:22.570Z] ====== log-regression (apache-spark) [default], iteration 5 started ======
[2024-08-24T02:17:23.034Z] GC before operation: completed in 89.573 ms, heap usage 271.585 MB -> 113.847 MB.
[2024-08-24T02:17:24.151Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1484.887 ms) ======
[2024-08-24T02:17:24.151Z] ====== log-regression (apache-spark) [default], iteration 6 started ======
[2024-08-24T02:17:24.638Z] GC before operation: completed in 95.329 ms, heap usage 325.155 MB -> 114.133 MB.
[2024-08-24T02:17:25.867Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1637.217 ms) ======
[2024-08-24T02:17:25.867Z] ====== log-regression (apache-spark) [default], iteration 7 started ======
[2024-08-24T02:17:26.333Z] GC before operation: completed in 89.228 ms, heap usage 277.533 MB -> 114.233 MB.
[2024-08-24T02:17:27.465Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1468.066 ms) ======
[2024-08-24T02:17:27.465Z] ====== log-regression (apache-spark) [default], iteration 8 started ======
[2024-08-24T02:17:27.966Z] GC before operation: completed in 88.090 ms, heap usage 297.850 MB -> 114.506 MB.
[2024-08-24T02:17:29.154Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1637.207 ms) ======
[2024-08-24T02:17:29.154Z] ====== log-regression (apache-spark) [default], iteration 9 started ======
[2024-08-24T02:17:29.609Z] GC before operation: completed in 85.551 ms, heap usage 277.697 MB -> 114.658 MB.
[2024-08-24T02:17:30.821Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1401.777 ms) ======
[2024-08-24T02:17:30.821Z] ====== log-regression (apache-spark) [default], iteration 10 started ======
[2024-08-24T02:17:30.821Z] GC before operation: completed in 102.105 ms, heap usage 238.921 MB -> 114.721 MB.
[2024-08-24T02:17:32.469Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1500.759 ms) ======
[2024-08-24T02:17:32.469Z] ====== log-regression (apache-spark) [default], iteration 11 started ======
[2024-08-24T02:17:32.469Z] GC before operation: completed in 98.651 ms, heap usage 258.019 MB -> 114.956 MB.
[2024-08-24T02:17:34.218Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1339.443 ms) ======
[2024-08-24T02:17:34.218Z] ====== log-regression (apache-spark) [default], iteration 12 started ======
[2024-08-24T02:17:34.218Z] GC before operation: completed in 93.151 ms, heap usage 298.342 MB -> 115.245 MB.
[2024-08-24T02:17:35.334Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1342.965 ms) ======
[2024-08-24T02:17:35.334Z] ====== log-regression (apache-spark) [default], iteration 13 started ======
[2024-08-24T02:17:35.334Z] GC before operation: completed in 100.778 ms, heap usage 280.137 MB -> 115.387 MB.
[2024-08-24T02:17:37.132Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1494.546 ms) ======
[2024-08-24T02:17:37.132Z] ====== log-regression (apache-spark) [default], iteration 14 started ======
[2024-08-24T02:17:37.132Z] GC before operation: completed in 113.293 ms, heap usage 259.587 MB -> 115.531 MB.
[2024-08-24T02:17:38.291Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1449.434 ms) ======
[2024-08-24T02:17:38.291Z] ====== log-regression (apache-spark) [default], iteration 15 started ======
[2024-08-24T02:17:38.719Z] GC before operation: completed in 95.124 ms, heap usage 230.673 MB -> 115.672 MB.
[2024-08-24T02:17:39.827Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1437.760 ms) ======
[2024-08-24T02:17:39.827Z] ====== log-regression (apache-spark) [default], iteration 16 started ======
[2024-08-24T02:17:40.304Z] GC before operation: completed in 98.513 ms, heap usage 230.482 MB -> 115.904 MB.
[2024-08-24T02:17:41.452Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1523.839 ms) ======
[2024-08-24T02:17:41.452Z] ====== log-regression (apache-spark) [default], iteration 17 started ======
[2024-08-24T02:17:41.836Z] GC before operation: completed in 95.724 ms, heap usage 241.427 MB -> 116.115 MB.
[2024-08-24T02:17:43.022Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1328.834 ms) ======
[2024-08-24T02:17:43.022Z] ====== log-regression (apache-spark) [default], iteration 18 started ======
[2024-08-24T02:17:43.022Z] GC before operation: completed in 94.160 ms, heap usage 297.188 MB -> 116.446 MB.
[2024-08-24T02:17:44.163Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1207.830 ms) ======
[2024-08-24T02:17:44.163Z] ====== log-regression (apache-spark) [default], iteration 19 started ======
[2024-08-24T02:17:44.628Z] GC before operation: completed in 113.456 ms, heap usage 444.169 MB -> 117.004 MB.
[2024-08-24T02:17:45.768Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1466.864 ms) ======
[2024-08-24T02:17:46.085Z] -----------------------------------
[2024-08-24T02:17:46.085Z] renaissance-log-regression_0_PASSED
[2024-08-24T02:17:46.085Z] -----------------------------------
[2024-08-24T02:17:46.399Z]
[2024-08-24T02:17:46.399Z] TEST TEARDOWN:
[2024-08-24T02:17:46.399Z] Nothing to be done for teardown.
[2024-08-24T02:17:46.399Z] renaissance-log-regression_0 Finish Time: Sat Aug 24 02:17:46 2024 Epoch Time (ms): 1724465866179