Quarantine UnauthorizedDirectWebSocketsConnectionDoesNotConnect #48961
Closed
Description
Failing Test(s)
Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect
Two of the last four failing main builds were from here
Error Message
Assert.Fail(): 1 error(s) logged.
2023-06-22T04:03:18.7529636Z [xUnit.net 00:00:01.54] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager - ExceptionOccurredWhileProcessingTheKeyElement - An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1" />'.
Stacktrace
Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect [FAIL]
2023-06-22T04:03:18.7473129Z [xUnit.net 00:00:01.54] Assert.Fail(): 1 error(s) logged.
2023-06-22T04:03:18.7529636Z [xUnit.net 00:00:01.54] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager - ExceptionOccurredWhileProcessingTheKeyElement - An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1" />'.
2023-06-22T04:03:18.7546868Z [xUnit.net 00:00:01.54] ===================
2023-06-22T04:03:18.7552030Z [xUnit.net 00:00:01.54] System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.7580702Z [xUnit.net 00:00:01.54] at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.7596385Z [xUnit.net 00:00:01.54] at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.7637450Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.7653269Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.7710973Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.7771971Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.KeyManagement.DeferredKey.<>c__DisplayClass1_0.<GetLazyDescriptorDelegate>g__GetLazyDescriptorDelegate|0() in /_/src/DataProtection/DataProtection/src/KeyManagement/DeferredKey.cs:line 57
2023-06-22T04:03:18.7816541Z [xUnit.net 00:00:01.54] at System.Lazy`1.ViaFactory(LazyThreadSafetyMode mode)
2023-06-22T04:03:18.7907613Z [xUnit.net 00:00:01.54] --- End of stack trace from previous location ---
2023-06-22T04:03:18.8063832Z [xUnit.net 00:00:01.54] at System.Lazy`1.CreateValue()
2023-06-22T04:03:18.8107934Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.get_Descriptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 51
2023-06-22T04:03:18.8168292Z [xUnit.net 00:00:01.55] at Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngGcmAuthenticatedEncryptorFactory.CreateEncryptorInstance(IKey key) in /_/src/DataProtection/DataProtection/src/AuthenticatedEncryption/CngGcmAuthenticatedEncryptorFactory.cs:line 38
2023-06-22T04:03:18.8192778Z [xUnit.net 00:00:01.55] at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.CreateEncryptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 59
2023-06-22T04:03:18.8298992Z [xUnit.net 00:00:01.55] at Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver.CanCreateAuthenticatedEncryptor(IKey key) in /_/src/DataProtection/DataProtection/src/KeyManagement/DefaultKeyResolver.cs:line 59
2023-06-22T04:03:18.8469094Z [xUnit.net 00:00:01.55] ===================
2023-06-22T04:03:18.8486088Z [xUnit.net 00:00:01.55] Stack Trace:
2023-06-22T04:03:18.8491751Z [xUnit.net 00:00:01.55] D:\a\_work\1\s\src\Shared\SignalR\VerifyNoErrorScope.cs(47,0): at Microsoft.AspNetCore.SignalR.Tests.VerifyNoErrorsScope.Dispose()
2023-06-22T04:03:18.8497140Z [xUnit.net 00:00:01.55] D:\a\_work\1\s\src\Shared\SignalR\InProcessTestServer.cs(157,0): at Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer`1.DisposeAsync()
2023-06-22T04:03:18.8500649Z [xUnit.net 00:00:01.55] D:\a\_work\1\s\src\Shared\SignalR\InProcessTestServer.cs(164,0): at Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer`1.DisposeAsync()
2023-06-22T04:03:18.8506382Z [xUnit.net 00:00:01.55] /_/src/SignalR/server/SignalR/test/EndToEndTests.cs(420,0): at Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect()
Logs
2023-06-22T04:03:18.7419689Z [xUnit.net 00:00:01.54] Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect [FAIL]
2023-06-22T04:03:18.7473129Z [xUnit.net 00:00:01.54] Assert.Fail(): 1 error(s) logged.
2023-06-22T04:03:18.7529636Z [xUnit.net 00:00:01.54] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager - ExceptionOccurredWhileProcessingTheKeyElement - An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1" />'.
2023-06-22T04:03:18.7546868Z [xUnit.net 00:00:01.54] ===================
2023-06-22T04:03:18.7552030Z [xUnit.net 00:00:01.54] System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.7580702Z [xUnit.net 00:00:01.54] at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.7596385Z [xUnit.net 00:00:01.54] at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.7637450Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.7653269Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.7710973Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.7771971Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.KeyManagement.DeferredKey.<>c__DisplayClass1_0.<GetLazyDescriptorDelegate>g__GetLazyDescriptorDelegate|0() in /_/src/DataProtection/DataProtection/src/KeyManagement/DeferredKey.cs:line 57
2023-06-22T04:03:18.7816541Z [xUnit.net 00:00:01.54] at System.Lazy`1.ViaFactory(LazyThreadSafetyMode mode)
2023-06-22T04:03:18.7907613Z [xUnit.net 00:00:01.54] --- End of stack trace from previous location ---
2023-06-22T04:03:18.8063832Z [xUnit.net 00:00:01.54] at System.Lazy`1.CreateValue()
2023-06-22T04:03:18.8107934Z [xUnit.net 00:00:01.54] at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.get_Descriptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 51
2023-06-22T04:03:18.8168292Z [xUnit.net 00:00:01.55] at Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngGcmAuthenticatedEncryptorFactory.CreateEncryptorInstance(IKey key) in /_/src/DataProtection/DataProtection/src/AuthenticatedEncryption/CngGcmAuthenticatedEncryptorFactory.cs:line 38
2023-06-22T04:03:18.8192778Z [xUnit.net 00:00:01.55] at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.CreateEncryptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 59
2023-06-22T04:03:18.8298992Z [xUnit.net 00:00:01.55] at Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver.CanCreateAuthenticatedEncryptor(IKey key) in /_/src/DataProtection/DataProtection/src/KeyManagement/DefaultKeyResolver.cs:line 59
2023-06-22T04:03:18.8469094Z [xUnit.net 00:00:01.55] ===================
2023-06-22T04:03:18.8486088Z [xUnit.net 00:00:01.55] Stack Trace:
2023-06-22T04:03:18.8491751Z [xUnit.net 00:00:01.55] D:\a\_work\1\s\src\Shared\SignalR\VerifyNoErrorScope.cs(47,0): at Microsoft.AspNetCore.SignalR.Tests.VerifyNoErrorsScope.Dispose()
2023-06-22T04:03:18.8497140Z [xUnit.net 00:00:01.55] D:\a\_work\1\s\src\Shared\SignalR\InProcessTestServer.cs(157,0): at Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer`1.DisposeAsync()
2023-06-22T04:03:18.8500649Z [xUnit.net 00:00:01.55] D:\a\_work\1\s\src\Shared\SignalR\InProcessTestServer.cs(164,0): at Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer`1.DisposeAsync()
2023-06-22T04:03:18.8506382Z [xUnit.net 00:00:01.55] /_/src/SignalR/server/SignalR/test/EndToEndTests.cs(420,0): at Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect()
2023-06-22T04:03:18.8509559Z [xUnit.net 00:00:01.55] --- End of stack trace from previous location ---
2023-06-22T04:03:18.8512871Z [xUnit.net 00:00:01.55] Output:
2023-06-22T04:03:18.8533247Z [xUnit.net 00:00:01.55] | [0.010s] TestLifetime Information: Starting test UnauthorizedDirectWebSocketsConnectionDoesNotConnect at 2023-06-22T04:03:17
2023-06-22T04:03:18.8608122Z [xUnit.net 00:00:01.55] | [0.077s] Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer Information: Starting test server...
2023-06-22T04:03:18.8618319Z [xUnit.net 00:00:01.55] | [0.082s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting starting
2023-06-22T04:03:18.8626661Z [xUnit.net 00:00:01.55] | [0.105s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Information: User profile is available. Using 'C:\Users\vsagent\AppData\Local\ASP.NET\DataProtection-Keys' as key repository and Windows DPAPI to encrypt keys at rest.
2023-06-22T04:03:18.8630234Z [xUnit.net 00:00:01.55] | [0.125s] Microsoft.AspNetCore.DataProtection.Repositories.FileSystemXmlRepository Debug: Reading data from file 'C:\Users\vsagent\AppData\Local\ASP.NET\DataProtection-Keys\key-227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50.xml'.
2023-06-22T04:03:18.8680096Z [xUnit.net 00:00:01.55] | [0.130s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Debug: Found key {227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50}.
2023-06-22T04:03:18.8707729Z [xUnit.net 00:00:01.55] | [0.140s] Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver Debug: Considering key {227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50} with expiration date 2023-09-20 04:01:59Z as default key.
2023-06-22T04:03:18.8713923Z [xUnit.net 00:00:01.55] | [0.144s] Microsoft.AspNetCore.DataProtection.TypeForwardingActivator Debug: Forwarded activator type request from Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor, Microsoft.AspNetCore.DataProtection, Version=8.0.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60 to Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor, Microsoft.AspNetCore.DataProtection, Culture=neutral, PublicKeyToken=adb9793829ddae60
2023-06-22T04:03:18.8717220Z [xUnit.net 00:00:01.55] | [0.172s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Error: An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1" />'.
2023-06-22T04:03:18.8720792Z [xUnit.net 00:00:01.55] | System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.8723815Z [xUnit.net 00:00:01.55] | at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.8728841Z [xUnit.net 00:00:01.55] | at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.8731411Z [xUnit.net 00:00:01.55] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.8733702Z [xUnit.net 00:00:01.55] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.8736699Z [xUnit.net 00:00:01.56] | at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.8739543Z [xUnit.net 00:00:01.56] | [0.173s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Trace: An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1">
2023-06-22T04:03:18.8742524Z [xUnit.net 00:00:01.56] | <creationDate>2023-06-22T04:01:59.006986Z</creationDate>
2023-06-22T04:03:18.8745575Z [xUnit.net 00:00:01.56] | <activationDate>2023-06-22T04:01:59.0068836Z</activationDate>
2023-06-22T04:03:18.8748657Z [xUnit.net 00:00:01.56] | <expirationDate>2023-09-20T04:01:59.0068836Z</expirationDate>
2023-06-22T04:03:18.8751883Z [xUnit.net 00:00:01.56] | <descriptor deserializerType="Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ConfigurationModel.AuthenticatedEncryptorDescriptorDeserializer, Microsoft.AspNetCore.DataProtection, Version=8.0.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60">
2023-06-22T04:03:18.8754955Z [xUnit.net 00:00:01.56] | <descriptor>
2023-06-22T04:03:18.8757874Z [xUnit.net 00:00:01.56] | <encryption algorithm="AES_256_CBC" />
2023-06-22T04:03:18.8761005Z [xUnit.net 00:00:01.56] | <validation algorithm="HMACSHA256" />
2023-06-22T04:03:18.8764198Z [xUnit.net 00:00:01.56] | <encryptedSecret decryptorType="Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor, Microsoft.AspNetCore.DataProtection, Version=8.0.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60" xmlns="http://schemas.asp.net/2015/03/dataProtection">
2023-06-22T04:03:18.8767587Z [xUnit.net 00:00:01.56] | <EncryptedData Type="http://www.w3.org/2001/04/xmlenc#Element" xmlns="http://www.w3.org/2001/04/xmlenc#">
2023-06-22T04:03:18.8770911Z [xUnit.net 00:00:01.56] | <EncryptionMethod Algorithm="http://www.w3.org/2001/04/xmlenc#aes256-cbc" />
2023-06-22T04:03:18.8774156Z [xUnit.net 00:00:01.56] | <KeyInfo xmlns="http://www.w3.org/2000/09/xmldsig#">
2023-06-22T04:03:18.8777394Z [xUnit.net 00:00:01.56] | <EncryptedKey xmlns="http://www.w3.org/2001/04/xmlenc#">
2023-06-22T04:03:18.8780846Z [xUnit.net 00:00:01.56] | <EncryptionMethod Algorithm="http://www.w3.org/2001/04/xmlenc#rsa-1_5" />
2023-06-22T04:03:18.8784876Z [xUnit.net 00:00:01.56] | <KeyInfo xmlns="http://www.w3.org/2000/09/xmldsig#">
2023-06-22T04:03:18.8787741Z [xUnit.net 00:00:01.56] | <X509Data>
2023-06-22T04:03:18.8791209Z [xUnit.net 00:00:01.56] | <X509Certificate>MIIDGDCCAgCgAwIBAgIQVgdqyzYKrZhPimJuMerwkDANBgkqhkiG9w0BAQsFADAUMRIwEAYDVQQDDAlsb2NhbGhvc3QwHhcNMTgwMjE1MjAzODQzWhcNMTkwMjE1MjA1ODQzWjAUMRIwEAYDVQQDDAlsb2NhbGhvc3QwggEiMA0GCSqGSIb3DQEBAQUAA4IBDwAwggEKAoIBAQDF7R7sBrtMHz78EoK4adqJ7ljvV3M7Tn6ChD967yg/7/S0ncT5RhL31et5KSlDBvL/qu6fswXqzhe8fiaHT858mSdE9kn5m2DOxe1G+FBxETFTg/G77OXqRoz06LYInDLS4n4aaOLDEetiyqpgDoP1THrl75MZnihgfaev3CTd2IEtXd/8ktMZnKIehpstgSFr2XatMDyE2v6r1DUqyIbfarOIAaDcYbgdTfleDrhms+WLpir2UwG2lv/hySjiFi4TpG1k5oA6KHQDC/cFGtDYxhLi7UNIRQ080RVqKDHBQ2qV3c3qF6kke6LBQfkUZ7uAfepnJrhmPG0i6sDBIDH5AgMBAAGjZjBkMA4GA1UdDwEB/wQEAwIFoDAdBgNVHSUEFjAUBggrBgEFBQcDAgYIKwYBBQUHAwEwFAYDVR0RBA0wC4IJbG9jYWxob3N0MB0GA1UdDgQWBBSvx1KvyrRdi1ymYoa7BIXg+JRKoDANBgkqhkiG9w0BAQsFAAOCAQEAVF66MmHnxybwt9dfJD1IaH9SXE18Z3vR3t69RGD1n/1s7jicTuEB0fW6jgd3nzpTKtKL59Gu9e7xktdxmcacl6VaxJShCNwqvPlthM/6Ybol62P7yjLqkoBZKd5FOpKKsnPypiiZb2hzeD2RwiuyIjL7E3tmqzJVlTd+OzCEKJiYnYLnIRM8WWBhS54+//Kx1XIA3MsB4xH+MtwBB/BgMiPGPFqgriURRIbAFepBICIyW429W1VAnbhid7pvC1IXXosXVCn7R84bQgVLTBZVgueFvl5Zy1zEzY4/j8L2VpeFKkDWHc/0auZpWqbjUl2M1ZsRXu1s+w87mwaI6mxixg==</X509Certificate>
2023-06-22T04:03:18.8822066Z [xUnit.net 00:00:01.56] | </X509Data>
2023-06-22T04:03:18.8822170Z [xUnit.net 00:00:01.56] | </KeyInfo>
2023-06-22T04:03:18.8822212Z [xUnit.net 00:00:01.56] | <CipherData>
2023-06-22T04:03:18.8822249Z [xUnit.net 00:00:01.56] | <CipherValue>YZfn60tiwGc8uzbqmZb4BZQnEdiOh3OJVF2KT2uEucx7StOqw7Q82st+M40ADhyRwkRAxllAzUBIWVUVCfI18CGHKTDZGxBdYlR3DjyDHZnC+Mdqe/KO0ru8X/OC/mcxuyelYF4Y3uEfbyh8cZQaI8/GA3HGwu3ic6c7MxwyWgl41a0aFF2u3n8lVVYdR6svNnsZu6+dGaC8DBf9tH++tdkiCle0bwxIyslQ4lF2TlYSw+Of96AmW6uyA69iMaV0rJpc4m2DpbLWImbk5l5gpITlzf4QxJ0mCxm3fv26X6693I/b7WaMTsbpxl0Z7t/6IN09vxZexKhabLKanlnegA==</CipherValue>
2023-06-22T04:03:18.8822461Z [xUnit.net 00:00:01.56] | </CipherData>
2023-06-22T04:03:18.8822503Z [xUnit.net 00:00:01.56] | </EncryptedKey>
2023-06-22T04:03:18.8822541Z [xUnit.net 00:00:01.56] | </KeyInfo>
2023-06-22T04:03:18.8822576Z [xUnit.net 00:00:01.56] | <CipherData>
2023-06-22T04:03:18.8822732Z [xUnit.net 00:00:01.56] | <CipherValue>M7XpqTOb+nu2mHfrqByw7OUI++h1hIHBAx1qsZa6xDV0HfdFljFBQzkpNw8o8xsldUFyHEz+zDwNxW1f4hyZVujpfmoHlMBmn0zYmaVX1yoaVnhYtmR5B3UVPTDQU8jSjNj99OABez2YjjlD3vjhsMGNAEKH3Xxqy0J2yDb3ijZTvJ4hUMFFIkrKFOhkP3kodYGtVC2GNVhoFuC0NE7unrlRBqaEWUrymzF3Jzx7W+EaHtXioxKNAd0mgpEnk/YYup0HSBakOuIxwuLJu4wKzZRggZnVNmUmcH3Qp3VBK6Lx8ZGsJxhWaiAbxgwepsy0BwBK4Lf9PmRCBoj3ui5yBiV/oVyZYdoGoUSGIMDxfrVdMXniQXO+W2ONlkg71Rb8Cc4KxWLPOmupgenkpzx5ag==</CipherValue>
2023-06-22T04:03:18.8822834Z [xUnit.net 00:00:01.56] | </CipherData>
2023-06-22T04:03:18.8822871Z [xUnit.net 00:00:01.56] | </EncryptedData>
2023-06-22T04:03:18.8825851Z [xUnit.net 00:00:01.56] | </encryptedSecret>
2023-06-22T04:03:18.8829218Z [xUnit.net 00:00:01.57] | </descriptor>
2023-06-22T04:03:18.8832465Z [xUnit.net 00:00:01.57] | </descriptor>
2023-06-22T04:03:18.8835798Z [xUnit.net 00:00:01.57] | </key>'.
2023-06-22T04:03:18.8839169Z [xUnit.net 00:00:01.57] | System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.8842555Z [xUnit.net 00:00:01.57] | at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.8888964Z [xUnit.net 00:00:01.57] | at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.8903998Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.8907829Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.8911511Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.8915758Z [xUnit.net 00:00:01.57] | [0.179s] Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver Warning: Key {227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50} is ineligible to be the default key because its CreateEncryptor method failed.
2023-06-22T04:03:18.8919400Z [xUnit.net 00:00:01.57] | System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.8923126Z [xUnit.net 00:00:01.57] | at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.8926535Z [xUnit.net 00:00:01.57] | at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.8936771Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.8944908Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.8948708Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.8952074Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.KeyManagement.DeferredKey.<>c__DisplayClass1_0.<GetLazyDescriptorDelegate>g__GetLazyDescriptorDelegate|0() in /_/src/DataProtection/DataProtection/src/KeyManagement/DeferredKey.cs:line 57
2023-06-22T04:03:18.8956711Z [xUnit.net 00:00:01.57] | at System.Lazy`1.ViaFactory(LazyThreadSafetyMode mode)
2023-06-22T04:03:18.8960296Z [xUnit.net 00:00:01.57] | at System.Lazy`1.ExecutionAndPublication(LazyHelper executionAndPublication, Boolean useDefaultConstructor)
2023-06-22T04:03:18.8966951Z [xUnit.net 00:00:01.57] | at System.Lazy`1.CreateValue()
2023-06-22T04:03:18.8970426Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.get_Descriptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 51
2023-06-22T04:03:18.8974072Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngGcmAuthenticatedEncryptorFactory.CreateEncryptorInstance(IKey key) in /_/src/DataProtection/DataProtection/src/AuthenticatedEncryption/CngGcmAuthenticatedEncryptorFactory.cs:line 38
2023-06-22T04:03:18.8978857Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.CreateEncryptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 59
2023-06-22T04:03:18.8982152Z [xUnit.net 00:00:01.57] | at Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver.CanCreateAuthenticatedEncryptor(IKey key) in /_/src/DataProtection/DataProtection/src/KeyManagement/DefaultKeyResolver.cs:line 59
2023-06-22T04:03:18.8987418Z [xUnit.net 00:00:01.57] | [0.181s] Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver Debug: Key {227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50} is no longer under consideration as default key because it is expired, revoked, or cannot be deciphered.
2023-06-22T04:03:18.8992742Z [xUnit.net 00:00:01.57] | [0.183s] Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver Warning: Key {227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50} is ineligible to be the default key because its CreateEncryptor method failed.
2023-06-22T04:03:18.8999654Z [xUnit.net 00:00:01.57] | System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.9044329Z [xUnit.net 00:00:01.57] | at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.9088570Z [xUnit.net 00:00:01.58] | at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.9203318Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.9233621Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.9237110Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.9248605Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.KeyManagement.DeferredKey.<>c__DisplayClass1_0.<GetLazyDescriptorDelegate>g__GetLazyDescriptorDelegate|0() in /_/src/DataProtection/DataProtection/src/KeyManagement/DeferredKey.cs:line 57
2023-06-22T04:03:18.9251949Z [xUnit.net 00:00:01.58] | at System.Lazy`1.ViaFactory(LazyThreadSafetyMode mode)
2023-06-22T04:03:18.9257290Z [xUnit.net 00:00:01.58] | --- End of stack trace from previous location ---
2023-06-22T04:03:18.9260944Z [xUnit.net 00:00:01.58] | at System.Lazy`1.CreateValue()
2023-06-22T04:03:18.9264240Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.get_Descriptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 51
2023-06-22T04:03:18.9270974Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngGcmAuthenticatedEncryptorFactory.CreateEncryptorInstance(IKey key) in /_/src/DataProtection/DataProtection/src/AuthenticatedEncryption/CngGcmAuthenticatedEncryptorFactory.cs:line 38
2023-06-22T04:03:18.9274086Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.CreateEncryptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 59
2023-06-22T04:03:18.9278688Z [xUnit.net 00:00:01.58] | at Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver.CanCreateAuthenticatedEncryptor(IKey key) in /_/src/DataProtection/DataProtection/src/KeyManagement/DefaultKeyResolver.cs:line 59
2023-06-22T04:03:18.9283307Z [xUnit.net 00:00:01.58] | [0.185s] Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver Debug: Repository contains no viable default key. Caller should generate a key with immediate activation.
2023-06-22T04:03:18.9286687Z [xUnit.net 00:00:01.58] | [0.186s] Microsoft.AspNetCore.DataProtection.KeyManagement.KeyRingProvider Debug: Policy resolution states that a new key should be added to the key ring.
2023-06-22T04:03:18.9290986Z [xUnit.net 00:00:01.58] | [0.189s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Information: Creating key {724029d1-364b-4e06-8c97-6729f7fb55a1} with creation date 2023-06-22 04:03:18Z, activation date 2023-06-22 04:03:18Z, and expiration date 2023-09-20 04:03:18Z.
2023-06-22T04:03:18.9294601Z [xUnit.net 00:00:01.58] | [0.191s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Debug: Descriptor deserializer type for key {724029d1-364b-4e06-8c97-6729f7fb55a1} is 'Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ConfigurationModel.AuthenticatedEncryptorDescriptorDeserializer, Microsoft.AspNetCore.DataProtection, Version=8.0.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60'.
2023-06-22T04:03:18.9298101Z [xUnit.net 00:00:01.58] | [0.191s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Debug: No key escrow sink found. Not writing key {724029d1-364b-4e06-8c97-6729f7fb55a1} to escrow.
2023-06-22T04:03:18.9302512Z [xUnit.net 00:00:01.58] | [0.196s] Microsoft.AspNetCore.DataProtection.XmlEncryption.DpapiXmlEncryptor Debug: Encrypting to Windows DPAPI for current user account (a00IY94\vsagent).
2023-06-22T04:03:18.9305411Z [xUnit.net 00:00:01.58] | [0.231s] Microsoft.AspNetCore.DataProtection.Repositories.FileSystemXmlRepository Information: Writing data to file 'C:\Users\vsagent\AppData\Local\ASP.NET\DataProtection-Keys\key-724029d1-364b-4e06-8c97-6729f7fb55a1.xml'.
2023-06-22T04:03:18.9310732Z [xUnit.net 00:00:01.58] | [0.232s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Debug: Key cache expiration token triggered by 'CreateNewKey' operation.
2023-06-22T04:03:18.9313824Z [xUnit.net 00:00:01.58] | [0.232s] Microsoft.AspNetCore.DataProtection.Repositories.FileSystemXmlRepository Debug: Reading data from file 'C:\Users\vsagent\AppData\Local\ASP.NET\DataProtection-Keys\key-227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50.xml'.
2023-06-22T04:03:18.9323789Z [xUnit.net 00:00:01.58] | [0.232s] Microsoft.AspNetCore.DataProtection.Repositories.FileSystemXmlRepository Debug: Reading data from file 'C:\Users\vsagent\AppData\Local\ASP.NET\DataProtection-Keys\key-724029d1-364b-4e06-8c97-6729f7fb55a1.xml'.
2023-06-22T04:03:18.9373953Z [xUnit.net 00:00:01.58] | [0.233s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Debug: Found key {227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50}.
2023-06-22T04:03:18.9388063Z [xUnit.net 00:00:01.58] | [0.233s] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager Debug: Found key {724029d1-364b-4e06-8c97-6729f7fb55a1}.
2023-06-22T04:03:18.9447986Z [xUnit.net 00:00:01.58] | [0.233s] Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver Debug: Considering key {724029d1-364b-4e06-8c97-6729f7fb55a1} with expiration date 2023-09-20 04:03:18Z as default key.
2023-06-22T04:03:18.9496519Z [xUnit.net 00:00:01.58] | [0.234s] Microsoft.AspNetCore.DataProtection.TypeForwardingActivator Debug: Forwarded activator type request from Microsoft.AspNetCore.DataProtection.XmlEncryption.DpapiXmlDecryptor, Microsoft.AspNetCore.DataProtection, Version=8.0.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60 to Microsoft.AspNetCore.DataProtection.XmlEncryption.DpapiXmlDecryptor, Microsoft.AspNetCore.DataProtection, Culture=neutral, PublicKeyToken=adb9793829ddae60
2023-06-22T04:03:18.9500164Z [xUnit.net 00:00:01.58] | [0.234s] Microsoft.AspNetCore.DataProtection.XmlEncryption.DpapiXmlDecryptor Debug: Decrypting secret element using Windows DPAPI.
2023-06-22T04:03:18.9503372Z [xUnit.net 00:00:01.58] | [0.235s] Microsoft.AspNetCore.DataProtection.TypeForwardingActivator Debug: Forwarded activator type request from Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ConfigurationModel.AuthenticatedEncryptorDescriptorDeserializer, Microsoft.AspNetCore.DataProtection, Version=8.0.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60 to Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ConfigurationModel.AuthenticatedEncryptorDescriptorDeserializer, Microsoft.AspNetCore.DataProtection, Culture=neutral, PublicKeyToken=adb9793829ddae60
2023-06-22T04:03:18.9513252Z [xUnit.net 00:00:01.59] | [0.239s] Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngCbcAuthenticatedEncryptorFactory Debug: Opening CNG algorithm 'AES' from provider '(null)' with chaining mode CBC.
2023-06-22T04:03:18.9516611Z [xUnit.net 00:00:01.59] | [0.242s] Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngCbcAuthenticatedEncryptorFactory Debug: Opening CNG algorithm 'SHA256' from provider '(null)' with HMAC.
2023-06-22T04:03:18.9523858Z [xUnit.net 00:00:01.59] | [0.245s] Microsoft.AspNetCore.DataProtection.KeyManagement.KeyRingProvider Debug: Using key {724029d1-364b-4e06-8c97-6729f7fb55a1} as the default key.
2023-06-22T04:03:18.9527543Z [xUnit.net 00:00:01.59] | [0.245s] Microsoft.AspNetCore.DataProtection.Internal.DataProtectionHostedService Debug: Key ring with default key {724029d1-364b-4e06-8c97-6729f7fb55a1} was loaded during application startup.
2023-06-22T04:03:18.9536529Z [xUnit.net 00:00:01.59] | [0.248s] Microsoft.AspNetCore.SignalR.Internal.DefaultHubProtocolResolver Debug: Registered SignalR Protocol: json, implemented by Microsoft.AspNetCore.SignalR.Protocol.JsonHubProtocol.
2023-06-22T04:03:18.9541219Z [xUnit.net 00:00:01.59] | [0.256s] Microsoft.Hosting.Lifetime Information: Now listening on: http://127.0.0.1:50101
2023-06-22T04:03:18.9544998Z [xUnit.net 00:00:01.59] | [0.256s] Microsoft.AspNetCore.Hosting.Diagnostics Debug: Loaded hosting startup assembly Microsoft.AspNetCore.SignalR.Tests
2023-06-22T04:03:18.9548286Z [xUnit.net 00:00:01.59] | [0.256s] Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionManager Trace: Starting connection heartbeat.
2023-06-22T04:03:18.9552337Z [xUnit.net 00:00:01.59] | [0.257s] Microsoft.Hosting.Lifetime Information: Application started. Press Ctrl+C to shut down.
2023-06-22T04:03:18.9571530Z [xUnit.net 00:00:01.59] | [0.257s] Microsoft.Hosting.Lifetime Information: Hosting environment: Production
2023-06-22T04:03:18.9574670Z [xUnit.net 00:00:01.59] | [0.257s] Microsoft.Hosting.Lifetime Information: Content root path: C:\h\w\B24409A6\w\A137089A\e
2023-06-22T04:03:18.9577266Z [xUnit.net 00:00:01.59] | [0.257s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting started
2023-06-22T04:03:18.9579530Z [xUnit.net 00:00:01.59] | [0.257s] Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer Information: Test Server started
2023-06-22T04:03:18.9582024Z [xUnit.net 00:00:01.59] | [0.266s] Microsoft.AspNetCore.Http.Connections.Client.HttpConnection Debug: Starting HttpConnection.
2023-06-22T04:03:18.9584051Z [xUnit.net 00:00:01.59] | [0.270s] Microsoft.AspNetCore.Http.Connections.Client.HttpConnection Debug: Starting transport 'WebSockets' with Url: http://127.0.0.1:50101/auth.
2023-06-22T04:03:18.9586419Z [xUnit.net 00:00:01.59] | [0.277s] Microsoft.AspNetCore.Http.Connections.Client.Internal.WebSocketsTransport Information: Starting transport. Transfer mode: Binary. Url: 'ws://127.0.0.1:50101/auth'.
2023-06-22T04:03:18.9588416Z [xUnit.net 00:00:01.59] | [0.511s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HMRIQMEA8CMM" accepted.
2023-06-22T04:03:18.9590704Z [xUnit.net 00:00:01.59] | [0.522s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HMRIQMEA8CMM" started.
2023-06-22T04:03:18.9592724Z [xUnit.net 00:00:01.59] | [0.583s] Microsoft.AspNetCore.Hosting.Diagnostics Information: Request starting HTTP/1.1 GET http://127.0.0.1:50101/auth - - -
2023-06-22T04:03:18.9595185Z [xUnit.net 00:00:01.59] | [0.624s] Microsoft.AspNetCore.Routing.Matching.DfaMatcher Debug: 1 candidate(s) found for the request path '/auth'
2023-06-22T04:03:18.9597370Z [xUnit.net 00:00:01.59] | [0.626s] Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware Debug: Request matched endpoint '/auth'
2023-06-22T04:03:18.9599445Z [xUnit.net 00:00:01.59] | [0.653s] Microsoft.AspNetCore.Authentication.JwtBearer.JwtBearerHandler Debug: AuthenticationScheme: Bearer was not authenticated.
2023-06-22T04:03:18.9601764Z [xUnit.net 00:00:01.59] | [0.669s] Microsoft.AspNetCore.Authorization.DefaultAuthorizationService Information: Authorization failed. Fail() was explicitly called.
2023-06-22T04:03:18.9603823Z [xUnit.net 00:00:01.59] | [0.680s] Microsoft.AspNetCore.Authentication.JwtBearer.JwtBearerHandler Information: AuthenticationScheme: Bearer was challenged.
2023-06-22T04:03:18.9606036Z [xUnit.net 00:00:01.59] | [0.689s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HMRIQMEA8CMM" completed keep alive response.
2023-06-22T04:03:18.9608030Z [xUnit.net 00:00:01.59] | [0.692s] Microsoft.AspNetCore.Hosting.Diagnostics Information: Request finished HTTP/1.1 GET http://127.0.0.1:50101/auth - 401 0 - 112.0665ms
2023-06-22T04:03:18.9610298Z [xUnit.net 00:00:01.59] | [0.707s] Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets Debug: Connection id "0HMRIQMEA8CMM" received FIN.
2023-06-22T04:03:18.9612455Z [xUnit.net 00:00:01.59] | [0.710s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HMRIQMEA8CMM" disconnecting.
2023-06-22T04:03:18.9614496Z [xUnit.net 00:00:01.59] | [0.711s] Microsoft.AspNetCore.Server.Kestrel.Connections Debug: Connection id "0HMRIQMEA8CMM" stopped.
2023-06-22T04:03:18.9616441Z [xUnit.net 00:00:01.60] | [0.714s] Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets Debug: Connection id "0HMRIQMEA8CMM" sending FIN because: "The Socket transport's send loop completed gracefully."
2023-06-22T04:03:18.9618495Z [xUnit.net 00:00:01.60] | [0.711s] Microsoft.AspNetCore.Http.Connections.Client.HttpConnection Error: Failed to start connection. Error starting transport 'WebSockets'.
2023-06-22T04:03:18.9620514Z [xUnit.net 00:00:01.60] | System.Net.WebSockets.WebSocketException (0x80004005): The server returned status code '401' when status code '101' was expected.
2023-06-22T04:03:18.9622506Z [xUnit.net 00:00:01.60] | at System.Net.WebSockets.WebSocketHandle.ValidateResponse(HttpResponseMessage response, String secValue)
2023-06-22T04:03:18.9624518Z [xUnit.net 00:00:01.60] | at System.Net.WebSockets.WebSocketHandle.ConnectAsync(Uri uri, HttpMessageInvoker invoker, CancellationToken cancellationToken, ClientWebSocketOptions options)
2023-06-22T04:03:18.9626503Z [xUnit.net 00:00:01.60] | at System.Net.WebSockets.ClientWebSocket.ConnectAsyncCore(Uri uri, HttpMessageInvoker invoker, CancellationToken cancellationToken)
2023-06-22T04:03:18.9628645Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.Http.Connections.Client.Internal.WebSocketsTransport.DefaultWebSocketFactory(WebSocketConnectionContext context, CancellationToken cancellationToken) in /_/src/SignalR/clients/csharp/Http.Connections.Client/src/Internal/WebSocketsTransport.cs:line 256
2023-06-22T04:03:18.9630753Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.Http.Connections.Client.Internal.WebSocketsTransport.StartAsync(Uri url, TransferFormat transferFormat, CancellationToken cancellationToken) in /_/src/SignalR/clients/csharp/Http.Connections.Client/src/Internal/WebSocketsTransport.cs:line 287
2023-06-22T04:03:18.9632759Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.Http.Connections.Client.HttpConnection.StartTransport(Uri connectUrl, HttpTransportType transportType, TransferFormat transferFormat, CancellationToken cancellationToken, Boolean useAck) in /_/src/SignalR/clients/csharp/Http.Connections.Client/src/HttpConnection.cs:line 518
2023-06-22T04:03:18.9634767Z [xUnit.net 00:00:01.60] | [0.736s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting stopping
2023-06-22T04:03:18.9636721Z [xUnit.net 00:00:01.60] | [0.738s] Microsoft.Hosting.Lifetime Information: Application is shutting down...
2023-06-22T04:03:18.9638737Z [xUnit.net 00:00:01.60] | [0.738s] Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionManager Trace: Ending connection heartbeat.
2023-06-22T04:03:18.9640943Z [xUnit.net 00:00:01.60] | [0.742s] Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer Information: Test server shut down
2023-06-22T04:03:18.9643132Z [xUnit.net 00:00:01.60] | [0.743s] Microsoft.Extensions.Hosting.Internal.Host Debug: Hosting stopped
2023-06-22T04:03:18.9645137Z [xUnit.net 00:00:01.60] | [0.748s] Microsoft.AspNetCore.SignalR.Tests.EndToEndTests Error: Test threw an exception.
2023-06-22T04:03:18.9647098Z [xUnit.net 00:00:01.60] | Xunit.Sdk.FailException: Assert.Fail(): 1 error(s) logged.
2023-06-22T04:03:18.9649114Z [xUnit.net 00:00:01.60] | Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager - ExceptionOccurredWhileProcessingTheKeyElement - An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1" />'.
2023-06-22T04:03:18.9651080Z [xUnit.net 00:00:01.60] | ===================
2023-06-22T04:03:18.9653118Z [xUnit.net 00:00:01.60] | System.Security.Cryptography.CryptographicException: Unable to retrieve the decryption key.
2023-06-22T04:03:18.9655179Z [xUnit.net 00:00:01.60] | at System.Security.Cryptography.Xml.EncryptedXml.GetDecryptionKey(EncryptedData encryptedData, String symmetricAlgorithmUri)
2023-06-22T04:03:18.9657175Z [xUnit.net 00:00:01.60] | at System.Security.Cryptography.Xml.EncryptedXml.DecryptDocument()
2023-06-22T04:03:18.9659253Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.EncryptedXmlDecryptor.Decrypt(XElement encryptedElement) in /_/src/DataProtection/DataProtection/src/XmlEncryption/EncryptedXmlDecryptor.cs:line 75
2023-06-22T04:03:18.9661240Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.DataProtection.XmlEncryption.XmlEncryptionExtensions.DecryptElement(XElement element, IActivator activator) in /_/src/DataProtection/DataProtection/src/XmlEncryption/XmlEncryptionExtensions.cs:line 51
2023-06-22T04:03:18.9663245Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager.Microsoft.AspNetCore.DataProtection.KeyManagement.Internal.IInternalXmlKeyManager.DeserializeDescriptorFromKeyElement(XElement keyElement) in /_/src/DataProtection/DataProtection/src/KeyManagement/XmlKeyManager.cs:line 445
2023-06-22T04:03:18.9665262Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.DataProtection.KeyManagement.DeferredKey.<>c__DisplayClass1_0.<GetLazyDescriptorDelegate>g__GetLazyDescriptorDelegate|0() in /_/src/DataProtection/DataProtection/src/KeyManagement/DeferredKey.cs:line 57
2023-06-22T04:03:18.9667246Z [xUnit.net 00:00:01.60] | at System.Lazy`1.ViaFactory(LazyThreadSafetyMode mode)
2023-06-22T04:03:18.9669242Z [xUnit.net 00:00:01.60] | --- End of stack trace from previous location ---
2023-06-22T04:03:18.9671764Z [xUnit.net 00:00:01.60] | at System.Lazy`1.CreateValue()
2023-06-22T04:03:18.9673773Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.get_Descriptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 51
2023-06-22T04:03:18.9675785Z [xUnit.net 00:00:01.60] | at Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.CngGcmAuthenticatedEncryptorFactory.CreateEncryptorInstance(IKey key) in /_/src/DataProtection/DataProtection/src/AuthenticatedEncryption/CngGcmAuthenticatedEncryptorFactory.cs:line 38
2023-06-22T04:03:18.9677800Z [xUnit.net 00:00:01.61] | at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyBase.CreateEncryptor() in /_/src/DataProtection/DataProtection/src/KeyManagement/KeyBase.cs:line 59
2023-06-22T04:03:18.9679845Z [xUnit.net 00:00:01.61] | at Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver.CanCreateAuthenticatedEncryptor(IKey key) in /_/src/DataProtection/DataProtection/src/KeyManagement/DefaultKeyResolver.cs:line 59
2023-06-22T04:03:18.9681847Z [xUnit.net 00:00:01.61] | ===================
2023-06-22T04:03:18.9683961Z [xUnit.net 00:00:01.61] | at Xunit.Assert.Fail(String message) in /_/src/xunit.assert/Asserts/FailAsserts.cs:line 28
2023-06-22T04:03:18.9685913Z [xUnit.net 00:00:01.61] | at Microsoft.AspNetCore.SignalR.Tests.VerifyNoErrorsScope.Dispose() in D:\a\_work\1\s\src\Shared\SignalR\VerifyNoErrorScope.cs:line 47
2023-06-22T04:03:18.9687935Z [xUnit.net 00:00:01.61] | at Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer`1.DisposeAsync() in D:\a\_work\1\s\src\Shared\SignalR\InProcessTestServer.cs:line 157
2023-06-22T04:03:18.9689961Z [xUnit.net 00:00:01.61] | at Microsoft.AspNetCore.SignalR.Tests.InProcessTestServer`1.DisposeAsync() in D:\a\_work\1\s\src\Shared\SignalR\InProcessTestServer.cs:line 164
2023-06-22T04:03:18.9691953Z [xUnit.net 00:00:01.61] | at Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect() in /_/src/SignalR/server/SignalR/test/EndToEndTests.cs:line 420
2023-06-22T04:03:18.9693912Z [xUnit.net 00:00:01.61] | at Xunit.Sdk.TestInvoker`1.<>c__DisplayClass48_0.<<InvokeTestMethodAsync>b__1>d.MoveNext() in /_/src/xunit.execution/Sdk/Frameworks/Runners/TestInvoker.cs:line 264
2023-06-22T04:03:18.9695878Z [xUnit.net 00:00:01.61] | --- End of stack trace from previous location ---
2023-06-22T04:03:18.9697996Z [xUnit.net 00:00:01.61] | at Xunit.Sdk.ExecutionTimer.AggregateAsync(Func`1 asyncAction) in /_/src/xunit.execution/Sdk/Frameworks/ExecutionTimer.cs:line 48
2023-06-22T04:03:18.9700600Z [xUnit.net 00:00:01.61] | at Xunit.Sdk.ExceptionAggregator.RunAsync(Func`1 code) in /_/src/xunit.core/Sdk/ExceptionAggregator.cs:line 90
2023-06-22T04:03:18.9702669Z [xUnit.net 00:00:01.61] | [0.750s] TestLifetime Information: Finished test UnauthorizedDirectWebSocketsConnectionDoesNotConnect in 0.7465445s
2023-06-22T04:03:18.9727463Z Passed Microsoft.AspNetCore.SignalR.Tests.DefaultHubLifetimeManagerTests.SendUsersAsyncWillCancelWithToken [5 ms]
2023-06-22T04:03:18.9730073Z Passed Microsoft.AspNetCore.SignalR.Tests.DefaultHubLifetimeManagerTests.SendAllAsyncWillCancelWithToken [4 ms]
2023-06-22T04:03:18.9732838Z Passed Microsoft.AspNetCore.SignalR.Tests.HubConnectionHandlerTests.CanPassDerivedParameterToStreamHubMethod(method: "DerivedParameterBaseClassAsyncEnumerable") [38 ms]
2023-06-22T04:03:18.9736019Z Passed Microsoft.AspNetCore.SignalR.Tests.DefaultHubLifetimeManagerTests.ClientDisconnectsWithoutCompletingClientResult [7 ms]
2023-06-22T04:03:18.9739722Z Passed Microsoft.AspNetCore.SignalR.Tests.DefaultHubLifetimeManagerTests.SendAllAsyncDoesNotWriteToDisconnectedConnectionsOutput [1 ms]
2023-06-22T04:03:18.9742684Z Failed Microsoft.AspNetCore.SignalR.Tests.EndToEndTests.UnauthorizedDirectWebSocketsConnectionDoesNotConnect [732 ms]
2023-06-22T04:03:18.9744024Z Error Message:
2023-06-22T04:03:18.9745193Z Assert.Fail(): 1 error(s) logged.
2023-06-22T04:03:18.9745480Z Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager - ExceptionOccurredWhileProcessingTheKeyElement - An exception occurred while processing the key element '<key id="227bd4c3-ec5d-4f3d-b518-55ad5e9e6d50" version="1" />'.