Am 13.02.2012 16:58, schrieb Paul J Stevens: > On 02/13/2012 04:56 PM, Reindl Harald wrote: > >> but i am running the identical postfix-2.9 packages on both machines >> these are from the internal repo and the whole machine is a clone >> >> how can sendmail from postfix act different and do any change to the >> message if the only different binary involved is dbmail? > > Too weird. Show me logs! And please: redact them to only include the > relevant lines if you can.
Logs attached, this problem seems to be much more weird as thought!
se at the bottom, additionally the HTML source of my testmail with
goes through "phpmailer" and is sent as multipart (PLAIN + HTML)
from my current point of view the DOT is added at receive-time from dbmail3
this is the definition of the alias
combination of local mailbox and external forwarder
+------------+-----------------------------------+----------------+-------------+
| alias_idnr | alias | deliver_to | client_idnr
|
+------------+-----------------------------------+----------------+-------------+
| 1059 | forwardt...@testserver.rhsoft.net | 17 | 524
|
| 1060 | forwardt...@testserver.rhsoft.net | rhs...@test.rh | 524
|
+------------+-----------------------------------+----------------+-------------+
body of the forwarded message (incoming on another dbmail3-instance on the
host):
...test1 {color:red;}
...test2 {color:blue;}
...test3 {color:green;}
____________________________
additional info info
this happens with exactly the same message delivered to dbmail3
so the additional DOT seems to be added here which would explain
why in the forwarder are THREE of them
* first dbmail-lmtp receives and adds a DOT
* mail is forwarded
* the other instances receives the mail per LMTP
* second dbmail-instance adds (my guess) another DOT
..test1 {color:red;}
..test2 {color:blue;}
..test3 {color:green;}
Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] log_query_time(+290): last query took [0.000] seconds Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_commit_transaction(+521): COMMIT Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_close(+274): [0x14254b0] connection to pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_get(+256): [0x14254b0] connection from pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_begin_transaction(+514): BEGIN Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_exec(+312): [0x14254b0] [UPDATE dbmail_users SET curmail_size = curmail_size + 3184 WHERE user_idnr = 17] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] log_query_time(+290): last query took [0.000] seconds Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_commit_transaction(+521): COMMIT Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_close(+274): [0x14254b0] connection to pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Notice:[message] sort_deliver_to_mailbox(+2038): message id=70939, size=3184 is inserted Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[message] sort_and_deliver(+1942): Keep was not cancelled. Message will be delivered by default. Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[message] insert_messages(+2538): successful sort_and_deliver for useridnr [17] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] execute_auto_ran(+2382): starting auto-reply procedure Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_get(+256): [0x14254b0] connection from pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_stmt_prepare(+400): [0x14254b0] [SELECT reply_body FROM dbmail_auto_replies WHERE user_idnr = ? AND NOW() BETWEEN start_date AND stop_date] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_stmt_set_u64(+420): [0x15395d0] 1:[17] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_close(+274): [0x14254b0] connection to pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] execute_auto_ran(+2385): no reply body found Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] insert_messages(+2598): deliver [1] messages to external addresses Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] insert_messages(+2603): delivering to external addresses Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[message] send_forward_list(+2421): delivering to [1] external addresses Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] parse_and_escape(+2056): parsing address [rhs...@test.rh] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] parse_and_escape(+2056): parsing address [postmas...@testserver.rhsoft.net] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[message] send_mail(+2132): opening pipe to [/usr/sbin/sendmail -i -f postmas...@testserver.rhsoft.net rhs...@test.rh] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] send_mail(+2140): pipe opened Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] send_mail(+2159): pipe closed Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[message] send_mail(+2164): sendmail exited normally Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_get(+256): [0x14254b0] connection from pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_begin_transaction(+514): BEGIN Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_exec(+312): [0x14254b0] [DELETE FROM dbmail_messages WHERE message_idnr = 70938] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] log_query_time(+290): last query took [0.000] seconds Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_commit_transaction(+521): COMMIT Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Database:[db] db_con_close(+274): [0x14254b0] connection to pool Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[message] insert_messages(+2625): temporary message deleted from database. Done. Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[clientbase] ci_write(+312): [0x7f801e377010] S > [54/54:215 Recipient <forwardt...@testserver.rhsoft.net> OK ] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[dsn] dsnuser_free(+218): dsnuser freed Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[clientbase] ci_readln(+423): [0x7f801e377010] C < [6:QUIT ] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[lmtp] lmtp_tokenizer(+264): [0x1530150] cmd [1], state [1] [QUIT] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Info:[clientbase] ci_write(+312): [0x7f801e377010] S > [31/31:221 testserver.rhsoft.net BYE ] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[lmtp] lmtp_handle_input(+121): [0x1530150] done Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[clientsession] socket_write_cb(+163): [0x1530150] state: [3] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[lmtp] lmtp_cb_write(+127): [0x1530150] state: [3] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[clientsession] client_session_bailout(+108): [0x1530150] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[clientbase] ci_close(+492): closing clientbase [0x7f801e377010] Feb 13 17:07:07 testserver.rhso dbmail-lmtpd[16717]: [0x13fa280] Debug:[clientbase] ci_cork(+205): [0x7f801e377010]
Feb 13 17:07:07 testserver postfix/smtpd[16854]: connect from local.rhsoft.net[84.113.45.179] Feb 13 17:07:07 testserver postfix/smtpd[16854]: 8296542876: client=local.rhsoft.net[84.113.45.179] Feb 13 17:07:07 testserver postfix/cleanup[16858]: 8296542876: message-id=<da0d85a0baa1ec253b3ac2893077bc619d8fd42c1329149...@srv-rhsoft.rhsoft.net> Feb 13 17:07:07 testserver postfix/qmgr[16824]: 8296542876: from=<postmas...@testserver.rhsoft.net>, size=3045, nrcpt=1 (queue active) Feb 13 17:07:07 testserver postfix/smtpd[16854]: disconnect from local.rhsoft.net[84.113.45.179] Feb 13 17:07:07 testserver postfix/pickup[16823]: ACC59428F8: uid=490 from=<postmas...@testserver.rhsoft.net> Feb 13 17:07:07 testserver postfix/lmtp[16859]: 8296542876: to=<forwardt...@testserver.rhsoft.net>, relay=127.0.0.1[127.0.0.1]:24, delay=0.19, delays=0.06/0.01/0/0.12, dsn=2.0.0, status=sent (215 Recipient <forwardt...@testserver.rhsoft.net> OK) Feb 13 17:07:07 testserver postfix/qmgr[16824]: 8296542876: removed Feb 13 17:07:07 testserver postfix/cleanup[16858]: ACC59428F8: message-id=<da0d85a0baa1ec253b3ac2893077bc619d8fd42c1329149...@srv-rhsoft.rhsoft.net> Feb 13 17:07:07 testserver postfix/qmgr[16824]: ACC59428F8: from=<postmas...@testserver.rhsoft.net>, size=3280, nrcpt=1 (queue active) Feb 13 17:07:07 testserver postfix/smtp[16862]: Untrusted TLS connection established to 192.168.196.1[192.168.196.1]:25: TLSv1 with cipher DHE-RSA-AES256-SHA (256/256 bits) Feb 13 17:07:07 testserver postfix/smtp[16862]: ACC59428F8: to=<rhs...@test.rh>, relay=192.168.196.1[192.168.196.1]:25, delay=0.19, delays=0.02/0.02/0.06/0.08, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as C971F16341A)Title: Neues HTML Dokument (Transitional)
HTML 4.01 Template (Transitional)
TEST 1
TEST 2
TEST 3
signature.asc
Description: OpenPGP digital signature
_______________________________________________ DBmail mailing list DBmail@dbmail.org http://mailman.fastxs.nl/cgi-bin/mailman/listinfo/dbmail
