Hi, I re-installed Digest::MD5 from scratch - make, make test, make
install - all went well but still the same problem:
Apr 11 10:23:16 isis postfix/smtp[16296]: [ID 197553 mail.info]
5533D2E8BA: to=<[EMAIL PROTECTED]>, orig_to=<[EMAIL PROTECTED]>,
relay=127.0.0.1[127.0.0.1], delay=-541, status=deferred (lost connection
with 127.0.0.1[127.0.0.1] while sending MAIL FROM)
Apr 11 10:23:16 isis postfix/smtp[16297]: [ID 197553 mail.info]
6B2902E943: to=<[EMAIL PROTECTED]>, relay=127.0.0.1[127.0.0.1],
delay=-590, status=deferred (lost connection with 127.0.0.1[127.0.0.1]
while sending MAIL FROM)
Apr 11 10:23:16 isis postfix/smtp[16296]: [ID 197553 mail.info]
5533D2E8BA: to=<[EMAIL PROTECTED]>, orig_to=<[EMAIL PROTECTED]>,
relay=127.0.0.1[127.0.0.1], delay=-541, status=deferred (lost connection
with 127.0.0.1[127.0.0.1] while sending MAIL FROM)
Apr 11 10:23:17 isis postfix/smtp[16297]: [ID 197553 mail.info]
812082EA32: to=<[EMAIL PROTECTED]>, relay=127.0.0.1[127.0.0.1],
delay=-833, status=deferred (lost connection with 127.0.0.1[127.0.0.1]
while sending end of data -- message may be sent more than once)
Mark Martinec wrote:
It looks like a process 24132 dies or a horrible sudden death
just before mail checking starts.
Could be a problem in crypto library. Try reinstalling module Digest::MD5
and make sure to run its self-diagnostics at installation time.
Mark
Here is the new output from amavisd debug:
# amavisd -u amavis debug
Apr 11 10:22:36 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
starting. /usr/local/sbin/amavisd at isis.eng.fsu.edu amavisd-new-2.4.0
(20060403)
Apr 11 10:22:36 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
user=amavis, EUID: 11369 (11369); group=184, EGID: 184 184 (184 184);
log_level=4
Apr 11 10:22:36 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Perl
version 5.006001
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: INFO:
no optional modules: DBD::mysql Sys::Hostname::Long Mail::SPF::Query
Net::CIDR::Lite Mail::SpamAssassin::Plugin::DomainKeys
Mail::DomainKeys::Header Mail::DomainKeys::Message
Mail::DomainKeys::Policy Mail::DomainKeys::Signature
Mail::DomainKeys::Key Mail::DomainKeys::Key::Public Crypt::OpenSSL::RSA
auto::Crypt::OpenSSL::RSA::new_public_key
auto::Crypt::OpenSSL::RSA::load_public_key
auto::Crypt::OpenSSL::RSA::_new auto::Crypt::OpenSSL::RSA::DESTROY
IP::Country::Fast
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
SpamControl: init_pre_chroot done
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: 2006/04/11-10:22:37 Amavis (type
Net::Server::PreForkSimple) starting! pid(15523)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Binding to UNIX socket file /var/amavis/amavisd.sock using
SOCK_STREAM
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Binding to TCP port 10024 on host 127.0.0.1
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Group Not Defined. Defaulting to EGID '184 184'
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: User Not Defined. Defaulting to EUID '11369'
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Setting up serialization via flock
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Amavis::Conf 2.062
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Archive::Tar 1.29
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Archive::Zip 1.16
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
BerkeleyDB 0.27
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Compress::Zlib 1.41
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Convert::TNEF 0.17
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Convert::UUlib 1.06
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
DBI 1.47
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
DB_File 1.811
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Digest::MD5 2.36
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
MIME::Entity 5.420
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
MIME::Parser 5.420
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
MIME::Tools 5.420
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Mail::Header 1.74
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Mail::Internet 1.74
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Mail::SpamAssassin 3.001001
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Net::Cmd 2.26
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Net::DNS 0.48
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Net::SMTP 2.29
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Net::Server 0.93
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Razor2::Client::Version 2.75
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Time::HiRes 1.66
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Module
Unix::Syslog 0.100
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Amavis::DB code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Amavis::Cache code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: SQL
base code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
SQL::Log code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
SQL::Quarantine NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Lookup::SQL code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Lookup::LDAP code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
AM.PDP-in proto code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: SMTP-in
proto code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Courier
proto code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
SMTP-out proto code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Pipe-out proto code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
BSMTP-out proto code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Local-out proto code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
OS_Fingerprint code NOT loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
ANTI-VIRUS code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
ANTI-SPAM code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
ANTI-SPAM-SA code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Unpackers code loaded
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
$file at /usr/bin/file
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
$dspam, not using it
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .mail
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .asc
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .uue
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .hqx
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .ync
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .F at /usr/local/bin/unfreeze
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .Z at /usr/bin/uncompress
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .gz
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .gz at /usr/local/bin/gzip -d (backup, not used)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .bz2 at /usr/bin/bzip2 -d
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .lzo at /usr/local/bin/lzop -d
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .rpm at /usr/bin/rpm2cpio
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .cpio at /usr/bin/pax
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .tar at /usr/bin/pax
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .tar (backup, not used)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .deb at /usr/local/bin/ar
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .zip
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .rar at /usr/local/bin/rar
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .arj at /usr/local/bin/unarj
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
decoder for .arc tried: nomarch, arc
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .zoo at /usr/local/bin/zoo
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .lha at /usr/local/bin/lha
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .cab at /usr/local/bin/cabextract
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .tnef at /usr/local/bin/tnef
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Internal decoder for .tnef (backup, not used)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Found
decoder for .exe at /usr/local/bin/rar; /usr/local/bin/lha;
/usr/local/bin/unarj
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: Using
internal av scanner code for (primary) ClamAV-clamd
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: KasperskyLab AVP - aveclient
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: KasperskyLab AntiViral Toolkit Pro (AVP)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: KasperskyLab AVPDaemonClient
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: CentralCommand Vexira (new) vascan
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: H+BEDV AntiVir or the (old) CentralCommand Vexira
Antivirus
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: Command AntiVirus for Linux
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: Symantec CarrierScan via Symantec CommandLineScanner
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: Symantec AntiVirus Scan Engine
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: F-Secure Antivirus
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: CAI InoculateIT
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: CAI eTrust Antivirus
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: MkS_Vir for Linux (beta)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: MkS_Vir daemon
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: ESET Software NOD32 Command Line Interface v 2.51
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: Norman Virus Control v5 / Linux
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: Panda Antivirus for Linux
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: NAI McAfee AntiVirus (uvscan)
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: VirusBuster
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: CyberSoft VFind
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: avast! Antivirus
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: Ikarus AntiVirus for Linux
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
primary av scanner: BitDefender
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
secondary av scanner: ClamAV-clamscan
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
secondary av scanner: FRISK F-Prot Antivirus
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
secondary av scanner: Trend Micro FileScanner
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
secondary av scanner: drweb - DrWeb Antivirus
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]: No
secondary av scanner: KasperskyLab kavscanner
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Creating db in /var/amavis/db/; BerkeleyDB 0.27, libdb 3.3
Apr 11 10:22:37 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
SpamControl: initializing Mail::SpamAssassin
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
SpamControl: init_pre_fork done
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Beginning prefork (2 processes)
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Starting "2" children
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
Net::Server: Child Preforked (15532)
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
Net::Server: Child Preforked (15534)
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]: TIMING
[total 19 ms] - bdb-open: 18 (99%)99, rundown: 0 (1%)100
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]: TIMING
[total 26 ms] - bdb-open: 26 (100%)100, rundown: 0 (0%)100
Apr 11 10:22:39 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Parent ready for children.
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
Net::Server: 2006/04/11-10:23:16 CONNECT TCP Peer: "127.0.0.1:41874"
Local: "127.0.0.1:10024"
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]: loaded
base policy bank
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
lookup_ip_acl (inet_acl): key="127.0.0.1" matches "127.0.0.1", result=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
process_request: fileno sock=13, STDIN=0, STDOUT=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
prolong_timer new request - timer reset: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
process_request: suggested_protocol="" on TCP
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) SMTP> 220 [127.0.0.1] ESMTP amavisd-new service ready
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 4: was busy, 17.2 ms, total idle 0.000 s, busy 0.017 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 5: was idle, 4.0 ms, total idle 0.004 s, busy 0.017 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) SMTP< EHLO isis.eng.fsu.edu\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer SMTP EHLO received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-[127.0.0.1]
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-VRFY
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-PIPELINING
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-SIZE
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-ENHANCEDSTATUSCODES
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-8BITMIME
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250-DSN
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250 XFORWARD NAME ADDR PROTO HELO
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 6: was busy, 3.2 ms, total idle 0.004 s, busy 0.020 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 5: was idle, 1.2 ms, total idle 0.005 s, busy 0.020 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP< XFORWARD NAME=localhost ADDR=127.0.0.1\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer SMTP XFORWARD received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250 2.5.0 Ok XFORWARD
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 6: was busy, 1.6 ms, total idle 0.005 s, busy 0.022 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 5: was idle, 0.2 ms, total idle 0.005 s, busy 0.022 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP< XFORWARD PROTO=ESMTP HELO=localhost\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer SMTP XFORWARD received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP> 250 2.5.0 Ok XFORWARD
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 6: was busy, 1.2 ms, total idle 0.005 s, busy 0.023 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) idle_proc, 5: was idle, 0.3 ms, total idle 0.006 s, busy 0.023 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) ESMTP< MAIL FROM:<[EMAIL PROTECTED]> SIZE=4323\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) prolong_timer SMTP MAIL received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) check_mail_begin_task: task_count=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15532]:
(15532-01) TempDir::prepare: creating directory
/var/amavis/tmp/amavis-20060411T102316-15532Apr 11 10:23:16
isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]: Net::Server:
2006/04/11-10:23:16 CONNECT TCP Peer: "127.0.0.1:41876" Local:
"127.0.0.1:10024"
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]: loaded
base policy bank
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
lookup_ip_acl (inet_acl): key="127.0.0.1" matches "127.0.0.1", result=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
process_request: fileno sock=13, STDIN=0, STDOUT=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
prolong_timer new request - timer reset: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
process_request: suggested_protocol="" on TCP
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Starting "1" children
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) SMTP> 220 [127.0.0.1] ESMTP amavisd-new service ready
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) idle_proc, 4: was busy, 21.3 ms, total idle 0.000 s, busy 0.021 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) idle_proc, 5: was idle, 1.9 ms, total idle 0.002 s, busy 0.021 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) SMTP< EHLO isis.eng.fsu.edu\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) prolong_timer SMTP EHLO received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250-[127.0.0.1]
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250-VRFY
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250-PIPELINING
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250-SIZE
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250-ENHANCEDSTATUSCODES
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250-8BITMIME
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]: Apr 11
10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]: Net::Server:
Child Preforked (16298)
(15534-01) ESMTP> 250-DSN
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP> 250 XFORWARD NAME ADDR PROTO HELO
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) idle_proc, 6: was busy, 10.6 ms, total idle 0.002 s, busy 0.032 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) idle_proc, 5: was idle, 1.2 ms, total idle 0.003 s, busy 0.032 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) ESMTP< MAIL FROM:<> SIZE=9337\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) prolong_timer SMTP MAIL received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) check_mail_begin_task: task_count=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15534]:
(15534-01) TempDir::prepare: creating directory
/var/amavis/tmp/amavis-20060411T102316-15534Apr 11 10:23:16
isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]: TIMING [total 15 ms] -
bdb-open: 15 (99%)99, rundown: 0 (1%)100
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Starting "1" children
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16301]:
Net::Server: Child Preforked (16301)
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16301]: TIMING
[total 16 ms] - bdb-open: 16 (99%)99, rundown: 0 (1%)100
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
Net::Server: 2006/04/11-10:23:16 CONNECT TCP Peer: "127.0.0.1:41881"
Local: "127.0.0.1:10024"
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]: loaded
base policy bank
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
lookup_ip_acl (inet_acl): key="127.0.0.1" matches "127.0.0.1", result=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
process_request: fileno sock=13, STDIN=0, STDOUT=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
prolong_timer new request - timer reset: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
process_request: suggested_protocol="" on TCP
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) SMTP> 220 [127.0.0.1] ESMTP amavisd-new service ready
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 4: was busy, 16.6 ms, total idle 0.000 s, busy 0.017 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 5: was idle, 0.6 ms, total idle 0.001 s, busy 0.017 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) SMTP< EHLO isis.eng.fsu.edu\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer SMTP EHLO received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-[127.0.0.1]
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-VRFY
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-PIPELINING
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-SIZE
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-ENHANCEDSTATUSCODES
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-8BITMIME
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250-DSN
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250 XFORWARD NAME ADDR PROTO HELO
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 6: was busy, 3.7 ms, total idle 0.001 s, busy 0.020 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 5: was idle, 0.3 ms, total idle 0.001 s, busy 0.020 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP< XFORWARD NAME=[UNAVAILABLE] ADDR=69.94.129.113\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer SMTP XFORWARD received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250 2.5.0 Ok XFORWARD
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 6: was busy, 1.7 ms, total idle 0.001 s, busy 0.022 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 5: was idle, 0.3 ms, total idle 0.001 s, busy 0.022 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP< XFORWARD PROTO=SMTP HELO=kanderson.propertylender.org\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer SMTP XFORWARD received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250 2.5.0 Ok XFORWARD
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 6: was busy, 1.6 ms, total idle 0.001 s, busy 0.024 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 5: was idle, 0.3 ms, total idle 0.002 s, busy 0.024 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP< MAIL FROM:<[EMAIL PROTECTED]> SIZE=1924\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer SMTP MAIL received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) check_mail_begin_task: task_count=1
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) TempDir::prepare: creating directory
/var/amavis/tmp/amavis-20060411T102316-16298Apr 11 10:23:16
isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]: (16298-01)
TempDir::prepare_file: creating file
/var/amavis/tmp/amavis-20060411T102316-16298/email.txt
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) lookup (debug_sender) => undef,
"[EMAIL PROTECTED]" does not match
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250 2.1.0 Sender [EMAIL PROTECTED] OK
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 6: was busy, 49.6 ms, total idle 0.002 s, busy 0.073 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 5: was idle, 0.4 ms, total idle 0.002 s, busy 0.073 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP< RCPT TO:<[EMAIL PROTECTED]>\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer SMTP RCPT received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 250 2.1.5 Recipient [EMAIL PROTECTED] OK
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 6: was busy, 2.1 ms, total idle 0.002 s, busy 0.075 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) idle_proc, 5: was idle, 0.3 ms, total idle 0.002 s, busy 0.075 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP< DATA\r\n
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer SMTP DATA received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP::10024 /var/amavis/tmp/amavis-20060411T102316-16298:
<[EMAIL PROTECTED]> -> <[EMAIL PROTECTED]> SIZE=1924
Received: from isis.eng.fsu.edu ([127.0.0.1]) by localhost
(isis.eng.fsu.edu [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for
<[EMAIL PROTECTED]>; Tue, 11 Apr 2006 10:23:16 -0400 (EDT)
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP> 354 End data with <CR><LF>.<CR><LF>
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer smtp response sent: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer receiving data: timer set to = 120 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) prolong_timer data-end received: timer set to = 300 s
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) ESMTP< .<CR><LF>
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) setting body type: 7BIT (h=0, b=0)
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) body hash: abb904db3c627fc386e47b099846eb32
Apr 11 10:23:16 isis.eng.fsu.edu /usr/local/sbin/amavisd[16298]:
(16298-01) Original mail size: 1924; quota set to: 962000 bytes
Apr 11 10:23:17 isis.eng.fsu.edu /usr/local/sbin/amavisd[15523]:
Net::Server: Starting "1" children
Apr 11 10:23:17 isis.eng.fsu.edu /usr/local/sbin/amavisd[16304]:
Net::Server: Child Preforked (16304)
Apr 11 10:23:17 isis.eng.fsu.edu /usr/local/sbin/amavisd[16304]: TIMING
[total 17 ms] - bdb-open: 16 (99%)99, rundown: 0 (1%)100
-------------------------------------------------------
This SF.Net email is sponsored by xPML, a groundbreaking scripting language
that extends applications into web and mobile media. Attend the live webcast
and join the prime developer group breaking into this new coding territory!
http://sel.as-us.falkag.net/sel?cmd=lnk&kid=110944&bid=241720&dat=121642
_______________________________________________
AMaViS-user mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/amavis-user
AMaViS-FAQ:http://www.amavis.org/amavis-faq.php3
AMaViS-HowTos:http://www.amavis.org/howto/