fetchmail: SMTP< 250 Ok: queued as

[daly1]

Zimbra installed fine without any problems on FC3.

Here is my /etc/hosts
# Do not remove the following line, or various programs
# that require network functionality will fail.
127.0.0.1               localhost.localdomain localhost host.no-ip.com

My domain is configured as host.no-ip.com. Zimbra is sitting behind a firewall. I connect fine to Zimbra, but using fetchmail to get my gmail is producing:

fetchmail: POP3> LIST 3
fetchmail: POP3< +OK 3 713
fetchmail: POP3> RETR 3
fetchmail: POP3< +OK message follows
reading message someone@gmail.com@gmail-pop.l.google.com:3 of 7 (713 octets)
fetchmail: SMTP> MAIL FROM: BODY=7BIT SIZE=713
fetchmail: SMTP< 250 Ok
fetchmail: SMTP> RCPT TO:
fetchmail: SMTP< 250 Ok
fetchmail: SMTP> DATA
fetchmail: SMTP< 354 End data with .
#*fetchmail: SMTP>. (EOM)
fetchmail: SMTP< 250 Ok: queued as 1372D945D7
 not flushed

My .fetchmailrc:

poll pop.gmail.com proto POP3 port 995 and options uidl
user someone@gmail.com pass passwordhere ssl is internal@host.no-ip.com here

I run fetchmail by typing:
fetchmail -k

Can someone please tell me why I am not receiving email?

Thanks.

[KevinH]

What do you see in /var/log/zimbra.log ?

[daly1]

This is one HUGE file What exactly am I looking for?

I am posting a portion which I think might be relevant, as it show receiving an email. I posted all the messages that came in at the same time:

Oct 23 14:43:26 localhost postfix/qmgr[9755]: 802828CFE8: from=, size=685685, nrcpt=1 (queue active)
Oct 23 14:43:26 localhost postfix/cleanup[31643]: 5FD608CFDE: message-id=
Oct 23 14:43:26 localhost postfix/cleanup[31841]: 499AC8CFE7: message-id=<6a03a303050626185036e19944@mail.gmail.com>
Oct 23 14:43:26 localhost postfix/smtpd[21455]: disconnect from localhost.localdomain[127.0.0.1]
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 5FD608CFDE: from=, size=1792, nrcpt=1 (queue active)
Oct 23 14:43:26 localhost postfix/smtpd[31757]: disconnect from localhost.localdomain[127.0.0.1]
Oct 23 14:43:26 localhost amavis[7521]: (07521-06) FWD via SMTP:  -> , 250 2.6.0
Ok, id=07521-06, from MTA([127.0.0.1]:10025): 250 Ok: queued as 5FD608CFDE
Oct 23 14:43:26 localhost amavis[7521]: (07521-06) lookup_ldap_attr(amavisspamtag2level) (WARN: no such attribute in LDAP entr
y), "aeldaly@daly.no-ip.com" result=undef
Oct 23 14:43:26 localhost amavis[7521]: (07521-06) Passed CLEAN, LOCAL [127.0.0.1] [64.233.163.109]  -> <
aeldaly@daly.no-ip.com>, Message-ID: , mail_id: Zz8xwVWA0pRH, Hits: -5.788, 9561 ms
Oct 23 14:43:26 localhost amavis[7521]: (07521-06) TIMING [total 9575 ms] - SMTP EHLO: 63 (1%)1, SMTP pre-MAIL: 4 (0%)1, looku
p_ldap: 230 (2%)3, SMTP pre-DATA-flush: 5 (0%)3, SMTP DATA: 1 (0%)3, body_hash: 3 (0%)3, gen_mail_id: 1 (0%)3, mime_decode: 83
 (1%)4, get-file-type1: 22 (0%)4, decompose_part: 2 (0%)4, parts_decode: 0 (0%)4, AV-scan-1: 30 (0%)5, spam-wb-list: 12 (0%)5,
 SA msg read: 33 (0%)5, SA parse: 192 (2%)7, SA check: 3998 (42%)49, update_cache: 5 (0%)49, deal_with_mail_size: 3 (0%)49, fw
