gistfile1.txt

15:52:50 pathfinder.1 | 2013-07-15T20:52:50Z 80536 TID-oxsyqylsc SearchService::CompositeSearchBuilder JID-b5377063eba252d41b97e3b8 INFO: fail: 60.003 sec
15:52:50 pathfinder.1 | 2013-07-15T20:52:50Z 80536 TID-oxsyqylsc WARN: {"retry"=>false, "queue"=>"pathfinding", "backtrace"=>true, "timeout"=>60, "class"=>"SearchService::CompositeSearchBuilder", "args"=>[{"start_latitude"=>50.7678, "start_longitude"=>6.091499, "end_latitude"=>52.525592, "end_longitude"=>13.369545, "vehicle_flags"=>7, "third_party_id"=>1, "created_at"=>nil, "updated_at"=>nil, "uuid"=>"7356fa77-2f26-46b4-a798-0e01709fec1f", "departure_time"=>"2013-07-17"}], "jid"=>"b5377063eba252d41b97e3b8"}
15:52:50 pathfinder.1 | 2013-07-15T20:52:50Z 80536 TID-oxsyqylsc WARN: execution expired
15:52:50 pathfinder.1 | 2013-07-15T20:52:50Z 80536 TID-oxsyqylsc WARN: /Users/ningja/.rvm/rubies/ruby-2.0.0-p0/lib/ruby/2.0.0/monitor.rb:185:in `lock'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/rubies/ruby-2.0.0-p0/lib/ruby/2.0.0/monitor.rb:185:in `mon_enter'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/rubies/ruby-2.0.0-p0/lib/ruby/2.0.0/monitor.rb:209:in `mon_synchronize'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/redis-3.0.3/lib/redis.rb:36:in `synchronize'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/redis-3.0.3/lib/redis.rb:629:in `set'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/redis-namespace-1.2.1/lib/redis/namespace.rb:257:in `method_missing'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/redis-objects-0.7.0/lib/redis/value.rb:23:in `value='
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/admin/app/models/search.rb:111:in `update_state'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/bot_queen.rb:12:in `enqueue_search'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/search_service/multi_search_builder.rb:9:in `block in enqueue_searches'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/activerecord-3.2.13/lib/active_record/associations/collection_proxy.rb:89:in `each'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/activerecord-3.2.13/lib/active_record/associations/collection_proxy.rb:89:in `method_missing'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/search_service/multi_search_builder.rb:8:in `enqueue_searches'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/search_service/composite_search_builder.rb:69:in `block (2 levels) in notify_multi_search_listeners'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/activerecord-3.2.13/lib/active_record/associations/collection_proxy.rb:89:in `each'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/activerecord-3.2.13/lib/active_record/associations/collection_proxy.rb:89:in `method_missing'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/search_service/composite_search_builder.rb:68:in `block in notify_multi_search_listeners'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/activerecord-3.2.13/lib/active_record/associations/collection_proxy.rb:89:in `each'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/activerecord-3.2.13/lib/active_record/associations/collection_proxy.rb:89:in `method_missing'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/search_service/composite_search_builder.rb:67:in `notify_multi_search_listeners'
15:52:50 pathfinder.1 | /Users/ningja/dev/projects/from_a_to_b/search_service/lib/search_service/composite_search_builder.rb:19:in `perform'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/processor.rb:49:in `block (3 levels) in process'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:109:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:109:in `block in invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/errplane-0.6.7/lib/errplane/sidekiq.rb:5:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:111:in `block in invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/server/timeout.rb:11:in `block in call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/server/timeout.rb:10:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:111:in `block in invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/server/active_record.rb:6:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:111:in `block in invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/server/retry_jobs.rb:50:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:111:in `block in invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/server/logging.rb:11:in `block in call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/logging.rb:22:in `with_context'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/server/logging.rb:7:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:111:in `block in invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:114:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/middleware/chain.rb:114:in `invoke'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/processor.rb:48:in `block (2 levels) in process'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/processor.rb:87:in `stats'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/sidekiq-2.10.0/lib/sidekiq/processor.rb:47:in `block in process'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/celluloid-0.12.4/lib/celluloid/calls.rb:23:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/celluloid-0.12.4/lib/celluloid/calls.rb:23:in `public_send'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/celluloid-0.12.4/lib/celluloid/calls.rb:23:in `dispatch'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/celluloid-0.12.4/lib/celluloid/future.rb:18:in `block in initialize'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/celluloid-0.12.4/lib/celluloid/internal_pool.rb:48:in `call'
15:52:50 pathfinder.1 | /Users/ningja/.rvm/gems/ruby-2.0.0-p0@search_service/gems/celluloid-0.12.4/lib/celluloid/internal_pool.rb:48:in `block in create'