View Single Post
  #3  
Old 2nd June 2013, 20:01
mikeoc mikeoc is offline
Junior Member
 
Join Date: Jun 2013
Posts: 8
Thanks: 1
Thanked 0 Times in 0 Posts
Default

Hi monkfish, thanks for the reply

I have my suspicions that it is DNS/MX related. All that's a bit of a dark art to me still. Using that lookup tool the one thing that strikes me is this:
Code:
SMTP Reverse DNS Mismatch Warning - Reverse DNS does not match SMTP Banner
I have NO idea of what that means.

As far as I can tell the mailbox is set up as it should be.

Postfix tells me it's running:
postfix/postfix-script: the Postfix mail system is running: PID: 29434

Postfix restarts without issue with no apparent change.

ispconfig monitor gives the system a full bill of health

The output of logs like this mean very little to me but in /var/log/mail.log I'm seeing this a lot:
Code:
Jun  2 06:40:01 vincam dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
Jun  2 06:40:01 vincam postfix/smtpd[12169]: warning: database /var/lib/mailman/data/virtual-mailman.db is older than source file /var/lib/mailman/$
Jun  2 06:40:01 vincam postfix/smtpd[12169]: connect from localhost[127.0.0.1]
Jun  2 06:40:01 vincam postfix/smtpd[12169]: lost connection after CONNECT from localhost[127.0.0.1]
Jun  2 06:40:01 vincam postfix/smtpd[12169]: disconnect from localhost[127.0.0.1]
tail -f /var/log/mail.log shows this:
Code:
Jun  2 18:20:49 vincam dovecot: imap-login: Login: user=<user@example.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=32333, secured
Jun  2 18:20:49 vincam dovecot: imap(user@example.com): Disconnected: Logged out bytes=79/687
Jun  2 18:20:57 vincam postfix/anvil[31876]: statistics: max connection rate 1/60s for (smtp:79.170.40.91) at Jun  2 18:14:05
Jun  2 18:20:57 vincam postfix/anvil[31876]: statistics: max connection count 1 for (smtp:79.170.40.91) at Jun  2 18:14:05
Jun  2 18:20:57 vincam postfix/anvil[31876]: statistics: max message rate 1/60s for (smtp:79.170.40.91) at Jun  2 18:14:05
Jun  2 18:20:57 vincam postfix/anvil[31876]: statistics: max cache size 1 at Jun  2 18:14:05
Jun  2 18:22:14 vincam postfix/smtpd[32344]: warning: database /var/lib/mailman/data/virtual-mailman.db is older than source file /var/lib/mailman/data/virtual-mailman
Jun  2 18:22:14 vincam postfix/smtpd[32344]: connect from mail91.extendcp.co.uk[79.170.40.91]
Jun  2 18:22:14 vincam postfix/trivial-rewrite[32347]: warning: do not list domain example.com in BOTH virtual_mailbox_domains and relay_domains
Jun  2 18:22:14 vincam postfix/cleanup[32351]: warning: database /var/lib/mailman/data/virtual-mailman.db is older than source file /var/lib/mailman/data/virtual-mailman
Jun  2 18:22:14 vincam postfix/smtpd[32344]: A1C87B713: client=mail91.extendcp.co.uk[79.170.40.91]
Jun  2 18:22:14 vincam postfix/cleanup[32351]: A1C87B713: message-id=<90C75C03-6D1F-4DE9-9851-E0580070998E@us3m.com>
Jun  2 18:22:14 vincam postfix/qmgr[29436]: A1C87B713: from=<mike@us3m.com>, size=898, nrcpt=1 (queue active)
Jun  2 18:22:14 vincam postfix/smtpd[32344]: disconnect from mail91.extendcp.co.uk[79.170.40.91]
Jun  2 18:22:20 vincam postfix/smtpd[32355]: warning: database /var/lib/mailman/data/virtual-mailman.db is older than source file /var/lib/mailman/data/virtual-mailman
Jun  2 18:22:20 vincam postfix/smtpd[32355]: connect from localhost[127.0.0.1]
Jun  2 18:22:20 vincam postfix/trivial-rewrite[32347]: warning: do not list domain example.com in BOTH virtual_mailbox_domains and relay_domains
Jun  2 18:22:20 vincam postfix/smtpd[32355]: 0E3FAB714: client=localhost[127.0.0.1]
Jun  2 18:22:20 vincam postfix/cleanup[32351]: 0E3FAB714: message-id=<90C75C03-6D1F-4DE9-9851-E0580070998E@us3m.com>
Jun  2 18:22:20 vincam postfix/qmgr[29436]: 0E3FAB714: from=<mike@us3m.com>, size=1395, nrcpt=1 (queue active)
Jun  2 18:22:20 vincam postfix/smtpd[32355]: disconnect from localhost[127.0.0.1]
Jun  2 18:22:20 vincam postfix/trivial-rewrite[32347]: warning: do not list domain example.com in BOTH virtual_mailbox_domains and relay_domains
Jun  2 18:22:20 vincam amavis[3265]: (03265-15) Passed CLEAN, [79.170.40.91] [82.14.162.91] <mike@us3m.com> -> <user@example.com>, Message-ID: <90C75C03-6D1F-4DE9-9851-E0580070998E@us3m.com>, mail_id: d2odX4E3Y2X7, Hits: 0, size: 898, queued_as: 0E3FAB714, 5384 ms
Jun  2 18:22:20 vincam postfix/smtp[32352]: A1C87B713: to=<user@example.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=5.4, delays=0.05/0.01/0/5.4, dsn=2.0.0, status=sent (250 2.0.0 from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 0E3FAB714)
Jun  2 18:22:20 vincam postfix/qmgr[29436]: A1C87B713: removed
Jun  2 18:22:20 vincam postfix/smtp[32356]: 0E3FAB714: to=<user@example.com>, relay=none, delay=0.02, delays=0.01/0.01/0/0, dsn=5.4.4, status=bounced (Host or domain name not found. Name service error for name=smtp type=AAAA: Host not found)
Jun  2 18:22:20 vincam postfix/cleanup[32351]: 14B69B715: message-id=<20130602172220.14B69B715@vincam.timesaverads.co.uk>
Jun  2 18:22:20 vincam postfix/bounce[32357]: 0E3FAB714: sender non-delivery notification: 14B69B715
Jun  2 18:22:20 vincam postfix/qmgr[29436]: 14B69B715: from=<>, size=3465, nrcpt=1 (queue active)
Jun  2 18:22:20 vincam postfix/qmgr[29436]: 0E3FAB714: removed
Jun  2 18:22:20 vincam postfix/smtp[32356]: 14B69B715: to=<mike@us3m.com>, relay=mail.us3m.com[79.170.40.91]:25, delay=0.12, delays=0.01/0/0.07/0.03, dsn=2.0.0, status=sent (250 OK id=1UjBz2-0002kA-6q)
Jun  2 18:22:20 vincam postfix/qmgr[29436]: 14B69B715: removed
postqueue -p reports "Mail queue is empty"

amavisd-new is running, can't see any errors.

Any insights?

Mike
Reply With Quote