d-connect: 25 (0%)49, fwd-mail-from: 4 (0%)49, fwd-rcpt-to: 7 (0%)49, write-header: 14 (0%)49, fwd-data: 1 (0%)49, fwd-data-en
d: 4774 (50%)99, fwd-rundown: 5 (0%)99, main_log_entry: 48 (1%)100, update_snmp: 4 (0%)100, unlink-1-files: 3 (0%)100, rundown
: 1 (0%)100
Oct 23 14:43:26 localhost postfix/smtp[31844]: 7F8AE8CFCA: to=, relay=127.0.0.1[127.0.0.1], delay=10,
status=sent (250 2.6.0 Ok, id=07521-06, from MTA([127.0.0.1]:10025): 250 Ok: queued as 5FD608CFDE)
Oct 23 14:43:26 localhost amavis[7521]: (07521-06) extra modules loaded: Net/LDAP/Bind.pm
Oct 23 14:43:26 localhost amavis[7521]: (07521-06) load: 1 %, total idle 2335.489 s, busy 31.983 s
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 7F8AE8CFCA: removed
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 499AC8CFE7: from=, size=3918, nrcpt=1 (queue active)
Oct 23 14:43:26 localhost postfix/smtpd[31849]: disconnect from localhost.localdomain[127.0.0.1]
Oct 23 14:43:26 localhost amavis[7519]: (07519-06) FWD via SMTP:  -> , 250 2.6.0 Ok
, id=07519-06, from MTA([127.0.0.1]:10025): 250 Ok: queued as 499AC8CFE7
Oct 23 14:43:26 localhost postfix/lmtp[31818]: 5FD608CFDE: to=, relay=none, delay=5, status=bounced (H
ost or domain name not found. Name service error for name=localhost.localdomain type=A: Host not found)
Oct 23 14:43:26 localhost postfix/lmtp[31818]: 499AC8CFE7: to=, relay=none, delay=4, status=bounced (H
ost or domain name not found. Name service error for name=localhost.localdomain type=A: Host not found)
Oct 23 14:43:26 localhost amavis[7519]: (07519-06) lookup_ldap_attr(amavisspamtag2level) (WARN: no such attribute in LDAP entr
y), "aeldaly@daly.no-ip.com" result=undef
Oct 23 14:43:26 localhost amavis[7519]: (07519-06) Passed CLEAN, LOCAL [127.0.0.1] [64.233.163.109]  -> , Message-ID: <6a03a303050626185036e19944@mail.gmail.com>, mail_id: cRMVROkDOpL3, Hits: -3.456, 8274 ms
Oct 23 14:43:26 localhost amavis[7519]: (07519-06) TIMING [total 8290 ms] - SMTP EHLO: 74 (1%)1, SMTP pre-MAIL: 6 (0%)1, looku
p_ldap: 791 (10%)11, SMTP pre-DATA-flush: 6 (0%)11, SMTP DATA: 1 (0%)11, body_hash: 4 (0%)11, gen_mail_id: 2 (0%)11, mime_deco
de: 149 (2%)12, get-file-type2: 41 (0%)13, decompose_part: 2 (0%)13, decompose_part: 2 (0%)13, parts_decode: 0 (0%)13, AV-scan
-1: 48 (1%)14, spam-wb-list: 10 (0%)14, SA msg read: 2 (0%)14, SA parse: 496 (6%)20, SA check: 2195 (26%)46, update_cache: 5 (
0%)46, deal_with_mail_size: 4 (0%)46, fwd-connect: 73 (1%)47, fwd-mail-from: 18 (0%)47, fwd-rcpt-to: 1225 (15%)62, write-heade
r: 20 (0%)62, fwd-data: 2 (0%)62, fwd-data-end: 2985 (36%)98, fwd-rundown: 7 (0%)99, main_log_entry: 111 (1%)100, update_snmp: 6 (0%)100, unlink-2-files: 3 (0%)100, rundown: 1 (0%)100
Oct 23 14:43:26 localhost postfix/smtp[31700]: 075B58CFE5: to=, relay=127.0.0.1[127.0.0.1], delay=10,
status=sent (250 2.6.0 Ok, id=07519-06, from MTA([127.0.0.1]:10025): 250 Ok: queued as 499AC8CFE7)
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 075B58CFE5: removed
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) ESMTP::10024 /opt/zimbra/amavisd/tmp/amavis-20051023T134536-07518:  ->  Received: SIZE=685685 from localhost.localdomain ([127.0.0.1]) by localhost (localhost
.localdomain [127.0.0.1]) (amavisd-new, port 10024) with ESMTP id 07518-08 for ; Sun, 23 Oct 2005 14:4
3:26 -0400 (EDT)
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) body hash: 6b40a16d538ec892cba027901d192960
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) Checking: FvyeufEr8u13 [127.0.0.1]  -> 
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) Cached virus check expired, TTL = 180 s
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) cached 6b40a16d538ec892cba027901d192960 from  (0,0)
Oct 23 14:43:26 localhost postfix/cleanup[31774]: 5C6778CFEA: message-id=<20051023184326.5C6778CFEA@localhost.localdomain>
Oct 23 14:43:26 localhost postfix/cleanup[31643]: 5FC588CFEC: message-id=<20051023184326.5FC588CFEC@localhost.localdomain>
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 5C6778CFEA: from=<>, size=3653, nrcpt=1 (queue active)
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 5C6778CFEA: to=, relay=none, delay=0, status=deferred (deli
very temporarily suspended: connect to gsmtp83-2.google.com[66.249.83.114]: Connection timed out)
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 5FD608CFDE: removed
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 499AC8CFE7: removed
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 5FC588CFEC: from=<>, size=5775, nrcpt=1 (queue active)
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) p003 1 Content-Type: multipart/mixed
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) p001 1/1 Content-Type: text/plain, size: 430 B, name:
Oct 23 14:43:26 localhost amavis[7518]: (07518-08) p002 1/2 Content-Type: image/jpeg, size: 499678 B, name: DCP_3982.JPG
Oct 23 14:43:26 localhost postfix/qmgr[9755]: 5FC588CFEC: to=, relay=none, delay=0, status=deferred (delive
ry temporarily suspended: connect to gsmtp83-2.google.com[66.249.83.114]: Connection timed out)
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) Checking for banned types and filenames
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) collect banned table[0]: aeldaly@daly.no-ip.com, tables: DEFAULT=>Amavis::L
ookup::RE=ARRAY(0x85e9b7c)
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) p.path aeldaly@daly.no-ip.com: "P=p003,L=1,M=multipart/mixed | P=p001,L=1/1
,M=text/plain,T=asc"
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) p.path aeldaly@daly.no-ip.com: "P=p003,L=1,M=multipart/mixed | P=p002,L=1/2
,M=image/jpeg,T=image,T=jpg,N=DCP_3982.JPG"
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) Using ClamAV-clamd: (built-in interface)
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) Using (ClamAV-clamd) on dir: CONTSCAN /opt/zimbra/amavisd/tmp/amavis-200510
23T134536-07518/parts\n
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) ClamAV-clamd: Connecting to socket  127.0.0.1:3310
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) ClamAV-clamd: Sending CONTSCAN /opt/zimbra/amavisd/tmp/amavis-20051023T1345
36-07518/parts\n to INET socket 127.0.0.1:3310
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) ask_av (ClamAV-clamd): /opt/zimbra/amavisd/tmp/amavis-20051023T134536-07518
/parts CLEAN
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) ClamAV-clamd result: clean
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) spam_scan: not wasting time on SA, message longer than 204800 bytes: 1051+6
75819
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) spam_scan: hits=
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) lookup_ldap_attr(amavisspamkilllevel) (WARN: no such attribute in LDAP entr
y), "aeldaly@daly.no-ip.com" result=undef
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) lookup_ldap_attr(amavisspamtaglevel) (WARN: no such attribute in LDAP entry
), "aeldaly@daly.no-ip.com" result=undef
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) lookup_ldap_attr(amavisspamtag2level) (WARN: no such attribute in LDAP entr
y), "aeldaly@daly.no-ip.com" result=undef
Oct 23 14:43:27 localhost postfix/smtpd[31757]: connect from localhost.localdomain[127.0.0.1]
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) AUTH not needed, user='', MTA offers ''
Oct 23 14:43:27 localhost postfix/smtpd[31757]: A17E58CFCA: client=localhost.localdomain[127.0.0.1]
Oct 23 14:43:27 localhost amavis[7518]: (07518-08) response to RCPT TO for : "250 Ok"
Oct 23 14:43:28 localhost amavis[7519]: (07519-06) ESMTP: NOTICE: client broke the connection without a QUIT ()
Oct 23 14:43:28 localhost amavis[7519]: (07519-06) extra modules loaded: Net/LDAP/Bind.pm
Oct 23 14:43:28 localhost amavis[7519]: (07519-06) load: 2 %, total idle 2331.840 s, busy 36.066 s
Oct 23 14:43:28 localhost postfix/cleanup[31841]: A17E58CFCA: message-id=<6a03a30305071108482bfca7a6@mail.gmail.com>
Oct 23 14:43:31 localhost postfix/qmgr[9755]: A17E58CFCA: from=, size=686158, nrcpt=1 (queue active)
Oct 23 14:43:31 localhost postfix/smtpd[31757]: disconnect from localhost.localdomain[127.0.0.1]
Oct 23 14:43:31 localhost amavis[7518]: (07518-08) FWD via SMTP:  -> , 250 2.6.0 Ok
, id=07518-08, from MTA([127.0.0.1]:10025): 250 Ok: queued as A17E58CFCA
Oct 23 14:43:32 localhost amavis[7518]: (07518-08) lookup_ldap_attr(amavisspamtag2level) (WARN: no such attribute in LDAP entr
y), "aeldaly@daly.no-ip.com" result=undef
Oct 23 14:43:32 localhost amavis[7518]: (07518-08) Passed CLEAN, LOCAL [127.0.0.1] [64.233.163.109]  -> , Message-ID: <6a03a30305071108482bfca7a6@mail.gmail.com>, mail_id: FvyeufEr8u13, Hits: -, 5705 ms

Does this provide any information?

[daly1]

It was a problem with DNS. host.dns.com was being resolved to the internal interface of the firewall sitting infront of the server.

Thanks!

[vpsadmin@webindia.com]

dear daly1,

while using fetchmail just add -a with the fetchmail command.this will fetch the mails which are read (not flushed) mails also.