(1.5ms)  CREATE TABLE "opay_payments" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "payable_id" integer, "payable_type" varchar(255), "session_id" varchar(255) NOT NULL, "provider" varchar(255) NOT NULL, "amount" integer NOT NULL, "finished" boolean DEFAULT 'f' NOT NULL, "status" varchar(255), "created_at" datetime, "updated_at" datetime) 
   (1.1ms)  CREATE INDEX "index_opay_payments_on_payable_id_and_payable_type" ON "opay_payments" ("payable_id", "payable_type")
   (1.0ms)  CREATE UNIQUE INDEX "index_opay_payments_on_session_id" ON "opay_payments" ("session_id")
   (1.0ms)  CREATE TABLE "orders" ("id" INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, "name" varchar(255), "amount" varchar(255), "finished" boolean DEFAULT 'f' NOT NULL, "created_at" datetime, "updated_at" datetime) 
   (2.0ms)  CREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) 
   (1.0ms)  CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
   (0.1ms)  SELECT version FROM "schema_migrations"
   (1.0ms)  INSERT INTO "schema_migrations" (version) VALUES ('20130326152550')
  ActiveRecord::SchemaMigration Load (0.1ms)  SELECT "schema_migrations".* FROM "schema_migrations"


Started GET "/" for 127.0.0.1 at 2014-04-24 15:18:45 +0200
Processing by OrdersController#index as HTML
  Order Load (3.7ms)  SELECT "orders".* FROM "orders"
  Rendered orders/index.html.erb within layouts/application (8.9ms)
