1 (edited by ale_punta 2018-05-11 16:45:24)

Topic: can't send/receive emails from local domain

======== Required information ====
- iRedMail version (check /etc/iredmail-release): 0.9.8
- Linux/BSD distribution name and version: Debian GNU/Linux 9.4 (stretch)
- Store mail accounts in which backend (LDAP/MySQL/PGSQL): OpenLDAP
- Web server (Apache or Nginx): Nginx
- Manage mail accounts with iRedAdmin-Pro? No
- [IMPORTANT] Related original log or error message is required if you're experiencing an issue.
====

Hi,

Roundcube, iredadmin and netdata works, but i try to send one email from user1@proyectoarj.tk to user2@proyectoarj.tk, the email stay in the "sends" file in a roudcube but user2 never receive the email.

My server is a Virtual Machine on Oracle VirtualBox.
Server: debian.proyectoarj.tk IP: 192.168.1.200

steps
show users accounts in the domain:

users

now i log in the roundcube with user1 and try to send email to user2:

users

the email stay in the "Sent" file:

users

now i log in the roundcube with user2 and hes dont have emails

users

I see some errors in the postfix log:

May 10 12:28:09 debian postfix/qmgr[2046]: 7C84D5FC70: from=<user1@proyectoarj.tk>, size=550, nrcpt=1 (queue active)
May 10 12:28:09 debian amavis[2048]: (02048-04) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 10 12:28:09 debian amavis[2048]: (02048-04) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180510T122809-02048-HtHIoyJP
May 10 12:28:09 debian postfix/amavis/smtp[3859]: 7C84D5FC70: to=<user2@proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10026, delay=2253, delays=2253/0.01/0/0.04, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] d: 451 4.5.0 Error in processing, id=02048-04, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))
May 10 12:33:09 debian postfix/qmgr[2046]: D5F865FC79: from=<amavis@debian.proyectoarj.tk>, size=725, nrcpt=1 (queue active)
May 10 12:33:09 debian postfix/qmgr[2046]: 34D8B5FC7A: from=<user1@proyectoarj.tk>, size=577, nrcpt=1 (queue active)
May 10 12:33:09 debian amavis[2047]: (02047-04) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 10 12:33:09 debian amavis[2047]: (02047-04) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180510T123309-02047-VbR_lWbx
May 10 12:33:09 debian amavis[2051]: (02051-05) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 10 12:33:09 debian amavis[2051]: (02051-05) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180510T123309-02051-wjbNHqm0
May 10 12:33:09 debian postfix/amavis/smtp[3998]: D5F865FC79: to=<amavis@debian.proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10024, delay=904, delays=904/0.01/0/0.04, dsn=4.5.0, status=deferred (host 127.0.0.1[127.01] said: 451 4.5.0 Error in processing, id=02047-04, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))
May 10 12:33:09 debian postfix/amavis/smtp[4000]: 34D8B5FC7A: to=<user2@proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10026, delay=468, delays=468/0.02/0/0.05, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] sa 451 4.5.0 Error in processing, id=02051-05, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))
May 10 12:38:09 debian postfix/qmgr[2046]: DC4F55FC75: from=<netdata@debian.proyectoarj.tk>, size=9247, nrcpt=1 (queue active)
May 10 12:38:09 debian amavis[2050]: (02050-05) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 10 12:38:09 debian amavis[2050]: (02050-05) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180510T123809-02050-NQ0sSo81
May 10 12:38:09 debian postfix/amavis/smtp[4142]: DC4F55FC75: to=<root@debian.proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10024, delay=2305, delays=2305/0.01/0/0.04, dsn=4.5.0, status=deferred (host 127.0.0.1[127.01] said: 451 4.5.0 Error in processing, id=02050-05, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))
May 10 12:38:26 debian roundcube: <7jse9c12> PHP Error: LDAP: ldap_list failed for dn=domainName=proyectoarj.tk,o=domains,dc=proyectoarj,dc=tk. Bad search filter (POST /mail/?_task=mail&_action=autocomplete)
May 10 12:40:58 debian postfix/submission/smtpd[4270]: connect from debian.proyectoarj.tk[127.0.0.1]
May 10 12:40:58 debian postfix/submission/smtpd[4270]: Anonymous TLS connection established from debian.proyectoarj.tk[127.0.0.1]: TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 (128/128 bits)
May 10 12:40:58 debian postfix/submission/smtpd[4270]: A56DB5FC7C: client=debian.proyectoarj.tk[127.0.0.1], sasl_method=LOGIN, sasl_username=user1@proyectoarj.tk
May 10 12:40:58 debian postfix/cleanup[4273]: A56DB5FC7C: message-id=<3b478ec21770f72c37b362bef8103445@proyectoarj.tk>
May 10 12:40:58 debian postfix/qmgr[2046]: A56DB5FC7C: from=<user1@proyectoarj.tk>, size=558, nrcpt=1 (queue active)
May 10 12:40:58 debian roundcube: <7jse9c12> User user1@proyectoarj.tk [192.168.1.100]; Message for user2@proyectoarj.tk; 250: 2.0.0 Ok: queued as A56DB5FC7C
May 10 12:40:58 debian postfix/submission/smtpd[4270]: disconnect from debian.proyectoarj.tk[127.0.0.1] ehlo=2 starttls=1 auth=1 mail=1 rcpt=1 data=1 quit=1 commands=8
May 10 12:40:58 debian amavis[2049]: (02049-05) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 10 12:40:58 debian amavis[2049]: (02049-05) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180510T124058-02049-ylpP3RQk
May 10 12:40:58 debian postfix/amavis/smtp[4274]: A56DB5FC7C: to=<user2@proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10026, delay=0.12, delays=0.06/0.01/0/0.05, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] d: 451 4.5.0 Error in processing, id=02049-05, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))
May 10 12:43:09 debian postfix/qmgr[2046]: 34D8B5FC7A: from=<user1@proyectoarj.tk>, size=577, nrcpt=1 (queue active)
May 10 12:43:09 debian amavis[2048]: (02048-05) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 10 12:43:09 debian amavis[2048]: (02048-05) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180510T124309-02048-RqFraVzY
May 10 12:43:09 debian postfix/amavis/smtp[4348]: 34D8B5FC7A: to=<user2@proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10026, delay=1068, delays=1068/0.02/0/0.05, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] d: 451 4.5.0 Error in processing, id=02048-05, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))

