[2024-09-04T20:33:02.190Z] Running test renaissance-finagle-http_0 ... [2024-09-04T20:33:02.190Z] =============================================== [2024-09-04T20:33:02.190Z] renaissance-finagle-http_0 Start Time: Wed Sep 4 16:33:01 2024 Epoch Time (ms): 1725481981922 [2024-09-04T20:33:02.190Z] variation: NoOptions [2024-09-04T20:33:02.190Z] JVM_OPTIONS: [2024-09-04T20:33:02.190Z] { \ [2024-09-04T20:33:02.190Z] echo ""; echo "TEST SETUP:"; \ [2024-09-04T20:33:02.190Z] echo "Nothing to be done for setup."; \ [2024-09-04T20:33:02.190Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17254817594853/renaissance-finagle-http_0"; \ [2024-09-04T20:33:02.190Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17254817594853/renaissance-finagle-http_0"; \ [2024-09-04T20:33:02.190Z] echo ""; echo "TESTING:"; \ [2024-09-04T20:33:02.190Z] "/Users/admin/workspace/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17254817594853/renaissance-finagle-http_0"/finagle-http.json" finagle-http; \ [2024-09-04T20:33:02.190Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17254817594853/renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-04T20:33:02.190Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-04T20:33:02.190Z] echo "Nothing to be done for teardown."; \ [2024-09-04T20:33:02.190Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17254817594853/TestTargetResult"; [2024-09-04T20:33:02.190Z] [2024-09-04T20:33:02.190Z] TEST SETUP: [2024-09-04T20:33:02.190Z] Nothing to be done for setup. [2024-09-04T20:33:02.190Z] [2024-09-04T20:33:02.190Z] TESTING: [2024-09-04T20:33:03.439Z] [2024-09-04T16:33:03.238-0400] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-09-04T20:33:03.439Z] INFO: HttpMuxer[/admin/metrics.json] = com.twitter.finagle.stats.MetricsExporter(com.twitter.finagle.stats.MetricsExporter) [2024-09-04T20:33:03.439Z] [2024-09-04T16:33:03.246-0400] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-09-04T20:33:03.439Z] INFO: HttpMuxer[/admin/per_host_metrics.json] = com.twitter.finagle.stats.HostMetricsExporter(com.twitter.finagle.stats.HostMetricsExporter) [2024-09-04T20:33:03.821Z] [2024-09-04T16:33:03.442-0400] com.twitter.finagle (com.twitter.finagle.Init$ $anonfun$once$1) [2024-09-04T20:33:03.821Z] INFO: Finagle version 21.12.0 (rev=95ec9bcb3d4db4553bdb7d90f07a034a6b6be5c0) built at 20211216-002149 [2024-09-04T20:33:03.821Z] finagle-http on :49216 spawning 3 client and default number of server workers. [2024-09-04T20:33:03.821Z] ====== finagle-http (web) [default], iteration 0 started ====== [2024-09-04T20:33:03.821Z] GC before operation: completed in 0.547 ms, heap usage 17.306 MB -> 17.409 MB. [2024-09-04T20:33:03.821Z] [2024-09-04T16:33:03.591-0400] com.twitter.finagle.BaseResolver (com.twitter.finagle.BaseResolver inetResolver$lzycompute) [2024-09-04T20:33:03.821Z] INFO: Using default inet resolver [2024-09-04T20:33:13.052Z] ====== finagle-http (web) [default], iteration 0 completed (8302.241 ms) ====== [2024-09-04T20:33:13.052Z] ====== finagle-http (web) [default], iteration 1 started ====== [2024-09-04T20:33:13.052Z] GC before operation: completed in 41.499 ms, heap usage 41.893 MB -> 13.202 MB. [2024-09-04T20:33:18.035Z] ====== finagle-http (web) [default], iteration 1 completed (5477.087 ms) ====== [2024-09-04T20:33:18.035Z] ====== finagle-http (web) [default], iteration 2 started ====== [2024-09-04T20:33:18.035Z] GC before operation: completed in 22.965 ms, heap usage 57.023 MB -> 13.603 MB. [2024-09-04T20:33:22.018Z] ====== finagle-http (web) [default], iteration 2 completed (4373.429 ms) ====== [2024-09-04T20:33:22.018Z] ====== finagle-http (web) [default], iteration 3 started ====== [2024-09-04T20:33:22.018Z] GC before operation: completed in 18.877 ms, heap usage 39.565 MB -> 13.793 MB. [2024-09-04T20:33:25.987Z] ====== finagle-http (web) [default], iteration 3 completed (3733.197 ms) ====== [2024-09-04T20:33:25.987Z] ====== finagle-http (web) [default], iteration 4 started ====== [2024-09-04T20:33:25.987Z] GC before operation: completed in 24.901 ms, heap usage 19.031 MB -> 13.697 MB. [2024-09-04T20:33:29.113Z] ====== finagle-http (web) [default], iteration 4 completed (3305.723 ms) ====== [2024-09-04T20:33:29.113Z] ====== finagle-http (web) [default], iteration 5 started ====== [2024-09-04T20:33:29.113Z] GC before operation: completed in 27.409 ms, heap usage 71.607 MB -> 13.727 MB. [2024-09-04T20:33:32.246Z] ====== finagle-http (web) [default], iteration 5 completed (2735.776 ms) ====== [2024-09-04T20:33:32.246Z] ====== finagle-http (web) [default], iteration 6 started ====== [2024-09-04T20:33:32.246Z] GC before operation: completed in 27.870 ms, heap usage 46.477 MB -> 13.768 MB. [2024-09-04T20:33:34.637Z] ====== finagle-http (web) [default], iteration 6 completed (2343.304 ms) ====== [2024-09-04T20:33:34.637Z] ====== finagle-http (web) [default], iteration 7 started ====== [2024-09-04T20:33:34.637Z] GC before operation: completed in 20.924 ms, heap usage 60.564 MB -> 13.797 MB. [2024-09-04T20:33:37.057Z] ====== finagle-http (web) [default], iteration 7 completed (2594.369 ms) ====== [2024-09-04T20:33:37.057Z] ====== finagle-http (web) [default], iteration 8 started ====== [2024-09-04T20:33:37.057Z] GC before operation: completed in 25.200 ms, heap usage 80.663 MB -> 13.840 MB. [2024-09-04T20:33:39.461Z] ====== finagle-http (web) [default], iteration 8 completed (2330.311 ms) ====== [2024-09-04T20:33:39.461Z] ====== finagle-http (web) [default], iteration 9 started ====== [2024-09-04T20:33:39.461Z] GC before operation: completed in 25.696 ms, heap usage 34.834 MB -> 13.833 MB. [2024-09-04T20:33:41.855Z] ====== finagle-http (web) [default], iteration 9 completed (2484.883 ms) ====== [2024-09-04T20:33:41.855Z] ====== finagle-http (web) [default], iteration 10 started ====== [2024-09-04T20:33:41.855Z] GC before operation: completed in 16.579 ms, heap usage 64.814 MB -> 13.841 MB. [2024-09-04T20:33:44.253Z] ====== finagle-http (web) [default], iteration 10 completed (2522.750 ms) ====== [2024-09-04T20:33:44.253Z] ====== finagle-http (web) [default], iteration 11 started ====== [2024-09-04T20:33:44.253Z] GC before operation: completed in 20.792 ms, heap usage 64.212 MB -> 13.776 MB. [2024-09-04T20:33:46.665Z] ====== finagle-http (web) [default], iteration 11 completed (2403.845 ms) ====== [2024-09-04T20:33:47.433Z] ----------------------------------- [2024-09-04T20:33:47.433Z] renaissance-finagle-http_0_PASSED [2024-09-04T20:33:47.433Z] ----------------------------------- [2024-09-04T20:33:47.433Z] [2024-09-04T20:33:47.433Z] TEST TEARDOWN: [2024-09-04T20:33:47.433Z] Nothing to be done for teardown. [2024-09-04T20:33:47.433Z] renaissance-finagle-http_0 Finish Time: Wed Sep 4 16:33:47 2024 Epoch Time (ms): 1725482027042