Paul J Stevens wrote:


Dan Stilts wrote:

Hey Guys;

Just wanted to let you know what else I just found after doing the latest cvs checkout dbmail...

When I install it in place with the same configuration as before, the message is now getting some extra weirdness, and no body text is displayed

X-Invalid-Header: X-Invalid-Header: <message body line 1>
X-Invalid-Header: <message body line 2>
X-Invalid-Header: <message body line 3>
...and so on.



This did happen for a very brief period last week. I thought I could convert incoming messages LF->CRLF before actually parsing them with gmime. The output you show told me that gmime didn't really like CRLF very much in parsing messages. So this was fixed immediately. Are you sure you're using cvs as of today or even yesterday?

I've been running 2.1-cvs and it's been behaving nicely. There was a small issue with NAMESPACE when I refactored _ic_list yesterday (factor 3 speedup), but that's been resolved also.


Hi Paul,

I just now did another cvs checkout dbmail and the same problem exists...attached is a TRACE=5 on SMTP. Any ideas?

Thanks,
Dan


Oct 13 01:17:48 ded3 postfix/smtpd[8466]: connect from 
adsl-67-117-138-190.dsl.snfc21.pacbell.net[67.117.138.190]
Oct 13 01:17:48 ded3 postfix/smtpd[8466]: 87386289986: 
client=adsl-67-117-138-190.dsl.snfc21.pacbell.net[67.117.138.190]
Oct 13 01:17:48 ded3 postfix/cleanup[8470]: 87386289986: message-id=<[EMAIL 
PROTECTED]>
Oct 13 01:17:48 ded3 postfix/qmgr[8464]: 87386289986: from=<[EMAIL PROTECTED]>, 
size=637, nrcpt=1 (queue active)
Oct 13 01:17:48 ded3 spamd[779]: connection from localhost [127.0.0.1] at port 
45554 
Oct 13 01:17:48 ded3 postfix/smtpd[8466]: disconnect from 
adsl-67-117-138-190.dsl.snfc21.pacbell.net[67.117.138.190]
Oct 13 01:17:48 ded3 spamd[8473]: info: setuid to dbmail succeeded 
Oct 13 01:17:48 ded3 spamd[8473]: Creating default_prefs 
[/dev/null/.spamassassin/user_prefs] 
Oct 13 01:17:48 ded3 spamd[8473]: Cannot write to 
/dev/null/.spamassassin/user_prefs: Not a directory 
Oct 13 01:17:48 ded3 spamd[8473]: Couldn't create readable default_prefs for 
[/dev/null/.spamassassin/user_prefs] 
Oct 13 01:17:48 ded3 spamd[8473]: processing message <[EMAIL PROTECTED]> for 
dbmail:105. 
Oct 13 01:17:48 ded3 dbmail/imap4d[8317]: PerformChildTask(): incoming 
connection from [67.117.138.190 (adsl-67-117-138-190.dsl.snfc21.pacbell.net)]
Oct 13 01:17:48 ded3 dbmail/imap4d[8317]: IMAPD [PID 8317]: user (id 3, name 
dstilts) login accepted @ 2004-10-13 01:17:48
Oct 13 01:17:49 ded3 spamd[8473]: clean message (0.0/5.0) for dbmail:105 in 0.5 
seconds, 619 bytes. 
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [host]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): found value 
[localhost]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [db]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): found value [dbmail]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [user]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): found value [dbmail]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [pass]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): found value 
[password_stripped]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [sqlport]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [sqlsocket]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [table_prefix]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: 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 13 01:17:49 ded3 dbmail/smtp[8472]: mime_readheader(): entering mime loop
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: mime_readheader(): mimeloop finished 
Oct 13 01:17:49 ded3 dbmail/smtp[8472]:  *** mime_readheader() done *** 
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: checking 
user [EMAIL PROTECTED] in alias table
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: checks 
[-1]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT deliver_to FROM dbmail_aliases WHERE lower(alias) = lower('[EMAIL 
PROTECTED]')]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: into 
checking loop
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: checking 
user [EMAIL PROTECTED] to !/usr/bin/procmail 
/etc/procmail_users/dstilts.procmailrc
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: checking 
user [!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc] in alias table
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: checks 
[1]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: 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 13 01:17:49 ded3 dbmail/smtp[8472]: authsql.c,auth_check_user_ext: adding 
[!/usr/bin/procmail /etc/procmail_users/dstilts.procmailrc] to deliver_to 
address
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dsn.c, dsnuser_resolve: user [EMAIL 
PROTECTED] found total of [1] aliases
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[BEGIN]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: misc.c,create_unique_id: created: 
701816680e98e05978e5c6bf568afa51
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND 
owner_idnr='1']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c, db_find_create_mailbox: mailbox 
[INBOX] found
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0', 
CURRENT_TIMESTAMP)]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id, 
unique_id,recent_flag, status) VALUES ('5', '47117', 
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_messageblks(is_header, messageblk,blocksize, 
physmessage_id)VALUES ('1','Received: from [192.168.1.62] 
(adsl-67-117-138-190.dsl.snfc21.pacbell.net [67.117.138.190])^I^I\n^Iby 
imap.allmopars.com (Postfix) with ESMTP id 87386289986^I^I\n^Ifor <[EMAIL 
PROTECTED]>; Wed, 13 Oct 2004 01:17:48 -0700 (PDT)\nMessage-ID: <[EMAIL 
PROTECTED]>\nDate: Wed, 13 Oct 2004 01:18:13 -0700\nFrom: Dan <[EMAIL 
PROTECTED]>\nUser-Agent: Mozilla Thunderbird 0.8 
(Windows/20040913)\nX-Accept-Language: en-us, en\nTo: [EMAIL PROTECTED]: 
test\nX-Spam-Checker-Version: SpamAssassin 2.63 (2004-01-11) on 
ded3.netdojo.com\nX-Spam-Level: \nX-Spam-Status: No, hits=0.0 required=5.0 
tests=none autolearn=no\n^Iversion=2.63\nMIME-Version: 1.0\nContent-Type: 
text/plain; charset=ISO-8859-1; format=flowed\nContent-Transfer-Encoding: 
7bit\n', '743', '47117')]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: store_message_temp(): allocating 
[524288] bytes of memory for readblock
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: pipe.c,store_message_in_blocks: 
inserting message:  line 1 line 2 line 3 Let's see if this works... 
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_messageblks(is_header, messageblk,blocksize, 
physmessage_id)VALUES ('0','\nline 1\nline 2\nline 3\nLet\'s see if this 
works...\n', '49', '47117')]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51', 
status = '0' WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[UPDATE dbmail_physmessage SET messagesize = '792', rfcsize = '814' WHERE id = 
'47117']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: 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 = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c,db_add_quotum_used: adding 792 to 
mailsize
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c.user_idnr_is_delivery_user_idnr: 
looking up user_idnr for [EMAIL PROTECTED]@__
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: pipe.c, insert_messages: temporary 
msgidnr is [76345]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: insert_messages(): we need to deliver 
[1] messages to external addresses
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: insert_messages(): delivering to 
external addresses
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): searching value for 
config item [SENDMAIL]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: GetConfigValue(): found value 
[/usr/sbin/sendmail]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: delivering to [1] 
external addresses
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: opening pipe to 
command /usr/bin/procmail /etc/procmail_users/dstilts.procmailrc
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: call to popen() 
successfully opened pipe [6]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: appending mbox style 
from header to pipe returnpath : [EMAIL PROTECTED]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: sending message id 
number [76345] to forward pipe
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: ferror reports 0, 
feof reports 0 on pipe 6
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: sending lines from 
message 76345 on pipe 6
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c,db_send_message_lines: request for 
[-2] lines
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c,db_send_message_lines: executing 
query [SELECT messageblk FROM dbmail_messageblks WHERE physmessage_id='47117' 
ORDER BY messageblk_idnr ASC]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT messageblk FROM dbmail_messageblks WHERE physmessage_id='47117' ORDER 
BY messageblk_idnr ASC]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c,db_send_message_lines: sending 
[-2] lines from message [76345]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c,db_send_message_lines: getting 
nextblock [1] 
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: db.c,db_send_message_lines: getting 
nextblock [2] 
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: closing pipes
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [host]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): found value 
[localhost]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [db]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): found value [dbmail]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [user]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): found value [dbmail]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [pass]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): found value 
[password_stripped]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [sqlport]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [sqlsocket]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [table_prefix]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): NULL item  value in 
item-list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: 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 13 01:17:49 ded3 dbmail/smtp[8477]: mime_readheader(): entering mime loop
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mime_readheader(): mimeloop finished 
Oct 13 01:17:49 ded3 dbmail/smtp[8477]:  *** mime_readheader() done *** 
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): mimelist currently has 
[20] nodes
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): mail address parser 
starting
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): total fields in header 
20
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): scanning for 
Return-Path
Oct 13 01:17:49 ded3 last message repeated 19 times
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): found 0 emailaddresses
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): mail address parser 
finished
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): mimelist currently has 
[20] nodes
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): mail address parser 
starting
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): total fields in header 
20
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): scanning for From
Oct 13 01:17:49 ded3 last message repeated 15 times
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): found [EMAIL 
PROTECTED], next in list is <null>
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): scanning for From
Oct 13 01:17:49 ded3 last message repeated 3 times
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): found 1 emailaddresses
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: mail_adr_list(): mail address parser 
finished
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: main(): setting mailbox for all 
deliveries to [INBOX]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT user_idnr FROM dbmail_users WHERE userid='dstilts']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dsn.c, dsnuser_resolve: added user 
[dstilts] id [3] to delivery list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[BEGIN]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: misc.c,create_unique_id: created: 
701816680e98e05978e5c6bf568afa51
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND 
owner_idnr='1']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: db.c, db_find_create_mailbox: mailbox 
[INBOX] found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_physmessage (messagesize, internal_date) VALUES ('0', 
CURRENT_TIMESTAMP)]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_messages(mailbox_idnr, physmessage_id, 
unique_id,recent_flag, status) VALUES ('5', '47118', 
'701816680e98e05978e5c6bf568afa51', '1', '5')]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_messageblks(is_header, messageblk,blocksize, 
physmessage_id)VALUES ('1','From [EMAIL PROTECTED]  Wed Oct 13 01: 17:49 
2004\nReceived: from [192.168.1.62] (adsl-67-117-138-190.dsl.snfc21.pacbell.net 
[67.117.138.190])^I^I\r^I^I\n^Iby imap.allmopars.com (Postfix) with ESMTP id 
87386289986^I^I\r^I^I\n^Ifor <[EMAIL PROTECTED]>; Wed, 13 Oct 2004 01:17:48 
-0700 (PDT)\nMessage-ID: <[EMAIL PROTECTED]>\nDate: Wed, 13 Oct 2004 01:18:13 
-0700\nFrom: Dan <[EMAIL PROTECTED]>\nUser-Agent: Mozilla Thunderbird 0.8 
(Windows/20040913)\nX-Accept-Language: en-us, en\nTo: [EMAIL PROTECTED]: 
test\nX-Spam-Checker-Version: SpamAssassin 2.63 (2004-01-11) on 
ded3.netdojo.com\nX-Spam-Level: \nX-Spam-Status: No, hits=0.0 required=5.0 
tests=none autolearn=no\r\n^Iversion=2.63\nX-Invalid-Header: 
\nX-Invalid-Header: line 1\nX-Invalid-Header: line 2\nX-Invalid-Header: line 
3\nX-Invalid-Header: Let\'s see if this
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: store_message_temp(): allocating 
[524288] bytes of memory for readblock
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: pipe.c,store_message_in_blocks: 
inserting message:  
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[INSERT INTO dbmail_messageblks(is_header, messageblk,blocksize, 
physmessage_id)VALUES ('0','\n', '1', '47118')]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[UPDATE dbmail_messages SET unique_id = '701816680e98e05978e5c6bf568afa51', 
status = '0' WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[UPDATE dbmail_physmessage SET messagesize = '944', rfcsize = '967' WHERE id = 
'47118']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: 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 = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: db.c,db_add_quotum_used: adding 944 to 
mailsize
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: db.c.user_idnr_is_delivery_user_idnr: 
looking up user_idnr for [EMAIL PROTECTED]@__
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT user_idnr FROM dbmail_users WHERE userid='[EMAIL PROTECTED]@__']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: pipe.c, insert_messages: temporary 
msgidnr is [76346]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: pipe.c, insert_messages: calling 
sort_and_deliver for useridnr [3]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [SQLREGEX]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [LIBSIEVE]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): item not found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT mailbox_idnr FROM dbmail_mailboxes WHERE name='INBOX' AND 
owner_idnr='3']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: db.c, db_find_create_mailbox: mailbox 
[INBOX] found
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: 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 = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT 1 FROM dbmail_users WHERE user_idnr = '3' AND (maxmail_size > 0) AND 
(curmail_size + '944' > maxmail_size)]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: misc.c,create_unique_id: created: 
f6186e830174307051888d8e35c7f144
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: 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, 'f6186e830174307051888d8e35c7f144', 
status FROM dbmail_messages WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: db.c,db_add_quotum_used: adding 944 to 
mailsize
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: db.c.user_idnr_is_delivery_user_idnr: 
no need to look up user_idnr for [EMAIL PROTECTED]@__
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[UPDATE dbmail_users SET curmail_size = curmail_size + '944' WHERE user_idnr = 
'3']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: sort.c, sort_and_deliver: message 
id=76347, size=944 is inserted
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: pipe.c, insert_messages: successful 
sort_and_deliver for useridnr [3]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [AUTO_NOTIFY]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): found value [no]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): searching value for 
config item [AUTO_REPLY]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: GetConfigValue(): found value [no]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: insert_messages(): we need to deliver 
[0] messages to external addresses
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[DELETE FROM dbmail_messages WHERE message_idnr = '76346']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '47118']
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: insert_messages(): temporary message 
deleted from database
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: insert_messages(): End of function
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dbmysql.c,db_query: executing query 
[COMMIT]
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: main(): freeing dsnuser list
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: dsn.c, dsnuser_free: dsnuser freed
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: main(): freeing all other lists
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: main(): freeing memory blocks
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: main(): they're all free. we're done.
Oct 13 01:17:49 ded3 dbmail/smtp[8477]: main(): exit code is [0].
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: forward.c,forward: pipe closed
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT physmessage_id FROM dbmail_messages WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[DELETE FROM dbmail_messages WHERE message_idnr = '76345']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[SELECT message_idnr FROM dbmail_messages WHERE physmessage_id = '47117']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[DELETE FROM dbmail_physmessage WHERE id = '47117']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[DELETE FROM dbmail_messageblks WHERE physmessage_id = '47117']
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: insert_messages(): temporary message 
deleted from database
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: insert_messages(): End of function
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dbmysql.c,db_query: executing query 
[COMMIT]
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: main(): freeing dsnuser list
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: dsn.c, dsnuser_free: dsnuser freed
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: main(): freeing all other lists
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: main(): freeing memory blocks
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: main(): they're all free. we're done.
Oct 13 01:17:49 ded3 dbmail/smtp[8472]: main(): exit code is [0].
Oct 13 01:17:49 ded3 postfix/pipe[8471]: 87386289986: to=<[EMAIL PROTECTED]>, 
relay=dbmail-smtp, delay=1, status=sent (allmopars.com)
Oct 13 01:17:49 ded3 postfix/qmgr[8464]: 87386289986: removed

Reply via email to