[tpop3d-discuss] tpop3d[2209]: net_loop: timed out client

Matthew Trent mtrent at localaccess.com
Thu, 11 Dec 2003 08:08:41 -0800


On Wednesday 10 December 2003 03:32 pm, you wrote:
> Ok, here's another timeout. This time the customer didn't get copies of the
> message, but the connection always died on a certain message (not quite
> 100k this time). We deleted a bunch of messages that were before it in the
> list, but it would always hang on this one message. The customer tried
> several times with us on the phone to download it. Client was Outlook
> Express I believe.

And here's another one. This one is very interesting because the message 
appears to be of the same type as the other one. It's some kind of email 
greeting card with what looks like a jpeg pasted raw into the body again. I 
have 8 identical log entries yesterday as the user repeatedly tried.

Dec 10 19:19:27 mail2 tpop3d[11880]: fork_child: [6]gks(69.10.198.196): began 
session for `gks' with mysql; child PID is 24550
Dec 10 19:19:27 mail2 tpop3d[24550]: maildir_new: scanned maildir /var/spool/
store/SERVERS/localaccess.com/gks (5 messages) in 0.003s
Dec 10 19:19:27 mail2 tpop3d[24550]: connection_sendresponse: client 
[6]gks(69.10.198.196): sent `+OK Welcome aboard! You have 5 messages.'
Dec 10 19:19:28 mail2 tpop3d[24550]: connection_parsecommand: client 
[6]gks(69.10.198.196): received `STAT'
Dec 10 19:19:28 mail2 tpop3d[24550]: connection_sendresponse: client 
[6]gks(69.10.198.196): sent `+OK 5 111700'
Dec 10 19:19:28 mail2 tpop3d[24550]: connection_parsecommand: client 
[6]gks(69.10.198.196): received `UIDL'
Dec 10 19:19:28 mail2 tpop3d[24550]: connection_sendresponse: client 
[6]gks(69.10.198.196): sent `+OK ID list follows:'
Dec 10 19:19:28 mail2 tpop3d[24550]: do_uidl: client [6]gks(69.10.198.196): 
sent 6-line unique ID list
Dec 10 19:19:29 mail2 tpop3d[24550]: connection_parsecommand: client 
[6]gks(69.10.198.196): received `RETR 2'
Dec 10 19:19:29 mail2 tpop3d[24550]: do_retr: client [6]gks(69.10.198.196): 
sending message 2 (97646 bytes)
Dec 10 19:19:29 mail2 tpop3d[24550]: connection_sendresponse: client 
[6]gks(69.10.198.196): sent `+OK Message follows'
Dec 10 19:19:29 mail2 tpop3d[24550]: do_retr: client [6]gks(69.10.198.196): 
sent message 2
Dec 10 19:20:30 mail2 tpop3d[24550]: connection_sendresponse: client 
[6]gks(69.10.198.196): sent `-ERR Client has been idle for too long.'
Dec 10 19:20:30 mail2 tpop3d[24550]: net_loop: timed out client 
[6]gks(69.10.198.196)
Dec 10 19:20:30 mail2 tpop3d[24550]: connections_post_select: client 
[6]gks(69.10.198.196): finished session for `gks' with mysql
Dec 10 19:20:30 mail2 tpop3d[24550]: connections_post_select: client 
[6]gks(69.10.198.196): disconnected; 42/98843 bytes read/written

Again, I've posted the message at:
ftp://alderaan.localaccess.com/timedout

You'll notice 'timedout' and 'gibberish' are nearly identical and both seem to 
cause the error above when downloaded with Outlook Express. I've telnetted in 
to port 110 and retrieved the message fine manually. It may be some kind of 
weird timing issue, as I think one of our techs said he set the user's 
account up in his Outlook Express and was able to retrieve it over our LAN. 
The users are on dialups.
-- 
Matt
Systems Administrator
Local Access Communications
360.330.5535