[2024-09-04T20:10:36.736Z] Running test renaissance-finagle-http_0 ... [2024-09-04T20:10:36.736Z] =============================================== [2024-09-04T20:10:37.421Z] renaissance-finagle-http_0 Start Time: Wed Sep 4 13:10:36 2024 Epoch Time (ms): 1725480636874 [2024-09-04T20:10:38.167Z] variation: NoOptions [2024-09-04T20:10:38.167Z] JVM_OPTIONS: [2024-09-04T20:10:38.167Z] { \ [2024-09-04T20:10:38.167Z] echo ""; echo "TEST SETUP:"; \ [2024-09-04T20:10:38.167Z] echo "Nothing to be done for setup."; \ [2024-09-04T20:10:38.167Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1725480610512/renaissance-finagle-http_0"; \ [2024-09-04T20:10:38.167Z] cd "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1725480610512/renaissance-finagle-http_0"; \ [2024-09-04T20:10:38.167Z] echo ""; echo "TESTING:"; \ [2024-09-04T20:10:38.167Z] "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_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_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1725480610512/renaissance-finagle-http_0"/finagle-http.json" finagle-http; \ [2024-09-04T20:10:38.167Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1725480610512/renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-04T20:10:38.167Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-04T20:10:38.167Z] echo "Nothing to be done for teardown."; \ [2024-09-04T20:10:38.167Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk21_hs_extended.perf_x86-64_mac/aqa-tests/TKG/../TKG/output_1725480610512/TestTargetResult"; [2024-09-04T20:10:38.167Z] [2024-09-04T20:10:38.167Z] TEST SETUP: [2024-09-04T20:10:38.167Z] Nothing to be done for setup. [2024-09-04T20:10:38.167Z] [2024-09-04T20:10:38.167Z] TESTING: [2024-09-04T20:11:03.707Z] [2024-09-04T13:11:00.982-0700] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-09-04T20:11:03.708Z] INFO: HttpMuxer[/admin/metrics.json] = com.twitter.finagle.stats.MetricsExporter(com.twitter.finagle.stats.MetricsExporter) [2024-09-04T20:11:03.708Z] [2024-09-04T13:11:01.178-0700] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-09-04T20:11:03.708Z] INFO: HttpMuxer[/admin/per_host_metrics.json] = com.twitter.finagle.stats.HostMetricsExporter(com.twitter.finagle.stats.HostMetricsExporter) [2024-09-04T20:11:06.814Z] [2024-09-04T13:11:05.886-0700] com.twitter.finagle (com.twitter.finagle.Init$ $anonfun$once$1) [2024-09-04T20:11:06.814Z] INFO: Finagle version 21.12.0 (rev=95ec9bcb3d4db4553bdb7d90f07a034a6b6be5c0) built at 20211216-002149 [2024-09-04T20:11:12.018Z] finagle-http on :49195 spawning 3 client and default number of server workers. [2024-09-04T20:11:12.018Z] ====== finagle-http (web) [default], iteration 0 started ====== [2024-09-04T20:11:13.184Z] GC before operation: completed in 1352.149 ms, heap usage 21.742 MB -> 9.485 MB. [2024-09-04T20:11:14.050Z] [2024-09-04T13:11:13.410-0700] com.twitter.finagle.BaseResolver (com.twitter.finagle.BaseResolver inetResolver$lzycompute) [2024-09-04T20:11:14.050Z] INFO: Using default inet resolver [2024-09-04T20:14:04.747Z] ====== finagle-http (web) [default], iteration 0 completed (166904.870 ms) ====== [2024-09-04T20:14:04.747Z] ====== finagle-http (web) [default], iteration 1 started ====== [2024-09-04T20:14:04.747Z] GC before operation: completed in 195.802 ms, heap usage 99.251 MB -> 12.829 MB. [2024-09-04T20:15:21.051Z] ====== finagle-http (web) [default], iteration 1 completed (76776.382 ms) ====== [2024-09-04T20:15:21.051Z] ====== finagle-http (web) [default], iteration 2 started ====== [2024-09-04T20:15:21.051Z] GC before operation: completed in 846.365 ms, heap usage 44.035 MB -> 13.203 MB. [2024-09-04T20:16:05.060Z] ====== finagle-http (web) [default], iteration 2 completed (43165.552 ms) ====== [2024-09-04T20:16:05.060Z] ====== finagle-http (web) [default], iteration 3 started ====== [2024-09-04T20:16:05.061Z] GC before operation: completed in 107.512 ms, heap usage 51.354 MB -> 13.330 MB. [2024-09-04T20:16:58.540Z] ====== finagle-http (web) [default], iteration 3 completed (49393.120 ms) ====== [2024-09-04T20:16:58.540Z] ====== finagle-http (web) [default], iteration 4 started ====== [2024-09-04T20:16:58.540Z] GC before operation: completed in 129.768 ms, heap usage 18.169 MB -> 13.360 MB. [2024-09-04T20:17:51.469Z] ====== finagle-http (web) [default], iteration 4 completed (53450.573 ms) ====== [2024-09-04T20:17:51.469Z] ====== finagle-http (web) [default], iteration 5 started ====== [2024-09-04T20:17:51.469Z] GC before operation: completed in 129.464 ms, heap usage 76.549 MB -> 13.342 MB. [2024-09-04T20:18:35.944Z] ====== finagle-http (web) [default], iteration 5 completed (45564.044 ms) ====== [2024-09-04T20:18:35.944Z] ====== finagle-http (web) [default], iteration 6 started ====== [2024-09-04T20:18:35.944Z] GC before operation: completed in 109.862 ms, heap usage 24.306 MB -> 13.305 MB. [2024-09-04T20:19:13.894Z] ====== finagle-http (web) [default], iteration 6 completed (42905.207 ms) ====== [2024-09-04T20:19:13.894Z] ====== finagle-http (web) [default], iteration 7 started ====== [2024-09-04T20:19:13.894Z] GC before operation: completed in 105.933 ms, heap usage 75.561 MB -> 13.330 MB. [2024-09-04T20:20:06.410Z] ====== finagle-http (web) [default], iteration 7 completed (45898.438 ms) ====== [2024-09-04T20:20:06.410Z] ====== finagle-http (web) [default], iteration 8 started ====== [2024-09-04T20:20:06.410Z] GC before operation: completed in 102.711 ms, heap usage 50.684 MB -> 13.337 MB. [2024-09-04T20:20:50.779Z] ====== finagle-http (web) [default], iteration 8 completed (47905.279 ms) ====== [2024-09-04T20:20:50.779Z] ====== finagle-http (web) [default], iteration 9 started ====== [2024-09-04T20:20:50.779Z] GC before operation: completed in 134.885 ms, heap usage 44.078 MB -> 13.342 MB. [2024-09-04T20:21:27.407Z] ====== finagle-http (web) [default], iteration 9 completed (39480.912 ms) ====== [2024-09-04T20:21:27.407Z] ====== finagle-http (web) [default], iteration 10 started ====== [2024-09-04T20:21:27.407Z] GC before operation: completed in 136.829 ms, heap usage 51.943 MB -> 13.374 MB. [2024-09-04T20:22:20.465Z] ====== finagle-http (web) [default], iteration 10 completed (46039.907 ms) ====== [2024-09-04T20:22:20.465Z] ====== finagle-http (web) [default], iteration 11 started ====== [2024-09-04T20:22:20.465Z] GC before operation: completed in 125.952 ms, heap usage 68.364 MB -> 13.318 MB. [2024-09-04T20:22:57.864Z] ====== finagle-http (web) [default], iteration 11 completed (41298.456 ms) ====== [2024-09-04T20:22:57.864Z] ----------------------------------- [2024-09-04T20:22:57.864Z] renaissance-finagle-http_0_PASSED [2024-09-04T20:22:57.864Z] ----------------------------------- [2024-09-04T20:22:57.864Z] [2024-09-04T20:22:57.864Z] TEST TEARDOWN: [2024-09-04T20:22:57.864Z] Nothing to be done for teardown. [2024-09-04T20:22:57.864Z] renaissance-finagle-http_0 Finish Time: Wed Sep 4 13:22:55 2024 Epoch Time (ms): 1725481375328