2017-10-17 21:10:12 -04:00
|
|
|
# frozen_string_literal: true
|
|
|
|
|
2015-02-05 00:08:52 -05:00
|
|
|
require_dependency 'middleware/anonymous_cache'
|
|
|
|
|
|
|
|
class Middleware::RequestTracker
|
|
|
|
|
2017-10-17 21:10:12 -04:00
|
|
|
@@detailed_request_loggers = nil
|
|
|
|
|
|
|
|
# register callbacks for detailed request loggers called on every request
|
|
|
|
# example:
|
|
|
|
#
|
|
|
|
# Middleware::RequestTracker.detailed_request_logger(->|env, data| do
|
|
|
|
# # do stuff with env and data
|
|
|
|
# end
|
|
|
|
def self.register_detailed_request_logger(callback)
|
|
|
|
|
|
|
|
unless @patched_instrumentation
|
|
|
|
require_dependency "method_profiler"
|
|
|
|
MethodProfiler.patch(PG::Connection, [
|
|
|
|
:exec, :async_exec, :exec_prepared, :send_query_prepared, :query
|
|
|
|
], :sql)
|
|
|
|
|
|
|
|
MethodProfiler.patch(Redis::Client, [
|
|
|
|
:call, :call_pipeline
|
|
|
|
], :redis)
|
|
|
|
@patched_instrumentation = true
|
|
|
|
end
|
|
|
|
|
|
|
|
(@@detailed_request_loggers ||= []) << callback
|
|
|
|
end
|
|
|
|
|
|
|
|
def self.unregister_detailed_request_logger(callback)
|
|
|
|
@@detailed_request_loggers.delete callback
|
|
|
|
|
|
|
|
if @@detailed_request_loggers.length == 0
|
|
|
|
@detailed_request_loggers = nil
|
|
|
|
end
|
|
|
|
|
|
|
|
end
|
|
|
|
|
2017-07-27 21:20:09 -04:00
|
|
|
def initialize(app, settings = {})
|
2015-02-05 00:08:52 -05:00
|
|
|
@app = app
|
|
|
|
end
|
|
|
|
|
2017-07-27 21:20:09 -04:00
|
|
|
def self.log_request_on_site(data, host)
|
2015-02-05 00:08:52 -05:00
|
|
|
RailsMultisite::ConnectionManagement.with_hostname(host) do
|
2015-02-10 01:03:33 -05:00
|
|
|
log_request(data)
|
2015-02-05 00:08:52 -05:00
|
|
|
end
|
|
|
|
end
|
|
|
|
|
2015-02-10 01:03:33 -05:00
|
|
|
def self.log_request(data)
|
|
|
|
status = data[:status]
|
|
|
|
track_view = data[:track_view]
|
2015-02-05 00:08:52 -05:00
|
|
|
|
2015-02-10 01:03:33 -05:00
|
|
|
if track_view
|
|
|
|
if data[:is_crawler]
|
2015-02-05 22:39:04 -05:00
|
|
|
ApplicationRequest.increment!(:page_view_crawler)
|
2015-02-10 01:03:33 -05:00
|
|
|
elsif data[:has_auth_cookie]
|
2015-02-05 22:39:04 -05:00
|
|
|
ApplicationRequest.increment!(:page_view_logged_in)
|
2015-07-03 17:02:57 -04:00
|
|
|
ApplicationRequest.increment!(:page_view_logged_in_mobile) if data[:is_mobile]
|
2015-02-05 00:08:52 -05:00
|
|
|
else
|
2015-02-05 22:39:04 -05:00
|
|
|
ApplicationRequest.increment!(:page_view_anon)
|
2015-07-03 17:02:57 -04:00
|
|
|
ApplicationRequest.increment!(:page_view_anon_mobile) if data[:is_mobile]
|
2015-02-05 22:39:04 -05:00
|
|
|
end
|
|
|
|
end
|
|
|
|
|
|
|
|
ApplicationRequest.increment!(:http_total)
|
|
|
|
|
|
|
|
if status >= 500
|
|
|
|
ApplicationRequest.increment!(:http_5xx)
|
2015-02-11 17:47:32 -05:00
|
|
|
elsif data[:is_background]
|
|
|
|
ApplicationRequest.increment!(:http_background)
|
2015-02-05 22:39:04 -05:00
|
|
|
elsif status >= 400
|
|
|
|
ApplicationRequest.increment!(:http_4xx)
|
|
|
|
elsif status >= 300
|
|
|
|
ApplicationRequest.increment!(:http_3xx)
|
2015-02-11 17:47:32 -05:00
|
|
|
elsif status >= 200 && status < 300
|
|
|
|
ApplicationRequest.increment!(:http_2xx)
|
2015-02-05 00:08:52 -05:00
|
|
|
end
|
|
|
|
|
|
|
|
end
|
|
|
|
|
2017-10-17 21:10:12 -04:00
|
|
|
def self.get_data(env, result, timing)
|
2017-07-27 21:20:09 -04:00
|
|
|
status, headers = result
|
2015-02-10 01:03:33 -05:00
|
|
|
status = status.to_i
|
|
|
|
|
|
|
|
helper = Middleware::AnonymousCache::Helper.new(env)
|
|
|
|
request = Rack::Request.new(env)
|
2015-02-25 19:40:57 -05:00
|
|
|
|
2017-10-17 21:10:12 -04:00
|
|
|
env_track_view = env["HTTP_DISCOURSE_TRACK_VIEW"]
|
2015-02-25 19:40:57 -05:00
|
|
|
track_view = status == 200
|
2017-10-17 21:10:12 -04:00
|
|
|
track_view &&= env_track_view != "0" && env_track_view != "false"
|
|
|
|
track_view &&= env_track_view || (request.get? && !request.xhr? && headers["Content-Type"] =~ /text\/html/)
|
2015-09-16 21:06:21 -04:00
|
|
|
track_view = !!track_view
|
2015-02-25 19:40:57 -05:00
|
|
|
|
2015-02-10 01:03:33 -05:00
|
|
|
{
|
|
|
|
status: status,
|
|
|
|
is_crawler: helper.is_crawler?,
|
|
|
|
has_auth_cookie: helper.has_auth_cookie?,
|
|
|
|
is_background: request.path =~ /^\/message-bus\// || request.path == /\/topics\/timings/,
|
2015-07-03 17:02:57 -04:00
|
|
|
is_mobile: helper.is_mobile?,
|
2017-10-17 21:10:12 -04:00
|
|
|
track_view: track_view,
|
|
|
|
timing: timing
|
2015-02-10 01:03:33 -05:00
|
|
|
}
|
2017-10-17 21:10:12 -04:00
|
|
|
|
2015-02-10 01:03:33 -05:00
|
|
|
end
|
2015-02-05 00:08:52 -05:00
|
|
|
|
2017-11-28 00:47:20 -05:00
|
|
|
def log_request_info(env, result, info)
|
2015-02-10 01:03:33 -05:00
|
|
|
|
|
|
|
# we got to skip this on error ... its just logging
|
2017-10-17 21:10:12 -04:00
|
|
|
data = self.class.get_data(env, result, info) rescue nil
|
2015-02-10 01:05:24 -05:00
|
|
|
host = RailsMultisite::ConnectionManagement.host(env)
|
2015-02-10 01:03:33 -05:00
|
|
|
|
|
|
|
if data
|
2017-07-27 21:20:09 -04:00
|
|
|
if result && (headers = result[1])
|
2016-10-27 03:08:01 -04:00
|
|
|
headers["X-Discourse-TrackView"] = "1" if data[:track_view]
|
2016-10-27 01:50:56 -04:00
|
|
|
end
|
2017-10-17 21:10:12 -04:00
|
|
|
|
|
|
|
if @@detailed_request_loggers
|
|
|
|
@@detailed_request_loggers.each { |logger| logger.call(env, data) }
|
|
|
|
end
|
|
|
|
|
2017-07-27 21:20:09 -04:00
|
|
|
log_later(data, host)
|
2015-02-05 00:08:52 -05:00
|
|
|
end
|
2015-02-10 01:03:33 -05:00
|
|
|
|
2015-02-05 00:08:52 -05:00
|
|
|
end
|
|
|
|
|
2017-11-28 00:47:20 -05:00
|
|
|
def call(env)
|
|
|
|
env["discourse.request_tracker"] = self
|
|
|
|
MethodProfiler.start if @@detailed_request_loggers
|
|
|
|
result = @app.call(env)
|
|
|
|
info = MethodProfiler.stop if @@detailed_request_loggers
|
|
|
|
result
|
|
|
|
ensure
|
|
|
|
log_request_info(env, result, info) unless env["discourse.request_tracker.skip"]
|
|
|
|
end
|
|
|
|
|
2017-07-27 21:20:09 -04:00
|
|
|
def log_later(data, host)
|
|
|
|
Scheduler::Defer.later("Track view", _db = nil) do
|
|
|
|
self.class.log_request_on_site(data, host)
|
2015-09-16 21:06:21 -04:00
|
|
|
end
|
|
|
|
end
|
|
|
|
|
2015-02-05 00:08:52 -05:00
|
|
|
end
|