Forwarded to devs Ubuntu 16.04, Postfix, Incoming mail generates error messages

[B_P]

TITLE:

Ubuntu 16.04, Postfix, Incoming mail generates error messages​

PRODUCT, VERSION, OPERATING SYSTEM, ARCHITECTURE:

Ubuntu 16.04.6 LTS‬
Plesk Onyx, Version 17.8.11 Update #48​

PROBLEM DESCRIPTION:

Incoming messages cause an error message regarding /var/run/dovecot/stats-writer:

"Error: net_connect_unix(/var/run/dovecot/stats-writer)"​

STEPS TO REPRODUCE:

Send a message from a remote server to any mailbox on the Plesk server (running Ubuntu 16.04 + Plesk + Spamassassin + DrWeb + SPF + DKIM)​

ACTUAL RESULT:

The mail is delivered, as the following log file tells. Have a look at the last rows to find the error message:

Apr 5 23:41:33 myserver postfix/smtpd[20545]: 01561A007A: client=other-server[<ip>]
Apr 5 23:41:33 myserver greylisting filter[20633]: Starting greylisting filter...
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: handlers_stderr: SKIP
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: SKIP during call 'grey' handler
Apr 5 23:41:33 myserver postfix/cleanup[20631]: 01561A007A: message-id=<7a7467e3-b91a-0c8f-5dd2-3837e9243d3f@other-server>
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: handlers_stderr: SKIP
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: SKIP during call 'limit-out' handler
Apr 5 23:41:33 myserver check-quota[20636]: Starting the check-quota filter...
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: handlers_stderr: SKIP
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: SKIP during call 'check-quota' handler
Apr 5 23:41:33 myserver spf[20637]: Starting the spf filter...
Apr 5 23:41:33 myserver spf[20637]: Error code: (2) Could not find a valid SPF record
Apr 5 23:41:33 myserver spf[20637]: Failed to query MAIL-FROM: No DNS data for 'other-server'.
Apr 5 23:41:33 myserver spf[20637]: SPF result: none
Apr 5 23:41:33 myserver spf[20637]: SPF status: PASS
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: handlers_stderr: PASS
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: PASS during call 'spf' handler
Apr 5 23:41:33 myserver drweb[20638]: Starting the drweb filter...
Apr 5 23:41:33 myserver qmail-queue[20638]: scan: the message(drweb.tmp.3DKVoo) sent by [email protected] to me@myserver is passed
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: handlers_stderr: PASS
Apr 5 23:41:33 myserver /usr/lib/plesk-9.0/psa-pc-remote[1925]: PASS during call 'drweb' handler
Apr 5 23:41:33 myserver postfix/qmgr[4798]: 01561A007A: from=<user@other-server>, size=8988, nrcpt=1 (queue active)
Apr 5 23:41:33 myserver postfix-local[20642]: postfix-local: from=user@other-server, to=me@myserver, dirname=/var/qmail/mailnames
Apr 5 23:41:33 myserver postfix/smtpd[20545]: disconnect from other-server[<ip>] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
Apr 5 23:41:33 myserver spamassassin[20643]: Starting the spamassassin filter...
Apr 5 23:41:33 myserver spamd[5443]: spamd: connection from ::1 [::1]:36472 to port 783, fd 5
Apr 5 23:41:33 myserver spamd[5443]: spamd: using default config for me@myserver: /var/qmail/mailnames/mydomain/me/.spamassassin/user_prefs
Apr 5 23:41:33 myserver spamd[5443]: spamd: processing message <7a7467e3-b91a-0c8f-5dd2-3837e9243d3f@other-server> for me@myserver:30
Apr 5 23:41:33 myserver spamd[5443]: dns: new_dns_packet: domain is utf8 flagged: dns2.otherdomain
Apr 5 23:41:35 myserver spamd[5443]: spamd: clean message (0.0/5.0) for me@myserver:30 in 2.0 seconds, 9254 bytes.
Apr 5 23:41:35 myserver spamd[5443]: spamd: result: . 0 - scantime=2.0,size=9254,user=me@myserver,uid=30,required_score=5.0,rhost=::1,raddr=::1,rport=36472,mid=<7a7467e3-b91a-0c8f-5dd2-3837e9243d3f@other-server>,autolearn=ham autolearn_force=no,shortcircuit=no
Apr 5 23:41:35 myserver dk_check[20645]: Starting the dk_check filter...
Apr 5 23:41:35 myserver dk_check[20645]: DKIM verify result: Message is not signed
Apr 5 23:41:35 myserver dmarc[20646]: Starting the dmarc filter...
Apr 5 23:41:35 myserver dmarc[20646]: DMARC: PASS message for me@myserver
Apr 5 23:41:35 myserver spamd[5411]: prefork: child states: II
Apr 5 23:41:36 myserver dovecot: service=lda, user=me@myserver, ip=[]. sieve: msgid=<7a7467e3-b91a-0c8f-5dd2-3837e9243d3f@other-server>: stored mail into mailbox 'INBOX'
Apr 5 23:41:36 myserver plesk sendmail[20652]: handlers_stderr: PASS
Apr 5 23:41:36 myserver plesk sendmail[20652]: PASS during call 'limit-out' handler
Apr 5 23:41:36 myserver check-quota[20654]: Starting the check-quota filter...
Apr 5 23:41:36 myserver plesk sendmail[20652]: handlers_stderr: SKIP
Apr 5 23:41:36 myserver plesk sendmail[20652]: SKIP during call 'check-quota' handler
Apr 5 23:41:36 myserver postfix/pickup[10114]: 996CEA0088: uid=30 from=<SRS0=Ktg8=SH=other-server=me@myserver>
Apr 5 23:41:36 myserver postfix/pipe[20641]: 01561A007A: to=<me@myserver>, relay=plesk_virtual, delay=3.8, delays=0.66/0.01/0/3.1, dsn=2.0.0, status=sent (delivered via plesk_virtual service (lda(me@myserver,)Error: net_connect_unix(/var/run/dovecot/stats-writer) failed: Permission))
Apr 5 23:41:36 myserver postfix/qmgr[4798]: 01561A007A: removed​

EXPECTED RESULT:

postfix/pipe should be able to deliver / store the message without any error message regarding var/run/dovecot/stats-writer​

ANY ADDITIONAL INFORMATION:

​

YOUR EXPECTATIONS FROM PLESK SERVICE TEAM:

Help with sorting out​

 

[IgorG]

Thank you. Bugreport PPPM-10408 was submitted.

 

[G J Piper]

I am experiencing this in the last 24 hours which seems related... is it the same error?

postfix-local[4808]: process '/usr/libexec/dovecot/dovecot-lda -d "$DELIVERED_TO"' stderr : lda([email protected],)Error: net_connect_unix(/var/run/dovecot/stats-writer) failed: Permission denied

 

[Failure404]

I am experiencing this in the last 24 hours which seems related... is it the same error?

postfix-local[4808]: process '/usr/libexec/dovecot/dovecot-lda -d "$DELIVERED_TO"' stderr : lda([email protected],)Error: net_connect_unix(/var/run/dovecot/stats-writer) failed: Permission denied

Same error message here.

 

[Brujo]

@G J Piper @Failure404 for me it looks like an new issue which is also discussed in this Topic Resolved - LDA error message since last Plesk core update and it seems @zwankie found a workaround. Therefore I suggest to open a new Report for the reproducible error