runtime icon indicating copy to clipboard operation
runtime copied to clipboard

Test failure: Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent

Open karelz opened this issue 4 years ago • 3 comments

Test types:

  • System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2
  • System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test

Failures 3/12-9/3 (incl. PRs):

Day Run OS Test
8/25 Official run - release/6.0-rc1 SLES.12.Amd64.Open SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2
8/27 PR #58092 (main = 7.0) Ubuntu.1804.Amd64.Open SyncHttpHandler_HttpClientHandler_Cancellation_Test
9/2 PR #58336 (release/6.0) Ubuntu.1604.Amd64.Open SyncHttpHandler_HttpClientHandler_Cancellation_Test

Failure:

System.TimeoutException : The operation has timed out.

   at System.Net.Http.Functional.Tests.SocketsHttpHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent() in /_/src/libraries/System.Net.Http/tests/FunctionalTests/SocketsHttpHandlerTest.Cancellation.cs:line 111
--- End of stack trace from previous location ---
{
  "ErrorMessage": "Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent [FAIL]",
  "BuildRetry": false,
  "ExcludeConsoleLog": false
}

Build Information

Build: https://dev.azure.com/dnceng-public/public/_build/results?buildId=438937 Build error leg or test failing: Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent

Known issue validation

Build: :mag_right: https://dev.azure.com/dnceng-public/public/_build/results?buildId=438937 Error message validated: Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent [FAIL] Result validation: :white_check_mark: Known issue matched with the provided build. Validation performed at: 10/17/2023 7:26:38 AM UTC

Report

Build Definition Test Pull Request
561847 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
561839 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
561461 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
561456 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Http11_Cancellation_Test.ConnectionFailure_AfterInitialRequestCancelled_SecondRequestSucceedsOnNewConnection
561460 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
561470 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
559939 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
559938 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
554893 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
554887 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_PostScenarioTest.PostRewindableStreamContentMultipleTimes_StreamContentFullySent
554879 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
554899 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
553205 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Http11_Cancellation_Test.ConnectionFailure_AfterInitialRequestCancelled_SecondRequestSucceedsOnNewConnection
553195 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
552708 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
552706 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
552705 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_PostScenarioTest.PostNonRewindableContentUsingAuth_PreAuthenticate_Success
552146 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
552148 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
550619 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Http11_Cancellation_Test.ConnectionFailure_AfterInitialRequestCancelled_SecondRequestSucceedsOnNewConnection
549076 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
549060 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
547432 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
547440 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
545737 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
545715 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
544127 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
544128 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
544143 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
543608 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
543602 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
543169 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
543182 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
541738 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
541734 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
541739 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
540245 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
538644 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
538638 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
537031 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
537032 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
535300 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
533129 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
533117 dotnet/runtime System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
533125 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
531697 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
531700 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
531686 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
530217 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Http11_Cancellation_Test.ConnectionFailure_AfterInitialRequestCancelled_SecondRequestSucceedsOnNewConnection dotnet/runtime#97099
530038 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
530016 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
530031 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent
530022 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_PostScenarioTest.PostNonRewindableContentUsingAuth_PreAuthenticate_Success
528393 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
528392 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue
526643 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Http11_Cancellation_Test.ConnectTimeout_TimesOutSSLAuth_Throws
526657 dotnet/runtime System.Net.Http.Functional.Tests.SocketsHttpHandler_PostScenarioTest.PostNonRewindableContentUsingAuth_PreAuthenticate_Success
526653 dotnet/runtime System.Net.Http.Functional.Tests.TelemetryTest_Http30.EventSource_ConnectionPoolAtMaxConnections_LogsRequestLeftQueue

Summary

24-Hour Hit Count 7-Day Hit Count 1-Month Count
0 12 58

karelz avatar Sep 03 '21 13:09 karelz

Tagging subscribers to this area: @dotnet/ncl See info in area-owners.md if you want to be subscribed.

