Bug #18175 for libnet: Net::smtp timeout on Redhat as4

Tue Mar 14 16:48:38 2006 Guest - Ticket created

Subject:

Net::smtp timeout on Redhat as4

While trying to use Net::smtp VERSION = "2.29" on Redhat as4 there is a 30 second timeout on sending messages. Of course the same script works instantly on netlib 1.16 and smtp 2.24/ Redhat 9. Sending mail using other methods, such as the simple "mail" command also work instantly. Can you help me to problem solve this better? A sample of the test below: Thank You, jeff # time ./smtp_test.pl -debug -user jeff.blasius@yale.edu Net::SMTP>>> Net::SMTP(2.29) Net::SMTP>>> Net::Cmd(2.26) Net::SMTP>>> Exporter(5.58) Net::SMTP>>> IO::Socket::INET(1.27) Net::SMTP>>> IO::Socket(1.28) Net::SMTP>>> IO::Handle(1.24) Net::SMTP=GLOB(0x85c720)<<< 220 research1.wss.yale.edu ESMTP Postfix Net::SMTP=GLOB(0x85c720)>>> EHLO localhost.localdomain Net::SMTP=GLOB(0x85c720)<<< 250-research1.wss.yale.edu Net::SMTP=GLOB(0x85c720)<<< 250-PIPELINING Net::SMTP=GLOB(0x85c720)<<< 250-SIZE 10240000 Net::SMTP=GLOB(0x85c720)<<< 250-VRFY Net::SMTP=GLOB(0x85c720)<<< 250-ETRN Net::SMTP=GLOB(0x85c720)<<< 250 8BITMIME Net::SMTP=GLOB(0x85c720)>>> MAIL FROM:<jeff.blasius@yale.edu> Net::SMTP=GLOB(0x85c720)<<< 250 Ok Net::SMTP=GLOB(0x85c720)>>> RCPT TO:<jeff.blasius@yale.edu> ~60 second timeout Net::SMTP=GLOB(0x85c720)<<< 250 Ok Net::SMTP=GLOB(0x85c720)>>> RSET Net::SMTP=GLOB(0x85c720)<<< 250 Ok Net::SMTP=GLOB(0x85c720)>>> MAIL FROM:<jeff.blasius@yale.edu> Net::SMTP=GLOB(0x85c720)<<< 250 Ok Net::SMTP=GLOB(0x85c720)>>> RCPT TO:<jeff.blasius@yale.edu> ~60 second timeout Net::SMTP=GLOB(0x85c720)<<< 250 Ok Net::SMTP=GLOB(0x85c720)>>> DATA Net::SMTP=GLOB(0x85c720)<<< 354 End data with <CR><LF>.<CR><LF> Net::SMTP=GLOB(0x85c720)>>> To: <jeff.blasius@yale.edu> Net::SMTP=GLOB(0x85c720)>>> Subject: A test message Net::SMTP=GLOB(0x85c720)>>> Net::SMTP=GLOB(0x85c720)>>> The message was sent directly via SMTP using Net::SMTP Net::SMTP=GLOB(0x85c720)>>> . Net::SMTP=GLOB(0x85c720)>>> The message was sent directly via SMTP using Net::SMTP Net::SMTP=GLOB(0x85c720)>>> . Net::SMTP=GLOB(0x85c720)<<< 250 Ok: queued as 9D5C7320FCA Net::SMTP=GLOB(0x85c720)>>> QUIT Net::SMTP=GLOB(0x85c720)<<< 221 Bye real 1m54.131s user 0m0.064s sys 0m0.013s

Tue Mar 14 19:28:46 2006 gbarr [...] pobox.com - Correspondence added

