[2025-03-27T14:57:27.373Z] Running test renaissance-finagle-http_0 ... [2025-03-27T14:57:27.373Z] =============================================== [2025-03-27T14:57:27.373Z] renaissance-finagle-http_0 Start Time: Thu Mar 27 14:57:27 2025 Epoch Time (ms): 1743087447205 [2025-03-27T14:57:27.373Z] variation: NoOptions [2025-03-27T14:57:27.373Z] JVM_OPTIONS: [2025-03-27T14:57:27.373Z] { \ [2025-03-27T14:57:27.373Z] echo ""; echo "TEST SETUP:"; \ [2025-03-27T14:57:27.373Z] echo "Nothing to be done for setup."; \ [2025-03-27T14:57:27.373Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1743086208764/renaissance-finagle-http_0"; \ [2025-03-27T14:57:27.373Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1743086208764/renaissance-finagle-http_0"; \ [2025-03-27T14:57:27.373Z] echo ""; echo "TESTING:"; \ [2025-03-27T14:57:27.373Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1743086208764/renaissance-finagle-http_0"/finagle-http.json" finagle-http; \ [2025-03-27T14:57:27.373Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1743086208764/renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-27T14:57:27.373Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-27T14:57:27.373Z] echo "Nothing to be done for teardown."; \ [2025-03-27T14:57:27.373Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1743086208764/TestTargetResult"; [2025-03-27T14:57:27.373Z] [2025-03-27T14:57:27.373Z] TEST SETUP: [2025-03-27T14:57:27.373Z] Nothing to be done for setup. [2025-03-27T14:57:27.373Z] [2025-03-27T14:57:27.373Z] TESTING: [2025-03-27T14:57:34.545Z] finagle-http on :38795 spawning 4 client and default number of server workers. [2025-03-27T14:57:34.545Z] ====== finagle-http (web) [default], iteration 0 started ====== [2025-03-27T14:57:34.545Z] GC before operation: completed in 49.025 ms, heap usage 17.862 MB -> 10.738 MB. [2025-03-27T14:58:42.745Z] ====== finagle-http (web) [default], iteration 0 completed (58476.162 ms) ====== [2025-03-27T14:58:42.745Z] ====== finagle-http (web) [default], iteration 1 started ====== [2025-03-27T14:58:42.745Z] GC before operation: completed in 139.237 ms, heap usage 57.956 MB -> 14.424 MB. [2025-03-27T14:59:09.234Z] ====== finagle-http (web) [default], iteration 1 completed (34396.563 ms) ====== [2025-03-27T14:59:09.234Z] ====== finagle-http (web) [default], iteration 2 started ====== [2025-03-27T14:59:09.234Z] GC before operation: completed in 108.948 ms, heap usage 61.656 MB -> 14.538 MB. [2025-03-27T14:59:25.826Z] ====== finagle-http (web) [default], iteration 2 completed (16369.363 ms) ====== [2025-03-27T14:59:25.826Z] ====== finagle-http (web) [default], iteration 3 started ====== [2025-03-27T14:59:25.826Z] GC before operation: completed in 142.315 ms, heap usage 82.102 MB -> 14.544 MB. [2025-03-27T14:59:39.974Z] ====== finagle-http (web) [default], iteration 3 completed (13898.125 ms) ====== [2025-03-27T14:59:39.974Z] ====== finagle-http (web) [default], iteration 4 started ====== [2025-03-27T14:59:39.974Z] GC before operation: completed in 111.602 ms, heap usage 50.203 MB -> 14.523 MB. [2025-03-27T14:59:54.156Z] ====== finagle-http (web) [default], iteration 4 completed (15489.181 ms) ====== [2025-03-27T14:59:54.156Z] ====== finagle-http (web) [default], iteration 5 started ====== [2025-03-27T14:59:54.156Z] GC before operation: completed in 134.680 ms, heap usage 28.649 MB -> 14.510 MB. [2025-03-27T15:00:08.339Z] ====== finagle-http (web) [default], iteration 5 completed (14635.458 ms) ====== [2025-03-27T15:00:08.339Z] ====== finagle-http (web) [default], iteration 6 started ====== [2025-03-27T15:00:09.147Z] GC before operation: completed in 163.064 ms, heap usage 38.685 MB -> 14.647 MB. [2025-03-27T15:00:25.728Z] ====== finagle-http (web) [default], iteration 6 completed (15258.302 ms) ====== [2025-03-27T15:00:25.729Z] ====== finagle-http (web) [default], iteration 7 started ====== [2025-03-27T15:00:25.729Z] GC before operation: completed in 153.808 ms, heap usage 75.565 MB -> 14.518 MB. [2025-03-27T15:00:39.844Z] ====== finagle-http (web) [default], iteration 7 completed (14387.329 ms) ====== [2025-03-27T15:00:39.844Z] ====== finagle-http (web) [default], iteration 8 started ====== [2025-03-27T15:00:39.844Z] GC before operation: completed in 112.052 ms, heap usage 22.919 MB -> 15.608 MB. [2025-03-27T15:00:54.541Z] ====== finagle-http (web) [default], iteration 8 completed (14453.845 ms) ====== [2025-03-27T15:00:54.541Z] ====== finagle-http (web) [default], iteration 9 started ====== [2025-03-27T15:00:54.541Z] GC before operation: completed in 180.611 ms, heap usage 94.460 MB -> 14.733 MB. [2025-03-27T15:01:11.048Z] ====== finagle-http (web) [default], iteration 9 completed (15581.338 ms) ====== [2025-03-27T15:01:11.048Z] ====== finagle-http (web) [default], iteration 10 started ====== [2025-03-27T15:01:11.048Z] GC before operation: completed in 148.142 ms, heap usage 19.886 MB -> 14.502 MB. [2025-03-27T15:01:27.590Z] ====== finagle-http (web) [default], iteration 10 completed (17308.114 ms) ====== [2025-03-27T15:01:27.590Z] ====== finagle-http (web) [default], iteration 11 started ====== [2025-03-27T15:01:27.590Z] GC before operation: completed in 119.983 ms, heap usage 44.488 MB -> 14.890 MB. [2025-03-27T15:01:44.109Z] ====== finagle-http (web) [default], iteration 11 completed (17824.229 ms) ====== [2025-03-27T15:01:44.911Z] ----------------------------------- [2025-03-27T15:01:44.911Z] renaissance-finagle-http_0_PASSED [2025-03-27T15:01:44.911Z] ----------------------------------- [2025-03-27T15:01:44.911Z] [2025-03-27T15:01:44.911Z] TEST TEARDOWN: [2025-03-27T15:01:44.911Z] Nothing to be done for teardown. [2025-03-27T15:01:44.911Z] renaissance-finagle-http_0 Finish Time: Thu Mar 27 15:01:44 2025 Epoch Time (ms): 1743087704793