[2024-11-22T22:01:04.626Z] Running test renaissance-finagle-http_0 ... [2024-11-22T22:01:04.626Z] =============================================== [2024-11-22T22:01:04.626Z] renaissance-finagle-http_0 Start Time: Fri Nov 22 22:01:03 2024 Epoch Time (ms): 1732312863397 [2024-11-22T22:01:04.626Z] variation: NoOptions [2024-11-22T22:01:04.626Z] JVM_OPTIONS: [2024-11-22T22:01:04.626Z] { \ [2024-11-22T22:01:04.626Z] echo ""; echo "TEST SETUP:"; \ [2024-11-22T22:01:04.626Z] echo "Nothing to be done for setup."; \ [2024-11-22T22:01:04.626Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17323126546768/renaissance-finagle-http_0"; \ [2024-11-22T22:01:04.626Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17323126546768/renaissance-finagle-http_0"; \ [2024-11-22T22:01:04.626Z] echo ""; echo "TESTING:"; \ [2024-11-22T22:01:04.626Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_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_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17323126546768/renaissance-finagle-http_0"/finagle-http.json" finagle-http; \ [2024-11-22T22:01:04.626Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17323126546768/renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-22T22:01:04.626Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-22T22:01:04.626Z] echo "Nothing to be done for teardown."; \ [2024-11-22T22:01:04.626Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17323126546768/TestTargetResult"; [2024-11-22T22:01:04.626Z] [2024-11-22T22:01:04.626Z] TEST SETUP: [2024-11-22T22:01:04.626Z] Nothing to be done for setup. [2024-11-22T22:01:04.626Z] [2024-11-22T22:01:04.626Z] TESTING: [2024-11-22T22:01:18.665Z] [2024-11-22T22:01:16.952+0000] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-11-22T22:01:18.665Z] INFO: HttpMuxer[/admin/metrics.json] = com.twitter.finagle.stats.MetricsExporter(com.twitter.finagle.stats.MetricsExporter) [2024-11-22T22:01:18.665Z] [2024-11-22T22:01:17.055+0000] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-11-22T22:01:18.665Z] INFO: HttpMuxer[/admin/per_host_metrics.json] = com.twitter.finagle.stats.HostMetricsExporter(com.twitter.finagle.stats.HostMetricsExporter) [2024-11-22T22:01:20.257Z] [2024-11-22T22:01:19.537+0000] com.twitter.finagle (com.twitter.finagle.Init$ $anonfun$once$1) [2024-11-22T22:01:20.257Z] INFO: Finagle version 21.12.0 (rev=95ec9bcb3d4db4553bdb7d90f07a034a6b6be5c0) built at 20211216-002149 [2024-11-22T22:01:21.860Z] finagle-http on :40883 spawning 4 client and default number of server workers. [2024-11-22T22:01:21.861Z] ====== finagle-http (web) [default], iteration 0 started ====== [2024-11-22T22:01:21.861Z] GC before operation: completed in 148.832 ms, heap usage 16.948 MB -> 9.862 MB. [2024-11-22T22:01:21.861Z] [2024-11-22T22:01:21.417+0000] com.twitter.finagle.BaseResolver (com.twitter.finagle.BaseResolver inetResolver$lzycompute) [2024-11-22T22:01:21.861Z] INFO: Using default inet resolver [2024-11-22T22:03:42.904Z] ====== finagle-http (web) [default], iteration 0 completed (130523.177 ms) ====== [2024-11-22T22:03:42.904Z] ====== finagle-http (web) [default], iteration 1 started ====== [2024-11-22T22:03:42.904Z] GC before operation: completed in 523.760 ms, heap usage 49.610 MB -> 13.589 MB. [2024-11-22T22:05:18.810Z] ====== finagle-http (web) [default], iteration 1 completed (93363.108 ms) ====== [2024-11-22T22:05:18.810Z] ====== finagle-http (web) [default], iteration 2 started ====== [2024-11-22T22:05:18.810Z] GC before operation: completed in 412.727 ms, heap usage 34.509 MB -> 13.684 MB. [2024-11-22T22:06:37.802Z] ====== finagle-http (web) [default], iteration 2 completed (86266.225 ms) ====== [2024-11-22T22:06:37.802Z] ====== finagle-http (web) [default], iteration 3 started ====== [2024-11-22T22:06:37.802Z] GC before operation: completed in 445.196 ms, heap usage 26.139 MB -> 13.722 MB. [2024-11-22T22:08:26.747Z] ====== finagle-http (web) [default], iteration 3 completed (110432.538 ms) ====== [2024-11-22T22:08:26.747Z] ====== finagle-http (web) [default], iteration 4 started ====== [2024-11-22T22:08:26.747Z] GC before operation: completed in 272.446 ms, heap usage 20.606 MB -> 13.698 MB. [2024-11-22T22:10:01.862Z] ====== finagle-http (web) [default], iteration 4 completed (97181.473 ms) ====== [2024-11-22T22:10:01.862Z] ====== finagle-http (web) [default], iteration 5 started ====== [2024-11-22T22:10:01.862Z] GC before operation: completed in 398.488 ms, heap usage 25.547 MB -> 13.697 MB. [2024-11-22T22:11:51.341Z] ====== finagle-http (web) [default], iteration 5 completed (97211.766 ms) ====== [2024-11-22T22:11:51.341Z] ====== finagle-http (web) [default], iteration 6 started ====== [2024-11-22T22:11:51.341Z] GC before operation: completed in 418.589 ms, heap usage 22.168 MB -> 13.704 MB. [2024-11-22T22:13:25.705Z] ====== finagle-http (web) [default], iteration 6 completed (95998.610 ms) ====== [2024-11-22T22:13:25.705Z] ====== finagle-http (web) [default], iteration 7 started ====== [2024-11-22T22:13:25.705Z] GC before operation: completed in 322.504 ms, heap usage 25.917 MB -> 13.709 MB. [2024-11-22T22:14:59.062Z] ====== finagle-http (web) [default], iteration 7 completed (90159.074 ms) ====== [2024-11-22T22:14:59.062Z] ====== finagle-http (web) [default], iteration 8 started ====== [2024-11-22T22:14:59.062Z] GC before operation: completed in 372.076 ms, heap usage 35.600 MB -> 13.714 MB. [2024-11-22T22:16:18.067Z] ====== finagle-http (web) [default], iteration 8 completed (87080.649 ms) ====== [2024-11-22T22:16:18.067Z] ====== finagle-http (web) [default], iteration 9 started ====== [2024-11-22T22:16:18.067Z] GC before operation: completed in 473.066 ms, heap usage 27.136 MB -> 13.758 MB. [2024-11-22T22:17:26.221Z] ====== finagle-http (web) [default], iteration 9 completed (67903.285 ms) ====== [2024-11-22T22:17:26.221Z] ====== finagle-http (web) [default], iteration 10 started ====== [2024-11-22T22:17:26.221Z] GC before operation: completed in 376.054 ms, heap usage 69.259 MB -> 13.749 MB. [2024-11-22T22:18:33.573Z] ====== finagle-http (web) [default], iteration 10 completed (71078.735 ms) ====== [2024-11-22T22:18:33.573Z] ====== finagle-http (web) [default], iteration 11 started ====== [2024-11-22T22:18:34.360Z] GC before operation: completed in 403.011 ms, heap usage 24.636 MB -> 13.712 MB. [2024-11-22T22:19:54.312Z] ====== finagle-http (web) [default], iteration 11 completed (75347.285 ms) ====== [2024-11-22T22:19:54.312Z] ----------------------------------- [2024-11-22T22:19:54.312Z] renaissance-finagle-http_0_PASSED [2024-11-22T22:19:54.312Z] ----------------------------------- [2024-11-22T22:19:54.312Z] [2024-11-22T22:19:54.312Z] TEST TEARDOWN: [2024-11-22T22:19:54.312Z] Nothing to be done for teardown. [2024-11-22T22:19:54.312Z] renaissance-finagle-http_0 Finish Time: Fri Nov 22 22:19:50 2024 Epoch Time (ms): 1732313990107