Zammad 5.0.3 is not sending any Mails

  • Used Zammad version: 5.0.3
  • Used Zammad installation type: package
  • Operating system: debian 10
  • Browser + version: Chromium 96

Expected behavior:

  • Zammd should sent Mails for Notifications, or when creating a new Mail to a customer, or when creating a new agent.

Actual behavior:

  • Zammad uses a wrong password for smtp (yes i have checked the password many times and from other clients)

Steps to reproduce the behavior:

  • Setup e-mail-address and see the wrong password error in mail.log

notices

In the zammad production.log i could see which subject it is searching for when testing the new e-mail-account so i send a mail with that subject to get around that test but i still doesn’t send emails because of the wrong password.
E-mail sending with local sendmail/postfix also doesn’t work.

Can you show the errormessage from the GUI or from the logs?
Also maybe show the configuration for SMTP?

in the mail.log I can see successful logins to imap/dovecot but only sometimes a password mismatch when trying to send Mails by smtp, more often i can’t see any request from zammad:

Jan  6 11:25:33 mx dovecot[3090]: imap-login: Login: user=<support-test@example.de>, method=PLAIN, rip=x.x.x.x, lip=y.y.y.y, mpid=28031, TLS, session=<dW9hSufUnKaod7K8>
Jan  6 11:25:58 mx dovecot[3090]: auth-worker(5470): sql(support-test@example.de,x.x.x.x,<3RHaS+fUpqaod7K8>): Password mismatch

Here the log from zammad when i try to send a mail and i see nothing in the mail.log:

