Heroku Sidekiq ttin stacktraces

gistfile1.txt

2013-09-12T20:28:01.301085+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22h5tp4 
2013-09-12T20:28:01.301186+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/cli.rb:117:in `backtrace'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/cli.rb:117:in `block in handle_signal'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/cli.rb:114:in `each'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/cli.rb:114:in `handle_signal'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/cli.rb:75:in `run'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/bin/sidekiq:8:in `<top (required)>'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/bin/sidekiq:23:in `load'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/bin/sidekiq:23:in `<main>'
2013-09-12T20:28:01.301186+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22h3p4g 
2013-09-12T20:28:01.301496+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 
levels) in wait'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.301496+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22h40sg 
2013-09-12T20:28:01.301643+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 levels) in wait'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.301643+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22h42uw 
2013-09-12T20:28:01.301813+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 levels) in wait'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.301813+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'
2013-09-12T20:28:01.302285+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22h4a1s 
2013-09-12T20:28:01.302285+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 levels) in wait'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.302465+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22yoh7s 
2013-09-12T20:28:01.302777+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/mysql2_adapter.rb:84:in `ping'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/mysql2_adapter.rb:84:in `active?'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:401:in `block (2 levels) in reap'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:400:in `each'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:400:in `block in reap'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:211:in `mon_synchronize'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:398:in `reap'
2013-09-12T20:28:01.302777+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:217:in `block in run'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow2305xi8 
2013-09-12T20:28:01.302926+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 levels) in wait'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.302926+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow2306qc0 
2013-09-12T20:28:01.303270+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 levels) in wait'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.303270+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow2307z84 
2013-09-12T20:28:01.303505+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/app/workers/ttin_worker.rb:11:in `sleep'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/app/workers/ttin_worker.rb:11:in `block in perform'
2013-09-12T20:28:01.303505+00:00 app[worker.1]: /app/app/workers/ttin_worker.rb:7:in `loop'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/app/workers/ttin_worker.rb:7:in `perform'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:48:in `block (3 levels) in process'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:115:in `call'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:115:in `block in invoke'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-pro-1.2.3/lib/sidekiq/batch/middleware.rb:32:in `call'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:6:in `call'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.303853+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.304022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.304452+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow230buto 
2013-09-12T20:28:01.304452+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.304633+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.304913+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.305082+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow234oyw0 
2013-09-12T20:28:01.307629+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.307629+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.308002+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.308180+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow234ouw4 
2013-09-12T20:28:01.308673+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.308673+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.308842+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.309186+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22lstlg 
2013-09-12T20:28:01.449064+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract_mysql_adapter.rb:286:in `query'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract_mysql_adapter.rb:286:in `block in execute'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract_adapter.rb:425:in `block in log'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activesupport-4.0.0/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract_adapter.rb:420:in `log'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract_mysql_adapter.rb:286:in `execute'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/mysql2_adapter.rb:220:in `execute'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract_mysql_adapter.rb:322:in `commit_db_transaction'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/transaction.rb:176:in `perform_commit'
2013-09-12T20:28:01.449064+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/transaction.rb:116:in `commit'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/database_statements.rb:236:in `commit_transaction'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/database_statements.rb:216:in `within_new_transaction'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/database_statements.rb:202:in `transaction'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/transactions.rb:209:in `transaction'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/transactions.rb:323:in `with_transaction_returning_status'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/transactions.rb:275:in `save!'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/app/workers/campaign_option_asset_images_generator_worker.rb:17:in `perform'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/app/workers/campaign_option_asset_images_migration_worker.rb:6:in `perform'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:48:in `block (3 levels) in process'
2013-09-12T20:28:01.449359+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:115:in `call'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:115:in `block in invoke'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-pro-1.2.3/lib/sidekiq/batch/middleware.rb:32:in `call'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:6:in `call'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.449599+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.450209+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.450209+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.450209+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.450209+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.450939+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.451189+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.451679+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22md3ac 
2013-09-12T20:28:01.452761+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.452761+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.453022+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.453253+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.455905+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22mgr7s 
2013-09-12T20:28:01.456625+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `ensure in call'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.456625+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.456860+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.457084+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.458165+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22q64e0 
2013-09-12T20:28:01.458935+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.458935+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.459194+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.459422+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.460354+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow234nwyg 
2013-09-12T20:28:01.461560+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.461560+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.461983+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.462416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.463809+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow234nsyk 
2013-09-12T20:28:01.464856+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:282:in `release_connection'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `each'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_adapters/abstract/connection_pool.rb:528:in `clear_active_connections!'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/activerecord-4.0.0/lib/active_record/connection_handling.rb:95:in `clear_active_connections!'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/active_record.rb:8:in `call'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.464856+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/retry_jobs.rb:62:in `call'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/logging.rb:22:in `with_context'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:117:in `block in invoke'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `call'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/middleware/chain.rb:120:in `invoke'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:47:in `block (2 levels) in process'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:102:in `stats'
2013-09-12T20:28:01.465169+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:46:in `block in process'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:83:in `do_defer'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/sidekiq-2.14.0/lib/sidekiq/processor.rb:37:in `process'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `public_send'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:25:in `dispatch'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/calls.rb:122:in `dispatch'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:322:in `block in handle_message'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:416:in `block in task'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks.rb:55:in `block in initialize'
2013-09-12T20:28:01.465416+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/tasks/task_fiber.rb:13:in `block in create'
2013-09-12T20:28:01.468835+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: Thread TID-ow22m54rc 
2013-09-12T20:28:01.469271+00:00 app[worker.1]: 2013-09-12T20:28:01Z 2 TID-ow22h5tp4 INFO: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `sleep'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:72:in `block (2 levels) in wait'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `handle_interrupt'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:68:in `block in wait'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `handle_interrupt'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/ruby-2.0.0/lib/ruby/2.0.0/thread.rb:66:in `wait'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/mailbox.rb:69:in `receive'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:173:in `run'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/actor.rb:157:in `block in initialize'
2013-09-12T20:28:01.469271+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
2013-09-12T20:28:01.469522+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `call'
2013-09-12T20:28:01.469522+00:00 app[worker.1]: /app/vendor/bundle/ruby/2.0.0/gems/celluloid-0.15.1/lib/celluloid/internal_pool.rb:100:in `block in create'