Completed 200 OK in 281ms (Views: 258.5ms | ActiveRecord: 3.7ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:18:47 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:18:47 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:18:47 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:18:47 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:18:47 +0200


Started GET "/orders/new" for 127.0.0.1 at 2014-04-24 15:18:49 +0200
Processing by OrdersController#new as HTML
  Rendered orders/_form.html.erb (48.7ms)
  Rendered orders/new.html.erb within layouts/application (57.0ms)
Completed 200 OK in 73ms (Views: 70.0ms | ActiveRecord: 0.5ms)


Started POST "/orders" for 127.0.0.1 at 2014-04-24 15:18:55 +0200
Processing by OrdersController#create as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "order"=>{"name"=>"name", "amount"=>"10"}, "commit"=>"Create Order"}
   (0.2ms)  begin transaction
  SQL (13.6ms)  INSERT INTO "orders" ("amount", "created_at", "name", "updated_at") VALUES (?, ?, ?, ?)  [["amount", "10"], ["created_at", Thu, 24 Apr 2014 13:18:55 UTC +00:00], ["name", "name"], ["updated_at", Thu, 24 Apr 2014 13:18:55 UTC +00:00]]
   (2.4ms)  commit transaction
Redirected to http://localhost:3000/orders/1
Completed 302 Found in 26ms (ActiveRecord: 16.2ms)


Started GET "/orders/1" for 127.0.0.1 at 2014-04-24 15:18:55 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"1"}
  Order Load (0.4ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "1"]]
  Opay::Payment Load (0.8ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
   (0.1ms)  begin transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'wfxL2JXCm2LhuZRGkrMr' ORDER BY "opay_payments"."id" ASC LIMIT 1
  SQL (2.9ms)  INSERT INTO "opay_payments" ("amount", "created_at", "payable_id", "payable_type", "provider", "session_id", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?)  [["amount", 10], ["created_at", Thu, 24 Apr 2014 13:18:56 UTC +00:00], ["payable_id", 1], ["payable_type", "Order"], ["provider", "payu"], ["session_id", "wfxL2JXCm2LhuZRGkrMr"], ["updated_at", Thu, 24 Apr 2014 13:18:56 UTC +00:00]]
   (1.2ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (199.7ms)
Completed 500 Internal Server Error in 214ms

ActionView::Template::Error (Empty payment provider):
    18: 
    19: 
    20: <%= payu_form_for(@order) do |f| %>
    21:   <%= f.payment_info first_name: 'Jan', last_name: 'Kowalski', email: 'kowalski@gmail.com', desc: 'Test payment', client_ip: '127.0.0.1' %>
    22:   <%= f.submit :pay_with_payu %>
    23: <% end -%>
    24: 
  app/views/orders/show.html.erb:21:in `block in _app_views_orders_show_html_erb__1764881669874171495_70128889827280'
  app/views/orders/show.html.erb:20:in `_app_views_orders_show_html_erb__1764881669874171495_70128889827280'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (28.0ms)


Started GET "/orders/1" for 127.0.0.1 at 2014-04-24 15:21:15 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"1"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "1"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'xsufcfDxp3mbDNz5pdmP' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.2ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "xsufcfDxp3mbDNz5pdmP"], ["updated_at", Thu, 24 Apr 2014 13:21:15 UTC +00:00]]
   (6.1ms)  commit transaction
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'MZdaqaVdatukLqLKGWmp' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.7ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "MZdaqaVdatukLqLKGWmp"], ["updated_at", Thu, 24 Apr 2014 13:21:15 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (37.2ms)
Completed 200 OK in 44ms (Views: 32.2ms | ActiveRecord: 10.2ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:21:15 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:21:15 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:15 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:15 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:15 +0200


Started GET "/orders/1" for 127.0.0.1 at 2014-04-24 15:21:55 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"1"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "1"]]
  Opay::Payment Load (3.5ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'JpqBqsCgrY6a4MtuP1xQ' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.7ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "JpqBqsCgrY6a4MtuP1xQ"], ["updated_at", Thu, 24 Apr 2014 13:21:56 UTC +00:00]]
   (1.2ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'jvGJ6FkA72qj2hLgpBCu' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "jvGJ6FkA72qj2hLgpBCu"], ["updated_at", Thu, 24 Apr 2014 13:21:56 UTC +00:00]]
   (3.1ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (98.2ms)
Completed 200 OK in 282ms (Views: 246.8ms | ActiveRecord: 16.9ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:21:56 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:56 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:56 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:56 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:21:56 +0200


Started PATCH "/opay/payu/paygw/UTF/NewPayment" for 127.0.0.1 at 2014-04-24 15:21:58 +0200
Processing by Opay::PayuController#paygw as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "first_name"=>"Jan", "last_name"=>"Kowalski", "email"=>"kowalski@gmail.com", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "pos_id"=>"123456", "pos_auth_key"=>"DiEKzTD", "session_id"=>"JpqBqsCgrY6a4MtuP1xQ", "amount"=>"10", "js"=>"1", "pay_type"=>"t", "ts"=>"1398345716", "sig"=>"fbf5c774953eda0008cd28fef8a513e3", "commit"=>"pay_with_payu"}
  Rendered /Users/olownia/dev/gems/opay/app/views/opay/payu/paygw.html.erb within layouts/opay/application (10.8ms)
Completed 200 OK in 97ms (Views: 96.8ms | ActiveRecord: 0.0ms)


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:21:58 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:58 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:58 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:21:58 +0200


Started GET "/opay/correct_authorization?session_id=JpqBqsCgrY6a4MtuP1xQ" for 127.0.0.1 at 2014-04-24 15:22:00 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"JpqBqsCgrY6a4MtuP1xQ"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'JpqBqsCgrY6a4MtuP1xQ' ORDER BY "opay_payments"."id" ASC LIMIT 1
Completed 404 Not Found in 2ms

ActiveRecord::RecordNotFound (ActiveRecord::RecordNotFound):
  activerecord (4.0.4) lib/active_record/relation/finder_methods.rb:98:in `first!'
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:4:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__2900285106230756710__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3670105951747852129__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.2ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (24.9ms)


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:35 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:35 +0200


Started PATCH "/opay/payu/paygw/UTF/NewPayment" for 127.0.0.1 at 2014-04-24 15:22:37 +0200
Processing by Opay::PayuController#paygw as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "first_name"=>"Jan", "last_name"=>"Kowalski", "email"=>"kowalski@gmail.com", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "pos_id"=>"123456", "pos_auth_key"=>"DiEKzTD", "session_id"=>"JpqBqsCgrY6a4MtuP1xQ", "amount"=>"10", "js"=>"1", "pay_type"=>"t", "ts"=>"1398345716", "sig"=>"fbf5c774953eda0008cd28fef8a513e3", "commit"=>"pay_with_payu"}
  Rendered /Users/olownia/dev/gems/opay/app/views/opay/payu/paygw.html.erb within layouts/opay/application (1.4ms)
Completed 200 OK in 7ms (Views: 7.2ms | ActiveRecord: 0.0ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:37 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:37 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:37 +0200


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:37 +0200


Started GET "/orders/1" for 127.0.0.1 at 2014-04-24 15:22:41 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"1"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "1"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Ym7rHuuTLVNpyEwvjj37' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "Ym7rHuuTLVNpyEwvjj37"], ["updated_at", Thu, 24 Apr 2014 13:22:41 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'LHkeq5ZVQTxeEpffRzp4' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "LHkeq5ZVQTxeEpffRzp4"], ["updated_at", Thu, 24 Apr 2014 13:22:41 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (14.9ms)
Completed 200 OK in 25ms (Views: 19.5ms | ActiveRecord: 3.8ms)


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:41 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:41 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:41 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:41 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:41 +0200


Started GET "/orders/new" for 127.0.0.1 at 2014-04-24 15:22:44 +0200
Processing by OrdersController#new as HTML
  Rendered orders/_form.html.erb (88.8ms)
  Rendered orders/new.html.erb within layouts/application (96.7ms)
Completed 200 OK in 103ms (Views: 102.0ms | ActiveRecord: 0.0ms)


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:44 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:44 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:44 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:44 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:44 +0200


Started GET "/orders" for 127.0.0.1 at 2014-04-24 15:22:48 +0200
Processing by OrdersController#index as HTML
  Order Load (0.4ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (6.0ms)
Completed 200 OK in 15ms (Views: 13.8ms | ActiveRecord: 0.6ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:48 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:48 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:48 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:48 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:48 +0200


Started GET "/orders/1" for 127.0.0.1 at 2014-04-24 15:22:50 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"1"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "1"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'oysoR4uzDi3JsLW7CTcA' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "oysoR4uzDi3JsLW7CTcA"], ["updated_at", Thu, 24 Apr 2014 13:22:50 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ecRSsMZT7bz3KBnsZCPR' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "ecRSsMZT7bz3KBnsZCPR"], ["updated_at", Thu, 24 Apr 2014 13:22:50 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (15.1ms)
Completed 200 OK in 24ms (Views: 18.9ms | ActiveRecord: 4.0ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:50 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:50 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:50 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:50 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:50 +0200


Started PATCH "/opay/payu/paygw/UTF/NewPayment" for 127.0.0.1 at 2014-04-24 15:22:52 +0200
Processing by Opay::PayuController#paygw as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "first_name"=>"Jan", "last_name"=>"Kowalski", "email"=>"kowalski@gmail.com", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "pos_id"=>"123456", "pos_auth_key"=>"DiEKzTD", "session_id"=>"oysoR4uzDi3JsLW7CTcA", "amount"=>"10", "js"=>"1", "pay_type"=>"t", "ts"=>"1398345770", "sig"=>"8d2eb14c0508b97fae2366ed76e24035", "commit"=>"pay_with_payu"}
  Rendered /Users/olownia/dev/gems/opay/app/views/opay/payu/paygw.html.erb within layouts/opay/application (1.3ms)
Completed 200 OK in 8ms (Views: 7.5ms | ActiveRecord: 0.0ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:52 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:52 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:52 +0200


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:52 +0200


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:22:53 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Completed 500 Internal Server Error in 3ms

NoMethodError (undefined method `cancel_payment_path' for #<Opay::PayuController:0x007f939d883140>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:10:in `wrong_authorizationt'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__2900285106230756710__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3670105951747852129__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.3ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (22.1ms)


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:22:58 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:58 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:58 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:22:58 +0200


Started GET "/opay/correct_authorization?session_id=oysoR4uzDi3JsLW7CTcA" for 127.0.0.1 at 2014-04-24 15:23:00 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"oysoR4uzDi3JsLW7CTcA"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'oysoR4uzDi3JsLW7CTcA' ORDER BY "opay_payments"."id" ASC LIMIT 1
Completed 404 Not Found in 2ms

ActiveRecord::RecordNotFound (ActiveRecord::RecordNotFound):
  activerecord (4.0.4) lib/active_record/relation/finder_methods.rb:98:in `first!'
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:4:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__2900285106230756710__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3670105951747852129__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (2.0ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (20.9ms)


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:23:24 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:24 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:24 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:24 +0200


Started PATCH "/opay/payu/paygw/UTF/NewPayment" for 127.0.0.1 at 2014-04-24 15:23:26 +0200
Processing by Opay::PayuController#paygw as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "first_name"=>"Jan", "last_name"=>"Kowalski", "email"=>"kowalski@gmail.com", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "pos_id"=>"123456", "pos_auth_key"=>"DiEKzTD", "session_id"=>"oysoR4uzDi3JsLW7CTcA", "amount"=>"10", "js"=>"1", "pay_type"=>"t", "ts"=>"1398345770", "sig"=>"8d2eb14c0508b97fae2366ed76e24035", "commit"=>"pay_with_payu"}
  Rendered /Users/olownia/dev/gems/opay/app/views/opay/payu/paygw.html.erb within layouts/opay/application (1.4ms)
Completed 200 OK in 12ms (Views: 11.4ms | ActiveRecord: 0.0ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:26 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:26 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:26 +0200


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:23:26 +0200


Started GET "/opay/correct_authorization?session_id=oysoR4uzDi3JsLW7CTcA" for 127.0.0.1 at 2014-04-24 15:23:28 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"oysoR4uzDi3JsLW7CTcA"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'oysoR4uzDi3JsLW7CTcA' ORDER BY "opay_payments"."id" ASC LIMIT 1
Completed 404 Not Found in 2ms

ActiveRecord::RecordNotFound (ActiveRecord::RecordNotFound):
  activerecord (4.0.4) lib/active_record/relation/finder_methods.rb:98:in `first!'
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:4:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__2900285106230756710__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3670105951747852129__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.6ms)


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:23:33 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:33 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:33 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:33 +0200


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:23:35 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Completed 500 Internal Server Error in 2ms

NoMethodError (undefined method `cancel_payment_path' for #<Opay::PayuController:0x007f939aed0460>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:10:in `wrong_authorizationt'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__2900285106230756710__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3670105951747852129__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (20.5ms)


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:23:55 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Completed 500 Internal Server Error in 3ms

NoMethodError (undefined method `cancel_payment_path' for #<Opay::PayuController:0x007f939d853620>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:10:in `wrong_authorizationt'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__2900285106230756710__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__3670105951747852129__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (20.2ms)


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:23:57 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:57 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:57 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:23:57 +0200


Started GET "/opay/correct_authorization?session_id=oysoR4uzDi3JsLW7CTcA" for 127.0.0.1 at 2014-04-24 15:24:10 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"oysoR4uzDi3JsLW7CTcA"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'oysoR4uzDi3JsLW7CTcA' ORDER BY "opay_payments"."id" ASC LIMIT 1
Completed 404 Not Found in 15ms

ActiveRecord::RecordNotFound (ActiveRecord::RecordNotFound):
  activerecord (4.0.4) lib/active_record/relation/finder_methods.rb:98:in `first!'
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:4:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1500625184490485662__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4332336798211170224__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (17.2ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (40.8ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:24:14 +0200


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:24:14 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:24:14 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:24:14 +0200


Started PATCH "/opay/payu/paygw/UTF/NewPayment" for 127.0.0.1 at 2014-04-24 15:24:16 +0200
Processing by Opay::PayuController#paygw as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "first_name"=>"Jan", "last_name"=>"Kowalski", "email"=>"kowalski@gmail.com", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "pos_id"=>"123456", "pos_auth_key"=>"DiEKzTD", "session_id"=>"oysoR4uzDi3JsLW7CTcA", "amount"=>"10", "js"=>"1", "pay_type"=>"t", "ts"=>"1398345770", "sig"=>"8d2eb14c0508b97fae2366ed76e24035", "commit"=>"pay_with_payu"}
  Rendered /Users/olownia/dev/gems/opay/app/views/opay/payu/paygw.html.erb within layouts/opay/application (8.8ms)
Completed 200 OK in 102ms (Views: 101.6ms | ActiveRecord: 0.0ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:24:16 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:24:16 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:24:16 +0200


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:24:16 +0200


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:24:17 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Completed 500 Internal Server Error in 4ms

NoMethodError (undefined method `root_path' for #<Opay::PayuController:0x007fce46993e48>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:10:in `wrong_authorizationt'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1500625184490485662__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4332336798211170224__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.1ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (22.2ms)


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:25:04 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Completed 500 Internal Server Error in 4ms

NoMethodError (undefined method `root_path' for #<Opay::PayuController:0x007fce46c01748>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:10:in `wrong_authorizationt'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1500625184490485662__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4332336798211170224__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.2ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (2.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (24.8ms)


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:25:38 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Completed 500 Internal Server Error in 3ms

NoMethodError (undefined method `root_path' for #<Opay::PayuController:0x007fce46d702c8>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:10:in `wrong_authorizationt'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1500625184490485662__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4332336798211170224__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (21.1ms)


Started GET "/opay/wrong_authorizationt" for 127.0.0.1 at 2014-04-24 15:25:51 +0200
Processing by Opay::PayuController#wrong_authorizationt as HTML
Redirected to http://localhost:3000/
Completed 302 Found in 7ms (ActiveRecord: 0.0ms)


Started GET "/" for 127.0.0.1 at 2014-04-24 15:25:51 +0200
Processing by OrdersController#index as HTML
  Order Load (4.2ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (4.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (64.4ms)
Completed 200 OK in 195ms (Views: 176.1ms | ActiveRecord: 9.3ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:25:52 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:52 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:52 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:52 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:25:52 +0200


Started GET "/orders/1" for 127.0.0.1 at 2014-04-24 15:25:55 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"1"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "1"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YMruHWLUVDTFwjhzBJk3' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.2ms)  begin transaction
  SQL (3.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "YMruHWLUVDTFwjhzBJk3"], ["updated_at", Thu, 24 Apr 2014 13:25:55 UTC +00:00]]
   (1.3ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Lp3pWAAg7Poxhzva7x2B' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["session_id", "Lp3pWAAg7Poxhzva7x2B"], ["updated_at", Thu, 24 Apr 2014 13:25:55 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (35.5ms)
Completed 200 OK in 45ms (Views: 36.4ms | ActiveRecord: 7.2ms)


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:56 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:56 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:56 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:25:56 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:25:56 +0200


Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-04-24 15:25:57 +0200
Processing by Opay::PaypalController#new as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"6UyWqDKrR+zb2JeoY3rG0gbIAKV7yZHCJ2l3g6AiiRE=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "confirm_url"=>"http://localhost:3000/opay/paypal/confirm", "cancel_url"=>"/", "session_id"=>"Lp3pWAAg7Poxhzva7x2B", "amount"=>"10", "x"=>"63", "y"=>"14"}
  Rendered /Users/olownia/dev/gems/opay/app/views/opay/paypal/new.html.erb within layouts/opay/application (8.9ms)
Completed 200 OK in 89ms (Views: 88.6ms | ActiveRecord: 0.0ms)


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:57 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:57 +0200


Started GET "/assets/opay/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:25:57 +0200


Started GET "/assets/opay/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:25:57 +0200


Started GET "/opay/correct_authorization?session_id=Lp3pWAAg7Poxhzva7x2B" for 127.0.0.1 at 2014-04-24 15:25:58 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"Lp3pWAAg7Poxhzva7x2B"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Lp3pWAAg7Poxhzva7x2B' ORDER BY "opay_payments"."id" ASC LIMIT 1
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", 1]]
  Opay::Payment Load (0.5ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "finished" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 1  [["finished", true], ["updated_at", Thu, 24 Apr 2014 13:25:58 UTC +00:00]]
   (0.8ms)  commit transaction
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "orders" SET "finished" = ?, "updated_at" = ? WHERE "orders"."id" = 1  [["finished", true], ["updated_at", Thu, 24 Apr 2014 13:25:58 UTC +00:00]]
   (1.0ms)  commit transaction
Completed 500 Internal Server Error in 21ms

NoMethodError (undefined method `root_path' for #<Opay::PayuController:0x007ff6dda861d8>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:6:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1529530369328220172__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4065094992399331645__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (1.0ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (2.0ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (29.2ms)


Started GET "/opay/correct_authorization?session_id=Lp3pWAAg7Poxhzva7x2B" for 127.0.0.1 at 2014-04-24 15:26:06 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"Lp3pWAAg7Poxhzva7x2B"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Lp3pWAAg7Poxhzva7x2B' ORDER BY "opay_payments"."id" ASC LIMIT 1
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", 1]]
  Opay::Payment Load (0.1ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
   (0.1ms)  begin transaction
   (0.1ms)  commit transaction
   (0.0ms)  begin transaction
   (0.1ms)  commit transaction
Completed 500 Internal Server Error in 64ms

NoMethodError (undefined method `root_path' for #<Opay::PayuController:0x007ff6ddd0d758>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:6:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1529530369328220172__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4065094992399331645__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (4.1ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (26.6ms)


Started GET "/opay/correct_authorization?session_id=Lp3pWAAg7Poxhzva7x2B" for 127.0.0.1 at 2014-04-24 15:26:09 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"Lp3pWAAg7Poxhzva7x2B"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Lp3pWAAg7Poxhzva7x2B' ORDER BY "opay_payments"."id" ASC LIMIT 1
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", 1]]
  Opay::Payment Load (0.1ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
   (0.1ms)  begin transaction
   (0.1ms)  commit transaction
   (0.1ms)  begin transaction
   (0.1ms)  commit transaction
Completed 500 Internal Server Error in 10ms

NoMethodError (undefined method `root_path' for #<Opay::PayuController:0x007ff6ddadf490>):
  /Users/olownia/dev/gems/opay/app/controllers/opay/application_controller.rb:6:in `correct_authorization'
  actionpack (4.0.4) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:189:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rendering.rb:10:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__1529530369328220172__process_action__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/abstract_controller/callbacks.rb:17:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/rescue.rb:29:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `block in instrument'
  activesupport (4.0.4) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
  activesupport (4.0.4) lib/active_support/notifications.rb:159:in `instrument'
  actionpack (4.0.4) lib/action_controller/metal/instrumentation.rb:30:in `process_action'
  actionpack (4.0.4) lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
  activerecord (4.0.4) lib/active_record/railties/controller_runtime.rb:18:in `process_action'
  actionpack (4.0.4) lib/abstract_controller/base.rb:136:in `process'
  actionpack (4.0.4) lib/abstract_controller/rendering.rb:44:in `process'
  actionpack (4.0.4) lib/action_controller/metal.rb:195:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
  actionpack (4.0.4) lib/action_controller/metal.rb:231:in `block in action'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:80:in `dispatch'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:48:in `call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/railtie/configurable.rb:30:in `method_missing'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:71:in `block in call'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `each'
  actionpack (4.0.4) lib/action_dispatch/journey/router.rb:59:in `call'
  actionpack (4.0.4) lib/action_dispatch/routing/route_set.rb:674:in `call'
  rack (1.5.2) lib/rack/etag.rb:23:in `call'
  rack (1.5.2) lib/rack/conditionalget.rb:25:in `call'
  rack (1.5.2) lib/rack/head.rb:11:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/params_parser.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/flash.rb:241:in `call'
  rack (1.5.2) lib/rack/session/abstract/id.rb:225:in `context'
  rack (1.5.2) lib/rack/session/abstract/id.rb:220:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/cookies.rb:486:in `call'
  activerecord (4.0.4) lib/active_record/query_cache.rb:36:in `call'
  activerecord (4.0.4) lib/active_record/connection_adapters/abstract/connection_pool.rb:626:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
  activesupport (4.0.4) lib/active_support/callbacks.rb:373:in `_run__4065094992399331645__call__callbacks'
  activesupport (4.0.4) lib/active_support/callbacks.rb:80:in `run_callbacks'
  actionpack (4.0.4) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/reloader.rb:64:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
  railties (4.0.4) lib/rails/rack/logger.rb:38:in `call_app'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `block in call'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `block in tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:26:in `tagged'
  activesupport (4.0.4) lib/active_support/tagged_logging.rb:68:in `tagged'
  railties (4.0.4) lib/rails/rack/logger.rb:20:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/request_id.rb:21:in `call'
  rack (1.5.2) lib/rack/methodoverride.rb:21:in `call'
  rack (1.5.2) lib/rack/runtime.rb:17:in `call'
  activesupport (4.0.4) lib/active_support/cache/strategy/local_cache.rb:83:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  actionpack (4.0.4) lib/action_dispatch/middleware/static.rb:64:in `call'
  rack (1.5.2) lib/rack/sendfile.rb:112:in `call'
  railties (4.0.4) lib/rails/engine.rb:511:in `call'
  railties (4.0.4) lib/rails/application.rb:97:in `call'
  rack (1.5.2) lib/rack/lock.rb:17:in `call'
  rack (1.5.2) lib/rack/content_length.rb:14:in `call'
  rack (1.5.2) lib/rack/handler/webrick.rb:60:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:138:in `service'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/httpserver.rb:94:in `run'
  /Users/olownia/.rvm/rubies/ruby-2.0.0-p353/lib/ruby/2.0.0/webrick/server.rb:295:in `block in start_thread'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_source.erb (0.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (2.0ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (25.2ms)


Started GET "/opay/correct_authorization?session_id=Lp3pWAAg7Poxhzva7x2B" for 127.0.0.1 at 2014-04-24 15:26:19 +0200
Processing by Opay::PayuController#correct_authorization as HTML
  Parameters: {"session_id"=>"Lp3pWAAg7Poxhzva7x2B"}
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Lp3pWAAg7Poxhzva7x2B' ORDER BY "opay_payments"."id" ASC LIMIT 1
  Order Load (3.9ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", 1]]
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
   (0.1ms)  begin transaction
   (0.1ms)  commit transaction
   (0.1ms)  begin transaction
   (0.1ms)  commit transaction
Redirected to http://localhost:3000/
Completed 302 Found in 87ms (ActiveRecord: 7.7ms)


Started GET "/" for 127.0.0.1 at 2014-04-24 15:26:20 +0200
Processing by OrdersController#index as HTML
  Order Load (0.3ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (1.9ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (9.6ms)
Completed 200 OK in 145ms (Views: 83.2ms | ActiveRecord: 2.1ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-04-24 15:26:20 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-04-24 15:26:20 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-04-24 15:26:20 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-04-24 15:26:20 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-04-24 15:26:20 +0200


Started GET "/" for 127.0.0.1 at 2014-10-07 10:53:50 +0200
Processing by OrdersController#index as HTML
  Order Load (3.7ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (4.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (121.1ms)
Completed 200 OK in 266ms (Views: 247.3ms | ActiveRecord: 9.0ms)


Started GET "/" for 127.0.0.1 at 2014-10-07 10:53:51 +0200
Processing by OrdersController#index as HTML
  Order Load (0.3ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (3.8ms)
Completed 200 OK in 10ms (Views: 9.0ms | ActiveRecord: 0.5ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 10:53:51 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 10:53:51 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 10:53:51 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 10:53:51 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 10:53:51 +0200


Started GET "/orders/new" for 127.0.0.1 at 2014-10-07 10:53:56 +0200
Processing by OrdersController#new as HTML
  Rendered orders/_form.html.erb (24.6ms)
  Rendered orders/new.html.erb within layouts/application (31.6ms)
Completed 200 OK in 41ms (Views: 40.8ms | ActiveRecord: 0.0ms)


Started POST "/orders" for 127.0.0.1 at 2014-10-07 10:54:02 +0200
Processing by OrdersController#create as HTML
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"R4Ab4JrH0PVlNWdSiQ56l6KIQ9GhxVyodHCcE0z/PVs=", "order"=>{"name"=>"nowe", "amount"=>"10"}, "commit"=>"Create Order"}
   (0.2ms)  begin transaction
  SQL (4.5ms)  INSERT INTO "orders" ("amount", "created_at", "name", "updated_at") VALUES (?, ?, ?, ?)  [["amount", "10"], ["created_at", Tue, 07 Oct 2014 08:54:02 UTC +00:00], ["name", "nowe"], ["updated_at", Tue, 07 Oct 2014 08:54:02 UTC +00:00]]
   (1.8ms)  commit transaction
Redirected to http://localhost:3000/orders/2
Completed 302 Found in 15ms (ActiveRecord: 6.5ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 10:54:02 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
   (0.1ms)  begin transaction
  Opay::Payment Load (0.6ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'qbTC6QFQWQd12xS3Qo9X' ORDER BY "opay_payments"."id" ASC LIMIT 1
  SQL (0.7ms)  INSERT INTO "opay_payments" ("amount", "created_at", "payable_id", "payable_type", "provider", "session_id", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?)  [["amount", 10], ["created_at", Tue, 07 Oct 2014 08:54:02 UTC +00:00], ["payable_id", 2], ["payable_type", "Order"], ["provider", "payu"], ["session_id", "qbTC6QFQWQd12xS3Qo9X"], ["updated_at", Tue, 07 Oct 2014 08:54:02 UTC +00:00]]
   (1.2ms)  commit transaction
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'yNRnCbsf6Rh1KqQWtdLT' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.8ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "yNRnCbsf6Rh1KqQWtdLT"], ["updated_at", Tue, 07 Oct 2014 08:54:02 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (117.9ms)
Completed 200 OK in 130ms (Views: 119.3ms | ActiveRecord: 5.3ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:04:13 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'kBzUSFywJVj8Vyqzn7is' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "kBzUSFywJVj8Vyqzn7is"], ["updated_at", Tue, 07 Oct 2014 09:04:14 UTC +00:00]]
   (1.1ms)  commit transaction
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'KeWqxzptZD43pvBQa29m' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.0ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "KeWqxzptZD43pvBQa29m"], ["updated_at", Tue, 07 Oct 2014 09:04:14 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (104.1ms)
Completed 200 OK in 282ms (Views: 245.9ms | ActiveRecord: 13.7ms)


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 11:04:15 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 11:04:15 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 11:04:15 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 11:04:15 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 11:04:15 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:04:19 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'sZUTDPUzkceduedFurny' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "sZUTDPUzkceduedFurny"], ["updated_at", Tue, 07 Oct 2014 09:04:19 UTC +00:00]]
   (4.6ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ycUzMpygXwtyLrbXcef3' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ycUzMpygXwtyLrbXcef3"], ["updated_at", Tue, 07 Oct 2014 09:04:19 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (20.2ms)
Completed 200 OK in 31ms (Views: 21.9ms | ActiveRecord: 7.8ms)


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 11:04:19 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 11:04:19 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 11:04:19 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 11:04:19 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 11:04:19 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:06:49 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'NzpX5ph3PF7sU12gMnVz' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "NzpX5ph3PF7sU12gMnVz"], ["updated_at", Tue, 07 Oct 2014 09:06:49 UTC +00:00]]
   (3.6ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ZjxvzA6Vh1SdWaytU5cu' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ZjxvzA6Vh1SdWaytU5cu"], ["updated_at", Tue, 07 Oct 2014 09:06:49 UTC +00:00]]
   (1.4ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (30.5ms)
Completed 500 Internal Server Error in 34ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuh do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___3648448099710293628_70212289597660'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (62.3ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (80.0ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:07:06 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'KrhtagTpqW5phgqU93q4' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "KrhtagTpqW5phgqU93q4"], ["updated_at", Tue, 07 Oct 2014 09:07:06 UTC +00:00]]
   (4.7ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'wwbtnaipMQienKY9cqM4' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "wwbtnaipMQienKY9cqM4"], ["updated_at", Tue, 07 Oct 2014 09:07:06 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (23.3ms)
Completed 500 Internal Server Error in 28ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___3648448099710293628_70212270635440'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.3ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (13.1ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:54:36 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.4ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.8ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '5fzgEeAgJmgkjy9xypvL' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (3.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "5fzgEeAgJmgkjy9xypvL"], ["updated_at", Tue, 07 Oct 2014 09:54:37 UTC +00:00]]
   (1.3ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'oWaiTnWJrsmEywy7kaqz' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "oWaiTnWJrsmEywy7kaqz"], ["updated_at", Tue, 07 Oct 2014 09:54:37 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (149.0ms)
Completed 500 Internal Server Error in 182ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__234608394932829712_70201537012880'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (17.3ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:56:16 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.0ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Q1c3KGNGd4a3Hz6mmPph' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "Q1c3KGNGd4a3Hz6mmPph"], ["updated_at", Tue, 07 Oct 2014 09:56:17 UTC +00:00]]
   (3.6ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'gMNiQ5cxjvyvrPMq74D1' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "gMNiQ5cxjvyvrPMq74D1"], ["updated_at", Tue, 07 Oct 2014 09:56:17 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (138.6ms)
Completed 500 Internal Server Error in 168ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___625044924949920673_70213300776560'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (17.7ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:56:52 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.1ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ZsJXXc89zooHFCA9XCwd' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ZsJXXc89zooHFCA9XCwd"], ["updated_at", Tue, 07 Oct 2014 09:56:53 UTC +00:00]]
   (3.7ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'zJyDqLARLWc6oXpLwbq1' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "zJyDqLARLWc6oXpLwbq1"], ["updated_at", Tue, 07 Oct 2014 09:56:53 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (149.0ms)
Completed 500 Internal Server Error in 179ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2679219169704143188_70222435250440'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (17.0ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:57:02 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'jr4mTDFvfueUFv2txp9q' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "jr4mTDFvfueUFv2txp9q"], ["updated_at", Tue, 07 Oct 2014 09:57:02 UTC +00:00]]
   (5.1ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'baWVqyHsJD4tY1Ji7EAX' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "baWVqyHsJD4tY1Ji7EAX"], ["updated_at", Tue, 07 Oct 2014 09:57:02 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (25.0ms)
Completed 500 Internal Server Error in 29ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2679219169704143188_70222435250440'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (13.1ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:57:05 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'xog2QYpZt6XiqNa59Yvk' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "xog2QYpZt6XiqNa59Yvk"], ["updated_at", Tue, 07 Oct 2014 09:57:05 UTC +00:00]]
   (1.1ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YBmWWEVa1sdSP2pKh5xR' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "YBmWWEVa1sdSP2pKh5xR"], ["updated_at", Tue, 07 Oct 2014 09:57:05 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (22.4ms)
Completed 500 Internal Server Error in 26ms

ActionView::Template::Error (Empty payment provider):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2679219169704143188_70222435250440'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.6ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (14.5ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:57:17 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (2.9ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '9oSpXst53MHNbnpEdbMb' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "9oSpXst53MHNbnpEdbMb"], ["updated_at", Tue, 07 Oct 2014 09:57:17 UTC +00:00]]
   (4.6ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ctS7oknDxEC1xDaUQRpa' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ctS7oknDxEC1xDaUQRpa"], ["updated_at", Tue, 07 Oct 2014 09:57:17 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (95.2ms)
Completed 500 Internal Server Error in 124ms

ActionView::Template::Error (Empty payment providerr):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___3797791388082251152_70199390605420'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (59.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (77.3ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:57:51 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.1ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'qfeqdk1CNp6B2ssVRDou' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "qfeqdk1CNp6B2ssVRDou"], ["updated_at", Tue, 07 Oct 2014 09:57:52 UTC +00:00]]
   (4.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ZFniQLWvSjZCcv9B4v6U' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.7ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ZFniQLWvSjZCcv9B4v6U"], ["updated_at", Tue, 07 Oct 2014 09:57:52 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (176.3ms)
Completed 500 Internal Server Error in 208ms

ActionView::Template::Error (undefined method `transferuj_form_for' for #<#<Class:0x007fe3be080968>:0x007fe3be088d70>):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___1053118418398182957_70308061900680'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (18.6ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:58:27 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'QNVXQ9SarqJnMBRvDgrP' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "QNVXQ9SarqJnMBRvDgrP"], ["updated_at", Tue, 07 Oct 2014 09:58:27 UTC +00:00]]
   (5.2ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'K2BkKuG5wwh4VrRzHDna' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "K2BkKuG5wwh4VrRzHDna"], ["updated_at", Tue, 07 Oct 2014 09:58:27 UTC +00:00]]
   (2.1ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (125.0ms)
Completed 500 Internal Server Error in 131ms

ActionView::Template::Error (undefined method `transferuj_form_for' for #<#<Class:0x007fe3be080968>:0x007fe3bbfc13f8>):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___1053118418398182957_70308061900680'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (13.7ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:58:40 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (2.9ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'zT6No4NyPGHtfr1raStp' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.3ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "zT6No4NyPGHtfr1raStp"], ["updated_at", Tue, 07 Oct 2014 09:58:40 UTC +00:00]]
   (3.7ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (80.3ms)
Completed 500 Internal Server Error in 111ms

ActionView::Template::Error (uninitialized constant Opay::Helpers::TransferujHelper):
    17: 
    18: 
    19: 
    20: <%= opay_form_for @order, provider: :payu do |f| %>
    21:   <%= f.payment_info first_name: 'Jan', last_name: 'Kowalski', email: 'kowalski@gmail.com', desc: 'Test payment', client_ip: '127.0.0.1' %>
    22:   <%= f.submit :pay_with_payu %>
    23: <% end -%>
  app/views/orders/show.html.erb:20:in `_app_views_orders_show_html_erb___3022902959719190816_70152078602080'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (19.0ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 11:59:34 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.5ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.5ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'kq91q2dBc7p9DM7ZQhks' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "kq91q2dBc7p9DM7ZQhks"], ["updated_at", Tue, 07 Oct 2014 09:59:35 UTC +00:00]]
   (4.6ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Gyf4RJ5pkbVn8XpWLSQg' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.2ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "Gyf4RJ5pkbVn8XpWLSQg"], ["updated_at", Tue, 07 Oct 2014 09:59:35 UTC +00:00]]
   (7.6ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (177.9ms)
Completed 500 Internal Server Error in 210ms

ActionView::Template::Error (undefined method `transferuj_form_for' for #<#<Class:0x007faa1c0888b0>:0x007faa1c090e70>):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___1889290907846547869_70184278150900'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.6ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (16.6ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:00:23 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.7ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.6ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'HkWcB3iyuv6nC91pSst8' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "HkWcB3iyuv6nC91pSst8"], ["updated_at", Tue, 07 Oct 2014 10:00:24 UTC +00:00]]
   (2.7ms)  commit transaction
  Opay::Payment Load (0.7ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'j7z9yH1PtPpRgf7ravXT' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.2ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "j7z9yH1PtPpRgf7ravXT"], ["updated_at", Tue, 07 Oct 2014 10:00:24 UTC +00:00]]
   (0.8ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (199.8ms)
Completed 500 Internal Server Error in 242ms

ActionView::Template::Error (undefined method `transferuj_form_for' for #<#<Class:0x007fb1840189b0>:0x007fb184020db8>):
    27:   <%= f.paypal_submit_tag %>
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__105714131137050030_70200182083540'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.2ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (21.7ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:01:37 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.4ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '6qzaJspJ5dG6zhjqsKes' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (6.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "6qzaJspJ5dG6zhjqsKes"], ["updated_at", Tue, 07 Oct 2014 10:01:38 UTC +00:00]]
   (3.5ms)  commit transaction
  Opay::Payment Load (0.7ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'pWxyyLWTLgU7BydC4yms' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (1.0ms)  begin transaction
  SQL (0.8ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "pWxyyLWTLgU7BydC4yms"], ["updated_at", Tue, 07 Oct 2014 10:01:38 UTC +00:00]]
   (1.1ms)  commit transaction
  Opay::Payment Load (0.7ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'aaLHtqy46CbpyFCENJUj' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.7ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "aaLHtqy46CbpyFCENJUj"], ["updated_at", Tue, 07 Oct 2014 10:01:38 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (114.3ms)
Completed 500 Internal Server Error in 147ms

ActionView::Template::Error (undefined method `payment_description' for #<Order:0x007fdb64dfe2a0>):
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
    34: 
  app/views/orders/show.html.erb:31:in `block in _app_views_orders_show_html_erb__2611298980786074081_70290130184820'
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2611298980786074081_70290130184820'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.1ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (18.0ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:04:56 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'WAoFfz3rjsMtZHPYx7ze' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "WAoFfz3rjsMtZHPYx7ze"], ["updated_at", Tue, 07 Oct 2014 10:04:56 UTC +00:00]]
   (1.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'dLJrr37do49TwkGynybD' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "dLJrr37do49TwkGynybD"], ["updated_at", Tue, 07 Oct 2014 10:04:56 UTC +00:00]]
   (0.8ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'NDbs1ZMeBbC4kBX3yA7H' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "NDbs1ZMeBbC4kBX3yA7H"], ["updated_at", Tue, 07 Oct 2014 10:04:56 UTC +00:00]]
   (1.1ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (22.6ms)
Completed 500 Internal Server Error in 28ms

ActionView::Template::Error (undefined method `payment_description' for #<Order:0x007fdb64f47440>):
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
    34: 
  app/views/orders/show.html.erb:31:in `block in _app_views_orders_show_html_erb__2611298980786074081_70290130184820'
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2611298980786074081_70290130184820'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (23.6ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:05:08 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.5ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'gftpqKQywuruRk79zewR' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "gftpqKQywuruRk79zewR"], ["updated_at", Tue, 07 Oct 2014 10:05:08 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'sbiudTxavYtADpb4Bd7H' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "sbiudTxavYtADpb4Bd7H"], ["updated_at", Tue, 07 Oct 2014 10:05:09 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'uFiKNo5CPfLrro8BYu9x' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "uFiKNo5CPfLrro8BYu9x"], ["updated_at", Tue, 07 Oct 2014 10:05:09 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (99.1ms)
Completed 500 Internal Server Error in 130ms

ActionView::Template::Error (undefined method `first_name' for #<Order:0x007f9bdb1fc740>):
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
    34: 
  app/views/orders/show.html.erb:31:in `block in _app_views_orders_show_html_erb___3314791979378380077_70153687821680'
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb___3314791979378380077_70153687821680'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (17.3ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:06:48 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.9ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.6ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ATZGYASTR4kDryFqcE8M' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (3.0ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ATZGYASTR4kDryFqcE8M"], ["updated_at", Tue, 07 Oct 2014 10:06:49 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YbhdHpTEU25ZhQTd8sHk' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "YbhdHpTEU25ZhQTd8sHk"], ["updated_at", Tue, 07 Oct 2014 10:06:49 UTC +00:00]]
   (2.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'qsewWxcvLsrNsYNLA3g2' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "qsewWxcvLsrNsYNLA3g2"], ["updated_at", Tue, 07 Oct 2014 10:06:49 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (103.7ms)
Completed 500 Internal Server Error in 136ms

ActionView::Template::Error (undefined method `first_name' for #<Order:0x007fd1231b4698>):
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
    34: 
  app/views/orders/show.html.erb:31:in `block in _app_views_orders_show_html_erb__2459721885762289119_70268087135540'
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2459721885762289119_70268087135540'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.2ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (17.8ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:07:09 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.5ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'pvDukhC69p2NStdEnKSm' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "pvDukhC69p2NStdEnKSm"], ["updated_at", Tue, 07 Oct 2014 10:07:09 UTC +00:00]]
   (1.0ms)  commit transaction
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '42WsRhFpuydTz4Vd3akR' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "42WsRhFpuydTz4Vd3akR"], ["updated_at", Tue, 07 Oct 2014 10:07:09 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '3B4z8qWtqzWhsPw2ZazU' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "3B4z8qWtqzWhsPw2ZazU"], ["updated_at", Tue, 07 Oct 2014 10:07:09 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (26.1ms)
Completed 500 Internal Server Error in 31ms

ActionView::Template::Error (no implicit conversion of nil into String):
    28: <% end -%>
    29: 
    30: <%= opay_form_for @order, provider: :transferuj do |f| %>
    31:   <%= f.payment_info  first_name: 'Jan', last_name: 'Kowalski', email: 'kowalski@gmail.com', desc: 'Test payment' %>
    32:   <%= f.submit :pay_with_transferuj %>
    33: <% end -%>
    34: 
  app/views/orders/show.html.erb:31:in `block in _app_views_orders_show_html_erb__2459721885762289119_70268107418360'
  app/views/orders/show.html.erb:30:in `_app_views_orders_show_html_erb__2459721885762289119_70268107418360'


  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms)
  Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (15.0ms)


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:09:43 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.8ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'horzysbzxfLp3zFUjVGd' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "horzysbzxfLp3zFUjVGd"], ["updated_at", Tue, 07 Oct 2014 10:09:44 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'GayCs9NrpapPk3sZskck' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "GayCs9NrpapPk3sZskck"], ["updated_at", Tue, 07 Oct 2014 10:09:44 UTC +00:00]]
   (1.4ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'KkXvvhd3q5VryUpVkfRL' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "KkXvvhd3q5VryUpVkfRL"], ["updated_at", Tue, 07 Oct 2014 10:09:44 UTC +00:00]]
   (1.4ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (99.1ms)
Completed 200 OK in 233ms (Views: 198.8ms | ActiveRecord: 15.6ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:09:44 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:09:44 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:09:44 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:09:44 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:09:44 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:10:29 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'dx6NAmEAMsyXYNXRdifC' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.0ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "dx6NAmEAMsyXYNXRdifC"], ["updated_at", Tue, 07 Oct 2014 10:10:29 UTC +00:00]]
   (5.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'hGqwgFEapuyFrFqe3bGT' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.7ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "hGqwgFEapuyFrFqe3bGT"], ["updated_at", Tue, 07 Oct 2014 10:10:29 UTC +00:00]]
   (1.1ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'D57LAzGKjmJtpPdtJzzR' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "D57LAzGKjmJtpPdtJzzR"], ["updated_at", Tue, 07 Oct 2014 10:10:29 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (40.1ms)
Completed 200 OK in 47ms (Views: 34.2ms | ActiveRecord: 11.1ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:29 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:10:29 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:29 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:10:29 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:29 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:10:42 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '4KpLrqpyJFu2BEyrGDcS' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "4KpLrqpyJFu2BEyrGDcS"], ["updated_at", Tue, 07 Oct 2014 10:10:42 UTC +00:00]]
   (4.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '6TxZKkufyLsr2DHiguq8' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "6TxZKkufyLsr2DHiguq8"], ["updated_at", Tue, 07 Oct 2014 10:10:42 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'xhQ9DoqaYYC7wCQwgfsE' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.4ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "xhQ9DoqaYYC7wCQwgfsE"], ["updated_at", Tue, 07 Oct 2014 10:10:42 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (28.8ms)
Completed 200 OK in 35ms (Views: 24.3ms | ActiveRecord: 9.7ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:10:42 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:42 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:42 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:42 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:10:42 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:10:44 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (2.0ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'TWbqo5afjXwfSjHYgPu4' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "TWbqo5afjXwfSjHYgPu4"], ["updated_at", Tue, 07 Oct 2014 10:10:44 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'uaVZtSMbFD1TvNCSH1qq' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "uaVZtSMbFD1TvNCSH1qq"], ["updated_at", Tue, 07 Oct 2014 10:10:44 UTC +00:00]]
   (3.5ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'L7CsKz7wSWX1HqQHBmAJ' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.9ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "L7CsKz7wSWX1HqQHBmAJ"], ["updated_at", Tue, 07 Oct 2014 10:10:44 UTC +00:00]]
   (1.1ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (116.5ms)
Completed 200 OK in 123ms (Views: 109.9ms | ActiveRecord: 11.3ms)


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:44 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:10:44 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:44 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:10:44 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:10:44 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:12:41 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.5ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ZziULWJcYFSmdNp3BqTm' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (3.2ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "ZziULWJcYFSmdNp3BqTm"], ["updated_at", Tue, 07 Oct 2014 10:12:42 UTC +00:00]]
   (1.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'MZHmxJUQwJRZiK4TRqYw' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "MZHmxJUQwJRZiK4TRqYw"], ["updated_at", Tue, 07 Oct 2014 10:12:42 UTC +00:00]]
   (1.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'qQ1xjxt7DwAQrySCwfsd' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.4ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "qQ1xjxt7DwAQrySCwfsd"], ["updated_at", Tue, 07 Oct 2014 10:12:42 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (153.6ms)
Completed 200 OK in 225ms (Views: 191.4ms | ActiveRecord: 15.5ms)


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:12:42 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:12:42 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:12:42 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:12:42 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:12:42 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:14:28 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.5ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'vGXqFzwGwShQjv4QVPTe' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "vGXqFzwGwShQjv4QVPTe"], ["updated_at", Tue, 07 Oct 2014 10:14:28 UTC +00:00]]
   (3.2ms)  commit transaction
  Opay::Payment Load (0.5ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'DbsPFpJ7qZn9wVzLxT2M' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "DbsPFpJ7qZn9wVzLxT2M"], ["updated_at", Tue, 07 Oct 2014 10:14:28 UTC +00:00]]
   (1.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '1SRdGqRb5RiK3JHytDhr' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "1SRdGqRb5RiK3JHytDhr"], ["updated_at", Tue, 07 Oct 2014 10:14:28 UTC +00:00]]
   (0.9ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (29.3ms)
Completed 200 OK in 45ms (Views: 33.5ms | ActiveRecord: 9.7ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:14:28 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:14:28 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:14:28 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:14:28 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:14:28 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:14:43 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (4.6ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'qxR7qDyUr8qbWfbEhwQv' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "qxR7qDyUr8qbWfbEhwQv"], ["updated_at", Tue, 07 Oct 2014 10:14:43 UTC +00:00]]
   (0.9ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'SbVBNhSqc8fhPiWpxA3R' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "SbVBNhSqc8fhPiWpxA3R"], ["updated_at", Tue, 07 Oct 2014 10:14:43 UTC +00:00]]
   (1.4ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'xM4hsmsorxM6qQ7dFLbw' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "xM4hsmsorxM6qQ7dFLbw"], ["updated_at", Tue, 07 Oct 2014 10:14:43 UTC +00:00]]
   (1.2ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (100.4ms)
Completed 200 OK in 224ms (Views: 189.0ms | ActiveRecord: 15.9ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:14:43 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:14:43 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:14:43 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:14:43 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:14:43 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:15:16 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.3ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (3.1ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YzYzmazPShSazJZqzrJK' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (2.1ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "YzYzmazPShSazJZqzrJK"], ["updated_at", Tue, 07 Oct 2014 10:15:16 UTC +00:00]]
   (3.6ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '3C7xqDxKBN9mxwhyZq6S' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.0ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "3C7xqDxKBN9mxwhyZq6S"], ["updated_at", Tue, 07 Oct 2014 10:15:16 UTC +00:00]]
   (2.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'AhvvAhpS1Rc9KxQBWyYv' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "AhvvAhpS1Rc9KxQBWyYv"], ["updated_at", Tue, 07 Oct 2014 10:15:16 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (96.4ms)
Completed 200 OK in 207ms (Views: 172.6ms | ActiveRecord: 17.3ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:15:16 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:15:16 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:15:16 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:15:16 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:15:16 +0200


Started GET "/" for 127.0.0.1 at 2014-10-07 12:16:23 +0200
Processing by OrdersController#index as HTML
  Order Load (0.3ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (7.3ms)
Completed 200 OK in 17ms (Views: 15.8ms | ActiveRecord: 0.8ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:16:23 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:23 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:23 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:23 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:16:23 +0200


Started GET "/" for 127.0.0.1 at 2014-10-07 12:16:30 +0200
Processing by OrdersController#index as HTML
  Order Load (0.2ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (8.6ms)
Completed 200 OK in 15ms (Views: 13.8ms | ActiveRecord: 0.7ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:16:30 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:30 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:30 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:30 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:16:30 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:16:33 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'h2ero1shjZU2vY1c4q4t' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.6ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "h2ero1shjZU2vY1c4q4t"], ["updated_at", Tue, 07 Oct 2014 10:16:33 UTC +00:00]]
   (1.7ms)  commit transaction
  Opay::Payment Load (0.4ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'qjE5kmLkrbSeRFY5Sz9z' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "qjE5kmLkrbSeRFY5Sz9z"], ["updated_at", Tue, 07 Oct 2014 10:16:33 UTC +00:00]]
   (1.7ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'PTcfFXb1azyHxyjMtNt6' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "PTcfFXb1azyHxyjMtNt6"], ["updated_at", Tue, 07 Oct 2014 10:16:33 UTC +00:00]]
   (1.1ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (29.9ms)
Completed 200 OK in 39ms (Views: 28.6ms | ActiveRecord: 8.8ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:16:34 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:34 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:34 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:16:34 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:16:34 +0200


Started GET "/" for 127.0.0.1 at 2014-10-07 12:16:37 +0200
Processing by OrdersController#index as HTML
  Order Load (0.3ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (5.1ms)
Completed 200 OK in 10ms (Views: 9.4ms | ActiveRecord: 0.7ms)


Started GET "/" for 127.0.0.1 at 2014-10-07 12:17:16 +0200
Processing by OrdersController#index as HTML
  Order Load (0.3ms)  SELECT "orders".* FROM "orders"
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 1], ["payable_type", "Order"]]
  Opay::Payment Load (0.2ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Rendered orders/index.html.erb within layouts/application (13.1ms)
Completed 200 OK in 19ms (Views: 17.8ms | ActiveRecord: 0.7ms)


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:17:16 +0200


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:17:16 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:17:16 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:17:16 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:17:16 +0200


Started GET "/orders/2" for 127.0.0.1 at 2014-10-07 12:17:18 +0200
Processing by OrdersController#show as HTML
  Parameters: {"id"=>"2"}
  Order Load (0.2ms)  SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1  [["id", "2"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1  [["payable_id", 2], ["payable_type", "Order"]]
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'RvqkBg47SEw7qNS7hUr9' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.7ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "RvqkBg47SEw7qNS7hUr9"], ["updated_at", Tue, 07 Oct 2014 10:17:18 UTC +00:00]]
   (1.0ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'xSczNPU6chusBL5iGGB3' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (0.5ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "xSczNPU6chusBL5iGGB3"], ["updated_at", Tue, 07 Oct 2014 10:17:18 UTC +00:00]]
   (1.5ms)  commit transaction
  Opay::Payment Load (0.3ms)  SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'H2Gx14NewLbCYdRLcHqw' ORDER BY "opay_payments"."id" ASC LIMIT 1
   (0.1ms)  begin transaction
  SQL (1.3ms)  UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 2  [["session_id", "H2Gx14NewLbCYdRLcHqw"], ["updated_at", Tue, 07 Oct 2014 10:17:18 UTC +00:00]]
   (1.0ms)  commit transaction
  Rendered orders/show.html.erb within layouts/application (41.9ms)
Completed 200 OK in 50ms (Views: 40.9ms | ActiveRecord: 7.6ms)


Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-10-07 12:17:18 +0200


Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-10-07 12:17:18 +0200


Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-10-07 12:17:18 +0200


Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-10-07 12:17:18 +0200


Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-10-07 12:17:19 +0200