(6.5ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL) 
   (4.2ms)  CREATE UNIQUE INDEX  "unique_schema_migrations" ON "schema_migrations"  ("version")
  ActiveRecord::SchemaMigration Load (0.4ms)  SELECT "schema_migrations".* FROM "schema_migrations"
Migrating to CreateAsyncRequestJobs (20160411190611)
   (0.1ms)  BEGIN
   (7.7ms)  CREATE TABLE "async_request_jobs" ("id" serial primary key, "worker" character varying, "status" integer, "status_code" integer, "response" text, "uid" character varying, "params" text, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) 
   (2.9ms)  CREATE  INDEX  "index_async_request_jobs_on_status" ON "async_request_jobs"  ("status")
   (2.9ms)  CREATE UNIQUE INDEX  "index_async_request_jobs_on_uid" ON "async_request_jobs"  ("uid")
  SQL (0.3ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1)  [["version", "20160411190611"]]
   (0.6ms)  COMMIT
  ActiveRecord::SchemaMigration Load (0.3ms)  SELECT "schema_migrations".* FROM "schema_migrations"
   (3.8ms)  SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete
FROM pg_constraint c
JOIN pg_class t1 ON c.conrelid = t1.oid
JOIN pg_class t2 ON c.confrelid = t2.oid
JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid
JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid
JOIN pg_namespace t3 ON c.connamespace = t3.oid
WHERE c.contype = 'f'
  AND t1.relname = 'async_request_jobs'
  AND t3.nspname = ANY (current_schemas(false))
ORDER BY c.conname



Started GET "/test" for ::1 at 2016-04-11 16:36:48 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 1ms (ActiveRecord: 0.0ms)

ArgumentError (wrong number of arguments (2 for 0)):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (46.4ms)


Started GET "/test" for ::1 at 2016-04-11 16:40:17 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 1ms (ActiveRecord: 0.0ms)

ArgumentError (wrong number of arguments (2 for 0)):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (8.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (48.8ms)


Started GET "/test" for ::1 at 2016-04-11 16:40:39 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007ff3b68792e8>):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.3ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (50.7ms)


Started GET "/test" for ::1 at 2016-04-11 16:48:33 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007f929e9dd0e0>):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (5.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (54.5ms)


Started GET "/test" for ::1 at 2016-04-11 16:49:03 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fc4e182a228>):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (45.4ms)


