[wplug] more on SMTP delay

[duncanhutty at comcast.net]

I turned up the logging on Postfix, by changing the smtp service line in master.cf to smtpd -v and adding debug_peer_list = 192.168.0.0/16 to main.cf
I noticed that in this transaction there are three separate 5s delays; where the timestamp of consecutive log entries (of which there were a total of about 500 for one email) were separated by 5s.
Here are those log entries that I noticed:
14:15:31 mail postfix/smtpd[11064]: connect from unknown[192.168.1.50]
14:15:31 mail postfix/smtpd[11064]: private/rewrite socket: wanted attribute: transport
14:15:36 mail postfix/smtpd[11064]: vstream_buf_get_ready: fd 17 got 95
14:15:36 mail postfix/smtpd[11064]: input attribute name: transport
14:15:36 mail postfix/smtpd[11064]: dict_ldap_lookup: No existing connection for LDAP source ldapalias, reopening
14:15:41 mail postfix/smtpd[11064]: dict_ldap_connect: Connecting to server ldap://localhost:389
14:15:41 mail postfix/smtpd[11064]: public/cleanup socket: wanted attribute: status
14:15:46 mail postfix/cleanup[11067]: 8124530F7A: message-id=KOEEIIAAFANAOOGGFAKPIEIKEOAA.duncanh at mail.holidaytvl.com
14:15:46 mail postfix/smtpd[11064]: > unknown[192.168.1.50]: 250 Ok: queued as 8124530F7A
I am not sure what the first delay (between 14:15:31 and 14:15:36) is about: private/rewrite wants a transport attribute; shouldn't that come from master.cf? If so I can't see why it would take so long.
The second delay (between :36 and :41) appears to be while postfix is waiting for the LDAP server. Fair enough, I suppose there is a way to have a persistent connection with the LDAP server. Perhaps if I have postfix bind to the LDAP server, the connection will be persistent?
I am not sure what the third delay (between :41 and :46) is either: public/cleanup wants a status attribute?
Thanks for your suggestions earlier, I could go for some more please. The full log for that transaction can be found at: http://duncanh.dotgeek.org/maillog.txt in the interests of not clogging the list too much.
Duncan Hutty
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://penguin.wplug.org/pipermail/wplug/attachments/20040825/32163dbd/attachment-0001.html