Home.... | log in.... | Pub my question! | Sign-up....
Java-index >> E-Mail, Calendar, & Collaboration >> Sun Java System Messaging Server

CPU load due to reprocess

Sun Java(tm) System Messaging Server 6.2-3.04 (built Jul 15 2005)

libimta.so 6.2-3.04 (built 01:32:55, Jul 15 2005)

SunOS nemrut 5.10 Generic_118855-19 i86pc i386 i86pc

I have been observing two processes called "reprocess" in the top list, which are consuming too much CPU - around 23% of CPU load per "reprocess".

As background information, I am using amavisd-new and spamassassin with a configured tcp-scan channel.

So, is that high load coming from reprocesses normal? What is that reprocess for? is there a way to increase the performance?

Thanks,

Rami

[607 byte] By [ramia] at [2007-11-26 16:35:36]
«« The TinyLine 2D 1.11 for CLDC/MIDP2.0, CDC/Personal Profile and J2SE
»» Training
# 1

Reprocess is where messages that cannot be dealt with immediately are sent, specifically, messages such as:

addressed to a mailing list, set for deferred processing

messages that are fragmented (you'll also see a defrag process)

No, it's not normal to see reprocess using a lot of cpu.

There was also a bug that I believe is post your version. I'd pull the current version of 118207, and install it.

jay_plesseta at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 2
Is that new version for Solaris 10?Thanks,Rami
ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 3
All current Messaging 6.2 versions will run on Solaris 8, 9 or 10.If you're using Intel/Solaris, you need a different patch, of course.
jay_plesseta at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 4

Hi Jay,

I noticed a number of following messages waiting in the process queue, all of which destined to postmaster@hostname.domain.com . According to the failure reason, postmaster@hostname.domain.com is an illegal email address. I tried to send an email to postmaster@domain.com (without the hostname), it worked. And I also checked ldap entry for Postmaster account, and I did not see any double postmaster. I also tried to delete and readd postmaster couple of times, but it did not help.

Can you tell why it is not delivering to postmaster@hostname.domain.com.

thanks,

Rami

ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 5

First, do you have any clue where these are coming from? Messaging Server itself shouldn't be sending postmaster mails that aren't addressed correctly.

Second, "a number" is how many? 3? 300,000? Makes a difference. . .

You can certainly add a "mailalternateaddress" of "postmaster@hostname.domain.com", and that should allow these to be delivered.

Why isn't it being delivered? Because the mail address is "postmaster@domain", not "postmaster@host.domain" Why should it be delivered? Messaging Server doesn't use the "hostname.domain" form to route messages.

jay_plesseta at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 6

These messages are coming from the messaging server itself to report failure reports for the outbound messages. This is the first day of our new server, and there are 71 messages in the process queue reporting postmaster@local-host.domain.com is "unknown or illegal user", and that count continuously goes up. My observation is that "reprocess" processes those message indefinitely, and tries to deliver them, then fails with that "unknown or illegal user" reason, and puts them back to process queue again with some new header, which causes an increase in the message sizes of those in the process queue each time.

ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 7
After the explanation in my previous post, my question is, how can I make my messaging server send to (or report to) postmaster@domain.com, instead of postmaster@local-host.doamin.com?thanks,Rami
ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 8
You can certainly add a "mailalternateaddress" of "postmaster@hostname.domain.com", and that should allow these to be delivered.
jay_plesseta at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 9
I did add a "mailalternateaddress" of "postmaster@hostname.domain.com", but it did not help. The messages are still in the process queue with the same failure. I even also tries to send and email to "postmaster@hostname.domain.com", and it was rejected by the server. Any comment!
ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 10

Hi Jay,

I got the following debug output for that. Can you have a look at tit if it helps?

Host name: nemrut

domain name: salescentrix.com

nemrut# imsimta test -rewrite -debug postmaster@nemrut.salescentrix.com

Initializing mm_.

Initializing mm_ submission.

Checking identifiers.

*** Debug output from initializing MM for submission:

14:58:26.30: Debug output enabled, message enqueue routines version V6.2-3.04 compiled Jul 15 200501:33:07

14:58:26.30: mmc_winit('l','postmaster@nemrut.salescentrix.com','0JCN00402JTEXP00@nemrut.sal escentrix.com') called.

14:58:26.30: Queue area size 125496800, temp area size 722786

14:58:26.30:31374200 blocks of effective free queue space available; setting disk limit accordingly.

14:58:26.30:361393 blocks of free temporary space available; setting disk limit accordingly.

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.30: Rewrite: "$*", position 0, hash table -

14:58:26.30:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.30:Rewrite failed, not forward.

14:58:26.30: Rewrite: "$*", position 1, hash table -

14:58:26.30:Failed.

14:58:26.30: Rewrite: "$*", position 0, rewrite database -

14:58:26.30:Failed

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.30: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.30:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.30:New mailbox: "postmaster".

14:58:26.30:New host: "nemrut.salescentrix.com".

14:58:26.30:New route: "nemrut.salescentrix.com".

14:58:26.30:New channel system: "nemrut.salescentrix.com".

14:58:26.30: Looking up host "nemrut.salescentrix.com".

14:58:26.30:- found on channel l

14:58:26.30: Routelocal flag set; scanning for % and !

14:58:26.30:Checking reverse URL cache for: postmaster@nemrut.salescentrix.com

14:58:26.30:Applying reverse URL pattern ldap:///$V?$N?sub?$R to: postmaster@nemrut.salescentrix.com

14:58:26.30:URL generation failed, status = 0

14:58:26.30:Mapped return address: postmaster@nemrut.salescentrix.com

14:58:26.30:from_access mapping check: ||MAIL|l|postmaster@nemrut.salescentrix.com|

14:58:26.30:- passed.

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.30: Rewrite: "$*", position 0, hash table -

14:58:26.30:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.30:Rewrite failed, not forward.

14:58:26.30: Rewrite: "$*", position 1, hash table -

14:58:26.30:Failed.

14:58:26.30: Rewrite: "$*", position 0, rewrite database -

14:58:26.30:Failed

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.30: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.30:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.30:New mailbox: "postmaster".

14:58:26.30:New host: "nemrut.salescentrix.com".

14:58:26.30:New route: "nemrut.salescentrix.com".

14:58:26.30:New channel system: "nemrut.salescentrix.com".

14:58:26.30: Looking up host "nemrut.salescentrix.com".

14:58:26.30:- found on channel l

14:58:26.30: Routelocal flag set; scanning for % and !

***

*** Debug output from rewriting a forward header address:

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.30: Rewrite: "$*", position 0, hash table -

14:58:26.30:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.30:Rewrite failed, not envelope.

14:58:26.30: Rewrite: "$*", position 1, hash table -

14:58:26.30:Failed.

14:58:26.30: Rewrite: "$*", position 0, rewrite database -

14:58:26.30:Failed

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.30: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.30:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.30:New mailbox: "postmaster".

14:58:26.30:New host: "nemrut.salescentrix.com".

14:58:26.30:New route: "nemrut.salescentrix.com".

14:58:26.30:New channel system: "nemrut.salescentrix.com".

14:58:26.30: Looking up host "nemrut.salescentrix.com".

14:58:26.30:- found on channel l

14:58:26.30: Routelocal flag set; scanning for % and !

14:58:26.30:Rewrite rules result: postmaster@nemrut.salescentrix.com

14:58:26.30:Checking reverse URL cache for: postmaster@nemrut.salescentrix.com

14:58:26.30:Applying reverse URL pattern ldap:///$V?$N?sub?$R to: postmaster@nemrut.salescentrix.com

14:58:26.30:URL generation failed, status = 0

***

*** Debug output from rewriting a forward envelope address:

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.30: Rewrite: "$*", position 0, hash table -

14:58:26.30:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.30:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

14:58:26.30:old state = not checked.

14:58:26.30:Domain check on nemrut.salescentrix.com.

14:58:26.30:new state = fail pending.

14:58:26.30:Rewrite failed due to prechannel mismatch.

14:58:26.30: Rewrite: "$*", position 1, hash table -

14:58:26.30:Failed.

14:58:26.30: Rewrite: "$*", position 0, rewrite database -

14:58:26.30:Failed

14:58:26.30: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.30: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.30:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.30:New mailbox: "postmaster".

14:58:26.30:New host: "nemrut.salescentrix.com".

14:58:26.30:New route: "nemrut.salescentrix.com".

14:58:26.30:New channel system: "nemrut.salescentrix.com".

14:58:26.30: Looking up host "nemrut.salescentrix.com".

14:58:26.30:- found on channel l

14:58:26.30: Routelocal flag set; scanning for % and !

***

forward channel= l

channel description=

channel user filter=

dest channel filter=

source channel filter =

channel flags #0= BIDIRECTIONAL MULTIPLE IMMNORMAL NOSERVICEALL

channel flags #1= NOSMTP DEFAULT

channel flags #2= POSTHEADBODY HEADERINC NOEXPROUTE

channel flags #3= NOLOGGING NOGREY NORESTRICTED RETAINSECURITYMULTIPARTS

channel flags #4= EIGHTBIT NOHEADERTRIM NOHEADERREAD RULES

channel flags #5=

channel flags #6= LOCALUSER REPORTNOTARY

channel flags #7= ALLOWSWITCHCHANNEL NOREMOTEHOST DATEFOUR DAYOFWEEK

channel flags #8= NODEFRAGMENT EXQUOTA REVERSE NOCONVERT_OCTET_STREAM

channel flags #9= NOTHURMAN INTERPRETENCODING USEINTERMEDIATE RECEIVEDFROM VALIDATELOCALSYSTEM NOTURN

linelength = 1023

channel env addr type = SOURCEROUTE

channel hdr addr type = SOURCEROUTE

channel official host = nemrut.salescentrix.com

channel queue 0 name= LOCAL_POOL

channel queue 1 name= LOCAL_POOL

channel queue 2 name= LOCAL_POOL

channel queue 3 name= LOCAL_POOL

channel after params=

channel user name=

urgentnotices =

normalnotices =

nonurgentnotices=

channel rightslist ids =

local behavior flags= %x7

expandchannel =

notificationchannel=

dispositionchannel=

saslswitchchannel=

tlsswitchchannel=

backward channel= l

header To: address= postmaster@nemrut.salescentrix.com

header From: address= postmaster@nemrut.salescentrix.com

envelope To: address= postmaster@nemrut.salescentrix.com (route (nemrut.salescentrix.com,nemrut.salescentrix.com)) (host nemrut.salescentrix.com)

envelope From: address = postmaster@nemrut.salescentrix.com

name=

mbox= postmaster

Extracted address action list:

postmaster@nemrut.salescentrix.com

Extracted 733 address action list:

postmaster@nemrut.salescentrix.com

Address list expansion:

*** Debug output from alias expansion:

14:58:26.33: Inner expand, level = 0, mailbox = postmaster@nemrut.salescentrix.com

14:58:26.33: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.33: Rewrite: "$*", position 0, hash table -

14:58:26.33:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.33:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

14:58:26.33:old state = not checked.

14:58:26.33:Domain check on nemrut.salescentrix.com.

14:58:26.33:new state = fail pending.

14:58:26.33:Rewrite failed due to prechannel mismatch.

14:58:26.33: Rewrite: "$*", position 1, hash table -

14:58:26.33:Failed.

14:58:26.33: Rewrite: "$*", position 0, rewrite database -

14:58:26.33:Failed

14:58:26.33: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.33: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.33:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.33:New mailbox: "postmaster".

14:58:26.33:New host: "nemrut.salescentrix.com".

14:58:26.33:New route: "nemrut.salescentrix.com".

14:58:26.33:New channel system: "nemrut.salescentrix.com".

14:58:26.33: Looking up host "nemrut.salescentrix.com".

14:58:26.33:- found on channel l

14:58:26.33: Routelocal flag set; scanning for % and !

14:58:26.33:Reparsed mailbox: postmaster

14:58:26.33:Reparsed host: nemrut.salescentrix.com

14:58:26.34:Variant #1 = postmaster@nemrut.salescentrix.com

14:58:26.34:Variant #2 = *@nemrut.salescentrix.com

14:58:26.34:Variant #3 = postmaster

14:58:26.34:Initial pool address: postmast

14:58:26.34: Inner expand, level = 1, mailbox = postmast

14:58:26.34: Rewriting: Mbox = "postmast", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.34: Rewrite: "$*", position 0, hash table -

14:58:26.34:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.34:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

14:58:26.34:old state = not checked.

14:58:26.34:Domain check on nemrut.salescentrix.com.

14:58:26.34:new state = fail pending.

14:58:26.34:Rewrite failed due to prechannel mismatch.

14:58:26.34: Rewrite: "$*", position 1, hash table -

14:58:26.34:Failed.

14:58:26.34: Rewrite: "$*", position 0, rewrite database -

14:58:26.34:Failed

14:58:26.34: Rewriting: Mbox = "postmast", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.34: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.34:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.34:New mailbox: "postmast".

14:58:26.34:New host: "nemrut.salescentrix.com".

14:58:26.34:New route: "nemrut.salescentrix.com".

14:58:26.34:New channel system: "nemrut.salescentrix.com".

14:58:26.34: Looking up host "nemrut.salescentrix.com".

14:58:26.34:- found on channel l

14:58:26.34: Routelocal flag set; scanning for % and !

14:58:26.34:Reparsed mailbox: postmast

14:58:26.34:Reparsed host: nemrut.salescentrix.com

14:58:26.34:Variant #1 = postmast@nemrut.salescentrix.com

14:58:26.34:Variant #2 = *@nemrut.salescentrix.com

14:58:26.34:Variant #3 = postmast

14:58:26.34:LDAP URL template identified

14:58:26.34:Error 0 determining URL from template ldap:///$V?*?sub?$R

postmast@nemrut.salescentrix.com

***

1 expansion total.

*** Debug output from submitting an envelope address:

14:58:26.34: mmc_wadr(0x08573b70,'postmaster@nemrut.salescentrix.com','postmaster@nemrut.sal escentrix.com') called.

14:58:26.35: Copy estimate before address addition is 1

14:58:26.35:Parsing address postmaster@nemrut.salescentrix.com

14:58:26.35: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.35: Rewrite: "$*", position 0, hash table -

14:58:26.35:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.35:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

14:58:26.35:old state = not checked.

14:58:26.35:Domain check on nemrut.salescentrix.com.

14:58:26.35:new state = fail pending.

14:58:26.35:Rewrite failed due to prechannel mismatch.

14:58:26.35: Rewrite: "$*", position 1, hash table -

14:58:26.35:Failed.

14:58:26.35: Rewrite: "$*", position 0, rewrite database -

14:58:26.35:Failed

14:58:26.35: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.35: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.35:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.35:New mailbox: "postmaster".

14:58:26.35:New host: "nemrut.salescentrix.com".

14:58:26.35:New route: "nemrut.salescentrix.com".

14:58:26.35:New channel system: "nemrut.salescentrix.com".

14:58:26.35: Looking up host "nemrut.salescentrix.com".

14:58:26.35:- found on channel l

14:58:26.35: Routelocal flag set; scanning for % and !

14:58:26.35:Address postmaster@nemrut.salescentrix.com requires local processing.

14:58:26.35:Variant #1 = postmaster@nemrut.salescentrix.com

14:58:26.35:Variant #2 = *@nemrut.salescentrix.com

14:58:26.35:Variant #3 = postmaster

14:58:26.35:Checking for postmaster@nemrut.salescentrix.com in the system alias file

14:58:26.35:- system alias file match for postmaster@nemrut.salescentrix.com

14:58:26.35:Initial pool address: postmast

14:58:26.35:- postmast

14:58:26.35:Parsing address postmast

14:58:26.35: Rewriting: Mbox = "postmast", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.35: Rewrite: "$*", position 0, hash table -

14:58:26.35:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.35:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

14:58:26.35:old state = not checked.

14:58:26.35:Domain check on nemrut.salescentrix.com.

14:58:26.35:new state = fail pending.

14:58:26.35:Rewrite failed due to prechannel mismatch.

14:58:26.35: Rewrite: "$*", position 1, hash table -

14:58:26.35:Failed.

14:58:26.35: Rewrite: "$*", position 0, rewrite database -

14:58:26.35:Failed

14:58:26.35: Rewriting: Mbox = "postmast", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

14:58:26.35: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

14:58:26.35:Found: "$U%$D@nemrut.salescentrix.com"

14:58:26.35:New mailbox: "postmast".

14:58:26.35:New host: "nemrut.salescentrix.com".

14:58:26.35:New route: "nemrut.salescentrix.com".

14:58:26.35:New channel system: "nemrut.salescentrix.com".

14:58:26.35: Looking up host "nemrut.salescentrix.com".

14:58:26.35:- found on channel l

14:58:26.35: Routelocal flag set; scanning for % and !

14:58:26.35:Address postmast@nemrut.salescentrix.com requires local processing.

14:58:26.35:Variant #1 = postmast@nemrut.salescentrix.com

14:58:26.35:Variant #2 = *@nemrut.salescentrix.com

14:58:26.35:Variant #3 = postmast

14:58:26.35:Checking for postmast@nemrut.salescentrix.com in the system alias file

14:58:26.35: - not found

14:58:26.35:Checking for *@nemrut.salescentrix.com in the system alias file

14:58:26.35: - not found

14:58:26.35:Checking for postmast in the system alias file

14:58:26.35: - not found

14:58:26.35:Checking postmast@nemrut.salescentrix.com with URL template ldap:///$V?*?sub?$R

14:58:26.35:LDAP URL template identified

14:58:26.36:Error 0 determining URL from template ldap:///$V?*?sub?$R

14:58:26.36: - orig_send_access mapping check: l|postmaster@nemrut.salescentrix.com|l|postmaster@nemrut.salescentrix.com

14:58:26.36:- passed.

14:58:26.36: - send_access mapping check: l|postmaster@nemrut.salescentrix.com|l|postmast@nemrut.salescentrix.com

14:58:26.36:- passed.

14:58:26.36: - user postmast unknown.

14:58:26.36: mmc_wnadr(0x08573b70,'postmaster@nemrut.salescentrix.com','postmast@nemrut.sale scentrix.com') called.

14:58:26.36:Cancelling DSNs that were created

14:58:26.36:- adding address postmaster@nemrut.salescentrix.com to headers.

14:58:26.36: Copy estimate after address addition is 1

14:58:26.36: Cancelling DSNs that were created***

Expanded address:

postmaster@nemrut.salescentrix.com

Submitted address list:

Address list error -- 5.1.1 unknown or illegal user: postmaster@nemrut.salescentrix.com

Submitted notifications list:

ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 11
"postmast" does not equal "postmaster"Please try again with correct spelling.jay
jay_plesseta at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 12
I typed it correctly. If you look at the very begining of the debug output, it reads like the following:nemrut# imsimta test -rewrite -debug postmaster@nemrut.salescentrix.comSo, I am debugging for postmaster not for postmast.
ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 13

Hm. If you typed it correctly, then how did it come up with "postmast" in the debug output?

14:58:26.34: Initial pool address: postmast

14:58:26.34: Inner expand, level = 1, mailbox = postmast

14:58:26.34: Rewriting: Mbox = "postmast", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

14:58:26.34: Rewrite: "$*", position 0, hash table -

14:58:26.34: Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

14:58:26.34: Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

14:58:26.34: old state = not checked.

14:58:26.34: Domain check on nemrut.salescentrix.com.

14:58:26.34: new state = fail pending.

14:58:26.34: Rewrite failed due to prechannel mismatch.

14:58:26.34: Rewrite: "$*", position 1, hash table -

14:58:26.34: Failed.

14:58:26.34: Rewrite: "$*", position 0, rewrite database -

14:58:26.34: Failed

14:58:26.34: Rewriting: Mbox = "postmast", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

Perhaps when you installed the server, you assigned the account to "postmast"? That would explain something.

Please have a look at the postmaster account in ldap, and see what's actually there, and post that.

jay_plesseta at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 14

"postmast" was an mailalternate name in the ldap for postmaster, for which I have no idea who put "postmast" in the first place. And there was an aliases between postmaster and postmast in the aliases file. Anyway, I got rid of it, and updated the aliases file. Here is the aliases file:

! MTA aliases file

!

root@salescentrix.com: postmaster

root@nemrut.salescentrix.com: postmaster

postmaster@nemrut.salescentrix.com: postmaster

Then I got the new debug output (far below). I compared the debug output with another messaging server, and I noticed that at some point it says (in the new debug output of failed configuration)

16:01:54.76:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.76:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.76:old state = not checked.

16:01:54.76:Domain check on nemrut.salescentrix.com.

Whereas in the running configuration it says:

15:19:12.67: Rewrite: "$*", position 0, hash table -

15:19:12.67:Found: "$A$E$F$U%$H$V$H@lithium.salescentrix.com"

15:19:12.67:Match, pattern = "salescentrix.com", current = "(*domaincheck*)"

15:19:12.67:old state = not checked.

15:19:12.67:Domain check on salescentrix.com.

So, there is a difference between the above lines of "match pattern" and "domain check on". First one includes the hostname, but the second one correctly identifies the domain name.

Here is the new full debug:

nemrut# imsimta test -rewrite -debug postmaster@nemrut.salescentrix.com

Initializing mm_.

Initializing mm_ submission.

Checking identifiers.

*** Debug output from initializing MM for submission:

16:01:54.72: Debug output enabled, message enqueue routines version V6.2-3.04 compiled Jul 15 200501:33:07

16:01:54.72: mmc_winit('l','postmaster@nemrut.salescentrix.com','0JCN00502MR68Y00@nemrut.sal escentrix.com') called.

16:01:54.72: Queue area size 125441214, temp area size 678456

16:01:54.72:31360303 blocks of effective free queue space available; setting disk limit accordingly.

16:01:54.72:339228 blocks of free temporary space available; setting disk limit accordingly.

16:01:54.72: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.72: Rewrite: "$*", position 0, hash table -

16:01:54.72:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.72:Rewrite failed, not forward.

16:01:54.72: Rewrite: "$*", position 1, hash table -

16:01:54.72:Failed.

16:01:54.72: Rewrite: "$*", position 0, rewrite database -

16:01:54.72:Failed

16:01:54.72: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.72: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.72:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.72:New mailbox: "postmaster".

16:01:54.72:New host: "nemrut.salescentrix.com".

16:01:54.72:New route: "nemrut.salescentrix.com".

16:01:54.72:New channel system: "nemrut.salescentrix.com".

16:01:54.72: Looking up host "nemrut.salescentrix.com".

16:01:54.72:- found on channel l

16:01:54.72: Routelocal flag set; scanning for % and !

16:01:54.72:Checking reverse URL cache for: postmaster@nemrut.salescentrix.com

16:01:54.72:Applying reverse URL pattern ldap:///$V?$N?sub?$R to: postmaster@nemrut.salescentrix.com

16:01:54.72:URL generation failed, status = 0

16:01:54.72:Mapped return address: postmaster@nemrut.salescentrix.com

16:01:54.72:from_access mapping check: ||MAIL|l|postmaster@nemrut.salescentrix.com|

16:01:54.72:- passed.

16:01:54.72: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.72: Rewrite: "$*", position 0, hash table -

16:01:54.72:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.72:Rewrite failed, not forward.

16:01:54.72: Rewrite: "$*", position 1, hash table -

16:01:54.72:Failed.

16:01:54.72: Rewrite: "$*", position 0, rewrite database -

16:01:54.72:Failed

16:01:54.72: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.72: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.72:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.73:New mailbox: "postmaster".

16:01:54.73:New host: "nemrut.salescentrix.com".

16:01:54.73:New route: "nemrut.salescentrix.com".

16:01:54.73:New channel system: "nemrut.salescentrix.com".

16:01:54.73: Looking up host "nemrut.salescentrix.com".

16:01:54.73:- found on channel l

16:01:54.73: Routelocal flag set; scanning for % and !

***

*** Debug output from rewriting a forward header address:

16:01:54.73: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.73: Rewrite: "$*", position 0, hash table -

16:01:54.73:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.73:Rewrite failed, not envelope.

16:01:54.73: Rewrite: "$*", position 1, hash table -

16:01:54.73:Failed.

16:01:54.73: Rewrite: "$*", position 0, rewrite database -

16:01:54.73:Failed

16:01:54.73: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.73: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.73:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.73:New mailbox: "postmaster".

16:01:54.73:New host: "nemrut.salescentrix.com".

16:01:54.73:New route: "nemrut.salescentrix.com".

16:01:54.73:New channel system: "nemrut.salescentrix.com".

16:01:54.73: Looking up host "nemrut.salescentrix.com".

16:01:54.73:- found on channel l

16:01:54.73: Routelocal flag set; scanning for % and !

16:01:54.73:Rewrite rules result: postmaster@nemrut.salescentrix.com

16:01:54.73:Checking reverse URL cache for: postmaster@nemrut.salescentrix.com

16:01:54.73:Applying reverse URL pattern ldap:///$V?$N?sub?$R to: postmaster@nemrut.salescentrix.com

16:01:54.73:URL generation failed, status = 0

***

*** Debug output from rewriting a forward envelope address:

16:01:54.73: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.73: Rewrite: "$*", position 0, hash table -

16:01:54.73:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.73:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.73:old state = not checked.

16:01:54.73:Domain check on nemrut.salescentrix.com.

16:01:54.73:new state = fail pending.

16:01:54.73:Rewrite failed due to prechannel mismatch.

16:01:54.73: Rewrite: "$*", position 1, hash table -

16:01:54.73:Failed.

16:01:54.73: Rewrite: "$*", position 0, rewrite database -

16:01:54.73:Failed

16:01:54.73: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.73: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.73:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.73:New mailbox: "postmaster".

16:01:54.73:New host: "nemrut.salescentrix.com".

16:01:54.73:New route: "nemrut.salescentrix.com".

16:01:54.73:New channel system: "nemrut.salescentrix.com".

16:01:54.73: Looking up host "nemrut.salescentrix.com".

16:01:54.73:- found on channel l

16:01:54.73: Routelocal flag set; scanning for % and !

***

forward channel= l

channel description=

channel user filter=

dest channel filter=

source channel filter =

channel flags #0= BIDIRECTIONAL MULTIPLE IMMNORMAL NOSERVICEALL

channel flags #1= NOSMTP DEFAULT

channel flags #2= POSTHEADBODY HEADERINC NOEXPROUTE

channel flags #3= NOLOGGING NOGREY NORESTRICTED RETAINSECURITYMULTIPARTS

channel flags #4= EIGHTBIT NOHEADERTRIM NOHEADERREAD RULES

channel flags #5=

channel flags #6= LOCALUSER REPORTNOTARY

channel flags #7= ALLOWSWITCHCHANNEL NOREMOTEHOST DATEFOUR DAYOFWEEK

channel flags #8= NODEFRAGMENT EXQUOTA REVERSE NOCONVERT_OCTET_STREAM

channel flags #9= NOTHURMAN INTERPRETENCODING USEINTERMEDIATE RECEIVEDFROM VALIDATELOCALSYSTEM NOTURN

linelength = 1023

channel env addr type = SOURCEROUTE

channel hdr addr type = SOURCEROUTE

channel official host = nemrut.salescentrix.com

channel queue 0 name= LOCAL_POOL

channel queue 1 name= LOCAL_POOL

channel queue 2 name= LOCAL_POOL

channel queue 3 name= LOCAL_POOL

channel after params=

channel user name=

urgentnotices =

normalnotices =

nonurgentnotices=

channel rightslist ids =

local behavior flags= %x7

expandchannel =

notificationchannel=

dispositionchannel=

saslswitchchannel=

tlsswitchchannel=

backward channel= l

header To: address= postmaster@nemrut.salescentrix.com

header From: address= postmaster@nemrut.salescentrix.com

envelope To: address= postmaster@nemrut.salescentrix.com (route (nemrut.salescentrix.com,nemrut.salescentrix.com)) (host nemrut.salescentrix.com)

envelope From: address = postmaster@nemrut.salescentrix.com

name=

mbox= postmaster

Extracted address action list:

postmaster@nemrut.salescentrix.com

Extracted 733 address action list:

postmaster@nemrut.salescentrix.com

Address list expansion:

*** Debug output from alias expansion:

16:01:54.76: Inner expand, level = 0, mailbox = postmaster@nemrut.salescentrix.com

16:01:54.76: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.76: Rewrite: "$*", position 0, hash table -

16:01:54.76:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.76:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.76:old state = not checked.

16:01:54.76:Domain check on nemrut.salescentrix.com.

16:01:54.76:new state = fail pending.

16:01:54.76:Rewrite failed due to prechannel mismatch.

16:01:54.76: Rewrite: "$*", position 1, hash table -

16:01:54.76:Failed.

16:01:54.76: Rewrite: "$*", position 0, rewrite database -

16:01:54.76:Failed

16:01:54.76: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.76: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.76:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.76:New mailbox: "postmaster".

16:01:54.76:New host: "nemrut.salescentrix.com".

16:01:54.76:New route: "nemrut.salescentrix.com".

16:01:54.76:New channel system: "nemrut.salescentrix.com".

16:01:54.76: Looking up host "nemrut.salescentrix.com".

16:01:54.76:- found on channel l

16:01:54.76: Routelocal flag set; scanning for % and !

16:01:54.76:Reparsed mailbox: postmaster

16:01:54.76:Reparsed host: nemrut.salescentrix.com

16:01:54.77:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.77:Variant #2 = *@nemrut.salescentrix.com

16:01:54.77:Variant #3 = postmaster

16:01:54.77:Initial pool address: postmaster

16:01:54.77: Inner expand, level = 1, mailbox = postmaster

16:01:54.77: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.77: Rewrite: "$*", position 0, hash table -

16:01:54.77:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.77:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.77:old state = not checked.

16:01:54.77:Domain check on nemrut.salescentrix.com.

16:01:54.77:new state = fail pending.

16:01:54.77:Rewrite failed due to prechannel mismatch.

16:01:54.77: Rewrite: "$*", position 1, hash table -

16:01:54.77:Failed.

16:01:54.77: Rewrite: "$*", position 0, rewrite database -

16:01:54.77:Failed

16:01:54.77: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.77: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.77:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.77:New mailbox: "postmaster".

16:01:54.77:New host: "nemrut.salescentrix.com".

16:01:54.77:New route: "nemrut.salescentrix.com".

16:01:54.77:New channel system: "nemrut.salescentrix.com".

16:01:54.77: Looking up host "nemrut.salescentrix.com".

16:01:54.77:- found on channel l

16:01:54.77: Routelocal flag set; scanning for % and !

16:01:54.77:Reparsed mailbox: postmaster

16:01:54.77:Reparsed host: nemrut.salescentrix.com

16:01:54.77:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.77:Variant #2 = *@nemrut.salescentrix.com

16:01:54.77:Variant #3 = postmaster

16:01:54.77:Initial pool address: postmaster

16:01:54.77: Inner expand, level = 2, mailbox = postmaster

16:01:54.77: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.77: Rewrite: "$*", position 0, hash table -

16:01:54.77:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.77:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.77:old state = not checked.

16:01:54.77:Domain check on nemrut.salescentrix.com.

16:01:54.77:new state = fail pending.

16:01:54.77:Rewrite failed due to prechannel mismatch.

16:01:54.77: Rewrite: "$*", position 1, hash table -

16:01:54.77:Failed.

16:01:54.77: Rewrite: "$*", position 0, rewrite database -

16:01:54.77:Failed

16:01:54.77: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.77: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.77:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.77:New mailbox: "postmaster".

16:01:54.77:New host: "nemrut.salescentrix.com".

16:01:54.77:New route: "nemrut.salescentrix.com".

16:01:54.77:New channel system: "nemrut.salescentrix.com".

16:01:54.77: Looking up host "nemrut.salescentrix.com".

16:01:54.77:- found on channel l

16:01:54.77: Routelocal flag set; scanning for % and !

16:01:54.77:Reparsed mailbox: postmaster

16:01:54.77:Reparsed host: nemrut.salescentrix.com

16:01:54.77:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.77:Variant #2 = *@nemrut.salescentrix.com

16:01:54.77:Variant #3 = postmaster

16:01:54.77:Initial pool address: postmaster

16:01:54.77: Inner expand, level = 3, mailbox = postmaster

16:01:54.77: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.77: Rewrite: "$*", position 0, hash table -

16:01:54.77:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.77:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.77:old state = not checked.

16:01:54.77:Domain check on nemrut.salescentrix.com.

16:01:54.77:new state = fail pending.

16:01:54.77:Rewrite failed due to prechannel mismatch.

16:01:54.77: Rewrite: "$*", position 1, hash table -

16:01:54.77:Failed.

16:01:54.77: Rewrite: "$*", position 0, rewrite database -

16:01:54.77:Failed

16:01:54.77: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.77: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.77:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.77:New mailbox: "postmaster".

16:01:54.77:New host: "nemrut.salescentrix.com".

16:01:54.77:New route: "nemrut.salescentrix.com".

16:01:54.77:New channel system: "nemrut.salescentrix.com".

16:01:54.77: Looking up host "nemrut.salescentrix.com".

16:01:54.77:- found on channel l

16:01:54.77: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

16:01:54.78:Initial pool address: postmaster

16:01:54.78: Inner expand, level = 4, mailbox = postmaster

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.78: Rewrite: "$*", position 0, hash table -

16:01:54.78:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.78:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.78:old state = not checked.

16:01:54.78:Domain check on nemrut.salescentrix.com.

16:01:54.78:new state = fail pending.

16:01:54.78:Rewrite failed due to prechannel mismatch.

16:01:54.78: Rewrite: "$*", position 1, hash table -

16:01:54.78:Failed.

16:01:54.78: Rewrite: "$*", position 0, rewrite database -

16:01:54.78:Failed

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.78: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.78:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.78:New mailbox: "postmaster".

16:01:54.78:New host: "nemrut.salescentrix.com".

16:01:54.78:New route: "nemrut.salescentrix.com".

16:01:54.78:New channel system: "nemrut.salescentrix.com".

16:01:54.78: Looking up host "nemrut.salescentrix.com".

16:01:54.78:- found on channel l

16:01:54.78: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

16:01:54.78:Initial pool address: postmaster

16:01:54.78: Inner expand, level = 5, mailbox = postmaster

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.78: Rewrite: "$*", position 0, hash table -

16:01:54.78:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.78:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.78:old state = not checked.

16:01:54.78:Domain check on nemrut.salescentrix.com.

16:01:54.78:new state = fail pending.

16:01:54.78:Rewrite failed due to prechannel mismatch.

16:01:54.78: Rewrite: "$*", position 1, hash table -

16:01:54.78:Failed.

16:01:54.78: Rewrite: "$*", position 0, rewrite database -

16:01:54.78:Failed

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.78: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.78:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.78:New mailbox: "postmaster".

16:01:54.78:New host: "nemrut.salescentrix.com".

16:01:54.78:New route: "nemrut.salescentrix.com".

16:01:54.78:New channel system: "nemrut.salescentrix.com".

16:01:54.78: Looking up host "nemrut.salescentrix.com".

16:01:54.78:- found on channel l

16:01:54.78: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

16:01:54.78:Initial pool address: postmaster

16:01:54.78: Inner expand, level = 6, mailbox = postmaster

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.78: Rewrite: "$*", position 0, hash table -

16:01:54.78:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.78:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.78:old state = not checked.

16:01:54.78:Domain check on nemrut.salescentrix.com.

16:01:54.78:new state = fail pending.

16:01:54.78:Rewrite failed due to prechannel mismatch.

16:01:54.78: Rewrite: "$*", position 1, hash table -

16:01:54.78:Failed.

16:01:54.78: Rewrite: "$*", position 0, rewrite database -

16:01:54.78:Failed

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.78: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.78:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.78:New mailbox: "postmaster".

16:01:54.78:New host: "nemrut.salescentrix.com".

16:01:54.78:New route: "nemrut.salescentrix.com".

16:01:54.78:New channel system: "nemrut.salescentrix.com".

16:01:54.78: Looking up host "nemrut.salescentrix.com".

16:01:54.78:- found on channel l

16:01:54.78: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

16:01:54.78:Initial pool address: postmaster

16:01:54.78: Inner expand, level = 7, mailbox = postmaster

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.78: Rewrite: "$*", position 0, hash table -

16:01:54.78:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.78:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.78:old state = not checked.

16:01:54.78:Domain check on nemrut.salescentrix.com.

16:01:54.78:new state = fail pending.

16:01:54.78:Rewrite failed due to prechannel mismatch.

16:01:54.78: Rewrite: "$*", position 1, hash table -

16:01:54.78:Failed.

16:01:54.78: Rewrite: "$*", position 0, rewrite database -

16:01:54.78:Failed

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.78: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.78:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.78:New mailbox: "postmaster".

16:01:54.78:New host: "nemrut.salescentrix.com".

16:01:54.78:New route: "nemrut.salescentrix.com".

16:01:54.78:New channel system: "nemrut.salescentrix.com".

16:01:54.78: Looking up host "nemrut.salescentrix.com".

16:01:54.78:- found on channel l

16:01:54.78: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

16:01:54.78:Initial pool address: postmaster

16:01:54.78: Inner expand, level = 8, mailbox = postmaster

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.78: Rewrite: "$*", position 0, hash table -

16:01:54.78:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.78:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.78:old state = not checked.

16:01:54.78:Domain check on nemrut.salescentrix.com.

16:01:54.78:new state = fail pending.

16:01:54.78:Rewrite failed due to prechannel mismatch.

16:01:54.78: Rewrite: "$*", position 1, hash table -

16:01:54.78:Failed.

16:01:54.78: Rewrite: "$*", position 0, rewrite database -

16:01:54.78:Failed

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.78: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.78:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.78:New mailbox: "postmaster".

16:01:54.78:New host: "nemrut.salescentrix.com".

16:01:54.78:New route: "nemrut.salescentrix.com".

16:01:54.78:New channel system: "nemrut.salescentrix.com".

16:01:54.78: Looking up host "nemrut.salescentrix.com".

16:01:54.78:- found on channel l

16:01:54.78: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

16:01:54.78:Initial pool address: postmaster

16:01:54.78: Inner expand, level = 9, mailbox = postmaster

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.78: Rewrite: "$*", position 0, hash table -

16:01:54.78:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.78:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.78:old state = not checked.

16:01:54.78:Domain check on nemrut.salescentrix.com.

16:01:54.78:new state = fail pending.

16:01:54.78:Rewrite failed due to prechannel mismatch.

16:01:54.78: Rewrite: "$*", position 1, hash table -

16:01:54.78:Failed.

16:01:54.78: Rewrite: "$*", position 0, rewrite database -

16:01:54.78:Failed

16:01:54.78: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.78: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.78:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.78:New mailbox: "postmaster".

16:01:54.78:New host: "nemrut.salescentrix.com".

16:01:54.78:New route: "nemrut.salescentrix.com".

16:01:54.78:New channel system: "nemrut.salescentrix.com".

16:01:54.78: Looking up host "nemrut.salescentrix.com".

16:01:54.78:- found on channel l

16:01:54.78: Routelocal flag set; scanning for % and !

16:01:54.78:Reparsed mailbox: postmaster

16:01:54.78:Reparsed host: nemrut.salescentrix.com

16:01:54.78:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.78:Variant #2 = *@nemrut.salescentrix.com

16:01:54.78:Variant #3 = postmaster

postmaster

***

1 expansion total.

*** Debug output from submitting an envelope address:

16:01:54.78: mmc_wadr(0x08573b70,'postmaster@nemrut.salescentrix.com','postmaster@nemrut.sal escentrix.com') called.

16:01:54.79: Copy estimate before address addition is 1

16:01:54.79:Parsing address postmaster@nemrut.salescentrix.com

16:01:54.79: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.79: Rewrite: "$*", position 0, hash table -

16:01:54.79:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.79:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.79:old state = not checked.

16:01:54.79:Domain check on nemrut.salescentrix.com.

16:01:54.79:new state = fail pending.

16:01:54.79:Rewrite failed due to prechannel mismatch.

16:01:54.79: Rewrite: "$*", position 1, hash table -

16:01:54.79:Failed.

16:01:54.79: Rewrite: "$*", position 0, rewrite database -

16:01:54.79:Failed

16:01:54.79: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.79: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.79:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.79:New mailbox: "postmaster".

16:01:54.79:New host: "nemrut.salescentrix.com".

16:01:54.79:New route: "nemrut.salescentrix.com".

16:01:54.79:New channel system: "nemrut.salescentrix.com".

16:01:54.79: Looking up host "nemrut.salescentrix.com".

16:01:54.79:- found on channel l

16:01:54.79: Routelocal flag set; scanning for % and !

16:01:54.79:Address postmaster@nemrut.salescentrix.com requires local processing.

16:01:54.79:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.79:Variant #2 = *@nemrut.salescentrix.com

16:01:54.79:Variant #3 = postmaster

16:01:54.79:Checking for postmaster@nemrut.salescentrix.com in the system alias file

16:01:54.79:- system alias file match for postmaster@nemrut.salescentrix.com

16:01:54.79:Initial pool address: postmaster

16:01:54.79:- postmaster

16:01:54.79:Parsing address postmaster

16:01:54.79: Rewriting: Mbox = "postmaster", host = "nemrut.salescentrix.com", domain = "$*", literal = "", tag = ""

16:01:54.79: Rewrite: "$*", position 0, hash table -

16:01:54.79:Found: "$A$E$F$U%$H$V$H@nemrut.salescentrix.com"

16:01:54.79:Match, pattern = "nemrut.salescentrix.com", current = "(*domaincheck*)"

16:01:54.79:old state = not checked.

16:01:54.79:Domain check on nemrut.salescentrix.com.

16:01:54.79:new state = fail pending.

16:01:54.79:Rewrite failed due to prechannel mismatch.

16:01:54.79: Rewrite: "$*", position 1, hash table -

16:01:54.79:Failed.

16:01:54.79: Rewrite: "$*", position 0, rewrite database -

16:01:54.79:Failed

16:01:54.79: Rewriting: Mbox = "postmaster", host = "nemrut", domain = "nemrut.salescentrix.com", literal = "", tag = ""

16:01:54.79: Rewrite: "nemrut.salescentrix.com", position 0, hash table -

16:01:54.79:Found: "$U%$D@nemrut.salescentrix.com"

16:01:54.79:New mailbox: "postmaster".

16:01:54.79:New host: "nemrut.salescentrix.com".

16:01:54.79:New route: "nemrut.salescentrix.com".

16:01:54.79:New channel system: "nemrut.salescentrix.com".

16:01:54.79: Looking up host "nemrut.salescentrix.com".

16:01:54.79:- found on channel l

16:01:54.79: Routelocal flag set; scanning for % and !

16:01:54.79:Address postmaster@nemrut.salescentrix.com requires local processing.

16:01:54.79:Variant #1 = postmaster@nemrut.salescentrix.com

16:01:54.79:Variant #2 = *@nemrut.salescentrix.com

16:01:54.79:Variant #3 = postmaster

16:01:54.79:Checking for postmaster@nemrut.salescentrix.com in the system alias file

16:01:54.79: - system alias file match for postmaster@nemrut.salescentrix.com

16:01:54.79:Initial pool address: postmaster

16:01:54.79: - postmaster

16:01:54.79:Alias loop; address ignored.

16:01:54.79:- adding address postmaster@nemrut.salescentrix.com to headers.

16:01:54.79: Copy estimate after address addition is 1

***

Expanded address:

postmaster@nemrut.salescentrix.com

Submitted address list:

Address list error -- 5.2.4 alias failed to expand to any valid addresses: postmaster@nemrut.salescentrix.com

Submitted notifications list:

ramia at 2007-7-8 23:00:27 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 15

If you pile through this debug output, it looks like "postmaster@host.domain" is getting resolved to "postmaster", which is aliased to "postmaster@host.domain". Circularity, and the server bails after a few rounds.

If you have both a mailAlternateAddress and an entry in the alias file, that's likely a problem for you. One or the other. . .

You might want to compare the test -rewrite of "postmaster@domain" against the one you just did, too.

jay_plesseta at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 16

I deleted the mailalternate, and left only in the aliases, but it did not help. I also checked postmaster@doamin, and it works. postmaster@host.domain still does not work. And the messaging server insists on sending the postmaster reports to postmaster@host.domain.

Any comments!

Thanks,

ramia at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 17

I also wanted to add that I configured amavisd-new to use spam assassis, and I defined a new channel call tcp_scan as you suggested in one of your earlies write-ups. This is the only difference between my two messaging servers. Do you think I have misconfigured tcp_scan channel?

Here is my imta.cnf:

nemrut# more imta.cnf

!

! IMTA configuration file

!

! part I : rewrite rules

!

! Domain Rewrite Rules.

! Uncomment this line to use domain rewrite rules

! from the configuration file instead of the domain database.

! Please refer to the iMS documentation for details.

!<IMTA_TABLE:domains.rules

!

! Rules to select local users

$* $A$E$F$U%$H$V$H@nemrut.salescentrix.com

nemrut.salescentrix.com $U%$D@nemrut.salescentrix.com

salescentrix.com $U%$D@nemrut.salescentrix.com

!

! ims-ms

.ims-ms-daemon $U%$H.ims-ms-daemon@ims-ms-daemon

!

! lmtp

!.lmtp $U%$H@lmtpcs-daemon

!

! lmtpn

!.lmtpn $U%$H@lmtpcn-daemon

!

! native

.native-daemon $U%$H.native-daemon@native-daemon

!

! pipe

.pipe-daemon $U%$H.pipe-daemon@pipe-daemon

!

! tcp_local

! Rules for top level internet domains

><IMTA_TABLE:internet.rules

!

! tcp_intranet

! Do mapping lookup for internal IP addresses

[] $E$R${INTERNAL_IP,$L}$U%[$L]@tcp_intranet-daemon

.salescentrix.com $U%$H.salescentrix.com@tcp_intranet-daemon

* $U%$&0.salescentrix.com

!

! reprocess

reprocess $U%reprocess.nemrut.salescentrix.com@reprocess-daemon

reprocess.nemrut.salescentrix.com $U%reprocess.nemrut.salescentrix.com@reprocess-daemon

!

! process

process $U%process.nemrut.salescentrix.com@process-daemon

process.nemrut.salescentrix.com $U%process.nemrut.salescentrix.com@process-daemon

!

! defragment

defragment $U%defragment.nemrut.salescentrix.com@defragment-daemon

defragment.nemrut.salescentrix.com $U%defragment.nemrut.salescentrix.com@defragment-daemon

!

! conversion

conversion $U%conversion.nemrut.salescentrix.com@conversion-daemon

conversion.nemrut.salescentrix.com $U%conversion.nemrut.salescentrix.com@conversion-daemon

!

! bitbucket

bitbucket $U%bitbucket.nemrut.salescentrix.com@bitbucket-daemon

bitbucket.nemrut.salescentrix.com $U%bitbucket.nemrut.salescentrix.com@bitbucket-daemon

!

! deleted

deleted-daemon $U%$H@deleted-daemon

.deleted-daemon $U%$H@deleted-daemon

!

! inactive

inactive-daemon $U%$H@inactive-daemon

.inactive-daemon $U%$H@inactive-daemon

!

! hold

hold-daemon $U%$H@hold-daemon

.hold-daemon $U%$H@hold-daemon

!

! tcp_scan

[] $E$R${tcp_scan,$L}$U%[$L]@tcp_scan-daemon

!

! part II : channel blocks

!

defaults logging notices 1 2 4 7 copywarnpost copysendpost postheadonly noswitchchannel immnonurgent maxjobs 7

defaulthost salescentrix.com salescentrix.com

!

! delivery channel to local /var/mail store

l subdirs 20 viaaliasrequired maxjobs 7 pool LOCAL_POOL

nemrut.salescentrix.com

!

! ims-ms

ims-ms defragment subdirs 20 notices 1 7 14 21 28 backoff "pt5m" "pt10m" "pt30m" "pt1h" "pt2h" "pt4h" maxjobs

2 pool IMS_POOL fileinto $U+$S@$D

ims-ms-daemon

!

! native

native defragment subdirs 20 maxjobs 1

native-daemon

!

! pipe

pipe single defragment subdirs 20

pipe-daemon

!

! tcp_local

tcp_local smtp mx single_sys remotehost inner switchchannel identnonenumeric subdirs 20 maxjobs 7 pool SMTP_PO

OL maytlsserver maysaslserver saslswitchchannel tcp_auth missingrecipientpolicy 0 aliasdetourhost tcp_scan-dae

mon

tcp-daemon mail.salescentrix.com

!

! tcp_scan

tcp_scan smtp single_sys subdirs 5 notices 1 7 14 21 28 backoff "pt8h" "pt24h" dequeue_removeroute maxjobs 7 p

ool SMTP_POOL daemon [127.0.0.1] port 10024

tcp_scan-daemon

!

! tcp_intranet

tcp_intranet smtp mx single_sys subdirs 20 dequeue_removeroute maxjobs 7 pool SMTP_POOL maytlsserver allowswit

chchannel saslswitchchannel tcp_auth missingrecipientpolicy 4 aliasdetourhost tcp_scan-daemon

tcp_intranet-daemon

!

! tcp_submit

tcp_submit submit smtp mx single_sys mustsaslserver maytlsserver missingrecipientpolicy 4

tcp_submit-daemon

!

! tcp_auth

tcp_auth smtp mx single_sys mustsaslserver missingrecipientpolicy 4

tcp_auth-daemon

!

! tcp_tas

tcp_tas smtp mx single_sys allowswitchchannel mustsaslserver maytlsserver deliveryflags 2

tcp_tas-daemon

!

! tcp_lmtpss (LMTP server - store)

!tcp_lmtpss lmtp subdirs 20

!tcp_lmtpss-daemon

!

! tcp_lmtpsn (LMTP server - native)

!tcp_lmtpsn lmtp subdirs 20

!tcp_lmtpsn-daemon

!

! tcp_lmtpcs (LMTP client - store)

!tcp_lmtpcs defragment lmtp port 225 nomx single_sys subdirs 20 maxjobs 7 pool SMTP_POOL dequeue_removeroute

!lmtpcs-daemon

!

! tcp_lmtpcn (LMTP client - native)

!tcp_lmtpcn defragment lmtp port 226 nomx single_sys subdirs 20 maxjobs 7 pool SMTP_POOL dequeue_removeroute

!lmtpcn-daemon

!

! reprocess

reprocess

reprocess-daemon

!

! process

process

process-daemon

!

! defragment

defragment

defragment-daemon

!

! conversion

conversion

conversion-daemon

!

! bitbucket

bitbucket

bitbucket-daemon

!

! deleted

deleted

deleted-daemon

!

! inactive

inactive

inactive-daemon

!

! hold

hold

hold-daemon>

ramia at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 18

Hi Jay,

Since I started to suspect of tcp_scan configuration, I disabled it and gave it a try. Then, everything was back to normal. I mean, all messages to postmaster@local-host.domain got delivered and all "reprocess" processes just disappeared from the top list, and CPU idle time hit 99%. So, there is definitely something wrong with my tcp_scan channel configuration. To summarize the problems I have observed so far:

1) postmaster@local-host.domain messages got stuck, and "reprocess" processes puts too much CPU load. On the other hand, postmaster@doamin has no problem. Unfortunately, messaging server itself wants to send the postmaster reports to postmaster@local-host.domain.