Subject:	Re: [rt.cpan.org #18175] Net::smtp timeout on Redhat as4
Date:	Tue, 14 Mar 2006 18:28:19 -0600
To:	bug-libnet [...] rt.cpan.org
From:	Graham Barr <gbarr [...] pobox.com>

On Mar 14, 2006, at 3:48 PM, Guest via RT wrote: Show quoted text

> While trying to use Net::smtp VERSION = "2.29" on Redhat as4 there > is a > 30 second timeout on sending messages. Of course the same script works > instantly on netlib 1.16 and smtp 2.24/ Redhat 9. Sending mail using > other methods, such as the simple "mail" command also work instantly. > Can you help me to problem solve this better? A sample of the test > below:

Unfortunately timeouts is something that can only be debugged by the person experiencing them. It is highly unlikely that I will be able to reproduce your specific problem. I suggest you make a copy of Net/Cmd.pm and annotate the command, response and getline methods with debug print statements to try to see what is happening. It looks like getline may not be realizing it has a complete line for some reason, then the select times out waiting for more data that is not there. Graham. Show quoted text

> > Thank You, > jeff > > # time ./smtp_test.pl -debug -user jeff.blasius@yale.edu > Net::SMTP>>> Net::SMTP(2.29) > Net::SMTP>>> Net::Cmd(2.26) > Net::SMTP>>> Exporter(5.58) > Net::SMTP>>> IO::Socket::INET(1.27) > Net::SMTP>>> IO::Socket(1.28) > Net::SMTP>>> IO::Handle(1.24) > Net::SMTP=GLOB(0x85c720)<<< 220 research1.wss.yale.edu ESMTP Postfix > Net::SMTP=GLOB(0x85c720)>>> EHLO localhost.localdomain > Net::SMTP=GLOB(0x85c720)<<< 250-research1.wss.yale.edu > Net::SMTP=GLOB(0x85c720)<<< 250-PIPELINING > Net::SMTP=GLOB(0x85c720)<<< 250-SIZE 10240000 > Net::SMTP=GLOB(0x85c720)<<< 250-VRFY > Net::SMTP=GLOB(0x85c720)<<< 250-ETRN > Net::SMTP=GLOB(0x85c720)<<< 250 8BITMIME > Net::SMTP=GLOB(0x85c720)>>> MAIL FROM:<jeff.blasius@yale.edu> > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > Net::SMTP=GLOB(0x85c720)>>> RCPT TO:<jeff.blasius@yale.edu> > > ~60 second timeout > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > Net::SMTP=GLOB(0x85c720)>>> RSET > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > Net::SMTP=GLOB(0x85c720)>>> MAIL FROM:<jeff.blasius@yale.edu> > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > Net::SMTP=GLOB(0x85c720)>>> RCPT TO:<jeff.blasius@yale.edu> > > ~60 second timeout > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > Net::SMTP=GLOB(0x85c720)>>> DATA > Net::SMTP=GLOB(0x85c720)<<< 354 End data with <CR><LF>.<CR><LF> > Net::SMTP=GLOB(0x85c720)>>> To: <jeff.blasius@yale.edu> > Net::SMTP=GLOB(0x85c720)>>> Subject: A test message > Net::SMTP=GLOB(0x85c720)>>> > Net::SMTP=GLOB(0x85c720)>>> The message was sent directly via SMTP > using > Net::SMTP > Net::SMTP=GLOB(0x85c720)>>> . > Net::SMTP=GLOB(0x85c720)>>> The message was sent directly via SMTP > using > Net::SMTP > Net::SMTP=GLOB(0x85c720)>>> . > Net::SMTP=GLOB(0x85c720)<<< 250 Ok: queued as 9D5C7320FCA > Net::SMTP=GLOB(0x85c720)>>> QUIT > Net::SMTP=GLOB(0x85c720)<<< 221 Bye > > real 1m54.131s > user 0m0.064s > sys 0m0.013s > >

Tue Mar 14 19:28:47 2006 The RT System itself - Status changed from 'new' to 'open'

Fri Mar 17 10:42:51 2006 jeff.blasius [...] yale.edu - Correspondence added

Subject:	Re: [rt.cpan.org #18175] Net::smtp timeout on Redhat as4
Date:	Fri, 17 Mar 2006 10:42:29 -0500
To:	bug-libnet [...] rt.cpan.org
From:	"Jeff Blasius" <jeff.blasius [...] gmail.com>

FWIW, this was resolved by running postfix in debug mode. It turns out the machine had some undeliverable messages in /var/spool/postfix/maildrop. For some reason Net::SMTP was triggering postfix to attempt to send these messages before the Net::SMTP message. I cleared the maildrop directory and all is well. Thanks, jeff On 3/14/06, Graham Barr via RT <bug-libnet@rt.cpan.org> wrote: Show quoted text

> > <URL: http://rt.cpan.org/Ticket/Display.html?id=18175 > > > On Mar 14, 2006, at 3:48 PM, Guest via RT wrote:

> > While trying to use Net::smtp VERSION = "2.29" on Redhat as4 there > > is a > > 30 second timeout on sending messages. Of course the same script works > > instantly on netlib 1.16 and smtp 2.24/ Redhat 9. Sending mail using > > other methods, such as the simple "mail" command also work instantly. > > Can you help me to problem solve this better? A sample of the test > > below:

> > Unfortunately timeouts is something that can only be debugged by the > person experiencing them. It is highly unlikely that I will be able > to reproduce your specific problem. > > I suggest you make a copy of Net/Cmd.pm and annotate the command, > response and getline methods with debug print statements to try to > see what is happening. > > It looks like getline may not be realizing it has a complete line for > some reason, then the select times out waiting for more data that is > not there. > > Graham. > >

> > > > Thank You, > > jeff > > > > # time ./smtp_test.pl -debug -user jeff.blasius@yale.edu > > Net::SMTP>>> Net::SMTP(2.29) > > Net::SMTP>>> Net::Cmd(2.26) > > Net::SMTP>>> Exporter(5.58) > > Net::SMTP>>> IO::Socket::INET(1.27) > > Net::SMTP>>> IO::Socket(1.28) > > Net::SMTP>>> IO::Handle(1.24) > > Net::SMTP=GLOB(0x85c720)<<< 220 research1.wss.yale.edu ESMTP Postfix > > Net::SMTP=GLOB(0x85c720)>>> EHLO localhost.localdomain > > Net::SMTP=GLOB(0x85c720)<<< 250-research1.wss.yale.edu > > Net::SMTP=GLOB(0x85c720)<<< 250-PIPELINING > > Net::SMTP=GLOB(0x85c720)<<< 250-SIZE 10240000 > > Net::SMTP=GLOB(0x85c720)<<< 250-VRFY > > Net::SMTP=GLOB(0x85c720)<<< 250-ETRN > > Net::SMTP=GLOB(0x85c720)<<< 250 8BITMIME > > Net::SMTP=GLOB(0x85c720)>>> MAIL FROM:<jeff.blasius@yale.edu> > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > > Net::SMTP=GLOB(0x85c720)>>> RCPT TO:<jeff.blasius@yale.edu> > > > > ~60 second timeout > > > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > > Net::SMTP=GLOB(0x85c720)>>> RSET > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > > Net::SMTP=GLOB(0x85c720)>>> MAIL FROM:<jeff.blasius@yale.edu> > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > > Net::SMTP=GLOB(0x85c720)>>> RCPT TO:<jeff.blasius@yale.edu> > > > > ~60 second timeout > > > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok > > Net::SMTP=GLOB(0x85c720)>>> DATA > > Net::SMTP=GLOB(0x85c720)<<< 354 End data with <CR><LF>.<CR><LF> > > Net::SMTP=GLOB(0x85c720)>>> To: <jeff.blasius@yale.edu> > > Net::SMTP=GLOB(0x85c720)>>> Subject: A test message > > Net::SMTP=GLOB(0x85c720)>>> > > Net::SMTP=GLOB(0x85c720)>>> The message was sent directly via SMTP > > using > > Net::SMTP > > Net::SMTP=GLOB(0x85c720)>>> . > > Net::SMTP=GLOB(0x85c720)>>> The message was sent directly via SMTP > > using > > Net::SMTP > > Net::SMTP=GLOB(0x85c720)>>> . > > Net::SMTP=GLOB(0x85c720)<<< 250 Ok: queued as 9D5C7320FCA > > Net::SMTP=GLOB(0x85c720)>>> QUIT > > Net::SMTP=GLOB(0x85c720)<<< 221 Bye > > > > real 1m54.131s > > user 0m0.064s > > sys 0m0.013s > > > >

> > >

Sat Feb 09 20:57:58 2008 GBARR [...] CPAN.ORG - Status changed from 'open' to 'resolved'