I, [2022-01-07T15:21:00.665753 #18653-173860]  INFO -- : Started PUT "/api/v1/taskbar/91" for 185.68.78.141 at 2022-01-07 15:21:00 +0100
I, [2022-01-07T15:21:00.674456 #18653-173860]  INFO -- : Processing by TaskbarController#update as JSON
I, [2022-01-07T15:21:00.674691 #18653-173860]  INFO -- :   Parameters: {"key"=>"TicketCreateScreen-77955", "client_id"=>"123", "callback"=>"TicketCreate", "state"=>{"body"=>"[FILTERED]", "formSenderType"=>"email-out", "form_id"=>"56526200
9", "title"=>"", "customer_id"=>"18", "customer_id_completion"=>"Trude Test <test@hostianer.com>", "cc"=>"", "group_id"=>"", "owner_id"=>"", "state_id"=>"2", "priority_id"=>"2", "tags"=>""}, "params"=>{"id"=>"77955", "shown"=>true}, "prio
"=>15, "notify"=>false, "active"=>true, "attachments"=>[], "updated_at"=>"2022-01-07T14:20:22.610Z", "id"=>"91"}
I, [2022-01-07T15:21:00.736202 #18653-173860]  INFO -- : Completed 200 OK in 61ms (Views: 0.6ms | ActiveRecord: 11.9ms | Allocations: 14539)
I, [2022-01-07T15:21:05.427717 #18653-265240]  INFO -- : Started PUT "/api/v1/taskbar/91" for 185.68.78.141 at 2022-01-07 15:21:05 +0100
I, [2022-01-07T15:21:05.435899 #18653-265240]  INFO -- : Processing by TaskbarController#update as JSON
I, [2022-01-07T15:21:05.436056 #18653-265240]  INFO -- :   Parameters: {"key"=>"TicketCreateScreen-77955", "client_id"=>"123", "callback"=>"TicketCreate", "state"=>{"body"=>"[FILTERED]", "formSenderType"=>"email-out", "form_id"=>"56526200
9", "title"=>"Nur ein Test", "customer_id"=>"18", "customer_id_completion"=>"Trude Test <test@hostianer.com>", "cc"=>"", "group_id"=>"", "owner_id"=>"", "state_id"=>"2", "priority_id"=>"2", "tags"=>""}, "params"=>{"id"=>"77955", "shown"=>
true}, "prio"=>15, "notify"=>false, "active"=>true, "attachments"=>[], "updated_at"=>"2022-01-07T14:20:22.610Z", "id"=>"91"}
I, [2022-01-07T15:21:05.479602 #18653-265240]  INFO -- : Completed 200 OK in 43ms (Views: 0.6ms | ActiveRecord: 9.3ms | Allocations: 14670)
I, [2022-01-07T15:21:13.053970 #18653-219360]  INFO -- : Started POST "/api/v1/integration/smime" for 185.68.78.141 at 2022-01-07 15:21:13 +0100
I, [2022-01-07T15:21:13.063624 #18653-219360]  INFO -- : Processing by Integration::SMIMEController#search as JSON
I, [2022-01-07T15:21:13.063835 #18653-219360]  INFO -- :   Parameters: {"ticket"=>{"body"=>"[FILTERED]", "formSenderType"=>"email-out", "form_id"=>"565262009", "title"=>"Nur ein Test", "customer_id"=>"18", "customer_id_completion"=>"Trude
 Test <test@hostianer.com>", "cc"=>"", "group_id"=>"1", "owner_id"=>"", "state_id"=>"2", "priority_id"=>"2", "tags"=>"", "to"=>"Trude Test <test@hostianer.com>"}, "article"=>{"body"=>"[FILTERED]", "formSenderType"=>"email-out", "form_id"=
>"565262009", "title"=>"Nur ein Test", "customer_id"=>"18", "customer_id_completion"=>"Trude Test <test@hostianer.com>", "cc"=>"", "group_id"=>"1", "owner_id"=>"", "state_id"=>"2", "priority_id"=>"2", "tags"=>"", "to"=>"Trude Test <test@h
ostianer.com>"}}
I, [2022-01-07T15:21:13.096827 #18653-219360]  INFO -- : Completed 200 OK in 33ms (Views: 0.3ms | ActiveRecord: 10.7ms | Allocations: 8657)
I, [2022-01-07T15:21:15.118044 #18653-207940]  INFO -- : Started PUT "/api/v1/taskbar/91" for 185.68.78.141 at 2022-01-07 15:21:15 +0100
I, [2022-01-07T15:21:15.128070 #18653-207940]  INFO -- : Processing by TaskbarController#update as JSON
I, [2022-01-07T15:21:15.128186 #18653-207940]  INFO -- :   Parameters: {"key"=>"TicketCreateScreen-77955", "client_id"=>"123", "callback"=>"TicketCreate", "state"=>{"body"=>"[FILTERED]", "formSenderType"=>"email-out", "form_id"=>"56526200
9", "title"=>"Nur ein Test", "customer_id"=>"18", "customer_id_completion"=>"Trude Test <test@hostianer.com>", "cc"=>"", "group_id"=>"1", "owner_id"=>"", "state_id"=>"2", "priority_id"=>"2", "tags"=>""}, "params"=>{"id"=>"77955", "shown"=
>true}, "prio"=>15, "notify"=>false, "active"=>true, "attachments"=>[], "updated_at"=>"2022-01-07T14:20:22.610Z", "id"=>"91"}
I, [2022-01-07T15:21:15.184497 #18653-207940]  INFO -- : Completed 200 OK in 56ms (Views: 0.6ms | ActiveRecord: 11.1ms | Allocations: 14632)
I, [2022-01-07T15:21:18.036605 #18653-253740]  INFO -- : Started POST "/api/v1/tickets" for 185.68.78.141 at 2022-01-07 15:21:18 +0100
I, [2022-01-07T15:21:18.046175 #18653-253740]  INFO -- : Processing by TicketsController#create as JSON
I, [2022-01-07T15:21:18.046329 #18653-253740]  INFO -- :   Parameters: {"title"=>"Nur ein Test", "group_id"=>"1", "owner_id"=>"", "customer_id"=>"18", "state_id"=>"2", "priority_id"=>"2", "article"=>{"from"=>"Users", "to"=>"Trude Test <test@hostianer.com>", "cc"=>"", "body"=>"[FILTERED]", "type_id"=>1, "sender_id"=>1, "form_id"=>"565262009", "content_type"=>"text/html"}, "tags"=>"", "id"=>"c-23"}
I, [2022-01-07T15:21:18.295640 #18653-253740]  INFO -- : Completed 201 Created in 249ms (Views: 0.5ms | ActiveRecord: 65.8ms | Allocations: 58129)
I, [2022-01-07T15:21:18.377522 #18653-265240]  INFO -- : Started DELETE "/api/v1/taskbar/91" for 185.68.78.141 at 2022-01-07 15:21:18 +0100
I, [2022-01-07T15:21:18.382844 #18653-173860]  INFO -- : Started GET "/api/v1/tickets/23?all=true&_=1641462633863" for 185.68.78.141 at 2022-01-07 15:21:18 +0100
I, [2022-01-07T15:21:18.390676 #18653-265240]  INFO -- : Processing by TaskbarController#destroy as JSON
I, [2022-01-07T15:21:18.393628 #18653-265240]  INFO -- :   Parameters: {"id"=>"91"}
I, [2022-01-07T15:21:18.393460 #18653-173860]  INFO -- : Processing by TicketsController#show as JSON
I, [2022-01-07T15:21:18.394148 #18653-173860]  INFO -- :   Parameters: {"all"=>"true", "_"=>"1641462633863", "id"=>"23"}
I, [2022-01-07T15:21:18.506969 #18653-265240]  INFO -- : Completed 200 OK in 113ms (Views: 0.3ms | ActiveRecord: 54.5ms | Allocations: 41684)
I, [2022-01-07T15:21:18.537166 #18653-219360]  INFO -- : Started POST "/api/v1/taskbar" for 185.68.78.141 at 2022-01-07 15:21:18 +0100
I, [2022-01-07T15:21:18.543449 #18653-219360]  INFO -- : Processing by TaskbarController#create as JSON
I, [2022-01-07T15:21:18.543585 #18653-219360]  INFO -- :   Parameters: {"key"=>"Ticket-23", "client_id"=>123, "callback"=>"TicketZoom", "params"=>{"ticket_id"=>"23", "shown"=>true}, "prio"=>15, "notify"=>false, "active"=>true, "id"=>"c-504"}

There is a bigger problem with zammad.
After logging out i can’t log in again. I just see a white screen.
zammad, zammad-web, zammad-websockets, zammad-worker and postgresql are running according to systemctl status and netstat. The Firewall is all open. There are no errors in the nginx error.log or in the zammad production.log.
When calling the url with #login/ it stays there, when calling just the url it changes it to url/#import/

Any ideas?