email troubleshooting

Discussion in 'General' started by asgare, Feb 23, 2015.

  1. asgare

    asgare Member

    Hello Contributors
    I checked out forum thoroughly but didn't find a solution.
    Via your nice documentation, I have installed ISPConfig latest version successfully and add email domain and emails, also I configured with outlook and so on.
    The problem is, wither via outlook nor web-email can't send email. All emails are fails.
    Now do you have a step by step guideline to troubleshooting the issue?
     
  2. till

    till Super Moderator Staff Member ISPConfig Developer

    Take a look at the mail log file of your server and post the errors that you get there when you try to send an email.
     
  3. asgare

    asgare Member

    Dear till
    Thanks for your prompt reply, please let me know how to look up for mail logs?
     
  4. till

    till Super Moderator Staff Member ISPConfig Developer

    Which Tutorial did you use to install your server?
     
  5. asgare

    asgare Member

  6. till

    till Super Moderator Staff Member ISPConfig Developer

    You can view the mail log with the command tail. e.g.:

    tail -n 100 /var/log/mail.log

    to view the last 100 lines. you can slo see parts of the mail.log file in the ispconfig monitor.
     
  7. asgare

    asgare Member

    since the number of words exceed 1000 words I have to break into 2 post
    here is the logs
    Code:
    Feb 23 17:30:05 ns1 postfix/smtpd[5051]: 70B87401711: client=localhost.localdomain[127.0.0.1]
    Feb 23 17:30:05 ns1 postfix/cleanup[5044]: 70B87401711: message-id=<[email protected]>
    Feb 23 17:30:05 ns1 postfix/qmgr[28072]: 70B87401711: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 23 17:30:05 ns1 postfix/smtpd[5051]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 23 17:30:05 ns1 amavis[29732]: (29732-17) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: LJ7_B1BhKEZD, Hits: 2.437, size: 881, queued_as: 70B87401711, 3221 ms
    Feb 23 17:30:05 ns1 postfix/smtp[5048]: 3AEB8401908: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=3.3, delays=0.03/0.01/0/3.2, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 70B87401711)
    Feb 23 17:30:05 ns1 postfix/qmgr[28072]: 3AEB8401908: removed
    Feb 23 17:30:05 ns1 postfix/local[5052]: 70B87401711: to=<[email protected]>, relay=local, delay=0.04, delays=0.01/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 23 17:30:05 ns1 postfix/qmgr[28072]: 70B87401711: removed
    Feb 23 17:35:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<iHpe48EPWQAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:35:01 ns1 postfix/smtpd[5154]: connect from localhost[::1]
    Feb 23 17:35:01 ns1 postfix/smtpd[5154]: lost connection after CONNECT from localhost[::1]
    Feb 23 17:35:01 ns1 postfix/smtpd[5154]: disconnect from localhost[::1]
    Feb 23 17:35:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<Bshe48EPBAAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:39:01 ns1 postfix/pickup[3630]: 6A36B401908: uid=0 from=<root>
    Feb 23 17:39:01 ns1 postfix/cleanup[5258]: 6A36B401908: message-id=<[email protected]>
    Feb 23 17:39:01 ns1 postfix/qmgr[28072]: 6A36B401908: from=<[email protected]>, size=992, nrcpt=1 (queue active)
    Feb 23 17:39:02 ns1 postfix/smtpd[5265]: connect from localhost.localdomain[127.0.0.1]
    Feb 23 17:39:02 ns1 postfix/smtpd[5265]: 97722401711: client=localhost.localdomain[127.0.0.1]
    Feb 23 17:39:02 ns1 postfix/cleanup[5258]: 97722401711: message-id=<[email protected]>
    Feb 23 17:39:02 ns1 postfix/qmgr[28072]: 97722401711: from=<[email protected]>, size=1421, nrcpt=1 (queue active)
    Feb 23 17:39:02 ns1 postfix/smtpd[5265]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 23 17:39:02 ns1 amavis[29654]: (29654-18) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: vd3S4herl1s9, Hits: 2.437, size: 991, queued_as: 97722401711, 1146 ms
    Feb 23 17:39:02 ns1 postfix/smtp[5262]: 6A36B401908: to=<[email protected]>, orig_to=<root>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.3, delays=0.08/0.03/0.01/1.1, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 97722401711)
    Feb 23 17:39:02 ns1 postfix/qmgr[28072]: 6A36B401908: removed
    Feb 23 17:39:02 ns1 postfix/local[5269]: 97722401711: to=<[email protected]>, orig_to=<[email protected]>, relay=local, delay=0.03, delays=0.01/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 23 17:39:02 ns1 postfix/qmgr[28072]: 97722401711: removed
    Feb 23 17:40:01 ns1 dovecot: imap-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=</UZE9cEPZgAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:40:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<NUxE9cEPEQAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:40:01 ns1 postfix/smtpd[5313]: connect from localhost[::1]
    Feb 23 17:40:01 ns1 postfix/smtpd[5313]: lost connection after CONNECT from localhost[::1]
    Feb 23 17:40:01 ns1 postfix/smtpd[5313]: disconnect from localhost[::1]
    Feb 23 17:40:01 ns1 postfix/pickup[3630]: AFD04401908: uid=33 from=<www-data>
    Feb 23 17:40:01 ns1 postfix/cleanup[5258]: AFD04401908: message-id=<[email protected]>
    Feb 23 17:40:01 ns1 postfix/qmgr[28072]: AFD04401908: from=<[email protected]>, size=881, nrcpt=1 (queue active)
    Feb 23 17:40:02 ns1 dovecot: imap([email protected]): Disconnected: Logged out in=259 out=7227
    Feb 23 17:40:03 ns1 postfix/smtpd[5265]: connect from localhost.localdomain[127.0.0.1]
    Feb 23 17:40:03 ns1 postfix/smtpd[5265]: 41248401711: client=localhost.localdomain[127.0.0.1]
    Feb 23 17:40:03 ns1 postfix/cleanup[5258]: 41248401711: message-id=<[email protected]>
    Feb 23 17:40:03 ns1 postfix/qmgr[28072]: 41248401711: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 23 17:40:03 ns1 postfix/smtpd[5265]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 23 17:40:03 ns1 postfix/local[5269]: 41248401711: to=<[email protected]>, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 23 17:40:03 ns1 postfix/qmgr[28072]: 41248401711: removed
    Feb 23 17:40:03 ns1 amavis[29732]: (29732-18) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: 9coHuxHzNB1E, Hits: 2.437, size: 881, queued_as: 41248401711, 1564 ms
    Feb 23 17:40:03 ns1 postfix/smtp[5262]: AFD04401908: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.6, delays=0.01/0/0/1.6, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 41248401711)
    Feb 23 17:40:03 ns1 postfix/qmgr[28072]: AFD04401908: removed
    Feb 23 17:45:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<CN8pB8IPcwAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:45:01 ns1 postfix/smtpd[5438]: connect from localhost[::1]
    Feb 23 17:45:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<GhwqB8IPHgAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:45:01 ns1 postfix/smtpd[5438]: lost connection after CONNECT from localhost[::1]
    Feb 23 17:45:01 ns1 postfix/smtpd[5438]: disconnect from localhost[::1]
    Feb 23 17:48:52 ns1 dovecot: auth-worker(5513): mysql(localhost): Connected to database dbispconfig
    Feb 23 17:48:52 ns1 dovecot: imap-login: Login: user=<[email protected]>, method=PLAIN, rip=188.158.199.201, lip=192.168.1.2, mpid=5515, session=<KPvoFMIPKQC8nsfJ>
    Feb 23 17:49:26 ns1 dovecot: imap([email protected]): Disconnected: Logged out in=660 out=18212
    Feb 23 17:50:02 ns1 dovecot: imap-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<DgMPGcIPegAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:50:02 ns1 postfix/smtpd[5574]: connect from localhost[::1]
    Feb 23 17:50:02 ns1 postfix/smtpd[5574]: lost connection after CONNECT from localhost[::1]
    Feb 23 17:50:02 ns1 postfix/smtpd[5574]: disconnect from localhost[::1]
    Feb 23 17:50:02 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<BhUPGcIPJQAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:50:02 ns1 postfix/pickup[3630]: 33BC1401908: uid=33 from=<www-data>
    Feb 23 17:50:02 ns1 postfix/cleanup[5606]: 33BC1401908: message-id=<[email protected]>
    Feb 23 17:50:02 ns1 postfix/qmgr[28072]: 33BC1401908: from=<[email protected]>, size=881, nrcpt=1 (queue active)
    Feb 23 17:50:04 ns1 postfix/smtpd[5613]: connect from localhost.localdomain[127.0.0.1]
    Feb 23 17:50:04 ns1 postfix/smtpd[5613]: 71215401711: client=localhost.localdomain[127.0.0.1]
    Feb 23 17:50:04 ns1 postfix/cleanup[5606]: 71215401711: message-id=<[email protected]>
    Feb 23 17:50:04 ns1 postfix/qmgr[28072]: 71215401711: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 23 17:50:04 ns1 postfix/smtpd[5613]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 23 17:50:04 ns1 amavis[29654]: (29654-19) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: 4EoIC2Zj_cKf, Hits: 2.437, size: 881, queued_as: 71215401711, 2242 ms
    Feb 23 17:50:04 ns1 postfix/smtp[5610]: 33BC1401908: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.3, delays=0.03/0.01/0/2.2, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 71215401711)
    Feb 23 17:50:04 ns1 postfix/qmgr[28072]: 33BC1401908: removed
    Feb 23 17:50:04 ns1 postfix/local[5614]: 71215401711: to=<[email protected]>, relay=local, delay=0.04, delays=0.01/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 23 17:50:04 ns1 postfix/qmgr[28072]: 71215401711: removed
    Feb 23 17:55:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<3U7lKsIPhwAAAAAAAAAAAAAAAAAAAAAB>
    
     
  8. asgare

    asgare Member

    Code:
    Feb 23 17:55:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<BVvlKsIPMgAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 17:55:01 ns1 postfix/smtpd[5707]: connect from localhost[::1]
    Feb 23 17:55:01 ns1 postfix/smtpd[5707]: lost connection after CONNECT from localhost[::1]
    Feb 23 17:55:01 ns1 postfix/smtpd[5707]: disconnect from localhost[::1]
    Feb 23 18:00:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<2vnJPMIPjgAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 18:00:01 ns1 postfix/smtpd[5836]: connect from localhost[::1]
    Feb 23 18:00:01 ns1 postfix/smtpd[5836]: lost connection after CONNECT from localhost[::1]
    Feb 23 18:00:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<pizKPMIPOQAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 18:00:01 ns1 postfix/smtpd[5836]: disconnect from localhost[::1]
    Feb 23 18:00:01 ns1 postfix/pickup[3630]: 9EA00401908: uid=33 from=<www-data>
    Feb 23 18:00:01 ns1 postfix/cleanup[5864]: 9EA00401908: message-id=<[email protected]>
    Feb 23 18:00:01 ns1 postfix/qmgr[28072]: 9EA00401908: from=<[email protected]>, size=881, nrcpt=1 (queue active)
    Feb 23 18:00:04 ns1 postfix/smtpd[5877]: connect from localhost.localdomain[127.0.0.1]
    Feb 23 18:00:04 ns1 postfix/smtpd[5877]: 30115401711: client=localhost.localdomain[127.0.0.1]
    Feb 23 18:00:04 ns1 postfix/cleanup[5864]: 30115401711: message-id=<[email protected]>
    Feb 23 18:00:04 ns1 postfix/qmgr[28072]: 30115401711: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 23 18:00:04 ns1 amavis[29732]: (29732-19) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: 1v7IfoovFuym, Hits: 2.437, size: 881, queued_as: 30115401711, 2523 ms
    Feb 23 18:00:04 ns1 postfix/smtpd[5877]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 23 18:00:04 ns1 postfix/smtp[5867]: 9EA00401908: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.6, delays=0.04/0.01/0.01/2.5, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 30115401711)
    Feb 23 18:00:04 ns1 postfix/qmgr[28072]: 9EA00401908: removed
    Feb 23 18:00:04 ns1 postfix/local[5878]: 30115401711: to=<[email protected]>, relay=local, delay=0.03, delays=0.01/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 23 18:00:04 ns1 postfix/qmgr[28072]: 30115401711: removed
    Feb 23 18:05:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<oimyTsIPngAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 18:05:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<3FyyTsIPSQAAAAAAAAAAAAAAAAAAAAAB>
    Feb 23 18:05:01 ns1 postfix/smtpd[6005]: connect from localhost[::1]
    Feb 23 18:05:01 ns1 postfix/smtpd[6005]: lost connection after CONNECT from localhost[::1]
    Feb 23 18:05:01 ns1 postfix/smtpd[6005]: disconnect from localhost[::1]
    
     
  9. asgare

    asgare Member

    Would you please let me know how do you read these logs and figure out the problem ? :)
     
    Last edited: Feb 24, 2015
  10. asgare

    asgare Member

    BTW till, for your information I purchased one dedicate IP and our connection to the Internet is via ADSL. Also I established a port forwarding via modem to Linux server. Everything works fine (domains and so on), except emails.
     
  11. till

    till Super Moderator Staff Member ISPConfig Developer

    There are no failed send attempts in that log snippet, most likely it is in a older part of the log. Please try to send again and ritgth after that, run the command to get the last 100 new log entres.
     
  12. asgare

    asgare Member

    Code:
    root@ns1:~# tail -n 100 /var/log/mail.log
    Feb 24 15:09:01 ns1 postfix/local[1289]: 9ED29401954: to=<[email protected]>, orig_to=<[email protected]>, relay=local, delay=0.05, delays=0.02/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 24 15:09:01 ns1 postfix/qmgr[28072]: 9ED29401954: removed
    Feb 24 15:10:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<Uy+q+tMP9wAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:10:01 ns1 postfix/smtpd[1333]: connect from localhost[::1]
    Feb 24 15:10:01 ns1 postfix/smtpd[1333]: lost connection after CONNECT from localhost[::1]
    Feb 24 15:10:01 ns1 postfix/smtpd[1333]: disconnect from localhost[::1]
    Feb 24 15:10:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<1kOq+tMPAwAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:10:01 ns1 postfix/pickup[32701]: A206B401954: uid=33 from=<www-data>
    Feb 24 15:10:01 ns1 postfix/cleanup[1278]: A206B401954: message-id=<[email protected]>
    Feb 24 15:10:01 ns1 postfix/qmgr[28072]: A206B401954: from=<[email protected]>, size=881, nrcpt=1 (queue active)
    Feb 24 15:10:04 ns1 postfix/smtpd[1285]: connect from localhost.localdomain[127.0.0.1]
    Feb 24 15:10:04 ns1 postfix/smtpd[1285]: 5D365401250: client=localhost.localdomain[127.0.0.1]
    Feb 24 15:10:04 ns1 postfix/cleanup[1278]: 5D365401250: message-id=<[email protected]>
    Feb 24 15:10:04 ns1 postfix/qmgr[28072]: 5D365401250: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 24 15:10:04 ns1 postfix/smtpd[1285]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 24 15:10:04 ns1 amavis[31685]: (31685-06) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: kKIU8YjF4BCN, Hits: 2.437, size: 881, queued_as: 5D365401250, 2732 ms
    Feb 24 15:10:04 ns1 postfix/smtp[1282]: A206B401954: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.7, delays=0.01/0/0/2.7, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 5D365401250)
    Feb 24 15:10:04 ns1 postfix/qmgr[28072]: A206B401954: removed
    Feb 24 15:10:04 ns1 postfix/local[1289]: 5D365401250: to=<[email protected]>, relay=local, delay=0.03, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 24 15:10:04 ns1 postfix/qmgr[28072]: 5D365401250: removed
    Feb 24 15:15:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<rTCPDNQPEAAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:15:01 ns1 postfix/smtpd[1468]: connect from localhost[::1]
    Feb 24 15:15:01 ns1 postfix/smtpd[1468]: lost connection after CONNECT from localhost[::1]
    Feb 24 15:15:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<NmaPDNQPBAAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:15:01 ns1 postfix/smtpd[1468]: disconnect from localhost[::1]
    Feb 24 15:19:31 ns1 dovecot: auth-worker(1569): mysql(localhost): Connected to database dbispconfig
    Feb 24 15:19:31 ns1 dovecot: imap-login: Login: user=<[email protected]>, method=PLAIN, rip=188.158.197.0, lip=192.168.1.2, mpid=1571, session=<0PSjHNQP6AC8nsUA>
    Feb 24 15:20:01 ns1 dovecot: imap-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<tIFqHtQPFwAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:20:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<3IZqHtQPCwAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:20:01 ns1 postfix/smtpd[1616]: connect from localhost[::1]
    Feb 24 15:20:01 ns1 postfix/smtpd[1616]: lost connection after CONNECT from localhost[::1]
    Feb 24 15:20:01 ns1 postfix/smtpd[1616]: disconnect from localhost[::1]
    Feb 24 15:20:01 ns1 postfix/pickup[32701]: 7D6EA401954: uid=33 from=<www-data>
    Feb 24 15:20:01 ns1 postfix/cleanup[1646]: 7D6EA401954: message-id=<[email protected]>
    Feb 24 15:20:01 ns1 postfix/qmgr[28072]: 7D6EA401954: from=<[email protected]>, size=881, nrcpt=1 (queue active)
    Feb 24 15:20:03 ns1 postfix/smtpd[1652]: connect from localhost.localdomain[127.0.0.1]
    Feb 24 15:20:03 ns1 postfix/smtpd[1652]: DC289401250: client=localhost.localdomain[127.0.0.1]
    Feb 24 15:20:03 ns1 postfix/cleanup[1646]: DC289401250: message-id=<[email protected]>
    Feb 24 15:20:03 ns1 postfix/qmgr[28072]: DC289401250: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 24 15:20:03 ns1 postfix/smtpd[1652]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 24 15:20:03 ns1 amavis[31762]: (31762-06) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: V7Pm3QrZvRKk, Hits: 2.437, size: 881, queued_as: DC289401250, 2389 ms
    Feb 24 15:20:03 ns1 postfix/smtp[1649]: 7D6EA401954: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.4, delays=0.03/0.01/0/2.4, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as DC289401250)
    Feb 24 15:20:03 ns1 postfix/qmgr[28072]: 7D6EA401954: removed
    Feb 24 15:20:03 ns1 postfix/local[1653]: DC289401250: to=<[email protected]>, relay=local, delay=0.04, delays=0.02/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 24 15:20:03 ns1 postfix/qmgr[28072]: DC289401250: removed
    Feb 24 15:20:11 ns1 dovecot: imap([email protected]): Disconnected: Logged out in=660 out=18195
    Feb 24 15:25:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<KWlPMNQPJAAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:25:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<lKxPMNQPGAAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:25:01 ns1 postfix/smtpd[1746]: connect from localhost[::1]
    Feb 24 15:25:01 ns1 postfix/smtpd[1746]: lost connection after CONNECT from localhost[::1]
    Feb 24 15:25:01 ns1 postfix/smtpd[1746]: disconnect from localhost[::1]
    Feb 24 15:30:01 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<UV80QtQPKwAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:30:01 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<xJE0QtQPHwAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:30:01 ns1 postfix/smtpd[1885]: connect from localhost[::1]
    Feb 24 15:30:01 ns1 postfix/smtpd[1885]: lost connection after CONNECT from localhost[::1]
    Feb 24 15:30:01 ns1 postfix/smtpd[1885]: disconnect from localhost[::1]
    Feb 24 15:30:01 ns1 postfix/pickup[32701]: E6C36401966: uid=33 from=<www-data>
    Feb 24 15:30:01 ns1 postfix/cleanup[1922]: E6C36401966: message-id=<[email protected]>
    Feb 24 15:30:01 ns1 postfix/qmgr[28072]: E6C36401966: from=<[email protected]>, size=881, nrcpt=1 (queue active)
    Feb 24 15:30:05 ns1 postfix/smtpd[1929]: connect from localhost.localdomain[127.0.0.1]
    Feb 24 15:30:05 ns1 postfix/smtpd[1929]: AB177401954: client=localhost.localdomain[127.0.0.1]
    Feb 24 15:30:05 ns1 postfix/cleanup[1922]: AB177401954: message-id=<[email protected]>
    Feb 24 15:30:05 ns1 postfix/smtpd[1929]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 24 15:30:05 ns1 postfix/qmgr[28072]: AB177401954: from=<[email protected]>, size=1318, nrcpt=1 (queue active)
    Feb 24 15:30:05 ns1 amavis[31685]: (31685-07) Passed CLEAN {RelayedInbound}, <[email protected]> -> <[email protected]>, Message-ID: <[email protected]>, mail_id: ld1hIJJ4jh87, Hits: 2.437, size: 881, queued_as: AB177401954, 3752 ms
    Feb 24 15:30:05 ns1 postfix/smtp[1926]: E6C36401966: to=<[email protected]>, orig_to=<www-data>, relay=127.0.0.1[127.0.0.1]:10024, delay=3.8, delays=0.03/0.01/0/3.8, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as AB177401954)
    Feb 24 15:30:05 ns1 postfix/qmgr[28072]: E6C36401966: removed
    Feb 24 15:30:05 ns1 postfix/local[1930]: AB177401954: to=<[email protected]>, relay=local, delay=0.04, delays=0.01/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION")
    Feb 24 15:30:05 ns1 postfix/qmgr[28072]: AB177401954: removed
    Feb 24 15:35:02 ns1 dovecot: imap-login: Disconnected (disconnected before greeting, waited 0 secs): user=<>, rip=::1, lip=::1, secured, session=<BMYZVNQPOAAAAAAAAAAAAAAAAAAAAAAB>
    Feb 24 15:35:02 ns1 postfix/smtpd[2023]: connect from localhost[::1]
    Feb 24 15:35:02 ns1 postfix/smtpd[2023]: lost connection after CONNECT from localhost[::1]
    Feb 24 15:35:02 ns1 postfix/smtpd[2023]: disconnect from localhost[::1]
    Feb 24 15:35:02 ns1 dovecot: pop3-login: Disconnected (no auth attempts in 0 secs): user=<>, rip=::1, lip=::1, secured, session=<qfYZVNQPLAAAAAAAAAAAAAAAAAAAAAAB>
    
     
  13. asgare

    asgare Member

    Code:
    Feb 24 15:36:04 ns1 dovecot: auth-worker(2068): mysql(localhost): Connected to database dbispconfig
    Feb 24 15:36:04 ns1 dovecot: imap-login: Login: user=<[email protected]>, method=PLAIN, rip=188.158.197.0, lip=192.168.1.2, mpid=2070, session=<qm3UV9QP+wC8nsUA>
    Feb 24 15:36:21 ns1 postfix/smtpd[2023]: warning: hostname adsl-188-158-197-0.sabanet.ir does not resolve to address 188.158.197.0: Name or service not known
    Feb 24 15:36:21 ns1 postfix/smtpd[2023]: connect from unknown[188.158.197.0]
    Feb 24 15:36:22 ns1 postfix/smtpd[2023]: 24D7D401954: client=unknown[188.158.197.0], sasl_method=LOGIN, [email protected]
    Feb 24 15:36:22 ns1 postfix/cleanup[2076]: 24D7D401954: message-id=<[email protected]>
    Feb 24 15:36:24 ns1 postfix/qmgr[28072]: 24D7D401954: from=<[email protected]>, size=66985, nrcpt=1 (queue active)
    Feb 24 15:36:26 ns1 postfix/smtpd[2080]: connect from localhost.localdomain[127.0.0.1]
    Feb 24 15:36:26 ns1 postfix/smtpd[2080]: 76FAC401966: client=localhost.localdomain[127.0.0.1]
    Feb 24 15:36:26 ns1 postfix/cleanup[2076]: 76FAC401966: message-id=<[email protected]>
    Feb 24 15:36:26 ns1 postfix/qmgr[28072]: 76FAC401966: from=<[email protected]>, size=67416, nrcpt=1 (queue active)
    Feb 24 15:36:26 ns1 postfix/smtpd[2080]: disconnect from localhost.localdomain[127.0.0.1]
    Feb 24 15:36:26 ns1 amavis[31762]: (31762-07) Passed CLEAN {RelayedOpenRelay}, [188.158.197.0]:13337 [188.158.197.0] <[email protected]> -> <[email protected]>, Queue-ID: 24D7D401954, Message-ID: <[email protected]>, mail_id: 52VL2I5uzThJ, Hits: 7.684, size: 66992, queued_as: 76FAC401966, 2471 ms
    Feb 24 15:36:26 ns1 postfix/smtp[2077]: 24D7D401954: to=<[email protected]>, relay=127.0.0.1[127.0.0.1]:10024, delay=4.5, delays=2/0.01/0/2.5, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 76FAC401966)
    Feb 24 15:36:26 ns1 postfix/qmgr[28072]: 24D7D401954: removed
    Feb 24 15:36:26 ns1 postfix/smtpd[2023]: disconnect from unknown[188.158.197.0]
    Feb 24 15:36:35 ns1 postfix/smtp[2081]: 76FAC401966: to=<[email protected]>, relay=gmail-smtp-in.l.google.com[74.125.136.26]:25, delay=8.5, delays=0.02/0.01/4.9/3.6, dsn=5.7.1, status=bounced (host gmail-smtp-in.l.google.com[74.125.136.26] said: 550-5.7.1 [188.158.220.83      12] Our system has detected that this message is 550-5.7.1 likely unsolicited mail. To reduce the amount of spam sent to Gmail, 550-5.7.1 this message has been blocked. Please visit 550-5.7.1 http://support.google.com/mail/bin/answer.py?hl=en&answer=188131 for 550 5.7.1 more information. gx8si23111124wib.102 - gsmtp (in reply to end of DATA command))
    Feb 24 15:36:35 ns1 postfix/cleanup[2076]: 0330B401969: message-id=<[email protected]>
    Feb 24 15:36:35 ns1 postfix/bounce[2082]: 76FAC401966: sender non-delivery notification: 0330B401969
    Feb 24 15:36:35 ns1 postfix/qmgr[28072]: 0330B401969: from=<>, size=3706, nrcpt=1 (queue active)
    Feb 24 15:36:35 ns1 postfix/qmgr[28072]: 76FAC401966: removed
    Feb 24 15:36:35 ns1 dovecot: lda([email protected]): sieve: msgid=<[email protected]>: stored mail into mailbox 'INBOX'
    Feb 24 15:36:35 ns1 postfix/pipe[2083]: 0330B401969: to=<[email protected]>, relay=dovecot, delay=0.07, delays=0.01/0.01/0/0.06, dsn=2.0.0, status=sent (delivered via dovecot service)
    Feb 24 15:36:35 ns1 postfix/qmgr[28072]: 0330B401969: removed
    Feb 24 15:36:38 ns1 dovecot: imap-login: Login: user=<[email protected]>, method=PLAIN, rip=188.158.197.0, lip=192.168.1.2, mpid=2086, session=<JMTaWdQPIgC8nsUA>
    Feb 24 15:37:11 ns1 dovecot: imap([email protected]): Disconnected: Logged out in=65850 out=133688
    root@ns1:~#
     
  14. asgare

    asgare Member

    sorry, Due to the maximum number of words I have to send log file output in two parts
     
  15. till

    till Super Moderator Staff Member ISPConfig Developer

    So your test was a message to an gmail account?

    The error means that gmail does not trust your IP address.

    1) Does the hsotanme of your server exist in dns?
    2) Does your IP address has a reverse dns record that points to the hostname?
    3) Do you have a spf record for the sender domain name that allows sending from this IP?
     
  16. asgare

    asgare Member

    Sorry to say that :( How do I answer your questions?
    This dedicate IP purchased recently just because of ISPConfig :) and most of Linux commands are new to me :D
     
    Last edited: Feb 24, 2015
  17. asgare

    asgare Member

    Moreover I went http://www.spamhaus.org/ site and unblock my IP address from their spam list
    I revive emails but I can't send email.
     
  18. asgare

    asgare Member

    Still hopeful for your helps :)
     
  19. till

    till Super Moderator Staff Member ISPConfig Developer

    Please check the things that i mentined above. Fisrt your hostname, you get it with:

    hostname -f

    on your server. if you enter that hostname in a web browser, do you reach the server or do you get a page not found error?

    2) the reverse dns record. the provider that assigned you the ip address has to set a reverse dns record for that IP that points to the hostname of your server. contact their support and ask them to do that (if they havent done that yet).

    3) A SPF record is a record that defines which servers are allowed to send email for a domain. you can add such a record in the dns zone of your domain at your domain registry.
     
  20. asgare

    asgare Member

    dear till, appreciate your continues helps
    1. When I enter my host name on browser it gives me "it works!"

    2. About reverse dns record: my customers can easily work with my web applications on this host which operates via ISPConfig "ns1 [dot] o10 [dot ir]". From this point of view I think it works too but if I didn't understand your exact mean of what you need please let me know to look for.

    3. I checked my domain control panel at the registry point and saw there is not any SPF record at there. Moreover I checked our country main domain registration center and also I didn't find any record as you mentioned.
     

Share This Page