2) I also noticed that when I enable the tcp_scan configuration, there is no log files called mail.log (or mail-log.current) in the log directory. However, when I disabled tcp_scan channel, mail.log appear in the log directory.

You may say why to use tcp_scan then, Well, I need to have "Mail filters" get executed after the SPAM check, and as I understand, the only way to do that, is to first define a new channel like tcp_scan and use amavisd-new as you suggested in one of your earlier write-ups.

So, can you pinpoint why my tcp_scan configuration introduces the above two problems, and how can I solve them?

Thanks,

Rami

ramia at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 19
your tcp_scan looks fine, to me. You may want to open a support case.
jay_plesseta at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 20
Hi Jay,Just for the records I wanted to add the resolution: there must be a blank line between part I and part II in imta.cnf. I spent too much time just to discover that.Thanks for your time & help.Rami
ramia at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
# 21
Yes, you're right, there must be a blank line.I didn't even check your file for that. It is documented in the reference guide, where the file's format is detailed.Not having the blank line will cause all kinds of problems.
jay_plesseta at 2007-7-21 16:47:21 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Messaging Server...
E-Mail, Calendar, & Collaboration
Sun Java System Messaging Server

E-Mail, Calendar, & Collaboration New Topic

E-Mail, Calendar, & Collaboration Hot Topic

E-Mail, Calendar, & Collaboration

All Classified