search

scaffeinate / socify

:rocket: Socify is an open source social networking platform written in Ruby on Rails
http://socifyapp.herokuapp.com
GNU General Public License v2.0
375 stars 211 forks source link

Error at signup #35

Open Delano83 opened 7 years ago

Delano83 commented 7 years ago

Hello,

I followed the instructions, generated my AWS Keys and configured SendGrid with my SMTP username and password. Now the app is running fine on Heroku until I try to sign up, it gives me the following error:

image

Here's my log file: image

Any sugggestions? Thanks

scaffeinate commented 7 years ago

@Delano83 Have you run your migrations on heroku? And also can you post in the complete stack trace for this?

Delano83 commented 7 years ago

@sudharti For db migrations, I ran:

heroku run rake db:migrate

Here is the complete stack trace of the error:

2017-01-13T02:02:32.525572+00:00 app[api]: Starting process with command bundle exec rake db:migrate by user ### 2017-01-13T02:02:37.346604+00:00 heroku[run.2184]: Starting process with command bundle exec rake db:migrate 2017-01-13T02:02:37.595872+00:00 heroku[run.2184]: State changed from starting to up 2017-01-13T02:02:37.314586+00:00 heroku[run.2184]: Awaiting client 2017-01-13T02:02:45.655472+00:00 heroku[run.2184]: Process exited with status 0 2017-01-13T02:02:45.682708+00:00 heroku[run.2184]: State changed from up to complete 2017-01-13T02:22:31.185396+00:00 app[api]: Release v12 created by user ### 2017-01-13T02:22:31.185396+00:00 app[api]: Set LOG_LEVEL config vars by user ### 2017-01-13T02:22:31.434796+00:00 heroku[web.1]: Restarting 2017-01-13T02:22:31.435470+00:00 heroku[web.1]: State changed from up to starting 2017-01-13T02:22:32.098521+00:00 app[web.1]: [2017-01-13 02:22:32] FATAL SignalException: SIGTERM 2017-01-13T02:22:32.098533+00:00 app[web.1]: /app/vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/server.rb:177:in select' 2017-01-13T02:22:32.098535+00:00 app[web.1]: /app/vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/server.rb:177:inblock in start' 2017-01-13T02:22:32.098536+00:00 app[web.1]: /app/vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/server.rb:33:in start' 2017-01-13T02:22:32.098537+00:00 app[web.1]: /app/vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/server.rb:164:instart' 2017-01-13T02:22:32.098537+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/handler/webrick.rb:34:in run' 2017-01-13T02:22:32.098538+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/server.rb:296:instart' 2017-01-13T02:22:32.098539+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/commands/server.rb:79:in start' 2017-01-13T02:22:32.098540+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/commands/commands_tasks.rb:90:inblock in server' 2017-01-13T02:22:32.098541+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/commands/commands_tasks.rb:85:in tap' 2017-01-13T02:22:32.098542+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/commands/commands_tasks.rb:85:inserver' 2017-01-13T02:22:32.098542+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/commands/commands_tasks.rb:49:in run_command!' 2017-01-13T02:22:32.098543+00:00 app[web.1]: /app/vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/commands.rb:18:in<top (required)>' 2017-01-13T02:22:32.098544+00:00 app[web.1]: bin/rails:8:in require' 2017-01-13T02:22:32.098545+00:00 app[web.1]: bin/rails:8:in

