3

We're hosting an ASP.Net MVC web app on Windows Server 2012, which runs over HTTPS. Most of the time everything is nice and fast, but we've noticed that about 1 in 50 requests for static files (e.g. images, javascript) are taking a few seconds seconds to complete. Some dynamic pages are also taking a while to complete too, but sometimes this is expected (e.g. performing a complex database query) although not always.

We've set up Failed Request Tracing on the website in IIS 8, and have set up a rule to log anything that takes over 2 seconds. We're getting about one log file generated per minute, and there is no pattern that I can identify – it's not like it's always the same static file for example.

In the example below, the request for a 20kb PNG image took 2,215 msec to complete. My understanding is that this isn't dependent on the user's connection speed and that this is just the time that the server took to process the request (please correct me if I'm wrong).

What I don't understand is why the Performance View just shows 0ms for each item. Similarly in the Compact View all the times are exactly the same. This means that it's not possible to see which part of the request is slowing things down. My assumption would be that the sum of all the figures in the Performance View would add up to the Time taken figure. Is there a reason I'm missing for why this might not be the case?

Just in case it's relevant, this is an Amazon EC2 instance with the image files stored on an SSD backed EBS volume. The CPU load on the server is at a steady 10-20%.

Screenshot 1 Screenshot 2

0

I would bet those are requests from mobile devices, Perf View from FRT isn't showing anything because these requests get stuck on IIS sending the bytes, not in any of those modules/events listed in FRT.

See if you can catch one of those in "Current Requests" view in IIS, msdn docs, or alternatively look in the IIS logs, get a bunch of those slow request and who.is several IPs. Odds are they're from mobile providers.

  • Thanks, I think you are correct. I find it a bit odd that the "Time taken" doesn't add up to the total of all the module durations, but after looking into this further it does just seem that the difference is the time for the data to be sent down the pipe. – philwilks Feb 23 '15 at 13:47
0

It's an asp/c# app? You can check in C:\Windows\System32\Logfiles\HTTPERR for IIS errors, and in w3c logs for timing.

  • The HTTPERR log files show lots of Timer_ConnectionIdle events (which is normal) and nothing else. I don't have W3C logging enabled at the moment but will switch than on for a couple of hours and see if I can get anything useful from it. – philwilks Jan 21 '15 at 14:13

Your Answer

By clicking “Post Your Answer”, you agree to our terms of service, privacy policy and cookie policy

Not the answer you're looking for? Browse other questions tagged or ask your own question.