Amavisd-new fails start after downgrading to perl 5.24

後藤 潔 gotow at seitoku.ac.jp
Wed Apr 18 04:09:47 UTC 2018


Amavisd-new 2.10.1_5 used to be working with MacPorts base version 2.4.2 on MacOSX 10.8.5.  When I have tried to upgrade amavisd-new to 2.10.1_6 from 2.10.1_5, perl version was upgraded to 5.26.  However ‘sudo port upgrade amavisd-new’ command was unable to install new mysql57 5.7.17.  I filed a ticket to report a bug , and was assigned as #56270, which was closed owing to duplicate of #55238.

After downgrading perl to 5.24 from 5.26, amavisd-new 2.10.1_5 failed to start.

The current versions related to amavisd-new of my system are as follows.

MacOSX 10.8.5
MacPorts base version 2.4.3
  amavisd-new @2.10.1_5+perl5_24 (active)
  ossp-uuid @1.6.2_10+perl5_24 (active)
  p5.24-libwww-perl @6.330.0_0 (active)
  p5.24-perl-ostype @1.10.0_0 (active)
  perl5 @5.24.2_0+perl5_24 (active)
  perl5.24 @5.24.3_1 (active)
  mysql5 @5.1.72_2 (active)
  mysql56 @5.6.34_0 (active)
  mysql_select @0.1.2_3 (active)
  p5.24-dbd-mysql @4.46.0_0+mysql5 (active)
  p5.24-berkeleydb @0.550.0_0+db53 (active)
  db53 @5.3.28_0+sql (active)

The output on console with commands are as follows.
----------
$ sudo amavisd debug-sa
...
Apr 18 09:11:13.629 hoge.ac.jp /opt/local/sbin/amavisd[15968]: (!!)TROUBLE in pre_loop_hook: config: no rules were found!  Do you need to run 'sa-update'?
Suicide () TROUBLE in pre_loop_hook: config: no rules were found!  Do you need to run 'sa-update'?

$ sudo /opt/local/libexec/perl5.24/sa-update -D
...
 4 18 09:11:53.772 [15977] dbg: diag: updates complete, exiting with code 1
----------

$ sudo amavisd start

The amavis.log said as follows.

Any comments and advices are appreciated.

