Many unprocessable mails

Infos:

  • Used Zammad version: * zammad-4.1.0-1630076259.40e648b8.centos7.x86_64
  • Used Zammad installation type: (source, package, docker-compose, …) Package
  • Operating system: CentOS 7
  • Browser + version: any

Expected behavior:

  • Zammad should process all emails

Actual behavior:

  • Very often Zammad is leaving messages in / opt / zammad / tmp / unprocessable_mail / and writing to the log:
E, [2021-09-27T10: 32: 06.878336 # 10918-47176818643100] ERROR -: Can't process email, you will find it for bug reporting under /opt/zammad/tmp/unprocessable_mail/5690ceec2ce8f63d18903133cdb1e403.eml, please create an issue at https://github.com/zammad/zammad/issues

Steps to reproduce the behavior:

  • I’ve sent the emails with Ticket#1093409

Thanks.

From the log file you provided the database seems to be at least instable just as your database server:

E, [2021-09-22T10:03:33.039521 #47290-47235079120100] ERROR -- : PG::UnableToSend: server closed the connection unexpectedly
E, [2021-09-22T10:03:33.039877 #47284-47235080223460] ERROR -- : PG::ConnectionBad: PQconsumeInput() server closed the connection unexpectedly
E, [2021-09-22T10:03:33.045215 #47288-47235079308700] ERROR -- : PG::UnableToSend: server closed the connection unexpectedly
E, [2021-09-22T10:03:33.046500 #47284-47235080223760] ERROR -- : PG::ConnectionBad: PQconsumeInput() server closed the connection unexpectedly
E, [2021-09-22T10:03:33.053611 #47130-46940618758560] ERROR -- : #<PG::ConnectionBad: server closed the connection unexpectedly
E, [2021-09-22T10:03:33.053733 #47130-46940618758560] ERROR -- : ["/opt/zammad/vendor/bundle/ruby/2.6.0/gems/pg-0.21.0/lib/pg.rb:56:in `initialize'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/pg-0.21.0/lib/pg.rb:56:in `new'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/pg-0.21.0/lib/pg.rb:56:in `connect'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/postgresql_adapter.rb:692:in `connect'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/postgresql_adapter.rb:223:in `initialize'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/postgresql_adapter.rb:48:in `new'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/postgresql_adapter.rb:48:in `postgresql_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:830:in `new_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:874:in `checkout_new_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:853:in `try_to_checkout_new_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:814:in `acquire_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:538:in `checkout'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:382:in `connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/abstract/connection_pool.rb:1033:in `retrieve_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_handling.rb:118:in `retrieve_connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_handling.rb:90:in `connection'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/core.rb:280:in `cached_find_by_statement'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/core.rb:201:in `find_by'", "/opt/zammad/lib/sessions/event/base.rb:95:in `current_user'", "/opt/zammad/lib/sessions/event/base.rb:118:in `permission_check'", "/opt/zammad/lib/sessions/event/chat_agent_state.rb:24:in `run'", "/opt/zammad/lib/sessions/event.rb:15:in `run'", "/opt/zammad/lib/websocket_server.rb:100:in `onmessage'", "/opt/zammad/lib/websocket_server.rb:25:in `block (3 levels) in run'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/em-websocket-0.5.1/lib/em-websocket/connection.rb:18:in `trigger_on_message'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/em-websocket-0.5.1/lib/em-websocket/message_processor_06.rb:52:in `message'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/em-websocket-0.5.1/lib/em-websocket/framing07.rb:118:in `process_data'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/em-websocket-0.5.1/lib/em-websocket/handler.rb:47:in `receive_data'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/em-websocket-0.5.1/lib/em-websocket/connection.rb:76:in `receive_data'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/eventmachine-1.2.7/lib/eventmachine.rb:195:in `run_machine'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/eventmachine-1.2.7/lib/eventmachine.rb:195:in `run'", "/opt/zammad/lib/websocket_server.rb:10:in `run'", "script/websocket-server.rb:129:in `<top (required)>'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/cli/exec.rb:74:in `load'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/cli/exec.rb:74:in `kernel_load'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/cli/exec.rb:28:in `run'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/cli.rb:463:in `exec'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/vendor/thor/lib/thor/command.rb:27:in `run'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/vendor/thor/lib/thor/invocation.rb:126:in `invoke_command'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/vendor/thor/lib/thor.rb:387:in `dispatch'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/cli.rb:27:in `dispatch'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/vendor/thor/lib/thor/base.rb:466:in `start'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/cli.rb:18:in `start'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/exe/bundle:30:in `block in <top (required)>'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/lib/bundler/friendly_errors.rb:124:in `with_friendly_errors'", "/opt/zammad/vendor/bundle/ruby/2.6.0/gems/bundler-1.17.3/exe/bundle:22:in `<top (required)>'", "/opt/zammad/bin/bundle:3:in `load'", "/opt/zammad/bin/bundle:3:in `<main>'"]
E, [2021-09-22T10:03:33.068733 #47284-47235079308700] ERROR -- : PG::ConnectionBad: PQconsumeInput() server closed the connection unexpectedly
E, [2021-09-22T10:03:34.073187 #47284-70164434248400] ERROR -- : FATAL:  el sistema de base de datos está en modo de recuperación
E, [2021-09-22T10:03:34.078137 #47284-70164434248400] ERROR -- : Error ID _ia7J4V4: FATAL:  el sistema de base de datos está en modo de recuperación
E, [2021-09-22T10:03:34.151167 #47286-47235079308700] ERROR -- : invalid encoding name: utf8 (PG::Error)
E, [2021-09-22T10:03:34.151836 #47286-47235079308700] ERROR -- : Error ID 9lS41bGV: invalid encoding name: utf8
E, [2021-09-22T10:03:34.172941 #47132-46972981536960] ERROR -- : thread_client 46940698473100 exited with error #<ActiveRecord::StatementInvalid: PG::ConnectionBad: PQconsumeInput() server closed the connection unexpectedly
E, [2021-09-22T10:03:34.173073 #47132-46972981536960] ERROR -- : /opt/zammad/vendor/bundle/ruby/2.6.0/gems/activerecord-5.2.4.6/lib/active_record/connection_adapters/postgresql_adapter.rb:611:in `async_exec'

You may want to find the root of that issue.
It seems your connecting to a non local database server - for this to be no issue, please ensure the database connection is stable and suitable for that approach.

This topic was automatically closed 120 days after the last reply. New replies are no longer allowed.