full log spree support order edit admin

2015-07-07T19:30:04.672916+00:00 app[web.1]: source=rack-timeout id=91e1d96e-902d-4650-b2e0-27eb560c9eeb wait=4ms timeout=20000ms state=ready
2015-07-07T19:30:04.705425+00:00 app[web.1]: Processing by Spree::Admin::OrdersController#edit as HTML
2015-07-07T19:30:04.705439+00:00 app[web.1]:   Parameters: {"id"=>"R690886836"}
2015-07-07T19:30:04.673436+00:00 app[web.1]: Started GET "/admin/orders/R690886836/edit" for 207.154.65.189 at 2015-07-07 19:30:04 +0000
2015-07-07T19:30:05.713104+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/shared/_order_summary.html.erb (12.8ms)
2015-07-07T19:30:05.928029+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/shared/_order_tabs.html.erb (414.1ms)
2015-07-07T19:30:05.927845+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/shared/_order_submenu.html.erb (57.8ms)
2015-07-07T19:30:05.929059+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/bundler/gems/spree_bootstrap_frontend-d20c03352917/spree_bootstrap/frontend/app/views/spree/shared/_error_messages.html.erb (0.7ms)
2015-07-07T19:30:06.218508+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_risk_analysis.html.erb (81.2ms)
2015-07-07T19:30:06.883363+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/variants/_autocomplete.js.erb (1.2ms)
2015-07-07T19:30:07.179537+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/variants/_autocomplete_stock.js.erb (2.0ms)
2015-07-07T19:30:07.180039+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_add_product.html.erb (577.4ms)
2015-07-07T19:30:07.742888+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/variants/_split.js.erb (11.2ms)
2015-07-07T19:30:08.952650+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_shipment_manifest.html.erb (959.4ms)
2015-07-07T19:30:09.490825+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_shipment.html.erb (1930.9ms)
2015-07-07T19:30:09.490892+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_form.html.erb (2139.2ms)
2015-07-07T19:30:09.490981+00:00 app[web.1]:   Rendered vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/edit.html.erb within spree/layouts/admin (4039.9ms)
2015-07-07T19:30:09.491325+00:00 app[web.1]: Completed 500 Internal Server Error in 4786ms
2015-07-07T19:30:09.544102+00:00 heroku[router]: at=info method=GET path="/admin/orders/R690886836/edit" host=amploc.herokuapp.com request_id=91e1d96e-902d-4650-b2e0-27eb560c9eeb fwd="207.154.65.189" dyno=web.1 connect=1ms service=4871ms status=500 bytes=1669
2015-07-07T19:30:09.537373+00:00 app[web.1]: 
2015-07-07T19:30:09.537378+00:00 app[web.1]: ActionView::Template::Error (undefined method `compute_shipping_rate' for nil:NilClass):
2015-07-07T19:30:09.537380+00:00 app[web.1]:     41:             <div class="field alpha five columns">
2015-07-07T19:30:09.537382+00:00 app[web.1]:     42:               <%= label_tag 'selected_shipping_rate_id', Spree.t(:shipping_method) %>
2015-07-07T19:30:09.537384+00:00 app[web.1]:     43:               <%= select_tag :selected_shipping_rate_id,
2015-07-07T19:30:09.537386+00:00 app[web.1]:     44:                     options_for_select(shipment.shipping_rates.map {|sr| ["#{sr.name} #{sr.display_price}", sr.id] }, shipment.selected_shipping_rate_id),
2015-07-07T19:30:09.537388+00:00 app[web.1]:     45:                     {:class => 'select2 fullwidth', :data => {'shipment-number' => shipment.number } } %>
2015-07-07T19:30:09.537389+00:00 app[web.1]:     46:             </div>
2015-07-07T19:30:09.537391+00:00 app[web.1]:     47:           </td>
2015-07-07T19:30:09.537392+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/spree_core-2.4.5/app/models/spree/shipping_rate.rb:15:in `calculate_tax_amount'
2015-07-07T19:30:09.537394+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/spree_core-2.4.5/app/models/spree/shipping_rate.rb:21:in `display_price'
2015-07-07T19:30:09.537397+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_shipment.html.erb:44:in `block in _f812cb1bb3777bf4850d5ab9fc29da0e'
2015-07-07T19:30:09.537398+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activerecord-4.1.8/lib/active_record/relation/delegation.rb:46:in `map'
2015-07-07T19:30:09.537400+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activerecord-4.1.8/lib/active_record/relation/delegation.rb:46:in `map'
2015-07-07T19:30:09.537402+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_shipment.html.erb:44:in `_f812cb1bb3777bf4850d5ab9fc29da0e'
2015-07-07T19:30:09.537403+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:145:in `block in render'
2015-07-07T19:30:09.537405+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:161:in `instrument'
2015-07-07T19:30:09.537406+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:339:in `instrument'
2015-07-07T19:30:09.537407+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:143:in `render'
2015-07-07T19:30:09.537408+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/deface-1.0.1/lib/deface/action_view_extensions.rb:41:in `render'
2015-07-07T19:30:09.537410+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:399:in `block in collection_with_template'
2015-07-07T19:30:09.537411+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:395:in `map'
2015-07-07T19:30:09.537412+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:395:in `collection_with_template'
2015-07-07T19:30:09.537414+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:291:in `render_collection'
2015-07-07T19:30:09.537415+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:275:in `block in render'
2015-07-07T19:30:09.537417+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument'
2015-07-07T19:30:09.537418+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `block in instrument'
2015-07-07T19:30:09.537419+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2015-07-07T19:30:09.537421+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `instrument'
2015-07-07T19:30:09.537422+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'
2015-07-07T19:30:09.537423+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:274:in `render'
2015-07-07T19:30:09.537424+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/renderer.rb:47:in `render_partial'
2015-07-07T19:30:09.537425+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/renderer.rb:21:in `render'
2015-07-07T19:30:09.537426+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/helpers/rendering_helper.rb:32:in `render'
2015-07-07T19:30:09.537428+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/_form.html.erb:7:in `_952999fe2582d5c5a9102e10fe4445cd'
2015-07-07T19:30:09.537429+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:145:in `block in render'
2015-07-07T19:30:09.537430+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:161:in `instrument'
2015-07-07T19:30:09.537431+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:339:in `instrument'
2015-07-07T19:30:09.537433+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:143:in `render'
2015-07-07T19:30:09.537440+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/deface-1.0.1/lib/deface/action_view_extensions.rb:41:in `render'
2015-07-07T19:30:09.537441+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:306:in `render_partial'
2015-07-07T19:30:09.537443+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:279:in `block in render'
2015-07-07T19:30:09.537444+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument'
2015-07-07T19:30:09.537446+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `block in instrument'
2015-07-07T19:30:09.537447+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2015-07-07T19:30:09.537448+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `instrument'
2015-07-07T19:30:09.537450+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'
2015-07-07T19:30:09.537451+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/partial_renderer.rb:278:in `render'
2015-07-07T19:30:09.537452+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/renderer.rb:47:in `render_partial'
2015-07-07T19:30:09.537454+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/renderer.rb:21:in `render'
2015-07-07T19:30:09.537455+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/helpers/rendering_helper.rb:32:in `render'
2015-07-07T19:30:09.537456+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/spree_backend-2.4.5/app/views/spree/admin/orders/edit.html.erb:33:in `_14a88cb7be90565df665ee806b583c48'
2015-07-07T19:30:09.537458+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:145:in `block in render'
2015-07-07T19:30:09.537459+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:161:in `instrument'
2015-07-07T19:30:09.537460+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:339:in `instrument'
2015-07-07T19:30:09.537461+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/template.rb:143:in `render'
2015-07-07T19:30:09.537463+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/deface-1.0.1/lib/deface/action_view_extensions.rb:41:in `render'
2015-07-07T19:30:09.537464+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/template_renderer.rb:55:in `block (2 levels) in render_template'
2015-07-07T19:30:09.537466+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/abstract_renderer.rb:38:in `block in instrument'
2015-07-07T19:30:09.537467+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `block in instrument'
2015-07-07T19:30:09.537468+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2015-07-07T19:30:09.537469+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `instrument'
2015-07-07T19:30:09.537471+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'
2015-07-07T19:30:09.537472+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/template_renderer.rb:54:in `block in render_template'
2015-07-07T19:30:09.537473+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/template_renderer.rb:62:in `render_with_layout'
2015-07-07T19:30:09.537474+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/template_renderer.rb:53:in `render_template'
2015-07-07T19:30:09.537475+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/template_renderer.rb:17:in `render'
2015-07-07T19:30:09.537477+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/renderer.rb:42:in `render_template'
2015-07-07T19:30:09.537478+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/renderer/renderer.rb:23:in `render'
2015-07-07T19:30:09.537479+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/rendering.rb:99:in `_render_template'
2015-07-07T19:30:09.537481+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/streaming.rb:217:in `_render_template'
2015-07-07T19:30:09.537482+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/rendering.rb:82:in `render_to_body'
2015-07-07T19:30:09.537483+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/rendering.rb:32:in `render_to_body'
2015-07-07T19:30:09.537484+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/renderers.rb:32:in `render_to_body'
2015-07-07T19:30:09.537485+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/abstract_controller/rendering.rb:25:in `render'
2015-07-07T19:30:09.537489+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/rendering.rb:16:in `render'
2015-07-07T19:30:09.537490+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/instrumentation.rb:41:in `block (2 levels) in render'
2015-07-07T19:30:09.537492+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/core_ext/benchmark.rb:12:in `block in ms'
2015-07-07T19:30:09.537493+00:00 app[web.1]:   vendor/ruby-2.0.0/lib/ruby/2.0.0/benchmark.rb:296:in `realtime'
2015-07-07T19:30:09.537494+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/core_ext/benchmark.rb:12:in `ms'
2015-07-07T19:30:09.537495+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/instrumentation.rb:41:in `block in render'
2015-07-07T19:30:09.537496+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/instrumentation.rb:84:in `cleanup_view_runtime'
2015-07-07T19:30:09.537498+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activerecord-4.1.8/lib/active_record/railties/controller_runtime.rb:25:in `cleanup_view_runtime'
2015-07-07T19:30:09.537499+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/instrumentation.rb:40:in `render'
2015-07-07T19:30:09.537500+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/implicit_render.rb:10:in `default_render'
2015-07-07T19:30:09.537501+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/implicit_render.rb:5:in `send_action'
2015-07-07T19:30:09.537503+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/abstract_controller/base.rb:189:in `process_action'
2015-07-07T19:30:09.537504+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/rendering.rb:10:in `process_action'
2015-07-07T19:30:09.537505+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/abstract_controller/callbacks.rb:20:in `block in process_action'
2015-07-07T19:30:09.537506+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:113:in `call'
2015-07-07T19:30:09.537507+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:113:in `call'
2015-07-07T19:30:09.537508+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537509+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:149:in `call'
2015-07-07T19:30:09.537511+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2015-07-07T19:30:09.537512+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537513+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537514+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537515+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537517+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.5
37518+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537519+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:149:in `call'
2015-07-07T19:30:09.537520+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2015-07-07T19:30:09.537521+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537522+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537524+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:149:in `call'
2015-07-07T19:30:09.537525+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:149:in `block in halting_and_conditional'
2015-07-07T19:30:09.537526+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537527+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537528+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:229:in `call'
2015-07-07T19:30:09.537529+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:229:in `block in halting'
2015-07-07T19:30:09.537531+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537532+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537536+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537537+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537539+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:229:in `call'
2015-07-07T19:30:09.537540+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:229:in `block in halting'
2015-07-07T19:30:09.537542+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537543+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537544+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `call'
2015-07-07T19:30:09.537545+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:166:in `block in halting'
2015-07-07T19:30:09.537546+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:86:in `call'
2015-07-07T19:30:09.537547+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:86:in `run_callbacks'
2015-07-07T19:30:09.537548+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/abstract_controller/callbacks.rb:19:in `process_action'
2015-07-07T19:30:09.537550+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/rescue.rb:29:in `process_action'
2015-07-07T19:30:09.537551+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/instrumentation.rb:31:in `block in process_action'
2015-07-07T19:30:09.537552+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `block in instrument'
2015-07-07T19:30:09.537554+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
2015-07-07T19:30:09.537555+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/notifications.rb:159:in `instrument'
2015-07-07T19:30:09.537556+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/instrumentation.rb:30:in `process_action'
2015-07-07T19:30:09.537557+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/params_wrapper.rb:250:in `process_action'
2015-07-07T19:30:09.537559+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activerecord-4.1.8/lib/active_record/railties/controller_runtime.rb:18:in `process_action'
2015-07-07T19:30:09.537560+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/abstract_controller/base.rb:136:in `process'
2015-07-07T19:30:09.537561+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionview-4.1.8/lib/action_view/rendering.rb:30:in `process'
2015-07-07T19:30:09.537562+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal.rb:196:in `dispatch'
2015-07-07T19:30:09.537564+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal/rack_delegation.rb:13:in `dispatch'
2015-07-07T19:30:09.537565+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_controller/metal.rb:232:in `block in action'
2015-07-07T19:30:09.537566+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/routing/route_set.rb:82:in `call'
2015-07-07T19:30:09.537567+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/routing/route_set.rb:82:in `dispatch'
2015-07-07T19:30:09.537568+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/routing/route_set.rb:50:in `call'
2015-07-07T19:30:09.537569+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/journey/router.rb:73:in `block in call'
2015-07-07T19:30:09.537571+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/journey/router.rb:59:in `each'
2015-07-07T19:30:09.537572+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/journey/router.rb:59:in `call'
2015-07-07T19:30:09.537573+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/routing/route_set.rb:678:in `call'
2015-07-07T19:30:09.537574+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/engine.rb:514:in `call'
2015-07-07T19:30:09.537575+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/railtie.rb:194:in `public_send'
2015-07-07T19:30:09.537577+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/railtie.rb:194:in `method_missing'
2015-07-07T19:30:09.537578+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/journey/router.rb:73:in `block in call'
2015-07-07T19:30:09.537579+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/journey/router.rb:59:in `each'
2015-07-07T19:30:09.537580+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/journey/router.rb:59:in `call'
2015-07-07T19:30:09.537582+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/routing/route_set.rb:678:in `call'
2015-07-07T19:30:09.537583+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/warden-1.2.3/lib/warden/manager.rb:35:in `block in call'
2015-07-07T19:30:09.537587+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `catch'
2015-07-07T19:30:09.537588+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/warden-1.2.3/lib/warden/manager.rb:34:in `call'
2015-07-07T19:30:09.537590+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/etag.rb:23:in `call'
2015-07-07T19:30:09.537591+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/conditionalget.rb:25:in `call'
2015-07-07T19:30:09.537592+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/head.rb:11:in `call'
2015-07-07T19:30:09.537593+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/params_parser.rb:27:in `call'
2015-07-07T19:30:09.537594+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/flash.rb:254:in `call'
2015-07-07T19:30:09.537596+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/session/abstract/id.rb:225:in `context'
2015-07-07T19:30:09.537597+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/session/abstract/id.rb:220:in `call'
2015-07-07T19:30:09.537598+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/cookies.rb:560:in `call'
2015-07-07T19:30:09.537599+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activerecord-4.1.8/lib/active_record/query_cache.rb:36:in `call'
2015-07-07T19:30:09.537600+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activerecord-4.1.8/lib/active_record/connection_adapters/abstract/connection_pool.rb:621:in `call'
2015-07-07T19:30:09.537602+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/callbacks.rb:29:in `block in call'
2015-07-07T19:30:09.537603+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/callbacks.rb:82:in `run_callbacks'
2015-07-07T19:30:09.537604+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/callbacks.rb:27:in `call'
2015-07-07T19:30:09.537605+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/remote_ip.rb:76:in `call'
2015-07-07T19:30:09.537606+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/debug_exceptions.rb:17:in `call'
2015-07-07T19:30:09.537608+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/show_exceptions.rb:30:in `call'
2015-07-07T19:30:09.537609+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/rack/logger.rb:38:in `call_app'
2015-07-07T19:30:09.537610+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/rack/logger.rb:20:in `block in call'
2015-07-07T19:30:09.537611+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/tagged_logging.rb:68:in `block in tagged'
2015-07-07T19:30:09.537613+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/tagged_logging.rb:26:in `tagged'
2015-07-07T19:30:09.537614+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/tagged_logging.rb:68:in `tagged'
2015-07-07T19:30:09.537615+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/rack/logger.rb:20:in `call'
2015-07-07T19:30:09.537617+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/request_id.rb:21:in `call'
2015-07-07T19:30:09.537618+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/methodoverride.rb:21:in `call'
2015-07-07T19:30:09.537619+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/runtime.rb:17:in `call'
2015-07-07T19:30:09.537620+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/activesupport-4.1.8/lib/active_support/cache/strategy/local_cache_middleware.rb:26:in `call'
2015-07-07T19:30:09.537622+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/actionpack-4.1.8/lib/action_dispatch/middleware/static.rb:84:in `call'
2015-07-07T19:30:09.537623+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-1.5.2/lib/rack/sendfile.rb:112:in `call'
2015-07-07T19:30:09.537624+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/rack-timeout-0.2.1/lib/rack/timeout.rb:108:in `call'
2015-07-07T19:30:09.537625+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/engine.rb:514:in `call'
2015-07-07T19:30:09.537627+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/railties-4.1.8/lib/rails/application.rb:144:in `call'
2015-07-07T19:30:09.537628+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/puma-2.11.1/lib/puma/configuration.rb:82:in `call'
2015-07-07T19:30:09.537629+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/puma-2.11.1/lib/puma/server.rb:507:in `handle_request'
2015-07-07T19:30:09.537630+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/puma-2.11.1/lib/puma/server.rb:375:in `process_client'
2015-07-07T19:30:09.537631+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/puma-2.11.1/lib/puma/server.rb:262:in `block in run'
2015-07-07T19:30:09.537632+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/puma-2.11.1/lib/puma/thread_pool.rb:104:in `call'
2015-07-07T19:30:09.537634+00:00 app[web.1]:   vendor/bundle/ruby/2.0.0/gems/puma-2.11.1/lib/puma/thread_pool.rb:104:in `block in spawn_thread'
2015-07-07T19:30:09.537635+00:00 app[web.1]: 
2015-07-07T19:30:09.537636+00:00 app[web.1]: 
2015-07-07T19:30:09.538173+00:00 app[web.1]: source=rack-timeout id=91e1d96e-902d-4650-b2e0-27eb560c9eeb wait=4ms timeout=20000ms service=4865ms state=completed