' 2017-01-13T02:22:32.098674+00:00 app[web.1]: [2017-01-13 02:22:32] INFO going to shutdown ... 2017-01-13T02:22:32.098731+00:00 app[web.1]: [2017-01-13 02:22:32] INFO WEBrick::HTTPServer#start done. 2017-01-13T02:22:32.099574+00:00 app[web.1]: Exiting 2017-01-13T02:22:32.075461+00:00 heroku[web.1]: Stopping all processes with SIGTERM 2017-01-13T02:22:32.266516+00:00 heroku[web.1]: Process exited with status 143 2017-01-13T02:22:37.011572+00:00 heroku[web.1]: Starting process with command bin/rails server -p 21614 -e production 2017-01-13T02:22:44.558073+00:00 app[web.1]: [2017-01-13 02:22:44] INFO WEBrick 1.3.1 2017-01-13T02:22:44.558122+00:00 app[web.1]: [2017-01-13 02:22:44] INFO ruby 2.3.1 (2016-04-26) [x86_64-linux] 2017-01-13T02:22:44.558717+00:00 app[web.1]: [2017-01-13 02:22:44] INFO WEBrick::HTTPServer#start: pid=4 port=21614 2017-01-13T02:22:45.000592+00:00 heroku[web.1]: State changed from starting to up 2017-01-13T02:34:27.036945+00:00 app[web.1]: => Booting WEBrick 2017-01-13T02:34:27.036960+00:00 app[web.1]: => Rails 5.0.0 application starting in production on http://0.0.0.0:21614 2017-01-13T02:34:27.036962+00:00 app[web.1]: => Run rails server -h for more startup options 2017-01-13T02:34:27.036963+00:00 app[web.1]: Started GET "/" for 71.244.130.75 at 2017-01-13 02:34:27 +0000 2017-01-13T02:34:27.064630+00:00 app[web.1]: Processing by HomeController#front as HTML 2017-01-13T02:34:27.084819+00:00 app[web.1]: Rendering home/front.html.erb within layouts/application 2017-01-13T02:34:27.100511+00:00 app[web.1]: (4.4ms) SELECT COUNT() FROM "activities" 2017-01-13T02:34:27.102163+00:00 app[web.1]: Rendered shared/_no_resource.html.erb (0.6ms) 2017-01-13T02:34:27.103628+00:00 app[web.1]: CACHE (0.0ms) SELECT COUNT() FROM "activities" 2017-01-13T02:34:27.103710+00:00 app[web.1]: Rendered shared/_paginate.html.erb (1.1ms) 2017-01-13T02:34:27.103780+00:00 app[web.1]: Rendered home/front.html.erb within layouts/application (18.9ms) 2017-01-13T02:34:27.109720+00:00 app[web.1]: Rendered shared/_navbar.html.erb (1.6ms) 2017-01-13T02:34:27.110093+00:00 app[web.1]: Completed 200 OK in 45ms (Views: 23.0ms | ActiveRecord: 13.8ms) 2017-01-13T02:34:27.111441+00:00 heroku[router]: at=info method=GET path="/" host=blooming-stream-15146.herokuapp.com request_id=8342725d-acc8-4e54-9284-710f1075338d fwd="71.244.130.75" dyno=web.1 connect=0ms service=127ms status=200 bytes=2981 2017-01-13T02:37:11.196157+00:00 app[web.1]: Started GET "/" for 71.244.130.75 at 2017-01-13 02:37:11 +0000 2017-01-13T02:37:11.199642+00:00 app[web.1]: Processing by HomeController#front as HTML 2017-01-13T02:37:11.202480+00:00 app[web.1]: Rendering home/front.html.erb within layouts/application 2017-01-13T02:37:11.204979+00:00 app[web.1]: (1.4ms) SELECT COUNT() FROM "activities" 2017-01-13T02:37:11.205271+00:00 app[web.1]: Rendered shared/_no_resource.html.erb (0.0ms) 2017-01-13T02:37:11.206078+00:00 app[web.1]: CACHE (0.0ms) SELECT COUNT() FROM "activities" 2017-01-13T02:37:11.206158+00:00 app[web.1]: Rendered shared/_paginate.html.erb (0.7ms) 2017-01-13T02:37:11.206296+00:00 app[web.1]: Rendered home/front.html.erb within layouts/application (3.7ms) 2017-01-13T02:37:11.207589+00:00 app[web.1]: Rendered shared/_navbar.html.erb (0.5ms) 2017-01-13T02:37:11.207969+00:00 app[web.1]: Completed 200 OK in 8ms (Views: 5.0ms | ActiveRecord: 1.4ms) 2017-01-13T02:37:11.213639+00:00 heroku[router]: at=info method=GET path="/" host=blooming-stream-15146.herokuapp.com request_id=02d70c8f-ae51-4e60-aa62-e0dcccdc095d fwd="71.244.130.75" dyno=web.1 connect=1ms service=24ms status=200 bytes=2981 2017-01-13T02:37:11.504746+00:00 heroku[router]: at=info method=GET path="/assets/application-ca02b73d394ececce0f57c7ee6277be612faea2f4aa809406f517a33727cb5d0.css" host=blooming-stream-15146.herokuapp.com request_id=02299a30-3c63-43c8-93d4-2363341fdf05 fwd="71.244.130.75" dyno=web.1 connect=1ms service=7ms status=304 bytes=133 2017-01-13T02:37:11.551757+00:00 heroku[router]: at=info method=GET path="/assets/application-a70d07178327a29bab055588f3f709f15cc791bd72e456f720705a0469a5c7a7.js" host=blooming-stream-15146.herokuapp.com request_id=ca46ddc6-4392-4f43-96b6-af26dd235a40 fwd="71.244.130.75" dyno=web.1 connect=2ms service=11ms status=304 bytes=133 2017-01-13T02:37:11.728283+00:00 heroku[router]: at=info method=GET path="/assets/ajax-loader-20b3c2cf0c50583716b68afb1d964b4b07bb999faead1260bca34c43bf7ee4ea.gif" host=blooming-stream-15146.herokuapp.com request_id=5f4ba606-796c-4533-8f0c-cbe8b1b96ca2 fwd="71.244.130.75" dyno=web.1 connect=1ms service=5ms status=304 bytes=133 2017-01-13T02:37:11.781038+00:00 heroku[router]: at=info method=GET path="/assets/fontawesome-webfont-7dacf83f51179de8d7980a513e67ab3a08f2c6272bb5946df8fd77c0d1763b73.woff2" host=blooming-stream-15146.herokuapp.com request_id=f77093a4-e8c4-4c7c-ba9d-0dcb3db4bb84 fwd="71.244.130.75" dyno=web.1 connect=1ms service=5ms status=304 bytes=133 2017-01-13T02:37:44.041486+00:00 app[web.1]: Started GET "/users/sign_up" for 71.244.130.75 at 2017-01-13 02:37:44 +0000 2017-01-13T02:37:44.043502+00:00 app[web.1]: Processing by Devise::RegistrationsController#new as HTML 2017-01-13T02:37:44.121037+00:00 app[web.1]: Rendering devise/registrations/new.html.erb within layouts/application 2017-01-13T02:37:44.944774+00:00 heroku[router]: at=info method=GET path="/users/sign_up" host=blooming-stream-15146.herokuapp.com request_id=671a2879-e6f8-4e5c-9416-4446e5891c14 fwd="71.244.130.75" dyno=web.1 connect=3ms service=891ms status=200 bytes=4045 2017-01-13T02:37:44.922036+00:00 app[web.1]: Rendered devise/shared/_links.html.erb (2.3ms) 2017-01-13T02:37:44.922097+00:00 app[web.1]: Rendered devise/registrations/new.html.erb within layouts/application (801.0ms) 2017-01-13T02:37:44.923399+00:00 app[web.1]: Rendered shared/_navbar.html.erb (0.6ms) 2017-01-13T02:37:44.923800+00:00 app[web.1]: Completed 200 OK in 880ms (Views: 805.2ms | ActiveRecord: 21.0ms) 2017-01-13T02:38:10.514727+00:00 app[web.1]: Started POST "/users" for 71.244.130.75 at 2017-01-13 02:38:10 +0000 2017-01-13T02:38:10.519577+00:00 app[web.1]: Processing by Devise::RegistrationsController#create as HTML 2017-01-13T02:38:10.519650+00:00 app[web.1]: Parameters: {"utf8"=>"✓", "authenticity_token"=>"YldlKKnEdjfRrZyc9PqPu7dFMCjmX02R5UBpz3mnhryL/7mqaj/mbWhlNi7wAx01Tf75MtlzhfHaExyM3FZn0Q==", "user"=>{"name"=>"John Travolta", "email"=>"john.travolta@adf.com", "password"=>"[FILTERED]", "password_confirmation"=>"[FILTERED]"}, "commit"=>"Sign up"} 2017-01-13T02:38:10.626175+00:00 app[web.1]: (1.3ms) BEGIN 2017-01-13T02:38:10.766054+00:00 app[web.1]: User Exists (1.9ms) SELECT 1 AS one FROM "users" WHERE ("users"."id" IS NOT NULL) AND "users"."slug" = $1 LIMIT $2 [["slug", "john-travolta"], ["LIMIT", 1]] 2017-01-13T02:38:10.769857+00:00 app[web.1]: User Exists (1.4ms) SELECT 1 AS one FROM "users" WHERE "users"."email" = $1 LIMIT $2 [["email", "john.travolta@adf.com"], ["LIMIT", 1]] 2017-01-13T02:38:10.774118+00:00 app[web.1]: SQL (1.6ms) INSERT INTO "users" ("name", "email", "encrypted_password", "confirmation_token", "confirmation_sent_at", "created_at", "updated_at", "slug") VALUES ($1, $2, $3, $4, $5, $6, $7, $8) RETURNING "id" [["name", "John Travolta"], ["email", "john.travolta@adf.com"], ["encrypted_password", "$2a$10$XkgK8j1Q7Fxp5Xs2sduZGe276tKtBNvD.dJl24YZTp4OaaTWHMFcm"], ["confirmation_token", "qZBXwyPnbsgXdQzF1-ii"], ["confirmation_sent_at", 2017-01-13 02:38:10 UTC], ["created_at", 2017-01-13 02:38:10 UTC], ["updated_at", 2017-01-13 02:38:10 UTC], ["slug", "john-travolta"]] 2017-01-13T02:38:10.779551+00:00 app[web.1]: (2.3ms) COMMIT 2017-01-13T02:38:10.796452+00:00 app[web.1]: Rendering devise/mailer/confirmation_instructions.html.erb 2017-01-13T02:38:10.799095+00:00 app[web.1]: Rendered devise/mailer/confirmation_instructions.html.erb (2.5ms) 2017-01-13T02:38:11.190091+00:00 app[web.1]: Devise::Mailer#confirmation_instructions: processed outbound mail in 403.3ms 2017-01-13T02:38:11.249111+00:00 app[web.1]: Sent mail to john.travolta@adf.com (58.6ms) 2017-01-13T02:38:11.249113+00:00 app[web.1]: Date: Fri, 13 Jan 2017 02:38:11 +0000 2017-01-13T02:38:11.249114+00:00 app[web.1]: From: admin@socifyapp.herokuapp.com 2017-01-13T02:38:11.249114+00:00 app[web.1]: Reply-To: admin@socifyapp.herokuapp.com 2017-01-13T02:38:11.249115+00:00 app[web.1]: To: john.travolta@adf.com 2017-01-13T02:38:11.249116+00:00 app[web.1]: Message-ID: 58783d932ff20_43ffd8fc468748532d@0fd0b50e-d1e0-4a48-a585-1fba6bdcf587.mail 2017-01-13T02:38:11.249117+00:00 app[web.1]: Subject: Confirmation instructions 2017-01-13T02:38:11.249118+00:00 app[web.1]: Mime-Version: 1.0 2017-01-13T02:38:11.249118+00:00 app[web.1]: Content-Type: text/html; 2017-01-13T02:38:11.249120+00:00 app[web.1]: charset=UTF-8 2017-01-13T02:38:11.249120+00:00 app[web.1]: Content-Transfer-Encoding: 7bit 2017-01-13T02:38:11.249121+00:00 app[web.1]: 2017-01-13T02:38:11.249121+00:00 app[web.1]:

