[2024-07-31T22:51:01.956Z] Running test renaissance-finagle-http_0 ... [2024-07-31T22:51:01.956Z] =============================================== [2024-07-31T22:51:01.956Z] renaissance-finagle-http_0 Start Time: Wed Jul 31 22:51:01 2024 Epoch Time (ms): 1722466261848 [2024-07-31T22:51:01.956Z] variation: NoOptions [2024-07-31T22:51:01.956Z] JVM_OPTIONS: [2024-07-31T22:51:01.956Z] { \ [2024-07-31T22:51:01.956Z] echo ""; echo "TEST SETUP:"; \ [2024-07-31T22:51:01.956Z] echo "Nothing to be done for setup."; \ [2024-07-31T22:51:01.956Z] mkdir -p "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/../TKG/output_17224662605506/renaissance-finagle-http_0"; \ [2024-07-31T22:51:01.956Z] cd "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/../TKG/output_17224662605506/renaissance-finagle-http_0"; \ [2024-07-31T22:51:01.956Z] echo ""; echo "TESTING:"; \ [2024-07-31T22:51:01.956Z] "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/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 "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/../TKG/output_17224662605506/renaissance-finagle-http_0"/finagle-http.json" finagle-http; \ [2024-07-31T22:51:01.956Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd /ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/../TKG/output_17224662605506/renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-07-31T22:51:01.956Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-07-31T22:51:01.956Z] echo "Nothing to be done for teardown."; \ [2024-07-31T22:51:01.956Z] } 2>&1 | tee -a "/ssd/jenkins/workspace/Test_openjdk11_hs_extended.perf_arm_linux_testList_0/aqa-tests/TKG/../TKG/output_17224662605506/TestTargetResult"; [2024-07-31T22:51:01.956Z] [2024-07-31T22:51:01.956Z] TEST SETUP: [2024-07-31T22:51:01.956Z] Nothing to be done for setup. [2024-07-31T22:51:01.956Z] [2024-07-31T22:51:01.956Z] TESTING: [2024-07-31T22:51:11.768Z] [2024-07-31T22:51:10.709+0000] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-07-31T22:51:11.768Z] INFO: HttpMuxer[/admin/metrics.json] = com.twitter.finagle.stats.MetricsExporter(com.twitter.finagle.stats.MetricsExporter) [2024-07-31T22:51:11.768Z] [2024-07-31T22:51:10.787+0000] com.twitter.finagle.http.HttpMuxer$ (com.twitter.finagle.http.HttpMuxer$ $anonfun$new$1) [2024-07-31T22:51:11.768Z] INFO: HttpMuxer[/admin/per_host_metrics.json] = com.twitter.finagle.stats.HostMetricsExporter(com.twitter.finagle.stats.HostMetricsExporter) [2024-07-31T22:51:12.185Z] [2024-07-31T22:51:12.141+0000] com.twitter.finagle (com.twitter.finagle.Init$ $anonfun$once$1) [2024-07-31T22:51:12.185Z] INFO: Finagle version 21.12.0 (rev=95ec9bcb3d4db4553bdb7d90f07a034a6b6be5c0) built at 20211216-002149 [2024-07-31T22:51:13.048Z] finagle-http on :34113 spawning 8 client and default number of server workers. [2024-07-31T22:51:13.048Z] ====== finagle-http (web) [default], iteration 0 started ====== [2024-07-31T22:51:13.459Z] GC before operation: completed in 101.568 ms, heap usage 13.372 MB -> 9.705 MB. [2024-07-31T22:51:13.459Z] [2024-07-31T22:51:13.147+0000] com.twitter.finagle.BaseResolver (com.twitter.finagle.BaseResolver inetResolver$lzycompute) [2024-07-31T22:51:13.459Z] INFO: Using default inet resolver [2024-07-31T22:53:24.199Z] ====== finagle-http (web) [default], iteration 0 completed (125618.470 ms) ====== [2024-07-31T22:53:24.199Z] ====== finagle-http (web) [default], iteration 1 started ====== [2024-07-31T22:53:24.199Z] GC before operation: completed in 154.249 ms, heap usage 26.728 MB -> 15.194 MB. [2024-07-31T22:54:35.399Z] ====== finagle-http (web) [default], iteration 1 completed (65609.395 ms) ====== [2024-07-31T22:54:35.399Z] ====== finagle-http (web) [default], iteration 2 started ====== [2024-07-31T22:54:35.399Z] GC before operation: completed in 133.281 ms, heap usage 19.589 MB -> 15.299 MB. [2024-07-31T22:55:25.391Z] ====== finagle-http (web) [default], iteration 2 completed (57044.608 ms) ====== [2024-07-31T22:55:25.391Z] ====== finagle-http (web) [default], iteration 3 started ====== [2024-07-31T22:55:25.391Z] GC before operation: completed in 139.111 ms, heap usage 28.301 MB -> 15.332 MB. [2024-07-31T22:56:25.470Z] ====== finagle-http (web) [default], iteration 3 completed (57092.193 ms) ====== [2024-07-31T22:56:25.470Z] ====== finagle-http (web) [default], iteration 4 started ====== [2024-07-31T22:56:25.470Z] GC before operation: completed in 122.845 ms, heap usage 27.589 MB -> 15.299 MB. [2024-07-31T22:57:25.101Z] ====== finagle-http (web) [default], iteration 4 completed (56845.603 ms) ====== [2024-07-31T22:57:25.101Z] ====== finagle-http (web) [default], iteration 5 started ====== [2024-07-31T22:57:25.101Z] GC before operation: completed in 113.426 ms, heap usage 33.063 MB -> 15.349 MB. [2024-07-31T22:58:15.040Z] ====== finagle-http (web) [default], iteration 5 completed (56740.882 ms) ====== [2024-07-31T22:58:15.040Z] ====== finagle-http (web) [default], iteration 6 started ====== [2024-07-31T22:58:15.040Z] GC before operation: completed in 148.262 ms, heap usage 27.028 MB -> 15.332 MB. [2024-07-31T22:59:14.987Z] ====== finagle-http (web) [default], iteration 6 completed (57015.556 ms) ====== [2024-07-31T22:59:14.987Z] ====== finagle-http (web) [default], iteration 7 started ====== [2024-07-31T22:59:14.987Z] GC before operation: completed in 125.937 ms, heap usage 28.695 MB -> 14.712 MB. [2024-07-31T23:00:14.590Z] ====== finagle-http (web) [default], iteration 7 completed (56925.256 ms) ====== [2024-07-31T23:00:14.590Z] ====== finagle-http (web) [default], iteration 8 started ====== [2024-07-31T23:00:14.590Z] GC before operation: completed in 152.480 ms, heap usage 30.438 MB -> 14.198 MB. [2024-07-31T23:01:04.507Z] ====== finagle-http (web) [default], iteration 8 completed (57218.989 ms) ====== [2024-07-31T23:01:04.507Z] ====== finagle-http (web) [default], iteration 9 started ====== [2024-07-31T23:01:04.964Z] GC before operation: completed in 140.690 ms, heap usage 23.780 MB -> 14.197 MB. [2024-07-31T23:02:04.620Z] ====== finagle-http (web) [default], iteration 9 completed (57100.003 ms) ====== [2024-07-31T23:02:04.620Z] ====== finagle-http (web) [default], iteration 10 started ====== [2024-07-31T23:02:04.620Z] GC before operation: completed in 127.450 ms, heap usage 43.866 MB -> 13.519 MB. [2024-07-31T23:03:04.503Z] ====== finagle-http (web) [default], iteration 10 completed (56988.241 ms) ====== [2024-07-31T23:03:04.503Z] ====== finagle-http (web) [default], iteration 11 started ====== [2024-07-31T23:03:04.503Z] GC before operation: completed in 113.767 ms, heap usage 16.952 MB -> 13.547 MB. [2024-07-31T23:04:04.979Z] ====== finagle-http (web) [default], iteration 11 completed (57118.854 ms) ====== [2024-07-31T23:04:04.979Z] ----------------------------------- [2024-07-31T23:04:04.979Z] renaissance-finagle-http_0_PASSED [2024-07-31T23:04:04.979Z] ----------------------------------- [2024-07-31T23:04:04.979Z] [2024-07-31T23:04:04.979Z] TEST TEARDOWN: [2024-07-31T23:04:04.979Z] Nothing to be done for teardown. [2024-07-31T23:04:04.979Z] renaissance-finagle-http_0 Finish Time: Wed Jul 31 23:03:56 2024 Epoch Time (ms): 1722467036914