posting latency

Kragen Sitaker kragen@pobox.com
Wed, 23 May 2001 15:59:11 -0400 (EDT)


Someone asks:
> > What's the usual latency in posts to the Fork list?
> > I've sent a couple of posts from my deafbox@hotmail
> > account this morning, and they seem delayed by hours.
>
> I think you'd have to ask Kragen about that right now,
> given the mail server switch.
>
> But I'd blame hotmail. Just because.

I was going to write a Perl script to answer this question, but it's
not at all apparent to me how to determine which outgoing log entries
correspond to which incoming log entries.  Here is some sample log
material --- sorry about the chopped lines:

May 23 05:39:27 lair postfix/local[4824]: 0FBBD2940B6: to=<fork@xent.com>, relay=local, delay=6, status=sent ("|/var/lib/ma
ilman/mail/wrapper post fork")
May 23 05:39:28 lair postfix/smtp[4861]: warning: valid_hostname: numeric hostname: 208.12.14.91
May 23 05:39:28 lair postfix/smtp[4845]: connect to fwns1d.raleigh.ibm.com[204.146.167.235]: Connection refused (port 25)
May 23 05:39:28 lair postfix/smtp[4871]: 658502940FB: to=<carey@4k-associates.com>, relay=m.dnsix.com[64.75.34.135], delay=
1, status=sent (250 Ok: queued as BB09A4F81)
May 23 05:39:28 lair postfix/smtp[4864]: CD12F2940F9: to=<dave@shortbus.com>, relay=mx.domaindiscover.com[209.75.5.4], dela
y=2, status=sent (250 2.0.0 f4NCiZK91429 Message accepted for delivery)
May 23 05:39:29 lair postfix/smtp[4862]: CD12F2940F9: to=<colin@onepointzero.com>, relay=onepointzero.com[207.155.21.233],
delay=3, status=sent (250 2.0.0 f4NCiZq15959 Message accepted for delivery)
May 23 05:39:29 lair postfix/smtpd[4839]: connect from m.dnsix.com[64.75.34.135]
May 23 05:39:29 lair postfix/smtpd[4839]: 1A0322940B6: client=m.dnsix.com[64.75.34.135]
May 23 05:39:29 lair postfix/cleanup[4822]: 1A0322940B6: message-id=<002b01c0e386$348db980$024a1ed8@pecan>
May 23 05:39:29 lair postfix/qmgr[24808]: 1A0322940B6: from=<fork-admin@xent.com>, size=2264 (queue active)
May 23 05:39:29 lair postfix/local[4824]: 1A0322940B6: to=<rohit@xent.com>, relay=local, delay=0, status=sent (mailbox)
May 23 05:39:29 lair postfix/smtpd[4839]: disconnect from m.dnsix.com[64.75.34.135]
May 23 05:39:29 lair postfix/smtp[4869]: CD12F2940F9: to=<dave@userland.com>, relay=mail.userland.com[209.181.141.41], dela
y=3, status=sent (250 2.0.0 message received OK)
May 23 05:39:29 lair postfix/smtp[4870]: CD12F2940F9: to=<bill@whump.com>, relay=jasper.he.net[216.218.145.2], delay=3, sta
tus=sent (250 FAA25720 Message accepted for delivery)
May 23 05:39:29 lair postfix/smtp[4866]: CD12F2940F9: to=<c.langreiter@tirol.com>, relay=tirolmail.highway.telekom.at[195.3
.87.133], delay=3, status=sent (250 ok 990621876 qp 142172)
May 23 05:39:29 lair postfix/smtp[4855]: CD12F2940F9: to=<bal@farcaster.com>, relay=shrike.farcaster.com[204.50.231.133], d
elay=3, status=sent (250 ok 990621877 qp 4424)
May 23 05:39:29 lair postfix/smtp[4885]: 658502940FB: to=<matt@haughey.com>, relay=lepen.pair.com[209.68.1.146], delay=2, s
tatus=sent (250 ok 990621876 qp 47188)
May 23 05:39:29 lair postfix/smtp[4867]: CD12F2940F9: to=<rasheed@ucf.ics.uci.edu>, relay=zima.ucf.ics.uci.edu[128.195.23.1
50], delay=3, status=sent (250 ok 990621876 qp 27170)
May 23 05:39:29 lair postfix/smtp[4865]: CD12F2940F9: to=<hkanji@stanford.edu>, relay=Leland.stanford.edu[171.64.14.7], del
ay=3, status=sent (250 2.0.0 f4NCiap19595 Message accepted for delivery)
May 23 05:39:30 lair postfix/smtp[4873]: 658502940FB: to=<gordoni@base.com>, relay=mailhost.base.com[63.201.136.251], delay
=3, status=sent (250 EAA02996 Message accepted for delivery)

Any clues?

-- 
<kragen@pobox.com>       Kragen Sitaker     <http://www.pobox.com/~kragen/>
Perilous to all of us are the devices of an art deeper than we possess
ourselves.
       -- Gandalf the White [J.R.R. Tolkien, "The Two Towers", Bk 3, Ch. XI]