What can i do?

Thank you very much

----

Spider Email Archiver: On-Premises, lightweight email archiving software developed by iRedMail team. Supports Amazon S3 compatible storage and custom branding.

2

Re: can't send/receive emails from local domain

/var/log/clamav/freshclam.log

Fri May 11 10:15:30 2018 -> --------------------------------------
Fri May 11 10:15:30 2018 -> freshclam daemon 0.99.4 (OS: linux-gnu, ARCH: x86_64, CPU: x86_64)
Fri May 11 10:15:30 2018 -> ClamAV update process started at Fri May 11 10:15:30 2018
Fri May 11 10:15:30 2018 -> WARNING: Can't query current.cvd.clamav.net
Fri May 11 10:15:30 2018 -> WARNING: Invalid DNS reply. Falling back to HTTP mode.
Fri May 11 10:15:30 2018 -> Reading CVD header (main.cvd): Fri May 11 10:15:30 2018 -> WARNING: Can't get information about db.local.clamav.net: Temporary failure in name resolution
Fri May 11 10:15:30 2018 -> WARNING: Can't read main.cvd header from db.local.clamav.net (IP: )
Fri May 11 10:15:30 2018 -> Trying again in 5 secs...
Fri May 11 10:15:35 2018 -> ClamAV update process started at Fri May 11 10:15:35 2018
Fri May 11 10:15:36 2018 -> WARNING: Your ClamAV installation is OUTDATED!
Fri May 11 10:15:36 2018 -> WARNING: Local version: 0.99.4 Recommended version: 0.100.0
Fri May 11 10:15:36 2018 -> DON'T PANIC! Read http://www.clamav.net/documents/upgrading-clamav
Fri May 11 10:15:36 2018 -> main.cvd is up to date (version: 58, sigs: 4566249, f-level: 60, builder: sigmgr)
Fri May 11 10:16:21 2018 -> Downloading daily-24557.cdiff [100%]
Fri May 11 10:16:36 2018 -> Downloading daily-24558.cdiff [100%]
Fri May 11 10:16:38 2018 -> Downloading daily-24559.cdiff [100%]
Fri May 11 10:16:40 2018 -> daily.cld updated (version: 24559, sigs: 1942395, f-level: 63, builder: neo)
Can't query daily.24559.85.1.0.823B7124.ping.clamav.net
Fri May 11 10:16:40 2018 -> bytecode.cvd is up to date (version: 319, sigs: 75, f-level: 63, builder: neo)
Fri May 11 10:16:47 2018 -> Database updated (6508719 signatures) from db.local.clamav.net (IP: 130.59.113.36)
Fri May 11 10:16:47 2018 -> ERROR: NotifyClamd: Can't find or parse configuration file /etc/clamav/clamd.conf
Fri May 11 10:16:47 2018 -> --------------------------------------

