[2024-11-15T06:14:15.970Z] Running test renaissance-log-regression_0 ... [2024-11-15T06:14:15.970Z] =============================================== [2024-11-15T06:14:15.970Z] renaissance-log-regression_0 Start Time: Fri Nov 15 06:14:15 2024 Epoch Time (ms): 1731651255736 [2024-11-15T06:14:15.970Z] variation: NoOptions [2024-11-15T06:14:15.970Z] JVM_OPTIONS: [2024-11-15T06:14:16.606Z] { \ [2024-11-15T06:14:16.606Z] echo ""; echo "TEST SETUP:"; \ [2024-11-15T06:14:16.606Z] echo "Nothing to be done for setup."; \ [2024-11-15T06:14:16.606Z] mkdir -p "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17316492184916/renaissance-log-regression_0"; \ [2024-11-15T06:14:16.606Z] cd "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17316492184916/renaissance-log-regression_0"; \ [2024-11-15T06:14:16.606Z] echo ""; echo "TESTING:"; \ [2024-11-15T06:14:16.606Z] "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/jdkbinary/j2sdk-image/bin/java" -jar "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17316492184916/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-11-15T06:14:16.606Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/..; rm -f -r "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17316492184916/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-15T06:14:16.606Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-15T06:14:16.606Z] echo "Nothing to be done for teardown."; \ [2024-11-15T06:14:16.606Z] } 2>&1 | tee -a "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17316492184916/TestTargetResult"; [2024-11-15T06:14:16.606Z] [2024-11-15T06:14:16.606Z] TEST SETUP: [2024-11-15T06:14:16.606Z] Nothing to be done for setup. [2024-11-15T06:14:16.606Z] [2024-11-15T06:14:16.606Z] TESTING: [2024-11-15T06:14:27.088Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-15T06:14:32.059Z] NOTE: 'log-regression' benchmark uses Spark local executor with 1 (out of 1) threads. [2024-11-15T06:14:39.371Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-11-15T06:14:40.014Z] GC before operation: completed in 126.536 ms, heap usage 47.024 MB -> 23.787 MB. [2024-11-15T06:15:02.152Z] ====== log-regression (apache-spark) [default], iteration 0 completed (22107.263 ms) ====== [2024-11-15T06:15:02.152Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-11-15T06:15:02.152Z] GC before operation: completed in 291.944 ms, heap usage 218.581 MB -> 109.902 MB. [2024-11-15T06:15:08.583Z] ====== log-regression (apache-spark) [default], iteration 1 completed (6050.602 ms) ====== [2024-11-15T06:15:08.583Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-11-15T06:15:08.583Z] GC before operation: completed in 181.137 ms, heap usage 201.252 MB -> 107.903 MB. [2024-11-15T06:15:12.688Z] ====== log-regression (apache-spark) [default], iteration 2 completed (4574.950 ms) ====== [2024-11-15T06:15:12.688Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-11-15T06:15:13.339Z] GC before operation: completed in 263.443 ms, heap usage 234.778 MB -> 102.052 MB. [2024-11-15T06:15:17.225Z] ====== log-regression (apache-spark) [default], iteration 3 completed (4086.217 ms) ====== [2024-11-15T06:15:17.225Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-11-15T06:15:17.865Z] GC before operation: completed in 483.734 ms, heap usage 187.410 MB -> 108.716 MB. [2024-11-15T06:15:21.739Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3901.134 ms) ====== [2024-11-15T06:15:21.739Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-11-15T06:15:21.739Z] GC before operation: completed in 225.544 ms, heap usage 177.962 MB -> 109.874 MB. [2024-11-15T06:15:25.726Z] ====== log-regression (apache-spark) [default], iteration 5 completed (3641.623 ms) ====== [2024-11-15T06:15:25.726Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-11-15T06:15:25.726Z] GC before operation: completed in 253.747 ms, heap usage 234.762 MB -> 111.094 MB. [2024-11-15T06:15:29.611Z] ====== log-regression (apache-spark) [default], iteration 6 completed (3735.132 ms) ====== [2024-11-15T06:15:29.611Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-11-15T06:15:29.611Z] GC before operation: completed in 260.002 ms, heap usage 218.539 MB -> 102.254 MB. [2024-11-15T06:15:33.633Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3099.081 ms) ====== [2024-11-15T06:15:33.633Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-11-15T06:15:33.633Z] GC before operation: completed in 207.856 ms, heap usage 207.419 MB -> 110.682 MB. [2024-11-15T06:15:36.612Z] ====== log-regression (apache-spark) [default], iteration 8 completed (3403.007 ms) ====== [2024-11-15T06:15:36.612Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-11-15T06:15:36.612Z] GC before operation: completed in 192.655 ms, heap usage 215.178 MB -> 111.960 MB. [2024-11-15T06:15:39.619Z] ====== log-regression (apache-spark) [default], iteration 9 completed (3066.939 ms) ====== [2024-11-15T06:15:39.619Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-11-15T06:15:40.754Z] GC before operation: completed in 215.017 ms, heap usage 211.201 MB -> 111.897 MB. [2024-11-15T06:15:42.902Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3107.854 ms) ====== [2024-11-15T06:15:42.902Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-11-15T06:15:43.538Z] GC before operation: completed in 295.981 ms, heap usage 205.040 MB -> 102.990 MB. [2024-11-15T06:15:46.609Z] ====== log-regression (apache-spark) [default], iteration 11 completed (3102.967 ms) ====== [2024-11-15T06:15:46.609Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-11-15T06:15:46.609Z] GC before operation: completed in 195.907 ms, heap usage 196.143 MB -> 112.338 MB. [2024-11-15T06:15:49.572Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3011.389 ms) ====== [2024-11-15T06:15:49.572Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-11-15T06:15:49.572Z] GC before operation: completed in 199.283 ms, heap usage 200.353 MB -> 112.710 MB. [2024-11-15T06:15:52.558Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2960.193 ms) ====== [2024-11-15T06:15:52.559Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-11-15T06:15:53.208Z] GC before operation: completed in 227.392 ms, heap usage 196.736 MB -> 112.963 MB. [2024-11-15T06:15:56.259Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3125.680 ms) ====== [2024-11-15T06:15:56.259Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-11-15T06:15:56.259Z] GC before operation: completed in 231.875 ms, heap usage 196.437 MB -> 166.229 MB. [2024-11-15T06:15:59.238Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2878.544 ms) ====== [2024-11-15T06:15:59.239Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-11-15T06:15:59.239Z] GC before operation: completed in 242.237 ms, heap usage 276.450 MB -> 113.212 MB. [2024-11-15T06:16:02.205Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2945.742 ms) ====== [2024-11-15T06:16:02.205Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-11-15T06:16:02.839Z] GC before operation: completed in 214.352 ms, heap usage 222.279 MB -> 114.276 MB. [2024-11-15T06:16:05.813Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2771.794 ms) ====== [2024-11-15T06:16:05.813Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-11-15T06:16:05.813Z] GC before operation: completed in 193.121 ms, heap usage 224.045 MB -> 115.829 MB. [2024-11-15T06:16:08.778Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2968.072 ms) ====== [2024-11-15T06:16:08.778Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-11-15T06:16:08.778Z] GC before operation: completed in 248.140 ms, heap usage 221.979 MB -> 105.293 MB. [2024-11-15T06:16:11.985Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2646.822 ms) ====== [2024-11-15T06:16:12.622Z] ----------------------------------- [2024-11-15T06:16:12.622Z] renaissance-log-regression_0_PASSED [2024-11-15T06:16:12.622Z] ----------------------------------- [2024-11-15T06:16:12.622Z] [2024-11-15T06:16:12.622Z] TEST TEARDOWN: [2024-11-15T06:16:12.622Z] Nothing to be done for teardown. [2024-11-15T06:16:12.622Z] renaissance-log-regression_0 Finish Time: Fri Nov 15 06:16:11 2024 Epoch Time (ms): 1731651371955