Helps to attach the log...
------------
Hey Paul,
So I upgraded tonight and everything is displaying great now. However I
am running into a new problem. When I receive and email, it shows as
'inserted' into the database, but it never shows up in any mail client
at all. I've posted some TRACE 5. There are two parts to the file. The
top one, to an email address that has a 'deliver_to' to some procmail
scripts I have setup for filtering and such, and the second part, is
just with an alias of [EMAIL PROTECTED] and a deliver_to of the user
id (in my case, the user id is '3'). Any thoughts?
Thanks,
Dan
Paul J Stevens wrote:
Dan Stilts wrote:
Hey All;
Well, I hadn't noticed this brought up, so figured I'd give it a shot.
I upgraded from 2.0.6 to the current svn trunk and no longer am able to
view messages in squirrelmail (as far as I can tell, Thunderbird still
works fine). In the inbox, all I see is an empty 'From', 'Unknown date'
and the Subject as (no subject), for all messages in the folder. When I
click on the (no subject) it comes up saying it can't find the message.
I am assuming this has to do with the DB layout changes from 2.0 ->
current, but wanted to check here first. If so, any reasonable way to
get the database in the right state for the messages?
dbmail-util -by is required before 2.1 is usable. The header tables need
to be filled. It may run a while.
Jan 31 02:41:43 mail dbmail/imap4d[28376]: RESPONSE: [HEADER.FIELDS (Date To Cc
From Subject X-Priority Content-Type)] ]
Jan 31 02:41:43 mail dbmail/imap4d[28376]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359481']
Jan 31 02:41:43 mail dbmail/imap4d[28376]: dbmysql.c,db_query: executing query
[SELECT physmessage_id,headername,headervalue FROM dbmail_headervalue v JOIN
dbmail_headername n ON v.headername_id=n.id WHERE physmessage_id IN (198560)
AND lower(headername) IN
('date','to','cc','from','subject','x-priority','content-type')]
Jan 31 02:41:43 mail dbmail/imap4d[28376]: RESPONSE: [NIL]
]n 31 02:41:43 mail dbmail/imap4d[28376]: RESPONSE: [)
No headers were found for the requested message.
Feb 1 01:18:14 mail postfix/qmgr[1820]: 9E965272E3: from=<[EMAIL PROTECTED]>,
size=1231, nrcpt=1 (queue active)
Feb 1 01:18:14 mail postfix/smtpd[2138]: disconnect from localhost[127.0.0.1]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT 1=1 FROM dbmail_physmessage LIMIT 1 OFFSET 0]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT 1=1 FROM dbmail_headervalue LIMIT 1 OFFSET 0]
Feb 1 01:18:15 mail dbmail/smtp[2143]:
dbmail-message.c,_set_content_from_stream: parse message
Feb 1 01:18:15 mail dbmail/smtp[2143]: mime.c,mime_fetch_headers: found [16]
mime headers
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] in alias table
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: checks
[0]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('[EMAIL
PROTECTED]') AND lower(alias) <> lower(deliver_to)]
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: into
checking loop
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] to !/usr/bin/procmail
/etc/procmail_users/dstilts.procmailrc
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: checking
user [!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc] in alias table
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: checks
[1]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) =
lower('!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc') AND
lower(alias) <> lower(deliver_to)]
Feb 1 01:18:15 mail dbmail/smtp[2143]: authsql.c,auth_check_user_ext: adding
[!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc] to deliver_to
address
Feb 1 01:18:15 mail dbmail/smtp[2143]: dsn.c, dsnuser_resolve: user [EMAIL
PROTECTED] found total of [1] aliases
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[BEGIN]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Feb 1 01:18:15 mail dbmail/smtp[2143]: misc.c,create_unique_id: created:
701816680e98e05978e5c6bf568afa51
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='1']
Feb 1 01:18:15 mail dbmail/smtp[2143]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0',
CURRENT_TIMESTAMP)]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id,
unique_id,recent_flag, status) VALUES ('5', '198787',
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359830']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks (is_header, messageblk,blocksize,
physmessage_id) VALUES ('1','Received: from cassoulet.panasas.com (localhost
[127.0.0.1])\n by mail.allmopars.com (Postfix) with ESMTP id 9E965272E3\n for
<[EMAIL PROTECTED]>; Wed, 1 Feb 2006 01:18:13 -0800 (PST)\nReceived: from
65.194.124.178 ([65.194.124.178] helo=cassoulet.panasas.com)\n by
ASSP-nospam; 1 Feb 2006 01:18:12 -0800\nReceived: from ASSP-nospam
(localhost.localdomain [127.0.0.1])\n by cassoulet.panasas.com
(8.12.10/8.12.10) with ESMTP id k119Kjbn019994\n for <[EMAIL PROTECTED]>; Wed,
1 Feb 2006 04:20:45 -0500\nReceived: from 172.17.133.23 ([172.17.133.23]
helo=pocono.panasas.com)\n by ASSP-nospam ; 1 Feb 06 09:20:44
-0000\nReceived: by exchange.ca.panasas.com\n with Internet Mail Service
(5.5.2653.19) id <C7AWFGJS>;\n Wed, 1 Feb 2006 01:20:42
-0800\nMessage-ID: <[EMAIL PROTECTED]>\nFrom: \"Stilts, Dan\" <d
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmail-message.c,dbmail_message_store:
allocating [524288] bytes of memory for readblock
Feb 1 01:18:15 mail dbmail/smtp[2143]: pipe.c,store_message_in_blocks:
inserting message: test
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359830']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks (is_header, messageblk,blocksize,
physmessage_id) VALUES ('0','test\n', '5', '198787')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51',
status = '0' WHERE message_idnr = '359830']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359830']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[UPDATE dbmail_physmessage SET messagesize = '1272', rfcsize = '1301' WHERE id
= '198787']
Feb 1 01:18:15 mail dbmail/smtp[2143]: 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 = '359830']
Feb 1 01:18:15 mail dbmail/smtp[2143]: db.c,db_add_quotum_used: adding 1272 to
mailsize
Feb 1 01:18:15 mail dbmail/smtp[2143]: db.c.user_idnr_is_delivery_user_idnr:
looking up user_idnr for [EMAIL PROTECTED]@__
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Content-Type']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (19,198787,'text/plain')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Received']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198787,'from cassoulet.panasas.com (localhost [127.0.0.1]) by
mail.allmopars.com (Postfix) with ESMTP id 9E965272E3 for <[EMAIL
PROTECTED]>; Wed, 1 Feb 2006 01:18:13 -0800 (PST)')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198787,'from 65.194.124.178 ([65.194.124.178]
helo=cassoulet.panasas.com) by ASSP-nospam; 1 Feb 2006 01:18:12 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198787,'from ASSP-nospam (localhost.localdomain [127.0.0.1]) by
cassoulet.panasas.com (8.12.10/8.12.10) with ESMTP id k119Kjbn019994 for
<[EMAIL PROTECTED]>; Wed, 1 Feb 2006 04:20:45 -0500')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198787,'from 172.17.133.23 ([172.17.133.23] helo=pocono.panasas.com)
by ASSP-nospam ; 1 Feb 06 09:20:44 -0000')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198787,'by exchange.ca.panasas.com with Internet Mail Service
(5.5.2653.19) id <C7AWFGJS>; Wed, 1 Feb 2006 01:20:42 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Message-ID']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (9,198787,'<[EMAIL PROTECTED]>')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='From']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (4,198787,'\"Stilts, Dan\" <[EMAIL PROTECTED]>')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='To']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (5,198787,'\"\'[EMAIL PROTECTED]'\" <[EMAIL PROTECTED]>')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Subject']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (6,198787,'test')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Date']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (7,198787,'Wed, 1 Feb 2006 01:20:41 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Mailer']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (8,198787,'Internet Mail Service (5.5.2653.19)')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Delay']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (469,198787,'not delayed (whitelisted); 1 Feb 2006 01:18:13 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Spam-Prob']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (144,198787,'0.00000')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Whitelisted']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (473,198787,'Yes')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Envelope-From']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (470,198787,'[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Return-Path']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (1,198787,'[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-DBMail-PhysMessage-ID']
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (275,198787,'198787')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_tofield (physmessage_id, toname, toaddr) VALUES
(198787,'\'[EMAIL PROTECTED]'','[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_fromfield (physmessage_id, fromname, fromaddr) VALUES
(198787,'Stilts, Dan','[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_datefield (physmessage_id, datefield) VALUES
(198787,'2006-02-01 09:20:41')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_subjectfield (physmessage_id, subjectfield) VALUES
(198787,'test')]
Feb 1 01:18:15 mail dbmail/smtp[2143]: pipe.c, insert_messages: temporary
msgidnr is [359830]
Feb 1 01:18:15 mail dbmail/smtp[2143]: pipe.c,insert_messages: deliver [1]
messages to external addresses
Feb 1 01:18:15 mail dbmail/smtp[2143]: pipe.c,insert_messages: delivering to
external addresses
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: delivering to [1]
external addresses
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: opening pipe to
command /usr/bin/procmail /etc/procmail_users/dstilts.procmailrc
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: call to popen()
successfully opened pipe [6]
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: appending mbox style
from header to pipe returnpath : [EMAIL PROTECTED]
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: sending message id
number [359830] to forward pipe
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: ferror reports 0,
feof reports 0 on pipe 6
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: sending lines from
message 359830 on pipe 6
Feb 1 01:18:15 mail dbmail/smtp[2143]: db.c,db_send_message_lines: request for
[-2] lines
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359830']
Feb 1 01:18:15 mail dbmail/smtp[2143]: db.c,db_send_message_lines: sending
[-2] lines from message [359830]
Feb 1 01:18:15 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT messageblk FROM dbmail_messageblks WHERE physmessage_id = '198787'
ORDER BY messageblk_idnr]
Feb 1 01:18:15 mail dbmail/smtp[2143]:
dbmail-message.c,_set_content_from_stream: parse message
Feb 1 01:18:15 mail dbmail/smtp[2143]: forward.c,forward: closing pipes
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT 1=1 FROM dbmail_physmessage LIMIT 1 OFFSET 0]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT 1=1 FROM dbmail_headervalue LIMIT 1 OFFSET 0]
Feb 1 01:18:15 mail dbmail/smtp[2146]:
dbmail-message.c,_set_content_from_stream: parse message
Feb 1 01:18:15 mail dbmail/smtp[2146]: mime.c,mime_fetch_headers: found [19]
mime headers
Feb 1 01:18:15 mail dbmail/smtp[2146]: mime.c,mail_address_build_list: mail
address parser starting
Feb 1 01:18:15 mail dbmail/smtp[2146]: mime.c,mime_findfield: scanning for
Return-Path
Feb 1 01:18:15 mail dbmail/smtp[2146]: mime.c,mail_address_build_list: found 1
emailaddresses
Feb 1 01:18:15 mail dbmail/smtp[2146]: main(): setting mailbox for all
deliveries to [INBOX]
Feb 1 01:18:15 mail dbmail/smtp[2146]: authsql.c,auth_check_user_ext: checking
user [dstilts] in alias table
Feb 1 01:18:15 mail dbmail/smtp[2146]: authsql.c,auth_check_user_ext: checks
[0]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('dstilts')
AND lower(alias) <> lower(deliver_to)]
Feb 1 01:18:15 mail dbmail/smtp[2146]: authsql.c,auth_check_user_ext: user
dstilts not in aliases table
Feb 1 01:18:15 mail dbmail/smtp[2146]: dsn.c, dsnuser_resolve: user [dstilts]
found total of [0] aliases
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='dstilts']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dsn.c, dsnuser_resolve: added user
[dstilts] id [3] to delivery list
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[BEGIN]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Feb 1 01:18:15 mail dbmail/smtp[2146]: misc.c,create_unique_id: created:
701816680e98e05978e5c6bf568afa51
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='1']
Feb 1 01:18:15 mail dbmail/smtp[2146]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0',
CURRENT_TIMESTAMP)]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id,
unique_id,recent_flag, status) VALUES ('5', '198788',
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks (is_header, messageblk,blocksize,
physmessage_id) VALUES ('1','From [EMAIL PROTECTED] Wed Feb 1 01: 18:15
2006\nReceived: from cassoulet.panasas.com (localhost [127.0.0.1])\n by
mail.allmopars.com (Postfix) with ESMTP id 9E965272E3\n for <[EMAIL
PROTECTED]>; Wed, 1 Feb 2006 01:18:13 -0800 (PST)\nReceived: from
65.194.124.178 ([65.194.124.178] helo=cassoulet.panasas.com)\n by
ASSP-nospam; 1 Feb 2006 01:18:12 -0800\nReceived: from ASSP-nospam
(localhost.localdomain [127.0.0.1])\n by cassoulet.panasas.com
(8.12.10/8.12.10) with ESMTP id k119Kjbn019994\n for <[EMAIL PROTECTED]>; Wed,
1 Feb 2006 04:20:45 -0500\nReceived: from 172.17.133.23 ([172.17.133.23]
helo=pocono.panasas.com)\n by ASSP-nospam ; 1 Feb 06 09:20:44
-0000\nReceived: by exchange.ca.panasas.com\n with Internet Mail Service
(5.5.2653.19) id <C7AWFGJS>;\n Wed, 1 Feb 2006 01:20:42
-0800\nMessage-ID: <1349BBA27FB5074AA31242A4C319AC51016C36
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmail-message.c,dbmail_message_store:
allocating [524288] bytes of memory for readblock
b 1 01:18:15 mail dbmail/smtp[2146]: pipe.c,store_message_in_blocks:
inserting message: test
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks (is_header, messageblk,blocksize,
physmessage_id) VALUES ('0','test\r\n\n', '7', '198788')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51',
status = '0' WHERE message_idnr = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[UPDATE dbmail_physmessage SET messagesize = '1326', rfcsize = '1356' WHERE id
= '198788']
Feb 1 01:18:15 mail dbmail/smtp[2146]: 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 = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: db.c,db_add_quotum_used: adding 1326 to
mailsize
Feb 1 01:18:15 mail dbmail/smtp[2146]: db.c.user_idnr_is_delivery_user_idnr:
looking up user_idnr for [EMAIL PROTECTED]@__
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Content-Type']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (19,198788,'text/plain')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Received']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198788,'from cassoulet.panasas.com (localhost [127.0.0.1]) by
mail.allmopars.com (Postfix) with ESMTP id 9E965272E3 for <[EMAIL
PROTECTED]>; Wed, 1 Feb 2006 01:18:13 -0800 (PST)')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198788,'from 65.194.124.178 ([65.194.124.178]
helo=cassoulet.panasas.com) by ASSP-nospam; 1 Feb 2006 01:18:12 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198788,'from ASSP-nospam (localhost.localdomain [127.0.0.1]) by
cassoulet.panasas.com (8.12.10/8.12.10) with ESMTP id k119Kjbn019994 for
<[EMAIL PROTECTED]>; Wed, 1 Feb 2006 04:20:45 -0500')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198788,'from 172.17.133.23 ([172.17.133.23] helo=pocono.panasas.com)
by ASSP-nospam ; 1 Feb 06 09:20:44 -0000')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198788,'by exchange.ca.panasas.com with Internet Mail Service
(5.5.2653.19) id <C7AWFGJS>; Wed, 1 Feb 2006 01:20:42 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Message-ID']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (9,198788,'<[EMAIL PROTECTED]>')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='From']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (4,198788,'\"Stilts, Dan\" <[EMAIL PROTECTED]>')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='To']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (5,198788,'\"\'[EMAIL PROTECTED]'\" <[EMAIL PROTECTED]>')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Subject']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (6,198788,'test')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Date']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (7,198788,'Wed, 1 Feb 2006 01:20:41 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Mailer']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (8,198788,'Internet Mail Service (5.5.2653.19)')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Delay']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (469,198788,'not delayed (whitelisted); 1 Feb 2006 01:18:13 -0800')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Spam-Prob']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (144,198788,'0.00000')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Whitelisted']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (473,198788,'Yes')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Envelope-From']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (470,198788,'[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Return-Path']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (1,198788,'[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-DBMail-PhysMessage-ID']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (275,198788,'198788')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_tofield (physmessage_id, toname, toaddr) VALUES
(198788,'\'[EMAIL PROTECTED]'','[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_fromfield (physmessage_id, fromname, fromaddr) VALUES
(198788,'Stilts, Dan','[EMAIL PROTECTED]')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_datefield (physmessage_id, datefield) VALUES
(198788,'2006-02-01 09:20:41')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_subjectfield (physmessage_id, subjectfield) VALUES
(198788,'test')]
Feb 1 01:18:15 mail dbmail/smtp[2146]: pipe.c, insert_messages: temporary
msgidnr is [359831]
Feb 1 01:18:15 mail dbmail/smtp[2146]: pipe.c, insert_messages: calling
sort_and_deliver for useridnr [3]
Feb 1 01:18:15 mail dbmail/smtp[2146]: pipe.c, insert_messages: successful
sort_and_deliver for useridnr [3]
Feb 1 01:18:15 mail dbmail/smtp[2146]: pipe.c,insert_messages: deliver [0]
messages to external addresses
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messages WHERE message_idnr = '359831']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '198788']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_physmessage WHERE id = '198788']
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messageblks WHERE physmessage_id = '198788']
Feb 1 01:18:15 mail dbmail/smtp[2146]: pipe.c,insert_messages: temporary
message deleted from database. Done.
Feb 1 01:18:15 mail dbmail/smtp[2146]: dbmysql.c,db_query: executing query
[COMMIT]
Feb 1 01:18:16 mail dbmail/smtp[2146]: main(): freeing dsnuser list
Feb 1 01:18:16 mail dbmail/smtp[2146]: dsn.c, dsnuser_free: dsnuser freed
Feb 1 01:18:16 mail dbmail/smtp[2146]: main(): freeing all other lists
Feb 1 01:18:16 mail dbmail/smtp[2146]: main(): they're all free. we're done.
Feb 1 01:18:16 mail dbmail/smtp[2146]: main(): exit code is [0].
Feb 1 01:18:16 mail dbmail/smtp[2143]: forward.c,forward: pipe closed
Feb 1 01:18:16 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359830']
Feb 1 01:18:16 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messages WHERE message_idnr = '359830']
Feb 1 01:18:16 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '198787']
Feb 1 01:18:16 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_physmessage WHERE id = '198787']
Feb 1 01:18:16 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messageblks WHERE physmessage_id = '198787']
Feb 1 01:18:16 mail dbmail/smtp[2143]: pipe.c,insert_messages: temporary
message deleted from database. Done.
Feb 1 01:18:16 mail dbmail/smtp[2143]: dbmysql.c,db_query: executing query
[COMMIT]
Feb 1 01:18:16 mail dbmail/smtp[2143]: main(): freeing dsnuser list
Feb 1 01:18:16 mail dbmail/smtp[2143]: dsn.c, dsnuser_free: dsnuser freed
Feb 1 01:18:16 mail dbmail/smtp[2143]: main(): freeing all other lists
Feb 1 01:18:16 mail dbmail/smtp[2143]: main(): they're all free. we're done.
Feb 1 01:18:16 mail dbmail/smtp[2143]: main(): exit code is [0].
Feb 1 01:18:16 mail postfix/pipe[2142]: 9E965272E3: to=<[EMAIL PROTECTED]>,
relay=dbmail-smtp, delay=3, status=sent (allmopars.com)
Feb 1 01:18:16 mail postfix/qmgr[1820]: 9E965272E3: removed
------------------------------------------------------------------------------------------------------------------
Feb 1 01:31:09 mail postfix/smtpd[2250]: connect from localhost[127.0.0.1]
Feb 1 01:31:09 mail postfix/smtpd[2250]: 4D66A272E2:
client=localhost[127.0.0.1]
Feb 1 01:31:09 mail postfix/cleanup[2252]: 4D66A272E2: message-id=<[EMAIL
PROTECTED]>
Feb 1 01:31:09 mail postfix/qmgr[1820]: 4D66A272E2: from=<[EMAIL PROTECTED]>,
size=1232, nrcpt=1 (queue active)
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT 1=1 FROM dbmail_physmessage LIMIT 1 OFFSET 0]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT 1=1 FROM dbmail_headervalue LIMIT 1 OFFSET 0]
Feb 1 01:31:09 mail dbmail/smtp[2275]:
dbmail-message.c,_set_content_from_stream: parse message
Feb 1 01:31:09 mail dbmail/smtp[2275]: mime.c,mime_fetch_headers: found [16]
mime headers
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] in alias table
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: checks
[0]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('[EMAIL
PROTECTED]') AND lower(alias) <> lower(deliver_to)]
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: into
checking loop
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: checking
user [EMAIL PROTECTED] to 3
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: checking
user [3] in alias table
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: checks
[1]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('3') AND
lower(alias) <> lower(deliver_to)]
Feb 1 01:31:09 mail dbmail/smtp[2275]: authsql.c,auth_check_user_ext: adding
[3] to deliver_to address
Feb 1 01:31:09 mail dbmail/smtp[2275]: dsn.c, dsnuser_resolve: user [EMAIL
PROTECTED] found total of [1] aliases
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[BEGIN]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Feb 1 01:31:09 mail dbmail/smtp[2275]: misc.c,create_unique_id: created:
701816680e98e05978e5c6bf568afa51
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND
owner_idnr='1']
Feb 1 01:31:09 mail dbmail/smtp[2275]: db.c, db_find_create_mailbox: mailbox
[INBOX] found
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0',
CURRENT_TIMESTAMP)]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id,
unique_id,recent_flag, status) VALUES ('5', '198798',
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks (is_header, messageblk,blocksize,
physmessage_id) VALUES ('1','Received: from cassoulet.panasas.com (localhost
[127.0.0.1])\n by mail.allmopars.com (Postfix) with ESMTP id 4D66A272E2\n for
<[EMAIL PROTECTED]>; Wed, 1 Feb 2006 01:31:09 -0800 (PST)\nReceived: from
65.194.124.178 ([65.194.124.178] helo=cassoulet.panasas.com)\n by ASSP-nospam;
1 Feb 2006 01:31:09 -0800\nReceived: from ASSP-nospam (localhost.localdomain
[127.0.0.1])\n by cassoulet.panasas.com (8.12.10/8.12.10) with ESMTP id
k118sMbn018916\n for <[EMAIL PROTECTED]>; Wed, 1 Feb 2006 03:54:22
-0500\nReceived: from 172.17.133.23 ([172.17.133.23] helo=pocono.panasas.com)\n
by ASSP-nospam ; 1 Feb 06 08:54:22 -0000\nReceived: by
exchange.ca.panasas.com\n with Internet Mail Service (5.5.2653.19) id
<C7AWFG23>;\n Wed, 1 Feb 2006 00:54:22 -0800\nMessage-ID: <[EMAIL
PROTECTED]>\nFrom: \"Stilts,
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmail-message.c,dbmail_message_store:
allocating [524288] bytes of memory for readblock
Feb 1 01:31:09 mail dbmail/smtp[2275]: pipe.c,store_message_in_blocks:
inserting message:
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_messageblks (is_header, messageblk,blocksize,
physmessage_id) VALUES ('0','\n', '1', '198798')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51',
status = '0' WHERE message_idnr = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[UPDATE dbmail_physmessage SET messagesize = '1273', rfcsize = '1302' WHERE id
= '198798']
Feb 1 01:31:09 mail dbmail/smtp[2275]: 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 = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: db.c,db_add_quotum_used: adding 1273 to
mailsize
Feb 1 01:31:09 mail dbmail/smtp[2275]: db.c.user_idnr_is_delivery_user_idnr:
looking up user_idnr for [EMAIL PROTECTED]@__
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Content-Type']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (19,198798,'text/plain')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Received']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198798,'from cassoulet.panasas.com (localhost [127.0.0.1]) by
mail.allmopars.com (Postfix) with ESMTP id 4D66A272E2 for <[EMAIL
PROTECTED]>; Wed, 1 Feb 2006 01:31:09 -0800 (PST)')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198798,'from 65.194.124.178 ([65.194.124.178]
helo=cassoulet.panasas.com) by ASSP-nospam; 1 Feb 2006 01:31:09 -0800')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198798,'from ASSP-nospam (localhost.localdomain [127.0.0.1]) by
cassoulet.panasas.com (8.12.10/8.12.10) with ESMTP id k118sMbn018916 for
<[EMAIL PROTECTED]>; Wed, 1 Feb 2006 03:54:22 -0500')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198798,'from 172.17.133.23 ([172.17.133.23] helo=pocono.panasas.com)
by ASSP-nospam ; 1 Feb 06 08:54:22 -0000')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (3,198798,'by exchange.ca.panasas.com with Internet Mail Service
(5.5.2653.19) id <C7AWFG23>; Wed, 1 Feb 2006 00:54:22 -0800')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Message-ID']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (9,198798,'<[EMAIL PROTECTED]>')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='From']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (4,198798,'\"Stilts, Dan\" <[EMAIL PROTECTED]>')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='To']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (5,198798,'\"\'Dan Stilts\'\" <[EMAIL PROTECTED]>')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Subject']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (6,198798,'test')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Date']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (7,198798,'Wed, 1 Feb 2006 00:54:21 -0800')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Mailer']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (8,198798,'Internet Mail Service (5.5.2653.19)')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Delay']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (469,198798,'not delayed (whitelisted); 1 Feb 2006 01:31:09 -0800')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Spam-Prob']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (144,198798,'0.00000')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Whitelisted']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (473,198798,'Yes')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-Assp-Envelope-From']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (470,198798,'[EMAIL PROTECTED]')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='Return-Path']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (1,198798,'[EMAIL PROTECTED]')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT id FROM dbmail_headername WHERE headername='X-DBMail-PhysMessage-ID']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_headervalue (headername_id, physmessage_id, headervalue)
VALUES (275,198798,'198798')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_tofield (physmessage_id, toname, toaddr) VALUES
(198798,'\'Dan Stilts\'','[EMAIL PROTECTED]')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_fromfield (physmessage_id, fromname, fromaddr) VALUES
(198798,'Stilts, Dan','[EMAIL PROTECTED]')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_datefield (physmessage_id, datefield) VALUES
(198798,'2006-02-01 08:54:21')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[INSERT INTO dbmail_subjectfield (physmessage_id, subjectfield) VALUES
(198798,'test')]
Feb 1 01:31:09 mail dbmail/smtp[2275]: pipe.c, insert_messages: temporary
msgidnr is [359841]
Feb 1 01:31:09 mail dbmail/smtp[2275]: pipe.c, insert_messages: calling
sort_and_deliver for useridnr [3]
Feb 1 01:31:09 mail dbmail/smtp[2275]: pipe.c, insert_messages: successful
sort_and_deliver for useridnr [3]
Feb 1 01:31:09 mail dbmail/smtp[2275]: pipe.c,insert_messages: deliver [0]
messages to external addresses
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messages WHERE message_idnr = '359841']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '198798']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_physmessage WHERE id = '198798']
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[DELETE FROM dbmail_messageblks WHERE physmessage_id = '198798']
Feb 1 01:31:09 mail dbmail/smtp[2275]: pipe.c,insert_messages: temporary
message deleted from database. Done.
Feb 1 01:31:09 mail dbmail/smtp[2275]: dbmysql.c,db_query: executing query
[COMMIT]
Feb 1 01:31:09 mail dbmail/smtp[2275]: main(): freeing dsnuser list
Feb 1 01:31:09 mail dbmail/smtp[2275]: dsn.c, dsnuser_free: dsnuser freed
Feb 1 01:31:09 mail dbmail/smtp[2275]: main(): freeing all other lists
Feb 1 01:31:09 mail dbmail/smtp[2275]: main(): they're all free. we're done.
Feb 1 01:31:09 mail dbmail/smtp[2275]: main(): exit code is [0].
Feb 1 01:31:09 mail postfix/pipe[2253]: 4D66A272E2: to=<[EMAIL PROTECTED]>,
relay=dbmail-smtp, delay=0, status=sent (allmopars.com)
Feb 1 01:31:09 mail postfix/qmgr[1820]: 4D66A272E2: removed