| |||||||||||||||||||||||||||||||
|
One server that was setup to use postfix (local users) and dovecot as mailbox_command just decided to stop working recently. It's hard to tell exactly where the issue is, and I'm trying to either find out further debugging info, and to find out what a few postfix lines mean. - Everything worked fine until one evening, it decided to stop. Any incoming message would just get deferred: 3AF5C6FC4A7: to=<username>, relay=local, delay=0.15, delays=0.09/0.01/0/0.04, dsn=4.3.0, status=deferred (temporary failure) - If I remove mailbox_command from the config, it works. However, dovecot is there to run sieve scripts (vacation autoreply, etc), which is the reason I'm using it. The only debugging I can see that I can set in postfix is to give "-v" to "local" in master.cf. Doing this gives (short snippet): Jan 24 09:36:48 progressive postfix/local[94846]: set_eugid: euid 1001 egid 20 Jan 24 09:36:48 progressive postfix/local[94846]: set_eugid: euid 125 egid 125 Jan 24 09:36:48 progressive postfix/local[94846]: deliver_dotforward: path /home/username/.forward expand_status 0 look_status -1 Jan 24 09:36:48 progressive postfix/local[94846]: deliver_mailbox[3]: local username recip username exten deliver username exp_from Jan 24 09:36:48 progressive postfix/local[94846]: been_here: mailbox username: 0 Jan 24 09:36:48 progressive postfix/local[94846]: deliver_mailbox[3]: set user_attr: username Jan 24 09:36:48 progressive postfix/local[94846]: deliver_command[4]: local username recip username exten deliver username exp_from Jan 24 09:36:48 progressive postfix/local[94846]: been_here: command username:1001 /usr/local/libexec/dovecot/deliver: 0 Jan 24 09:36:48 progressive postfix/local[94846]: connect to subsystem private/defer Jan 24 09:36:48 progressive postfix/local[94846]: send attr nrequest = 0 Jan 24 09:36:48 progressive postfix/local[94846]: send attr flags = 0 Jan 24 09:36:48 progressive postfix/local[94846]: send attr queue_id = 3AF5C6FC4A7 Jan 24 09:36:48 progressive postfix/local[94846]: send attr original_recipient = username Jan 24 09:36:48 progressive postfix/local[94846]: send attr recipient = username Jan 24 09:36:48 progressive postfix/local[94846]: send attr offset = 214 Jan 24 09:36:48 progressive postfix/local[94846]: send attr dsn_orig_rcpt = Jan 24 09:36:48 progressive postfix/local[94846]: send attr notify_flags = 0 Jan 24 09:36:48 progressive postfix/local[94846]: send attr status = 4.3.0 Jan 24 09:36:48 progressive postfix/local[94846]: send attr diag_type = x-unix Jan 24 09:36:48 progressive postfix/local[94846]: send attr diag_text = temporary failure Jan 24 09:36:48 progressive postfix/local[94846]: send attr mta_type = Jan 24 09:36:48 progressive postfix/local[94846]: send attr mta_mname = Jan 24 09:36:48 progressive postfix/local[94846]: send attr action = delayed Jan 24 09:36:48 progressive postfix/local[94846]: send attr reason = temporary failure Jan 24 09:36:48 progressive postfix/local[94846]: private/defer socket: wanted attribute: status So, is it truly calling "/usr/local/libexec/dovecot/deliver"? I can run that command from the commandline with the uid/gid it says its switching to. More importantly, that task is set to log, and it does NOT log anything when the above happens. It DOES log if I run it from the command line, and DID log until it decided to stop working. I know the answer is that something has changed on my system, but I'm trying to figure out exactly where that somethign is. The key quiestion is is there any further debugging I can do besides "local -v"? Any reason why it says it's going to deferred, or any true output I can get when postfix calls the deliver command? Thanks, falz Also, here's postconf -n: command_directory = /usr/local/sbin config_directory = /usr/local/etc/postfix daemon_directory = /usr/local/libexec/postfix debug_peer_level = 2 home_mailbox = Maildir/ html_directory = no mail_owner = postfix mailbox_command = /usr/local/libexec/dovecot/deliver mailq_path = /usr/local/bin/mailq manpage_directory = /usr/local/man mydestination = $myhostname, localhost.$mydomain, localhost, $mydomain myhostname = mail.example.com mynetworks = 127.0.0.0/8, 10.170.10.152/29, 10.170.18.160/29 mynetworks_style = host newaliases_path = /usr/local/bin/newaliases queue_directory = /var/spool/postfix readme_directory = no sample_directory = /usr/local/etc/postfix sendmail_path = /usr/local/sbin/sendmail setgid_group = maildrop smtp_tls_cert_file = /usr/local/etc/postfix/certs/example.com.crt smtp_tls_key_file = /usr/local/etc/postfix/certs/example.com.key smtp_tls_note_starttls_offer = yes smtpd_client_restrictions = check_client_access hash:/usr/local/etc/postfix/access smtpd_recipient_restrictions = permit_mynetworks, permit_sasl_authenticated, reject_unauth_destination smtpd_sasl_auth_enable = yes smtpd_sasl_local_domain = $mydomain smtpd_sasl_path = private/auth smtpd_sasl_type = dovecot smtpd_tls_CAfile = /usr/local/etc/postfix/certs/gd_intermediate_bundle.crt smtpd_tls_loglevel = 3 smtpd_tls_received_header = yes smtpd_tls_session_cache_timeout = 3600s smtpd_use_tls = yes tls_random_source = dev:/dev/urandom unknown_local_recipient_reject_code = 550
| ||||||||||||||||||||||||||||||
© 2004-2008 readlist.com