Welcome john.travolta@adf.com!

2017-01-13T02:38:11.249122+00:00 app[web.1]: 2017-01-13T02:38:11.249123+00:00 app[web.1]:

You can confirm your account email through the link below:

2017-01-13T02:38:11.249123+00:00 app[web.1]: 2017-01-13T02:38:11.249124+00:00 app[web.1]:

Confirm my account

2017-01-13T02:38:11.249125+00:00 app[web.1]: 2017-01-13T02:38:11.250008+00:00 app[web.1]: Completed 500 Internal Server Error in 730ms (ActiveRecord: 8.5ms) 2017-01-13T02:38:11.253890+00:00 app[web.1]:
2017-01-13T02:38:11.253915+00:00 app[web.1]: Net::SMTPAuthenticationError (535 Authentication failed: The provided authorization grant is invalid, expired, or revoked 2017-01-13T02:38:11.253916+00:00 app[web.1]: ): 2017-01-13T02:38:11.253931+00:00 app[web.1]:
2017-01-13T02:38:11.253950+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/net/smtp.rb:977:in check_auth_response' 2017-01-13T02:38:11.253966+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/net/smtp.rb:741:inauth_plain' 2017-01-13T02:38:11.253983+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/net/smtp.rb:733:in authenticate' 2017-01-13T02:38:11.253998+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/net/smtp.rb:568:indo_start' 2017-01-13T02:38:11.254014+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/net/smtp.rb:521:in start' 2017-01-13T02:38:11.254030+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/mail-2.6.4/lib/mail/network/delivery_methods/smtp.rb:113:indeliver!' 2017-01-13T02:38:11.254045+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/mail-2.6.4/lib/mail/message.rb:2149:in do_delivery' 2017-01-13T02:38:11.254063+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/mail-2.6.4/lib/mail/message.rb:237:inblock in deliver' 2017-01-13T02:38:11.254066+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionmailer-5.0.0/lib/action_mailer/base.rb:543:in block in deliver_mail' 2017-01-13T02:38:11.254087+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/notifications.rb:164:inblock in instrument' 2017-01-13T02:38:11.254102+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/notifications/instrumenter.rb:21:in instrument' 2017-01-13T02:38:11.254118+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/notifications.rb:164:ininstrument' 2017-01-13T02:38:11.254134+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionmailer-5.0.0/lib/action_mailer/base.rb:541:in deliver_mail' 2017-01-13T02:38:11.254150+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/mail-2.6.4/lib/mail/message.rb:237:indeliver' 2017-01-13T02:38:11.254166+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionmailer-5.0.0/lib/action_mailer/message_delivery.rb:96:in block in deliver_now' 2017-01-13T02:38:11.254181+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionmailer-5.0.0/lib/action_mailer/rescuable.rb:15:inhandle_exceptions' 2017-01-13T02:38:11.254198+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionmailer-5.0.0/lib/action_mailer/message_delivery.rb:95:in deliver_now' 2017-01-13T02:38:11.254225+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/devise-4.2.0/lib/devise/models/authenticatable.rb:191:insend_devise_notification' 2017-01-13T02:38:11.254229+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/devise-4.2.0/lib/devise/models/confirmable.rb:117:in send_confirmation_instructions' 2017-01-13T02:38:11.254230+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/devise-4.2.0/lib/devise/models/confirmable.rb:179:insend_on_create_confirmation_instructions' 2017-01-13T02:38:11.254248+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:382:in block in make_lambda' 2017-01-13T02:38:11.254268+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:232:inblock in conditional' 2017-01-13T02:38:11.254285+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:456:in block in call' 2017-01-13T02:38:11.254300+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:456:ineach' 2017-01-13T02:38:11.254315+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:456:in call' 2017-01-13T02:38:11.254331+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:101:inrun_callbacks__' 2017-01-13T02:38:11.254346+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:750:in _run_commit_callbacks' 2017-01-13T02:38:11.254362+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/transactions.rb:354:incommitted!' 2017-01-13T02:38:11.254378+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/connection_adapters/abstract/transaction.rb:87:in commit_records' 2017-01-13T02:38:11.254394+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/connection_adapters/abstract/transaction.rb:178:incommit_transaction' 2017-01-13T02:38:11.254409+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/connection_adapters/abstract/transaction.rb:202:in within_new_transaction' 2017-01-13T02:38:11.254425+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/connection_adapters/abstract/database_statements.rb:232:intransaction' 2017-01-13T02:38:11.254441+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/transactions.rb:211:in transaction' 2017-01-13T02:38:11.254456+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/transactions.rb:392:inwith_transaction_returning_status' 2017-01-13T02:38:11.254472+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/transactions.rb:319:in block in save' 2017-01-13T02:38:11.254515+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/transactions.rb:334:inrollback_active_record_state!' 2017-01-13T02:38:11.254518+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/transactions.rb:318:in save' 2017-01-13T02:38:11.254544+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/suppressor.rb:41:insave' 2017-01-13T02:38:11.254547+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/devise-4.2.0/app/controllers/devise/registrations_controller.rb:17:in create' 2017-01-13T02:38:11.254569+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal/basic_implicit_render.rb:4:insend_action' 2017-01-13T02:38:11.254572+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/abstract_controller/base.rb:188:in process_action' 2017-01-13T02:38:11.254602+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal/rendering.rb:30:inprocess_action' 2017-01-13T02:38:11.254632+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/abstract_controller/callbacks.rb:20:in block in process_action' 2017-01-13T02:38:11.254662+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:126:incall' 2017-01-13T02:38:11.254694+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:506:in block (2 levels) in compile' 2017-01-13T02:38:11.254723+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:455:incall' 2017-01-13T02:38:11.254754+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:448:in block (2 levels) in around' 2017-01-13T02:38:11.254785+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:286:inblock (2 levels) in halting' 2017-01-13T02:38:11.254816+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/public_activity-1.5.0/lib/public_activity/utility/store_controller.rb:25:in store_controller_for_public_activity' 2017-01-13T02:38:11.254846+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:382:inblock in make_lambda' 2017-01-13T02:38:11.254876+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:285:in block in halting' 2017-01-13T02:38:11.254905+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:447:inblock in around' 2017-01-13T02:38:11.254936+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:455:in call' 2017-01-13T02:38:11.254966+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:101:inrun_callbacks' 2017-01-13T02:38:11.254996+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:750:in _run_process_action_callbacks' 2017-01-13T02:38:11.255028+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:90:inrun_callbacks' 2017-01-13T02:38:11.255056+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/abstract_controller/callbacks.rb:19:in process_action' 2017-01-13T02:38:11.255088+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal/rescue.rb:20:inprocess_action' 2017-01-13T02:38:11.255118+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal/instrumentation.rb:32:in block in process_action' 2017-01-13T02:38:11.255281+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/notifications.rb:164:inblock in instrument' 2017-01-13T02:38:11.255296+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/notifications/instrumenter.rb:21:in instrument' 2017-01-13T02:38:11.255355+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/notifications.rb:164:ininstrument' 2017-01-13T02:38:11.255360+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal/instrumentation.rb:30:in process_action' 2017-01-13T02:38:11.255363+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal/params_wrapper.rb:248:inprocess_action' 2017-01-13T02:38:11.255405+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activerecord-5.0.0/lib/active_record/railties/controller_runtime.rb:18:in process_action' 2017-01-13T02:38:11.255451+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/abstract_controller/base.rb:126:inprocess' 2017-01-13T02:38:11.255693+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionview-5.0.0/lib/action_view/rendering.rb:30:in process' 2017-01-13T02:38:11.255731+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal.rb:190:indispatch' 2017-01-13T02:38:11.255975+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_controller/metal.rb:262:in dispatch' 2017-01-13T02:38:11.257891+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/routing/route_set.rb:50:indispatch' 2017-01-13T02:38:11.257896+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/routing/route_set.rb:32:in serve' 2017-01-13T02:38:11.257934+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/routing/mapper.rb:16:inblock in ' 2017-01-13T02:38:11.257967+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/routing/mapper.rb:46:in serve' 2017-01-13T02:38:11.257997+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/journey/router.rb:39:inblock in serve' 2017-01-13T02:38:11.258027+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/journey/router.rb:26:in each' 2017-01-13T02:38:11.258062+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/journey/router.rb:26:inserve' 2017-01-13T02:38:11.258084+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/routing/route_set.rb:725:in call' 2017-01-13T02:38:11.258115+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/warden-1.2.6/lib/warden/manager.rb:35:inblock in call' 2017-01-13T02:38:11.258146+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/warden-1.2.6/lib/warden/manager.rb:34:in catch' 2017-01-13T02:38:11.258176+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/warden-1.2.6/lib/warden/manager.rb:34:incall' 2017-01-13T02:38:11.258216+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/etag.rb:25:in call' 2017-01-13T02:38:11.258219+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/conditional_get.rb:38:incall' 2017-01-13T02:38:11.258253+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/head.rb:12:in call' 2017-01-13T02:38:11.258285+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/session/abstract/id.rb:222:incontext' 2017-01-13T02:38:11.258315+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/session/abstract/id.rb:216:in call' 2017-01-13T02:38:11.258349+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/cookies.rb:613:incall' 2017-01-13T02:38:11.258405+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/callbacks.rb:38:in block in call' 2017-01-13T02:38:11.258406+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:97:in__run_callbacks' 2017-01-13T02:38:11.258440+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:750:in _run_call_callbacks' 2017-01-13T02:38:11.258475+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/callbacks.rb:90:inrun_callbacks' 2017-01-13T02:38:11.258510+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/callbacks.rb:36:in call' 2017-01-13T02:38:11.258544+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/remote_ip.rb:79:incall' 2017-01-13T02:38:11.258570+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/debug_exceptions.rb:49:in call' 2017-01-13T02:38:11.258602+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/show_exceptions.rb:31:incall' 2017-01-13T02:38:11.258638+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/rack/logger.rb:36:in call_app' 2017-01-13T02:38:11.258662+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/rack/logger.rb:24:inblock in call' 2017-01-13T02:38:11.258665+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/tagged_logging.rb:70:in block in tagged' 2017-01-13T02:38:11.258688+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/tagged_logging.rb:26:intagged' 2017-01-13T02:38:11.258691+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/tagged_logging.rb:70:in tagged' 2017-01-13T02:38:11.258724+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/rack/logger.rb:24:incall' 2017-01-13T02:38:11.258727+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/request_id.rb:24:in call' 2017-01-13T02:38:11.258728+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/method_override.rb:22:incall' 2017-01-13T02:38:11.258742+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/runtime.rb:22:in call' 2017-01-13T02:38:11.258789+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/activesupport-5.0.0/lib/active_support/cache/strategy/local_cache_middleware.rb:28:incall' 2017-01-13T02:38:11.258815+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/executor.rb:12:in call' 2017-01-13T02:38:11.258834+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/actionpack-5.0.0/lib/action_dispatch/middleware/static.rb:136:incall' 2017-01-13T02:38:11.258842+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/sendfile.rb:111:in call' 2017-01-13T02:38:11.258863+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/railties-5.0.0/lib/rails/engine.rb:522:incall' 2017-01-13T02:38:11.258865+00:00 app[web.1]: vendor/bundle/ruby/2.3.0/gems/rack-2.0.1/lib/rack/handler/webrick.rb:86:in service' 2017-01-13T02:38:11.258898+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/httpserver.rb:140:inservice' 2017-01-13T02:38:11.258899+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/httpserver.rb:96:in run' 2017-01-13T02:38:11.258902+00:00 app[web.1]: vendor/ruby-2.3.1/lib/ruby/2.3.0/webrick/server.rb:296:inblock in start_thread'

