Skip to content
New issue

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

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

Already on GitHub? Sign in to your account

Nginx hosting issue #8300

Closed
bencoskater opened this issue Aug 28, 2018 — with docs.microsoft.com · 38 comments
Closed

Nginx hosting issue #8300

bencoskater opened this issue Aug 28, 2018 — with docs.microsoft.com · 38 comments
Labels
Source - Docs.ms Docs Customer feedback via GitHub Issue
Milestone

Comments

Copy link

Hi,

Please update your documentation. I tried what you wrote (good tuto by the way). Unfortunately my web application crashed after some REST API calls. Apparently due to the localhost binding and target ip in nginx. Following urls http://*:8080 and http://127.0.0.1:8080 + server 127.0.0.1:8080 in nginx make the application crash with aborted connection.
So to make it works, I had to replace the binding with the network IP and the same in nginx.
This happened in production mode.


Document Details

Do not edit this section. It is required for docs.microsoft.com ➟ GitHub issue linking.

@bencoskater
Copy link
Author

unfortunately the problem is still present...
27 23:57:47 server-web dotnet-web-sro-status[6378]: warn: Microsoft.AspNetCore.Server.Kestrel[0]
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: Connection processing ended abnormally.
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: Microsoft.AspNetCore.Connections.ConnectionAbortedException: The connection was aborted
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at System.IO.Pipelines.PipeCompletion.ThrowLatchedException()
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at System.IO.Pipelines.Pipe.GetReadResult(ReadResult& result)
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at System.IO.Pipelines.Pipe.GetReadAsyncResult()
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at System.IO.Pipelines.Pipe.DefaultPipeReader.GetResult(Int16 token)
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at System.Threading.Tasks.ValueTask`1.get_Result()
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequests[TContext](IHt
g 27 23:57:47 server-web dotnet-web-sro-status[6378]: at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequestsAsync[TContext

@guardrex
Copy link
Collaborator

@shirhatti

@guardrex guardrex self-assigned this Aug 28, 2018
@guardrex guardrex added the Source - Docs.ms Docs Customer feedback via GitHub Issue label Aug 28, 2018
@guardrex guardrex added this to the Backlog milestone Aug 28, 2018
@bencoskater
Copy link
Author

Ok, after first investigation it seems to be an issue when I use cloudflare (client<—>cloudflare<—>nginx<—>kestrel).
I think the header is bigger than expected provoking the crash. I will check that and let you know...

@shirhatti
Copy link
Contributor

@halter73

@halter73
Copy link
Member

@bencoskater When you say you see a crash, how is that observed other than these logs? Does the process unexpectedly exit? Is a connection unexpectedly closed by the server?

Also, what version of ASP.NET Core/Kestrel you are using? If you are using 2.1, did you select Kestrel's libuv transport?

@bencoskater
Copy link
Author

bencoskater commented Aug 28, 2018

Hi @halter73,

It’s the runtime 2.1.3. I will provide you other informations tonight. Thanks for your help

@bencoskater
Copy link
Author

Is there any way to get detailed logs?

@halter73
Copy link
Member

Trace is our most verbose log level. Here are the docs for changing this.

@bencoskater
Copy link
Author

bencoskater commented Aug 28, 2018

By the way the error 502 happens on the call of rest API.

@halter73
Copy link
Member

Do you get a 502 for all subsequent requests until you restart the server? Or is it a transient issue?

@bencoskater
Copy link
Author

bencoskater commented Aug 29, 2018

It’s transient. Since I disabled cloudflare proxy I got less problem.
The process is next:
Call Default controller V1Controller, action Index (~/)—> Ok
Call rest API Controller api action Providers (~/api/providers)—> transient issue, almost the time it’s ok
Then click on tab to display status:
Call rest API Controller api action status (~/API/provider/{id}/status) —> transient issue but this part failed almost the time especially with cloudflare enabled.
Right after I refresh the page, cloudflare reply with 502 error. I wait few minutes and retry again. Rarely everything is fine. Almost the time it is in failure. With cloudflare on, it’s a nightmare lol.

@bencoskater
Copy link
Author

bencoskater commented Aug 29, 2018

Here is my configuration:
Virtual machine on Debian 9 Kernel - Linux 4.9.0-8-amd64, RAM: 973MB, PROC: Intel(R) Core(TM) i3-3110M CPU @ 2.40GHz, 1 core

.Net:
Host (useful for support):
Version: 2.1.3
Commit: 124038c13e

.NET Core SDKs installed:
No SDKs were found.

.NET Core runtimes installed:
Microsoft.AspNetCore.All 2.1.3 [/usr/share/dotnet/shared/Microsoft.AspNetCore.All]
Microsoft.AspNetCore.App 2.1.3 [/usr/share/dotnet/shared/Microsoft.AspNetCore.App]
Microsoft.NETCore.App 2.1.3 [/usr/share/dotnet/shared/Microsoft.NETCore.App

libuv is not installed as I am using the runtime, apparantly not required regarding the documentation.

Here is the nginx host configuration:

upstream sro-status {
        server 192.168.0.253:8081;
        keepalive 16;
        zone sro-status 64k;
}
server {
        listen 443;
        ssl on;
        ssl_certificate /home/nginx/certs/my-cloud-ga.pem;
        ssl_certificate_key /home/nginx/certs/my-cloud-ga.key;
        server_name srostats.my-cloud.ga;
        location / {
                proxy_set_header Host $host;
                proxy_set_header X-Forwarded-For $proxy_add_x_forwarded_for;
                proxy_set_header Upgrade $http_upgrade;
                proxy_set_header Connection keep-alive;
                proxy_set_header X-Forwarded-Proto $scheme;
                proxy_pass http://sro-status;
                proxy_http_version 1.1;
                proxy_set_header Connection keep-alive;
                proxy_cache_bypass $http_upgrade;
                fastcgi_buffers 16 16k;
                fastcgi_buffer_size 32k;
                proxy_connect_timeout 300s;
                proxy_read_timeout 300s;
        }
}

nginx.config:

user www-data;
worker_processes auto;
pid /run/nginx.pid;
include /etc/nginx/modules-enabled/*.conf;
events {
        worker_connections 768;
}
http {
        sendfile on;
        tcp_nopush on;
        tcp_nodelay on;
        keepalive_timeout 65;
        types_hash_max_size 2048;
        server_names_hash_bucket_size 64;
        include /etc/nginx/mime.types;
        default_type application/octet-stream;
        ssl_protocols TLSv1 TLSv1.1 TLSv1.2; # Dropping SSLv3, ref: POODLE
        ssl_prefer_server_ciphers on;
        access_log /var/log/nginx/access.log;
        error_log /var/log/nginx/error.log;
        gzip on;
        gzip_disable "msie6";
        include /etc/nginx/conf.d/*.conf;
        include /etc/nginx/sites-enabled/*;
        \#defined for .net core
        proxy_buffer_size   128k;
        proxy_buffers   4 256k;
        proxy_busy_buffers_size   256k;
        large_client_header_buffers 4 16k;
}

@bencoskater
Copy link
Author

bencoskater commented Aug 29, 2018

here is the logs from nginx:

2018/08/28 23:04:35 [error] 13215#13215: *1 upstream prematurely closed connection while reading response header from upstream, client: 162.158.126.36, server: srostats.my-cloud.ga, request: "GET /api/Provider/1/ServerList HTTP/1.1", upstream: "http://192.168.0.253:8081/api/Provider/1/ServerList", host: "srostats.my-cloud.ga", referrer: "https://srostats.my-cloud.ga/"
2018/08/28 23:05:11 [error] 13215#13215: *7 upstream prematurely closed connection while reading response header from upstream, client: 162.158.126.36, server: srostats.my-cloud.ga, request: "GET /api/Providers HTTP/1.1", upstream: "http://192.168.0.253:8081/api/Providers", host: "srostats.my-cloud.ga", referrer: "https://srostats.my-cloud.ga/"
2018/08/28 23:05:11 [error] 13215#13215: *7 upstream prematurely closed connection while reading response header from upstream, client: 162.158.126.36, server: srostats.my-cloud.ga, request: "GET /api/Providers HTTP/1.1", upstream: "http://192.168.0.253:8081/api/Providers", host: "srostats.my-cloud.ga", referrer: "https://srostats.my-cloud.ga/"
2018/08/28 23:11:42 [error] 13734#13734: *3 upstream prematurely closed connection while reading response header from upstream, client: 162.158.126.66, server: srostats.my-cloud.ga, request: "GET /api/Providers HTTP/1.1", upstream: "http://192.168.0.253:8081/api/Providers", host: "srostats.my-cloud.ga", referrer: "https://srostats.my-cloud.ga/"
2018/08/28 23:11:42 [error] 13734#13734: *3 upstream prematurely closed connection while reading response header from upstream, client: 162.158.126.66, server: srostats.my-cloud.ga, request: "GET /api/Providers HTTP/1.1", upstream: "http://192.168.0.253:8081/api/Providers", host: "srostats.my-cloud.ga", referrer: "https://srostats.my-cloud.ga/"

logs from journalctl -fu of my Kestrel service:

-- Logs begin at Mon 2018-08-27 01:21:20 EDT. --
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequests[TContext](IHttpApplication`1 application)
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequestsAsync[TContext](IHttpApplication`1 application)
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]: warn: Microsoft.AspNetCore.Server.Kestrel[0]
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:       Connection processing ended abnormally.
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]: Microsoft.AspNetCore.Connections.ConnectionAbortedException: The connection was aborted
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at System.IO.Pipelines.PipeCompletion.ThrowLatchedException()
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at System.IO.Pipelines.Pipe.GetReadResult(ReadResult& result)
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at System.IO.Pipelines.Pipe.GetReadAsyncResult()
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequests[TContext](IHttpApplication`1 application)
Aug 28 23:11:42 server-web dotnet-web-sro-status[26557]:    at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequestsAsync[TContext](IHttpApplication`1 application)

Unfortunately I did not get time to implement logs in my application. regarding nginx logs, it seems to be a header problem.

@bencoskater
Copy link
Author

I implemented this in the Program class for the moment and compiled in debug to see if there will be more details:

private static void CurrentDomain_FirstChanceException(object sender, System.Runtime.ExceptionServices.FirstChanceExceptionEventArgs e)
        {

            //log.LogError(e.Exception.ToString());
            Console.WriteLine(e.Exception);

        }

        private static void CurrentDomain_UnhandledException(object sender, UnhandledExceptionEventArgs e)
        {
            //log.LogError(e.ToString());
            Console.WriteLine(e);
        }

@bencoskater
Copy link
Author

Hi,

My yesterday’s modification provides nothing more :( I will continue to investigate tonight. In the meantime if you have any ideas that would be helpful :)

@halter73
Copy link
Member

@bencoskater Do you have any additional trace/info level logs? I'm pretty sure the ConnectionAbortedException originated due to an exception thrown from Socket.SendAsync(). Details about these kind of SocketExceptions are usually logged at the informational level in 2.1.3.

For 2.2.0-preview2, I've made some changes to the socket transport in the KestrelHttpServer repository to better report these kind of errors so you don't need that kind of verbose tracing to get details about SocketExceptions thrown from SendAsync if it prematurely ends. Unfortunately, this hasn't even been picked up by our daily builds yet.

I would try upping the logging verbosity first, but if that by itself doesn't work, you could also try cloning the aspnet/KestrelHttpServer repo, checking out the release/2.2 branch, running build.sh, and referencing the repo's artifacts/build/ directory in your NuGet.config.

@bencoskater
Copy link
Author

bencoskater commented Aug 29, 2018

I am using VS on windows. The Linux is used as web server.
I am going to make a copy (or a snapshot) of my vm andcompile on it and then try it. What do you think?
Should I remove the installed version?

@halter73
Copy link
Member

You don't have to compile Kestrel on your Linux VM. You can compile the Kestrel NuGet packages on Windows, reference them from your NuGet.config, and publish your app from Windows to Linux.

You might be able to save yourself some effort by continuing to use version 2.1.3 of Kestrel with more verbose logging. I expect that will also give us details about originating exception. I only suggesting compiling Kestrel yourself as a last ditch effort.

@bencoskater
Copy link
Author

Hi Stephen,
I added the preview 2.2.0-preview1-35029 in my project and added following config logs in "CreateWebHostBuilder":

.ConfigureLogging((hostingContext, logging) =>
                {
                    logging.AddConfiguration(hostingContext.Configuration.GetSection("logging"));
                    logging.AddConsole();
                    logging.AddDebug();
                })

I Cannot connect to the host, here is the exception logged:

kestrel-sro-status.service - Silkroad Online Server Analytics
   Loaded: loaded (/etc/systemd/system/kestrel-sro-status.service; enabled; vendor preset: enabled)
   Active: active (running) since Wed 2018-08-29 20:40:25 EDT; 21s ago
 Main PID: 30109 (dotnet)
    Tasks: 18 (limit: 4915)
   CGroup: /system.slice/kestrel-sro-status.service
           └─30109 /usr/bin/dotnet /home/svc-net/www/Silkroad.Analytics/Silkroad.Analytics.WebV1.dll

Aug 29 20:40:25 server-web systemd[1]: Started Silkroad Online Server Analytics.
Aug 29 20:40:26 server-web dotnet-web-sro-status[30109]: Hosting environment: Production
Aug 29 20:40:26 server-web dotnet-web-sro-status[30109]: Content root path: /home/svc-net/www/Silkroad.Analytics
Aug 29 20:40:26 server-web dotnet-web-sro-status[30109]: Now listening on: http://0.0.0.0:8081
Aug 29 20:40:26 server-web dotnet-web-sro-status[30109]: Application started. Press Ctrl+C to shut down.
Aug 29 20:40:28 server-web dotnet-web-sro-status[30109]: crit: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[0]
Aug 29 20:40:28 server-web dotnet-web-sro-status[30109]:       Unexpected exception in SocketTransport.HandleConnectionAsync.
Aug 29 20:40:28 server-web dotnet-web-sro-status[30109]: System.MissingMethodException: Method not found: 'Void Microsoft.AspNetCore.Server.Kestrel.Transport.Abstractions.Internal.IConnectionDispatcher.OnConnection(Microsoft.AspNetCore.Server.Kestrel.Transport.Abstractions.Internal.TransportConnection)'.
Aug 29 20:40:28 server-web dotnet-web-sro-status[30109]:    at Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets.SocketTransport.HandleConnectionAsync(SocketConnection connection)

Apparently the method "OnConnection" is missing in this version. I do not know if it is related to my issue.

@bencoskater
Copy link
Author

bencoskater commented Aug 30, 2018

I had to upgrade all packages to 2.2 preview. I created a self-contained package for testing. I cannot reproduce the exception for the moment.

@bencoskater
Copy link
Author

Hi, got the error this morning with this version. I don't have any more details using systemctl status nor journalctl -xe. the only logs I have is:

kestrel-sro-status.service - Silkroad Online Server Analytics
   Loaded: loaded (/etc/systemd/system/kestrel-sro-status.service; enabled; vendor preset: enabled)
   Active: active (running) since Thu 2018-08-30 07:18:04 EDT; 39s ago
 Main PID: 30611 (dotnet)
    Tasks: 21 (limit: 4915)
   CGroup: /system.slice/kestrel-sro-status.service
           └─30611 /usr/bin/dotnet /home/svc-net/www/Silkroad.Analytics/Silkroad.Analytics.WebV1.dll

Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]: info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]:       Executing action method Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1) with arguments (1) - Validation state: Valid
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]: info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]:       Executed action method Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1), returned result Microsoft.AspNetCore.Mvc.ObjectResult in 17.149ms.
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]: info: Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor[1]
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]:       Executing ObjectResult, writing value of type 'System.Linq.Enumerable+SelectListIterator`2[[SilkroadData.Model.ServerList, SilkroadData, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null],[<>f__AnonymousType0`5[[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.Boolean, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e]], Silkroad.Analytics.WebV1, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]'.
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]: info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]:       Executed action Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1) in 32.7256ms
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]: info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Aug 30 07:18:43 server-web dotnet-web-sro-status[30611]:       Request finished in 35.0947ms 200 application/json; charset=utf-8

@halter73
Copy link
Member

Are you still seeing 502's with the new packages? Is it possible your systemd journal has a very small buffer size?

I'm surprised there aren't any logs about the connection opening or closing. Those should always be there if you have your log level set to "Trace" even for non-error scenarios. If you set the log level to "Information" (which I believe is the default), you won't get these connection logs since that setting is not verbose enough.

The logs I'm referring to should look something like the following for a successful request.

dbug: Microsoft.AspNetCore.Server.Kestrel[1]
      Connection id "0HLGEKTFTTPT6" started.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
      Request starting HTTP/1.1 GET http://localhost:5000/
dbug: Microsoft.AspNetCore.Server.Kestrel[9]
      Connection id "0HLGEKTFTTPT6" completed keep alive response.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 45.7426ms 200 text/plain
dbug: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[6]
      Connection id "0HLGEKTFTTPT6" received FIN.
dbug: Microsoft.AspNetCore.Server.Kestrel[10]
      Connection id "0HLGEKTFTTPT6" disconnecting.
dbug: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[7]
      Connection id "0HLGEKTFTTPT6" sending FIN.
dbug: Microsoft.AspNetCore.Server.Kestrel[2]
      Connection id "0HLGEKTFTTPT6" stopped.

@bencoskater
Copy link
Author

bencoskater commented Aug 30, 2018

Hi Stephen, yes still getting errors. Now I changed to Trace and I have more details.
You can download it here https://srostats.my-cloud.ga/log.txt

Copy link

This is probably one of the best tutorial's so far. I will say though, after following all of the steps, I just get an NGNIX splash page. As in I get the NGINX splash page. Is anyone else running their web server headless?

@bencoskater
Copy link
Author

bencoskater commented Sep 1, 2018

Hi Stephen,

I installed Debian on a new VM to see if I got the porblem. Now the first server has only Nginx, and the other the 2.1 runtime and I deployed the package in seld-contained and ran the batch without dotnet command (it was a mistake of my previous test). I also taken advantage to redirect everything in a log file. the result is the same even in local network it has failed. Here is a part of the log:

      Request starting HTTP/1.1 GET http://srostats-dev.my-cloud.ga/api/Providers  
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware[0]
      All hosts are allowed.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.HttpOverrides.ForwardedHeadersMiddleware[1]
      Unknown proxy: 192.168.0.253:59644
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware[4]
      The request path /api/Providers does not match a supported file type
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Routing.Tree.TreeRouter[1]
      Request successfully matched the route with name '(null)' and template 'Api/Providers'.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Route matched with {action = "Providers", controller = "Api"}. Executing action Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1)
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of authorization filters (in the following order): None
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of resource filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of action filters (in the following order): Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of exception filters (in the following order): None
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of result filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter, Microsoft.AspNetCore.Mvc.ProducesAttribute (Order: 0)
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Executing action method Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1) - Validation state: Valid
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[4]
      Before executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[11]
      List of registered output formatters, in the following order: Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[4]
      No information found on request to perform content negotiation.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[9]
      Attempting to select the first output formatter in the output formatters list which supports a content type from the explicitly specified content types 'application/json'.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[2]
      Selected output formatter 'Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter' and content type 'application/json' to write the response.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor[1]
      Executing ObjectResult, writing value of type 'System.Linq.Enumerable+SelectListIterator`2[[SilkroadData.Model.Provider, SilkroadData, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null],[<>f__AnonymousType1`7[[System.Int32, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e]], Silkroad.Analytics.WebV1, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]'.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[5]
      After executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1) in 60.9317ms
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Server.Kestrel[9]
      Connection id "0HLGFRKEAS5UG" completed keep alive response.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 74.228ms 200 application/json; charset=utf-8
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action method Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1), returned result Microsoft.AspNetCore.Mvc.ObjectResult in 16.4339ms.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[4]
      Before executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[11]
      List of registered output formatters, in the following order: Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[4]
      No information found on request to perform content negotiation.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[9]
      Attempting to select the first output formatter in the output formatters list which supports a content type from the explicitly specified content types 'application/json'.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[2]
      Selected output formatter 'Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter' and content type 'application/json' to write the response.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor[1]
      Executing ObjectResult, writing value of type 'System.Linq.Enumerable+SelectListIterator`2[[SilkroadData.Model.Provider, SilkroadData, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null],[<>f__AnonymousType1`7[[System.Int32, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.UInt16, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e],[System.String, System.Private.CoreLib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=7cec85d7bea7798e]], Silkroad.Analytics.WebV1, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]'.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[5]
      After executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[37mtrce�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1) in 27.0426ms
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Server.Kestrel[9]
      Connection id "0HLGFRKEAS5UH" completed keep alive response.
�[40m�[32minfo�[39m�[22m�[49m: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 28.5361ms 200 application/json; charset=utf-8
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[7]
      Connection id "0HLGFRKEAS5UH" sending FIN.
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Server.Kestrel[10]
      Connection id "0HLGFRKEAS5UH" disconnecting.
�[40m�[1m�[33mwarn�[39m�[22m�[49m: Microsoft.AspNetCore.Server.Kestrel[0]
      Connection processing ended abnormally.
Microsoft.AspNetCore.Connections.ConnectionAbortedException: The connection was aborted
   at System.IO.Pipelines.PipeCompletion.ThrowLatchedException()
   at System.IO.Pipelines.PipeCompletion.IsCompletedOrThrow()
   at System.IO.Pipelines.Pipe.GetReadResult(ReadResult& result)
   at System.IO.Pipelines.Pipe.GetReadAsyncResult()
   at System.IO.Pipelines.Pipe.DefaultPipeReader.GetResult(Int16 token)
   at System.Threading.Tasks.ValueTask`1.get_Result()
   at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequests[TContext](IHttpApplication`1 application)
   at Microsoft.AspNetCore.Server.Kestrel.Core.Internal.Http.HttpProtocol.ProcessRequestsAsync[TContext](IHttpApplication`1 application)
�[40m�[37mdbug�[39m�[22m�[49m: Microsoft.AspNetCore.Server.Kestrel[2]
      Connection id "0HLGFRKEAS5UH" stopped.

@bencoskater
Copy link
Author

I am trying on windows and apparently there is no problem.

@se-augustus
Copy link

I resolved my issue...kind of. The "Location" attribute was incorrect. When I removed it, it worked.

@bencoskater
Copy link
Author

@se-augustus, hi, please make another ticket next time you are faced to a problem to do not make people confused about the original reported issue. Thanks

@bencoskater
Copy link
Author

Hi @halter73,
I hope you are fine. I would like to know if you have any update on the issue?

Thanks

@halter73
Copy link
Member

Unfortunately, the logs you posted aren't very revealing. That said, the improved reporting I mentioned in a pervious post should not finally be available on the https://dotnet.myget.org/F/dotnet-core/api/v3/index.json NuGet feed. If you could update to the 2.2.0-preview3-35208 version of Microsoft.AspNetCore.Server.Kestrel, that should get us better logs. Thank you for your patience.

@bencoskater
Copy link
Author

Hi,
OK, I will do that this week-end. thanks for following up!

@halter73
Copy link
Member

The 2.2.0-preview2 packages were uploaded to NuGet today. Those should also include the new logging.

@bencoskater
Copy link
Author

Hi Stephen,

Thanks for your feedback. I am going to update all my solution and let you know.

@bencoskater
Copy link
Author

bencoskater commented Sep 16, 2018

Hi sorry nothing related to https, I removed my previous post in consequence. I am in HTTP so the warning is shown because there is no https binding on my application.
Here is the log:

dbug: Microsoft.AspNetCore.Hosting.Internal.WebHost[3]
      Hosting starting
info: Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager[0]
      User profile is available. Using '/root/.aspnet/DataProtection-Keys' as key repository; keys will not be encrypted at rest.
dbug: Microsoft.AspNetCore.DataProtection.Repositories.FileSystemXmlRepository[37]
      Reading data from file '/root/.aspnet/DataProtection-Keys/key-0913f1bd-63e6-4591-b45d-5bc910ded270.xml'.
dbug: Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager[18]
      Found key {0913f1bd-63e6-4591-b45d-5bc910ded270}.
dbug: Microsoft.AspNetCore.DataProtection.KeyManagement.DefaultKeyResolver[13]
      Considering key {0913f1bd-63e6-4591-b45d-5bc910ded270} with expiration date 2018-12-15 00:10:22Z as default key.
dbug: Microsoft.AspNetCore.DataProtection.TypeForwardingActivator[0]
      Forwarded activator type request from Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ConfigurationModel.AuthenticatedEncryptorDescriptorDeserializer, Microsoft.AspNetCore.DataProtection, Version=2.2.0.0, Culture=neutral, PublicKeyToken=adb9793829ddae60 to Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ConfigurationModel.AuthenticatedEncryptorDescriptorDeserializer, Microsoft.AspNetCore.DataProtection, Culture=neutral, PublicKeyToken=adb9793829ddae60
dbug: Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ManagedAuthenticatedEncryptorFactory[11]
      Using managed symmetric algorithm 'System.Security.Cryptography.Aes'.
dbug: Microsoft.AspNetCore.DataProtection.AuthenticatedEncryption.ManagedAuthenticatedEncryptorFactory[10]
      Using managed keyed hash algorithm 'System.Security.Cryptography.HMACSHA256'.
dbug: Microsoft.AspNetCore.DataProtection.KeyManagement.KeyRingProvider[2]
      Using key {0913f1bd-63e6-4591-b45d-5bc910ded270} as the default key.
dbug: Microsoft.AspNetCore.DataProtection.Internal.DataProtectionStartupFilter[0]
      Key ring with default key {0913f1bd-63e6-4591-b45d-5bc910ded270} was loaded during application startup.
dbug: Microsoft.AspNetCore.Mvc.MvcJsonOptions[0]
      Compatibility switch AllowInputFormatterExceptionMessages in type MvcJsonOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch AllowCombiningAuthorizeFilters in type MvcOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch AllowBindingHeaderValuesToNonStringModelTypes in type MvcOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch AllowValidatingTopLevelNodes in type MvcOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch InputFormatterExceptionPolicy in type MvcOptions is using compatibility value MalformedInputExceptions for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch SuppressBindingUndefinedValueToEnumType in type MvcOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch EnableEndpointRouting in type MvcOptions is using default value False
dbug: Microsoft.AspNetCore.Mvc.MvcOptions[0]
      Compatibility switch MaxValidationDepth in type MvcOptions is using default value (null)
dbug: Microsoft.AspNetCore.Mvc.ApiBehaviorOptions[0]
      Compatibility switch SuppressMapClientErrors in type ApiBehaviorOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.ApiBehaviorOptions[0]
      Compatibility switch SuppressUseValidationProblemDetailsForInvalidModelStateResponses in type ApiBehaviorOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.RazorPages.RazorPagesOptions[0]
      Compatibility switch AllowAreas in type RazorPagesOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.RazorPages.RazorPagesOptions[0]
      Compatibility switch AllowMappingHeadRequestsToGetHandler in type RazorPagesOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcViewOptions[0]
      Compatibility switch SuppressTempDataAttributePrefix in type MvcViewOptions is using compatibility value True for version Version_2_1
dbug: Microsoft.AspNetCore.Mvc.MvcViewOptions[0]
      Compatibility switch AllowRenderingMaxLengthAttribute in type MvcViewOptions is using default value False
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ModelBinderFactory[12]
      Registered model binder providers, in the following order: Microsoft.AspNetCore.Mvc.ModelBinding.Binders.BinderTypeModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.ServicesModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.BodyModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.HeaderModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.FloatingPointTypeModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.EnumTypeModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.SimpleTypeModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.CancellationTokenModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.ByteArrayModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.FormFileModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.FormCollectionModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.KeyValuePairModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.DictionaryModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.ArrayModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.CollectionModelBinderProvider, Microsoft.AspNetCore.Mvc.ModelBinding.Binders.ComplexTypeModelBinderProvider
dbug: Microsoft.AspNetCore.Server.Kestrel.Core.KestrelServer[2]
      Failed to locate the development https certificate at '(null)'.
dbug: Microsoft.AspNetCore.Hosting.Internal.WebHost[4]
      Hosting started
dbug: Microsoft.AspNetCore.Hosting.Internal.WebHost[0]
      Loaded hosting startup assembly Silkroad.Analytics.WebV1
Hosting environment: Production
Content root path: /home/svc-net/www/Silkroad.Analytics
Now listening on: http://0.0.0.0:8081
Application started. Press Ctrl+C to shut down.
dbug: Microsoft.AspNetCore.Server.Kestrel[1]
      Connection id "0HLGRD7EOQ76P" started.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
      Request starting HTTP/1.0 GET http://srostats-dev.my-cloud.ga/  
dbug: Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware[0]
      Wildcard detected, all requests with hosts will be allowed.
trce: Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware[0]
      All hosts are allowed.
dbug: Microsoft.AspNetCore.HttpOverrides.ForwardedHeadersMiddleware[1]
      Unknown proxy: 192.168.0.253:44840
warn: Microsoft.AspNetCore.HttpsPolicy.HttpsRedirectionMiddleware[3]
      Failed to determine the https port for redirect.
dbug: Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware[4]
      The request path / does not match a supported file type
dbug: Microsoft.AspNetCore.Routing.RouteBase[1]
      Request successfully matched the route with name 'Default' and template '{controller=V1}/{action=Index}/{id?}'.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Route matched with {action = "Index", controller = "V1"}. Executing action Silkroad.Analytics.WebV1.Controllers.V1Controller.Index (Silkroad.Analytics.WebV1)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of authorization filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of resource filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of action filters (in the following order): Microsoft.AspNetCore.Mvc.Internal.ControllerActionFilter (Order: -2147483648), Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of exception filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of result filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecutionAsync on filter Microsoft.AspNetCore.Mvc.Internal.ControllerActionFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Executing action method Silkroad.Analytics.WebV1.Controllers.V1Controller.Index (Silkroad.Analytics.WebV1) - Validation state: Valid
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action method Silkroad.Analytics.WebV1.Controllers.V1Controller.Index (Silkroad.Analytics.WebV1), returned result Microsoft.AspNetCore.Mvc.ViewResult in 4.0961ms.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecutionAsync on filter Microsoft.AspNetCore.Mvc.Internal.ControllerActionFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[4]
      Before executing action result Microsoft.AspNetCore.Mvc.ViewResult.
dbug: Microsoft.AspNetCore.Mvc.Razor.RazorViewEngine[1]
      View lookup cache miss for view 'Index' in controller 'V1'.
dbug: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[3]
      Initializing Razor view compiler with compiled view: '/Views/Shared/_Template.cshtml'.
dbug: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[3]
      Initializing Razor view compiler with compiled view: '/Views/V1/Error.cshtml'.
dbug: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[3]
      Initializing Razor view compiler with compiled view: '/Views/V1/Index.cshtml'.
dbug: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[3]
      Initializing Razor view compiler with compiled view: '/Views/_ViewImports.cshtml'.
dbug: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[3]
      Initializing Razor view compiler with compiled view: '/Views/_ViewStart.cshtml'.
trce: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[5]
      Located compiled view for view at path '/Views/V1/Index.cshtml'.
trce: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[7]
      Could not find a file for view at path '/Views/V1/_ViewStart.cshtml'.
trce: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[5]
      Located compiled view for view at path '/Views/_ViewStart.cshtml'.
trce: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[7]
      Could not find a file for view at path '/_ViewStart.cshtml'.
dbug: Microsoft.AspNetCore.Mvc.Razor.RazorViewEngine[3]
      Using precompiled view for '/Views/V1/Index.cshtml'.
info: Microsoft.AspNetCore.Mvc.ViewFeatures.ViewResultExecutor[1]
      Executing ViewResult, running view Index.
dbug: Microsoft.AspNetCore.Mvc.ViewFeatures.ViewResultExecutor[2]
      The view path '/Views/V1/Index.cshtml' was found in 46.2315ms.
trce: Microsoft.AspNetCore.Mvc.Razor.Internal.RazorViewCompiler[5]
      Located compiled view for view at path '/Views/Shared/_Template.cshtml'.
dbug: Microsoft.AspNetCore.Mvc.Razor.RazorViewEngine[3]
      Using precompiled view for '~/Views/Shared/_Template.cshtml'.
info: Microsoft.AspNetCore.Mvc.ViewFeatures.ViewResultExecutor[4]
      Executed ViewResult - view Index executed in 262.2519ms.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[5]
      After executing action result Microsoft.AspNetCore.Mvc.ViewResult.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action Silkroad.Analytics.WebV1.Controllers.V1Controller.Index (Silkroad.Analytics.WebV1) in 347.6741ms
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 777.4995ms 200 text/html; charset=utf-8
dbug: Microsoft.AspNetCore.Server.Kestrel[10]
      Connection id "0HLGRD7EOQ76P" disconnecting.
dbug: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[7]
      Connection id "0HLGRD7EOQ76P" sending FIN.
dbug: Microsoft.AspNetCore.Server.Kestrel[2]
      Connection id "0HLGRD7EOQ76P" stopped.
dbug: Microsoft.AspNetCore.Server.Kestrel[1]
      Connection id "0HLGRD7EOQ76Q" started.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
      Request starting HTTP/1.0 GET http://srostats-dev.my-cloud.ga/api/Providers  
trce: Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware[0]
      All hosts are allowed.
dbug: Microsoft.AspNetCore.HttpOverrides.ForwardedHeadersMiddleware[1]
      Unknown proxy: 192.168.0.253:44842
dbug: Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware[4]
      The request path /api/Providers does not match a supported file type
dbug: Microsoft.AspNetCore.Routing.Tree.TreeRouter[1]
      Request successfully matched the route with name '(null)' and template 'Api/Providers'.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Route matched with {action = "Providers", controller = "Api"}. Executing action Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of authorization filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of resource filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of action filters (in the following order): Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of exception filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of result filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter, Microsoft.AspNetCore.Mvc.ProducesAttribute (Order: 0)
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Executing action method Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1) - Validation state: Valid
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action method Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1), returned result Microsoft.AspNetCore.Mvc.ObjectResult in 540.2207ms.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[4]
      Before executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[11]
      List of registered output formatters, in the following order: Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[4]
      No information found on request to perform content negotiation.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[9]
      Attempting to select the first output formatter in the output formatters list which supports a content type from the explicitly specified content types 'application/json'.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[2]
      Selected output formatter 'Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter' and content type 'application/json' to write the response.
info: Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor[1]
      Executing ObjectResult, writing value of type 'System.Linq.Enumerable+SelectListIterator`2[[SilkroadData.Model.Provider, SilkroadData, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null],[Silkroad.Analytics.WebV1.Controllers.Provider, Silkroad.Analytics.WebV1, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]'.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[5]
      After executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action Silkroad.Analytics.WebV1.Controllers.ApiController.Providers (Silkroad.Analytics.WebV1) in 727.6069ms
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 744.4898ms 200 application/json; charset=utf-8
dbug: Microsoft.AspNetCore.Server.Kestrel[10]
      Connection id "0HLGRD7EOQ76Q" disconnecting.
dbug: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[7]
      Connection id "0HLGRD7EOQ76Q" sending FIN.
dbug: Microsoft.AspNetCore.Server.Kestrel[2]
      Connection id "0HLGRD7EOQ76Q" stopped.
dbug: Microsoft.AspNetCore.Server.Kestrel[1]
      Connection id "0HLGRD7EOQ76R" started.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
      Request starting HTTP/1.0 GET http://srostats-dev.my-cloud.ga/api/Provider/1/ServerList  
trce: Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware[0]
      All hosts are allowed.
dbug: Microsoft.AspNetCore.HttpOverrides.ForwardedHeadersMiddleware[1]
      Unknown proxy: 192.168.0.253:44846
dbug: Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware[4]
      The request path /api/Provider/1/ServerList does not match a supported file type
dbug: Microsoft.AspNetCore.Routing.Tree.TreeRouter[1]
      Request successfully matched the route with name '(null)' and template 'Api/Provider/{id}/ServerList'.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Route matched with {action = "ServerList", controller = "Api"}. Executing action Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of authorization filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of resource filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of action filters (in the following order): Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of exception filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of result filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter, Microsoft.AspNetCore.Mvc.ProducesAttribute (Order: 0)
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[22]
      Attempting to bind parameter 'id' of type 'System.Int32' ...
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.Binders.SimpleTypeModelBinder[44]
      Attempting to bind parameter 'id' of type 'System.Int32' using the name 'id' in request data ...
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.Binders.SimpleTypeModelBinder[45]
      Done attempting to bind parameter 'id' of type 'System.Int32'.
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[23]
      Done attempting to bind parameter 'id' of type 'System.Int32'.
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[26]
      Attempting to validate the bound parameter 'id' of type 'System.Int32' ...
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[27]
      Done attempting to validate the bound parameter 'id' of type 'System.Int32'.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Executing action method Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1) with arguments (1) - Validation state: Valid
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action method Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1), returned result Microsoft.AspNetCore.Mvc.ObjectResult in 26.5609ms.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[4]
      Before executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[11]
      List of registered output formatters, in the following order: Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[4]
      No information found on request to perform content negotiation.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[9]
      Attempting to select the first output formatter in the output formatters list which supports a content type from the explicitly specified content types 'application/json'.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[2]
      Selected output formatter 'Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter' and content type 'application/json' to write the response.
info: Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor[1]
      Executing ObjectResult, writing value of type 'System.Linq.Enumerable+SelectListIterator`2[[SilkroadData.Model.ServerList, SilkroadData, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null],[Silkroad.Analytics.WebV1.Controllers.ServerList, Silkroad.Analytics.WebV1, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]'.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[5]
      After executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1) in 98.4009ms
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 131.6773ms 200 application/json; charset=utf-8
dbug: Microsoft.AspNetCore.Server.Kestrel[10]
      Connection id "0HLGRD7EOQ76R" disconnecting.
dbug: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[7]
      Connection id "0HLGRD7EOQ76R" sending FIN.
dbug: Microsoft.AspNetCore.Server.Kestrel[2]
      Connection id "0HLGRD7EOQ76R" stopped.
dbug: Microsoft.AspNetCore.Server.Kestrel[1]
      Connection id "0HLGRD7EOQ76S" started.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
      Request starting HTTP/1.0 GET http://srostats-dev.my-cloud.ga/api/Provider/1/ServerList  
trce: Microsoft.AspNetCore.HostFiltering.HostFilteringMiddleware[0]
      All hosts are allowed.
dbug: Microsoft.AspNetCore.HttpOverrides.ForwardedHeadersMiddleware[1]
      Unknown proxy: 192.168.0.253:44848
dbug: Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware[4]
      The request path /api/Provider/1/ServerList does not match a supported file type
dbug: Microsoft.AspNetCore.Routing.Tree.TreeRouter[1]
      Request successfully matched the route with name '(null)' and template 'Api/Provider/{id}/ServerList'.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Route matched with {action = "ServerList", controller = "Api"}. Executing action Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of authorization filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of resource filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of action filters (in the following order): Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of exception filters (in the following order): None
dbug: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Execution plan of result filters (in the following order): Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter, Microsoft.AspNetCore.Mvc.ProducesAttribute (Order: 0)
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[22]
      Attempting to bind parameter 'id' of type 'System.Int32' ...
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.Binders.SimpleTypeModelBinder[44]
      Attempting to bind parameter 'id' of type 'System.Int32' using the name 'id' in request data ...
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.Binders.SimpleTypeModelBinder[45]
      Done attempting to bind parameter 'id' of type 'System.Int32'.
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[23]
      Done attempting to bind parameter 'id' of type 'System.Int32'.
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[26]
      Attempting to validate the bound parameter 'id' of type 'System.Int32' ...
dbug: Microsoft.AspNetCore.Mvc.ModelBinding.ParameterBinder[27]
      Done attempting to validate the bound parameter 'id' of type 'System.Int32'.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuting on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Executing action method Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1) with arguments (1) - Validation state: Valid
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action method Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1), returned result Microsoft.AspNetCore.Mvc.ObjectResult in 3.6177ms.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Action Filter: Before executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Action Filter: After executing OnActionExecuted on filter Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuting on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[4]
      Before executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[11]
      List of registered output formatters, in the following order: Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter, Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[4]
      No information found on request to perform content negotiation.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[9]
      Attempting to select the first output formatter in the output formatters list which supports a content type from the explicitly specified content types 'application/json'.
dbug: Microsoft.AspNetCore.Mvc.Infrastructure.DefaultOutputFormatterSelector[2]
      Selected output formatter 'Microsoft.AspNetCore.Mvc.Formatters.JsonOutputFormatter' and content type 'application/json' to write the response.
info: Microsoft.AspNetCore.Mvc.Infrastructure.ObjectResultExecutor[1]
      Executing ObjectResult, writing value of type 'System.Linq.Enumerable+SelectListIterator`2[[SilkroadData.Model.ServerList, SilkroadData, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null],[Silkroad.Analytics.WebV1.Controllers.ServerList, Silkroad.Analytics.WebV1, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]'.
dbug: Microsoft.AspNetCore.Server.Kestrel.Transport.Sockets[7]
      Connection id "0HLGRD7EOQ76S" sending FIN.
dbug: Microsoft.AspNetCore.Server.Kestrel[10]
      Connection id "0HLGRD7EOQ76S" disconnecting.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[5]
      After executing action result Microsoft.AspNetCore.Mvc.ObjectResult.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ProducesAttribute.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Result Filter: Before executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Result Filter: After executing OnResultExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Resource Filter: Before executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
trce: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[3]
      Resource Filter: After executing OnResourceExecuted on filter Microsoft.AspNetCore.Mvc.ViewFeatures.Internal.SaveTempDataFilter.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
      Executed action Silkroad.Analytics.WebV1.Controllers.ApiController.ServerList (Silkroad.Analytics.WebV1) in 12.4859ms
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
      Request finished in 20.4222ms 200 application/json; charset=utf-8
dbug: Microsoft.AspNetCore.Server.Kestrel[2]
      Connection id "0HLGRD7EOQ76S" stopped.

@halter73
Copy link
Member

@bencoskater So you're still seeing 502s with the 2.2.0-preview2 packages? The logs look perfectly normal.

If you are still seeing 502s, you might try adding our connection logging middleware which will log every byte of each request and response. If that's too verbose, you could try adding middleware like the following to at least make sure nginx is using http1.1 and/or is setting the "Connection: keep-alive" header as configured.

    public class Startup
    {
        public void Configure(IApplicationBuilder app, ILoggerFactory loggerFactory)
        {
            var logger = loggerFactory.CreateLogger("MyApp");

            app.Use(next =>
            {
                return context =>
                {
                    logger.LogDebug("Http Version: {HttpVersion}, Connection: {KeepAliveValue}",
                        context.Request.Protocol, context.Request.Headers["Connection"]);

                    return next(context);
                };
            });

            // ...

It might also help to add timestamps to the log to see if Kestrel is closing the connection due to a keep-alive timeout. You can either use a third-party logging provider like serilog for this or you can decorate the default console logger.

@bencoskater
Copy link
Author

Hi @halter73,

I will do that when I have time this week otherwise it will be this week-end.

Thanks

@chaseaucoin
Copy link

Hello, I am also having problems connecting to my sit via dotnetcore on ubuntu via cloudflare. If I go to the IP or if I use a vanilla domain and point it to the IP I have no issue but Cloudflare shows 502 Errors.

@guardrex
Copy link
Collaborator

Closing for lack of on-going discussion. Thus far, I don't have anything actionable for a doc update. We may have something later ... we can re-open this if there's more to discuss that leads to a doc enhancement opportunity.

@guardrex guardrex removed their assignment Oct 17, 2018
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Source - Docs.ms Docs Customer feedback via GitHub Issue
Projects
None yet
Development

No branches or pull requests

6 participants