
12th December 2010, 02:09
|
|
Member
|
|
Join Date: Feb 2007
Location: Lakewood, OH US
Posts: 97
Thanks: 10
Thanked 3 Times in 3 Posts
|
|
After upgrade from Ubuntu 9.10 to 10.10 Mail Queue won't empty - Amavis???
Hi Guys,
I upgraded from Ubuntu 9.10 to 10.10 and everything seems to work OK except incoming mail isn't getting out of the mail queue. It seems to be something to do with amavis.
If I comment out the line in /etc/postfix/main.cf for amavis, then mail is delivered. Of course, now I have no spam/virus checking ;( I see a similar post and they upgraded amavis, but when I tried their instructions, the site for the ppa couldn't be found/resolved.
Here's the line in /etc/postfix/main.cf:
Code:
diff main.cf.orig main.cf
71c71
< content_filter = amavis:[127.0.0.1]:10024
---
> # content_filter = amavis:[127.0.0.1]:10024
Amavis is running on that port:
Code:
tcp 0 0 127.0.0.1:10024 0.0.0.0:* LISTEN 2115/amavisd (maste
tcp 1 0 127.0.0.1:10024 127.0.0.1:51560 CLOSE_WAIT -
tcp 0 0 127.0.0.1:10024 127.0.0.1:55250 ESTABLISHED - amavis 2115 99.8 0.6 195620 76796 ? Rs 22:06 22:57 amavisd (master)
postfix 6314 0.0 0.0 50852 2880 ? S 22:27 0:00 smtp -n amavis -t unix -u -c -o smtp_data_done_timeout=1200 -o smtp_send_xforward_command=yes
postfix 6315 0.0 0.0 50852 2880 ? S 22:27 0:00 smtp -n amavis -t unix -u -c -o smtp_data_done_timeout=1200 -o smtp_send_xforward_command=yes
root 6361 0.0 0.0 7628 960 pts/1 S+ 22:29 0:00 grep amavis
tcp 0 0 127.0.0.1:55251 127.0.0.1:10024 ESTABLISHED 6315/smtp
tcp 1 0 127.0.0.1:10024 127.0.0.1:58023 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:58022 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:51761 CLOSE_WAIT -
tcp 0 0 127.0.0.1:58023 127.0.0.1:10024 FIN_WAIT2 -
tcp 0 0 127.0.0.1:10024 127.0.0.1:55251 ESTABLISHED -
tcp 1 0 127.0.0.1:10024 127.0.0.1:45032 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:57909 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:51762 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:49483 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:51559 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:45033 CLOSE_WAIT -
tcp 1 0 127.0.0.1:10024 127.0.0.1:49482 CLOSE_WAIT -
tcp 0 0 127.0.0.1:55250 127.0.0.1:10024 ESTABLISHED 6314/smtp
tcp 0 0 127.0.0.1:58022 127.0.0.1:10024 FIN_WAIT2 -
tcp 1 0 127.0.0.1:10024 127.0.0.1:57908 CLOSE_WAIT -
I tried to flush it, but it seems to go back to the initial state:
Code:
root@inferno:/etc/init.d# postqueue -p
-Queue ID- --Size-- ----Arrival Time---- -Sender/Recipient-------
13440F625F* 9446 Sat Dec 11 19:51:02 bang@abandoneddirt.info
dantepasquale@cocoanet.us
2DD77F6253 1910 Sat Dec 11 18:57:45 Deena@clickz.com
(conversation with 127.0.0.1[127.0.0.1] timed out while receiving the initial server greeting)
dantepasquale@cocoanet.us
2FEC9F6261 14398 Sat Dec 11 19:53:32 bounce@marketing.guess.com
(lost connection with 127.0.0.1[127.0.0.1] while receiving the initial server greeting)
dantepasquale@cocoanet.us
50133F6591 854 Sat Dec 11 18:40:48 Mary@uiujwaeefbcvcauhd.ataonline.com.tr
(conversation with 127.0.0.1[127.0.0.1] timed out while receiving the initial server greeting)
dantepasquale@cocoanet.us
98DDBF625D 284805 Sat Dec 11 19:13:34 DanteBell@cocoanet.us
(conversation with 127.0.0.1[127.0.0.1] timed out while receiving the initial server greeting)
DantePasquale@cocoanet.us
913F9F61F4 10846 Sat Dec 11 18:39:05 Lisa@siebence.info
(conversation with 127.0.0.1[127.0.0.1] timed out while receiving the initial server greeting)
dantepasquale@cocoanet.us
68AD4F625E 2486 Sat Dec 11 19:24:12 dantebell@covad.net
(conversation with 127.0.0.1[127.0.0.1] timed out while receiving the initial server greeting)
DantePasquale@cocoanet.us
-- 322 Kbytes in 7 Requests.
Then I tried flushing the queue and that looked promising ...
Code:
root@inferno:/etc/init.d# postqueue -f
root@inferno:/etc/init.d# postqueue -p
-Queue ID- --Size-- ----Arrival Time---- -Sender/Recipient-------
13440F625F* 9446 Sat Dec 11 19:51:02 bang@abandoneddirt.info
dantepasquale@cocoanet.us
2DD77F6253* 1910 Sat Dec 11 18:57:45 Deena@clickz.com
dantepasquale@cocoanet.us
2FEC9F6261* 14398 Sat Dec 11 19:53:32 bounce@marketing.guess.com
dantepasquale@cocoanet.us
50133F6591* 854 Sat Dec 11 18:40:48 Mary@uiujwaeefbcvcauhd.ataonline.com.tr
dantepasquale@cocoanet.us
98DDBF625D* 284805 Sat Dec 11 19:13:34 DanteBell@cocoanet.us
DantePasquale@cocoanet.us
913F9F61F4* 10846 Sat Dec 11 18:39:05 Lisa@siebence.info
dantepasquale@cocoanet.us
68AD4F625E* 2486 Sat Dec 11 19:24:12 dantebell@covad.net
DantePasquale@cocoanet.us
-- 322 Kbytes in 7 Requests.
But still no mail reached my mail client, so I ran the -p again and see:
Code:
root@inferno:/etc/init.d# postqueue -p
-Queue ID- --Size-- ----Arrival Time---- -Sender/Recipient-------
2DD77F6253* 1910 Sat Dec 11 18:57:45 Deena@clickz.com
dantepasquale@cocoanet.us
2FEC9F6261* 14398 Sat Dec 11 19:53:32 bounce@marketing.guess.com
dantepasquale@cocoanet.us
50133F6591* 854 Sat Dec 11 18:40:48 Mary@uiujwaeefbcvcauhd.ataonline.com.tr
dantepasquale@cocoanet.us
98DDBF625D* 284805 Sat Dec 11 19:13:34 DanteBell@cocoanet.us
DantePasquale@cocoanet.us
913F9F61F4* 10846 Sat Dec 11 18:39:05 Lisa@siebence.info
dantepasquale@cocoanet.us
68AD4F625E* 2486 Sat Dec 11 19:24:12 dantebell@covad.net
DantePasquale@cocoanet.us
13440F625F 9446 Sat Dec 11 19:51:02 bang@abandoneddirt.info
(conversation with 127.0.0.1[127.0.0.1] timed out while receiving the initial server greeting)
dantepasquale@cocoanet.us
Last edited by DantePasquale; 12th December 2010 at 04:31.
Reason: added main.cf removed amavis and now mail gets delivered.
|

12th December 2010, 19:38
|
|
Super Moderator
|
|
Join Date: Apr 2005
Location: Lüneburg, Germany
Posts: 41,685
Thanks: 1,899
Thanked 2,601 Times in 2,450 Posts
|
|
What's the output of ? What's in your mail log if you try to deliver a mail with amavisd enabled in your Postfix configuration?
|

12th December 2010, 20:23
|
|
Member
|
|
Join Date: Feb 2007
Location: Lakewood, OH US
Posts: 97
Thanks: 10
Thanked 3 Times in 3 Posts
|
|
Here's the mail log. I enabled amavis in postfix main.cf, restarted spamassassin, amavis and postfix:
Code:
Dec 12 14:14:43 inferno spamd[26247]: spamd: server started on port 783/tcp (running version 3.3.1)
Dec 12 14:14:43 inferno spamd[26247]: spamd: server pid: 26247
Dec 12 14:14:43 inferno spamd[26247]: spamd: server successfully spawned child process, pid 26257
Dec 12 14:14:43 inferno spamd[26247]: spamd: server successfully spawned child process, pid 26258
Dec 12 14:14:43 inferno spamd[26247]: prefork: child states: IS
Dec 12 14:14:43 inferno spamd[26247]: prefork: child states: II
Dec 12 14:14:49 inferno amavis[26280]: starting. /usr/sbin/amavisd-new at inferno.cocoanet.us amavisd-new-2.6.4 (20090625), Unicode aware, LANG="en_US.UTF-8"
Dec 12 14:14:49 inferno amavis[26280]: Perl version 5.010001
Dec 12 14:14:49 inferno amavis[26286]: Net::Server: Group Not Defined. Defaulting to EGID '128 128'
Dec 12 14:14:49 inferno amavis[26286]: Net::Server: User Not Defined. Defaulting to EUID '117'
Dec 12 14:14:49 inferno amavis[26286]: Module Amavis::Conf 2.207
Dec 12 14:14:49 inferno amavis[26286]: Module Archive::Zip 1.30
Dec 12 14:14:49 inferno amavis[26286]: Module BerkeleyDB 0.39
Dec 12 14:14:49 inferno amavis[26286]: Module Compress::Zlib 2.022
Dec 12 14:14:49 inferno amavis[26286]: Module Convert::TNEF 0.17
Dec 12 14:14:49 inferno amavis[26286]: Module Convert::UUlib 1.12
Dec 12 14:14:49 inferno amavis[26286]: Module Crypt::OpenSSL::RSA 0.25
Dec 12 14:14:49 inferno amavis[26286]: Module Digest::MD5 2.39
Dec 12 14:14:49 inferno amavis[26286]: Module Digest::SHA 5.47
Dec 12 14:14:49 inferno amavis[26286]: Module IO::Socket::INET6 2.54
Dec 12 14:14:49 inferno amavis[26286]: Module MIME::Entity 5.427
Dec 12 14:14:49 inferno amavis[26286]: Module MIME::Parser 5.427
Dec 12 14:14:49 inferno amavis[26286]: Module MIME::Tools 5.427
Dec 12 14:14:49 inferno amavis[26286]: Module Mail::DKIM::Signer 0.38
Dec 12 14:14:49 inferno amavis[26286]: Module Mail::DKIM::Verifier 0.38
Dec 12 14:14:49 inferno amavis[26286]: Module Mail::Header 2.05
Dec 12 14:14:49 inferno amavis[26286]: Module Mail::Internet 2.05
Dec 12 14:14:49 inferno amavis[26286]: Module Net::DNS 0.65
Dec 12 14:14:49 inferno amavis[26286]: Module Net::Server 0.97
Dec 12 14:14:49 inferno amavis[26286]: Module Socket6 0.23
Dec 12 14:14:49 inferno amavis[26286]: Module Time::HiRes 1.9719
Dec 12 14:14:49 inferno amavis[26286]: Module Unix::Syslog 1.1
Dec 12 14:14:49 inferno amavis[26286]: Amavis::DB code loaded
Dec 12 14:14:49 inferno amavis[26286]: Amavis::Cache code loaded
Dec 12 14:14:49 inferno amavis[26286]: SQL base code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: SQL::Log code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: SQL::Quarantine NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: Lookup::SQL code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: Lookup::LDAP code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: AM.PDP-in proto code loaded
Dec 12 14:14:49 inferno amavis[26286]: SMTP-in proto code loaded
Dec 12 14:14:49 inferno amavis[26286]: Courier proto code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: SMTP-out proto code loaded
Dec 12 14:14:49 inferno amavis[26286]: Pipe-out proto code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: BSMTP-out proto code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: Local-out proto code loaded
Dec 12 14:14:49 inferno amavis[26286]: OS_Fingerprint code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: ANTI-VIRUS code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: ANTI-SPAM code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: ANTI-SPAM-EXT code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: ANTI-SPAM-C code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: ANTI-SPAM-SA code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: Unpackers code loaded
Dec 12 14:14:49 inferno amavis[26286]: DKIM code loaded
Dec 12 14:14:49 inferno amavis[26286]: Tools code NOT loaded
Dec 12 14:14:49 inferno amavis[26286]: Found $file at /usr/bin/file
Dec 12 14:14:49 inferno amavis[26286]: No $altermime, not using it
Dec 12 14:14:49 inferno amavis[26286]: Internal decoder for .mail
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .F
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .Z at /bin/uncompress
Dec 12 14:14:49 inferno amavis[26286]: Internal decoder for .gz
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .bz2 at /bin/bzip2 -d
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .lzo at /usr/bin/lzop -d
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .rpm tried: rpm2cpio.pl, rpm2cpio
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .cpio at /usr/bin/pax
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .tar at /usr/bin/pax
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .deb at /usr/bin/ar
Dec 12 14:14:49 inferno amavis[26286]: Internal decoder for .zip
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .7z tried: 7zr, 7za, 7z
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .rar tried: unrar-free
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .arj at /usr/bin/arj
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .arc at /usr/bin/nomarch
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .zoo at /usr/bin/zoo
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .lha
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .doc tried: ripole
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .cab at /usr/bin/cabextract
Dec 12 14:14:49 inferno amavis[26286]: No decoder for .tnef
Dec 12 14:14:49 inferno amavis[26286]: Internal decoder for .tnef
Dec 12 14:14:49 inferno amavis[26286]: Found decoder for .exe at /usr/bin/arj
Dec 12 14:14:49 inferno amavis[26286]: Creating db in /var/lib/amavis/db/; BerkeleyDB 0.39, libdb 4.8
Dec 12 14:15:01 inferno pop3d: Connection, ip=[::1]
Dec 12 14:15:01 inferno imapd: Connection, ip=[::1]
Dec 12 14:15:01 inferno pop3d: Disconnected, ip=[::1]
Dec 12 14:15:01 inferno imapd: Disconnected, ip=[::1], time=0
Dec 12 14:15:01 inferno postfix/postqueue[26451]: warning: Mail system is down -- accessing queue directly
Dec 12 14:15:01 inferno postfix/master[26457]: daemon started -- version 2.7.0, configuration /etc/postfix
netstat -tap with everything running:
Code:
netstat -tap
Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
tcp 0 0 inferno.cocoanet.u:6011 *:* LISTEN 26145/6
tcp 0 0 *:8443 *:* LISTEN 3932/apache2
tcp 0 0 *:https *:* LISTEN 3932/apache2
tcp 0 0 *:microsoft-ds *:* LISTEN 1376/smbd
tcp 0 0 *:16001 *:* LISTEN 4246/pulseaudio
tcp 0 0 *:9443 *:* LISTEN 3932/apache2
tcp 0 0 inferno.cocoanet.:10024 *:* LISTEN 26286/amavisd (mast
tcp 0 0 inferno.cocoanet.:10025 *:* LISTEN 26457/master
tcp 0 0 *:4713 *:* LISTEN 4246/pulseaudio
tcp 0 0 *:mysql *:* LISTEN 1525/mysqld
tcp 0 0 *:netbios-ssn *:* LISTEN 1376/smbd
tcp 0 0 inferno.cocoanet.:spamd *:* LISTEN 26247/spamd.pid
tcp 0 0 *:www *:* LISTEN 3932/apache2
tcp 0 0 *:5552 *:* LISTEN 1674/tprintdaemon
tcp 0 0 *:tproxy *:* LISTEN 3932/apache2
tcp 0 0 inferno.cocoanet.u:7634 *:* LISTEN 3573/hddtemp
tcp 0 0 *:ftp *:* LISTEN 18770/pure-ftpd (SE
tcp 0 0 h-74-1-46-164.sf:domain *:* LISTEN 1553/named
tcp 0 0 h-74-1-46-168.sf:domain *:* LISTEN 1553/named
tcp 0 0 h-74-1-46-167.sf:domain *:* LISTEN 1553/named
tcp 0 0 h-74-1-46-166.sf:domain *:* LISTEN 1553/named
tcp 0 0 h-74-1-46-165.sf:domain *:* LISTEN 1553/named
tcp 0 0 www.cocoanet.us:domain *:* LISTEN 1553/named
tcp 0 0 inferno.cocoanet:domain *:* LISTEN 1553/named
tcp 0 0 inferno.cocoanet:domain *:* LISTEN 1553/named
tcp 0 0 *:ssh *:* LISTEN 2095/sshd
tcp 0 0 *:ipp *:* LISTEN 3870/cupsd
tcp 0 0 *:smtp *:* LISTEN 26457/master
tcp 0 0 inferno.cocoanet.u:5433 *:* LISTEN 2138/postgres
tcp 0 0 inferno.cocoanet.us:953 *:* LISTEN 1553/named
tcp 0 0 inferno.cocoanet.u:6010 *:* LISTEN 25582/5
tcp 38 0 h-74-1-46-164.sfl:48148 one-ubuntu-com.ca:https CLOSE_WAIT 4694/python
tcp 0 0 h-74-1-46-164.sfl:59872 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:56145 a184-84-255-154.dep:www ESTABLISHED 4324/gweather-apple
tcp 0 0 h-74-1-46-164.sfl:59866 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59904 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59889 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:39565 ec2-174-129-241-1:https ESTABLISHED 4694/python
tcp 0 0 h-74-1-46-164.sfl:59883 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:56146 a184-84-255-154.dep:www ESTABLISHED 4324/gweather-apple
tcp 0 0 inferno.cocoanet.us:ssh h-74-1-46-171.sfl:55056 ESTABLISHED 25505/sshd: dante [
tcp 0 0 h-74-1-46-164.sfl:59891 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59892 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 inferno.co:microsoft-ds 74.81.152.184:1209 ESTABLISHED 26778/smbd
tcp 0 0 www.cocoanet.us:www h-74-1-46-171.sfl:55132 ESTABLISHED 18738/apache2
tcp 0 0 h-74-1-46-164.sfl:59868 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59862 cluster003.ovh.net:www TIME_WAIT -
tcp 1 0 h-74-1-46-164.sfl:43769 205.128.76.126:www CLOSE_WAIT 4324/gweather-apple
tcp 0 0 h-74-1-46-164.sfl:59865 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-:microsoft-ds 74.81.152.184:1318 ESTABLISHED 26785/smbd
tcp 0 0 h-74-1-46-164.sfl:59905 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-:microsoft-ds 74.81.152.184:1242 ESTABLISHED 26780/smbd
tcp 0 0 h-74-1-46-164.sfl:59896 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59898 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59885 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 inferno.co:microsoft-ds 74.81.152.184:2129 ESTABLISHED -
tcp 0 0 h-74-1-46-164.sfl:59908 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 inferno.cocoanet.us:ssh h-74-1-46-171.sfl:55191 ESTABLISHED 26078/sshd: dante [
tcp 0 0 h-74-1-46-164.sfl:59890 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 www.cocoan:microsoft-ds 74.81.152.184:2203 ESTABLISHED -
tcp 0 0 h-74-1-46-:microsoft-ds 74.81.152.184:2205 ESTABLISHED -
tcp 0 0 h-74-1-46-164.sfl:59894 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59895 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59907 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59884 cluster003.ovh.net:www TIME_WAIT -
tcp 0 0 h-74-1-46-164.sfl:59906 cluster003.ovh.net:www TIME_WAIT -
tcp6 0 0 localhost:6011 [::]:* LISTEN 26145/6
tcp6 0 0 [::]:16001 [::]:* LISTEN 4246/pulseaudio
tcp6 0 0 [::]:imaps [::]:* LISTEN 3409/couriertcpd
tcp6 0 0 [::]:pop3s [::]:* LISTEN 3443/couriertcpd
tcp6 0 0 [::]:4713 [::]:* LISTEN 4246/pulseaudio
tcp6 0 0 [::]:pop3 [::]:* LISTEN 3423/couriertcpd
tcp6 0 0 [::]:imap2 [::]:* LISTEN 3389/couriertcpd
tcp6 0 0 [::]:ftp [::]:* LISTEN 18770/pure-ftpd (SE
tcp6 0 0 [::]:domain [::]:* LISTEN 1553/named
tcp6 0 0 [::]:ssh [::]:* LISTEN 2095/sshd
tcp6 0 0 [::]:ipp [::]:* LISTEN 3870/cupsd
tcp6 0 0 localhost:5433 [::]:* LISTEN 2138/postgres
tcp6 0 0 localhost:953 [::]:* LISTEN 1553/named
tcp6 0 0 localhost:6010 [::]:* LISTEN 25582/5
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55024 ESTABLISHED 4967/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55045 ESTABLISHED 25343/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55047 ESTABLISHED 20806/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55031 ESTABLISHED 12335/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55096 ESTABLISHED 25368/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55025 ESTABLISHED 4961/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55029 ESTABLISHED 4963/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55005 ESTABLISHED 4904/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55013 ESTABLISHED 4576/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55011 ESTABLISHED 24080/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55105 ESTABLISHED 25366/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55049 ESTABLISHED 25354/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55021 ESTABLISHED 4581/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55055 ESTABLISHED 18570/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55002 ESTABLISHED 4789/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55069 ESTABLISHED 21908/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55038 ESTABLISHED 24921/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55015 ESTABLISHED 5382/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55017 ESTABLISHED 4909/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55036 ESTABLISHED 22980/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55081 ESTABLISHED 25134/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55008 ESTABLISHED 4908/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55003 ESTABLISHED 4811/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55035 ESTABLISHED 13974/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55022 ESTABLISHED 4964/couriertls
tcp6 0 0 www.cocoanet.us:imaps h-74-1-46-171.sfl:55068 ESTABLISHED 5264/couriertls
tcp6 0 0 h-74-1-46-166.sfl:imaps h-74-1-46-171.sfl:55007 ESTABLISHED 4986/couriertls
Here's the mail.log after sending from gmail to a few accounts on my server:
Code:
Dec 12 14:18:33 inferno postfix/smtpd[26985]: connect from mail-ww0-f41.google.com[74.125.82.41]
Dec 12 14:18:34 inferno postfix/smtpd[26985]: 11E95F61C6: client=mail-ww0-f41.google.com[74.125.82.41]
Dec 12 14:18:34 inferno postfix/cleanup[26995]: 11E95F61C6: message-id=<AANLkTi=CzDEw89BO7FEawXfBrsQ2QOOqqsrmDFtOk4oE@mail.gmail.com>
Dec 12 14:18:34 inferno postfix/qmgr[26460]: 11E95F61C6: from=<dantepasquale@gmail.com>, size=11511, nrcpt=1 (queue active)
Dec 12 14:18:34 inferno postfix/smtpd[27195]: connect from inferno.cocoanet.us[127.0.0.1]
Dec 12 14:18:34 inferno postfix/smtpd[27195]: E4972F61C8: client=inferno.cocoanet.us[127.0.0.1]
Dec 12 14:18:34 inferno postfix/cleanup[26995]: E4972F61C8: message-id=<AANLkTi=CzDEw89BO7FEawXfBrsQ2QOOqqsrmDFtOk4oE@mail.gmail.com>
Dec 12 14:18:34 inferno postfix/qmgr[26460]: E4972F61C8: from=<dantepasquale@gmail.com>, size=11933, nrcpt=1 (queue active)
Dec 12 14:18:34 inferno amavis[26288]: (26288-01) Passed CLEAN, [74.125.82.41] [74.125.82.41] <dantepasquale@gmail.com> -> <Donatella@crustypanties.us>, Message-ID: <AANLkTi=CzDEw89BO7FEawXfBrsQ2QOOqqsrmDFtOk4oE@mail.gmail.com>, mail_id: bO2Jbgr+mlgI, Hits: -, size: 11511, queued_as: E4972F61C8, dkim_id=@gmail.com,dantepasquale@gmail.com, 455 ms
Dec 12 14:18:34 inferno postfix/smtp[26998]: 11E95F61C6: to=<Donatella@crustypanties.us>, relay=127.0.0.1[127.0.0.1]:10024, delay=1, delays=0.56/0/0.01/0.45, dsn=2.0.0, status=sent (250 2.0.0 Ok, id=26288-01, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as E4972F61C8)
Dec 12 14:18:34 inferno postfix/qmgr[26460]: 11E95F61C6: removed
Dec 12 14:18:34 inferno postfix/pipe[27002]: E4972F61C8: to=<donatella@crustypanties.us>, relay=maildrop, delay=0.03, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered via maildrop service)
Dec 12 14:18:34 inferno postfix/qmgr[26460]: E4972F61C8: removed
Dec 12 14:18:35 inferno postfix/smtpd[27204]: connect from mail-ww0-f48.google.com[74.125.82.48]
Dec 12 14:18:36 inferno postfix/smtpd[27204]: 4C1AAF61C6: client=mail-ww0-f48.google.com[74.125.82.48]
Dec 12 14:18:36 inferno postfix/cleanup[26995]: 4C1AAF61C6: message-id=<AANLkTi=CzDEw89BO7FEawXfBrsQ2QOOqqsrmDFtOk4oE@mail.gmail.com>
Dec 12 14:18:36 inferno postfix/qmgr[26460]: 4C1AAF61C6: from=<dantepasquale@gmail.com>, size=11471, nrcpt=2 (queue active)
Dec 12 14:18:36 inferno postfix/smtpd[27000]: E7932F61C8: client=inferno.cocoanet.us[127.0.0.1]
Dec 12 14:18:36 inferno postfix/cleanup[26995]: E7932F61C8: message-id=<AANLkTi=CzDEw89BO7FEawXfBrsQ2QOOqqsrmDFtOk4oE@mail.gmail.com>
Dec 12 14:18:36 inferno postfix/qmgr[26460]: E7932F61C8: from=<dantepasquale@gmail.com>, size=11825, nrcpt=2 (queue active)
Dec 12 14:18:36 inferno postfix/smtpd[27000]: disconnect from inferno.cocoanet.us[127.0.0.1]
Dec 12 14:18:36 inferno amavis[26287]: (26287-02) Passed CLEAN, [74.125.82.48] [74.125.82.48] <dantepasquale@gmail.com> -> <DantePasquale@cocoanet.us>,<dantebell@cocoanet.us>, Message-ID: <AANLkTi=CzDEw89BO7FEawXfBrsQ2QOOqqsrmDFtOk4oE@mail.gmail.com>, mail_id: jwx0VdoySMKs, Hits: -, size: 11471, queued_as: E7932F61C8, dkim_id=@gmail.com,dantepasquale@gmail.com, 105 ms
Dec 12 14:18:36 inferno postfix/smtp[26998]: 4C1AAF61C6: to=<DantePasquale@cocoanet.us>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.79, delays=0.68/0/0/0.11, dsn=2.0.0, status=sent (250 2.0.0 Ok, id=26287-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as E7932F61C8)
Dec 12 14:18:36 inferno postfix/smtp[26998]: 4C1AAF61C6: to=<dantebell@cocoanet.us>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.79, delays=0.68/0/0/0.11, dsn=2.0.0, status=sent (250 2.0.0 Ok, id=26287-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as E7932F61C8)
Dec 12 14:18:36 inferno postfix/qmgr[26460]: 4C1AAF61C6: removed
Dec 12 14:18:36 inferno postfix/pipe[27002]: E7932F61C8: to=<dantebell@cocoanet.us>, relay=maildrop, delay=0.04, delays=0.01/0/0/0.03, dsn=2.0.0, status=sent (delivered via maildrop service)
Dec 12 14:18:37 inferno postfix/pipe[27214]: E7932F61C8: to=<dantepasquale@cocoanet.us>, relay=maildrop, delay=0.08, delays=0.01/0.01/0/0.06, dsn=2.0.0, status=sent (delivered via maildrop service)
Dec 12 14:18:37 inferno postfix/qmgr[26460]: E7932F61C8: removed
Dec 12 14:19:04 inferno postfix/smtpd[26985]: disconnect from mail-ww0-f41.google.com[74.125.82.41]
Dec 12 14:19:06 inferno postfix/smtpd[27204]: disconnect from mail-ww0-f48.google.com[74.125.82.48]
...
Dec 12 14:21:49 inferno postfix/cleanup[27907]: A5F53F61C8: message-id=<20101212142146.zudk10e42v6w4o40@webmail.covad.net>
Dec 12 14:21:49 inferno postfix/smtpd[27195]: disconnect from inferno.cocoanet.us[127.0.0.1]
Dec 12 14:21:49 inferno postfix/qmgr[26460]: A5F53F61C8: from=<dantebell@covad.net>, size=2801, nrcpt=2 (queue active)
Dec 12 14:21:49 inferno amavis[26288]: (26288-02) Passed CLEAN, [209.235.129.76] [74.1.46.171] <dantebell@covad.net> -> <DanteBell@cocoanet.us>,<DantePasquale@cocoanet.us>, Message-ID: <20101212142146.zudk10e42v6w4o40@webmail.covad.net>, mail_id: D6GAe--wN7j6, Hits: -, size: 2447, queued_as: A5F53F61C8, 90 ms
Dec 12 14:21:49 inferno postfix/smtp[27908]: 719F4F61C6: to=<DanteBell@cocoanet.us>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.27, delays=0.17/0.01/0/0.09, dsn=2.0.0, status=sent (250 2.0.0 Ok, id=26288-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as A5F53F61C8)
Dec 12 14:21:49 inferno postfix/smtp[27908]: 719F4F61C6: to=<DantePasquale@cocoanet.us>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.27, delays=0.17/0.01/0/0.09, dsn=2.0.0, status=sent (250 2.0.0 Ok, id=26288-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as A5F53F61C8)
Dec 12 14:21:49 inferno postfix/qmgr[26460]: 719F4F61C6: removed
Dec 12 14:21:49 inferno postfix/pipe[27911]: A5F53F61C8: to=<dantebell@cocoanet.us>, relay=maildrop, delay=0.04, delays=0.01/0.01/0/0.03, dsn=2.0.0, status=sent (delivered via maildrop service)
Dec 12 14:21:49 inferno postfix/pipe[27912]: A5F53F61C8: to=<dantepasquale@cocoanet.us>, relay=maildrop, delay=0.08, delays=0.01/0.01/0/0.06, dsn=2.0.0, status=sent (delivered via maildrop service)
Dec 12 14:21:49 inferno postfix/qmgr[26460]: A5F53F61C8: removed
Not sure why, but things look better now. Mail is finally beind pushed out the postfix queue, but all kinds of spam is coming through and I don't see any messages about amavis or spamassassin dumping bad messages. Did I lose the config files for amavis & spam assassin?
Last edited by DantePasquale; 13th December 2010 at 01:54.
Reason: clarify 'better'
|

13th December 2010, 14:40
|
|
Super Moderator
|
|
Join Date: Apr 2005
Location: Lüneburg, Germany
Posts: 41,685
Thanks: 1,899
Thanked 2,601 Times in 2,450 Posts
|
|
What's in /etc/hosts? What's in your main.cf and master.cf now?
|

13th December 2010, 15:47
|
|
Member
|
|
Join Date: Feb 2007
Location: Lakewood, OH US
Posts: 97
Thanks: 10
Thanked 3 Times in 3 Posts
|
|
postfix config files:
main.cf
Code:
# See /usr/share/postfix/main.cf.dist for a commented, more complete version
# Debian specific: Specifying a file name will cause the first
# line of that file to be used as the name. The Debian default
# is /etc/mailname.
#myorigin = /etc/mailname
smtpd_banner = $myhostname ESMTP $mail_name (Ubuntu)
biff = no
# appending .domain is the MUA's job.
append_dot_mydomain = no
# Uncomment the next line to generate "delayed mail" warnings
#delay_warning_time = 4h
readme_directory = /usr/share/doc/postfix
# TLS parameters
smtpd_tls_cert_file = /etc/postfix/smtpd.cert
smtpd_tls_key_file = /etc/postfix/smtpd.key
smtpd_use_tls = yes
smtpd_tls_session_cache_database = btree:${data_directory}/smtpd_scache
smtp_tls_session_cache_database = btree:${data_directory}/smtp_scache
# See /usr/share/doc/postfix/TLS_README.gz in the postfix-doc package for
# information on enabling SSL in the smtp client.
myhostname = inferno.cocoanet.us
alias_maps = hash:/etc/aliases
alias_database = hash:/etc/aliases
myorigin = /etc/mailname
mydestination = inferno.cocoanet.us, localhost, localhost.localdomain
relayhost =
mynetworks = 127.0.0.0/8 [::1]/128
mailbox_size_limit = 0
recipient_delimiter = +
inet_interfaces = all
html_directory = /usr/share/doc/postfix/html
virtual_alias_domains =
virtual_alias_maps = proxy:mysql:/etc/postfix/mysql-virtual_forwardings.cf, mysql:/etc/postfix/mysql-virtual_email2email.cf
virtual_mailbox_domains = proxy:mysql:/etc/postfix/mysql-virtual_domains.cf
virtual_mailbox_maps = proxy:mysql:/etc/postfix/mysql-virtual_mailboxes.cf
virtual_mailbox_base = /var/vmail
virtual_uid_maps = static:5000
virtual_gid_maps = static:5000
smtpd_sasl_auth_enable = yes
broken_sasl_auth_clients = yes
smtpd_sasl_authenticated_header = yes
smtpd_recipient_restrictions = permit_mynetworks, permit_sasl_authenticated, check_recipient_access mysql:/etc/postfix/mysql-virtual_recipient.cf, reject_unauth_destination
smtpd_tls_security_level = may
transport_maps = proxy:mysql:/etc/postfix/mysql-virtual_transports.cf
relay_domains = mysql:/etc/postfix/mysql-virtual_relaydomains.cf
virtual_create_maildirsize = yes
virtual_maildir_extended = yes
virtual_mailbox_limit_maps = proxy:mysql:/etc/postfix/mysql-virtual_mailbox_limit_maps.cf
virtual_mailbox_limit_override = yes
virtual_maildir_limit_message = "The user you are trying to reach is over quota."
virtual_overquota_bounce = yes
proxy_read_maps = $local_recipient_maps $mydestination $virtual_alias_maps $virtual_alias_domains $virtual_mailbox_maps $virtual_mailbox_domains $relay_recipient_maps $relay_domains $canonical_maps $sender_canonical_maps $recipient_canonical_maps $relocated_maps $transport_maps $mynetworks $virtual_mailbox_limit_maps
smtpd_sender_restrictions = check_sender_access mysql:/etc/postfix/mysql-virtual_sender.cf
smtpd_client_restrictions = check_client_access mysql:/etc/postfix/mysql-virtual_client.cf
maildrop_destination_concurrency_limit = 1
maildrop_destination_recipient_limit = 1
virtual_transport = maildrop
header_checks = regexp:/etc/postfix/header_checks
mime_header_checks = regexp:/etc/postfix/mime_header_checks
nested_header_checks = regexp:/etc/postfix/nested_header_checks
body_checks = regexp:/etc/postfix/body_checks
content_filter = amavis:[127.0.0.1]:10024
receive_override_options = no_address_mappings
message_size_limit = 0
relay_recipient_maps = mysql:/etc/postfix/mysql-virtual_relayrecipientmaps.cf
master.cf
Code:
#
# Postfix master process configuration file. For details on the format
# of the file, see the master(5) manual page (command: "man 5 master").
#
# Do not forget to execute "postfix reload" after editing this file.
#
# ==========================================================================
# service type private unpriv chroot wakeup maxproc command + args
# (yes) (yes) (yes) (never) (100)
# ==========================================================================
smtp inet n - - - - smtpd
#submission inet n - - - - smtpd
# -o smtpd_tls_security_level=encrypt
# -o smtpd_sasl_auth_enable=yes
# -o smtpd_client_restrictions=permit_sasl_authenticated,reject
# -o milter_macro_daemon_name=ORIGINATING
#smtps inet n - - - - smtpd
# -o smtpd_tls_wrappermode=yes
# -o smtpd_sasl_auth_enable=yes
# -o smtpd_client_restrictions=permit_sasl_authenticated,reject
# -o milter_macro_daemon_name=ORIGINATING
#628 inet n - - - - qmqpd
pickup fifo n - - 60 1 pickup
cleanup unix n - - - 0 cleanup
qmgr fifo n - n 300 1 qmgr
#qmgr fifo n - - 300 1 oqmgr
tlsmgr unix - - - 1000? 1 tlsmgr
rewrite unix - - - - - trivial-rewrite
bounce unix - - - - 0 bounce
defer unix - - - - 0 bounce
trace unix - - - - 0 bounce
verify unix - - - - 1 verify
flush unix n - - 1000? 0 flush
proxymap unix - - n - - proxymap
proxywrite unix - - n - 1 proxymap
smtp unix - - - - - smtp
# When relaying mail as backup MX, disable fallback_relay to avoid MX loops
relay unix - - - - - smtp
-o smtp_fallback_relay=
# -o smtp_helo_timeout=5 -o smtp_connect_timeout=5
showq unix n - - - - showq
error unix - - - - - error
retry unix - - - - - error
discard unix - - - - - discard
local unix - n n - - local
virtual unix - n n - - virtual
lmtp unix - - - - - lmtp
anvil unix - - - - 1 anvil
scache unix - - - - 1 scache
#
# ====================================================================
# Interfaces to non-Postfix software. Be sure to examine the manual
# pages of the non-Postfix software to find out what options it wants.
#
# Many of the following services use the Postfix pipe(8) delivery
# agent. See the pipe(8) man page for information about ${recipient}
# and other message envelope options.
# ====================================================================
#
# maildrop. See the Postfix MAILDROP_README file for details.
# Also specify in main.cf: maildrop_destination_recipient_limit=1
#
maildrop unix - n n - - pipe
flags=DRhu user=vmail argv=/usr/bin/maildrop -d vmail ${extension} ${recipient} ${user} ${nexthop} ${sender}
#
# See the Postfix UUCP_README file for configuration details.
#
uucp unix - n n - - pipe
flags=Fqhu user=uucp argv=uux -r -n -z -a$sender - $nexthop!rmail ($recipient)
#
# Other external delivery methods.
#
ifmail unix - n n - - pipe
flags=F user=ftn argv=/usr/lib/ifmail/ifmail -r $nexthop ($recipient)
bsmtp unix - n n - - pipe
flags=Fq. user=bsmtp argv=/usr/lib/bsmtp/bsmtp -t$nexthop -f$sender $recipient
scalemail-backend unix - n n - 2 pipe
flags=R user=scalemail argv=/usr/lib/scalemail/bin/scalemail-store ${nexthop} ${user} ${extension}
mailman unix - n n - - pipe
flags=FR user=list argv=/usr/lib/mailman/bin/postfix-to-mailman.py
${nexthop} ${user}
amavis unix - - - - 2 smtp
-o smtp_data_done_timeout=1200
-o smtp_send_xforward_command=yes
127.0.0.1:10025 inet n - - - - smtpd
-o content_filter=
-o local_recipient_maps=
-o relay_recipient_maps=
-o smtpd_restriction_classes=
-o smtpd_client_restrictions=
-o smtpd_helo_restrictions=
-o smtpd_sender_restrictions=
-o smtpd_recipient_restrictions=permit_mynetworks,reject
-o mynetworks=127.0.0.0/8
-o strict_rfc821_envelopes=yes
-o receive_override_options=no_unknown_recipient_checks,no_header_body_checks
-o smtpd_bind_address=127.0.0.1
I think these haven't changed other than me commenting out the amavis stuff for debugging.
Also, I am seeing messages from amavis in /var/log/syslog as expected. The reason I didn't see them before is that amavisd-new was using 100% CPU and probably was looping on something. However, tons of spam is still getting through. Does spamassassin have to re-learn everything after an upgrade?
Code:
Dec 13 09:57:50 inferno amavis[30597]: (30597-10) Passed CLEAN, [91.113.132.50] [202.189.118.253] <Norma@stertil.de> -> <dantepasquale@cocoanet.us>, Message-ID: <1C33A810.1191676@rsi.com>, mail_id: I-kGCGDWHMwB, Hits: -, size: 1487, queued_as: 1A43EF61C6, 92 ms
Last edited by DantePasquale; 13th December 2010 at 16:01.
|

14th December 2010, 02:34
|
|
Member
|
|
Join Date: Feb 2007
Location: Lakewood, OH US
Posts: 97
Thanks: 10
Thanked 3 Times in 3 Posts
|
|
Well, the power went out for 8 hours, when the server came back online amavisd-new was back to using 100% CPU. So I ran it in debug mode via
Code:
service amavis debug
and see this spewing out to the screen:
Code:
Use of uninitialized value $fam_listen in numeric ne (!=) at /usr/share/perl5/IO/Socket/INET6.pm line 182.
---
Thousands of times!!
So I did some searching and it turns out I had this exact same messages spewing out after upgrading to 9.10!
See this post: http://www.howtoforge.com/forums/sho...33&postcount=3
The problem is that for some reason, the perl that I have after upgrading doesn't have proper IPV6 support. Not sure why, and not sure where it comes from, but this upgrade had the same issue!
So, I followed the instructions in the previous post of mine and it looks like things are working, again.
Didn't reboot yet (I'm not there so I don't want it to fail and I have some major, major work to do this week!).
|
|
The Following User Says Thank You to DantePasquale For This Useful Post:
|
falko (14th December 2010)
|
| Thread Tools |
|
|
| Display Modes |
Linear Mode
|
Posting Rules
|
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts
HTML code is Off
|
|
|
All times are GMT +2. The time now is 08:34.
|
|
Recent comments
16 hours 8 min ago
17 hours 8 min ago
20 hours 55 min ago
22 hours 9 min ago
1 day 1 hour ago
1 day 9 hours ago
1 day 17 hours ago
1 day 19 hours ago
2 days 10 hours ago
2 days 12 hours ago