At the moment we only log that information from nginx's perspective, and there can be a lot of unaccounted time. It could be in nginx request queueing, or in tornado's (thumbor).
Description
Details
Revisions and Commits
rTHMBREXT Thumbor Plugins | |||
rTHMBREXT3d0030df230f Version bump | |||
Restricted Differential Revision | rTHMBREXTdb19799d17f2 Record time when thumbor receives the request |
Status | Subtype | Assigned | Task | ||
---|---|---|---|---|---|
Resolved | • Gilles | T185466 Review Varnish slow log for upload.wikimedia.org | |||
Resolved | • Gilles | T186594 Log time when request makes it to Thumbor |
Event Timeline
Change 409314 had a related patch set uploaded (by Gilles; owner: Gilles):
[operations/debs/python-thumbor-wikimedia@master] Upgrade to 1.12
Change 409315 had a related patch set uploaded (by Gilles; owner: Gilles):
[mediawiki/vagrant@master] Add Thumbor-Request-Date to Swift header whitelist
Change 409315 merged by jenkins-bot:
[mediawiki/vagrant@master] Add Thumbor-Request-Date to Swift header whitelist
Change 409314 merged by Filippo Giunchedi:
[operations/debs/python-thumbor-wikimedia@master] Upgrade to 1.12
Mentioned in SAL (#wikimedia-operations) [2018-02-12T15:00:58Z] <godog> roll-upgrade thumbor to 1.12 - T186500 T186594 T186492
Show up in the Varnish slow log. Not exposed in thumbnail responses sent to the actual client, but I think that's ok. This was added to attempt to figure out some slow log mysteries.
Actually doesn't show up for 200s yet, but I think that's because the swift proxy filtering kicks in only in this case (which is interesting in itself - error responses aren't subject to the header filtering).
Change 409942 had a related patch set uploaded (by Gilles; owner: Gilles):
[operations/puppet@production] Whitelist new Thumbor-Request-Date header in Swift
Change 409942 merged by Filippo Giunchedi:
[operations/puppet@production] Whitelist new Thumbor-Request-Date header in Swift