Cyrus + Postfix through LMTP problem

Nybbles2Byte nybbles2byte at gmail.com
Sat Jul 11 07:35:41 EDT 2009


Hello,

I seem to have one nagging problem in getting my Cyrus to work in that it won't talk with Postfix.
They are on the same computer and are connected through LMTP. I use MySQL for authentication, 
directly through Postfix and via SASL for Cyrus. I can connect to Cyrus through my email client 
on another computer to the same email address that Postfix is having a problem with.

From the detailed debug log from Postfix it seems to me that Cyrus is rejecting the email but
all the detail in the log suggests that Postfix is passing Cyrus the correct information. Being
a newbie on Linux and all the components in this setup I could very well be wrong in this 
conclusion so I am hoping someone much more experienced can shed some light on this problem.

Below is all the outputs I could create from sending an email to and from the same account as 
a test plus all the setup information to go with it - with comments and some other 
irrelevancies stripped to make a little as possible to look through.

I know this is my last problem but I've run out of ideas on where to look to solve it so help 
would be greatly appreciated!

-Reggie

-----------------------------------------------------------------------------------------------------
- VERSIONS OF SOFTWARE (all x86_64)
-----------------------------------------------------------------------------------------------------
Cyrus-IMAP  2.3.11- 31.1
Cyrus-SASL  2.1.22-140.2
Postfix     2.5. 1- 28.5


-----------------------------------------------------------------------------------------------------
- PROOF OF EXISTENCE OF MAILBOXES
-----------------------------------------------------------------------------------------------------
neutrino:/var/mail # cyradm -u root at localhost localhost
Password: 
localhost> lm *@stuv.com
user.sales at stuv.com (\HasNoChildren)  
localhost> 


-----------------------------------------------------------------------------------------------------
- ADDITIONAL VERIFICATION OF MAILBOXES -> OUTPUT FROM "tree -Ad" on Cyrus data (mailboxes) directory
-----------------------------------------------------------------------------------------------------
.
??? domain
?   ??? s
?       ??? stuv.com
?           ??? u
?               ??? user^sales
??? stage.
??? sync.


-----------------------------------------------------------------------------------------------------
- CYRUS SETUP File: "cyrus.conf"
-----------------------------------------------------------------------------------------------------
START {
  recover   cmd="ctl_cyrusdb -r"
  idled	    cmd="idled"
}
SERVICES {
  imap	   	cmd="imapd" 	listen="imap"	prefork=0
  sieve		cmd="timsieved"	listen="sieve"	prefork=0
  lmtpunix	cmd="lmtpd" 	listen="/var/lib/imap/socket/lmtp" prefork=0
  notify	cmd="notifyd" 	listen="/var/lib/imap/socket/notify" proto="udp" prefork=0
}

EVENTS {
  checkpoint  cmd="ctl_cyrusdb -c"  period=30
  delprune    cmd="cyr_expire -E 3" at=0400
  tlsprune    cmd="tls_prune" 	    at=0400
}


-----------------------------------------------------------------------------------------------------
- CYRUS SETUP File: "imap.conf"
-----------------------------------------------------------------------------------------------------
sasl_auxprop_plugin: sql
sasl_log_level: 7
sasl_mech_list: PLAIN LOGIN CRAM-MD5 DIGEST-MD5
sasl_pwcheck_method: auxprop
sasl_sql_hostnames: localhost
sasl_sql_user: cyrus
sasl_sql_passwd: XXXXXXXXXXXX
sasl_sql_database: mail
sasl_sql_select: SELECT `password` FROM `accounts` WHERE `user`='%u' AND `realm`='%r' AND `virtual` != 0
sasl_sql_insert: INSERT INTO `accounts` (`user`, `realm`, `password`) VALUES ('%u', '%r', '%v')
sasl_sql_update: UPDATE `accounts` SET `user`='%u',`realm`='%r',`password`='%v' WHERE `user`='%u' AND `realm`='%r'

admins: cyrus root
allowplaintext: 1
altnamespace: 1
anyoneuseracl: 0
auth_mech: unix
configdirectory: /var/lib/imap
defaultdomain: localhost

drachost: localhost
dracinterval: 0

foolstupidclients: 1

hashimapspool: 1

improved_mboxlist_sort: 1
lmtp_downcase_rcpt: 1
lmtp_strict_quota: 1
logtimestamps: 1
partition-default: /var/mail/cyrus
popsubfolders: 1
poptimeout: 10
sendmail: /usr/sbin/sendmail
sievedir: /var/mail/sieve
syslog_prefix: SeoWS
unixhierarchysep: 1
virtdomains: 1


-----------------------------------------------------------------------------------------------------
- POSTFIX SETUP File: "master.cf" (relevant lines only)
-----------------------------------------------------------------------------------------------------
virtual   unix  -       n       n       -       -       virtual
lmtp      unix  -       -       n       -       -       lmtp    -v

cyrus     unix  -       n       n       -       -       pipe
  user=cyrus argv=/usr/lib/cyrus/bin/deliver -e -r ${sender} -m ${extension} ${user}


-----------------------------------------------------------------------------------------------------
- POSTFIX SETUP File: "main.cf"
-----------------------------------------------------------------------------------------------------
alias_maps = hash:/etc/aliases, mysql:/etc/postfix/mysql-local-aliases.cf
command_directory = /usr/sbin
config_directory = /etc/postfix
daemon_directory = /usr/lib/postfix
debug_peer_level = 7
home_mailbox = Maildir/
html_directory = /usr/share/doc/packages/postfix24/html
inet_protocols = all
local_destination_concurrency_limit = 5
local_destination_recipient_limit = 300
mail_owner = postfix
mailq_path = /usr/bin/mailq
manpage_directory = /usr/share/man
mydestination = 
mydomain = stuv.com
myhostname = neutrino.stuv.com
mynetworks = 192.168.17.0/24, 173.11.84.1, 173.11.84.2, 127.0.0.0/8
myorigin = $mydomain
newaliases_path = /usr/bin/newaliases
queue_directory = /var/spool/postfix
readme_directory = /usr/share/doc/packages/postfix24/README_FILES
sample_directory = /usr/share/doc/packages/postfix24/samples
sendmail_path = /usr/sbin/sendmail
setgid_group = maildrop
smtpd_recipient_restrictions = permit_mynetworks, permit_auth_destination, permit_sasl_authenticated, reject_unauth_destination
soft_bounce = yes
unknown_local_recipient_reject_code = 550
virtual_alias_maps = mysql:/etc/postfix/mysql-virtual-aliases.cf
virtual_gid_maps = static:124
virtual_mailbox_domains = mysql:/etc/postfix/mysql-virtual-mailbox-domains.cf
virtual_mailbox_maps = mysql:/etc/postfix/mysql-virtual-mailboxes.cf
virtual_transport = lmtp:unix:/var/lib/imap/socket/lmtp
virtual_uid_maps = static:1002


-----------------------------------------------------------------------------------------------------
- SASL OUTPUT - File: "auth.log"
-----------------------------------------------------------------------------------------------------
Jul 11 03:39:24 neutrino SeoWS/lmtpunix[11084]: sql auxprop plugin using mysql engine


-----------------------------------------------------------------------------------------------------
- MySQL QUERY OUTPUT - File: "mysqld-query.log"
-----------------------------------------------------------------------------------------------------
090711  3:39:2414254 Connect	postfix at localhost on mail
		14254 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='stuv.com' AND `virtual` != 0
		14255 Connect	postfix at localhost on mail
		14255 Query	SELECT realm FROM accounts WHERE realm='stuv.com' AND `virtual` != 0 LIMIT 1
		14256 Connect	postfix at localhost on mail
		14256 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='sales at stuv.com' AND `virtual` != 0
		14256 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='sales' AND `virtual` != 0
		14256 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='@stuv.com' AND `virtual` != 0
		14257 Connect	postfix at localhost on mail
		14257 Query	SELECT CONCAT(`realm`, '/user.', `user`) AS maildir FROM accounts WHERE CONCAT_WS('@', `user`, `realm`)='sales at stuv.com' AND `virtual` != 0
		14258 Connect	postfix at localhost on mail
		14258 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='sales at stuv.com' AND `virtual` != 0
		14258 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='sales' AND `virtual` != 0
		14258 Query	SELECT `send_to` FROM `aliases` WHERE `alias`='@stuv.com' AND `virtual` != 0


-----------------------------------------------------------------------------------------------------
- POSTFIX DEBUG LEVEL ON LMTP OUTPUT - File: "mail"
-----------------------------------------------------------------------------------------------------
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: smtp_connect_unix: trying: /var/lib/imap/socket/lmtp...
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: global TLS level: none
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 220 neutrino LMTP Cyrus v2.3.11 ready
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: > neutrino.stuv.com[/var/lib/imap/socket/lmtp]: LHLO neutrino.stuv.com
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250-neutrino
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250-8BITMIME
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250-ENHANCEDSTATUSCODES
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250-PIPELINING
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250-SIZE
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250-AUTH EXTERNAL
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250 IGNOREQUOTA
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: server features: 0xf size 0
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: Using LMTP PIPELINING, TCP send buffer size is 4096
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: > neutrino.stuv.com[/var/lib/imap/socket/lmtp]: MAIL FROM:<sales at stuv.com> SIZE=1520
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: > neutrino.stuv.com[/var/lib/imap/socket/lmtp]: RCPT TO:<sales at stuv.com>
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: > neutrino.stuv.com[/var/lib/imap/socket/lmtp]: DATA
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250 2.1.0 ok
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 550-Mailbox unknown.  Either there is no mailbox associated with this
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 550-name or you do not have authorization to see it.
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 550 5.1.1 User unknown
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: connect to subsystem private/defer
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr nrequest = 0
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr flags = 0
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr queue_id = 1E8E1D67BB
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr original_recipient = sales at stuv.com
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr recipient = sales at stuv.com
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr offset = 498
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr dsn_orig_rcpt = rfc822;sales at stuv.com
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr notify_flags = 0
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr status = 4.1.1
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr diag_type = smtp
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr diag_text = 550-Mailbox unknown.  Either there is no mailbox associated with this 550-name or you do not have authorization to see it. 550 5.1.1 User unknown
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr mta_type = dns
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr mta_mname = neutrino.stuv.com
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr action = delayed
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr reason = host neutrino.stuv.com[/var/lib/imap/socket/lmtp] said: 550-Mailbox unknown.  Either there is no mailbox associated with this 550-name or you do not have authorization to see it. 550 5.1.1 User unknown (in reply to RCPT TO command)
Jul 11 03:39:24 neutrino postfix/smtpd[11074]: disconnect from unknown[192.168.17.1]
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: private/defer socket: wanted attribute: status
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: input attribute name: status
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: input attribute value: 0
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: private/defer socket: wanted attribute: (list terminator)
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: input attribute name: (end)
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: 1E8E1D67BB: to=<sales at stuv.com>, relay=neutrino.stuv.com[/var/lib/imap/socket/lmtp], delay=0.09, delays=0.03/0.02/0.01/0.04, dsn=4.1.1, status=SOFTBOUNCE (host neutrino.stuv.com[/var/lib/imap/socket/lmtp] said: 550-Mailbox unknown.  Either there is no mailbox associated with this 550-name or you do not have authorization to see it. 550 5.1.1 User unknown (in reply to RCPT TO command))
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 503 5.5.1 No recipients
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: > neutrino.stuv.com[/var/lib/imap/socket/lmtp]: RSET
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: > neutrino.stuv.com[/var/lib/imap/socket/lmtp]: QUIT
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: < neutrino.stuv.com[/var/lib/imap/socket/lmtp]: 250 2.0.0 ok
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: name_mask: resource
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: name_mask: software
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: deliver_request_final: send: "" -1
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr status = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr diag_type = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr diag_text = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr mta_type = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr mta_mname = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr action = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr reason = 
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: send attr status = 4294967295
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: master_notify: status 1
Jul 11 03:39:24 neutrino postfix/lmtp[11083]: connection closed
-----------------------------------------------------------------------------------------------------
- END POSTFIX OUTPUT
-----------------------------------------------------------------------------------------------------

-- 
Reg                          mailto:nybbles2byte at gmail.com
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.andrew.cmu.edu/pipermail/info-cyrus/attachments/20090711/061798fc/attachment-0001.html 


More information about the Info-cyrus mailing list