{"action":"created","issue":{"url":"https://api.github.com/repos/mperham/sidekiq/issues/2880","repository_url":"https://api.github.com/repos/mperham/sidekiq","labels_url":"https://api.github.com/repos/mperham/sidekiq/issues/2880/labels{/name}","comments_url":"https://api.github.com/repos/mperham/sidekiq/issues/2880/comments","events_url":"https://api.github.com/repos/mperham/sidekiq/issues/2880/events","html_url":"https://github.com/mperham/sidekiq/issues/2880","id":140041181,"number":2880,"title":"Sidekiq Pro: 9 minute delay between \"startup complete\" and \"started processing\"","user":{"login":"dacoinminster","id":981570,"avatar_url":"https://avatars.githubusercontent.com/u/981570?v=3","gravatar_id":"","url":"https://api.github.com/users/dacoinminster","html_url":"https://github.com/dacoinminster","followers_url":"https://api.github.com/users/dacoinminster/followers","following_url":"https://api.github.com/users/dacoinminster/following{/other_user}","gists_url":"https://api.github.com/users/dacoinminster/gists{/gist_id}","starred_url":"https://api.github.com/users/dacoinminster/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/dacoinminster/subscriptions","organizations_url":"https://api.github.com/users/dacoinminster/orgs","repos_url":"https://api.github.com/users/dacoinminster/repos","events_url":"https://api.github.com/users/dacoinminster/events{/privacy}","received_events_url":"https://api.github.com/users/dacoinminster/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":null,"milestone":null,"comments":2,"created_at":"2016-03-10T23:40:42Z","updated_at":"2016-03-11T00:52:58Z","closed_at":null,"body":"After deployment to heroku of sidekiq pro, I've been seeing a disturbingly long delay between the \"Sidekiq startup complete\" message and the \"Starting processing\" message. From our logs:\r\n\r\nMar 10 15:21:43 cl-recipe-manager app/sidekiq.5: Sidekiq startup complete. ENV['SIDEKIQ_AR_DB_POOL_SIZE']=10, ENV['SIDEKIQ_CONCURRENCY']=5, Rails configured to be 10. \r\nMar 10 15:30:15 cl-recipe-manager app/sidekiq.5: 3 TID-osrk1fes8 INFO: Starting processing, hit Ctrl-C to stop \r\n\r\nWhat could cause such a long delay? It seems to be getting worse over time. I think it took 5 minutes last deployment a few weeks ago - this time it took almost 9 minutes.\r\n\r\nThe delay is starting to affect users negatively, so I hope you can help us sort this out.\r\n\r\nThanks!"},"comment":{"url":"https://api.github.com/repos/mperham/sidekiq/issues/comments/195121571","html_url":"https://github.com/mperham/sidekiq/issues/2880#issuecomment-195121571","issue_url":"https://api.github.com/repos/mperham/sidekiq/issues/2880","id":195121571,"user":{"login":"mperham","id":2911,"avatar_url":"https://avatars.githubusercontent.com/u/2911?v=3","gravatar_id":"","url":"https://api.github.com/users/mperham","html_url":"https://github.com/mperham","followers_url":"https://api.github.com/users/mperham/followers","following_url":"https://api.github.com/users/mperham/following{/other_user}","gists_url":"https://api.github.com/users/mperham/gists{/gist_id}","starred_url":"https://api.github.com/users/mperham/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/mperham/subscriptions","organizations_url":"https://api.github.com/users/mperham/orgs","repos_url":"https://api.github.com/users/mperham/repos","events_url":"https://api.github.com/users/mperham/events{/privacy}","received_events_url":"https://api.github.com/users/mperham/received_events","type":"User","site_admin":false},"created_at":"2016-03-11T00:52:58Z","updated_at":"2016-03-11T00:52:58Z","body":"\"Sidekiq startup complete.\" is not a log message in the Sidekiq code so that doesn't help.\r\n\r\nCheck your [slowlog](http://redis.io/commands/slowlog).  Monitor your Redis `redis-cli monitor` and see what operations it is performing."}}