On 2013–09–23 Kevin A. McGrail wrote:
> 1 - run sa-update -D -v to get more verbosity and send that log to
> the mailing list
log is attached, here the last lines:
Sep 23 19:52:46.968 [5668] dbg: channel: reading MIRRORED.BY file
error: no mirrors available for channel updates.spamassassin.org
channel: no mirrors available, channel failed
Sep 23 19:52:46.968 [5668] dbg: generic: cleaning up temporary directory/files
Sep 23 19:52:46.969 [5668] dbg: diag: updates complete, exiting with code 4
Update available for channel updates.spamassassin.org
Update failed, exiting with code 4
> 2 - Look at
> /var/lib/spamassassin/3.003002/updates_spamassassin_org/MIRRORED.BY
> (I believe that's the correct path).
This file is empty here. I assume that's wrong.
> That file can end up blank on some machines but that's been fixed.
I'm on Debian Sid. I'll file a bug report tomorrow. What's supposed
to be in that file (then I can add it manually as a workaround)?
Marco
Sep 23 19:52:36.528 [5668] dbg: logger: adding facilities: all
Sep 23 19:52:36.529 [5668] dbg: logger: logging level is DBG
Sep 23 19:52:36.529 [5668] dbg: generic: SpamAssassin version 3.3.2
Sep 23 19:52:36.529 [5668] dbg: generic: Perl 5.018001, PREFIX=/usr,
DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/spamassassin,
LOCAL_STATE_DIR=/var/lib/spamassassin
Sep 23 19:52:36.529 [5668] dbg: config: timing enabled
Sep 23 19:52:36.530 [5668] dbg: config: score set 0 chosen.
Sep 23 19:52:36.541 [5668] dbg: dns: is Net::DNS::Resolver available? yes
Sep 23 19:52:36.541 [5668] dbg: dns: Net::DNS version: 0.68
Sep 23 19:52:36.542 [5668] dbg: generic: sa-update version svn917659
Sep 23 19:52:36.542 [5668] dbg: generic: using update directory:
/var/lib/spamassassin/3.003002
Sep 23 19:52:36.758 [5668] dbg: diag: perl platform: 5.018001 linux
Sep 23 19:52:36.758 [5668] dbg: diag: [...] module installed: Digest::SHA,
version 5.84_01
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: HTML::Parser,
version 3.71
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: Net::DNS, version
0.68
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: NetAddr::IP,
version 4.062
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: Time::HiRes,
version 1.9725
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: Archive::Tar,
version 1.90
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: IO::Zlib, version
1.10
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module not installed: Digest::SHA1
('require' failed)
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: MIME::Base64,
version 3.13
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: DB_File, version
1.827
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: Net::SMTP,
version 2.31
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module installed: Mail::SPF,
version v2.009
Sep 23 19:52:36.759 [5668] dbg: diag: [...] module not installed:
IP::Country::Fast ('require' failed)
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed:
Razor2::Client::Agent, version 2.84
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module not installed: Net::Ident
('require' failed)
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed:
IO::Socket::INET6, version 2.69
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed: IO::Socket::SSL,
version 1.954
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed: Compress::Zlib,
version 2.06
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module not installed: Mail::DKIM
('require' failed)
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed: DBI, version 1.628
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed: Getopt::Long,
version 2.39
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed: LWP::UserAgent,
version 6.05
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module installed: HTTP::Date,
version 6.02
Sep 23 19:52:36.760 [5668] dbg: diag: [...] module not installed:
Encode::Detect ('require' failed)
Sep 23 19:52:36.761 [5668] dbg: gpg: Searching for 'gpg'
Sep 23 19:52:36.762 [5668] dbg: util: current PATH is:
/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
Sep 23 19:52:36.762 [5668] dbg: util: executable for gpg was found at
/usr/bin/gpg
Sep 23 19:52:36.762 [5668] dbg: gpg: found /usr/bin/gpg
Sep 23 19:52:36.762 [5668] dbg: gpg: release trusted key id list:
0C2B1D7175B852C64B3CDC716C55397824F434CE
5E541DC959CB8BAC7C78DFDC4056A61A5244EC45
26C900A46DD40CD5AD24F6D7DEE01987265FA05B
Sep 23 19:52:36.771 [5668] dbg: channel: attempting channel
updates.spamassassin.org
Sep 23 19:52:36.771 [5668] dbg: channel: update directory
/var/lib/spamassassin/3.003002/updates_spamassassin_org
Sep 23 19:52:36.771 [5668] dbg: channel: channel cf file
/var/lib/spamassassin/3.003002/updates_spamassassin_org.cf
Sep 23 19:52:36.771 [5668] dbg: channel: channel pre file
/var/lib/spamassassin/3.003002/updates_spamassassin_org.pre
Sep 23 19:52:46.790 [5668] dbg: dns: 2.3.3.updates.spamassassin.org => 1525332,
parsed as 1525332
Sep 23 19:52:46.790 [5668] dbg: channel: preparing temp directory for new
channel
Sep 23 19:52:46.791 [5668] dbg: generic: update tmp directory
/tmp/.spamassassin5668KGejSFtmp
Sep 23 19:52:46.791 [5668] dbg: generic: lint checking site pre files once
before attempting channel updates
Sep 23 19:52:46.791 [5668] dbg: generic: SpamAssassin version 3.3.2
Sep 23 19:52:46.792 [5668] dbg: generic: Perl 5.018001, PREFIX=/usr,
DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/spamassassin,
LOCAL_STATE_DIR=/var/lib/spamassassin
Sep 23 19:52:46.792 [5668] dbg: config: timing enabled
Sep 23 19:52:46.793 [5668] dbg: config: score set 0 chosen.
Sep 23 19:52:46.797 [5668] dbg: dns: is Net::DNS::Resolver available? yes
Sep 23 19:52:46.797 [5668] dbg: dns: Net::DNS version: 0.68
Sep 23 19:52:46.797 [5668] dbg: ignore: using a test message to lint rules
Sep 23 19:52:46.797 [5668] dbg: config: using "/etc/spamassassin" for site
rules pre files
Sep 23 19:52:46.798 [5668] dbg: config: read file /etc/spamassassin/init.pre
Sep 23 19:52:46.798 [5668] dbg: config: read file /etc/spamassassin/v310.pre
Sep 23 19:52:46.798 [5668] dbg: config: read file /etc/spamassassin/v312.pre
Sep 23 19:52:46.799 [5668] dbg: config: read file /etc/spamassassin/v320.pre
Sep 23 19:52:46.799 [5668] dbg: config: read file /etc/spamassassin/v330.pre
Sep 23 19:52:46.799 [5668] dbg: config: using
"/tmp/.spamassassin5668KGejSFtmp/doesnotexist" for sys rules pre files
Sep 23 19:52:46.799 [5668] dbg: config: using
"/tmp/.spamassassin5668KGejSFtmp/doesnotexist" for default rules dir
Sep 23 19:52:46.799 [5668] dbg: config: using
"/tmp/.spamassassin5668KGejSFtmp/doesnotexist/doesnotexist" for user prefs file
Sep 23 19:52:46.800 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::URIDNSBL from @INC
Sep 23 19:52:46.805 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::Hashcash from @INC
Sep 23 19:52:46.807 [5668] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF
from @INC
Sep 23 19:52:46.809 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::Pyzor from @INC
Sep 23 19:52:46.812 [5668] dbg: pyzor: local tests only, disabling Pyzor
Sep 23 19:52:46.813 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::Razor2 from @INC
Sep 23 19:52:46.817 [5668] dbg: razor2: local tests only, skipping Razor
Sep 23 19:52:46.817 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::SpamCop from @INC
Sep 23 19:52:46.819 [5668] dbg: reporter: local tests only, disabling SpamCop
Sep 23 19:52:46.819 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC
Sep 23 19:52:46.820 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::WhiteListSubject from @INC
Sep 23 19:52:46.820 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::MIMEHeader from @INC
Sep 23 19:52:46.823 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::ReplaceTags from @INC
Sep 23 19:52:46.828 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::DKIM from @INC
Sep 23 19:52:46.839 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::Check from @INC
Sep 23 19:52:46.857 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC
Sep 23 19:52:46.859 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::URIDetail from @INC
Sep 23 19:52:46.862 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::Bayes from @INC
Sep 23 19:52:46.884 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::BodyEval from @INC
Sep 23 19:52:46.888 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::DNSEval from @INC
Sep 23 19:52:46.893 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::HTMLEval from @INC
Sep 23 19:52:46.899 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::HeaderEval from @INC
Sep 23 19:52:46.916 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::MIMEEval from @INC
Sep 23 19:52:46.924 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::RelayEval from @INC
Sep 23 19:52:46.930 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::URIEval from @INC
Sep 23 19:52:46.932 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::WLBLEval from @INC
Sep 23 19:52:46.935 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::VBounce from @INC
Sep 23 19:52:46.938 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::ImageInfo from @INC
Sep 23 19:52:46.943 [5668] dbg: plugin: loading
Mail::SpamAssassin::Plugin::FreeMail from @INC
Sep 23 19:52:46.952 [5668] dbg: config: finish parsing
Sep 23 19:52:46.952 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x4136ef8) implements
'finish_parsing_end', priority 0
Sep 23 19:52:46.953 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::FreeMail=HASH(0x46bccb8) implements
'finish_parsing_end', priority 0
Sep 23 19:52:46.953 [5668] dbg: replacetags: replacing tags
Sep 23 19:52:46.953 [5668] dbg: replacetags: done replacing tags
Sep 23 19:52:46.953 [5668] dbg: FreeMail: no freemail_domains entries defined,
disabling plugin
Sep 23 19:52:46.953 [5668] dbg: config: score set 0 chosen.
Sep 23 19:52:46.954 [5668] dbg: config: time limit 300.0 s
Sep 23 19:52:46.954 [5668] dbg: message: main message type: text/plain
Sep 23 19:52:46.955 [5668] dbg: message: ---- MIME PARSER START ----
Sep 23 19:52:46.955 [5668] dbg: message: parsing normal part
Sep 23 19:52:46.955 [5668] dbg: message: ---- MIME PARSER END ----
Sep 23 19:52:46.955 [5668] dbg: check: pms new, time limit in 299.998 s
Sep 23 19:52:46.956 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::DNSEval=HASH(0x448ff10) implements 'check_start',
priority 0
Sep 23 19:52:46.958 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::Check=HASH(0x400f190) implements 'check_main',
priority 0
Sep 23 19:52:46.959 [5668] dbg: config: trusted_networks are not configured; it
is recommended that you configure trusted_networks manually
Sep 23 19:52:46.959 [5668] dbg: metadata: X-Spam-Relays-Trusted:
Sep 23 19:52:46.959 [5668] dbg: metadata: X-Spam-Relays-Untrusted:
Sep 23 19:52:46.959 [5668] dbg: metadata: X-Spam-Relays-Internal:
Sep 23 19:52:46.959 [5668] dbg: metadata: X-Spam-Relays-External:
Sep 23 19:52:46.960 [5668] dbg: message: no encoding detected
Sep 23 19:52:46.960 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x3ffca70) implements
'parsed_metadata', priority 0
Sep 23 19:52:46.961 [5668] dbg: dns: is_dns_available() last checked
1379958767.0 seconds ago; re-checking
Sep 23 19:52:46.961 [5668] dbg: dns: is DNS available? 0
Sep 23 19:52:46.961 [5668] dbg: rules: local tests only, ignoring RBL eval
Sep 23 19:52:46.962 [5668] dbg: check: check_main, time limit in 299.992 s
Sep 23 19:52:46.964 [5668] dbg: dns: harvest_dnsbl_queries
Sep 23 19:52:46.965 [5668] dbg: check: is spam? score=0 required=5
Sep 23 19:52:46.965 [5668] dbg: check: tests=
Sep 23 19:52:46.965 [5668] dbg: check: subtests=
Sep 23 19:52:46.966 [5668] dbg: timing: total 167 ms - init: 156 (93.8%),
parse: 1.69 (1.0%), extract_message_metadata: 3 (1.6%), get_uri_detail_list: 2
(1.3%)
Sep 23 19:52:46.966 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::MIMEHeader=HASH(0x400ec08) implements
'finish_tests', priority 0
Sep 23 19:52:46.967 [5668] dbg: plugin:
Mail::SpamAssassin::Plugin::Check=HASH(0x400f190) implements 'finish_tests',
priority 0
Sep 23 19:52:46.968 [5668] dbg: generic: lint check of site pre files
succeeded, continuing with channel updates
Sep 23 19:52:46.968 [5668] dbg: channel: reading MIRRORED.BY file
error: no mirrors available for channel updates.spamassassin.org
channel: no mirrors available, channel failed
Sep 23 19:52:46.968 [5668] dbg: generic: cleaning up temporary directory/files
Sep 23 19:52:46.969 [5668] dbg: diag: updates complete, exiting with code 4
Update available for channel updates.spamassassin.org
Update failed, exiting with code 4
