[Postfix-es] problemas con el BCC

[Satoru Lucas Shindoi]

El Mon, 4 Jun 2007 15:27:40 -0300
Satoru Lucas Shindoi <lucas en dpec.com.ar> escribió:

[..... snip .....]

> Gente:
> 
> Por si a alguien le interesa la solución a este problema, les cuento:
> - la opción "always_bcc" en el main.cf en esta versión de postfix que estoy usando (la de etch) al parecer afecta a todos los procesos, cuando anteriormente no lo hacia. Así que tuve que modificar el master.cf agregando una linea "always_bcc= " en la linea donde reinyectas el correo que te da el content_filter (amavis por ej.)
> Cosa rara, no encontre nada en el changelog (o no mire bien)

Gente:

Lamentablemente descubri que mi "solución" no arreglaba nada.
Que detecte en mi investigacion:

Jun 28 12:28:17 proxy-i postfix/smtpd[9888]: connect from unknown[192.168.0.30]
Jun 28 12:28:17 proxy-i postfix/smtpd[9888]: setting up TLS connection from unknown[192.168.0.30]
Jun 28 12:28:17 proxy-i postfix/smtpd[9888]: TLS connection established from unknown[192.168.0.30]: TLSv1 with cipher DHE-RSA-AES256-SHA (256/256 bits)
Jun 28 12:28:17 proxy-i postfix/smtpd[9888]: 541BE3DE12F: client=unknown[192.168.0.30], sasl_method=LOGIN, sasl_username=lucas en proxy-i
Jun 28 12:28:17 proxy-i postfix/cleanup[9892]: 541BE3DE12F: message-id=<20070628122706.470c0cc3 en develop.ejemplo.com.ar>
Jun 28 12:28:17 proxy-i postfix/qmgr[9882]: 541BE3DE12F: from=<lucas en ejemplo.com.ar>, size=1404, nrcpt=2 (queue active)
Jun 28 12:28:17 proxy-i postfix/smtpd[9888]: disconnect from unknown[192.168.0.30]

Jun 28 12:28:17 proxy-i postfix/smtpd[9896]: connect from localhost[127.0.0.1]
Jun 28 12:28:17 proxy-i postfix/smtpd[9896]: 8755C3DE149: client=localhost[127.0.0.1]
Jun 28 12:28:17 proxy-i postfix/cleanup[9892]: 8755C3DE149: message-id=<20070628122706.470c0cc3 en develop.ejemplo.com.ar>
Jun 28 12:28:17 proxy-i postfix/qmgr[9882]: 8755C3DE149: from=<lucas en ejemplo.com.ar>, size=1819, nrcpt=3 (queue active)
Jun 28 12:28:17 proxy-i postfix/smtpd[9896]: disconnect from localhost[127.0.0.1]
Jun 28 12:28:17 proxy-i amavis[9644]: (09644-10) Passed CLEAN, [192.168.0.30] [192.168.0.30] <lucas en ejemplo.com.ar> -> <backupcorreo en ejemplo.com.ar>,<servtecnico en ejemplo.com.ar>, Message-ID: <20070628122706.470c0cc3 en develop.ejemplo.com.ar>, mail_id: KQDnqR9AZaEh, Hits: -0.957, queued_as: 8755C3DE149, 229 ms

Jun 28 12:28:17 proxy-i postfix/lmtp[9893]: 541BE3DE12F: to=<backupcorreo en ejemplo.com.ar>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.33, delays=0.08/0.01/0.01/0.23, dsn=2.6.0, status=sent (250 2.6.0 Ok, id=09644-10, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 8755C3DE149)
Jun 28 12:28:17 proxy-i postfix/lmtp[9893]: 541BE3DE12F: to=<servtecnico en ejemplo.com.ar>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.33, delays=0.08/0.01/0.01/0.23, dsn=2.6.0, status=sent (250 2.6.0 Ok, id=09644-10, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 8755C3DE149)
Jun 28 12:28:17 proxy-i postfix/qmgr[9882]: 541BE3DE12F: removed

Hasta ACA veniamos bien....


Ahora desde aca en adelante:

