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

Matthew Trent mtrent at localaccess.com
Thu, 11 Dec 2003 09:32:23 -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.

Sorry for so many posts, but I'm trying to be helpful and give lots of info...

Anyway, I had the original employee who triggered my whole timeout 
investigation try to reproduce the problem, and she did. She resent the 2mb 
email with pictures attached and she once again got duplicates in her inbox, 
and I see timeout errors in the logs. She using Microsoft Outlook CWS, Build 
9.0.2416 (9.0.2911.0) and connecting through our network (not dialup). I 
should also add that with the last log I sent (username 'gks'), the user is 
actually using Outlook 2000, not OE.

Dec 11 09:16:45 mail1 tpop3d[12906]: fork_child: [9]mgoulart(69.10.192.39): 
began session for `mgoulart' with mysql; child PID is 10026
Dec 11 09:16:45 mail1 tpop3d[10026]: maildir_new: scanned maildir /var/spool/
store/SERVERS/mashell.com/mgoulart (1 messages) in 0.001s
Dec 11 09:16:45 mail1 tpop3d[10026]: connection_sendresponse: client 
[9]mgoulart(69.10.192.39): sent `+OK Welcome aboard! You have exactly one 
message.'
Dec 11 09:16:45 mail1 tpop3d[10026]: connection_parsecommand: client 
[9]mgoulart(69.10.192.39): received `STAT'
Dec 11 09:16:45 mail1 tpop3d[10026]: connection_sendresponse: client 
[9]mgoulart(69.10.192.39): sent `+OK 1 2458366'
Dec 11 09:16:48 mail1 tpop3d[10026]: connection_parsecommand: client 
[9]mgoulart(69.10.192.39): received `RETR 1'
Dec 11 09:16:48 mail1 tpop3d[10026]: do_retr: client 
[9]mgoulart(69.10.192.39): sending message 1 (2458366 bytes)
Dec 11 09:16:48 mail1 tpop3d[10026]: connection_sendresponse: client 
[9]mgoulart(69.10.192.39): sent `+OK Message follows'
Dec 11 09:16:49 mail1 tpop3d[10026]: do_retr: client 
[9]mgoulart(69.10.192.39): sent message 1
Dec 11 09:17:38 mail1 tpop3d[10026]: connection_sendresponse: client 
[9]mgoulart(69.10.192.39): sent `-ERR Client has been idle for too long.'
Dec 11 09:17:38 mail1 tpop3d[10026]: net_loop: timed out client 
[9]mgoulart(69.10.192.39)
Dec 11 09:17:38 mail1 tpop3d[10026]: connections_post_select: client 
[9]mgoulart(69.10.192.39): finished session for `mgoulart' with mysql
Dec 11 09:17:38 mail1 tpop3d[10026]: connections_post_select: client 
[9]mgoulart(69.10.192.39): disconnected; 42/2490577 bytes read/written

It looks like all the bytes were transferred, yet still an error and the 
message is still in the 'new' folder.

The email is at:
ftp://alderaan.localaccess.com/timeout2
-- 
Matt
Systems Administrator
Local Access Communications
360.330.5535