----------
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: logging initialized, log level 2, logfile: /opt/local/var/log/amavis/amavis.log
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: Valid PID file (younger than sys uptime 4 21:38:00)
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: starting. /opt/local/sbin/amavisd at hoge.ac.jp amavisd-new-2.10.1 (20141025), Unicode aware, LANG="ja_JP.UTF-8"
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: perl=5.024003, user=, EUID: 83 (83);  group=, EGID: 83 83 (83 83)
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: INFO: no optional modules: unicore::lib::Nt::De.pl Unix::Getrusage
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: SpamControl: scanner SpamAssassin, module Amavis::SpamControl::SpamAssassin
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: INFO: SA version: 3.4.1, 3.004001, no optional modules: Image::Info Image::Info::GIF Image::Info::JPEG Image::Info::PNG Image::Info::BMP Image::Info::TIFF
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: SpamControl: init_pre_chroot on SpamAssassin done
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: socket module IO::Socket::IP, protocol families available: INET, INET6
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: bind to /opt/local/var/amavis/amavisd.sock|unix, 127.0.0.1:10024/tcp, [::1]:10024/tcp, 127.0.0.1:10026/tcp, [::1]:10026/tcp
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18113]: _WARN: Pid_file "/opt/local/var/amavis/amavisd.pid" already exists.  Overwriting!
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Process Backgrounded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: 2018/04/18-11:31:11 Amavis (type Net::Server::PreForkSimple) starting! pid(18117)
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Binding to UNIX socket file "/opt/local/var/amavis/amavisd.sock"
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Binding to TCP port 10024 on host ::1 with IPv6
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Binding to TCP port 10026 on host 127.0.0.1 with IPv4
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Binding to TCP port 10026 on host ::1 with IPv6
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: Group Not Defined.  Defaulting to EGID '83 83'
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Net::Server: User Not Defined.  Defaulting to EUID '83'
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: config files read: /opt/local/etc/amavisd/amavisd.conf
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Amavis::Conf        2.404
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Archive::Zip        1.60
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module BerkeleyDB          0.55
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Compress::Raw::Zlib 2.076
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Compress::Zlib      2.074
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Crypt::OpenSSL::RSA 0.28
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module DB_File             1.835
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Digest::MD5         2.55
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Digest::SHA         6.01
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Digest::SHA1        2.13
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Encode              2.97
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module File::Temp          0.2304
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module IO::Socket::INET6   2.72
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module IO::Socket::IP      0.39
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module MIME::Entity        5.509
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module MIME::Parser        5.509
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module MIME::Tools         5.509
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Mail::DKIM::Signer  0.52
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Mail::DKIM::Verifier 0.52
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Mail::Header        2.20
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Mail::Internet      2.20
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Mail::SPF           v2.009
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Mail::SpamAssassin  3.004001
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Net::DNS            1.15
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Net::LibIDN         0.12
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Net::Patricia       1.22
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Net::Server         2.009
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module NetAddr::IP         4.079
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Razor2::Client::Version 2.84
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Scalar::Util        1.5
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Socket              2.027
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Socket6             0.28
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Time::HiRes         1.9754
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module URI                 1.73
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Module Unix::Syslog        1.1
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Amavis::ZMQ code     NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Amavis::DB code      loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: SQL base code        NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: SQL::Log code        NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: SQL::Quarantine      NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Lookup::SQL code     NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Lookup::LDAP code    NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: AM.PDP-in proto code loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: SMTP-in proto code   loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Courier proto code   NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: SMTP-out proto code  loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Pipe-out proto code  NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: BSMTP-out proto code NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Local-out proto code loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: OS_Fingerprint code  NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: ANTI-VIRUS code      loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: ANTI-SPAM code       loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: ANTI-SPAM-EXT code   NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: ANTI-SPAM-C code     NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: ANTI-SPAM-SA code    loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Unpackers code       loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: DKIM code            loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Tools code           NOT loaded
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No $file,              not using it
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No $altermime,         not using it
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Internal decoder for .mail
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .F, tried: unfreeze, freeze -d, melt, fcat
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found decoder for    .Z    at /opt/local/bin/uncompress
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found decoder for    .gz   at /opt/local/bin/gzip -d
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Internal decoder for .gz   (backup, not used)
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found decoder for    .bz2  at /opt/local/bin/bzip2 -d
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found decoder for    .xz   at /opt/local/bin/unxz -c
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found decoder for    .lzma at /opt/local/bin/lzmadec
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .lzo, tried: lzop -d
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .rpm, tried: rpm2cpio.pl, rpm2cpio
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .cpio, tried: pax, gcpio, cpio
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .tar, tried: pax, gcpio, cpio
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found decoder for    .deb  at /opt/local/bin/ar
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Internal decoder for .zip 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .7z, tried: 7zr, 7za, 7z
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .rar, tried: rar, unrar
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .arj, tried: arj, unarj
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .arc, tried: nomarch, arc
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .zoo, tried: zoo, unzoo
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .lha, tried: lha
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .cab, tried: cabextract
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .tnef, tried: tnef
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Internal decoder for .tnef
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No ext program for   .exe, tried: rar, unrar; lha; arj, unarj
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .7z  
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .F   
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .arc 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .arj 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .cab 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .cpio
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .exe 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .lha 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .lzo 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .rar 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .rpm 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .tar 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: No decoder for       .zoo 
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Using primary internal av scanner code for ClamAV-clamd
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Found secondary av scanner ClamAV-clamscan at /opt/local/bin/clamscan
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Deleting db files __db.001,__db.002,__db.003,nanny.db,snmp.db in /opt/local/var/amavis/db
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: Creating db in /opt/local/var/amavis/db/; BerkeleyDB 0.55, libdb 5.3
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: initializing Mail::SpamAssassin (0)
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: SpamAssassin debug facilities: info
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: (!!)TROUBLE in pre_loop_hook: config: no rules were found!  Do you need to run 'sa-update'?
Apr 18 11:31:11 hoge.ac.jp /opt/local/sbin/amavisd[18117]: (!)_DIE: Suicide () TROUBLE in pre_loop_hook: config: no rules were found!  Do you need to run 'sa-update'?
----------



More information about the macports-users mailing list