Blazor wasm signalr longpolling throws error while polling

[msschl]

c# SignalR client fails after the first long polling request in blazor wasm.

Server logs:

[18:18:48 DBG] Connection id "0HM2QD9QHKLIQ" received FIN. {"EventId": {"Id": 6, "Name": "ConnectionReadFin"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIQ" sending FIN because: "The client closed the connection." {"EventId": {"Id": 7, "Name": "ConnectionWriteFin"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIQ" disconnecting. {"EventId": {"Id": 10, "Name": "ConnectionDisconnect"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIQ" stopped. {"EventId": {"Id": 2, "Name": "ConnectionStop"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIE" received FIN. {"EventId": {"Id": 6, "Name": "ConnectionReadFin"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIE" sending FIN because: "The client closed the connection." {"EventId": {"Id": 7, "Name": "ConnectionWriteFin"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIE" disconnecting. {"EventId": {"Id": 10, "Name": "ConnectionDisconnect"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Client disconnected from Long Polling endpoint for connection. {"EventId": {"Id": 4, "Name": "LongPollingDisconnected"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.Transports.LongPollingTransport", "TransportConnectionId": "J7woEgpuzoRls5ueiHi0jg", "RequestId": "0HM2QD9QHKLIE:00000008", "RequestPath": "/", "SpanId": "f41338b830ce4148", "TraceId": "d5626a9d359b3142ad3734b49fb0ffee", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLIE"}
[18:18:48 INF] Executed endpoint '' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLIE:00000008", "RequestPath": "/", "SpanId": "f41338b830ce4148", "TraceId": "d5626a9d359b3142ad3734b49fb0ffee", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLIE"}
[18:18:48 INF] HTTP GET /?id=tWMpvd4N8eWBdNQ_vJTV_Q responded 200 in 59999.2856 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": null, "EndpointName": "", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLIE:00000008", "SpanId": "f41338b830ce4148", "TraceId": "d5626a9d359b3142ad3734b49fb0ffee", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLIE"}
[18:18:48 INF] Request finished in 60000.0113ms 0  {"ElapsedMilliseconds": 60000.0113, "StatusCode": 0, "ContentType": null, "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLIE:00000008", "RequestPath": "/", "SpanId": "f41338b830ce4148", "TraceId": "d5626a9d359b3142ad3734b49fb0ffee", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLIE"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLIE" stopped. {"EventId": {"Id": 2, "Name": "ConnectionStop"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" accepted. {"EventId": {"Id": 39, "Name": "ConnectionAccepted"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" started. {"EventId": {"Id": 1, "Name": "ConnectionStart"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 INF] Request starting HTTP/1.1 OPTIONS http://broadcast.company.xyz/negotiate?negotiateVersion=1   {"Protocol": "HTTP/1.1", "Method": "OPTIONS", "ContentType": null, "ContentLength": null, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/negotiate", "QueryString": "?negotiateVersion=1", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/negotiate' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Request matched endpoint '/negotiate' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request is a preflight request. {"EventId": {"Id": 1, "Name": "IsPreflightRequest"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] HTTP OPTIONS /negotiate?negotiateVersion=1 responded 204 in 0.6428 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": null, "EndpointName": "/negotiate", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000001", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000"}
[18:18:48 INF] Request finished in 1.273ms 204  {"ElapsedMilliseconds": 1.273, "StatusCode": 204, "ContentType": null, "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000001", "RequestPath": "/negotiate", "SpanId": "05fe91d552e2a04e", "TraceId": "862806dbec0a944cb95bcb5a7e75e17f", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Request starting HTTP/1.1 POST http://broadcast.company.xyz/negotiate?negotiateVersion=1  0 {"Protocol": "HTTP/1.1", "Method": "POST", "ContentType": null, "ContentLength": 0, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/negotiate", "QueryString": "?negotiateVersion=1", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/negotiate' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Request matched endpoint '/negotiate' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token found: DB47AA7C48674F7C343F76BC422E6D4B2E8A2C184EEE4FB99F6127E20B0BC253 {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token is a reference token and is supported. {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: BearerIdentityServerAuthenticationIntrospection was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityModel.AspNetCore.OAuth2Introspection.OAuth2IntrospectionHandler", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Authorization was successful. {"EventId": {"Id": 1, "Name": "UserAuthorizationSucceeded"}, "SourceContext": "Microsoft.AspNetCore.Authorization.DefaultAuthorizationService", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executing endpoint '/negotiate' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] New connection 22-qVOkc95tR0tyH7ECZ-w created. {"EventId": {"Id": 1, "Name": "CreatedNewConnection"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionManager", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Sending negotiation response. {"EventId": {"Id": 10, "Name": "NegotiationRequest"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionDispatcher", "TransportConnectionId": "22-qVOkc95tR0tyH7ECZ-w", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executed endpoint '/negotiate' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] HTTP POST /negotiate?negotiateVersion=1 responded 200 in 21.4820 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": "application/json", "EndpointName": "/negotiate", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000002", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000"}
[18:18:48 INF] Request finished in 21.8896ms 200 application/json {"ElapsedMilliseconds": 21.8896, "StatusCode": 200, "ContentType": "application/json", "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000002", "RequestPath": "/negotiate", "SpanId": "f409b33c85b17c4e", "TraceId": "7723dbadd0c1df4a978a83eb7c7e0caa", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Request starting HTTP/1.1 POST http://broadcast.company.xyz/negotiate?negotiateVersion=1  0 {"Protocol": "HTTP/1.1", "Method": "POST", "ContentType": null, "ContentLength": 0, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/negotiate", "QueryString": "?negotiateVersion=1", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/negotiate' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Request matched endpoint '/negotiate' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token found: DB47AA7C48674F7C343F76BC422E6D4B2E8A2C184EEE4FB99F6127E20B0BC253 {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token is a reference token and is supported. {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: BearerIdentityServerAuthenticationIntrospection was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityModel.AspNetCore.OAuth2Introspection.OAuth2IntrospectionHandler", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Authorization was successful. {"EventId": {"Id": 1, "Name": "UserAuthorizationSucceeded"}, "SourceContext": "Microsoft.AspNetCore.Authorization.DefaultAuthorizationService", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executing endpoint '/negotiate' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] New connection nIbCwzYy75YdafRrkHcFNQ created. {"EventId": {"Id": 1, "Name": "CreatedNewConnection"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionManager", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Sending negotiation response. {"EventId": {"Id": 10, "Name": "NegotiationRequest"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionDispatcher", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executed endpoint '/negotiate' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] HTTP POST /negotiate?negotiateVersion=1 responded 200 in 13.0231 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": "application/json", "EndpointName": "/negotiate", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000003", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000"}
[18:18:48 INF] Request finished in 13.4996ms 200 application/json {"ElapsedMilliseconds": 13.4996, "StatusCode": 200, "ContentType": "application/json", "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000003", "RequestPath": "/negotiate", "SpanId": "b7e7cd7c64ed7a4f", "TraceId": "6955cda9394a2a4cbdd840a48d5613f2", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Request starting HTTP/1.1 OPTIONS http://broadcast.company.xyz/?id=P4gYVFr30Epc5YBsMC3ccg   {"Protocol": "HTTP/1.1", "Method": "OPTIONS", "ContentType": null, "ContentLength": null, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/", "QueryString": "?id=P4gYVFr30Epc5YBsMC3ccg", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Request matched endpoint '' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request is a preflight request. {"EventId": {"Id": 1, "Name": "IsPreflightRequest"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] HTTP OPTIONS /?id=P4gYVFr30Epc5YBsMC3ccg responded 204 in 0.2419 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": null, "EndpointName": "", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000004", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000"}
[18:18:48 INF] Request finished in 0.575ms 204  {"ElapsedMilliseconds": 0.575, "StatusCode": 204, "ContentType": null, "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000004", "RequestPath": "/", "SpanId": "c7d3a60854b7d641", "TraceId": "ccace9b37d0d7b44833e5d2cdaa78cf1", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Request starting HTTP/1.1 GET http://broadcast.company.xyz/?id=P4gYVFr30Epc5YBsMC3ccg   {"Protocol": "HTTP/1.1", "Method": "GET", "ContentType": null, "ContentLength": null, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/", "QueryString": "?id=P4gYVFr30Epc5YBsMC3ccg", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Request matched endpoint '' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token found: DB47AA7C48674F7C343F76BC422E6D4B2E8A2C184EEE4FB99F6127E20B0BC253 {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token is a reference token and is supported. {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: BearerIdentityServerAuthenticationIntrospection was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityModel.AspNetCore.OAuth2Introspection.OAuth2IntrospectionHandler", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Authorization was successful. {"EventId": {"Id": 1, "Name": "UserAuthorizationSucceeded"}, "SourceContext": "Microsoft.AspNetCore.Authorization.DefaultAuthorizationService", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executing endpoint '' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Establishing new connection. {"EventId": {"Id": 4, "Name": "EstablishedConnection"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionDispatcher", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executed endpoint '' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] HTTP GET /?id=P4gYVFr30Epc5YBsMC3ccg responded 200 in 13.8832 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": "application/octet-stream", "EndpointName": "", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000005", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] OnConnectedAsync started. {"EventId": {"Id": 5, "Name": "ConnectedStarting"}, "SourceContext": "Microsoft.AspNetCore.SignalR.HubConnectionHandler", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000"}
[18:18:48 INF] Request finished in 14.3555ms 200 application/octet-stream {"ElapsedMilliseconds": 14.3555, "StatusCode": 200, "ContentType": "application/octet-stream", "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ8" accepted. {"EventId": {"Id": 39, "Name": "ConnectionAccepted"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ8" started. {"EventId": {"Id": 1, "Name": "ConnectionStart"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 INF] Request starting HTTP/1.1 GET http://10.244.186.174:10240/readiness   {"Protocol": "HTTP/1.1", "Method": "GET", "ContentType": null, "ContentLength": null, "Scheme": "http", "Host": "10.244.186.174:10240", "PathBase": "", "Path": "/readiness", "QueryString": "", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/readiness' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] Request matched endpoint 'Health checks' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] AuthenticationScheme: Bearer was not authenticated. {"EventId": {"Id": 9, "Name": "AuthenticationSchemeNotAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 INF] Executing endpoint 'Health checks' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] Running health checks {"EventId": {"Id": 100, "Name": "HealthCheckProcessingBegin"}, "SourceContext": "Microsoft.Extensions.Diagnostics.HealthChecks.DefaultHealthCheckService", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] Running health check self {"EventId": {"Id": 102, "Name": "HealthCheckBegin"}, "SourceContext": "Microsoft.Extensions.Diagnostics.HealthChecks.DefaultHealthCheckService", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] Health check self completed after 0.1595ms with status Healthy and 'null' {"EventId": {"Id": 103, "Name": "HealthCheckEnd"}, "SourceContext": "Microsoft.Extensions.Diagnostics.HealthChecks.DefaultHealthCheckService", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] Health check processing completed after 0.3949ms with combined status Healthy {"EventId": {"Id": 101, "Name": "HealthCheckProcessingEnd"}, "SourceContext": "Microsoft.Extensions.Diagnostics.HealthChecks.DefaultHealthCheckService", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 INF] Executed endpoint 'Health checks' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 VRB] HTTP GET /readiness responded 200 in 0.9228 ms {"Host": "10.244.186.174:10240", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": "text/plain", "EndpointName": "Health checks", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ8:00000001", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 INF] Request finished in 1.1645ms 200 text/plain {"ElapsedMilliseconds": 1.1645, "StatusCode": 200, "ContentType": "text/plain", "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ8:00000001", "RequestPath": "/readiness", "SpanId": "5955e7c73fc57849", "TraceId": "b81a42ed45aee5439875b9686557b209", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ8"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ8" received FIN. {"EventId": {"Id": 6, "Name": "ConnectionReadFin"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ8" disconnecting. {"EventId": {"Id": 10, "Name": "ConnectionDisconnect"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ8" sending FIN because: "The client closed the connection." {"EventId": {"Id": 7, "Name": "ConnectionWriteFin"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ8" stopped. {"EventId": {"Id": 2, "Name": "ConnectionStop"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 INF] Request starting HTTP/1.1 GET http://broadcast.company.xyz/?id=P4gYVFr30Epc5YBsMC3ccg   {"Protocol": "HTTP/1.1", "Method": "GET", "ContentType": null, "ContentLength": null, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/", "QueryString": "?id=P4gYVFr30Epc5YBsMC3ccg", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Request matched endpoint '' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token found: DB47AA7C48674F7C343F76BC422E6D4B2E8A2C184EEE4FB99F6127E20B0BC253 {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 VRB] Token is a reference token and is supported. {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: BearerIdentityServerAuthenticationIntrospection was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityModel.AspNetCore.OAuth2Introspection.OAuth2IntrospectionHandler", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Authorization was successful. {"EventId": {"Id": 1, "Name": "UserAuthorizationSucceeded"}, "SourceContext": "Microsoft.AspNetCore.Authorization.DefaultAuthorizationService", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executing endpoint '' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Resuming existing connection. {"EventId": {"Id": 5, "Name": "ResumingConnection"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionDispatcher", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ9" accepted. {"EventId": {"Id": 39, "Name": "ConnectionAccepted"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ9" started. {"EventId": {"Id": 1, "Name": "ConnectionStart"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel"}
[18:18:48 INF] Request starting HTTP/1.1 POST http://broadcast.company.xyz/?id=P4gYVFr30Epc5YBsMC3ccg  32 {"Protocol": "HTTP/1.1", "Method": "POST", "ContentType": null, "ContentLength": 32, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/", "QueryString": "?id=P4gYVFr30Epc5YBsMC3ccg", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] Request matched endpoint '' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] Token found: DB47AA7C48674F7C343F76BC422E6D4B2E8A2C184EEE4FB99F6127E20B0BC253 {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] Token is a reference token and is supported. {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] AuthenticationScheme: BearerIdentityServerAuthenticationIntrospection was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityModel.AspNetCore.OAuth2Introspection.OAuth2IntrospectionHandler", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] Authorization was successful. {"EventId": {"Id": 1, "Name": "UserAuthorizationSucceeded"}, "SourceContext": "Microsoft.AspNetCore.Authorization.DefaultAuthorizationService", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] Executing endpoint '' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ9", Request id "0HM2QD9QHKLJ9:00000001": started reading request body. {"EventId": {"Id": 25, "Name": "RequestBodyStart"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ9", Request id "0HM2QD9QHKLJ9:00000001": done reading request body. {"EventId": {"Id": 26, "Name": "RequestBodyDone"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000"}
[18:18:48 VRB] Received 32 bytes. {"EventId": {"Id": 6, "Name": "ReceivedBytes"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionDispatcher", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] Found protocol implementation for requested protocol: json. {"EventId": {"Id": 2, "Name": "FoundImplementationForProtocol"}, "SourceContext": "Microsoft.AspNetCore.SignalR.Internal.DefaultHubProtocolResolver", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Executed endpoint '' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] Completed connection handshake. Using HubProtocol 'json'. {"EventId": {"Id": 1, "Name": "HandshakeComplete"}, "SourceContext": "Microsoft.AspNetCore.SignalR.HubConnectionContext", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000005", "RequestPath": "/", "SpanId": "d6e2b3b30550c149", "TraceId": "d1910277ada4d841afb7b2a529921ea4", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] HTTP POST /?id=P4gYVFr30Epc5YBsMC3ccg responded 200 in 16.1763 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": "text/plain", "EndpointName": "", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000001", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] Writing a 3 byte message to connection. {"EventId": {"Id": 3, "Name": "LongPollingWritingMessage"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.Transports.LongPollingTransport", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ9" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000"}
[18:18:48 INF] Executed endpoint '' {"EventId": {"Id": 1, "Name": "ExecutedEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Request finished in 16.8592ms 200 text/plain {"ElapsedMilliseconds": 16.8592, "StatusCode": 200, "ContentType": "text/plain", "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ9:00000001", "RequestPath": "/", "SpanId": "e733508da004ff4b", "TraceId": "b6157e2ac0b8b347a13cc951ad6d5931", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] HTTP GET /?id=P4gYVFr30Epc5YBsMC3ccg responded 200 in 34.5274 ms {"Host": "broadcast.company.xyz", "Protocol": "HTTP/1.1", "Scheme": "http", "ContentType": "application/octet-stream", "EndpointName": "", "SourceContext": "Serilog.AspNetCore.RequestLoggingMiddleware", "RequestId": "0HM2QD9QHKLJ7:00000006", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 DBG] Connection id "0HM2QD9QHKLJ7" completed keep alive response. {"EventId": {"Id": 9, "Name": "ConnectionKeepAlive"}, "SourceContext": "Microsoft.AspNetCore.Server.Kestrel", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000"}
[18:18:48 INF] Request finished in 35.4431ms 200 application/octet-stream {"ElapsedMilliseconds": 35.4431, "StatusCode": 200, "ContentType": "application/octet-stream", "EventId": {"Id": 2}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ7:00000006", "RequestPath": "/", "SpanId": "585902abdda4eb40", "TraceId": "63591a6057a6ba4aa69048a82a8fd87e", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ7"}
[18:18:48 INF] Request starting HTTP/1.1 GET http://broadcast.company.xyz/?id=P4gYVFr30Epc5YBsMC3ccg   {"Protocol": "HTTP/1.1", "Method": "GET", "ContentType": null, "ContentLength": null, "Scheme": "http", "Host": "broadcast.company.xyz", "PathBase": "", "Path": "/", "QueryString": "?id=P4gYVFr30Epc5YBsMC3ccg", "EventId": {"Id": 1}, "SourceContext": "Microsoft.AspNetCore.Hosting.Diagnostics", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] All hosts are allowed. {"EventId": {"Id": 2, "Name": "AllHostsAllowed"}, "SourceContext": "Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] 1 candidate(s) found for the request path '/' {"EventId": {"Id": 1001, "Name": "CandidatesFound"}, "SourceContext": "Microsoft.AspNetCore.Routing.Matching.DfaMatcher", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] Request matched endpoint '' {"EventId": {"Id": 1, "Name": "MatchSuccess"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointRoutingMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] The request has an origin header: 'https://map.company.xyz'. {"EventId": {"Id": 2, "Name": "RequestHasOriginHeader"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] CORS policy execution successful. {"EventId": {"Id": 4, "Name": "PolicySuccess"}, "SourceContext": "Microsoft.AspNetCore.Cors.Infrastructure.CorsService", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] HandleAuthenticateAsync called {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] Token found: DB47AA7C48674F7C343F76BC422E6D4B2E8A2C184EEE4FB99F6127E20B0BC253 {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 VRB] Token is a reference token and is supported. {"SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] AuthenticationScheme: BearerIdentityServerAuthenticationIntrospection was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityModel.AspNetCore.OAuth2Introspection.OAuth2IntrospectionHandler", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] AuthenticationScheme: Bearer was successfully authenticated. {"EventId": {"Id": 8, "Name": "AuthenticationSchemeAuthenticated"}, "SourceContext": "IdentityServer4.AccessTokenValidation.IdentityServerAuthenticationHandler", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] Authorization was successful. {"EventId": {"Id": 1, "Name": "UserAuthorizationSucceeded"}, "SourceContext": "Microsoft.AspNetCore.Authorization.DefaultAuthorizationService", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 INF] Executing endpoint '' {"EventId": {"Name": "ExecutingEndpoint"}, "SourceContext": "Microsoft.AspNetCore.Routing.EndpointMiddleware", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}
[18:18:48 DBG] Resuming existing connection. {"EventId": {"Id": 5, "Name": "ResumingConnection"}, "SourceContext": "Microsoft.AspNetCore.Http.Connections.Internal.HttpConnectionDispatcher", "TransportConnectionId": "nIbCwzYy75YdafRrkHcFNQ", "RequestId": "0HM2QD9QHKLJ9:00000002", "RequestPath": "/", "SpanId": "a58419a4e6084647", "TraceId": "921ae06af05ba049a19697f4ebec8ab0", "ParentId": "0000000000000000", "ConnectionId": "0HM2QD9QHKLJ9"}

Exceptions (if any)

Further technical details

• ASP.NET Core version: 5.0 rc-1
• Include the output of dotnet --info:

$ dotnet --info
.NET SDK (reflecting any global.json):
 Version:   5.0.100-rc.1.20452.10
 Commit:    473d1b592e

Runtime Environment:
 OS Name:     Windows
 OS Version:  10.0.18362
 OS Platform: Windows
 RID:         win10-x64
 Base Path:   C:\Program Files\dotnet\sdk\5.0.100-rc.1.20452.10\

Host (useful for support):
  Version: 5.0.0-rc.1.20451.14
  Commit:  38017c3935

• The IDE (VS / VS Code/ VS4Mac) you're running on, and it's version: vscode

[msschl]

Although I don't suspect this being the problem, here is the Cors policy used of the signalr server:

services.AddCors(options =>
{
  options.AddDefaultPolicy(builder =>
  {
    builder.WithOrigins("https://map.company.xyz", "https://localhost:5001")
           .AllowAnyHeader()
           .WithMethods("OPTIONS", "GET", "POST")
           .AllowCredentials();
  });
});

[BrennanConroy]

Do you have logs before, during, and after the failure? Those look like logs before it failed so everything is functioning normally.

@pranavkm Is "TypeError: Failed to fetch" an easy error to diagnose or just something generic?

[msschl]

Logs from the client:

info: Microsoft.AspNetCore.Http.Connections.Client.Internal.LongPollingTransport[1]
      Starting transport. Transfer mode: Text.
dotnet.5.0.0-rc.1.20451.14.js:1 info: Microsoft.AspNetCore.Http.Connections.Client.HttpConnection[3]
      HttpConnection Started.
dotnet.5.0.0-rc.1.20451.14.js:1 info: Microsoft.AspNetCore.SignalR.Client.HubConnection[24]
      Using HubProtocol 'json v1'.
dotnet.5.0.0-rc.1.20451.14.js:1 info: Microsoft.AspNetCore.SignalR.Client.HubConnection[44]
      HubConnection started.
Access to fetch at 'https://broadcast.company.xyz/?id=ZpkSp4Kc-XndiL21-qYM8Q' from origin 'https://map.company.xyz' has been blocked by CORS policy: No 'Access-Control-Allow-Origin' header is present on the requested resource. If an opaque response serves your needs, set the request's mode to 'no-cors' to fetch the resource with CORS disabled.
VM7:1 GET https://broadcast.company.xyz/?id=ZpkSp4Kc-XndiL21-qYM8Q net::ERR_FAILED
(anonymous) @ VM7:1
_mono_wasm_invoke_js_with_args @ dotnet.5.0.0-rc.1.20451.14.js:1
...

This time I also got a CORS error...
Also, in the logs of the server are no errors.

So may be the problem is again related to Cors? Maybe due to the browser fetch api used?

[BrennanConroy]

Also, in the logs of the server are no errors.

Ah thanks, that's what I was looking for.

Ok, if you got a CORS error then that's probably the root cause

[msschl]

In dotnet/runtime #42179 I had to add .WithExposedHeaders("header_name") to get headers in the HttpClient. As signalr uses the HttpClient are there any headers that need to be exposed?

[BrennanConroy]

No, SignalR doesn't read any headers.

I forgot about this doc, it might help
https://docs.microsoft.com/aspnet/core/blazor/fundamentals/additional-scenarios?view=aspnetcore-3.1#signalr-cross-origin-negotiation-for-authentication

[msschl]

I've tried it, but I doesn't solve the problem. Also the authorization header was already sent before, even without adding the IncludeRequestCredentialsMessageHandler.cs

[msschl]

I would really like to have longpolling working at least as a fallback for ws. Any other ideas?

[BrennanConroy]

It just looks like you have CORS mis-configured somehow. Is your server behind a reverse proxy? Hosted in Azure App Service? There might be CORS settings you need at those layers if so.

Have you tried normal http requests from your app to see if they work?

Thank you for contacting us. Due to a lack of activity on this discussion issue we're closing it in an effort to keep our backlog clean. If you believe there is a concern related to the ASP.NET Core framework, which hasn't been addressed yet, please file a new issue.

This issue will be locked after 30 more days of inactivity. If you still wish to discuss this subject after then, please create a new issue!