spree-contrib / better_spree_paypal_express

A better Spree PayPal Express Extension.
http://guides.spreecommerce.org
BSD 3-Clause "New" or "Revised" License
110 stars 269 forks source link

Redirection issue #124

Closed ManuelFrigerio closed 9 years ago

ManuelFrigerio commented 10 years ago

Hi @radar I set up the gem and everything is working fine locally, however I got few issues on production.

When I click on the Paypal icon I get redirected to Paypal, then I pay and I get redirected to my website again but at that point I got an error page.

The page is this one => https://www.mywebsite.com/paypal/confirm?payment_method_id=3&utm_nooverride=1&token=EC-1EA8356825335473W&PayerID=HBJTEZMNRZJFY

Checking the Heroku logs this is what I got:

ActiveRecord::RecordNotFound (ActiveRecord::RecordNotFound)


What am I doing wrong?

JDutil commented 10 years ago

Please provide steps to reproduce the problem, and a full backtrace as we ask for in our Contributing Guidelines

ManuelFrigerio commented 10 years ago

Hi @JDutil ,

I apologize, I'm quite new here :)

This is the fulltrace:

ActiveRecord::RecordNotFound (ActiveRecord::RecordNotFound):
2014-09-08T14:58:18.732931+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.732940+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T14:58:18.732930+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T14:58:18.735919+00:00 heroku[router]: at=info method=GET path="/paypal/confirm?payment_method_id=3&utm_nooverride=1&token=EC-6JY52499SP657152L&PayerID=LDDVL3ERYNXB6" host=www.crukafe.co.uk request_id=2d533f1a-6c1e-4dc7-b5a7-bc14d874ce75 fwd="84.207.252.4" dyno=web.1 connect=1ms service=71ms status=404 bytes=1310
2014-09-08T14:58:18.732936+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.732934+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2014-09-08T14:58:18.732938+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `call'
2014-09-08T14:58:18.732920+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/base.rb:189:in `process_action'
2014-09-08T14:58:18.732958+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.732967+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2014-09-08T14:58:18.732951+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T14:58:18.732963+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/rescue.rb:29:in `process_action'
2014-09-08T14:58:18.732962+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/callbacks.rb:19:in `process_action'
2014-09-08T14:58:18.732983+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
2014-09-08T14:58:18.732917+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/bundler/gems/better_spree_paypal_express-21ff0380a15a/app/controllers/spree/paypal_controller.rb:48:in `confirm'
2014-09-08T14:58:18.732932+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `call'
2014-09-08T14:58:18.732935+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T14:58:18.732957+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T14:58:18.732966+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/notifications.rb:159:in `block in instrument'
2014-09-08T14:58:18.732946+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `call'
2014-09-08T14:58:18.732947+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2014-09-08T14:58:18.732948+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `call'
2014-09-08T14:58:18.732922+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/rendering.rb:10:in `process_action'
2014-09-08T14:58:18.732996+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/railtie.rb:194:in `public_send'
2014-09-08T14:58:18.732993+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:678:in `call'
2014-09-08T14:58:18.732998+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/railtie.rb:194:in `method_missing'
2014-09-08T14:58:18.732919+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
2014-09-08T14:58:18.732939+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `block in halting'
2014-09-08T14:58:18.732994+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/engine.rb:514:in `call'
2014-09-08T14:58:18.732970+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/instrumentation.rb:30:in `process_action'
2014-09-08T14:58:18.732975+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
2014-09-08T14:58:18.732977+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activerecord-4.1.4/lib/active_record/railties/controller_runtime.rb:18:in `process_action'
2014-09-08T14:58:18.733026+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `call'
2014-09-08T14:58:18.733031+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/head.rb:11:in `call'
2014-09-08T14:58:18.733028+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/etag.rb:23:in `call'
2014-09-08T14:58:18.732943+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T14:58:18.733029+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/conditionalget.rb:25:in `call'
2014-09-08T14:58:18.732925+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:113:in `call'
2014-09-08T14:58:18.733045+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
2014-09-08T14:58:18.732985+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:82:in `call'
2014-09-08T14:58:18.732924+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/callbacks.rb:20:in `block in process_action'
2014-09-08T14:58:18.733043+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:82:in `run_callbacks'
2014-09-08T14:58:18.733060+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/rack/logger.rb:20:in `call'
2014-09-08T14:58:18.733084+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/handler/webrick.rb:60:in `service'
2014-09-08T14:58:18.733047+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
2014-09-08T14:58:18.733059+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/tagged_logging.rb:68:in `tagged'
2014-09-08T14:58:18.733083+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/content_length.rb:14:in `call'
2014-09-08T14:58:18.733044+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/callbacks.rb:27:in `call'
2014-09-08T14:58:18.733062+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/request_id.rb:21:in `call'
2014-09-08T14:58:18.733080+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/application.rb:144:in `call'
2014-09-08T14:58:18.733091+00:00 app[web.1]: 
2014-09-08T14:58:18.732950+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `block in halting'
2014-09-08T14:58:18.732952+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.732965+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
2014-09-08T14:58:18.732969+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/notifications.rb:159:in `instrument'
2014-09-08T14:58:18.732928+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.732944+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.733058+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/tagged_logging.rb:26:in `tagged'
2014-09-08T14:58:18.733081+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/lock.rb:17:in `call'
2014-09-08T14:58:18.733000+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `each'
2014-09-08T14:58:18.733033+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/flash.rb:254:in `call'
2014-09-08T14:58:18.732927+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:113:in `call'
2014-09-08T14:58:18.732942+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T14:58:18.732980+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionview-4.1.4/lib/action_view/rendering.rb:30:in `process'
2014-09-08T14:58:18.732984+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal.rb:232:in `block in action'
2014-09-08T14:58:18.732992+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `call'
2014-09-08T14:58:18.732999+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:71:in `block in call'
2014-09-08T14:58:18.733032+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/params_parser.rb:27:in `call'
2014-09-08T14:58:18.733048+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
2014-09-08T14:58:18.733063+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/methodoverride.rb:21:in `call'
2014-09-08T14:58:18.733086+00:00 app[web.1]:   vendor/ruby-2.1.0/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service'
2014-09-08T14:58:18.732986+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:82:in `dispatch'
2014-09-08T14:58:18.733001+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `call'
2014-09-08T14:58:18.732988+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:50:in `call'
2014-09-08T14:58:18.733003+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:678:in `call'
2014-09-08T14:58:18.732961+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:86:in `run_callbacks'
2014-09-08T14:58:18.733039+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activerecord-4.1.4/lib/active_record/query_cache.rb:36:in `call'
2014-09-08T14:58:18.732960+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:86:in `call'
2014-09-08T14:58:18.733035+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/session/abstract/id.rb:225:in `context'
2014-09-08T14:58:18.733040+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activerecord-4.1.4/lib/active_record/connection_adapters/abstract/connection_pool.rb:621:in `call'
2014-09-08T14:58:18.733042+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
2014-09-08T14:58:18.733053+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/rack/logger.rb:38:in `call_app'
2014-09-08T14:58:18.732981+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal.rb:196:in `dispatch'
2014-09-08T14:58:18.732978+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/base.rb:136:in `process'
2014-09-08T14:58:18.733056+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/tagged_logging.rb:68:in `block in tagged'
2014-09-08T14:58:18.733055+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/rack/logger.rb:20:in `block in call'
2014-09-08T14:58:18.733067+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/static.rb:64:in `call'
2014-09-08T14:58:18.732989+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:71:in `block in call'
2014-09-08T14:58:18.732990+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `each'
2014-09-08T14:58:18.733066+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call'
2014-09-08T14:58:18.733064+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/runtime.rb:17:in `call'
2014-09-08T14:58:18.733090+00:00 app[web.1]: 
2014-09-08T14:58:18.733004+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/warden-1.2.3/lib/warden/manager.rb:35:in `block in call'
2014-09-08T14:58:18.733006+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `catch'
2014-09-08T14:58:18.733089+00:00 app[web.1]:   vendor/ruby-2.1.0/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread'
2014-09-08T14:58:18.733087+00:00 app[web.1]:   vendor/ruby-2.1.0/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run'
2014-09-08T14:58:18.733036+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/session/abstract/id.rb:220:in `call'
2014-09-08T14:58:18.733037+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/cookies.rb:560:in `call'
2014-09-08T14:58:18.733069+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/sendfile.rb:112:in `call'
2014-09-08T14:58:18.733078+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/engine.rb:514:in `call'

Not really sure how I can reproduce the problem. What do you mean by that?

JDutil commented 10 years ago

The error is being raised here: https://github.com/spree-contrib/better_spree_paypal_express/blob/master/app/controllers/spree/paypal_controller.rb#L48

Apparently you have no current_order, but I'm not sure why that would be. You'll have to do some debugging to figure out why that is the case.

JDutil commented 10 years ago

Actually I think the parameter paypal is returning to you: 2014-09-08T14:58:18.735919+00:00 heroku[router]: at=info method=GET path="/paypal/confirm?payment_method_id=3&utm_nooverride=1&token=EC-6JY52499SP657152L&PayerID=LDDVL3ERYNXB6"

It should be guest_token not token.

ManuelFrigerio commented 10 years ago

All right, but how do I set parameters in the Paypal callaback? Is that possible?

ManuelFrigerio commented 10 years ago

Also, I don't think this is correct. Because in the code, the "confirm" method is expecting a "token" as you can see:

:source => Spree::PaypalExpressCheckout.create({ :token => params[:token], :payer_id => params[:PayerID] }),

The app is hosted on heroku and I've recently bought an SSL certificate. Could that be the problem?

JDutil commented 10 years ago

I think the issue is that the token param needs to set the guest_token cookie & lookup order like this: https://github.com/spree/spree/blob/master/frontend/app/controllers/spree/orders_controller.rb#L72-L73

Otherwise current_order is unable to find the order: https://github.com/spree/spree/blob/master/core/lib/spree/core/controller_helpers/order.rb#L35 https://github.com/spree/spree/blob/master/core/lib/spree/core/controller_helpers/order.rb#L81-L100

Trying to make an update for it but need to fix some specs.

ManuelFrigerio commented 10 years ago

Thank you very much @JDutil but it's still not 100% clear to me how to solve it.

What am I supposed to do to fix it?

ManuelFrigerio commented 10 years ago

No one can help?

I tried again and this time this is the backtrace:

2014-09-08T17:45:59.298252+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T17:45:59.298226+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T17:45:59.298193+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/transition_collection.rb:63:in `block in perform'
2014-09-08T17:45:59.298183+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/transition.rb:448:in `catch'
2014-09-08T17:45:59.298245+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `call'
2014-09-08T17:45:59.298267+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/instrumentation.rb:30:in `process_action'
2014-09-08T17:45:59.298217+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/rendering.rb:10:in `process_action'
2014-09-08T17:45:59.298241+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T17:45:59.298249+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T17:45:59.298215+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
2014-09-08T17:45:59.298232+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T17:45:59.298248+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T17:45:59.298247+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `block in halting'
2014-09-08T17:45:59.298191+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/transition_collection.rb:63:in `catch'
2014-09-08T17:45:59.298196+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/transition.rb:227:in `block in within_transaction'
2014-09-08T17:45:59.298272+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionview-4.1.4/lib/action_view/rendering.rb:30:in `process'
2014-09-08T17:45:59.298223+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `block in halting'
2014-09-08T17:45:59.298262+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/notifications.rb:159:in `block in instrument'
2014-09-08T17:45:59.298257+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/rescue.rb:29:in `process_action'
2014-09-08T17:45:59.298261+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
2014-09-08T17:45:59.298271+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/base.rb:136:in `process'
2014-09-08T17:45:59.298281+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:71:in `block in call'
2014-09-08T17:45:59.298285+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:678:in `call'
2014-09-08T17:45:59.298230+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T17:45:59.298244+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2014-09-08T17:45:59.298309+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/cookies.rb:560:in `call'
2014-09-08T17:45:59.298291+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `each'
2014-09-08T17:45:59.298298+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `call'
2014-09-08T17:45:59.298256+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/callbacks.rb:19:in `process_action'
2014-09-08T17:45:59.298235+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:229:in `block in halting'
2014-09-08T17:45:59.298198+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/transition.rb:226:in `within_transaction'
2014-09-08T17:45:59.298254+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:86:in `run_callbacks'
2014-09-08T17:45:59.298264+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2014-09-08T17:45:59.298205+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/transition_collection.rb:62:in `perform'
2014-09-08T17:45:59.298213+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/bundler/gems/better_spree_paypal_express-21ff0380a15a/app/controllers/spree/paypal_controller.rb:57:in `confirm'
2014-09-08T17:45:59.298331+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/rack/logger.rb:20:in `call'
2014-09-08T17:45:59.298273+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal.rb:196:in `dispatch'
2014-09-08T17:45:59.298250+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T17:45:59.298207+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/state_machine-1.2.0/lib/state_machine/event.rb:172:in `fire'
2014-09-08T17:45:59.298276+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal.rb:232:in `block in action'
2014-09-08T17:45:59.298282+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `each'
2014-09-08T17:45:59.298269+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activerecord-4.1.4/lib/active_record/railties/controller_runtime.rb:18:in `process_action'
2014-09-08T17:45:59.298336+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call'
2014-09-08T17:45:59.298301+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/conditionalget.rb:25:in `call'
2014-09-08T17:45:59.298280+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:50:in `call'
2014-09-08T17:45:59.298284+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `call'
2014-09-08T17:45:59.298216+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/abstract_controller/base.rb:189:in `process_action'
2014-09-08T17:45:59.298265+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/notifications.rb:159:in `instrument'
2014-09-08T17:45:59.298222+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:113:in `call'
2014-09-08T17:45:59.298288+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/railtie.rb:194:in `public_send'
2014-09-08T17:45:59.298277+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:82:in `call'
2014-09-08T17:45:59.298313+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
2014-09-08T17:45:59.298303+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/params_parser.rb:27:in `call'
2014-09-08T17:45:59.298302+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/head.rb:11:in `call'
2014-09-08T17:45:59.298293+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:59:in `call'
2014-09-08T17:45:59.298237+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T17:45:59.298275+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
2014-09-08T17:45:59.298286+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/engine.rb:514:in `call'
2014-09-08T17:45:59.298224+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:166:in `call'
2014-09-08T17:45:59.298325+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/rack/logger.rb:38:in `call_app'
2014-09-08T17:45:59.298318+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:82:in `run_callbacks'
2014-09-08T17:45:59.298307+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/session/abstract/id.rb:220:in `call'
2014-09-08T17:45:59.298294+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:678:in `call'
2014-09-08T17:45:59.298253+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:86:in `call'
2014-09-08T17:45:59.298289+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/railtie.rb:194:in `method_missing'
2014-09-08T17:45:59.298304+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/flash.rb:254:in `call'
2014-09-08T17:45:59.298229+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2014-09-08T17:45:59.298338+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/static.rb:64:in `call'
2014-09-08T17:45:59.298330+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/tagged_logging.rb:68:in `tagged'
2014-09-08T17:45:59.298327+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/tagged_logging.rb:68:in `block in tagged'
2014-09-08T17:45:59.298319+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/callbacks.rb:27:in `call'
2014-09-08T17:45:59.298295+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/warden-1.2.3/lib/warden/manager.rb:35:in `block in call'
2014-09-08T17:45:59.298268+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
2014-09-08T17:45:59.298306+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/session/abstract/id.rb:225:in `context'
2014-09-08T17:45:59.298242+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/callbacks.rb:149:in `call'
2014-09-08T17:45:59.298297+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `catch'
2014-09-08T17:45:59.298279+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/routing/route_set.rb:82:in `dispatch'
2014-09-08T17:45:59.298312+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activerecord-4.1.4/lib/active_record/connection_adapters/abstract/connection_pool.rb:621:in `call'
2014-09-08T17:45:59.298345+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/handler/webrick.rb:60:in `service'
2014-09-08T17:45:59.298339+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/sendfile.rb:112:in `call'
2014-09-08T17:45:59.298347+00:00 app[web.1]:   vendor/ruby-2.1.0/lib/ruby/2.1.0/webrick/httpserver.rb:138:in `service'
2014-09-08T17:45:59.298326+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/rack/logger.rb:20:in `block in call'
2014-09-08T17:45:59.298299+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/etag.rb:23:in `call'
2014-09-08T17:45:59.298290+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/journey/router.rb:71:in `block in call'
2014-09-08T17:45:59.298323+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
2014-09-08T17:45:59.298321+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
2014-09-08T17:45:59.298310+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activerecord-4.1.4/lib/active_record/query_cache.rb:36:in `call'
2014-09-08T17:45:59.298332+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/request_id.rb:21:in `call'
2014-09-08T17:45:59.298328+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/activesupport-4.1.4/lib/active_support/tagged_logging.rb:26:in `tagged'
2014-09-08T17:45:59.298335+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/runtime.rb:17:in `call'
2014-09-08T17:45:59.298322+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/actionpack-4.1.4/lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
2014-09-08T17:45:59.298341+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/application.rb:144:in `call'
2014-09-08T17:45:59.298349+00:00 app[web.1]:   vendor/ruby-2.1.0/lib/ruby/2.1.0/webrick/server.rb:295:in `block in start_thread'
2014-09-08T17:45:59.298351+00:00 app[web.1]: 
2014-09-08T17:45:59.298334+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/methodoverride.rb:21:in `call'
2014-09-08T17:45:59.298348+00:00 app[web.1]:   vendor/ruby-2.1.0/lib/ruby/2.1.0/webrick/httpserver.rb:94:in `run'
2014-09-08T17:45:59.298344+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/content_length.rb:14:in `call'
2014-09-08T17:45:59.298340+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/railties-4.1.4/lib/rails/engine.rb:514:in `call'
2014-09-08T17:45:59.298343+00:00 app[web.1]:   vendor/bundle/ruby/2.1.0/gems/rack-1.5.2/lib/rack/lock.rb:17:in `call'
2014-09-08T17:45:59.298352+00:00 app[web.1]: 

@radar Apparently this is a common issue, isn't it?

radar commented 10 years ago

Hi @ManuelFrigerio, I don't work on Spree any longer. I noticed you've got an Airpair request with me soon, so if @JDutil doesn't fix this by then, let's work on that then.

ManuelFrigerio commented 10 years ago

@radar I tried to book a session with you on AirPair, but you were unavailable :(

radar commented 10 years ago

@ManuelFrigerio I am available on Thursday morning my time. Try booking again :)

ManuelFrigerio commented 10 years ago

@radar Unfortunately the AirPair guys paired me with another guy who solved the issue. But I tell you what: we want to implement a recurring billing system in the app (using Spree), so I'd definitely love to ask for your help :)