I don't suppose anyone has a workaround/fix for this by chance?
Just some additional info:
I notice that the problem is only occuring when i have the deliver_to
set to
!/usr/bin/procmail /etc/procmail_users/<user>.procmailrc
And this is still only displaying incorrectly in Outlook Express.
Attached are a couple files. Both are log snips of dbmail_smtp with
trace = 5. one log shows the message coming in where it is delivered to
procmail, then reinserted, and the other, is to an alias that has a
direct deliver_to, to the user.
Let me know if there is anything else you would like me to include.
Thanks,
Dan
Aaron Stone wrote:
Paul J Stevens <[EMAIL PROTECTED]> said:
Ok so probably the mimeparser is adding spurious \r characters
in the string send to the client.
What's your take Aaron?
Yep, it's in the MIME parser. Somewhere, in the MIME parser. Early in the
2.0rc series, I had a fairly elegant and unified mechanism for receiving
messages, but the \r, \r\n, \r\r\n, etc. problems with the MIME parser
forced us to change to much heftier code that handled messages differently
if they came in over the network or from stdin.
Once we move to a more robust MIME parser in 2.1, we'll be able to throw
differently formatted messages at it and get better results. As for 2.0,
we'll just have to figure out a robust hack...
Aaron
--
_______________________________________________
Dbmail-dev mailing list
Dbmail-dev@dbmail.org
http://twister.fastxs.net/mailman/listinfo/dbmail-dev
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [host]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): found value
[localhost]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [db]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): found value [dbmail]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [user]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): found value [dbmail]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [pass]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): found value [EMAIL
PROTECTED]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [sqlport]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): item not found
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [sqlsocket]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): item not found
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_connect: MySQL host is set
to localhost, but no mysql_socket has been set. Use sqlsocket=... in
dbmail.conf. Connecting will be attempted using the default socket.
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: header.c,consume_header_line: end of
header found
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: header.c,get_rfc_size: remaining_len = 1
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: mime_readheader(): entering mime loop
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: mime_readheader(): found double
newline; header size: 28 lines
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] in alias table
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: checks
[-1]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('[EMAIL
PROTECTED]')]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: into
checking loop
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] to !/usr/bin/procmail
/etc/procmail_users/dstilts.procmailrc
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: checking
user [!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc] in alias table
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: checks
[1]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) =
lower('!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc')]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: authsql.c,auth_check_user_ext: adding
[!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc] to deliver_to
address
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dsn.c, dsnuser_resolve_list: user
[EMAIL PROTECTED] found total of [1] aliases
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: misc.c,create_unique_id: created:
701816680e98e05978e5c6bf568afa51
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='1']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0',
CURRENT_TIMESTAMP)]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id,
unique_id,recent_flag, status) VALUES ('5', '42310',
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks(messageblk,blocksize, physmessage_id) VALUES
('Received: from mx02.net.com (mx02.net.com [134.56.3.132])\n^Iby
imap.allmopars.com (Postfix) with ESMTP id 72135289986\n^Ifor <[EMAIL
PROTECTED]>; Tue, 5 Oct 2004 10:00:57 -0700 (PDT)\nReceived: from
mx01-int.net.com (mx01-int.net.com [134.56.112.13])\n^Iby mx02.net.com
(Switch-3.1.3/Switch-3.1.0) with ESMTP id i95H4NTM023871\n^Ifor <[EMAIL
PROTECTED]>; Tue, 5 Oct 2004 10:04:24 -0700 (PDT)\nReceived: from
fmt-ex01.net.com ([134.56.112.251])\n^Iby mx01-int.net.com
(Switch-3.1.3/Switch-3.1.0) with ESMTP id i95H271w003892\n^Ifor <[EMAIL
PROTECTED]>; Tue, 5 Oct 2004 10:02:31 -0700 (PDT)\nReceived: from
fmt-owa02.net.com ([134.56.112.254]) by fmt-ex01.net.com with Microsoft
SMTPSVC(6.0.3790.0);\n^I Tue, 5 Oct 2004 10:00:34 -0700\nReceived: from
[134.56.102.203] ([134.56.102.203]) by fmt-owa02.net.com with Microsoft
SMTPSVC(6.0.3790.0);\n^I Tue, 5 Oct
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: store_message_temp(): allocating
[524288] bytes of memory for readblock
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: pipe.c,store_message_in_blocks:
inserting message:
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks(messageblk,blocksize, physmessage_id) VALUES
('\n', '1', '42310')]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51',
status = '0' WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[UPDATE dbmail_physmessage SET messagesize = '1492', rfcsize = '1521' WHERE id
= '42310']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT dbmail_mailboxes.owner_idnr FROM dbmail_mailboxes, dbmail_messages
WHERE dbmail_mailboxes.mailbox_idnr = dbmail_messages.mailbox_idnr AND
dbmail_messages.message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c,db_add_quotum_used: adding 1492 to
mailsize
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c.user_idnr_is_delivery_user_idnr:
looking up user_idnr for [EMAIL PROTECTED]@__
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: pipe.c, insert_messages: temporary
msgidnr is [68218]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: insert_messages(): we need to deliver
[1] messages to external addresses
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: insert_messages(): delivering to
external addresses
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): searching value for
config item [SENDMAIL]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: GetConfigValue(): found value
[/usr/sbin/sendmail]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: delivering to [1]
external addresses
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: opening pipe to
command /usr/bin/procmail /etc/procmail_users/dstilts.procmailrc
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: call to popen()
successfully opened pipe [6]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: appending mbox style
from header to pipe returnpath : [EMAIL PROTECTED]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: sending message id
number [68218] to forward pipe
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: ferror reports 0,
feof reports 0 on pipe 6
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: sending lines from
message 68218 on pipe 6
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c,db_send_message_lines: request for
[-2] lines
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c,db_send_message_lines: executing
query [SELECT messageblk FROM dbmail_messageblks WHERE physmessage_id='42310'
ORDER BY messageblk_idnr ASC]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT messageblk FROM dbmail_messageblks WHERE physmessage_id='42310' ORDER
BY messageblk_idnr ASC]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c,db_send_message_lines: sending
[-2] lines from message [68218]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c,db_send_message_lines: getting
nextblock [1]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: db.c,db_send_message_lines: getting
nextblock [2]
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: closing pipes
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [host]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): found value
[localhost]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [db]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): found value [dbmail]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [user]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): found value [dbmail]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [pass]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): found value [EMAIL
PROTECTED]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [sqlport]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): item not found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [sqlsocket]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): item not found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_connect: MySQL host is set
to localhost, but no mysql_socket has been set. Use sqlsocket=... in
dbmail.conf. Connecting will be attempted using the default socket.
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: header.c,consume_header_line: end of
header found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: header.c,get_rfc_size: remaining_len = 1
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mime_readheader(): entering mime loop
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mime_readheader(): found double
newline; header size: 29 lines
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): mimelist currently has
[20] nodes
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): mail address parser
starting
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): total fields in header
20
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): scanning for
Return-Path
Oct 5 10:00:58 ded3 last message repeated 19 times
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): found 0 emailaddresses
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): mail address parser
finished
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): mimelist currently has
[20] nodes
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): mail address parser
starting
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): total fields in header
20
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): scanning for From
Oct 5 10:00:58 ded3 last message repeated 11 times
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): found [EMAIL
PROTECTED], next in list is <null>
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): scanning for From
Oct 5 10:00:58 ded3 last message repeated 7 times
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): found 1 emailaddresses
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: mail_adr_list(): mail address parser
finished
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: main(): setting mailbox for all
deliveries to [INBOX]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='dstilts']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dsn.c, dsnuser_resolve_list: added user
[dstilts] id [3] to delivery list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: misc.c,create_unique_id: created:
701816680e98e05978e5c6bf568afa51
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='1']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0',
CURRENT_TIMESTAMP)]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id,
unique_id,recent_flag, status) VALUES ('5', '42311',
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks(messageblk,blocksize, physmessage_id) VALUES
('From [EMAIL PROTECTED] Tue Oct 5 10:00:58 2004\nReceived: from mx02.net.com
(mx02.net.com [134.56.3.132])\r\n^Iby imap.allmopars.com (Postfix) with ESMTP
id 72135289986\r\n^Ifor <[EMAIL PROTECTED]>; Tue, 5 Oct 2004 10:00:57 -0700
(PDT)\r\nReceived: from mx01-int.net.com (mx01-int.net.com
[134.56.112.13])\r\n^Iby mx02.net.com (Switch-3.1.3/Switch-3.1.0) with ESMTP id
i95H4NTM023871\r\n^Ifor <[EMAIL PROTECTED]>; Tue, 5 Oct 2004 10:04:24 -0700
(PDT)\r\nReceived: from fmt-ex01.net.com ([134.56.112.251])\r\n^Iby
mx01-int.net.com (Switch-3.1.3/Switch-3.1.0) with ESMTP id
i95H271w003892\r\n^Ifor <[EMAIL PROTECTED]>; Tue, 5 Oct 2004 10:02:31 -0700
(PDT)\r\nReceived: from fmt-owa02.net.com ([134.56.112.254]) by
fmt-ex01.net.com with Microsoft SMTPSVC(6.0.3790.0);\r\n^I Tue, 5 Oct 2004
10:00:34 -0700\r\nReceived: from [134.56.102.203] ([134.56.102.20
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: store_message_temp(): allocating
[524288] bytes of memory for readblock
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: pipe.c,store_message_in_blocks:
inserting message:
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks(messageblk,blocksize, physmessage_id) VALUES
('\n', '1', '42311')]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51',
status = '0' WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[UPDATE dbmail_physmessage SET messagesize = '1573', rfcsize = '1575' WHERE id
= '42311']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT dbmail_mailboxes.owner_idnr FROM dbmail_mailboxes, dbmail_messages
WHERE dbmail_mailboxes.mailbox_idnr = dbmail_messages.mailbox_idnr AND
dbmail_messages.message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: db.c,db_add_quotum_used: adding 1573 to
mailsize
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: db.c.user_idnr_is_delivery_user_idnr:
looking up user_idnr for [EMAIL PROTECTED]@__
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: pipe.c, insert_messages: temporary
msgidnr is [68219]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: pipe.c, insert_messages: calling
sort_and_deliver for useridnr [3]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [SQLREGEX]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): item not found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [LIBSIEVE]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): item not found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='3']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT pm.messagesize FROM dbmail_physmessage pm, dbmail_messages msg WHERE
pm.id = msg.physmessage_id AND message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT 1 FROM dbmail_users WHERE user_idnr = '3' AND (maxmail_size > 0) AND
(curmail_size + '1573' > maxmail_size)]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: misc.c,create_unique_id: created:
5d5ea855c1a968ee6b142a6db6535705
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages (mailbox_idnr,physmessage_id, seen_flag,
answered_flag, deleted_flag, flagged_flag, recent_flag, draft_flag, unique_id,
status) SELECT '2', physmessage_id, seen_flag, answered_flag, deleted_flag,
flagged_flag, recent_flag, draft_flag, '5d5ea855c1a968ee6b142a6db6535705',
status FROM dbmail_messages WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: db.c,db_add_quotum_used: adding 1573 to
mailsize
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: db.c.user_idnr_is_delivery_user_idnr:
no need to look up user_idnr for [EMAIL PROTECTED]@__
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[UPDATE dbmail_users SET curmail_size = curmail_size + '1573' WHERE user_idnr =
'3']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: sort.c, sort_and_deliver: message
id=68220, size=1573 is inserted
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: pipe.c, insert_messages: successful
sort_and_deliver for useridnr [3]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [AUTO_NOTIFY]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): found value [no]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): searching value for
config item [AUTO_REPLY]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: GetConfigValue(): found value [no]
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: insert_messages(): we need to deliver
[0] messages to external addresses
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messages WHERE message_idnr = '68219']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dbmysql.c,db_query: executing query
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '42311']
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: insert_messages(): temporary message
deleted from database
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: insert_messages(): End of function
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: main(): freeing dsnuser list
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: dsn.c, dsnuser_free: dsnuser freed
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: main(): freeing all other lists
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: main(): freeing memory blocks
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: main(): they're all free. we're done.
Oct 5 10:00:58 ded3 dbmail/smtp[1601]: main(): exit code is [0].
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: forward.c,forward: pipe closed
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messages WHERE message_idnr = '68218']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '42310']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_physmessage WHERE id = '42310']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messageblks WHERE physmessage_id = '42310']
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: insert_messages(): temporary message
deleted from database
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: insert_messages(): End of function
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: main(): freeing dsnuser list
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: dsn.c, dsnuser_free: dsnuser freed
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: main(): freeing all other lists
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: main(): freeing memory blocks
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: main(): they're all free. we're done.
Oct 5 10:00:58 ded3 dbmail/smtp[1595]: main(): exit code is [0].
Oct 5 10:00:58 ded3 postfix/pipe[1566]: 72135289986: to=<[EMAIL PROTECTED]>,
relay=dbmail-smtp, delay=1, status=sent (allmopars.com)
Oct 5 10:00:58 ded3 postfix/qmgr[22477]: 72135289986: removed
Oct 5 10:05:12 ded3 postfix/smtpd[1591]: connect from
mx01.net.com[134.56.3.131]
Oct 5 10:05:12 ded3 postfix/smtpd[1591]: 8216B289987:
client=mx01.net.com[134.56.3.131]
Oct 5 10:05:12 ded3 postfix/cleanup[1608]: 8216B289987: message-id=<[EMAIL
PROTECTED]>
Oct 5 10:05:12 ded3 postfix/qmgr[22477]: 8216B289987: from=<[EMAIL
PROTECTED]>, size=1471, nrcpt=1 (queue active)
Oct 5 10:05:12 ded3 postfix/smtpd[1591]: disconnect from
mx01.net.com[134.56.3.131]
Oct 5 10:05:12 ded3 spamd[779]: connection from localhost [127.0.0.1] at port
41328
Oct 5 10:05:12 ded3 spamd[1616]: info: setuid to dbmail succeeded
Oct 5 10:05:12 ded3 spamd[1616]: Creating default_prefs
[/dev/null/.spamassassin/user_prefs]
Oct 5 10:05:12 ded3 spamd[1616]: Cannot write to
/dev/null/.spamassassin/user_prefs: Not a directory
Oct 5 10:05:12 ded3 spamd[1616]: Couldn't create readable default_prefs for
[/dev/null/.spamassassin/user_prefs]
Oct 5 10:05:12 ded3 spamd[1616]: processing message <[EMAIL PROTECTED]> for
dbmail:105.
Oct 5 10:05:13 ded3 spamd[1616]: clean message (0.0/5.0) for dbmail:105 in 0.7
seconds, 1443 bytes.
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [host]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): found value
[localhost]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [db]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): found value [dbmail]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [user]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): found value [dbmail]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [pass]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): found value [EMAIL
PROTECTED]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [sqlport]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): item not found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [sqlsocket]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): NULL item value in
item-list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): item not found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_connect: MySQL host is set
to localhost, but no mysql_socket has been set. Use sqlsocket=... in
dbmail.conf. Connecting will be attempted using the default socket.
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: header.c,consume_header_line: end of
header found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: header.c,get_rfc_size: remaining_len = 1
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: mime_readheader(): entering mime loop
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: mime_readheader(): found double
newline; header size: 28 lines
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] in alias table
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: checks
[-1]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('[EMAIL
PROTECTED]')]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: into
checking loop
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] to 3
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: checking
user [3] in alias table
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: checks
[1]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('3')]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: authsql.c,auth_check_user_ext: adding
[3] to deliver_to address
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dsn.c, dsnuser_resolve_list: user
[EMAIL PROTECTED] found total of [1] aliases
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: misc.c,create_unique_id: created:
701816680e98e05978e5c6bf568afa51
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='1']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0',
CURRENT_TIMESTAMP)]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id,
unique_id,recent_flag, status) VALUES ('5', '42314',
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks(messageblk,blocksize, physmessage_id) VALUES
('Received: from mx01.net.com (mx01.net.com [134.56.3.131])\n^Iby
imap.allmopars.com (Postfix) with ESMTP id 8216B289987\n^Ifor <[EMAIL
PROTECTED]>; Tue, 5 Oct 2004 10:05:12 -0700 (PDT)\nReceived: from
mx02-int.net.com (mx02-int.net.com [134.56.112.14])\n^Iby mx01.net.com
(Switch-3.1.3/Switch-3.1.0) with ESMTP id i95H8d7O011387\n^Ifor <[EMAIL
PROTECTED]>; Tue, 5 Oct 2004 10:08:39 -0700 (PDT)\nReceived: from
fmt-ex01.net.com ([134.56.112.251])\n^Iby mx02-int.net.com
(Switch-3.1.3/Switch-3.1.0) with ESMTP id i95H8ZG5002315\n^Ifor <[EMAIL
PROTECTED]>; Tue, 5 Oct 2004 10:08:38 -0700 (PDT)\nReceived: from
fmt-owa02.net.com ([134.56.112.254]) by fmt-ex01.net.com with Microsoft
SMTPSVC(6.0.3790.0);\n^I Tue, 5 Oct 2004 10:04:57 -0700\nReceived: from
[134.56.102.203] ([134.56.102.203]) by fmt-owa02.net.com with Microsoft
SMTPSVC(6.0.3790.0);\n^I Tue, 5 Oct 2004 10:04:5
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: store_message_temp(): allocating
[524288] bytes of memory for readblock
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: pipe.c,store_message_in_blocks:
inserting message:
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks(messageblk,blocksize, physmessage_id) VALUES
('\n', '1', '42314')]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51',
status = '0' WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[UPDATE dbmail_physmessage SET messagesize = '1463', rfcsize = '1492' WHERE id
= '42314']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT dbmail_mailboxes.owner_idnr FROM dbmail_mailboxes, dbmail_messages
WHERE dbmail_mailboxes.mailbox_idnr = dbmail_messages.mailbox_idnr AND
dbmail_messages.message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: db.c,db_add_quotum_used: adding 1463 to
mailsize
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: db.c.user_idnr_is_delivery_user_idnr:
looking up user_idnr for [EMAIL PROTECTED]@__
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: pipe.c, insert_messages: temporary
msgidnr is [68223]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: pipe.c, insert_messages: calling
sort_and_deliver for useridnr [3]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [SQLREGEX]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): item not found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [LIBSIEVE]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): item not found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='3']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT pm.messagesize FROM dbmail_physmessage pm, dbmail_messages msg WHERE
pm.id = msg.physmessage_id AND message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT 1 FROM dbmail_users WHERE user_idnr = '3' AND (maxmail_size > 0) AND
(curmail_size + '1463' > maxmail_size)]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: misc.c,create_unique_id: created:
6f136ec363796d56c30b35ccfbe16c53
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages (mailbox_idnr,physmessage_id, seen_flag,
answered_flag, deleted_flag, flagged_flag, recent_flag, draft_flag, unique_id,
status) SELECT '2', physmessage_id, seen_flag, answered_flag, deleted_flag,
flagged_flag, recent_flag, draft_flag, '6f136ec363796d56c30b35ccfbe16c53',
status FROM dbmail_messages WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: db.c,db_add_quotum_used: adding 1463 to
mailsize
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: db.c.user_idnr_is_delivery_user_idnr:
no need to look up user_idnr for [EMAIL PROTECTED]@__
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[UPDATE dbmail_users SET curmail_size = curmail_size + '1463' WHERE user_idnr =
'3']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: sort.c, sort_and_deliver: message
id=68224, size=1463 is inserted
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: pipe.c, insert_messages: successful
sort_and_deliver for useridnr [3]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [AUTO_NOTIFY]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): found value [no]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): searching value for
config item [AUTO_REPLY]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: GetConfigValue(): found value [no]
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: insert_messages(): we need to deliver
[0] messages to external addresses
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messages WHERE message_idnr = '68223']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dbmysql.c,db_query: executing query
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '42314']
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: insert_messages(): temporary message
deleted from database
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: insert_messages(): End of function
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: main(): freeing dsnuser list
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: dsn.c, dsnuser_free: dsnuser freed
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: main(): freeing all other lists
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: main(): freeing memory blocks
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: main(): they're all free. we're done.
Oct 5 10:05:13 ded3 dbmail/smtp[1615]: main(): exit code is [0].
Oct 5 10:05:13 ded3 postfix/pipe[1614]: 8216B289987: to=<[EMAIL PROTECTED]>,
relay=dbmail-smtp, delay=1, status=sent (allmopars.com)
Oct 5 10:05:13 ded3 postfix/qmgr[22477]: 8216B289987: removed