systemctl status clamav-daemon

root@debian:/var/log# systemctl status clamav-daemon
● clamav-daemon.service - Clam AntiVirus userspace daemon
   Loaded: loaded (/lib/systemd/system/clamav-daemon.service; enabled; vendor preset: enabled)
  Drop-In: /etc/systemd/system/clamav-daemon.service.d
           └─extend.conf
   Active: failed (Result: exit-code) since Fri 2018-05-11 10:15:29 CEST; 9min ago
     Docs: man:clamd(8)
           man:clamd.conf(5)
           http://www.clamav.net/lang/en/doc/
  Process: 451 ExecStart=/usr/sbin/clamd --foreground=true (code=exited, status=1/FAILURE)
  Process: 429 ExecStartPre=/bin/chown clamav /run/clamav (code=exited, status=0/SUCCESS)
  Process: 401 ExecStartPre=/bin/mkdir /run/clamav (code=exited, status=0/SUCCESS)
 Main PID: 451 (code=exited, status=1/FAILURE)

may 11 10:15:23 debian systemd[1]: Starting Clam AntiVirus userspace daemon...
may 11 10:15:26 debian systemd[1]: Started Clam AntiVirus userspace daemon.
may 11 10:15:29 debian clamd[451]: ERROR: Parse error at line 90: Unknown option AllowSupplementaryGroups
may 11 10:15:29 debian clamd[451]: ERROR: Can't open/parse the config file /etc/clamav/clamd.conf
may 11 10:15:29 debian systemd[1]: clamav-daemon.service: Main process exited, code=exited, status=1/FAILURE
may 11 10:15:29 debian systemd[1]: clamav-daemon.service: Unit entered failed state.
may 11 10:15:29 debian systemd[1]: clamav-daemon.service: Failed with result 'exit-code'.

systemctl status amavis

● amavis.service - LSB: Starts amavisd-new mailfilter
   Loaded: loaded (/etc/init.d/amavis; generated; vendor preset: enabled)
   Active: active (running) since Fri 2018-05-11 10:16:04 CEST; 15min ago
     Docs: man:systemd-sysv-generator(8)
  Process: 588 ExecStart=/etc/init.d/amavis start (code=exited, status=0/SUCCESS)
    Tasks: 6 (limit: 4915)
   CGroup: /system.slice/amavis.service
           ├─2173 /usr/sbin/amavisd-new (master)
           ├─2189 /usr/sbin/amavisd-new (ch1-avail)
           ├─2190 /usr/sbin/amavisd-new (virgin child)
           ├─2191 /usr/sbin/amavisd-new (ch1-avail)
           ├─2192 /usr/sbin/amavisd-new (ch1-avail)
           └─2193 /usr/sbin/amavisd-new (ch1-avail)

