Hi folks i'm trying to figure out a problem with some domains when they send mails to my server. apparently the problem comes from an invalid header but i don't know what kind of parameter must change, cause this isn't happens with all the domains just with some ones.
maybe one of you help me about it, i show the message log and the postconf -n please tell me know if i should make any change in particular in tha log, notice that message seems to be sent but seconds later a bounced message is showed here's an attach log info
Jul 28 09:45:08 boom3 postfix/qmgr[3548]: 3337125C001: from=<sen...@.com>, size=1836, nrcpt=1 (queue active) Jul 28 09:45:08 boom3 postfix/smtpd[6976]: disconnect from unknown[192.27.1.15] Jul 28 09:45:08 boom3 amavis[5637]: (05637-16) ESMTP::10024 /var/spool/amavis/tmp/amavis-20090728T092128-05637: <sen...@.com> -> <recipi...@myserver> SIZE=1836 Received: from myserver ([127.0.0.1]) by localhost (myserver [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <recipi...@myserver>; Tue, 28 Jul 2009 09:45:08 -0600 (CST) Jul 28 09:45:08 boom3 amavis[6937]: (06937-01) ESMTP::10024 /var/spool/amavis/tmp/amavis-20090728T094508-06937: <sen...@.com> -> <recipi...@myserver> SIZE=1838 Received: from myserver ([127.0.0.1]) by localhost (myserver [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <recipi...@myserver>; Tue, 28 Jul 2009 09:45:08 -0600 (CST) Jul 28 09:45:08 boom3 amavis[5637]: (05637-16) Checking: XPr4Jvf1nybP <sen...@.com> -> <recipi...@myserver> Jul 28 09:45:08 boom3 amavis[5637]: (05637-16) p001 1 Content-Type: text/plain, size: 868 B, name: Jul 28 09:45:08 boom3 amavis[6937]: (06937-01) Checking: Wb-KS8AghfQh <sen...@.com> -> <recipi...@myserver> Jul 28 09:45:08 boom3 amavis[6937]: (06937-01) p001 1 Content-Type: text/plain, size: 868 B, name: Jul 28 09:45:09 boom3 postfix/smtpd[6914]: connect from unknown[192.27.1.15] Jul 28 09:45:09 boom3 postfix/smtpd[6914]: 567CD25C003: client=unknown[192.27.1.15] Jul 28 09:45:09 boom3 postfix/cleanup[6921]: 567CD25C003: message-id= Jul 28 09:45:09 boom3 postfix/qmgr[3548]: 567CD25C003: from=<sen...@.com>, size=1833, nrcpt=1 (queue active) Jul 28 09:45:09 boom3 postfix/smtpd[6914]: disconnect from unknown[192.27.1.15] Jul 28 09:45:10 boom3 postfix/smtpd[6932]: connect from localhost[127.0.0.1] Jul 28 09:45:10 boom3 postfix/smtpd[6932]: 934E325C004: client=localhost[127.0.0.1] Jul 28 09:45:10 boom3 postfix/cleanup[6984]: 934E325C004: message-id= Jul 28 09:45:10 boom3 postfix/qmgr[3548]: 934E325C004: from=<sen...@.com>, size=2274, nrcpt=1 (queue active) Jul 28 09:45:10 boom3 postfix/smtpd[6932]: disconnect from localhost[127.0.0.1] Jul 28 09:45:10 boom3 amavis[5637]: (05637-16) FWD via SMTP: <sen...@.com> -> <recipi...@myserver>,BODY=7BIT 250 2.6.0 Ok, id=05637-16, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 934E325C004 Jul 28 09:45:10 booo3 amavis[5637]: (05637-16) Passed CLEAN, [10.10.10.10] <sen...@.com> -> <recipi...@myserver>, mail_id: XPr4Jvf1nybP, Hits: -0.699, size: 1836, queued_as: 934E325C004, 2375 ms Jul 28 09:45:10 boom3 postfix/smtp[6922]: 3337125C001: to=<recipi...@myserver>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.5, delays=0.09/0/0/2.4, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 934E325C004) Jul 28 09:45:10 boom3 postfix/qmgr[3548]: 3337125C001: removed Jul 28 09:45:10 boom3 amavis[5637]: (05637-16) TIMING [total 2380 ms] - SMTP greeting: 2 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 0 (0%)0, SMTP pre-DATA-flush: 3 (0%)0, SMTP DATA: 34 (1%)2, check_init: 1 (0%)2, digest_hdr: 1 (0%)2, digest_body: 0 (0%)2, gen_mail_id: 1 (0%)2, mime_decode: 8 (0%)2, get-file-type1: 15 (1%)3, parts_decode: 0 (0%)3, check_header: 2 (0%)3, AV-scan-1: 4 (0%)3, AV-scan-2: 1467 (62%)65, spam-wb-list: 2 (0%)65, SA msg read: 1 (0%)65, SA parse: 2 (0%)65, SA check: 739 (31%)96, update_cache: 6 (0%)96, decide_mail_destiny: 1 (0%)96, fwd-connect: 6 (0%)96, fwd-mail-pip: 13 (1%)97, fwd-rcpt-pip: 0 (0%)97, fwd-data-chkpnt: 0 (0%)97, write-header: 1 (0%)97, fwd-data-contents: 0 (0%)97, fwd-end-chkpnt: 59 (2%)99, prepare-dsn: 1 (0%)99, main_log_entry: 9 (0%)100, update_snmp: 2 (0%)100, SMTP pre-response: 0 (0%)100, SMTP response: 0 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100 Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) ESMTP::10024 /var/spool/amavis/tmp/amavis-20090728T092128-05637: <sen...@.com> -> <recipi...@myserver> SIZE=1833 Received: from myserver. ([127.0.0.1]) by localhost (myserver. [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <recipi...@myserver>; Tue, 28 Jul 2009 09:45:10 -0600 (CST) Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) Checking: wKNkVzaar0-x <sen...@.com> -> <recipi...@myserver> Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) cached acae0dadbbcd66e7cf51eda9ae4bc2f8 from <sen...@.com> (1,1) Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) p001 1 Content-Type: text/plain, size: 868 B, name: Jul 28 09:45:10 boom3 postfix/smtpd[6932]: connect from localhost[127.0.0.1] Jul 28 09:45:10 boom3 postfix/smtpd[6932]: B9A7225C001: client=localhost[127.0.0.1] Jul 28 09:45:10 boom3 postfix/cleanup[6921]: B9A7225C001: message-id= Jul 28 09:45:10 boom3 postfix/pipe[6971]: 934E325C004: to=<recipi...@myserver>, orig_to=<recipi...@myserver>, relay=cyrus, delay=0.23, delays=0.06/0/0/0.16, dsn=5.6.0, status=bounced (data format error. Command output: recipient: Message contains invalid header ) Jul 28 09:45:10 boom3 postfix/cleanup[6984]: CADF625C005: message-id=<20090728154510.cadf625c...@myserver> Jul 28 09:45:10 boom3 postfix/smtpd[6932]: disconnect from localhost[127.0.0.1] Jul 28 09:45:10 bomm3 amavis[5637]: (05637-17) FWD via SMTP: <sen...@.com> -> <recipi...@myserver>,BODY=7BIT 250 2.6.0 Ok, id=05637-17, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as B9A7225C001 Jul 28 09:45:10 bomm3 amavis[5637]: (05637-17) Passed CLEAN, [10.10.10.10] <sen...@.com> -> <recipi...@myserver>, mail_id: wKNkVzaar0-x, Hits: -0.699, size: 1833, queued_as: B9A7225C001, 182 ms Jul 28 09:45:10 bomm3 postfix/smtp[6989]: 567CD25C003: to=<recipi...@myserver>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.5, delays=0.02/0.01/1.3/0.18, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as B9A7225C001) Jul 28 09:45:10 bomm3 amavis[5637]: (05637-17) TIMING [total 187 ms] - SMTP greeting: 2 (1%)1, SMTP EHLO: 0 (0%)1, SMTP pre-MAIL: 0 (0%)1, SMTP pre-DATA-flush: 2 (1%)2, SMTP DATA: 36 (19%)22, check_init: 1 (0%)22, digest_hdr: 0 (0%)22, digest_body: 0 (0%)22, gen_mail_id: 1 (0%)23, mime_decode: 8 (4%)27, get-file-type1: 11 (6%)33, parts_decode: 0 (0%)33, check_header: 2 (1%)34, spam-wb-list: 3 (2%)36, update_cache: 1 (1%)36, decide_mail_destiny: 1 (1%)37, fwd-connect: 6 (3%)40, fwd-mail-pip: 1 (1%)41, fwd-rcpt-pip: 1 (0%)41, fwd-data-chkpnt: 0 (0%)42, write-header: 2 (1%)43, fwd-data-contents: 0 (0%)43, fwd-end-chkpnt: 94 (50%)93, prepare-dsn: 1 (0%)94, main_log_entry: 9 (5%)98, update_snmp: 2 (1%)99, SMTP pre-response: 0 (0%)99, SMTP response: 0 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100 Jul 28 09:45:10 bomm3 postfix/bounce[6974]: 934E325C004: sender non-delivery notification: CADF625C005 Jul 28 09:45:10 bomm3 postfix/qmgr[3548]: CADF625C005: from=<>, size=4225, nrcpt=1 (queue active) Jul 28 09:45:10 bomm3 postfix/qmgr[3548]: 567CD25C003: removed Jul 28 09:45:10 bomm3 postfix/qmgr[3548]: 934E325C004: removed Jul 28 09:45:10 bomm3 postfix/qmgr[3548]: B9A7225C001: from=<sen...@.com>, size=2271, nrcpt=1 (queue active) Jul 28 09:45:11 bomm3 postfix/pipe[6971]: B9A7225C001: to=<recipi...@myserver>, orig_to=<recipi...@myserver>, relay=cyrus, delay=0.24, delays=0.12/0/0/0.12, dsn=5.6.0, status=bounced (data format error. Command output: recipiet: Message contains invalid header ) Jul 28 09:45:11 bomm3 postfix/cleanup[6921]: 00D2D25C003: message-id=<20090728154511.00d2d25c...@myserver> Jul 28 09:45:11 bomm3 postfix/bounce[6974]: B9A7225C001: sender non-delivery notification: 00D2D25C003 Jul 28 09:45:11 bomm3 postfix/qmgr[3548]: 00D2D25C003: from=<>, size=4222, nrcpt=1 (queue active) Jul 28 09:45:11 bomm3 postfix/qmgr[3548]: B9A7225C001: removed Jul 28 09:45:11 bomm3 postfix/smtpd[6932]: connect from localhost[127.0.0.1] Jul 28 09:45:11 bomm3 postfix/smtpd[6932]: E99FA25C001: client=localhost[127.0.0.1] Jul 28 09:45:11 bomm3 postfix/cleanup[6984]: E99FA25C001: message-id= Jul 28 09:45:12 bomm3 postfix/smtpd[6932]: disconnect from localhost[127.0.0.1] Jul 28 09:45:12 bomm3 postfix/qmgr[3548]: E99FA25C001: from=<sen...@.com>, size=2276, nrcpt=1 (queue active) Jul 28 09:45:12 bomm3 amavis[6937]: (06937-01) FWD via SMTP: <sen...@.com> -> <recipi...@myserver>,BODY=7BIT 250 2.6.0 Ok, id=06937-01, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as E99FA25C001 Jul 28 09:45:12 bomm3 amavis[6937]: (06937-01) Passed CLEAN, [10.10.10.10] <sen...@.com> -> <recipi...@myserver>, mail_id: Wb-KS8AghfQh, Hits: -0.884, size: 1838, queued_as: E99FA25C001, 3710 ms Jul 28 09:45:12 bomm3 postfix/smtp[6936]: 370E125C002: to=<recipi...@myserver>, relay=127.0.0.1[127.0.0.1]:10024, delay=3.8, delays=0.07/0.02/0.01/3.7, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as E99FA25C001) Jul 28 09:45:12 bomm3 postfix/qmgr[3548]: 370E125C002: removed Jul 28 09:45:12 bomm3 amavis[6937]: (06937-01) TIMING [total 3716 ms] - SMTP greeting: 5 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 0 (0%)0, mkdir tempdir: 0 (0%)0, create email.txt: 0 (0%)0, SMTP pre-DATA-flush: 3 (0%)0, SMTP DATA: 41 (1%)1, check_init: 1 (0%)1, digest_hdr: 1 (0%)1, digest_body: 0 (0%)1, gen_mail_id: 1 (0%)1, mkdir parts: 1 (0%)1, mime_decode: 12 (0%)2, get-file-type1: 12 (0%)2, parts_decode: 0 (0%)2, check_header: 2 (0%)2, AV-scan-1: 5 (0%)2, AV-scan-2: 1470 (40%)42, spam-wb-list: 2 (0%)42, SA msg read: 1 (0%)42, SA parse: 3 (0%)42, SA check: 2071 (56%)98, update_cache: 7 (0%)98, decide_mail_destiny: 1 (0%)98, fwd-connect: 7 (0%)98, fwd-mail-pip: 2 (0%)98, fwd-rcpt-pip: 0 (0%)98, fwd-data-chkpnt: 0 (0%)98, write-header: 1 (0%)98, fwd-data-contents: 0 (0%)98, fwd-end-chkpnt: 50 (1%)100, prepare-dsn: 1 (0%)100, main_log_entry: 11 (0%)100, update_snmp: 2 (0%)100, SMTP pre-response: 0 (0%)100, SMTP response: 0 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100 Jul 28 09:45:12 bomm3 postfix/pipe[6971]: E99FA25C001: to=<recipi...@myserver>, orig_to=<recipi...@myserver>, relay=cyrus, delay=0.12, delays=0.05/0/0/0.06, dsn=5.6.0, status=bounced (data format error. Command output: user: Message contains invalid header ) Jul 28 09:45:12 bomm3 postfix/cleanup[6921]: 1205A25C002: message-id=<20090728154512.1205a25c...@myserver> Jul 28 09:45:12 bomm3 postfix/qmgr[3548]: 1205A25C002: from=<>, size=4227, nrcpt=1 (queue active) Jul 28 09:45:12 bomm3 postfix/bounce[6974]: E99FA25C001: sender non-delivery notification: 1205A25C002 Jul 28 09:45:12 bomm3 postfix/qmgr[3548]: E99FA25C001: removed Jul 28 09:45:13 bomm3 postfix/smtp[6922]: CADF625C005: to=<sen...@.com>, relay=mail.sender[11.11.11.11]:25, delay=2.2, delays=0.03/0.02/0.98/1.2, dsn=2.0.0, status=sent (250 OK DE/42-05623-E222F6A4) Jul 28 09:45:13 bomm3 postfix/smtp[6989]: 00D2D25C003: to=<sen...@.com>, relay=mail.sender[11.11.11.11]:25, delay=2, delays=0.04/0/0.8/1.2, dsn=2.0.0, status=sent (250 OK CE/42-05623-E222F6A4) Jul 28 09:45:13 bomm3 postfix/qmgr[3548]: CADF625C005: removed Jul 28 09:45:13 bomm3 postfix/qmgr[3548]: 00D2D25C003: removed Jul 28 09:45:13 bomm3 postfix/smtp[6936]: 1205A25C002: to=<sen...@.com>, relay=mail.sender[11.11.11.11]:25, delay=1.6, delays=0.04/0/0.94/0.65, dsn=2.0.0, status=sent (250 OK C1/52-05623-F222F6A4) Jul 28 09:45:13 bomm3 postfix/qmgr[3548]: 1205A25C002: removed Jul 28 09:45:13 bomm3 postfix/smtp[6936]: 1205A25C002: to=<sen...@.com>, relay=mail.sender[11.11.11.11]:25, delay=1.6, delays=0.04/0/0.94/0.65, dsn=2.0.0, status=sent (250 OK C1/52-05623-F222F6A4) Jul 28 09:45:13 bomm3 postfix/qmgr[3548]: 1205A25C002: removed Jul 28 09:46:05 bomm3 postfix/smtpd[6976]: connect from unknown[192.27.1.15] Jul 28 09:46:05 bomm3 postfix/smtpd[6976]: C137325C001: client=unknown[192.27.1.15] Jul 28 09:46:05 bomm3 postfix/smtpd[6976]: disconnect from unknown[192.27.1.15]
Jul 28 09:45:08 boom3 amavis[5637]: (05637-16) Checking: XPr4Jvf1nybP <sen...@.com> -> <recipi...@myserver> Jul 28 09:45:08 boom3 amavis[6937]: (06937-01) Checking: Wb-KS8AghfQh <sen...@.com> -> <recipi...@myserver> Jul 28 09:45:10 boom3 amavis[5637]: (05637-16) FWD via SMTP: <sen...@.com> -> <recipi...@myserver>,BODY=7BIT 250 2.6.0 Ok, id=05637-16, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 934E325C004 Jul 28 09:45:10 boom3 amavis[5637]: (05637-16) Passed CLEAN, [10.10.10.10] <sen...@.com> -> <recipi...@myserver>, mail_id: XPr4Jvf1nybP, Hits: -0.699, size: 1836, queued_as: 934E325C004, 2375 ms Jul 28 09:45:10 boom3 postfix/smtp[6922]: 3337125C001: to=<recipi...@myserver>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.5, delays=0.09/0/0/2.4, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 934E325C004) Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) ESMTP::10024 /var/spool/amavis/tmp/amavis-20090728T092128-05637: <sen...@.com> -> <recipi...@myserver> SIZE=1833 Received: from myserver. ([127.0.0.1]) by localhost (myserver. [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <recipi...@myserver>; Tue, 28 Jul 2009 09:45:10 -0600 (CST) Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) Checking: wKNkVzaar0-x <sen...@.com> -> <recipi...@myserver> Jul 28 09:45:10 boom3 postfix/pipe[6971]: 934E325C004: to=<recipi...@myserver>, orig_to=<recipi...@myserver>, relay=cyrus, delay=0.23, delays=0.06/0/0/0.16, dsn=5.6.0, status=bounced (data format error. Command output: usermyserver: Message contains invalid header ) Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) FWD via SMTP: <sen...@.com> -> <recipi...@myserver>,BODY=7BIT 250 2.6.0 Ok, id=05637-17, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as B9A7225C001 Jul 28 09:45:10 boom3 amavis[5637]: (05637-17) Passed CLEAN, [10.10.10.10] <sen...@.com> -> <recipi...@myserver>, mail_id: wKNkVzaar0-x, Hits: -0.699, size: 1833, queued_as: B9A7225C001, 182 ms Jul 28 09:45:10 boom3 postfix/smtp[6989]: 567CD25C003: to=<recipi...@myserver>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.5, delays=0.02/0.01/1.3/0.18, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as B9A7225C001) Jul 28 09:45:11 boom3 postfix/pipe[6971]: B9A7225C001: to=<recipi...@myserver>, orig_to=<recipi...@myserve>, relay=cyrus, delay=0.24, delays=0.12/0/0/0.12, dsn=5.6.0, status=bounced (data format error. Command output: usermyserver: Message contains invalid header ) Jul 28 09:45:12 boom3 amavis[6937]: (06937-01) FWD via SMTP: <sen...@.com> -> <recipi...@myserver>,BODY=7BIT 250 2.6.0 Ok, id=06937-01, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as E99FA25C001 Jul 28 09:45:12 boom3 amavis[6937]: (06937-01) Passed CLEAN, [10.10.10.10] <sen...@.com> -> <recipi...@myserver>, mail_id: Wb-KS8AghfQh, Hits: -0.884, size: 1838, queued_as: E99FA25C001, 3710 ms Jul 28 09:45:12 boom3 postfix/smtp[6936]: 370E125C002: to=<recipi...@myserver>, relay=127.0.0.1[127.0.0.1]:10024, delay=3.8, delays=0.07/0.02/0.01/3.7, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as E99FA25C001) Jul 28 09:45:12 boom3 postfix/pipe[6971]: E99FA25C001: to=<recipi...@myserver>, orig_to=<recipi...@myserver>, relay=cyrus, delay=0.12, delays=0.05/0/0/0.06, dsn=5.6.0, status=bounced (data format error. Command output: usermyserver: Message contains invalid header )
# postconf -n alias_maps = hash:/etc/aliases, hash:/var/lib/mailman/data/aliases best_mx_transport = local biff = no command_directory = /usr/sbin config_directory = /etc/postfix daemon_directory = /usr/lib/postfix debug_peer_level = 2 defer_transports = disable_dns_lookups = no disable_mime_output_conversion = no html_directory = /usr/share/doc/packages/postfix/html inet_interfaces = all inet_protocols = all mail_owner = postfix mailbox_command = mailbox_size_limit = 0 mailbox_transport = cyrus mailq_path = /usr/bin/mailq manpage_directory = /usr/share/man masquerade_classes = envelope_sender, header_sender, header_recipient masquerade_domains = masquerade_exceptions = root message_size_limit = 10485760 mydestination = mysql:/etc/postfix/mysql-mydestination.cf myhostname = myserver mynetworks = 10.10.10.10/10, 11.11.11.11/11, 12.12.12.12./, 127.0.0.0/8 mynetworks_style = subnet newaliases_path = /usr/bin/newaliases queue_directory = /var/spool/postfix readme_directory = /usr/share/doc/packages/postfix/README_FILES receive_override_options = no_address_mappings relayhost = relocated_maps = hash:/etc/postfix/relocated sample_directory = /usr/share/doc/packages/postfix/samples sender_canonical_maps = mysql:/etc/postfix/mysql-canonical.cf sendmail_path = /usr/sbin/sendmail setgid_group = maildrop smtp_sasl_auth_enable = no smtp_use_tls = no smtpd_client_restrictions = permit_mynetworks, reject_rbl_client bl.spamcop.net, reject_rbl_client sbl.spamhaus.org smtpd_helo_required = yes smtpd_helo_restrictions = permit_mynetworks smtpd_recipient_restrictions = permit_mynetworks, reject_unauth_destination smtpd_sasl_auth_enable = no smtpd_sender_restrictions = hash:/etc/postfix/access smtpd_use_tls = no strict_8bitmime = no strict_rfc821_envelopes = yes transport_maps = hash:/etc/postfix/transport unknown_local_recipient_reject_code = 550 virtual_alias_maps = mysql:/etc/postfix/mysql-virtual.cf
