Ever wondered if some of your app's latency is coming from myserious middleware? Want to be able to tie requests to specific workers and threads while you're at it? Add this gem to a Rails app to get a log line like this for each request:
at=info thread_id=70351652783840 process_id=55394 request_id=013f9cc29c1e4c483435dbc15ab260f4 measure#pre_request=0ms measure#rack_in=202ms measure#app=505ms measure#rack_out=301ms
That includes:
thread_id
: For tracking requests across threads, (e.g. Puma)process_id
: For tracking requests across workers (e.g. Puma or Unicorn)request_id
: Correlate with your app (or Heroku router) logspre_request
: Measure the time between HTTP_X_REQUEST_START
and the start of your rack stack (similar to New Relic's 'reuqest queueing' metric)rack_in
: The time in the rack stack before your app sees the requestapp
: The time spent processing the request in your apprack_out
: The time spent going back out of the rack stackAdd this line to your application's Gemfile:
gem 'rack-timing'
And then execute:
$ bundle
git checkout -b my-new-feature
)git commit -am 'Add some feature'
)git push origin my-new-feature
)