The following two log entries appeared next to one another. The whole page usually loads in under 3 seconds. There is 1 resident instance. The first network request sent by the page is the first log entry. It was not served by the resident instance. There were no dynamic instances at the time of the request. The minimum pending latency of the app is set to 14.9s (the largest possible value). This is an attempt to tell the scheduler to leave me alone. Two instances started for a page that did not need them. The resident instance did nothing. It served zero requests from this page load. One of the startups was done via a user facing request which caused the page to stall and take over 15 seconds to load. The scheduler might be optimized to serve high traffic sites, but I can guarantee I will never get to a high amount of traffic my users have to put up with 15 second page loads. -------------------------------------------------------------------------------- --------------------------------------------------------------------
1. 2. 2012-09-01 09:36:59.435 /members/sphere/show/527001 200 13821ms 10kb Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.1 (KHTML, like Gecko) Chrome/21.0.1180.79 Safari/537.1 3. 50.131.165.108 - - [01/Sep/2012:09:36:59 -0700] "GET /members/sphere/show/527001 HTTP/1.1" 200 10518 "http://lemurspot.appspot.com/members/sphere/list/Public"; "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.1 (KHTML, like Gecko) Chrome/21.0.1180.79 Safari/537.1" "lemurspot.appspot.com" ms=13822 cpu_ms=10594 cpm_usd=0.001175 loading_request=1 instance=00c61b117c2fce802ccb47a4e712b784e3f54e 4. I 2012-09-01 09:36:53.878 5. [s~lemurspot/3.361443701203144598].<stdout>: Loading core functions for production environment 6. 7. I 2012-09-01 09:36:59.434 8. This request caused a new process to be started for your application, and thus caused your application code to be loaded for the first time. This request may thus take longer and use more CPU than a typical request for your application. 9. -------------------------------------------------------------------------------- -------------------------------------------------------------------- 10. 11. 2012-09-01 09:36:50.272 /_ah/warmup 404 13273ms 0kb 12. 0.1.0.3 - - [01/Sep/2012:09:36:50 -0700] "GET /_ah/warmup HTTP/1.1" 404 205 - - "3.361443701203144598.lemurspot.appspot.com" ms=13273 cpu_ms=9662 cpm_usd=0.000023 loading_request=1 instance=00c61b117c0d042247ec72de95d943c6c2be81 13. I 2012-09-01 09:36:45.776 14. [s~lemurspot/3.361443701203144598].<stdout>: Loading core functions for production environment 15. 16. | 2012-09-01 09:36:49.678 17. [s~lemurspot/3.361443701203144598].<stdout>: Sep 01, 2012 16:36:49 Warmup request recieved 18. 19. I 2012-09-01 09:36:50.271 20. This request caused a new process to be started for your application, and thus caused your application code to be loaded for the first time. This request may thus take longer and use more CPU than a typical request for your application. 21. -------------------------------------------------------------------------------- -------------------------------------------------------------------- -- You received this message because you are subscribed to the Google Groups "Google App Engine" group. To view this discussion on the web visit https://groups.google.com/d/msg/google-appengine/-/1IIkkk-FSFoJ. To post to this group, send email to [email protected]. To unsubscribe from this group, send email to [email protected]. For more options, visit this group at http://groups.google.com/group/google-appengine?hl=en.