may 11 10:16:04 debian amavis[2173]: No decoder for       .F
may 11 10:16:04 debian amavis[2173]: No decoder for       .zoo
may 11 10:20:16 debian amavis[2192]: (02192-01) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
may 11 10:20:16 debian amavis[2192]: (02192-01) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180511T102016-02192-yzfJWPhz
may 11 10:20:32 debian amavis[2193]: (02193-01) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
may 11 10:20:32 debian amavis[2193]: (02193-01) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180511T102032-02193-bN80A34J
may 11 10:26:04 debian amavis[2191]: (02191-01) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
may 11 10:26:04 debian amavis[2191]: (02191-01) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180511T102604-02191-eEpujVj5
may 11 10:26:04 debian amavis[2189]: (02189-01) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
may 11 10:26:04 debian amavis[2189]: (02189-01) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180511T102604-02189-rueV0_lv

/var/log/dovecot/dovecot.log

May 10 09:59:17 debian dovecot: master: Dovecot v2.2.27 (c0f36b0) starting up for pop3, imap, sieve, lmtp (core dumps disabled)
May 11 10:15:30 debian dovecot: master: Dovecot v2.2.27 (c0f36b0) starting up for pop3, imap, sieve, lmtp (core dumps disabled)
root@debian:/var/log#

/var/log/mail.log

May 11 10:26:04 debian postfix/qmgr[2053]: 4A9EC5FA78: from=<user1@proyectoarj.tk>, size=555, nrcpt=1 (queue active)
May 11 10:26:04 debian postfix/qmgr[2053]: B3B485FA7F: from=<root@debian.proyectoarj.tk>, size=6436, nrcpt=1 (queue active)
May 11 10:26:04 debian amavis[2191]: (02191-01) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 11 10:26:04 debian amavis[2191]: (02191-01) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180511T102604-02191-eEpujVj5
May 11 10:26:04 debian postfix/amavis/smtp[3330]: 4A9EC5FA78: to=<user2@proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10026, delay=348, delays=348/0.01/0/0.05, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] said: 451 4.5.0 Error in processing, id=02191-01, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))
May 11 10:26:04 debian amavis[2189]: (02189-01) (!!)TROUBLE in check_mail: check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766.
May 11 10:26:04 debian amavis[2189]: (02189-01) (!)PRESERVING EVIDENCE in /var/lib/amavis/tmp/amavis-20180511T102604-02189-rueV0_lv
May 11 10:26:04 debian postfix/amavis/smtp[3332]: B3B485FA7F: to=<root@debian.proyectoarj.tk>, relay=127.0.0.1[127.0.0.1]:10024, delay=332, delays=332/0.03/0/0.04, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] said: 451 4.5.0 Error in processing, id=02189-01, check_init2 FAILED: Could not open /etc/resolv.conf: No such file or directory at /usr/sbin/amavisd-new line 17766. (in reply to end of DATA command))

/var/log/messages