scaffeinate commented 7 years ago

@Delano83 From your log I can see that the SMTP authorization fails. This part below:

2017-01-13T02:38:11.249125+00:00 app[web.1]:
2017-01-13T02:38:11.250008+00:00 app[web.1]: Completed 500 Internal Server Error in 730ms (ActiveRecord: 8.5ms)
2017-01-13T02:38:11.253890+00:00 app[web.1]:
2017-01-13T02:38:11.253915+00:00 app[web.1]: Net::SMTPAuthenticationError (535 Authentication failed: The provided authorization grant is invalid, expired, or revoked
Delano83 commented 7 years ago

Thanks @sudharti! This is what I have for smtp configuration: config.active_record.dump_schema_after_migration = false

config.action_mailer.default_url_options = { host: 'http://_myapp_.herokuapp.com' }

ActionMailer::Base.delivery_method = :smtp ActionMailer::Base.perform_deliveries = true

ActionMailer::Base.smtp_settings = { :address => 'smtp.sendgrid.net', :port => '587', :authentication => :plain, :user_name => ENV['SENDGRID_USERNAME'], :password => ENV['SENDGRID_PASSWORD'], :domain => 'heroku.com', :enable_starttls_auto => true }

For my Config Vars in Heroku, I have 'apikey' for username and my key for the password. Does it sound right to you?

scaffeinate commented 7 years ago

@Delano83 No I think for sendgrid it's just the username and password of your account. That's what I have set. Just checked my heroku config.

scaffeinate commented 7 years ago

@Delano83 Were you able to resolve it?

Delano83 commented 7 years ago

@sudharti Not quite yet...I put my Sendgrid username and password but still get SMTP error. Did you have to do any extra configuration on Sendgrid apart from setting up an SMTP Api Key?

scaffeinate commented 7 years ago

@Delano83 Try printing the ENV variable in Log to test if you are able to get the correct values. If that's not the issue then your account might not have been provisioned yet. Check this https://twitter.com/ryandeussing/status/260363641533108225?lang=en

Delano83 commented 7 years ago

@sudharti The authentification is set to 'plain' and the const variables are correctly printed in the console... How long does it take for your account to be provisioned since I just created my account? I now get a different error:

ArgumentError (SMTP-AUTH requested but missing user name)

Something to do with a missing username?

scaffeinate commented 7 years ago

@Delano83 Make sure that the username is not your email id. Because I have set the same and it seems to work. Either that or problem with heroku provisioning 🤔

Delano83 commented 7 years ago

@scaffeinate Still getting the error even afer checking with SendGrid for provisioning... Hopefully it's an isolated issue and we can close this thread.