Started GET "/test" for ::1 at 2016-04-11 16:56:32 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 3ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fc2f648e908>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (9.3ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (50.0ms)


Started GET "/test" for ::1 at 2016-04-11 16:56:58 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fd781c00890>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (47.5ms)


Started GET "/test" for ::1 at 2016-04-11 16:57:40 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fe3aa739908>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (51.0ms)


Started GET "/test" for ::1 at 2016-04-11 16:57:44 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 1ms (ActiveRecord: 0.0ms)

NameError (undefined local variable or method `byebug' for #<ApplicationController:0x007fe3aa406718>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (45.9ms)


Started GET "/test" for ::1 at 2016-04-11 16:57:50 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 0ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `pry' for #<Binding:0x007fe3aa5ee508>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (41.2ms)


Started GET "/test" for ::1 at 2016-04-11 19:38:05 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 3ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fe3a94f3690>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (46.5ms)


Started GET "/test" for ::1 at 2016-04-11 19:41:11 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007f8adb3f8820>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (5.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (51.2ms)


Started GET "/test" for ::1 at 2016-04-11 19:43:01 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 2ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fb96bbde5f8>):
  app/controllers/application_controller.rb:9:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (2.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (8.3ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (53.3ms)


Started GET "/test" for ::1 at 2016-04-11 19:43:14 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 244131ms (ActiveRecord: 0.0ms)

NoMethodError (undefined method `execute_async' for #<ApplicationController:0x007fb96d5babc0>):
  app/controllers/application_controller.rb:10:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (6.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (48.3ms)


Started GET "/" for ::1 at 2016-04-11 19:49:32 -0300
Processing by Rails::WelcomeController#index as HTML
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/railties-4.2.6/lib/rails/templates/rails/welcome/index.html.erb (1.1ms)
Completed 200 OK in 6ms (Views: 6.1ms | ActiveRecord: 0.0ms)


Started GET "/test" for ::1 at 2016-04-11 19:49:37 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 3020ms (ActiveRecord: 4.7ms)

ActiveRecord::UnknownAttributeError (unknown attribute 'worker_class' for AsyncRequest::Job.):
  app/controllers/application_controller.rb:10:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (43.6ms)


Started GET "/test" for ::1 at 2016-04-11 19:50:02 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 1ms (ActiveRecord: 0.0ms)

ArgumentError (A copy of AsyncRequest::ApplicationHelper has been removed from the module tree but is still active!):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (40.6ms)


Started GET "/test" for ::1 at 2016-04-11 19:50:11 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 29ms (ActiveRecord: 4.9ms)

ActiveRecord::UnknownAttributeError (unknown attribute 'worker_class' for AsyncRequest::Job.):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (49.6ms)


Started GET "/test" for ::1 at 2016-04-11 19:50:52 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 1ms (ActiveRecord: 0.0ms)

ArgumentError (A copy of AsyncRequest::ApplicationHelper has been removed from the module tree but is still active!):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (5.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (44.5ms)


Started GET "/test" for ::1 at 2016-04-11 19:50:59 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.8ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "5e40c8c5-6a0e-48c5-a783-79f9bdad662d"], ["created_at", "2016-04-11 22:50:59.726053"], ["updated_at", "2016-04-11 22:50:59.726053"]]
   (0.4ms)  COMMIT
Completed 500 Internal Server Error in 36ms (ActiveRecord: 5.9ms)

NameError (uninitialized constant JobProcessor::Sidekiq):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (5.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (55.2ms)


Started GET "/test" for ::1 at 2016-04-11 19:51:24 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.7ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "a6f82625-a17e-46f0-8f2e-be80091792a3"], ["created_at", "2016-04-11 22:51:24.766703"], ["updated_at", "2016-04-11 22:51:24.766703"]]
   (1.0ms)  COMMIT
Completed 500 Internal Server Error in 39ms (ActiveRecord: 7.5ms)

NameError (uninitialized constant Sidekiq):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.3ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (10.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (54.0ms)


Started GET "/test" for ::1 at 2016-04-11 19:51:50 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "1a2de47f-f3a0-4974-a297-62d646baf7f9"], ["created_at", "2016-04-11 22:51:50.557634"], ["updated_at", "2016-04-11 22:51:50.557634"]]
   (0.4ms)  COMMIT
Completed 500 Internal Server Error in 36ms (ActiveRecord: 5.9ms)

NameError (uninitialized constant Sidekiq):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (8.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (48.3ms)


Started GET "/test" for ::1 at 2016-04-11 19:53:15 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "851ed509-3783-400d-91f0-618032337ed1"], ["created_at", "2016-04-11 22:53:15.268313"], ["updated_at", "2016-04-11 22:53:15.268313"]]
   (0.4ms)  COMMIT
Completed 500 Internal Server Error in 37ms (ActiveRecord: 6.5ms)

NameError (uninitialized constant AsyncRequest::JobProcessor::Sidekiq):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (9.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (47.1ms)


Started GET "/test" for ::1 at 2016-04-11 19:54:36 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "827e45b0-ca7c-418a-bb6e-b033a4dfd569"], ["created_at", "2016-04-11 22:54:36.641339"], ["updated_at", "2016-04-11 22:54:36.641339"]]
   (0.4ms)  COMMIT
Completed 500 Internal Server Error in 37ms (ActiveRecord: 6.1ms)

NameError (uninitialized constant Sidekiq):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (57.8ms)


Started GET "/test" for ::1 at 2016-04-11 19:59:38 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.8ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "d6adac2c-fc70-47f2-8894-c23325bd0051"], ["created_at", "2016-04-11 22:59:38.265316"], ["updated_at", "2016-04-11 22:59:38.265316"]]
   (0.5ms)  COMMIT
Completed 500 Internal Server Error in 37ms (ActiveRecord: 6.3ms)

NameError (uninitialized constant Sidekiq):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (2.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (49.5ms)


Started GET "/test" for ::1 at 2016-04-11 20:00:29 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.8ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "e081d823-cd53-404f-aebb-6f6ec3d881f9"], ["created_at", "2016-04-11 23:00:29.184147"], ["updated_at", "2016-04-11 23:00:29.184147"]]
   (0.3ms)  COMMIT
Completed 500 Internal Server Error in 34ms (ActiveRecord: 5.9ms)

LoadError (Unable to autoload constant JobProcessor, expected /Users/matiasdesanti1/Projects/async_request/app/workers/job_processor.rb to define it):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (8.3ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (50.8ms)


Started GET "/test" for ::1 at 2016-04-11 20:00:51 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "7431dd1a-3d6a-42b5-853b-9f570aa61265"], ["created_at", "2016-04-11 23:00:51.994525"], ["updated_at", "2016-04-11 23:00:51.994525"]]
   (0.5ms)  COMMIT
Completed 500 Internal Server Error in 33ms (ActiveRecord: 5.7ms)

LoadError (Unable to autoload constant JobProcessor, expected /Users/matiasdesanti1/Projects/async_request/app/workers/job_processor.rb to define it):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (46.5ms)


Started GET "/test" for ::1 at 2016-04-11 20:01:24 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "ede9ba43-9946-4c9a-be0f-cf6dbcdedbe0"], ["created_at", "2016-04-11 23:01:24.200418"], ["updated_at", "2016-04-11 23:01:24.200418"]]
   (0.4ms)  COMMIT
Completed 500 Internal Server Error in 53ms (ActiveRecord: 6.0ms)

ActionView::MissingTemplate (Missing template application/test with {:locale=>[:en], :formats=>[:html], :variants=>[], :handlers=>[:erb, :builder, :raw, :ruby]}. Searched in:
  * "/Users/matiasdesanti1/Projects/async_request/test/dummy/app/views"
  * "/Users/matiasdesanti1/Projects/async_request/app/views"
):
  actionview (4.2.6) lib/action_view/path_set.rb:46:in `find'
  actionview (4.2.6) lib/action_view/lookup_context.rb:121:in `find'
  actionview (4.2.6) lib/action_view/renderer/abstract_renderer.rb:18:in `find_template'
  actionview (4.2.6) lib/action_view/renderer/template_renderer.rb:40:in `determine_template'
  actionview (4.2.6) lib/action_view/renderer/template_renderer.rb:8:in `render'
  actionview (4.2.6) lib/action_view/renderer/renderer.rb:46:in `render_template'
  actionview (4.2.6) lib/action_view/renderer/renderer.rb:27:in `render'
  actionview (4.2.6) lib/action_view/rendering.rb:100:in `_render_template'
  actionpack (4.2.6) lib/action_controller/metal/streaming.rb:217:in `_render_template'
  actionview (4.2.6) lib/action_view/rendering.rb:83:in `render_to_body'
  actionpack (4.2.6) lib/action_controller/metal/rendering.rb:32:in `render_to_body'
  actionpack (4.2.6) lib/action_controller/metal/renderers.rb:37:in `render_to_body'
  actionpack (4.2.6) lib/abstract_controller/rendering.rb:25:in `render'
  actionpack (4.2.6) lib/action_controller/metal/rendering.rb:16:in `render'
  actionpack (4.2.6) lib/action_controller/metal/instrumentation.rb:44:in `block (2 levels) in render'
  activesupport (4.2.6) lib/active_support/core_ext/benchmark.rb:12:in `block in ms'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/benchmark.rb:303:in `realtime'
  activesupport (4.2.6) lib/active_support/core_ext/benchmark.rb:12:in `ms'
  actionpack (4.2.6) lib/action_controller/metal/instrumentation.rb:44:in `block in render'
  actionpack (4.2.6) lib/action_controller/metal/instrumentation.rb:87:in `cleanup_view_runtime'
  activerecord (4.2.6) lib/active_record/railties/controller_runtime.rb:25:in `cleanup_view_runtime'
  actionpack (4.2.6) lib/action_controller/metal/instrumentation.rb:43:in `render'
  actionpack (4.2.6) lib/action_controller/metal/implicit_render.rb:10:in `default_render'
  actionpack (4.2.6) lib/action_controller/metal/implicit_render.rb:5:in `send_action'
  actionpack (4.2.6) lib/abstract_controller/base.rb:198:in `process_action'
  actionpack (4.2.6) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.2.6) lib/abstract_controller/callbacks.rb:20:in `block in process_action'
  activesupport (4.2.6) lib/active_support/callbacks.rb:117:in `call'
  activesupport (4.2.6) lib/active_support/callbacks.rb:117:in `call'
  activesupport (4.2.6) lib/active_support/callbacks.rb:555:in `block (2 levels) in compile'
  activesupport (4.2.6) lib/active_support/callbacks.rb:505:in `call'
  activesupport (4.2.6) lib/active_support/callbacks.rb:505:in `call'
  activesupport (4.2.6) lib/active_support/callbacks.rb:92:in `__run_callbacks__'
  activesupport (4.2.6) lib/active_support/callbacks.rb:778:in `_run_process_action_callbacks'
  activesupport (4.2.6) lib/active_support/callbacks.rb:81:in `run_callbacks'
  actionpack (4.2.6) lib/abstract_controller/callbacks.rb:19:in `process_action'
  actionpack (4.2.6) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.2.6) lib/action_controller/metal/instrumentation.rb:32:in `block in process_action'
  activesupport (4.2.6) lib/active_support/notifications.rb:164:in `block in instrument'
  activesupport (4.2.6) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.2.6) lib/active_support/notifications.rb:164:in `instrument'
  actionpack (4.2.6) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.2.6) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.2.6) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.2.6) lib/abstract_controller/base.rb:137:in `process'
  actionview (4.2.6) lib/action_view/rendering.rb:30:in `process'
  actionpack (4.2.6) lib/action_controller/metal.rb:196:in `dispatch'
  actionpack (4.2.6) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.2.6) lib/action_controller/metal.rb:237:in `block in action'
  actionpack (4.2.6) lib/action_dispatch/routing/route_set.rb:74:in `call'
  actionpack (4.2.6) lib/action_dispatch/routing/route_set.rb:74:in `dispatch'
  actionpack (4.2.6) lib/action_dispatch/routing/route_set.rb:43:in `serve'
  actionpack (4.2.6) lib/action_dispatch/journey/router.rb:43:in `block in serve'
  actionpack (4.2.6) lib/action_dispatch/journey/router.rb:30:in `each'
  actionpack (4.2.6) lib/action_dispatch/journey/router.rb:30:in `serve'
  actionpack (4.2.6) lib/action_dispatch/routing/route_set.rb:817:in `call'
  rack (1.6.4) lib/rack/etag.rb:24:in `call'
  rack (1.6.4) lib/rack/conditionalget.rb:25:in `call'
  rack (1.6.4) lib/rack/head.rb:13:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/flash.rb:260:in `call'
  rack (1.6.4) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.6.4) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/cookies.rb:560:in `call'
  activerecord (4.2.6) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.2.6) lib/active_record/connection_adapters/abstract/connection_pool.rb:653:in `call'
  activerecord (4.2.6) lib/active_record/migration.rb:377:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.2.6) lib/active_support/callbacks.rb:88:in `__run_callbacks__'
  activesupport (4.2.6) lib/active_support/callbacks.rb:778:in `_run_call_callbacks'
  activesupport (4.2.6) lib/active_support/callbacks.rb:81:in `run_callbacks'
  actionpack (4.2.6) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/reloader.rb:73:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/remote_ip.rb:78:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.2.6) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
  rack (1.6.4) lib/rack/runtime.rb:18:in `call'
  activesupport (4.2.6) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/static.rb:120:in `call'
  rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
  railties (4.2.6) lib/rails/engine.rb:518:in `call'
  railties (4.2.6) lib/rails/application.rb:165:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  rack (1.6.4) lib/rack/content_length.rb:15:in `call'
  rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.9ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (8.6ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/missing_template.html.erb within rescues/layout (50.9ms)


Started GET "/jobs" for ::1 at 2016-04-11 20:01:57 -0300

ActionController::RoutingError (No route matches [GET] "/jobs"):
  actionpack (4.2.6) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.2.6) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
  rack (1.6.4) lib/rack/runtime.rb:18:in `call'
  activesupport (4.2.6) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/static.rb:120:in `call'
  rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
  railties (4.2.6) lib/rails/engine.rb:518:in `call'
  railties (4.2.6) lib/rails/application.rb:165:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  rack (1.6.4) lib/rack/content_length.rb:15:in `call'
  rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_table.html.erb (5.3ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (0.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (63.7ms)


Started GET "/test" for ::1 at 2016-04-11 20:02:17 -0300
Processing by ApplicationController#test as HTML
Completed 500 Internal Server Error in 1ms (ActiveRecord: 0.0ms)

ArgumentError (A copy of AsyncRequest::ApplicationHelper has been removed from the module tree but is still active!):
  app/controllers/application_controller.rb:7:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (3.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.4ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (1.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (39.9ms)


Started GET "/test" for ::1 at 2016-04-11 20:02:25 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "99a48e07-5544-49e9-84b1-78690cfd0e54"], ["created_at", "2016-04-11 23:02:25.923745"], ["updated_at", "2016-04-11 23:02:25.923745"]]
   (0.5ms)  COMMIT
Completed 200 OK in 38ms (Views: 0.2ms | ActiveRecord: 6.8ms)


Started GET "/jobs/99a48e07-5544-49e9-84b1-78690cfd0e54" for ::1 at 2016-04-11 20:02:31 -0300

ActionController::RoutingError (No route matches [GET] "/jobs/99a48e07-5544-49e9-84b1-78690cfd0e54"):
  actionpack (4.2.6) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.2.6) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
  rack (1.6.4) lib/rack/runtime.rb:18:in `call'
  activesupport (4.2.6) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/static.rb:120:in `call'
  rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
  railties (4.2.6) lib/rails/engine.rb:518:in `call'
  railties (4.2.6) lib/rails/application.rb:165:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  rack (1.6.4) lib/rack/content_length.rb:15:in `call'
  rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_table.html.erb (5.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (72.0ms)


Started GET "/async_requst/jobs/99a48e07-5544-49e9-84b1-78690cfd0e54" for ::1 at 2016-04-11 20:02:42 -0300

ActionController::RoutingError (No route matches [GET] "/async_requst/jobs/99a48e07-5544-49e9-84b1-78690cfd0e54"):
  actionpack (4.2.6) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.2.6) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.2.6) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.2.6) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.6.4) lib/rack/methodoverride.rb:22:in `call'
  rack (1.6.4) lib/rack/runtime.rb:18:in `call'
  activesupport (4.2.6) lib/active_support/cache/strategy/local_cache_middleware.rb:28:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  actionpack (4.2.6) lib/action_dispatch/middleware/static.rb:120:in `call'
  rack (1.6.4) lib/rack/sendfile.rb:113:in `call'
  railties (4.2.6) lib/rails/engine.rb:518:in `call'
  railties (4.2.6) lib/rails/application.rb:165:in `call'
  rack (1.6.4) lib/rack/lock.rb:17:in `call'
  rack (1.6.4) lib/rack/content_length.rb:15:in `call'
  rack (1.6.4) lib/rack/handler/webrick.rb:88:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:138:in `service'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/httpserver.rb:94:in `run'
  /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/2.2.0/webrick/server.rb:294:in `block in start_thread'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.7ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.1ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/routes/_table.html.erb (1.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (6.5ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/routing_error.html.erb within rescues/layout (65.9ms)


Started GET "/test" for ::1 at 2016-04-11 20:03:18 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "1fd32c7b-e9f6-424c-ab0c-2f8fb416889f"], ["created_at", "2016-04-11 23:03:18.354944"], ["updated_at", "2016-04-11 23:03:18.354944"]]
   (0.4ms)  COMMIT
Completed 500 Internal Server Error in 40ms (ActiveRecord: 5.8ms)

NameError (undefined local variable or method `byebug' for #<ApplicationController:0x007fdde1159728>):
  app/controllers/application_controller.rb:8:in `test'


  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_source.erb (4.0ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_trace.html.erb (1.8ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/_request_and_response.html.erb (7.2ms)
  Rendered /Users/matiasdesanti1/.rbenv/versions/2.2.2/lib/ruby/gems/2.2.0/gems/actionpack-4.2.6/lib/action_dispatch/middleware/templates/rescues/diagnostics.html.erb within rescues/layout (53.0ms)


Started GET "/test" for ::1 at 2016-04-11 20:03:28 -0300
Processing by ApplicationController#test as HTML
   (0.2ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "b6b8668a-f798-4b24-9119-4e9a352cd287"], ["created_at", "2016-04-11 23:03:28.707414"], ["updated_at", "2016-04-11 23:03:28.707414"]]
   (0.5ms)  COMMIT
DEPRECATION WARNING: `named_routes.helpers` is deprecated, please use `route_defined?(route_name)` to see if a named route was defined. (called from test at (pry):1)
DEPRECATION WARNING: `named_routes.helpers` is deprecated, please use `route_defined?(route_name)` to see if a named route was defined. (called from test at (pry):7)
Completed 200 OK in 150933ms (Views: 0.2ms | ActiveRecord: 6.0ms)


Started GET "/async_request/jobs/b6b8668a-f798-4b24-9119-4e9a352cd287" for ::1 at 2016-04-11 20:06:07 -0300
Processing by AsyncRequest::JobsController#show as HTML
  Parameters: {"id"=>"b6b8668a-f798-4b24-9119-4e9a352cd287"}
  AsyncRequest::Job Load (0.6ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "b6b8668a-f798-4b24-9119-4e9a352cd287"]]
Completed 202 Accepted in 8ms (ActiveRecord: 0.6ms)


Started GET "/async_request/jobs/b6b8668a-f798-4b24-9119-4e9a352cd287" for ::1 at 2016-04-11 20:06:34 -0300
Processing by AsyncRequest::JobsController#show as */*
  Parameters: {"id"=>"b6b8668a-f798-4b24-9119-4e9a352cd287"}
  AsyncRequest::Job Load (0.3ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "b6b8668a-f798-4b24-9119-4e9a352cd287"]]
Completed 202 Accepted in 1ms (ActiveRecord: 0.3ms)


Started GET "/test" for ::1 at 2016-04-11 20:08:57 -0300
Processing by ApplicationController#test as */*
   (0.1ms)  BEGIN
  SQL (0.6ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "47e3314e-9e43-4ba3-b3e9-d4020c01a951"], ["created_at", "2016-04-11 23:08:57.492141"], ["updated_at", "2016-04-11 23:08:57.492141"]]
   (0.5ms)  COMMIT
Completed 202 Accepted in 38ms (Views: 0.2ms | ActiveRecord: 6.0ms)
  AsyncRequest::Job Load (0.6ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."id" = $1 LIMIT 1  [["id", 13]]
   (0.2ms)  BEGIN
  SQL (0.4ms)  UPDATE "async_request_jobs" SET "status" = $1, "updated_at" = $2 WHERE "async_request_jobs"."id" = $3  [["status", 1], ["updated_at", "2016-04-11 23:08:57.541314"], ["id", 13]]
   (0.3ms)  COMMIT


Started GET "/async_request/jobs/47e3314e-9e43-4ba3-b3e9-d4020c01a951" for ::1 at 2016-04-11 20:09:43 -0300
Processing by AsyncRequest::JobsController#show as */*
  Parameters: {"id"=>"47e3314e-9e43-4ba3-b3e9-d4020c01a951"}
  AsyncRequest::Job Load (0.5ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "47e3314e-9e43-4ba3-b3e9-d4020c01a951"]]
Completed 202 Accepted in 12ms (ActiveRecord: 2.5ms)
  AsyncRequest::Job Load (0.6ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."id" = $1 LIMIT 1  [["id", 13]]
   (0.2ms)  BEGIN
   (0.2ms)  COMMIT
  ActiveRecord::SchemaMigration Load (0.6ms)  SELECT "schema_migrations".* FROM "schema_migrations"
  ActiveRecord::SchemaMigration Load (0.2ms)  SELECT "schema_migrations".* FROM "schema_migrations"
Migrating to CreateAsyncRequestJobs (20160411190611)
   (0.2ms)  BEGIN
   (1.0ms)  DROP INDEX "index_async_request_jobs_on_uid"
   (0.3ms)  DROP INDEX "index_async_request_jobs_on_status"
   (1.5ms)  DROP TABLE "async_request_jobs"
  SQL (0.3ms)  DELETE FROM "schema_migrations" WHERE "schema_migrations"."version" = $1  [["version", "20160411190611"]]
   (1.5ms)  COMMIT
  ActiveRecord::SchemaMigration Load (0.2ms)  SELECT "schema_migrations".* FROM "schema_migrations"
  ActiveRecord::SchemaMigration Load (0.4ms)  SELECT "schema_migrations".* FROM "schema_migrations"
Migrating to CreateAsyncRequestJobs (20160411190611)
   (0.1ms)  BEGIN
   (9.4ms)  CREATE TABLE "async_request_jobs" ("id" serial primary key, "worker" character varying, "status" integer, "status_code" integer, "response" text, "uid" character varying, "params" text, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) 
   (2.8ms)  CREATE  INDEX  "index_async_request_jobs_on_status" ON "async_request_jobs"  ("status")
   (2.9ms)  CREATE UNIQUE INDEX  "index_async_request_jobs_on_uid" ON "async_request_jobs"  ("uid")
  SQL (0.3ms)  INSERT INTO "schema_migrations" ("version") VALUES ($1)  [["version", "20160411190611"]]
   (0.8ms)  COMMIT
  ActiveRecord::SchemaMigration Load (0.3ms)  SELECT "schema_migrations".* FROM "schema_migrations"
   (3.5ms)  SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete
FROM pg_constraint c
JOIN pg_class t1 ON c.conrelid = t1.oid
JOIN pg_class t2 ON c.confrelid = t2.oid
JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid
JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid
JOIN pg_namespace t3 ON c.connamespace = t3.oid
WHERE c.contype = 'f'
  AND t1.relname = 'async_request_jobs'
  AND t3.nspname = ANY (current_schemas(false))
ORDER BY c.conname



Started GET "/async_request/jobs/47e3314e-9e43-4ba3-b3e9-d4020c01a951" for ::1 at 2016-04-11 20:10:45 -0300
Processing by AsyncRequest::JobsController#show as */*
  Parameters: {"id"=>"47e3314e-9e43-4ba3-b3e9-d4020c01a951"}
  AsyncRequest::Job Load (0.6ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "47e3314e-9e43-4ba3-b3e9-d4020c01a951"]]
Completed 404 Not Found in 24ms (ActiveRecord: 2.8ms)


Started GET "/test" for ::1 at 2016-04-11 20:10:49 -0300
Processing by ApplicationController#test as */*
   (0.1ms)  BEGIN
  SQL (0.5ms)  INSERT INTO "async_request_jobs" ("worker", "params", "uid", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"  [["worker", "Test"], ["params", "---\n- a\n"], ["uid", "298a1db1-85e2-4dd2-9847-55b1ff6a360d"], ["created_at", "2016-04-11 23:10:49.675662"], ["updated_at", "2016-04-11 23:10:49.675662"]]
   (1.1ms)  COMMIT
Completed 202 Accepted in 19ms (Views: 0.2ms | ActiveRecord: 4.3ms)
  AsyncRequest::Job Load (0.6ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."id" = $1 LIMIT 1  [["id", 1]]
   (0.2ms)  BEGIN
  SQL (0.5ms)  UPDATE "async_request_jobs" SET "status" = $1, "updated_at" = $2 WHERE "async_request_jobs"."id" = $3  [["status", 1], ["updated_at", "2016-04-11 23:10:49.720112"], ["id", 1]]
   (0.4ms)  COMMIT


Started GET "/async_request/jobs/298a1db1-85e2-4dd2-9847-55b1ff6a360d" for ::1 at 2016-04-11 20:10:59 -0300
Processing by AsyncRequest::JobsController#show as */*
  Parameters: {"id"=>"298a1db1-85e2-4dd2-9847-55b1ff6a360d"}
  AsyncRequest::Job Load (0.4ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "298a1db1-85e2-4dd2-9847-55b1ff6a360d"]]
Completed 202 Accepted in 2ms (ActiveRecord: 0.4ms)


Started GET "/async_request/jobs/298a1db1-85e2-4dd2-9847-55b1ff6a360d" for ::1 at 2016-04-11 20:11:26 -0300
Processing by AsyncRequest::JobsController#show as */*
  Parameters: {"id"=>"298a1db1-85e2-4dd2-9847-55b1ff6a360d"}
  AsyncRequest::Job Load (0.3ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "298a1db1-85e2-4dd2-9847-55b1ff6a360d"]]
Completed 202 Accepted in 9ms (ActiveRecord: 2.5ms)
  AsyncRequest::Job Load (0.6ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."id" = $1 LIMIT 1  [["id", 1]]
   (0.2ms)  BEGIN
   (0.1ms)  COMMIT
   (0.1ms)  BEGIN
  SQL (0.4ms)  UPDATE "async_request_jobs" SET "status" = $1, "status_code" = $2, "response" = $3, "updated_at" = $4 WHERE "async_request_jobs"."id" = $5  [["status", 2], ["status_code", 200], ["response", "{:message=>\"you did it!\"}"], ["updated_at", "2016-04-11 23:11:35.830732"], ["id", 1]]
   (0.5ms)  COMMIT


Started GET "/async_request/jobs/298a1db1-85e2-4dd2-9847-55b1ff6a360d" for ::1 at 2016-04-11 20:11:39 -0300
Processing by AsyncRequest::JobsController#show as */*
  Parameters: {"id"=>"298a1db1-85e2-4dd2-9847-55b1ff6a360d"}
  AsyncRequest::Job Load (0.3ms)  SELECT  "async_request_jobs".* FROM "async_request_jobs" WHERE "async_request_jobs"."uid" = $1 LIMIT 1  [["uid", "298a1db1-85e2-4dd2-9847-55b1ff6a360d"]]
Completed 0  in 1ms (Views: 0.1ms | ActiveRecord: 0.3ms)
   (0.2ms)  DROP DATABASE IF EXISTS "dummy_test"
   (714.2ms)  CREATE DATABASE "dummy_test" ENCODING = 'unicode'
  SQL (0.3ms)  CREATE EXTENSION IF NOT EXISTS "plpgsql"
   (9.8ms)  CREATE TABLE "async_request_jobs" ("id" serial primary key, "worker" character varying, "status" integer, "status_code" integer, "response" text, "uid" character varying, "params" text, "created_at" timestamp NOT NULL, "updated_at" timestamp NOT NULL) 
   (3.1ms)  CREATE  INDEX  "index_async_request_jobs_on_status" ON "async_request_jobs" USING btree ("status")
   (3.3ms)  CREATE UNIQUE INDEX  "index_async_request_jobs_on_uid" ON "async_request_jobs" USING btree ("uid")
   (4.8ms)  CREATE TABLE "schema_migrations" ("version" character varying NOT NULL) 
   (3.1ms)  CREATE UNIQUE INDEX  "unique_schema_migrations" ON "schema_migrations"  ("version")
   (0.4ms)  SELECT version FROM "schema_migrations"
   (0.4ms)  INSERT INTO "schema_migrations" (version) VALUES ('20160411190611')
  ActiveRecord::SchemaMigration Load (0.6ms)  SELECT "schema_migrations".* FROM "schema_migrations"
  ActiveRecord::SchemaMigration Load (0.2ms)  SELECT "schema_migrations".* FROM "schema_migrations"
   (3.3ms)  SELECT t2.oid::regclass::text AS to_table, a1.attname AS column, a2.attname AS primary_key, c.conname AS name, c.confupdtype AS on_update, c.confdeltype AS on_delete
FROM pg_constraint c
JOIN pg_class t1 ON c.conrelid = t1.oid
JOIN pg_class t2 ON c.confrelid = t2.oid
JOIN pg_attribute a1 ON a1.attnum = c.conkey[1] AND a1.attrelid = t1.oid
JOIN pg_attribute a2 ON a2.attnum = c.confkey[1] AND a2.attrelid = t2.oid
JOIN pg_namespace t3 ON c.connamespace = t3.oid
WHERE c.contype = 'f'
  AND t1.relname = 'async_request_jobs'
  AND t3.nspname = ANY (current_schemas(false))
ORDER BY c.conname