Postfix , dovecot error

NethServer release 7.3.1611 (Final)

Hello to all,
this postfix and dovecot blocked this morning, I had to restart the server to resume operation.
I attach the logs to you, what happened?
Thank you

Oct 16 10:19:15 servizi dovecot: master: Warning: SIGHUP received - reloading configuration
Oct 16 10:19:17 servizi postfix/trivial-rewrite[27582]: table hash:/etc/postfix/transport(0,lock|no_regsub|fold_fix) has changed – restarting
Oct 16 10:21:50 servizi postfix/anvil[27180]: statistics: max connection rate 4/60s for (submission:40.68.194.119) at Oct 16 10:12:52
Oct 16 10:21:50 servizi postfix/anvil[27180]: statistics: max connection count 2 for (submission:40.68.194.119) at Oct 16 10:12:43
Oct 16 10:21:50 servizi postfix/anvil[27180]: statistics: max cache size 4 at Oct 16 10:13:28
Oct 16 10:27:56 servizi clamd[1254]: SelfCheck: Database status OK.
Oct 16 10:32:44 servizi dovecot: master: Warning: SIGHUP received - reloading configuration
Oct 16 10:34:50 servizi postfix/smtpd[29468]: connect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:34:51 servizi postfix/smtpd[29468]: NOQUEUE: client=87-87-55-55.ip287.fastwebnet.it[87.87.55.55], sasl_method=LOGIN, sasl_username=amministrazione@dominio.ext
Oct 16 10:36:03 servizi postfix/smtpd[29580]: connect from 248-189-1-1.static.clienti.tiscali.it[248.189.1.1]
Oct 16 10:36:04 servizi postfix/smtpd[29580]: NOQUEUE: client=248-189-1-1.static.clienti.tiscali.it[248.189.1.1], sasl_method=LOGIN, sasl_username=ced@dominio.ext
Oct 16 10:36:27 servizi postfix/smtpd[29612]: connect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:36:28 servizi postfix/smtpd[29612]: NOQUEUE: client=87-87-55-55.ip287.fastwebnet.it[87.87.55.55], sasl_method=LOGIN, sasl_username=amministrazione@dominio.ext
Oct 16 10:36:36 servizi postfix/smtpd[29468]: warning: timeout talking to proxy 127.0.0.1:10587
Oct 16 10:36:36 servizi postfix/smtpd[29468]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=amministrazione@dominio.ext to=abifone@esempio.ext proto=ESMTP helo=
Oct 16 10:36:36 servizi postfix/smtpd[29468]: disconnect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:37:44 servizi postfix/smtpd[29580]: warning: timeout talking to proxy 127.0.0.1:10587
Oct 16 10:37:44 servizi postfix/smtpd[29580]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=ced@dominio.ext to=ced@dominio.ext proto=ESMTP helo=
Oct 16 10:37:44 servizi postfix/smtpd[29580]: disconnect from 248-189-1-1.static.clienti.tiscali.it[248.189.1.1]
Oct 16 10:37:56 servizi clamd[1254]: SelfCheck: Database status OK.
Oct 16 10:38:14 servizi postfix/smtpd[29612]: warning: timeout talking to proxy 127.0.0.1:10587
Oct 16 10:38:14 servizi postfix/smtpd[29612]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=amministrazione@dominio.ext to=abifone@esempio.ext proto=ESMTP helo=
Oct 16 10:38:14 servizi postfix/smtpd[29612]: disconnect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:38:15 servizi postfix/smtpd[29468]: connect from 248-189-1-1.static.clienti.tiscali.it[248.189.1.1]
Oct 16 10:38:15 servizi postfix/smtpd[29468]: NOQUEUE: client=248-189-1-1.static.clienti.tiscali.it[248.189.1.1], sasl_method=LOGIN, sasl_username=ced@dominio.ext
Oct 16 10:38:45 servizi postfix/smtpd[29580]: connect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:38:46 servizi postfix/smtpd[29580]: NOQUEUE: client=87-87-55-55.ip287.fastwebnet.it[87.87.55.55], sasl_method=LOGIN, sasl_username=amministrazione@dominio.ext
Oct 16 10:39:56 servizi postfix/smtpd[29468]: warning: timeout talking to proxy 127.0.0.1:10587
Oct 16 10:39:56 servizi postfix/smtpd[29468]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=ced@dominio.ext to=ced@dominio.ext proto=ESMTP helo=
Oct 16 10:39:56 servizi postfix/smtpd[29468]: disconnect from 248-189-1-1.static.clienti.tiscali.it[248.189.1.1]
Oct 16 10:40:31 servizi postfix/smtpd[29580]: warning: timeout talking to proxy 127.0.0.1:10587
Oct 16 10:40:31 servizi postfix/smtpd[29580]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=amministrazione@dominio.ext to=abifone@esempio.ext proto=ESMTP helo=
Oct 16 10:40:31 servizi postfix/smtpd[29580]: disconnect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:40:52 servizi postfix/smtpd[29468]: connect from 248-189-1-1.static.clienti.tiscali.it[248.189.1.1]
Oct 16 10:40:53 servizi postfix/smtpd[29468]: NOQUEUE: client=248-189-1-1.static.clienti.tiscali.it[248.189.1.1], sasl_method=LOGIN, sasl_username=ced@dominio.ext
Oct 16 10:41:10 servizi postfix/smtpd[29580]: connect from 87-87-55-55.ip287.fastwebnet.it[87.87.55.55]
Oct 16 10:41:10 servizi postfix/smtpd[29580]: NOQUEUE: client=87-87-55-55.ip287.fastwebnet.it[87.87.55.55], sasl_method=LOGIN, sasl_username=amministrazione@dominio.ext
Oct 16 10:42:09 servizi amavis[1741]: sd_notify (no socket): STOPPING=1\nSTATUS=Server rundown, notifying child processes.
Oct 16 10:42:09 servizi amavis[1741]: Net::Server: 2017/10/16-10:42:09 Server closing!
Oct 16 10:42:09 servizi amavis[1741]: sd_notify (no socket): STATUS=Child processes have been stopped.
Oct 16 10:42:09 servizi postfix/smtpd[29580]: warning: lost connection with proxy 127.0.0.1:10587
Oct 16 10:42:09 servizi postfix/smtpd[29580]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=amministrazione@dominio.ext to=abifone@esempio.ext proto=ESMTP helo=
Oct 16 10:42:09 servizi postfix/smtpd[29468]: warning: lost connection with proxy 127.0.0.1:10587
Oct 16 10:42:09 servizi postfix/smtpd[29468]: proxy-reject: END-OF-MESSAGE: 451 4.3.0 Error: queue file write error; from=ced@dominio.ext to=ced@dominio.ext proto=ESMTP helo=
Oct 16 10:42:09 servizi postfix/smtpd[29468]: disconnect from 248-189-1-1.static.clienti.tiscali.it[248.189.1.1]
Oct 16 10:42:47 servizi dovecot: master: Dovecot v2.2.10 starting up for imap, lmtp, sieve, pop3 (core dumps disabled)
Oct 16 10:42:47 servizi clamd[1323]: Received 0 file descriptor(s) from systemd.
Oct 16 10:42:47 servizi clamd[1323]: clamd daemon 0.99.2 (OS: linux-gnu, ARCH: x86_64, CPU: x86_64)
Oct 16 10:42:47 servizi clamd[1323]: Running as user amavis (UID 991, GID 987)
Oct 16 10:42:47 servizi clamd[1323]: Log file size limited to 1048576 bytes.
Oct 16 10:42:47 servizi clamd[1323]: Reading databases from /var/lib/clamav
Oct 16 10:42:47 servizi clamd[1323]: Not loading PUA signatures.
Oct 16 10:42:47 servizi clamd[1323]: Bytecode: Security mode set to “TrustSigned”.
Oct 16 10:42:47 servizi spamd[1046]: logger: removing stderr method
Oct 16 10:42:47 servizi postfix/postfix-script[1534]: starting the Postfix mail system
Oct 16 10:42:48 servizi amavis[992]: logging initialized, log level 2, syslog: amavis.mail
Oct 16 10:42:48 servizi amavis[992]: sd_notify (no socket): STATUS=Config files have been read, modules loaded.
Oct 16 10:42:48 servizi amavis[992]: starting. /usr/sbin/amavisd at servizi.dominio.ext amavisd-new-2.11.0 (20160426), Unicode aware, LANG=“en_US.UTF-8”
Oct 16 10:42:48 servizi amavis[992]: perl=5.016003, user=991, EUID: 991 (991); group=, EGID: 987 987 (987 987)
Oct 16 10:42:48 servizi amavis[992]: INFO: no optional modules: unicore::lib::Nt::De.pl Uni

amavisd runs on port 10587 and only if you enabled the disclaimer.
You could increase $log_level to 5 in amavisd.conf and check the logs if it happens again.

2 Likes

thanks Filippo for you replay,

I changed log to value 5, but amais logs only see maillog? or is there a specific log for amavis?

I have the active disclaimer.
Thank you