Issue Details

Test types:

  • System.Net.Http.Functional.Tests.SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2
  • System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test
Day Run OS Test
8/28 Official run - release/6.0-rc1 SLES.12.Amd64.Open SocketsHttpHandler_HttpClientHandler_Cancellation_Test_Http2
8/27 PR #58092 (main = 7.0) Ubuntu.1804.Amd64.Open SyncHttpHandler_HttpClientHandler_Cancellation_Test
9/2 PR #58336 (release/6.0) Ubuntu.1604.Amd64.Open SyncHttpHandler_HttpClientHandler_Cancellation_Test

Failure:

System.TimeoutException : The operation has timed out.

   at System.Net.Http.Functional.Tests.SocketsHttpHandler_Cancellation_Test.Expect100Continue_WaitsExpectedPeriodOfTimeBeforeSendingContent() in /_/src/libraries/System.Net.Http/tests/FunctionalTests/SocketsHttpHandlerTest.Cancellation.cs:line 111
--- End of stack trace from previous location ---
Author: karelz
Assignees: -
Labels:

area-System.Net.Http, test-run-core

Milestone: Future

ghost avatar Sep 03 '21 13:09 ghost

This issue seems to be a bit old but the failure message is the same I'm seeing every now and then.

This release/7.0-rc2 PR hit it: https://github.com/dotnet/runtime/pull/75932

  • Queue: Libraries Test Run release coreclr Linux x64 Debug
  • Job results: https://dev.azure.com/dnceng-public/public/_build/results?buildId=24574&view=logs&j=71afe768-e493-597c-228c-037834193aeb&t=fe87d331-02fa-5ca6-e382-69b0a11bb0f6&l=104
System.Net.Http.Functional.Tests.SyncHttpHandler_HttpClientHandler_Cancellation_Test.GetAsync_CancelDuringResponseBodyReceived_Unbuffered_TaskCanceledQuickly(chunkedTransfer: True, connectionClose: False, readOrCopyToAsync: False) [FAIL]
      System.TimeoutException : The operation has timed out.
      Stack Trace:
        /_/src/libraries/Common/tests/System/Net/Http/HttpClientHandlerTest.Cancellation.cs(260,0): at System.Net.Http.Functional.Tests.HttpClientHandler_Cancellation_Test.<>c__DisplayClass4_2.<<GetAsync_CancelDuringResponseBodyReceived_Unbuffered_TaskCanceledQuickly>b__0>d.MoveNext()
        --- End of stack trace from previous location ---
        /_/src/libraries/Common/tests/System/Net/Http/LoopbackServer.cs(101,0): at System.Net.Test.Common.LoopbackServer.CreateServerAsync(Func`2 funcAsync, Options options)
        /_/src/libraries/Common/tests/System/Net/Http/HttpClientHandlerTest.Cancellation.cs(228,0): at System.Net.Http.Functional.Tests.HttpClientHandler_Cancellation_Test.GetAsync_CancelDuringResponseBodyReceived_Unbuffered_TaskCanceledQuickly(Boolean chunkedTransfer, Boolean connectionClose, Boolean readOrCopyToAsync)
        --- End of stack trace from previous location ---

carlossanlop avatar Sep 21 '22 17:09 carlossanlop

Triage: this looks quite active, we should look into it.

ManickaP avatar Sep 20 '23 12:09 ManickaP

This should be fixed by #102699. I don't see any TimeoutException on Kusto in main within last 30 day as well (only handshake timeouts on QUIC which can be too short in some cases), and both reported issues are from release/6.0 and release/8.0 branches. I'd say let's close this and track this handshake timeout issue under another issue.

/cc @ManickaP

liveans avatar Jul 03 '24 10:07 liveans

Original bug fixed by #102699 in main. For handshake timeouts closing this in favor of #104426.

liveans avatar Jul 04 '24 11:07 liveans