aboutsummaryrefslogtreecommitdiffstats
path: root/activejob/test/cases/logging_test.rb
diff options
context:
space:
mode:
authorCory Gwin @gwincr11 <gwincr11@github.com>2019-02-12 12:49:12 -0500
committerRafael Mendonça França <rafaelmfranca@gmail.com>2019-02-13 19:20:41 -0500
commit31021c780f346002beabff3fa2e4869556e32c3c (patch)
treed7767e8f7269419b5f13c8666d8e0de4863abdc1 /activejob/test/cases/logging_test.rb
parent840f55567191c96bdf4250a339759dbb532d351e (diff)
downloadrails-31021c780f346002beabff3fa2e4869556e32c3c.tar.gz
rails-31021c780f346002beabff3fa2e4869556e32c3c.tar.bz2
rails-31021c780f346002beabff3fa2e4869556e32c3c.zip
Adding enque time tracking and logging
Motivation: - Currently we have 2 seperate monkey patches in place for tracking enqueded time for 2 seperate workers. It seems that activejob could be a source of truth for how long an item has been enqued so that we can easily use it for consistent monitoring across workers/apps to ensure that jobs are running at an acceptable speed. Changes: - Add an enqueded at attribute and serilization tooling. - Add a method to get how long a job has been enqueded for. - Add a logging item to show how long a job was enqued prior to the perform method firing.
Diffstat (limited to 'activejob/test/cases/logging_test.rb')
-rw-r--r--activejob/test/cases/logging_test.rb2
1 files changed, 2 insertions, 0 deletions
diff --git a/activejob/test/cases/logging_test.rb b/activejob/test/cases/logging_test.rb
index 6154ba301d..acd37456c9 100644
--- a/activejob/test/cases/logging_test.rb
+++ b/activejob/test/cases/logging_test.rb
@@ -115,6 +115,8 @@ class LoggingTest < ActiveSupport::TestCase
perform_enqueued_jobs do
LoggingJob.perform_later "Dummy"
assert_match(/Performing LoggingJob \(Job ID: .*?\) from .*? with arguments:.*Dummy/, @logger.messages)
+
+ assert_match(/enqueued at /, @logger.messages)
assert_match(/Dummy, here is it: Dummy/, @logger.messages)
assert_match(/Performed LoggingJob \(Job ID: .*?\) from .*? in .*ms/, @logger.messages)
end