[2025-03-06T23:25:09.431Z] Running test renaissance-finagle-http_0 ... [2025-03-06T23:25:09.431Z] =============================================== [2025-03-06T23:25:09.431Z] renaissance-finagle-http_0 Start Time: Thu Mar 6 23:25:09 2025 Epoch Time (ms): 1741303509089 [2025-03-06T23:25:09.431Z] variation: NoOptions [2025-03-06T23:25:09.431Z] JVM_OPTIONS: [2025-03-06T23:25:09.431Z] { \ [2025-03-06T23:25:09.431Z] echo ""; echo "TEST SETUP:"; \ [2025-03-06T23:25:09.431Z] echo "Nothing to be done for setup."; \ [2025-03-06T23:25:09.431Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17413035076445/renaissance-finagle-http_0"; \ [2025-03-06T23:25:09.431Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17413035076445/renaissance-finagle-http_0"; \ [2025-03-06T23:25:09.431Z] echo ""; echo "TESTING:"; \ [2025-03-06T23:25:09.431Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/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 "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17413035076445/renaissance-finagle-http_0"/finagle-http.json" finagle-http; \ [2025-03-06T23:25:09.431Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17413035076445/renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-06T23:25:09.431Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-06T23:25:09.431Z] echo "Nothing to be done for teardown."; \ [2025-03-06T23:25:09.431Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17413035076445/TestTargetResult"; [2025-03-06T23:25:09.431Z] [2025-03-06T23:25:09.431Z] TEST SETUP: [2025-03-06T23:25:09.431Z] Nothing to be done for setup. [2025-03-06T23:25:09.431Z] [2025-03-06T23:25:09.431Z] TESTING: [2025-03-06T23:25:14.024Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-03-06T23:25:14.024Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by io.netty.util.internal.PlatformDependent0$3 (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17413035076445/renaissance-finagle-http_0/harness-232510-12039077780224498070/twitter-finagle/lib/netty-common-4.1.72.Final.jar) [2025-03-06T23:25:14.024Z] WARNING: Please consider reporting this to the maintainers of class io.netty.util.internal.PlatformDependent0$3 [2025-03-06T23:25:14.024Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-03-06T23:25:14.024Z] [2025-03-06T23:25:13.721+0000] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2025-03-06T23:25:14.024Z] INFO: HttpMuxer[/admin/metrics.json] = com.twitter.finagle.stats.MetricsExporter(com.twitter.finagle.stats.MetricsExporter) [2025-03-06T23:25:14.024Z] [2025-03-06T23:25:13.738+0000] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2025-03-06T23:25:14.024Z] INFO: HttpMuxer[/admin/per_host_metrics.json] = com.twitter.finagle.stats.HostMetricsExporter(com.twitter.finagle.stats.HostMetricsExporter) [2025-03-06T23:25:16.209Z] WARNING: A restricted method in java.lang.System has been called [2025-03-06T23:25:16.209Z] WARNING: java.lang.System::loadLibrary has been called by io.netty.util.internal.NativeLibraryUtil in an unnamed module (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17413035076445/renaissance-finagle-http_0/harness-232510-12039077780224498070/twitter-finagle/lib/netty-common-4.1.72.Final.jar) [2025-03-06T23:25:16.209Z] WARNING: Use --enable-native-access=ALL-UNNAMED to avoid a warning for callers in this module [2025-03-06T23:25:16.209Z] WARNING: Restricted methods will be blocked in a future release unless native access is enabled [2025-03-06T23:25:16.209Z] [2025-03-06T23:25:16.209Z] [2025-03-06T23:25:14.878+0000] com.twitter.finagle (com.twitter.finagle.Init$ $anonfun$once$1) [2025-03-06T23:25:16.209Z] INFO: Finagle version 21.12.0 (rev=95ec9bcb3d4db4553bdb7d90f07a034a6b6be5c0) built at 20211216-002149 [2025-03-06T23:25:16.209Z] finagle-http on :45245 spawning 4 client and default number of server workers. [2025-03-06T23:25:16.209Z] ====== finagle-http (web) [default], iteration 0 started ====== [2025-03-06T23:25:16.209Z] GC before operation: completed in 124.132 ms, heap usage 18.030 MB -> 10.148 MB. [2025-03-06T23:25:16.209Z] [2025-03-06T23:25:15.854+0000] com.twitter.finagle.BaseResolver (com.twitter.finagle.BaseResolver inetResolver$lzycompute) [2025-03-06T23:25:16.209Z] INFO: Using default inet resolver [2025-03-06T23:26:24.195Z] ====== finagle-http (web) [default], iteration 0 completed (59903.930 ms) ====== [2025-03-06T23:26:24.195Z] ====== finagle-http (web) [default], iteration 1 started ====== [2025-03-06T23:26:24.195Z] GC before operation: completed in 166.668 ms, heap usage 41.345 MB -> 13.491 MB. [2025-03-06T23:26:43.555Z] ====== finagle-http (web) [default], iteration 1 completed (26446.080 ms) ====== [2025-03-06T23:26:43.555Z] ====== finagle-http (web) [default], iteration 2 started ====== [2025-03-06T23:26:43.555Z] GC before operation: completed in 175.386 ms, heap usage 25.810 MB -> 13.533 MB. [2025-03-06T23:27:02.804Z] ====== finagle-http (web) [default], iteration 2 completed (18358.121 ms) ====== [2025-03-06T23:27:02.804Z] ====== finagle-http (web) [default], iteration 3 started ====== [2025-03-06T23:27:02.804Z] GC before operation: completed in 83.335 ms, heap usage 70.687 MB -> 13.551 MB. [2025-03-06T23:27:23.887Z] ====== finagle-http (web) [default], iteration 3 completed (18464.522 ms) ====== [2025-03-06T23:27:23.887Z] ====== finagle-http (web) [default], iteration 4 started ====== [2025-03-06T23:27:23.887Z] GC before operation: completed in 129.681 ms, heap usage 38.154 MB -> 13.564 MB. [2025-03-06T23:27:35.846Z] ====== finagle-http (web) [default], iteration 4 completed (16147.752 ms) ====== [2025-03-06T23:27:35.846Z] ====== finagle-http (web) [default], iteration 5 started ====== [2025-03-06T23:27:36.635Z] GC before operation: completed in 83.551 ms, heap usage 18.537 MB -> 13.546 MB. [2025-03-06T23:27:53.102Z] ====== finagle-http (web) [default], iteration 5 completed (16311.923 ms) ====== [2025-03-06T23:27:53.102Z] ====== finagle-http (web) [default], iteration 6 started ====== [2025-03-06T23:27:53.102Z] GC before operation: completed in 109.334 ms, heap usage 47.153 MB -> 13.659 MB. [2025-03-06T23:28:09.626Z] ====== finagle-http (web) [default], iteration 6 completed (17108.793 ms) ====== [2025-03-06T23:28:09.626Z] ====== finagle-http (web) [default], iteration 7 started ====== [2025-03-06T23:28:09.626Z] GC before operation: completed in 85.726 ms, heap usage 26.220 MB -> 13.564 MB. [2025-03-06T23:28:32.495Z] ====== finagle-http (web) [default], iteration 7 completed (20760.908 ms) ====== [2025-03-06T23:28:32.495Z] ====== finagle-http (web) [default], iteration 8 started ====== [2025-03-06T23:28:32.495Z] GC before operation: completed in 203.716 ms, heap usage 71.594 MB -> 13.527 MB. [2025-03-06T23:28:51.011Z] ====== finagle-http (web) [default], iteration 8 completed (18464.134 ms) ====== [2025-03-06T23:28:51.011Z] ====== finagle-http (web) [default], iteration 9 started ====== [2025-03-06T23:28:51.011Z] GC before operation: completed in 76.652 ms, heap usage 70.856 MB -> 13.682 MB. [2025-03-06T23:29:03.499Z] ====== finagle-http (web) [default], iteration 9 completed (13127.119 ms) ====== [2025-03-06T23:29:03.499Z] ====== finagle-http (web) [default], iteration 10 started ====== [2025-03-06T23:29:03.499Z] GC before operation: completed in 106.749 ms, heap usage 28.839 MB -> 13.629 MB. [2025-03-06T23:29:19.835Z] ====== finagle-http (web) [default], iteration 10 completed (15997.905 ms) ====== [2025-03-06T23:29:19.835Z] ====== finagle-http (web) [default], iteration 11 started ====== [2025-03-06T23:29:19.835Z] GC before operation: completed in 92.692 ms, heap usage 58.554 MB -> 13.576 MB. [2025-03-06T23:29:40.373Z] ====== finagle-http (web) [default], iteration 11 completed (21306.952 ms) ====== [2025-03-06T23:29:40.373Z] ----------------------------------- [2025-03-06T23:29:40.373Z] renaissance-finagle-http_0_PASSED [2025-03-06T23:29:40.373Z] ----------------------------------- [2025-03-06T23:29:40.373Z] [2025-03-06T23:29:40.373Z] TEST TEARDOWN: [2025-03-06T23:29:40.373Z] Nothing to be done for teardown. [2025-03-06T23:29:40.373Z] renaissance-finagle-http_0 Finish Time: Thu Mar 6 23:29:40 2025 Epoch Time (ms): 1741303780261