May 11 10:15:38 debian kernel: [   29.167760] nf_conntrack version 0.5.0 (65536 buckets, 262144 max)
May 11 10:15:41 debian uwsgi: *** Starting uWSGI 2.0.14-debian (64bit) on [Fri May 11 10:15:33 2018] ***
May 11 10:15:41 debian uwsgi: compiled with version: 6.3.0 20170516 on 17 March 2018 15:41:47
May 11 10:15:41 debian uwsgi: os: Linux-4.9.0-6-amd64 #1 SMP Debian 4.9.82-1+deb9u3 (2018-03-02)
May 11 10:15:41 debian uwsgi: nodename: debian
May 11 10:15:41 debian uwsgi: machine: x86_64
May 11 10:15:41 debian uwsgi: clock source: unix
May 11 10:15:41 debian uwsgi: pcre jit disabled
May 11 10:15:41 debian uwsgi: detected number of CPU cores: 1
May 11 10:15:41 debian uwsgi: current working directory: /
May 11 10:15:41 debian uwsgi: writing pidfile to /var/run/mlmmjadmin/mlmmjadmin.pid
May 11 10:15:41 debian uwsgi: detected binary path: /usr/bin/uwsgi-core
May 11 10:15:41 debian uwsgi: setgid() to 2003
May 11 10:15:41 debian uwsgi: setuid() to 2003
May 11 10:15:41 debian uwsgi: chdir() to /opt/mlmmjadmin
May 11 10:15:41 debian uwsgi: your processes number limit is 19763
May 11 10:15:41 debian uwsgi: your memory page size is 4096 bytes
May 11 10:15:41 debian uwsgi: detected max file descriptor number: 1024
May 11 10:15:41 debian uwsgi: VirtualHosting mode enabled.
May 11 10:15:41 debian uwsgi: lock engine: pthread robust mutexes
May 11 10:15:41 debian uwsgi: thunder lock: disabled (you can enable it with --thunder-lock)
May 11 10:15:41 debian uwsgi: uwsgi socket 0 bound to TCP address 127.0.0.1:7790 fd 6
May 11 10:15:41 debian uwsgi: Python version: 2.7.13 (default, Nov 24 2017, 17:33:09)  [GCC 6.3.0 20170516]
May 11 10:15:41 debian uwsgi: Python main interpreter initialized at 0x5620127df9f0
May 11 10:15:41 debian uwsgi: python threads support enabled
May 11 10:15:41 debian uwsgi: your server socket listen backlog is limited to 100 connections
May 11 10:15:41 debian uwsgi: your mercy for graceful operations on workers is 60 seconds
May 11 10:15:41 debian uwsgi: mapped 436608 bytes (426 KB) for 5 cores
May 11 10:15:41 debian uwsgi: *** Operational MODE: preforking ***
May 11 10:15:41 debian uwsgi: WSGI app 0 (mountpoint='') ready in 6 seconds on interpreter 0x5620127df9f0 pid: 555 (default app)
May 11 10:15:41 debian uwsgi: *** uWSGI is running in multiple interpreter mode ***
May 11 10:15:41 debian uwsgi: spawned uWSGI master process (pid: 555)
May 11 10:15:41 debian uwsgi: spawned uWSGI worker 1 (pid: 861, cores: 1)
May 11 10:15:41 debian uwsgi: spawned uWSGI worker 2 (pid: 862, cores: 1)
May 11 10:15:41 debian uwsgi: spawned uWSGI worker 3 (pid: 863, cores: 1)
May 11 10:15:41 debian uwsgi: spawned uWSGI worker 4 (pid: 864, cores: 1)
May 11 10:15:41 debian uwsgi: spawned uWSGI worker 5 (pid: 865, cores: 1)
May 11 10:15:57 debian lightdm[1713]: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files
May 11 10:16:05 debian org.a11y.atspi.Registry[2186]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry
May 11 10:20:34 debian liblogging-stdlog:  [origin software="rsyslogd" swVersion="8.24.0" x-pid="396" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
May 11 10:20:34 debian liblogging-stdlog:  [origin software="rsyslogd" swVersion="8.24.0" x-pid="396" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
root@debian:/var/log#

Do you need more info? Please, tell me.

I follow the steps on this post: https://forum.iredmail.org/topic4631-ir … -mail.html

but didnt works hmm

3 (edited by ale_punta 2018-05-11 20:02:55)

Re: can't send/receive emails from local domain

Hi,

I reinstall the debian without graphic environment, and after install iredmail. Now i sending mails outside and inside of my domain with no problems!