Jun 28 12:28:17 proxy-i cyrus/lmtpd[9800]: accepted connection
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9800]: lmtp connection preauth'd as postman
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9800]: duplicate_check: <20070628122706.470c0cc3 en develop.ejemplo.com.ar> user.backupcorreo    0
Jun 28 12:28:17 proxy-i cyrus/master[9904]: about to exec /usr/lib/cyrus/bin/lmtpd
Jun 28 12:28:17 proxy-i cyrus/lmtpunix[9904]: executed
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9799]: accepted connection
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9799]: lmtp connection preauth'd as postman
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9799]: duplicate_check: <20070628122706.470c0cc3 en develop.ejemplo.com.ar> user.backupcorreo    0
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9904]: accepted connection
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9904]: lmtp connection preauth'd as postman
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9904]: duplicate_check: <20070628122706.470c0cc3 en develop.ejemplo.com.ar> user.servtecnico     0

Se puede observar que a backupcorreo el deliver le entrega dos copias!

Mi idea (desesperada) es que postfix (via LMTP) le entrega al deliver (cyrus) el original y la copia mas otra copia de nuevo. 

Mi pregunta es porque?

Ya probe con agregar en la linea correspondiente del master.cf sobre el lmtp la cadena "-o always_bcc=" (sin las comillas) pero sin solucion.


Aca el resto del log....

Jun 28 12:28:17 proxy-i cyrus/lmtpd[9904]: mystore: starting txn 2147483812
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9904]: mystore: committing txn 2147483812
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9904]: duplicate_mark: <20070628122706.470c0cc3 en develop.ejemplo.com.ar> user.servtecnico     1183044497
Jun 28 12:28:17 proxy-i postfix/lmtp[9902]: 8755C3DE149: to=<servtecnico en ejemplo.com.ar>, relay=proxy-i.ejemplo.com.ar[/var/run/cyrus/socket/lmtp], delay=0.29, delays=0.05/0.09/0.14/0.01, dsn=2.1.5, status=sent (250 2.1.5 Ok)
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9800]: mystore: starting txn 2147483813
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9800]: mystore: committing txn 2147483813
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9800]: duplicate_mark: <20070628122706.470c0cc3 en develop.ejemplo.com.ar> user.backupcorreo    1183044497
Jun 28 12:28:17 proxy-i postfix/lmtp[9900]: 8755C3DE149: to=<backupcorreo en ejemplo.com.ar>, relay=proxy-i.ejemplo.com.ar[/var/run/cyrus/socket/lmtp], delay=0.29, delays=0.05/0.06/0.11/0.07, dsn=2.1.5, status=sent (250 2.1.5 Ok)
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9799]: mystore: starting txn 2147483814
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9799]: mystore: committing txn 2147483814
Jun 28 12:28:17 proxy-i cyrus/lmtpd[9799]: duplicate_mark: <20070628122706.470c0cc3 en develop.ejemplo.com.ar> user.backupcorreo    1183044497
Jun 28 12:28:17 proxy-i postfix/lmtp[9901]: 8755C3DE149: to=<backupcorreo en ejemplo.com.ar>, relay=proxy-i.ejemplo.com.ar[/var/run/cyrus/socket/lmtp], delay=0.32, delays=0.05/0.07/0.12/0.07, dsn=2.1.5, status=sent (250 2.1.5 Ok)
Jun 28 12:28:17 proxy-i postfix/qmgr[9882]: 8755C3DE149: removed

En mi muy pobre opinion, no creo que sea un tema de cyrus (a pesar de ello hurgue en su conf.)
Asi que le sigo desconfiando a postfix.....

Si alguien me tira una linea.....

Un abrazo

-- 
Satoru Lucas Shindoi - lucas en dpec.com.ar 
SysAdmin GNU/Linux, *NIX
Oficina (06 a 15 hs) 03783 463449 / 425612
ICQ: 95357247 - Gmail: shindoi en gmail.com - lucas en shindoi.com.ar
Messenger: slshindoi en hotmail.com - Yahoo: slshindoi en yahoo.com.ar
--------------------------------------------------------------------------
Sistemas de Informacion - DPEC - https://www.dpec.com.ar/sistemas
Proyectos NEA - www.nea.org.ar