[2024-11-07T23:17:41.392Z] Running test renaissance-log-regression_0 ... [2024-11-07T23:17:41.392Z] =============================================== [2024-11-07T23:17:41.392Z] renaissance-log-regression_0 Start Time: Thu Nov 7 23:17:41 2024 Epoch Time (ms): 1731021461204 [2024-11-07T23:17:41.392Z] variation: NoOptions [2024-11-07T23:17:41.392Z] JVM_OPTIONS: [2024-11-07T23:17:41.392Z] { \ [2024-11-07T23:17:41.392Z] echo ""; echo "TEST SETUP:"; \ [2024-11-07T23:17:41.392Z] echo "Nothing to be done for setup."; \ [2024-11-07T23:17:41.392Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310206155553/renaissance-log-regression_0"; \ [2024-11-07T23:17:41.392Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310206155553/renaissance-log-regression_0"; \ [2024-11-07T23:17:41.392Z] echo ""; echo "TESTING:"; \ [2024-11-07T23:17:41.392Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310206155553/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-11-07T23:17:41.392Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310206155553/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-07T23:17:41.392Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-07T23:17:41.392Z] echo "Nothing to be done for teardown."; \ [2024-11-07T23:17:41.392Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17310206155553/TestTargetResult"; [2024-11-07T23:17:41.392Z] [2024-11-07T23:17:41.392Z] TEST SETUP: [2024-11-07T23:17:41.392Z] Nothing to be done for setup. [2024-11-07T23:17:41.392Z] [2024-11-07T23:17:41.392Z] TESTING: [2024-11-07T23:17:45.482Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-07T23:17:47.397Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-07T23:17:52.676Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-11-07T23:17:52.676Z] GC before operation: completed in 171.453 ms, heap usage 113.028 MB -> 27.164 MB. [2024-11-07T23:18:04.023Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10733.785 ms) ====== [2024-11-07T23:18:04.023Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-11-07T23:18:04.023Z] GC before operation: completed in 319.830 ms, heap usage 189.502 MB -> 99.583 MB. [2024-11-07T23:18:05.938Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2364.506 ms) ====== [2024-11-07T23:18:05.938Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-11-07T23:18:06.899Z] GC before operation: completed in 199.010 ms, heap usage 357.901 MB -> 101.539 MB. [2024-11-07T23:18:08.824Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2177.775 ms) ====== [2024-11-07T23:18:08.824Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-11-07T23:18:08.824Z] GC before operation: completed in 232.464 ms, heap usage 298.635 MB -> 101.596 MB. [2024-11-07T23:18:10.890Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2096.449 ms) ====== [2024-11-07T23:18:10.890Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-11-07T23:18:10.890Z] GC before operation: completed in 238.364 ms, heap usage 194.287 MB -> 101.026 MB. [2024-11-07T23:18:12.804Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1972.318 ms) ====== [2024-11-07T23:18:12.804Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-11-07T23:18:13.738Z] GC before operation: completed in 227.181 ms, heap usage 323.639 MB -> 102.456 MB. [2024-11-07T23:18:15.666Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1949.771 ms) ====== [2024-11-07T23:18:15.666Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-11-07T23:18:15.666Z] GC before operation: completed in 228.363 ms, heap usage 219.052 MB -> 101.897 MB. [2024-11-07T23:18:17.583Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1846.203 ms) ====== [2024-11-07T23:18:17.583Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-11-07T23:18:17.583Z] GC before operation: completed in 177.453 ms, heap usage 322.814 MB -> 103.047 MB. [2024-11-07T23:18:19.502Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1755.333 ms) ====== [2024-11-07T23:18:19.502Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-11-07T23:18:19.502Z] GC before operation: completed in 207.567 ms, heap usage 181.297 MB -> 102.088 MB. [2024-11-07T23:18:21.455Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1690.132 ms) ====== [2024-11-07T23:18:21.455Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-11-07T23:18:21.455Z] GC before operation: completed in 212.953 ms, heap usage 344.789 MB -> 103.712 MB. [2024-11-07T23:18:23.378Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1793.355 ms) ====== [2024-11-07T23:18:23.379Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-11-07T23:18:23.379Z] GC before operation: completed in 205.144 ms, heap usage 270.483 MB -> 103.361 MB. [2024-11-07T23:18:25.295Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1808.998 ms) ====== [2024-11-07T23:18:25.295Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-11-07T23:18:25.295Z] GC before operation: completed in 246.305 ms, heap usage 290.351 MB -> 103.767 MB. [2024-11-07T23:18:27.212Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1709.521 ms) ====== [2024-11-07T23:18:27.212Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-11-07T23:18:27.212Z] GC before operation: completed in 183.351 ms, heap usage 284.307 MB -> 103.944 MB. [2024-11-07T23:18:29.132Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1763.860 ms) ====== [2024-11-07T23:18:29.132Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-11-07T23:18:29.132Z] GC before operation: completed in 220.704 ms, heap usage 280.182 MB -> 104.094 MB. [2024-11-07T23:18:31.047Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1637.384 ms) ====== [2024-11-07T23:18:31.047Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-11-07T23:18:31.047Z] GC before operation: completed in 199.307 ms, heap usage 297.101 MB -> 104.440 MB. [2024-11-07T23:18:32.754Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1722.483 ms) ====== [2024-11-07T23:18:32.754Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-11-07T23:18:32.754Z] GC before operation: completed in 191.933 ms, heap usage 218.129 MB -> 104.047 MB. [2024-11-07T23:18:34.671Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1729.293 ms) ====== [2024-11-07T23:18:34.671Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-11-07T23:18:34.671Z] GC before operation: completed in 177.217 ms, heap usage 240.325 MB -> 104.591 MB. [2024-11-07T23:18:36.605Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1606.897 ms) ====== [2024-11-07T23:18:36.605Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-11-07T23:18:36.605Z] GC before operation: completed in 209.668 ms, heap usage 352.078 MB -> 105.835 MB. [2024-11-07T23:18:38.692Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1593.711 ms) ====== [2024-11-07T23:18:38.693Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-11-07T23:18:38.693Z] GC before operation: completed in 225.131 ms, heap usage 273.134 MB -> 105.351 MB. [2024-11-07T23:18:40.612Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1615.623 ms) ====== [2024-11-07T23:18:40.613Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-11-07T23:18:40.613Z] GC before operation: completed in 165.128 ms, heap usage 257.046 MB -> 105.493 MB. [2024-11-07T23:18:42.527Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1578.520 ms) ====== [2024-11-07T23:18:42.527Z] ----------------------------------- [2024-11-07T23:18:42.527Z] renaissance-log-regression_0_PASSED [2024-11-07T23:18:42.527Z] ----------------------------------- [2024-11-07T23:18:42.527Z] [2024-11-07T23:18:42.527Z] TEST TEARDOWN: [2024-11-07T23:18:42.527Z] Nothing to be done for teardown. [2024-11-07T23:18:42.527Z] renaissance-log-regression_0 Finish Time: Thu Nov 7 23:18:41 2024 Epoch Time (ms): 1731021521801