Skip to content

Instantly share code, notes, and snippets.

@zunda
Created July 9, 2022 07:44
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save zunda/9623ec92de7c40a046afafa58633cc43 to your computer and use it in GitHub Desktop.
Save zunda/9623ec92de7c40a046afafa58633cc43 to your computer and use it in GitHub Desktop.
Sidekiqを6.4.2から6.5.1に上げた時にruby-3.1.2のMastodonで見られる例外
2022-07-09T07:37:08.775204+00:00 app[web.1]:
pid=68 tid=2h4w class=ActivityPub::DeliveryWorker jid=a67bc00b58725d5a4f8d0c92 elapsed=5.05 INFO: fail
pid=68 tid=2h4w WARN: {"context":"Job raised exception","job":{"retry":16,"queue":"push","dead":false,"class":"ActivityPub::DeliveryWorker","args":["{\"@context\":[\"https://www.w3.org/ns/activitystreams\",{\"ostatus\":\"http://ostatus.org#\",\"atomUri\":\"ostatus:atomUri\",\"inReplyToAtomUri\":\"ostatus:inReplyToAtomUri\",\"conversation\":\"ostatus:conversation\",\"sensitive\":\"as:sensitive\",\"toot\":\"http://joinmastodon.org/ns#\",\"votersCount\":\"toot:votersCount\"}],\"id\":\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/activity\",\"type\":\"Create\",\"actor\":\"https://mastodon.zunda.ninja/users/zundan\",\"published\":\"2022-07-09T07:30:24Z\",\"to\":[\"https://www.w3.org/ns/activitystreams#Public\"],\"cc\":[\"https://mastodon.zunda.ninja/users/zundan/followers\"],\"object\":{\"id\":\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625\",\"type\":\"Note\",\"summary\":null,\"inReplyTo\":null,\"published\":\"2022-07-09T07:30:24Z\",\"url\":\"https://mastodon.zunda.ninja/@zundan/108616209186149625\",\"attributedTo\":\"https://mastodon.zunda.ninja/users/zundan\",\"to\":[\"https://www.w3.org/ns/activitystreams#Public\"],\"cc\":[\"https://mastodon.zunda.ninja/users/zundan/followers\"],\"sensitive\":false,\"atomUri\":\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625\",\"inReplyToAtomUri\":null,\"conversation\":\"tag:mastodon.zunda.ninja,2022-07-09:objectId=11464096:objectType=Conversation\",\"content\":\"\\u003cp\\u003eさてsidekiqの更新をデプロイしますねgkbr\\u003c/p\\u003e\",\"contentMap\":{\"ja\":\"\\u003cp\\u003eさてsidekiqの更新をデプロイしますねgkbr\\u003c/p\\u003e\"},\"attachment\":[],\"tag\":[],\"replies\":{\"id\":\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/replies\",\"type\":\"Collection\",\"first\":{\"type\":\"CollectionPage\",\"next\":\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/replies?only_other_accounts=true\\u0026page=true\",\"partOf\":\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/replies\",\"items\":[]}}},\"signature\":{\"type\":\"RsaSignature2017\",\"creator\":\"https://mastodon.zunda.ninja/users/zundan#main-key\",\"created\":\"2022-07-09T07:30:25Z\",\"signatureValue\":\"NX8ZYQPlS+YN4SdRnMJYQWE/XkZHxUTmrdPPi5STxwqXFgmDks0K/db83bdvq1F/jbYAxsFOebmYdhtFSQbbsxB3KEmTKpKmCWhNnYxop720W4BknxYaNSYbgpNXidycrW88dc59B3oPvhWw5EYDz81Ob6Rj+UjFclnIev15kXne4mBPw/g/vOHWprJVZ++fe7rfBM4SBWr9gjVbYVs6MgvwYUsWtSvZDnPZJ3ScefbtgR0VmATT9TgTFpgluScHqptzo/3myDuQeNdO4oOmK4Nb1YbBcWnSNdQUwVQe03syDGGffItcf8rA6/wDicI+492MOJa7y1wktuXf4SvYVg==\"}}",1,"https://example.com/inbox",{"synchronize_followers":false}],"jid":"a67bc00b58725d5a4f8d0c92","created_at":1657351825.1004186,"enqueued_at":1657351971.9895546,"error_message":"https://example.com/inbox","error_class":"Stoplight::Error::RedLight","failed_at":1657351826.3667152,"retry_count":2,"retried_at":1657351882.2130437},"jobstr":"{\"retry\":16,\"queue\":\"push\",\"dead\":false,\"class\":\"ActivityPub::DeliveryWorker\",\"args\":[\"{\\\"@context\\\":[\\\"https://www.w3.org/ns/activitystreams\\\",{\\\"ostatus\\\":\\\"http://ostatus.org#\\\",\\\"atomUri\\\":\\\"ostatus:atomUri\\\",\\\"inReplyToAtomUri\\\":\\\"ostatus:inReplyToAtomUri\\\",\\\"conversation\\\":\\\"ostatus:conversation\\\",\\\"sensitive\\\":\\\"as:sensitive\\\",\\\"toot\\\":\\\"http://joinmastodon.org/ns#\\\",\\\"votersCount\\\":\\\"toot:votersCount\\\"}],\\\"id\\\":\\\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/activity\\\",\\\"type\\\":\\\"Create\\\",\\\"actor\\\":\\\"https://mastodon.zunda.ninja/users/zundan\\\",\\\"published\\\":\\\"2022-07-09T07:30:24Z\\\",\\\"to\\\":[\\\"https://www.w3.org/ns/activitystreams#Public\\\"],\\\"cc\\\":[\\\"https://mastodon.zunda.ninja/users/zundan/followers\\\"],\\\"object\\\":{\\\"id\\\":\\\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625\\\",\\\"type\\\":\\\"Note\\\",\\\"summary\\\":null,\\\"inReplyTo\\\":null,\\\"published\\\":\\\"2022-07-09T07:30:24Z\\\",\\\"url\\\":\\\"https://mastodon.zunda.ninja/@zundan/108616209186149625\\\",\\\"attributedTo\\\":\\\"https://mastodon.zunda.ninja/users/zundan\\\",\\\"to\\\":[\\\"https://www.w3.org/ns/activitystreams#Public\\\"],\\\"cc\\\":[\\\"https://mastodon.zunda.ninja/users/zundan/followers\\\"],\\\"sensitive\\\":false,\\\"atomUri\\\":\\\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625\\\",\\\"inReplyToAtomUri\\\":null,\\\"conversation\\\":\\\"tag:mastodon.zunda.ninja,2022-07-09:objectId=11464096:objectType=Conversation\\\",\\\"content\\\":\\\"\\\\u003cp\\\\u003eさてsidekiqの更新をデプロイしますねgkbr\\\\u003c/p\\\\u003e\\\",\\\"contentMap\\\":{\\\"ja\\\":\\\"\\\\u003cp\\\\u003eさてsidekiqの更新をデプロイしますねgkbr\\\\u003c/p\\\\u003e\\\"},\\\"attachment\\\":[],\\\"tag\\\":[],\\\"replies\\\":{\\\"id\\\":\\\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/replies\\\",\\\"type\\\":\\\"Collection\\\",\\\"first\\\":{\\\"type\\\":\\\"CollectionPage\\\",\\\"next\\\":\\\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/replies?only_other_accounts=true\\\\u0026page=true\\\",\\\"partOf\\\":\\\"https://mastodon.zunda.ninja/users/zundan/statuses/108616209186149625/replies\\\",\\\"items\\\":[]}}},\\\"signature\\\":{\\\"type\\\":\\\"RsaSignature2017\\\",\\\"creator\\\":\\\"https://mastodon.zunda.ninja/users/zundan#main-key\\\",\\\"created\\\":\\\"2022-07-09T07:30:25Z\\\",\\\"signatureValue\\\":\\\"NX8ZYQPlS+YN4SdRnMJYQWE/XkZHxUTmrdPPi5STxwqXFgmDks0K/db83bdvq1F/jbYAxsFOebmYdhtFSQbbsxB3KEmTKpKmCWhNnYxop720W4BknxYaNSYbgpNXidycrW88dc59B3oPvhWw5EYDz81Ob6Rj+UjFclnIev15kXne4mBPw/g/vOHWprJVZ++fe7rfBM4SBWr9gjVbYVs6MgvwYUsWtSvZDnPZJ3ScefbtgR0VmATT9TgTFpgluScHqptzo/3myDuQeNdO4oOmK4Nb1YbBcWnSNdQUwVQe03syDGGffItcf8rA6/wDicI+492MOJa7y1wktuXf4SvYVg==\\\"}}\",1,\"https://example.com/inbox\",{\"synchronize_followers\":false}],\"jid\":\"a67bc00b58725d5a4f8d0c92\",\"created_at\":1657351825.1004186,\"enqueued_at\":1657351971.9895546,\"error_message\":\"https://example.com/inbox\",\"error_class\":\"Stoplight::Error::RedLight\",\"failed_at\":1657351826.3667152,\"retry_count\":2,\"retried_at\":1657351882.2130437}"}
pid=68 tid=2h4w WARN: HTTP::TimeoutError: Connect timed out after 5 seconds on https://example.com/inbox
pid=68 tid=2h4w WARN: /app/app/lib/request.rb:225:in `open'
pid=68 tid=2h4w WARN: {"context":"processor"}
pid=68 tid=2h4w WARN: NoMethodError: undefined method `call' for nil:NilClass
@callback.call(self, ex)
^^^^^
pid=68 tid=2h4w WARN: /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:73:in `rescue in run'
/app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:67:in `run'
/app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:8:in `watchdog'
/app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:17:in `block in safe_thread'
#<Thread:0x00007f434799d6d0@processor /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:15 run> terminated with exception (report_on_exception is true):
/app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:73:in `rescue in run': undefined method `call' for nil:NilClass (NoMethodError)
@callback.call(self, ex)
^^^^^
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:67:in `run'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:8:in `watchdog'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:17:in `block in safe_thread'
/app/app/lib/request.rb:225:in `open': Connect timed out after 5 seconds on https://example.com/inbox (HTTP::TimeoutError)
/app/app/lib/request.rb:225:in `open': Connect timed out after 5 seconds (HTTP::TimeoutError)
from /app/app/lib/request.rb:12:in `connect'
from /app/vendor/bundle/ruby/3.1.0/gems/http-5.1.0/lib/http/connection.rb:42:in `initialize'
from /app/vendor/bundle/ruby/3.1.0/gems/httplog-1.5.0/lib/httplog/adapters/http.rb:49:in `initialize'
from /app/vendor/bundle/ruby/3.1.0/gems/http-5.1.0/lib/http/client.rb:70:in `new'
from /app/vendor/bundle/ruby/3.1.0/gems/http-5.1.0/lib/http/client.rb:70:in `perform'
from /app/vendor/bundle/ruby/3.1.0/gems/httplog-1.5.0/lib/httplog/adapters/http.rb:12:in `block (2 levels) in <class:Client>'
from /app/vendor/ruby-3.1.2/lib/ruby/3.1.0/benchmark.rb:311:in `realtime'
from /app/vendor/bundle/ruby/3.1.0/gems/httplog-1.5.0/lib/httplog/adapters/http.rb:11:in `block in <class:Client>'
from /app/vendor/bundle/ruby/3.1.0/gems/http-5.1.0/lib/http/client.rb:31:in `request'
from /app/vendor/bundle/ruby/3.1.0/gems/http-5.1.0/lib/http/chainable.rb:27:in `post'
from /app/app/lib/request.rb:60:in `public_send'
from /app/app/lib/request.rb:60:in `perform'
from /app/app/workers/activitypub/delivery_worker.rb:55:in `block (2 levels) in perform_request'
from /app/app/lib/request_pool.rb:53:in `use'
from /app/app/lib/request_pool.rb:108:in `block (2 levels) in with'
from /app/vendor/bundle/ruby/3.1.0/gems/activesupport-6.1.6/lib/active_support/notifications.rb:205:in `instrument'
from /app/app/lib/request_pool.rb:107:in `block in with'
from /app/app/lib/connection_pool/shared_connection_pool.rb:21:in `block (2 levels) in with'
from /app/app/lib/connection_pool/shared_connection_pool.rb:20:in `handle_interrupt'
from /app/app/lib/connection_pool/shared_connection_pool.rb:20:in `block in with'
from /app/app/lib/connection_pool/shared_connection_pool.rb:16:in `handle_interrupt'
from /app/app/lib/connection_pool/shared_connection_pool.rb:16:in `with'
from /app/app/lib/request_pool.rb:106:in `with'
from /app/app/workers/activitypub/delivery_worker.rb:54:in `block in perform_request'
from /app/vendor/bundle/ruby/3.1.0/gems/stoplight-3.0.0/lib/stoplight/light/runnable.rb:52:in `run_code'
from /app/vendor/bundle/ruby/3.1.0/gems/stoplight-3.0.0/lib/stoplight/light/runnable.rb:42:in `run_yellow'
from /app/vendor/bundle/ruby/3.1.0/gems/stoplight-3.0.0/lib/stoplight/light/runnable.rb:24:in `run'
from /app/app/workers/activitypub/delivery_worker.rb:65:in `perform_request'
from /app/app/workers/activitypub/delivery_worker.rb:26:in `perform'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:196:in `execute_job'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:164:in `block (2 levels) in process'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/middleware/chain.rb:144:in `block in invoke'
from /app/vendor/bundle/ruby/3.1.0/gems/nsa-0.2.8/lib/nsa/collectors/sidekiq.rb:31:in `block in call'
from /app/vendor/bundle/ruby/3.1.0/gems/nsa-0.2.8/lib/nsa/statsd/publisher.rb:27:in `statsd_time'
from /app/vendor/bundle/ruby/3.1.0/gems/nsa-0.2.8/lib/nsa/collectors/sidekiq.rb:30:in `call'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/middleware/chain.rb:146:in `block in invoke'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-unique-jobs-7.1.25/lib/sidekiq_unique_jobs/middleware.rb:36:in `call'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/middleware/chain.rb:146:in `block in invoke'
from /app/lib/mastodon/sidekiq_middleware.rb:7:in `call'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/middleware/chain.rb:146:in `block in invoke'
from /app/vendor/bundle/ruby/3.1.0/gems/scout_apm-4.1.2/lib/scout_apm/background_job_integrations/sidekiq.rb:68:in `call'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/middleware/chain.rb:146:in `block in invoke'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/middleware/chain.rb:149:in `invoke'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:163:in `block in process'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:136:in `block (6 levels) in dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/job_retry.rb:115:in `local'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:135:in `block (5 levels) in dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/rails.rb:14:in `block in call'
from /app/vendor/bundle/ruby/3.1.0/gems/activesupport-6.1.6/lib/active_support/execution_wrapper.rb:91:in `wrap'
from /app/vendor/bundle/ruby/3.1.0/gems/activesupport-6.1.6/lib/active_support/reloader.rb:72:in `block in wrap'
from /app/vendor/bundle/ruby/3.1.0/gems/activesupport-6.1.6/lib/active_support/execution_wrapper.rb:91:in `wrap'
from /app/vendor/bundle/ruby/3.1.0/gems/activesupport-6.1.6/lib/active_support/reloader.rb:71:in `wrap'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/rails.rb:13:in `call'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:131:in `block (4 levels) in dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:257:in `stats'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:126:in `block (3 levels) in dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/job_logger.rb:13:in `call'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:125:in `block (2 levels) in dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/job_retry.rb:82:in `global'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:124:in `block in dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/job_logger.rb:39:in `prepare'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:123:in `dispatch'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:162:in `process'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:78:in `process_one'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/processor.rb:68:in `run'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:8:in `watchdog'
from /app/vendor/bundle/ruby/3.1.0/gems/sidekiq-6.5.1/lib/sidekiq/component.rb:17:in `block in safe_thread'
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment