Did you tell postfix it's talking to dovecot? Aki
On 25.03.2018 20:29, Vladimir Tiukhtin wrote: > > Hi guys. > > I am getting strange error: > > > BUG: Unknown command in userdb socket: CPID?2625 > > > I am using service auth to authenticate users on postfix. > > *My OS*: > > # cat /etc/os-release > NAME="CentOS Linux" > VERSION="7 (Core)" > ID="centos" > ID_LIKE="rhel fedora" > VERSION_ID="7" > PRETTY_NAME="CentOS Linux 7 (Core)" > ANSI_COLOR="0;31" > CPE_NAME="cpe:/o:centos:centos:7" > HOME_URL="https://www.centos.org/"; > BUG_REPORT_URL="https://bugs.centos.org/"; > > CENTOS_MANTISBT_PROJECT="CentOS-7" > CENTOS_MANTISBT_PROJECT_VERSION="7" > REDHAT_SUPPORT_PRODUCT="centos" > REDHAT_SUPPORT_PRODUCT_VERSION=" > > *My dovecot:* > > # dovecot --version > 2.2.10 > > *My config*: > > service auth { > unix_listener auth-userdb { > mode = 0600 > user = postfix > group = postfix > } > } > > *My Postfix:* > > # rpm -qa | grep postf > postfix-2.10.1-6.el7.x86_64 > > *Log*: > > Mar 25 16:52:33 mail-server postfix/smtpd[2625]: connect from > unknown[10.254.200.202] > Mar 25 16:52:33 mail-server dovecot[2621]: auth: Debug: Loading > modules from directory: /usr/lib64/dovecot/auth > Mar 25 16:52:33 mail-server dovecot[2621]: auth: Debug: Module loaded: > /usr/lib64/dovecot/auth/libdriver_mysql.so > Mar 25 16:52:33 mail-server dovecot[2621]: auth: Debug: Module loaded: > /usr/lib64/dovecot/auth/libdriver_sqlite.so > Mar 25 16:52:33 mail-server dovecot[2621]: auth: Debug: Read auth > token secret from /var/run/dovecot//auth-token-secret.dat > Mar 25 16:52:33 mail-server dovecot[2621]: auth: Debug: master in: > CPID 2625 > Mar 25 16:52:33 mail-server dovecot[2621]: auth: Error: BUG: Unknown > command in userdb socket: CPID?2625 > Mar 25 16:52:33 mail-server postfix/smtpd[2625]: fatal: no SASL > authentication mechanisms > Mar 25 16:52:34 mail-server postfix/master[2424]: warning: process > /usr/libexec/postfix/smtpd pid 2625 exit status 1 > Mar 25 16:52:34 mail-server postfix/master[2424]: warning: > /usr/libexec/postfix/smtpd: bad command startup -- throttling > > The interesting thing is IF I am taking off "-" (minus) from the > socket name, everything works just perfect! So if I change config to: > > service auth { > unix_listener blabla { > mode = 0600 > user = postfix > group = postfix > } > } > > Mar 25 16:55:12 mail-server postfix/smtpd[2872]: connect from > unknown[10.254.200.202] > Mar 25 16:55:12 mail-server dovecot[2786]: auth: Debug: Loading > modules from directory: /usr/lib64/dovecot/auth > Mar 25 16:55:12 mail-server dovecot[2786]: auth: Debug: Module loaded: > /usr/lib64/dovecot/auth/libdriver_mysql.so > Mar 25 16:55:12 mail-server dovecot[2786]: auth: Debug: Module loaded: > /usr/lib64/dovecot/auth/libdriver_sqlite.so > Mar 25 16:55:12 mail-server dovecot[2786]: auth: Debug: Read auth > token secret from /var/run/dovecot//auth-token-secret.dat > Mar 25 16:55:12 mail-server dovecot[2786]: auth: Debug: auth client > connected (pid=0) > Mar 25 16:55:13 mail-server dovecot[2786]: auth: Debug: client in: > AUTH 1 PLAIN service=smtp nologin > lip=192.168.101.24 rip=10.254.200.202 secured > resp=<hidden> > Mar 25 16:55:13 mail-server dovecot[2786]: auth: Debug: > cache(ad...@asergis.com,10.254.200.202): miss > Mar 25 16:55:13 mail-server dovecot[2786]: auth-worker(2878): Debug: > Loading modules from directory: /usr/lib64/dovecot/auth > Mar 25 16:55:13 mail-server dovecot[2786]: auth-worker(2878): Debug: > Module loaded: /usr/lib64/dovecot/auth/libdriver_mysql.so > Mar 25 16:55:13 mail-server dovecot[2786]: auth-worker(2878): Debug: > Module loaded: /usr/lib64/dovecot/auth/libdriver_sqlite.so > Mar 25 16:55:13 mail-server dovecot[2786]: auth-worker(2878): Debug: > sql(ad...@asergis.com,10.254.200.202): query: SELECT userid AS > username, domain, password FROM users WHERE userid = 'admin' AND > domain = 'asergis.com' > Mar 25 16:55:13 mail-server dovecot[2786]: auth: Debug: client passdb > out: OK 1 user=ad...@asergis.com > Mar 25 16:55:13 mail-server postfix/smtpd[2872]: 5C63030208: > client=unknown[10.254.200.202], sasl_method=PLAIN, > sasl_username=ad...@asergis.com > Mar 25 16:55:13 mail-server postfix/cleanup[2881]: 5C63030208: > message-id=<d7706aa7-a2ad-6890-5590-e6f83b5ec...@asergis.com> > Mar 25 16:55:13 mail-server postfix/qmgr[2870]: 5C63030208: > from=<ad...@asergis.com>, size=622, nrcpt=1 (queue active) > > > P.s. I don't mind to use socket without minus on its name. But this > looks really strange. Thanks. You are awesome > > > Vladimir >
