Good call. Indeed, these requests are logging from 63,000 to 88,000 ms. So now, I guess the question is why lightweight pages are periodically timing out:)
On Tuesday, October 21, 2014 9:26:55 AM UTC-7, PK wrote: > > Check how close the request is to its deadline when you see this. In many > occasions, this is a side effect of your request exceeding its deadline. > The runtime probably tries to flush the logs first and that masks the real > condition. > > PK > > On Oct 21, 2014, at 9:22 AM, johnP <[email protected] <javascript:>> > wrote: > > Started getting these periodically. Couple times a day for a week. > Python 2.7. Looks like it's totally internal to Google, although who > knows. Maybe I'm triggering it somehow. Tried to wait for a week for it > to clear up on its own. No luck. > > > 1. > E2014-10-21 06:00:34.955 > > Traceback (most recent call last): > > 2. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/app_logging.py", > line 78, in emit > > 3. E2014-10-21 06:00:34.955 > > logservice.write(message) > > 4. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/logservice/logservice.py", > line 348, in write > > 5. E2014-10-21 06:00:34.955 > > logs_buffer().write(message) > > 6. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/logservice/logservice.py", > line 236, in write > > 7. E2014-10-21 06:00:34.955 > > return self._write(line) > > 8. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/logservice/logservice.py", > line 253, in _write > > 9. E2014-10-21 06:00:34.955 > > self._autoflush() > > 10. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/logservice/logservice.py", > line 322, in _autoflush > > 11. E2014-10-21 06:00:34.955 > > self._flush() > > 12. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/logservice/logservice.py", > line 305, in _flush > > 13. E2014-10-21 06:00:34.955 > > apiproxy_stub_map.MakeSyncCall('logservice', 'Flush', request, > response) > > 14. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/apiproxy_stub_map.py", > line 94, in MakeSyncCall > > 15. E2014-10-21 06:00:34.955 > > return stubmap.MakeSyncCall(service, call, request, response) > > 16. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/apiproxy_stub_map.py", > line 328, in MakeSyncCall > > 17. E2014-10-21 06:00:34.955 > > rpc.CheckSuccess() > > 18. E2014-10-21 06:00:34.955 > > File > "/base/data/home/runtimes/python27/python27_lib/versions/1/google/appengine/api/apiproxy_rpc.py", > line 133, in CheckSuccess > > 19. E2014-10-21 06:00:34.955 > > raise self.exception > > 20. E2014-10-21 06:00:34.955 > > CancelledError: The API call logservice.Flush() was explicitly cancelled. > > 21. E2014-10-21 06:00:34.955 > > Logged from file cgi.py, line 121 > > > -- > You received this message because you are subscribed to the Google Groups > "Google App Engine" group. > To unsubscribe from this group and stop receiving emails from it, send an > email to [email protected] <javascript:>. > To post to this group, send email to [email protected] > <javascript:>. > Visit this group at http://groups.google.com/group/google-appengine. > For more options, visit https://groups.google.com/d/optout. > > -- You received this message because you are subscribed to the Google Groups "Google App Engine" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. To post to this group, send email to [email protected]. Visit this group at http://groups.google.com/group/google-appengine. For more options, visit https://groups.google.com/d/optout.
