spec/dummy/log/development.log in opay-1.2.0 vs spec/dummy/log/development.log in opay-1.2.1
- old
+ new
@@ -10054,5 +10054,1470 @@
Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-25 16:00:07 +0100
Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-25 16:00:07 +0100
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 11:51:50 +0100
+Processing by OrdersController#index as HTML
+ [1m[36mOrder Load (2.1ms)[0m [1mSELECT "orders".* FROM "orders"[0m
+ [1m[35mOpay::Payment Load (2.8ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (54.6ms)
+Completed 200 OK in 153ms (Views: 140.4ms | ActiveRecord: 6.8ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 11:51:50 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 11:51:50 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 11:51:50 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 11:51:50 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 11:51:50 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 11:51:52 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.6ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ectGK1vk561D9v3i16uo' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.5ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "ectGK1vk561D9v3i16uo"], ["updated_at", Wed, 26 Mar 2014 10:51:52 UTC +00:00]]
+ [1m[35m (0.9ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '39t2nMrykAozWBy9pNZJ' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "39t2nMrykAozWBy9pNZJ"], ["updated_at", Wed, 26 Mar 2014 10:51:52 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (23.7ms)
+Completed 200 OK in 29ms (Views: 23.3ms | ActiveRecord: 4.9ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 11:51:52 +0100
+
+
+Started GET "/fsdlj" for 127.0.0.1 at 2014-03-26 11:55:39 +0100
+
+ActionController::RoutingError (No route matches [GET] "/fsdlj"):
+ actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:21: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/_trace.erb (1.1ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (1.7ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.3ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_table.html.erb (5.3ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (30.5ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 11:57:47 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'NPZVs8JbxK3QdEfpqsEm' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "NPZVs8JbxK3QdEfpqsEm"], ["updated_at", Wed, 26 Mar 2014 10:57:47 UTC +00:00]]
+ [1m[35m (0.9ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Qxb4Pzaw2pLDz63pW6iN' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "Qxb4Pzaw2pLDz63pW6iN"], ["updated_at", Wed, 26 Mar 2014 10:57:47 UTC +00:00]]
+ [1m[35m (0.9ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (11.2ms)
+Completed 200 OK in 17ms (Views: 12.3ms | ActiveRecord: 3.4ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 11:57:47 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 11:57:47 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 11:57:47 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 11:57:47 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 11:57:47 +0100
+
+
+Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-03-26 11:57:48 +0100
+Processing by Opay::PaypalController#new as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "session_id"=>"Qxb4Pzaw2pLDz63pW6iN", "amount"=>"123", "x"=>"74", "y"=>"17"}
+ [1m[36mOpay::Payment Load (0.4ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Qxb4Pzaw2pLDz63pW6iN' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.5ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "EC-6FV695887K7267158"], ["updated_at", Wed, 26 Mar 2014 10:57:51 UTC +00:00]]
+ [1m[35m (2.2ms)[0m commit transaction
+Redirected to https://www.sandbox.paypal.com/cgi-bin/webscr?cmd=_express-checkout&token=EC-6FV695887K7267158
+Completed 302 Found in 2705ms (ActiveRecord: 3.2ms)
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 11:58:37 +0100
+Processing by OrdersController#index as HTML
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders"[0m
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (13.6ms)
+Completed 200 OK in 18ms (Views: 16.6ms | ActiveRecord: 1.4ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 11:58:37 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 11:58:37 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 11:58:37 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 11:58:37 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 11:58:37 +0100
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 12:00:50 +0100
+Processing by OrdersController#index as HTML
+ [1m[36mOrder Load (0.6ms)[0m [1mSELECT "orders".* FROM "orders"[0m
+ [1m[35mOpay::Payment Load (0.6ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (77.7ms)
+Completed 200 OK in 85ms (Views: 78.7ms | ActiveRecord: 3.0ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:00:51 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:00:51 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:00:51 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:00:51 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:00:51 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:00:52 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'sEqQD29QXNa1wxcYEw5q' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.5ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "sEqQD29QXNa1wxcYEw5q"], ["updated_at", Wed, 26 Mar 2014 11:00:52 UTC +00:00]]
+ [1m[35m (1.0ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'K21dSeGixFsxDy2QGJy5' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "K21dSeGixFsxDy2QGJy5"], ["updated_at", Wed, 26 Mar 2014 11:00:52 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (15.1ms)
+Completed 500 Internal Server Error in 19ms
+
+ActionView::Template::Error (undefined method `new_paypal_payment_path' for #<Module:0x007fe155b48c58>):
+ 22: <%= f.submit :pay_with_payu %>
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb__2387074991247083223_70302889808380'
+
+
+ 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.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.0ms)
+ 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 (11.7ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:03:48 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (3.8ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'UPUeb3W2WbxwPVh3vXTv' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (2.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "UPUeb3W2WbxwPVh3vXTv"], ["updated_at", Wed, 26 Mar 2014 11:03:48 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '8QpptSrJpat123s2v9zG' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "8QpptSrJpat123s2v9zG"], ["updated_at", Wed, 26 Mar 2014 11:03:48 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (126.7ms)
+Completed 500 Internal Server Error in 150ms
+
+ActionView::Template::Error (undefined local variable or method `opay' for #<Opay::FormBuilder:0x007f85d77a41f8>):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb___4440398349873022870_70106416350420'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb___4440398349873022870_70106416350420'
+
+
+ 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.0ms)
+ 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.2ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:06:10 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.4ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'QxrD8hkBYtqdHs3Byp11' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.8ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "QxrD8hkBYtqdHs3Byp11"], ["updated_at", Wed, 26 Mar 2014 11:06:10 UTC +00:00]]
+ [1m[35m (2.5ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'pwCPaJhKpwV9fWcCxKED' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "pwCPaJhKpwV9fWcCxKED"], ["updated_at", Wed, 26 Mar 2014 11:06:10 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (110.0ms)
+Completed 200 OK in 165ms (Views: 139.1ms | ActiveRecord: 10.1ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:06:11 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:06:11 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:11 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:11 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:11 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:06:28 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YZC82frMvE5oiP1bSgSd' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "YZC82frMvE5oiP1bSgSd"], ["updated_at", Wed, 26 Mar 2014 11:06:28 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YCM24oCNNpDmycbDxavs' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "YCM24oCNNpDmycbDxavs"], ["updated_at", Wed, 26 Mar 2014 11:06:28 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (10.1ms)
+Completed 200 OK in 15ms (Views: 10.2ms | ActiveRecord: 3.2ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:06:28 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:28 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:28 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:06:28 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:28 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:06:42 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'evNxYQgrhYsMCYy4oive' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "evNxYQgrhYsMCYy4oive"], ["updated_at", Wed, 26 Mar 2014 11:06:42 UTC +00:00]]
+ [1m[35m (2.8ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'EknqCvHsDgH8gPGawCNT' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "EknqCvHsDgH8gPGawCNT"], ["updated_at", Wed, 26 Mar 2014 11:06:42 UTC +00:00]]
+ [1m[35m (1.1ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (73.1ms)
+Completed 200 OK in 148ms (Views: 126.5ms | ActiveRecord: 10.2ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:06:42 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:06:42 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:42 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:42 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:06:42 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:07:45 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'FUVXsTmsxhZ9Pp8tcnkv' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.5ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "FUVXsTmsxhZ9Pp8tcnkv"], ["updated_at", Wed, 26 Mar 2014 11:07:45 UTC +00:00]]
+ [1m[35m (3.3ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Y7abN43pS7kUTxvy2xjT' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "Y7abN43pS7kUTxvy2xjT"], ["updated_at", Wed, 26 Mar 2014 11:07:45 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (123.4ms)
+Completed 500 Internal Server Error in 143ms
+
+ActionView::Template::Error (undefined local variable or method `opay' for #<Opay::FormBuilder:0x007ff357ed7ec8>):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb__4496842588475430743_70341562792660'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb__4496842588475430743_70341562792660'
+
+
+ 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.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 (1.0ms)
+ 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 (11.6ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:08:28 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'RYPtGnP4zRe1CWRqxzPZ' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "RYPtGnP4zRe1CWRqxzPZ"], ["updated_at", Wed, 26 Mar 2014 11:08:28 UTC +00:00]]
+ [1m[35m (2.5ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Ap7PckmDxHQSHonzpufs' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "Ap7PckmDxHQSHonzpufs"], ["updated_at", Wed, 26 Mar 2014 11:08:28 UTC +00:00]]
+ [1m[35m (0.9ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (68.2ms)
+Completed 500 Internal Server Error in 88ms
+
+ActionView::Template::Error (nil is not a symbol):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb___1094987308371887666_70241488149280'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb___1094987308371887666_70241488149280'
+
+
+ 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.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.1ms)
+ 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 (10.9ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:09:47 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ob9CwvaPz5EXQiFoe9Jx' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.6ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "ob9CwvaPz5EXQiFoe9Jx"], ["updated_at", Wed, 26 Mar 2014 11:09:47 UTC +00:00]]
+ [1m[35m (2.6ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'yFmtR7XQTJZzbQH2y4ud' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.6ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "yFmtR7XQTJZzbQH2y4ud"], ["updated_at", Wed, 26 Mar 2014 11:09:47 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (88.2ms)
+Completed 500 Internal Server Error in 108ms
+
+ActionView::Template::Error (undefined method `cancel_payment_path' for #<ActionDispatch::Routing::RoutesProxy:0x007f834e3e1bf0>):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb___4298322347377076017_70100963384100'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb___4298322347377076017_70100963384100'
+
+
+ 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.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 (1.0ms)
+ 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.5ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:11:42 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.3ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.8ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'XrRdL2NQJiGXYbqeJQ2H' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.6ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "XrRdL2NQJiGXYbqeJQ2H"], ["updated_at", Wed, 26 Mar 2014 11:11:43 UTC +00:00]]
+ [1m[35m (2.3ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'PDcjyTurbj2yesHHcc57' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "PDcjyTurbj2yesHHcc57"], ["updated_at", Wed, 26 Mar 2014 11:11:43 UTC +00:00]]
+ [1m[35m (0.6ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (75.5ms)
+Completed 500 Internal Server Error in 97ms
+
+ActionView::Template::Error (undefined method `cancel_payment_path' for #<ActionDispatch::Routing::RoutesProxy:0x007f842f991208>):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb___3713253799349200231_70102849587940'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb___3713253799349200231_70102849587940'
+
+
+ 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.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.1ms)
+ 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 (11.3ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:12:13 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (1.9ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'kYtiQhhTFBkHAxDqvutk' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "kYtiQhhTFBkHAxDqvutk"], ["updated_at", Wed, 26 Mar 2014 11:12:14 UTC +00:00]]
+ [1m[35m (2.2ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Kb3PsrzxC2qxwk23h8ox' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "Kb3PsrzxC2qxwk23h8ox"], ["updated_at", Wed, 26 Mar 2014 11:12:14 UTC +00:00]]
+ [1m[35m (1.0ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (69.6ms)
+Completed 200 OK in 147ms (Views: 126.5ms | ActiveRecord: 9.3ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:12:14 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:12:14 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:12:14 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:12:14 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:12:14 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:13:48 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = '3Q3P3HxfUNGH2SA3fend' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "3Q3P3HxfUNGH2SA3fend"], ["updated_at", Wed, 26 Mar 2014 11:13:48 UTC +00:00]]
+ [1m[35m (2.3ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'NtDbcDb4yi4rWS94QDkw' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "NtDbcDb4yi4rWS94QDkw"], ["updated_at", Wed, 26 Mar 2014 11:13:48 UTC +00:00]]
+ [1m[35m (0.9ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (67.0ms)
+Completed 500 Internal Server Error in 87ms
+
+ActionView::Template::Error (nil is not a symbol):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb___989983410501932168_70156464301500'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb___989983410501932168_70156464301500'
+
+
+ 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.4ms)
+ 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.1ms)
+ 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 (11.5ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:14:24 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.5ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'mqG5kiu4KoJ4FgThQPqZ' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.5ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "mqG5kiu4KoJ4FgThQPqZ"], ["updated_at", Wed, 26 Mar 2014 11:14:24 UTC +00:00]]
+ [1m[35m (2.6ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'YpcK71UZMAQednCpG1Q6' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "YpcK71UZMAQednCpG1Q6"], ["updated_at", Wed, 26 Mar 2014 11:14:24 UTC +00:00]]
+ [1m[35m (1.0ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (69.8ms)
+Completed 200 OK in 147ms (Views: 124.2ms | ActiveRecord: 10.6ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:14:24 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:14:24 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:14:24 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:14:24 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:14:24 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:16:48 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.1ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ZqFU2Hy6NpqpsehHdQ7x' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "ZqFU2Hy6NpqpsehHdQ7x"], ["updated_at", Wed, 26 Mar 2014 11:16:48 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'Gbdf2JFhtr3qxYAi4X2o' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.0ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "Gbdf2JFhtr3qxYAi4X2o"], ["updated_at", Wed, 26 Mar 2014 11:16:48 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (10.6ms)
+Completed 200 OK in 15ms (Views: 10.6ms | ActiveRecord: 3.1ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:16:48 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:16:48 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:16:48 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:16:48 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:16:48 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:17:55 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (4.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'D98JfrbfWAXa2YX3WaTE' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "D98JfrbfWAXa2YX3WaTE"], ["updated_at", Wed, 26 Mar 2014 11:17:55 UTC +00:00]]
+ [1m[35m (3.0ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'abw7meHV9zyohnj7nouG' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "abw7meHV9zyohnj7nouG"], ["updated_at", Wed, 26 Mar 2014 11:17:55 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (77.1ms)
+Completed 200 OK in 156ms (Views: 131.1ms | ActiveRecord: 12.3ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:17:56 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:17:56 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:17:56 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:17:56 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:17:56 +0100
+
+
+Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-03-26 12:17:57 +0100
+Processing by Opay::PaypalController#new as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "create_url"=>"http://localhost:3000/opay/paypal/new", "cancel_url"=>"http://localhost:3000/cancel", "session_id"=>"abw7meHV9zyohnj7nouG", "amount"=>"123", "x"=>"78", "y"=>"8"}
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'abw7meHV9zyohnj7nouG' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "EC-9HU13651EU692490R"], ["updated_at", Wed, 26 Mar 2014 11:17:59 UTC +00:00]]
+ [1m[35m (2.8ms)[0m commit transaction
+Redirected to https://www.sandbox.paypal.com/cgi-bin/webscr?cmd=_express-checkout&token=EC-9HU13651EU692490R
+Completed 302 Found in 1674ms (ActiveRecord: 3.5ms)
+
+
+Started GET "/opay/paypal/new?token=EC-9HU13651EU692490R&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:18:23 +0100
+
+ActionController::RoutingError (No route matches [GET] "/opay/paypal/new"):
+ actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:21: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/_trace.erb (1.2ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (1.4ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.4ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_table.html.erb (6.6ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (34.4ms)
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 12:20:01 +0100
+Processing by OrdersController#index as HTML
+ [1m[36mOrder Load (1.7ms)[0m [1mSELECT "orders".* FROM "orders"[0m
+ [1m[35mOpay::Payment Load (3.3ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (53.2ms)
+Completed 200 OK in 138ms (Views: 126.0ms | ActiveRecord: 7.3ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:20:01 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:20:01 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:20:01 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:20:01 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:20:01 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:20:04 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'aVUmptmc325gzoKuPMNF' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "aVUmptmc325gzoKuPMNF"], ["updated_at", Wed, 26 Mar 2014 11:20:04 UTC +00:00]]
+ [1m[35m (2.8ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'FGpsozmMc8FbP9c2ARz5' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "FGpsozmMc8FbP9c2ARz5"], ["updated_at", Wed, 26 Mar 2014 11:20:04 UTC +00:00]]
+ [1m[35m (0.9ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (23.5ms)
+Completed 200 OK in 29ms (Views: 21.3ms | ActiveRecord: 6.3ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:20:04 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:20:04 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:20:04 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:20:04 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:20:04 +0100
+
+
+Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-03-26 12:20:05 +0100
+Processing by Opay::PaypalController#new as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "create_url"=>"http://localhost:3000/opay/paypal/new", "cancel_url"=>"http://localhost:3000/cancel", "session_id"=>"FGpsozmMc8FbP9c2ARz5", "amount"=>"123", "x"=>"57", "y"=>"16"}
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'FGpsozmMc8FbP9c2ARz5' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "EC-94M36163V0215214P"], ["updated_at", Wed, 26 Mar 2014 11:20:08 UTC +00:00]]
+ [1m[35m (3.1ms)[0m commit transaction
+Redirected to https://www.sandbox.paypal.com/cgi-bin/webscr?cmd=_express-checkout&token=EC-94M36163V0215214P
+Completed 302 Found in 2484ms (ActiveRecord: 3.8ms)
+
+
+Started GET "/opay/paypal/new?token=EC-94M36163V0215214P&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:20:24 +0100
+
+ActionController::RoutingError (No route matches [GET] "/opay/paypal/new"):
+ actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:21: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/_trace.erb (1.2ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (1.4ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.3ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_table.html.erb (4.7ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (31.4ms)
+
+
+Started GET "/opay/paypal/new?token=EC-94M36163V0215214P&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:21:10 +0100
+
+ActionController::RoutingError (No route matches [GET] "/opay/paypal/new"):
+ actionpack (4.0.4) lib/action_dispatch/middleware/debug_exceptions.rb:21: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/_trace.erb (1.1ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (4.6ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_route.html.erb (0.4ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/routes/_table.html.erb (4.0ms)
+ Rendered /Users/olownia/.rvm/gems/ruby-2.0.0-p353@opay/gems/actionpack-4.0.4/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (35.1ms)
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 12:21:12 +0100
+Processing by OrdersController#index as HTML
+ [1m[36mOrder Load (1.4ms)[0m [1mSELECT "orders".* FROM "orders"[0m
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (84.0ms)
+Completed 200 OK in 162ms (Views: 152.4ms | ActiveRecord: 5.2ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:21:13 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:21:13 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:21:13 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:21:13 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:21:13 +0100
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:21:14 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.3ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'DDriemy4YsLezjgPoeAf' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.5ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "DDriemy4YsLezjgPoeAf"], ["updated_at", Wed, 26 Mar 2014 11:21:14 UTC +00:00]]
+ [1m[35m (2.4ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'w5eJSP27N7YY8yboc6Tb' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "w5eJSP27N7YY8yboc6Tb"], ["updated_at", Wed, 26 Mar 2014 11:21:14 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (27.4ms)
+Completed 500 Internal Server Error in 31ms
+
+ActionView::Template::Error (undefined method `paypal_create_payment_url' for #<ActionDispatch::Routing::RoutesProxy:0x007fc6fc6fe198>):
+ 23: <% end -%>
+ 24:
+ 25: <%= paypal_form_for(@order) do |f| %>
+ 26: <%= f.paypal_payment_info desc: 'Test payment', client_ip: '127.0.0.1' %>
+ 27: <%= f.paypal_submit_tag %>
+ 28: <% end -%>
+ 29:
+ app/views/orders/show.html.erb:26:in `block in _app_views_orders_show_html_erb__121614291019874798_70246307471620'
+ app/views/orders/show.html.erb:25:in `_app_views_orders_show_html_erb__121614291019874798_70246307471620'
+
+
+ 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.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.0ms)
+ 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 (10.0ms)
+
+
+Started GET "/orders/11" for 127.0.0.1 at 2014-03-26 12:22:53 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"11"}
+ [1m[36mOrder Load (0.4ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "11"]]
+ [1m[35mOpay::Payment Load (2.0ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'ocNybxianBzwy6iCTTCy' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "ocNybxianBzwy6iCTTCy"], ["updated_at", Wed, 26 Mar 2014 11:22:54 UTC +00:00]]
+ [1m[35m (3.0ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'm87anX6m4wxMsdCi54rp' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "m87anX6m4wxMsdCi54rp"], ["updated_at", Wed, 26 Mar 2014 11:22:54 UTC +00:00]]
+ [1m[35m (1.0ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (105.4ms)
+Completed 200 OK in 148ms (Views: 122.0ms | ActiveRecord: 10.7ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:22:54 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:22:54 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:22:54 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:22:54 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:22:54 +0100
+
+
+Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-03-26 12:22:56 +0100
+Processing by Opay::PaypalController#new as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "confirm_url"=>"http://localhost:3000/opay/paypal/confirm", "cancel_url"=>"http://localhost:3000/cancel", "session_id"=>"m87anX6m4wxMsdCi54rp", "amount"=>"123", "x"=>"72", "y"=>"15"}
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'm87anX6m4wxMsdCi54rp' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["session_id", "EC-0JB44150003482301"], ["updated_at", Wed, 26 Mar 2014 11:22:58 UTC +00:00]]
+ [1m[35m (2.3ms)[0m commit transaction
+Redirected to https://www.sandbox.paypal.com/cgi-bin/webscr?cmd=_express-checkout&token=EC-0JB44150003482301
+Completed 302 Found in 2479ms (ActiveRecord: 3.0ms)
+
+
+Started GET "/opay/paypal/confirm?token=EC-0JB44150003482301&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:23:15 +0100
+
+AbstractController::ActionNotFound (The action 'confirm' could not be found for Opay::PaypalController):
+ actionpack (4.0.4) lib/abstract_controller/base.rb:131: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__1093271326943730298__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/unknown_action.erb within rescues/layout (0.5ms)
+
+
+Started GET "/opay/paypal/confirm?token=EC-0JB44150003482301&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:23:25 +0100
+
+AbstractController::ActionNotFound (The action 'confirm' could not be found for Opay::PaypalController):
+ actionpack (4.0.4) lib/abstract_controller/base.rb:131: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__1093271326943730298__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/unknown_action.erb within rescues/layout (0.6ms)
+
+
+Started GET "/opay/paypal/confirm?token=EC-0JB44150003482301&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:23:26 +0100
+
+AbstractController::ActionNotFound (The action 'confirm' could not be found for Opay::PaypalController):
+ actionpack (4.0.4) lib/abstract_controller/base.rb:131: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__1093271326943730298__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/unknown_action.erb within rescues/layout (0.4ms)
+
+
+Started GET "/opay/paypal/confirm?token=EC-0JB44150003482301&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:23:35 +0100
+Processing by Opay::PaypalController#confirm as HTML
+ Parameters: {"token"=>"EC-0JB44150003482301", "PayerID"=>"7RJPMT48ZEAZ8"}
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'EC-0JB44150003482301' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35mOrder Load (2.0ms)[0m SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1 [["id", 11]]
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (1.3ms)[0m [1mUPDATE "opay_payments" SET "finished" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 11[0m [["finished", true], ["updated_at", Wed, 26 Mar 2014 11:23:39 UTC +00:00]]
+ [1m[35m (2.1ms)[0m commit transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35mSQL (0.4ms)[0m UPDATE "orders" SET "finished" = ?, "updated_at" = ? WHERE "orders"."id" = 11 [["finished", true], ["updated_at", Wed, 26 Mar 2014 11:23:39 UTC +00:00]]
+ [1m[36m (0.9ms)[0m [1mcommit transaction[0m
+Redirected to http://localhost:3000/
+Completed 302 Found in 4107ms (ActiveRecord: 9.0ms)
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 12:23:39 +0100
+Processing by OrdersController#index as HTML
+ [1m[35mOrder Load (0.2ms)[0m SELECT "orders".* FROM "orders"
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 11], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (16.1ms)
+Completed 200 OK in 85ms (Views: 82.5ms | ActiveRecord: 1.7ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:23:39 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:23:39 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:39 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:40 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:40 +0100
+
+
+Started GET "/orders/new" for 127.0.0.1 at 2014-03-26 12:23:43 +0100
+Processing by OrdersController#new as HTML
+ Rendered orders/_form.html.erb (9.8ms)
+ Rendered orders/new.html.erb within layouts/application (13.4ms)
+Completed 200 OK in 20ms (Views: 19.2ms | ActiveRecord: 0.0ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:23:43 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:23:43 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:43 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:43 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:43 +0100
+
+
+Started POST "/orders" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+Processing by OrdersController#create as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "order"=>{"name"=>"odfssfd", "amount"=>"3455"}, "commit"=>"Create Order"}
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.6ms)[0m [1mINSERT INTO "orders" ("amount", "created_at", "name", "updated_at") VALUES (?, ?, ?, ?)[0m [["amount", "3455"], ["created_at", Wed, 26 Mar 2014 11:23:56 UTC +00:00], ["name", "odfssfd"], ["updated_at", Wed, 26 Mar 2014 11:23:56 UTC +00:00]]
+ [1m[35m (0.8ms)[0m commit transaction
+Redirected to http://localhost:3000/orders/12
+Completed 302 Found in 6ms (ActiveRecord: 1.4ms)
+
+
+Started GET "/orders/12" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"12"}
+ [1m[36mOrder Load (0.1ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", "12"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 12], ["payable_type", "Order"]]
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'DWm6bxpFxTRkJ8LimdsF' ORDER BY "opay_payments"."id" ASC LIMIT 1
+ [1m[36mSQL (0.5ms)[0m [1mINSERT INTO "opay_payments" ("amount", "created_at", "payable_id", "payable_type", "provider", "session_id", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?)[0m [["amount", 3455], ["created_at", Wed, 26 Mar 2014 11:23:56 UTC +00:00], ["payable_id", 12], ["payable_type", "Order"], ["provider", "payu"], ["session_id", "DWm6bxpFxTRkJ8LimdsF"], ["updated_at", Wed, 26 Mar 2014 11:23:56 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'KhUazrzPDSPeQ9LnUV4t' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 12[0m [["session_id", "KhUazrzPDSPeQ9LnUV4t"], ["updated_at", Wed, 26 Mar 2014 11:23:56 UTC +00:00]]
+ [1m[35m (0.7ms)[0m commit transaction
+ Rendered orders/show.html.erb within layouts/application (16.8ms)
+Completed 200 OK in 22ms (Views: 17.9ms | ActiveRecord: 3.1ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:23:56 +0100
+
+
+Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-03-26 12:23:57 +0100
+Processing by Opay::PaypalController#new as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "confirm_url"=>"http://localhost:3000/opay/paypal/confirm", "cancel_url"=>"http://localhost:3000/cancel", "session_id"=>"KhUazrzPDSPeQ9LnUV4t", "amount"=>"3455", "x"=>"65", "y"=>"12"}
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'KhUazrzPDSPeQ9LnUV4t' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 12[0m [["session_id", "EC-9VJ616047K511440U"], ["updated_at", Wed, 26 Mar 2014 11:23:58 UTC +00:00]]
+ [1m[35m (2.1ms)[0m commit transaction
+Redirected to https://www.sandbox.paypal.com/cgi-bin/webscr?cmd=_express-checkout&token=EC-9VJ616047K511440U
+Completed 302 Found in 1234ms (ActiveRecord: 2.8ms)
+
+
+Started GET "/opay/paypal/confirm?token=EC-9VJ616047K511440U&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:24:25 +0100
+Processing by Opay::PaypalController#confirm as HTML
+ Parameters: {"token"=>"EC-9VJ616047K511440U", "PayerID"=>"7RJPMT48ZEAZ8"}
+ [1m[36mOpay::Payment Load (0.3ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'EC-9VJ616047K511440U' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35mOrder Load (0.2ms)[0m SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1 [["id", 12]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 12], ["payable_type", "Order"]]
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.4ms)[0m [1mUPDATE "opay_payments" SET "finished" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 12[0m [["finished", true], ["updated_at", Wed, 26 Mar 2014 11:24:29 UTC +00:00]]
+ [1m[35m (2.8ms)[0m commit transaction
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35mSQL (0.4ms)[0m UPDATE "orders" SET "finished" = ?, "updated_at" = ? WHERE "orders"."id" = 12 [["finished", true], ["updated_at", Wed, 26 Mar 2014 11:24:29 UTC +00:00]]
+ [1m[36m (0.9ms)[0m [1mcommit transaction[0m
+Redirected to http://localhost:3000/
+Completed 302 Found in 3331ms (ActiveRecord: 5.3ms)
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 12:24:29 +0100
+Processing by OrdersController#index as HTML
+ [1m[35mOrder Load (0.2ms)[0m SELECT "orders".* FROM "orders"
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 12], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (11.8ms)
+Completed 200 OK in 15ms (Views: 14.0ms | ActiveRecord: 1.2ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:24:29 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:29 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:29 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:24:29 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:29 +0100
+
+
+Started GET "/orders/new" for 127.0.0.1 at 2014-03-26 12:24:32 +0100
+Processing by OrdersController#new as HTML
+ Rendered orders/_form.html.erb (3.2ms)
+ Rendered orders/new.html.erb within layouts/application (4.2ms)
+Completed 200 OK in 8ms (Views: 7.2ms | ActiveRecord: 0.0ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:24:32 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:32 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:24:32 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:32 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:32 +0100
+
+
+Started POST "/orders" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+Processing by OrdersController#create as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "order"=>{"name"=>"dfsfsd", "amount"=>"100"}, "commit"=>"Create Order"}
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35mSQL (0.5ms)[0m INSERT INTO "orders" ("amount", "created_at", "name", "updated_at") VALUES (?, ?, ?, ?) [["amount", "100"], ["created_at", Wed, 26 Mar 2014 11:24:38 UTC +00:00], ["name", "dfsfsd"], ["updated_at", Wed, 26 Mar 2014 11:24:38 UTC +00:00]]
+ [1m[36m (1.0ms)[0m [1mcommit transaction[0m
+Redirected to http://localhost:3000/orders/13
+Completed 302 Found in 5ms (ActiveRecord: 1.6ms)
+
+
+Started GET "/orders/13" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+Processing by OrdersController#show as HTML
+ Parameters: {"id"=>"13"}
+ [1m[35mOrder Load (0.2ms)[0m SELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1 [["id", "13"]]
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 13], ["payable_type", "Order"]]
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mOpay::Payment Load (0.2ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'MVyzeUJpHaNvvxYe7pSd' ORDER BY "opay_payments"."id" ASC LIMIT 1[0m
+ [1m[35mSQL (0.4ms)[0m INSERT INTO "opay_payments" ("amount", "created_at", "payable_id", "payable_type", "provider", "session_id", "updated_at") VALUES (?, ?, ?, ?, ?, ?, ?) [["amount", 100], ["created_at", Wed, 26 Mar 2014 11:24:38 UTC +00:00], ["payable_id", 13], ["payable_type", "Order"], ["provider", "payu"], ["session_id", "MVyzeUJpHaNvvxYe7pSd"], ["updated_at", Wed, 26 Mar 2014 11:24:38 UTC +00:00]]
+ [1m[36m (1.0ms)[0m [1mcommit transaction[0m
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'gvx3aarxVgSWumbBnY4C' ORDER BY "opay_payments"."id" ASC LIMIT 1
+ [1m[36m (0.0ms)[0m [1mbegin transaction[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 13 [["session_id", "gvx3aarxVgSWumbBnY4C"], ["updated_at", Wed, 26 Mar 2014 11:24:38 UTC +00:00]]
+ [1m[36m (0.6ms)[0m [1mcommit transaction[0m
+ Rendered orders/show.html.erb within layouts/application (12.6ms)
+Completed 200 OK in 19ms (Views: 14.0ms | ActiveRecord: 3.2ms)
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:24:38 +0100
+
+
+Started PATCH "/opay/paypal/new" for 127.0.0.1 at 2014-03-26 12:24:39 +0100
+Processing by Opay::PaypalController#new as HTML
+ Parameters: {"utf8"=>"✓", "authenticity_token"=>"LxPfeVzneXNj+2bpRUb7hS67YTqTM6/hZBnUjyKVxes=", "desc"=>"Test payment", "client_ip"=>"127.0.0.1", "confirm_url"=>"http://localhost:3000/opay/paypal/confirm", "cancel_url"=>"http://localhost:3000/cancel", "session_id"=>"gvx3aarxVgSWumbBnY4C", "amount"=>"100", "x"=>"54", "y"=>"14"}
+ [1m[35mOpay::Payment Load (0.2ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'gvx3aarxVgSWumbBnY4C' ORDER BY "opay_payments"."id" ASC LIMIT 1
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "opay_payments" SET "session_id" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 13 [["session_id", "EC-1UJ90758EA102210E"], ["updated_at", Wed, 26 Mar 2014 11:24:40 UTC +00:00]]
+ [1m[36m (2.2ms)[0m [1mcommit transaction[0m
+Redirected to https://www.sandbox.paypal.com/cgi-bin/webscr?cmd=_express-checkout&token=EC-1UJ90758EA102210E
+Completed 302 Found in 1056ms (ActiveRecord: 2.8ms)
+
+
+Started GET "/opay/paypal/confirm?token=EC-1UJ90758EA102210E&PayerID=7RJPMT48ZEAZ8" for 127.0.0.1 at 2014-03-26 12:25:00 +0100
+Processing by Opay::PaypalController#confirm as HTML
+ Parameters: {"token"=>"EC-1UJ90758EA102210E", "PayerID"=>"7RJPMT48ZEAZ8"}
+ [1m[35mOpay::Payment Load (0.3ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."session_id" = 'EC-1UJ90758EA102210E' ORDER BY "opay_payments"."id" ASC LIMIT 1
+ [1m[36mOrder Load (0.1ms)[0m [1mSELECT "orders".* FROM "orders" WHERE "orders"."id" = ? LIMIT 1[0m [["id", 13]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 13], ["payable_type", "Order"]]
+ [1m[36m (0.1ms)[0m [1mbegin transaction[0m
+ [1m[35mSQL (0.3ms)[0m UPDATE "opay_payments" SET "finished" = ?, "updated_at" = ? WHERE "opay_payments"."id" = 13 [["finished", true], ["updated_at", Wed, 26 Mar 2014 11:25:03 UTC +00:00]]
+ [1m[36m (3.0ms)[0m [1mcommit transaction[0m
+ [1m[35m (0.1ms)[0m begin transaction
+ [1m[36mSQL (0.3ms)[0m [1mUPDATE "orders" SET "finished" = ?, "updated_at" = ? WHERE "orders"."id" = 13[0m [["finished", true], ["updated_at", Wed, 26 Mar 2014 11:25:03 UTC +00:00]]
+ [1m[35m (0.6ms)[0m commit transaction
+Redirected to http://localhost:3000/
+Completed 302 Found in 3065ms (ActiveRecord: 4.9ms)
+
+
+Started GET "/" for 127.0.0.1 at 2014-03-26 12:25:03 +0100
+Processing by OrdersController#index as HTML
+ [1m[36mOrder Load (0.2ms)[0m [1mSELECT "orders".* FROM "orders"[0m
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 1], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 2], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 3], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 4], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 5], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 6], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 7], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 8], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 9], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 10], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 11], ["payable_type", "Order"]]
+ [1m[36mOpay::Payment Load (0.1ms)[0m [1mSELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1[0m [["payable_id", 12], ["payable_type", "Order"]]
+ [1m[35mOpay::Payment Load (0.1ms)[0m SELECT "opay_payments".* FROM "opay_payments" WHERE "opay_payments"."payable_id" = ? AND "opay_payments"."payable_type" = ? LIMIT 1 [["payable_id", 13], ["payable_type", "Order"]]
+ Rendered orders/index.html.erb within layouts/application (13.9ms)
+Completed 200 OK in 18ms (Views: 16.6ms | ActiveRecord: 1.4ms)
+
+
+Started GET "/assets/scaffold.css?body=1" for 127.0.0.1 at 2014-03-26 12:25:03 +0100
+
+
+Started GET "/assets/application.css?body=1" for 127.0.0.1 at 2014-03-26 12:25:03 +0100
+
+
+Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at 2014-03-26 12:25:03 +0100
+
+
+Started GET "/assets/application.js?body=1" for 127.0.0.1 at 2014-03-26 12:25:03 +0100
+
+
+Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at 2014-03-26 12:25:03 +0100
+ [1m[36m (1.2ms)[0m [1mCREATE 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) [0m
+ [1m[35m (1.2ms)[0m CREATE INDEX "index_opay_payments_on_payable_id_and_payable_type" ON "opay_payments" ("payable_id", "payable_type")
+ [1m[36m (1.2ms)[0m [1mCREATE UNIQUE INDEX "index_opay_payments_on_session_id" ON "opay_payments" ("session_id")[0m
+ [1m[35m (1.2ms)[0m 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)
+ [1m[36m (1.0ms)[0m [1mCREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) [0m
+ [1m[35m (1.2ms)[0m CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
+ [1m[36m (0.1ms)[0m [1mSELECT version FROM "schema_migrations"[0m
+ [1m[35m (0.8ms)[0m INSERT INTO "schema_migrations" (version) VALUES ('20130326152550')
+ [1m[36mActiveRecord::SchemaMigration Load (0.1ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m
+ [1m[36m (3.5ms)[0m [1mCREATE 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) [0m
+ [1m[35m (1.1ms)[0m CREATE INDEX "index_opay_payments_on_payable_id_and_payable_type" ON "opay_payments" ("payable_id", "payable_type")
+ [1m[36m (1.1ms)[0m [1mCREATE UNIQUE INDEX "index_opay_payments_on_session_id" ON "opay_payments" ("session_id")[0m
+ [1m[35m (1.0ms)[0m 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)
+ [1m[36m (1.0ms)[0m [1mCREATE TABLE "schema_migrations" ("version" varchar(255) NOT NULL) [0m
+ [1m[35m (1.2ms)[0m CREATE UNIQUE INDEX "unique_schema_migrations" ON "schema_migrations" ("version")
+ [1m[36m (0.1ms)[0m [1mSELECT version FROM "schema_migrations"[0m
+ [1m[35m (1.1ms)[0m INSERT INTO "schema_migrations" (version) VALUES ('20130326152550')
+ [1m[36mActiveRecord::SchemaMigration Load (0.1ms)[0m [1mSELECT "schema_migrations".* FROM "schema_migrations"[0m