[Postfix-es] unexpected command-line argument

Simon J Mudd sjmudd en pobox.com
Lun Oct 17 20:07:56 CEST 2005


rmcama at wanadoo.es (Kien) writes:

> Ricardo Muñoz escribió:
> 
> >Podrias establecer una sesion de telnet al puerto 10025? asi podrias
> >comprobar que la segunda instancia de postfix esta funcionando. De echo
> >enviando mensajes al 10025 deberian entregarse correctamente.
> > Despues puedes hacer lo mismo al 10024 y mirar logs de amavis para
> > ver que se comporte correctamente. un saludo,
> >
> >--
> >Ricardo Muñoz(rmunoz at warp.es)
> >http://people.warp.es/~ricardo
> >
> Hola Ricardo :-)
> 
>     Estos son mis resultados:
> 
>     # telnet localhost 10025
>     Trying 127.0.0.1...
>     Connected to localhost.
>     Escape character is '^]'.
>     220 rugonet.com ESMTP Postfix (Debian/GNU)
>     EHLO localhost
>     250-rugonet.com
>     250-PIPELINING
>     250-SIZE 10240000
>     250-VRFY
>     250-ETRN
>     250-STARTTLS
>     250 8BITMIME
>     QUIT
>     221 Bye
>     Connection closed by foreign host.
>     #
> 
>     # telnet localhost 10024
>     Trying 127.0.0.1...
>     Connected to localhost.
>     Escape character is '^]'.
>     220 [127.0.0.1] ESMTP amavisd-new service ready
>     EHLO localhost
>     250-[127.0.0.1]
>     250-PIPELINING
>     250-SIZE
>     250-8BITMIME
>     250 ENHANCEDSTATUSCODES
>     QUIT
>     221 2.0.0 [127.0.0.1] (amavisd) closing transmission channel
>     Connection closed by foreign host.
>     #
> 
> Configuro en 'amavisd.conf' lo siguiente:
> 
> # true (e.g. 1) => syslog;  false (e.g. 0) => logging to file
> $DO_SYSLOG = 0;                 # (defaults to false)
> #$SYSLOG_LEVEL = 'user.info';     # (facility.priority, default 'mail.info')
> 
> # Log file (if not using syslog)
> $LOGFILE = "/var/log/amavis.log";  # (defaults to empty, no log)
> 
> Y  esto es lo que tengo en '/var/log/amavis.log':
> 
> Oct 14 11:55:21 rugonet.com amavisd-new[12090]: starting.  amavisd-new
> at rugonet.com amavisd-new-20030616-p10, Unicode aware
> , LANG=es_ES at euro
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Perl version
> 5.008007
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Amavis::Conf
> 1.15
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Archive::Tar
> 1.26
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Archive::Zip
> 1.14
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Compress::Zlib
> 1.34
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Convert::TNEF
> 0.17
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Convert::UUlib
> 1.051
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module DB_File
> 1.811
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module MIME::Entity
> 5.417
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module MIME::Parser
> 5.417
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module MIME::Tools
> 5.417
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Mail::Header
> 1.62
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Mail::Internet
> 1.62
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module
> Mail::SpamAssassin  3.000004
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Net::Cmd
> 2.26
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Net::SMTP
> 2.29
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Net::Server
> 0.87
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Time::HiRes
> 1.66
> Oct 14 11:55:22 rugonet.com amavisd-new[12090]: Module Unix::Syslog
> 0.100
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $file       at
> /usr/bin/file
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: No $arc,          not
> using it
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $gzip       at
> /bin/gzip
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $bzip2      at
> /usr/bin/bzip2
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $lzop       at
> /usr/bin/lzop
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $lha        at
> /usr/bin/lha
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $unarj      at
> /usr/bin/arj
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $uncompress at
> /bin/uncompress
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: No $unfreeze,     not
> using it
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $unrar      at
> /usr/bin/unrar
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: No $zoo,          not
> using it
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found $cpio       at
> /bin/cpio
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Using internal av
> scanner code for (primary) Clam Antivirus-clamd
> Oct 14 11:55:22 rugonet.com amavisd-new[12091]: Found secondary av
> scanner Clam Antivirus - clamscan at /usr/bin/clamscan
> 
> Pues nada, aqui sigo con mis pruebas. Espero puedas echarme una mano
> (y no al cuello, eh ?? ;-) )

Tienes que seguir *un* mensaje a traves de tu sistema.

Usando mail, mutt o tu MDA envia un mensaje y seguir el rastro.

Debes ver lo siguiente:

1. postfix recibe el mensaje (de /usr/sbin/sendmail o smtpd segun tu configuracion)
   - mira los logs de postfix

2. lo entrega a amavis a localhost:10024
   - mira los logs de amavis para ver lo que hace y A DONDE lo envia

3. amavis DEBE entregarlo a localhost:10025 (Postfix donde el
   content_filter esta deshabilitado)
   - mira los logs de amavis y postfix

4. Postfix DEBE enviarlo a su destino final (o local)
   - si en los logs ves que Postfix lo envia otra vez a amavis
     entonces el problema sera que tu configuracion de postfix en el
     puerto 10025 no tiene correctamente desactivado el
     content_filter.

Puedes habilitar el -v en smtp y smtpd (master.cf) para ver lo que
hace los demonios de Postfix y aumentar el nivel de informacion de
amavis, pero lo importante es determinar donde el "flujo de mensajes"
es incorrecto y despues determinar el por que.

Simon


Más información sobre la lista de distribución Postfix-es