Skip to content

Quarantine Microsoft.AspNetCore.Server.Kestrel.Sockets #60990

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom
Closed
ilonatommy opened this issue Mar 18, 2025 · 1 comment
Closed

Quarantine Microsoft.AspNetCore.Server.Kestrel.Sockets #60990

ilonatommy opened this issue Mar 18, 2025 · 1 comment
Labels
area-networking Includes servers, yarp, json patch, bedrock, websockets, http client factory, and http abstractions test-failure

Comments

@ilonatommy
Copy link
Member

Failing Test(s)

  • Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2
  • Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish

Error Message

 ---- System.IO.IOException : Unable to read data from the transport connection: An established connection was aborted by the software in your host machine..
-------- System.Net.Sockets.SocketException : An established connection was aborted by the software in your host machine.

OR

 System.TimeoutException : The operation has timed out.

Stacktrace

2025-03-17T15:20:05.0024707Z [xUnit.net 00:00:30.61]     Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2 [FAIL]
2025-03-17T15:20:05.0028238Z [xUnit.net 00:00:30.62]       System.Net.Http.HttpRequestException : The SSL connection could not be established, see inner exception.
2025-03-17T15:20:05.0031087Z [xUnit.net 00:00:30.62]       ---- System.IO.IOException : Unable to read data from the transport connection: An established connection was aborted by the software in your host machine..
2025-03-17T15:20:05.0034088Z [xUnit.net 00:00:30.62]       -------- System.Net.Sockets.SocketException : An established connection was aborted by the software in your host machine.
2025-03-17T15:20:05.0037557Z [xUnit.net 00:00:30.62]       Stack Trace:
2025-03-17T15:20:05.0040708Z [xUnit.net 00:00:30.62]            at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:05.0043202Z [xUnit.net 00:00:30.62]            at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:05.0045809Z [xUnit.net 00:00:30.62]            at System.Net.Http.HttpConnectionPool.InjectNewHttp2ConnectionAsync(QueueItem queueItem)
2025-03-17T15:20:05.0048714Z [xUnit.net 00:00:30.62]            at System.Threading.Tasks.TaskCompletionSourceWithCancellation`1.WaitWithCancellationAsync(CancellationToken cancellationToken)
2025-03-17T15:20:05.0051686Z [xUnit.net 00:00:30.62]            at System.Net.Http.HttpConnectionPool.SendWithVersionDetectionAndRetryAsync(HttpRequestMessage request, Boolean async, Boolean doRequestAuth, CancellationToken cancellationToken)
2025-03-17T15:20:05.0054504Z [xUnit.net 00:00:30.62]            at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:05.0057803Z [xUnit.net 00:00:30.62]            at System.Net.Http.HttpClient.GetStringAsyncCore(HttpRequestMessage request, CancellationToken cancellationToken)
2025-03-17T15:20:05.0060578Z [xUnit.net 00:00:30.62]         /_/src/Servers/Kestrel/test/FunctionalTests/Http2/HandshakeTests.cs(87,0): at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2()
2025-03-17T15:20:05.0124490Z [xUnit.net 00:00:30.62]         /_/src/Servers/Kestrel/test/FunctionalTests/Http2/HandshakeTests.cs(88,0): at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2()
2025-03-17T15:20:05.0188838Z [xUnit.net 00:00:30.62]         --- End of stack trace from previous location ---
2025-03-17T15:20:05.0191319Z [xUnit.net 00:00:30.62]         ----- Inner Stack Trace -----
2025-03-17T15:20:05.0305222Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](CancellationToken cancellationToken, Int32 estimatedSize)
2025-03-17T15:20:05.0307622Z [xUnit.net 00:00:30.62]            at System.Runtime.CompilerServices.PoolingAsyncValueTaskMethodBuilder`1.StateMachineBox`1.System.Threading.Tasks.Sources.IValueTaskSource<TResult>.GetResult(Int16 token)
2025-03-17T15:20:05.0309865Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.ReceiveHandshakeFrameAsync[TIOAdapter](CancellationToken cancellationToken)
2025-03-17T15:20:05.0312416Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.ForceAuthenticationAsync[TIOAdapter](Boolean receiveFirst, Byte[] reAuthenticationData, CancellationToken cancellationToken)
2025-03-17T15:20:05.0396039Z [xUnit.net 00:00:30.62]            at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:05.0435666Z [xUnit.net 00:00:30.62]         ----- Inner Stack Trace -----
2025-03-17T15:20:05.0438212Z [xUnit.net 00:00:30.62]            at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.CreateException(SocketError error, Boolean forAsyncThrow)
2025-03-17T15:20:05.0440625Z [xUnit.net 00:00:30.62]            at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ReceiveAsync(Socket socket, CancellationToken cancellationToken)
2025-03-17T15:20:05.0442639Z [xUnit.net 00:00:30.62]            at System.Net.Sockets.Socket.ReceiveAsync(Memory`1 buffer, SocketFlags socketFlags, Boolean fromNetworkStream, CancellationToken cancellationToken)
2025-03-17T15:20:05.0444923Z [xUnit.net 00:00:30.62]            at System.Net.Sockets.NetworkStream.ReadAsync(Memory`1 buffer, CancellationToken cancellationToken)
2025-03-17T15:20:05.0545987Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](CancellationToken cancellationToken, Int32 estimatedSize)
2025-03-17T15:20:05.0675252Z [xUnit.net 00:00:30.62]            at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:05.0678603Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](CancellationToken cancellationToken, Int32 estimatedSize)
2025-03-17T15:20:05.0680827Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.ReceiveHandshakeFrameAsync[TIOAdapter](CancellationToken cancellationToken)
2025-03-17T15:20:05.0682772Z [xUnit.net 00:00:30.62]            at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:05.0753031Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.ReceiveHandshakeFrameAsync[TIOAdapter](CancellationToken cancellationToken)
2025-03-17T15:20:05.0793257Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.ForceAuthenticationAsync[TIOAdapter](Boolean receiveFirst, Byte[] reAuthenticationData, CancellationToken cancellationToken)
2025-03-17T15:20:05.0843413Z [xUnit.net 00:00:30.62]            at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:05.0879479Z [xUnit.net 00:00:30.62]            at System.Net.Security.SslStream.ForceAuthenticationAsync[TIOAdapter](Boolean receiveFirst, Byte[] reAuthenticationData, CancellationToken cancellationToken)
2025-03-17T15:20:05.0882053Z [xUnit.net 00:00:30.63]            at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:05.0894032Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:05.0896480Z [xUnit.net 00:00:30.63]            at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:05.0901254Z [xUnit.net 00:00:30.63]            at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:05.0903768Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:05.0905646Z [xUnit.net 00:00:30.63]            at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:05.1028354Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:05.1156978Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:05.1261039Z [xUnit.net 00:00:30.63]            at System.Threading.Tasks.AwaitTaskContinuation.RunOrScheduleAction(IAsyncStateMachineBox box, Boolean allowInlining)
2025-03-17T15:20:05.1263596Z [xUnit.net 00:00:30.63]            at System.Threading.Tasks.Task.RunContinuations(Object continuationObject)
2025-03-17T15:20:05.1359282Z [xUnit.net 00:00:30.63]            at System.Threading.Tasks.Task`1.TrySetResult(TResult result)
2025-03-17T15:20:05.1717243Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.SetExistingTaskResult(Task`1 task, TResult result)
2025-03-17T15:20:05.1851502Z [xUnit.net 00:00:30.63]            at System.Net.Http.HttpConnectionPool.ConnectToTcpHostAsync(String host, Int32 port, HttpRequestMessage initialRequest, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:05.2028067Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:05.2037332Z [xUnit.net 00:00:30.63]            at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:05.2045540Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:05.2052482Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:05.2099718Z [xUnit.net 00:00:30.63]            at System.Threading.Tasks.AwaitTaskContinuation.RunOrScheduleAction(IAsyncStateMachineBox box, Boolean allowInlining)
2025-03-17T15:20:05.2128521Z [xUnit.net 00:00:30.63]            at System.Threading.Tasks.Task.RunContinuations(Object continuationObject)
2025-03-17T15:20:05.2448414Z [xUnit.net 00:00:30.63]            at System.Threading.Tasks.Task`1.TrySetResult(TResult result)
2025-03-17T15:20:05.2873114Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.SetExistingTaskResult(Task`1 task, TResult result)
2025-03-17T15:20:05.3273833Z [xUnit.net 00:00:30.63]            at System.Net.Sockets.Socket.<ConnectAsync>g__WaitForConnectWithCancellation|289_0(AwaitableSocketAsyncEventArgs saea, ValueTask connectTask, CancellationToken cancellationToken)
2025-03-17T15:20:05.3549620Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:05.4199967Z [xUnit.net 00:00:30.63]            at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:05.4496172Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:05.4725047Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:05.4735226Z [xUnit.net 00:00:30.63]            at System.Net.Sockets.SocketAsyncEventArgs.<DnsConnectAsync>g__Core|113_0(MultiConnectSocketAsyncEventArgs internalArgs, Task`1 addressesTask, Int32 port, SocketType socketType, ProtocolType protocolType, CancellationToken cancellationToken)
2025-03-17T15:20:05.4742977Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:05.4750899Z [xUnit.net 00:00:30.63]            at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:05.4757743Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:05.4764520Z [xUnit.net 00:00:30.63]            at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:05.4770310Z [xUnit.net 00:00:30.63]            at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:05.4779150Z [xUnit.net 00:00:30.63]            at System.Net.Sockets.SocketAsyncEventArgs.<>c.<.cctor>b__174_0(UInt32 errorCode, UInt32 numBytes, NativeOverlapped* nativeOverlapped)
2025-03-17T15:20:05.4784999Z [xUnit.net 00:00:30.63]            at System.Threading.PortableThreadPool.IOCompletionPoller.Event.Invoke()
2025-03-17T15:20:05.4791524Z [xUnit.net 00:00:30.63]            at System.Threading.ThreadPoolTypedWorkItemQueue.System.Threading.IThreadPoolWorkItem.Execute()
2025-03-17T15:20:05.4798305Z [xUnit.net 00:00:30.63]            at System.Threading.ThreadPoolWorkQueue.Dispatch()
2025-03-17T15:20:05.4804527Z [xUnit.net 00:00:30.63]            at System.Threading.PortableThreadPool.WorkerThread.WorkerThreadStart()
2025-03-17T15:20:05.4811094Z [xUnit.net 00:00:30.63]            at System.Threading.Thread.StartHelper.RunWorker()
2025-03-17T15:20:05.4863688Z [xUnit.net 00:00:30.63]         --- End of stack trace from previous location ---
2025-03-17T15:20:05.4883017Z [xUnit.net 00:00:30.63]         
2025-03-17T15:20:05.5409737Z [xUnit.net 00:00:30.63]       Output:
2025-03-17T15:20:05.5420926Z [xUnit.net 00:00:30.64]         | [0.023s] TestLifetime Information: Starting test TlsAlpnHandshakeSelectsHttp2From1and2 at 2025-03-17T15:19:44
2025-03-17T15:20:05.6289014Z [xUnit.net 00:00:30.64]         | [0.948s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting starting
2025-03-17T15:20:05.6355626Z [xUnit.net 00:00:30.64]         | [1.250s] Microsoft.Hosting.Lifetime Information: Now listening on: https://127.0.0.1:51370
2025-03-17T15:20:05.6515264Z [xUnit.net 00:00:30.64]         | [1.251s] Microsoft.AspNetCore.Hosting.Diagnostics Debug: Loaded hosting startup assembly Sockets.FunctionalTests
2025-03-17T15:20:05.6536322Z [xUnit.net 00:00:30.64]         | [1.251s] Microsoft.Hosting.Lifetime Information: Application started. Press Ctrl+C to shut down.
2025-03-17T15:20:05.6544119Z [xUnit.net 00:00:30.64]         | [1.251s] Microsoft.Hosting.Lifetime Information: Hosting environment: Production
2025-03-17T15:20:05.6551576Z [xUnit.net 00:00:30.64]         | [1.255s] Microsoft.Hosting.Lifetime Information: Content root path: C:\h\w\B41E09B7\w\A0EB0905\e\
2025-03-17T15:20:05.6558540Z [xUnit.net 00:00:30.64]         | [1.255s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting started
2025-03-17T15:20:05.7653590Z [xUnit.net 00:00:30.64]         | [1.255s] Microsoft.AspNetCore.Server.Kestrel Debug: TestServer is listening on port 51370
2025-03-17T15:20:05.9277140Z [xUnit.net 00:00:30.64]         | [3.882s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HNB5CSJ6CB3O" accepted.
2025-03-17T15:20:05.9782767Z [xUnit.net 00:00:30.64]         | [3.889s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HNB5CSJ6CB3O" started.
2025-03-17T15:20:05.9791820Z [xUnit.net 00:00:30.64]         | [13.908s] Microsoft.AspNetCore.Server.Kestrel.Https.Internal.HttpsConnectionMiddleware Debug: Authentication of the HTTPS connection timed out.
2025-03-17T15:20:05.9798175Z [xUnit.net 00:00:30.64]         | [13.913s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HNB5CSJ6CB3O" stopped.
2025-03-17T15:20:05.9805836Z [xUnit.net 00:00:30.64]         | [13.914s] Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets Debug: Connection id "0HNB5CSJ6CB3O" sending FIN because: "The Socket transport's send loop completed gracefully."
2025-03-17T15:20:05.9812877Z [xUnit.net 00:00:30.64]         | [20.532s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting stopping
2025-03-17T15:20:05.9820629Z [xUnit.net 00:00:30.64]         | [20.532s] Microsoft.Hosting.Lifetime Information: Application is shutting down...
2025-03-17T15:20:05.9828402Z [xUnit.net 00:00:30.64]         | [20.533s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting stopped
2025-03-17T15:20:05.9835421Z [xUnit.net 00:00:30.64]         | [20.591s] Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests Error: Test threw an exception.
2025-03-17T15:20:05.9844874Z [xUnit.net 00:00:30.64]         | System.Net.Http.HttpRequestException: The SSL connection could not be established, see inner exception.
2025-03-17T15:20:05.9853393Z [xUnit.net 00:00:30.64]         |  ---> System.IO.IOException: Unable to read data from the transport connection: An established connection was aborted by the software in your host machine..
2025-03-17T15:20:05.9860976Z [xUnit.net 00:00:30.64]         |  ---> System.Net.Sockets.SocketException (10053): An established connection was aborted by the software in your host machine.
2025-03-17T15:20:05.9870668Z [xUnit.net 00:00:30.64]         |    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.CreateException(SocketError error, Boolean forAsyncThrow)
2025-03-17T15:20:05.9881229Z [xUnit.net 00:00:30.64]         |    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ReceiveAsync(Socket socket, CancellationToken cancellationToken)
2025-03-17T15:20:05.9889405Z [xUnit.net 00:00:30.64]         |    at System.Net.Sockets.Socket.ReceiveAsync(Memory`1 buffer, SocketFlags socketFlags, Boolean fromNetworkStream, CancellationToken cancellationToken)
2025-03-17T15:20:05.9898360Z [xUnit.net 00:00:30.64]         |    at System.Net.Sockets.NetworkStream.ReadAsync(Memory`1 buffer, CancellationToken cancellationToken)
2025-03-17T15:20:05.9911499Z [xUnit.net 00:00:30.64]         |    at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](CancellationToken cancellationToken, Int32 estimatedSize)
2025-03-17T15:20:05.9921009Z [xUnit.net 00:00:30.64]         |    at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:05.9930743Z [xUnit.net 00:00:30.64]         |    at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](CancellationToken cancellationToken, Int32 estimatedSize)
2025-03-17T15:20:06.1221890Z [xUnit.net 00:00:30.64]         |    at System.Net.Security.SslStream.ReceiveHandshakeFrameAsync[TIOAdapter](CancellationToken cancellationToken)
2025-03-17T15:20:06.3471466Z [xUnit.net 00:00:30.64]         |    at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:06.4290974Z [xUnit.net 00:00:30.64]         |    at System.Net.Security.SslStream.ReceiveHandshakeFrameAsync[TIOAdapter](CancellationToken cancellationToken)
2025-03-17T15:20:06.6067020Z [xUnit.net 00:00:30.64]         |    at System.Net.Security.SslStream.ForceAuthenticationAsync[TIOAdapter](Boolean receiveFirst, Byte[] reAuthenticationData, CancellationToken cancellationToken)
2025-03-17T15:20:06.8319814Z [xUnit.net 00:00:30.64]         |    at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:06.9762445Z [xUnit.net 00:00:30.64]         |    at System.Net.Security.SslStream.ForceAuthenticationAsync[TIOAdapter](Boolean receiveFirst, Byte[] reAuthenticationData, CancellationToken cancellationToken)
2025-03-17T15:20:07.0906078Z [xUnit.net 00:00:30.64]         |    at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:07.2297773Z [xUnit.net 00:00:30.64]         |    at System.Runtime.CompilerServices.AsyncMethodBuilderCore.Start[TStateMachine](TStateMachine& stateMachine)
2025-03-17T15:20:07.4136405Z [xUnit.net 00:00:30.64]         |    at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:07.5917315Z [xUnit.net 00:00:30.64]         |    at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:07.7711986Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:07.9635281Z [xUnit.net 00:00:30.65]         |    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:08.1921670Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:08.3696411Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:08.4576591Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.AwaitTaskContinuation.RunOrScheduleAction(IAsyncStateMachineBox box, Boolean allowInlining)
2025-03-17T15:20:08.5647905Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.Task.RunContinuations(Object continuationObject)
2025-03-17T15:20:08.7148516Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.Task`1.TrySetResult(TResult result)
2025-03-17T15:20:08.9939377Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.SetExistingTaskResult(Task`1 task, TResult result)
2025-03-17T15:20:09.2734293Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.HttpConnectionPool.ConnectToTcpHostAsync(String host, Int32 port, HttpRequestMessage initialRequest, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:09.3241433Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:09.3607601Z [xUnit.net 00:00:30.65]         |    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:09.3957001Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:09.4035469Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:09.4103871Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.AwaitTaskContinuation.RunOrScheduleAction(IAsyncStateMachineBox box, Boolean allowInlining)
2025-03-17T15:20:09.4107657Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.Task.RunContinuations(Object continuationObject)
2025-03-17T15:20:09.4379593Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.Task`1.TrySetResult(TResult result)
2025-03-17T15:20:09.4425350Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.SetExistingTaskResult(Task`1 task, TResult result)
2025-03-17T15:20:09.4539475Z [xUnit.net 00:00:30.65]         |    at System.Net.Sockets.Socket.<ConnectAsync>g__WaitForConnectWithCancellation|289_0(AwaitableSocketAsyncEventArgs saea, ValueTask connectTask, CancellationToken cancellationToken)
2025-03-17T15:20:09.4551277Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:09.4553955Z [xUnit.net 00:00:30.65]         |    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:09.4556735Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:09.4558631Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:09.4560449Z [xUnit.net 00:00:30.65]         |    at System.Net.Sockets.SocketAsyncEventArgs.<DnsConnectAsync>g__Core|113_0(MultiConnectSocketAsyncEventArgs internalArgs, Task`1 addressesTask, Int32 port, SocketType socketType, ProtocolType protocolType, CancellationToken cancellationToken)
2025-03-17T15:20:09.4562208Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.ExecutionContextCallback(Object s)
2025-03-17T15:20:09.4776878Z [xUnit.net 00:00:30.65]         |    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:09.4809299Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext(Thread threadPoolThread)
2025-03-17T15:20:09.4897231Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1.AsyncStateMachineBox`1.MoveNext()
2025-03-17T15:20:09.4900453Z [xUnit.net 00:00:30.65]         |    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
2025-03-17T15:20:09.4902868Z [xUnit.net 00:00:30.65]         |    at System.Net.Sockets.SocketAsyncEventArgs.<>c.<.cctor>b__174_0(UInt32 errorCode, UInt32 numBytes, NativeOverlapped* nativeOverlapped)
2025-03-17T15:20:09.4904946Z [xUnit.net 00:00:30.65]         |    at System.Threading.PortableThreadPool.IOCompletionPoller.Event.Invoke()
2025-03-17T15:20:09.4980407Z [xUnit.net 00:00:30.65]         |    at System.Threading.ThreadPoolTypedWorkItemQueue.System.Threading.IThreadPoolWorkItem.Execute()
2025-03-17T15:20:09.4998346Z [xUnit.net 00:00:30.65]         |    at System.Threading.ThreadPoolWorkQueue.Dispatch()
2025-03-17T15:20:09.5126052Z [xUnit.net 00:00:30.65]         |    at System.Threading.PortableThreadPool.WorkerThread.WorkerThreadStart()
2025-03-17T15:20:09.5144358Z [xUnit.net 00:00:30.65]         |    at System.Threading.Thread.StartHelper.RunWorker()
2025-03-17T15:20:09.5160398Z [xUnit.net 00:00:30.65]         | --- End of stack trace from previous location ---
2025-03-17T15:20:09.5199400Z [xUnit.net 00:00:30.65]         |    --- End of inner exception stack trace ---
2025-03-17T15:20:09.5208336Z [xUnit.net 00:00:30.65]         |    at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](CancellationToken cancellationToken, Int32 estimatedSize)
2025-03-17T15:20:09.5240161Z [xUnit.net 00:00:30.65]         |    at System.Runtime.CompilerServices.PoolingAsyncValueTaskMethodBuilder`1.StateMachineBox`1.System.Threading.Tasks.Sources.IValueTaskSource<TResult>.GetResult(Int16 token)
2025-03-17T15:20:09.5244816Z [xUnit.net 00:00:30.65]         |    at System.Net.Security.SslStream.ReceiveHandshakeFrameAsync[TIOAdapter](CancellationToken cancellationToken)
2025-03-17T15:20:09.5248589Z [xUnit.net 00:00:30.65]         |    at System.Net.Security.SslStream.ForceAuthenticationAsync[TIOAdapter](Boolean receiveFirst, Byte[] reAuthenticationData, CancellationToken cancellationToken)
2025-03-17T15:20:09.5250735Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:09.5260033Z [xUnit.net 00:00:30.65]         |    --- End of inner exception stack trace ---
2025-03-17T15:20:09.5262969Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.ConnectHelper.EstablishSslConnectionAsync(SslClientAuthenticationOptions sslOptions, HttpRequestMessage request, Boolean async, Stream stream, CancellationToken cancellationToken)
2025-03-17T15:20:09.5265694Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.HttpConnectionPool.ConnectAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:09.5267290Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.HttpConnectionPool.InjectNewHttp2ConnectionAsync(QueueItem queueItem)
2025-03-17T15:20:09.5269384Z [xUnit.net 00:00:30.65]         |    at System.Threading.Tasks.TaskCompletionSourceWithCancellation`1.WaitWithCancellationAsync(CancellationToken cancellationToken)
2025-03-17T15:20:09.5289491Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.HttpConnectionPool.SendWithVersionDetectionAndRetryAsync(HttpRequestMessage request, Boolean async, Boolean doRequestAuth, CancellationToken cancellationToken)
2025-03-17T15:20:09.5306023Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.RedirectHandler.SendAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
2025-03-17T15:20:09.5312166Z [xUnit.net 00:00:30.65]         |    at System.Net.Http.HttpClient.GetStringAsyncCore(HttpRequestMessage request, CancellationToken cancellationToken)
2025-03-17T15:20:09.5343581Z [xUnit.net 00:00:30.65]         |    at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2() in /_/src/Servers/Kestrel/test/FunctionalTests/Http2/HandshakeTests.cs:line 87
2025-03-17T15:20:09.5352191Z [xUnit.net 00:00:30.65]         |    at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2() in /_/src/Servers/Kestrel/test/FunctionalTests/Http2/HandshakeTests.cs:line 88
2025-03-17T15:20:09.5355092Z [xUnit.net 00:00:30.65]         |    at Xunit.Sdk.TestInvoker`1.<>c__DisplayClass47_0.<<InvokeTestMethodAsync>b__1>d.MoveNext() in /_/src/xunit.execution/Sdk/Frameworks/Runners/TestInvoker.cs:line 259
2025-03-17T15:20:09.5357613Z [xUnit.net 00:00:30.66]         | --- End of stack trace from previous location ---
2025-03-17T15:20:09.5361287Z [xUnit.net 00:00:30.66]         |    at Xunit.Sdk.ExecutionTimer.AggregateAsync(Func`1 asyncAction) in /_/src/xunit.execution/Sdk/Frameworks/ExecutionTimer.cs:line 48
2025-03-17T15:20:09.5363108Z [xUnit.net 00:00:30.66]         |    at Xunit.Sdk.ExceptionAggregator.RunAsync(Func`1 code) in /_/src/xunit.core/Sdk/ExceptionAggregator.cs:line 90
2025-03-17T15:20:09.5364858Z [xUnit.net 00:00:30.66]         | [20.602s] TestLifetime Information: Finished test TlsAlpnHandshakeSelectsHttp2From1and2 in 20.5792253s

2025-03-17T15:22:13.3394341Z [xUnit.net 00:02:36.89]     Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish [FAIL]
2025-03-17T15:22:13.3408313Z [xUnit.net 00:02:36.89]       System.TimeoutException : The operation has timed out.
2025-03-17T15:22:13.3420537Z [xUnit.net 00:02:36.89]       Stack Trace:
2025-03-17T15:22:13.3434976Z [xUnit.net 00:02:36.89]         /_/src/Shared/TaskExtensions.cs(123,0): at Microsoft.AspNetCore.InternalTesting.TaskExtensions.TimeoutAfter(Task task, TimeSpan timeout, String filePath, Int32 lineNumber)
2025-03-17T15:22:13.3451251Z [xUnit.net 00:02:36.89]         /_/src/Servers/Kestrel/test/FunctionalTests/Http2/ShutdownTests.cs(196,0): at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish()
2025-03-17T15:22:13.3464285Z [xUnit.net 00:02:36.89]         /_/src/Servers/Kestrel/test/FunctionalTests/Http2/ShutdownTests.cs(215,0): at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish()
2025-03-17T15:22:13.3476543Z [xUnit.net 00:02:36.89]         --- End of stack trace from previous location ---
2025-03-17T15:22:13.3488779Z [xUnit.net 00:02:36.89]       Output:
2025-03-17T15:22:13.3502958Z [xUnit.net 00:02:36.89]         | [0.002s] TestLifetime Information: Starting test GracefulTurnsAbortiveIfRequestsDoNotFinish at 2025-03-17T15:19:43
2025-03-17T15:22:13.3515202Z [xUnit.net 00:02:36.89]         | [1.548s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting starting
2025-03-17T15:22:13.3529177Z [xUnit.net 00:02:36.89]         | [1.851s] Microsoft.Hosting.Lifetime Information: Now listening on: https://127.0.0.1:51369
2025-03-17T15:22:13.3541432Z [xUnit.net 00:02:36.89]         | [1.851s] Microsoft.AspNetCore.Hosting.Diagnostics Debug: Loaded hosting startup assembly Sockets.FunctionalTests
2025-03-17T15:22:13.3554849Z [xUnit.net 00:02:36.89]         | [1.852s] Microsoft.Hosting.Lifetime Information: Application started. Press Ctrl+C to shut down.
2025-03-17T15:22:13.3570043Z [xUnit.net 00:02:36.89]         | [1.852s] Microsoft.Hosting.Lifetime Information: Hosting environment: Production
2025-03-17T15:22:13.3582202Z [xUnit.net 00:02:36.89]         | [1.855s] Microsoft.Hosting.Lifetime Information: Content root path: C:\h\w\B41E09B7\w\A0EB0905\e\
2025-03-17T15:22:13.3595386Z [xUnit.net 00:02:36.90]         | [1.855s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting started
2025-03-17T15:22:13.3608917Z [xUnit.net 00:02:36.90]         | [1.855s] Microsoft.AspNetCore.Server.Kestrel Debug: TestServer is listening on port 51369
2025-03-17T15:22:13.3622111Z [xUnit.net 00:02:36.90]         | [4.489s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HNB5CSJ6CB3P" accepted.
2025-03-17T15:22:13.3780673Z [xUnit.net 00:02:36.90]         | [4.499s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HNB5CSJ6CB3P" started.
2025-03-17T15:22:13.3793951Z [xUnit.net 00:02:36.90]         | [14.514s] Microsoft.AspNetCore.Server.Kestrel.Https.Internal.HttpsConnectionMiddleware Debug: Authentication of the HTTPS connection timed out.
2025-03-17T15:22:13.4291219Z [xUnit.net 00:02:36.90]         | [14.515s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HNB5CSJ6CB3P" stopped.
2025-03-17T15:22:13.4371659Z [xUnit.net 00:02:36.90]         | [14.515s] Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets Debug: Connection id "0HNB5CSJ6CB3P" sending FIN because: "The Socket transport's send loop completed gracefully."
2025-03-17T15:22:13.4409510Z [xUnit.net 00:02:36.90]         | [31.926s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting stopping
2025-03-17T15:22:13.4452672Z [xUnit.net 00:02:36.90]         | [31.926s] Microsoft.Hosting.Lifetime Information: Application is shutting down...
2025-03-17T15:22:13.4529185Z [xUnit.net 00:02:36.90]         | [31.927s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting stopped
2025-03-17T15:22:13.4586901Z [xUnit.net 00:02:36.90]         | [31.928s] Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests Error: Test threw an exception.
2025-03-17T15:22:13.4627134Z [xUnit.net 00:02:36.90]         | System.TimeoutException: The operation has timed out.
2025-03-17T15:22:13.4671248Z [xUnit.net 00:02:36.90]         |    at Microsoft.AspNetCore.InternalTesting.TaskExtensions.TimeoutAfter(Task task, TimeSpan timeout, String filePath, Int32 lineNumber) in /_/src/Shared/TaskExtensions.cs:line 123
2025-03-17T15:22:13.4687697Z [xUnit.net 00:02:36.90]         |    at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish() in /_/src/Servers/Kestrel/test/FunctionalTests/Http2/ShutdownTests.cs:line 196
2025-03-17T15:22:13.4700293Z [xUnit.net 00:02:36.90]         |    at Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish() in /_/src/Servers/Kestrel/test/FunctionalTests/Http2/ShutdownTests.cs:line 215
2025-03-17T15:22:13.4745057Z [xUnit.net 00:02:36.90]         |    at Xunit.Sdk.TestInvoker`1.<>c__DisplayClass47_0.<<InvokeTestMethodAsync>b__1>d.MoveNext() in /_/src/xunit.execution/Sdk/Frameworks/Runners/TestInvoker.cs:line 259
2025-03-17T15:22:13.4754996Z [xUnit.net 00:02:36.90]         | --- End of stack trace from previous location ---
2025-03-17T15:22:13.4790158Z [xUnit.net 00:02:36.90]         |    at Xunit.Sdk.ExecutionTimer.AggregateAsync(Func`1 asyncAction) in /_/src/xunit.execution/Sdk/Frameworks/ExecutionTimer.cs:line 48
2025-03-17T15:22:13.4809387Z [xUnit.net 00:02:36.90]         |    at Xunit.Sdk.ExceptionAggregator.RunAsync(Func`1 code) in /_/src/xunit.core/Sdk/ExceptionAggregator.cs:line 90
2025-03-17T15:22:13.4821733Z [xUnit.net 00:02:36.90]         | [31.929s] TestLifetime Information: Finished test GracefulTurnsAbortiveIfRequestsDoNotFinish in 31.9272992s

Logs

error : (NETCORE_ENGINEERING_TELEMETRY=Test) Test Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.HandshakeTests.TlsAlpnHandshakeSelectsHttp2From1and2 has failed. Check the Test tab or this console log: https://helix.dot.net/api/2019-06-17/jobs/8bc7329a-8dee-4684-b8cc-9a4c227705ef/workitems/Sockets.FunctionalTests--net10.0/console
error : (NETCORE_ENGINEERING_TELEMETRY=Test) Test Microsoft.AspNetCore.Server.Kestrel.Sockets.FunctionalTests.Http2.ShutdownTests.GracefulTurnsAbortiveIfRequestsDoNotFinish has failed. Check the Test tab or this console log: https://helix.dot.net/api/2019-06-17/jobs/8bc7329a-8dee-4684-b8cc-9a4c227705ef/workitems/Sockets.FunctionalTests--net10.0/console

Build

https://dev.azure.com/dnceng-public/public/_build/results?buildId=983039&view=logs&j=0932446f-c4a2-59c2-187c-ad542d294916
@dotnet-issue-labeler dotnet-issue-labeler bot added the area-networking Includes servers, yarp, json patch, bedrock, websockets, http client factory, and http abstractions label Mar 18, 2025
@ilonatommy
Copy link
Member Author

Closing in favor of dotnet/dnceng#5279.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
area-networking Includes servers, yarp, json patch, bedrock, websockets, http client factory, and http abstractions test-failure
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@ilonatommy