The file on the server exists, but access is denied at the first attempt. One
of the following
attempts succeeds, but wget fails to download the file.
This happens with a fresh checkout of 1.10.2, compiled with --with-ssl
~/.wgetrc contains just one line: 'wait = 3'
> /tmp/wget-test/wget-1.10.2+devel/src/wget -d
'ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm'
DEBUG output created by Wget 1.10.2+devel on linux-gnu.
Using `.listing' as listing tmp file.
--15:44:53--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm
=> `.listing'
Resolving download.fedora.redhat.com... 66.187.224.20, 209.132.176.220,
209.132.176.221, ...
Caching download.fedora.redhat.com => 66.187.224.20 209.132.176.220
209.132.176.221 209.132.176.20
Connecting to download.fedora.redhat.com|66.187.224.20|:21... connected.
Created socket 3.
Releasing 0x0998ba10 (new refcount 1).
Logging in as anonymous ... 421 There are too many connections from your
internet address.
Error in server greeting.
Closed fd 3
Retrying.
--15:44:56--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm
(try: 2) => `.listing'
Found download.fedora.redhat.com in host_name_addresses_map (0x998ba10)
Connecting to download.fedora.redhat.com|66.187.224.20|:21... connected.
Created socket 3.
Releasing 0x0998ba10 (new refcount 1).
Logging in as anonymous ... 421 There are too many connections from your
internet address.
Error in server greeting.
Closed fd 3
Retrying.
--15:45:00--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm
(try: 3) => `.listing'
Found download.fedora.redhat.com in host_name_addresses_map (0x998ba10)
Connecting to download.fedora.redhat.com|66.187.224.20|:21... connected.
Created socket 3.
Releasing 0x0998ba10 (new refcount 1).
Logging in as anonymous ... 421 There are too many connections from your
internet address.
Error in server greeting.
Closed fd 3
Retrying.
--15:45:03--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm
(try: 4) => `.listing'
Found download.fedora.redhat.com in host_name_addresses_map (0x998ba10)
Connecting to download.fedora.redhat.com|66.187.224.20|:21... connected.
Created socket 3.
Releasing 0x0998ba10 (new refcount 1).
Logging in as anonymous ... 421 There are too many connections from your
internet address.
Error in server greeting.
Closed fd 3
Retrying.
--15:45:06--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm
(try: 5) => `.listing'
Found download.fedora.redhat.com in host_name_addresses_map (0x998ba10)
Connecting to download.fedora.redhat.com|66.187.224.20|:21... connected.
Created socket 3.
Releasing 0x0998ba10 (new refcount 1).
Logging in as anonymous ... 220 Fedora FTP server ready. All transfers are
logged. [no EPSV]
--> USER anonymous
331 Please specify the password.
--> PASS -wget@
230 Login successful.
Logged in!
==> SYST ...
--> SYST
215 UNIX Type: L8
done. ==> PWD ...
--> PWD
257 "/"
done.
==> TYPE I ...
--> TYPE I
200 Switching to Binary mode.
done. ==> CWD not required.
conaddr is: 66.187.224.20
==> PASV ...
--> PASV
227 Entering Passive Mode (66,187,224,20,50,26)
trying to connect to 66.187.224.20 port 12826
Created socket 5.
done. ==> LIST ...
--> LIST
150 Here comes the directory listing.
done.
[ <=>
] 126
--.--K/s
Closed fd 5
226 Directory send OK.
15:45:08 (517.00 KB/s) - `.listing' saved [126]
DIRECTORY; perms 751; month: Mar; day: 16; time: 19:57:00 (no yr);
DIRECTORY; perms 755; month: Oct; day: 29; year: 2003 (no tm);
Removed `.listing'.
No matches on pattern `bind*9.3.1-18.FC4.i386.rpm'.
Closed fd 3
When the server isn't that busy or there aren't so many connections from the
same IP, the same command succeeds:
>/tmp/wget-test/wget-1.10.2+devel/src/wget -d
'ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm'
DEBUG output created by Wget 1.10.2+devel on linux-gnu.
Using `.listing' as listing tmp file.
--15:47:05--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind*9.3.1-18.FC4.i386.rpm
=> `.listing'
Resolving download.fedora.redhat.com... 66.187.224.20, 209.132.176.20,
209.132.176.220, ...
Caching download.fedora.redhat.com => 66.187.224.20 209.132.176.20
209.132.176.220 209.132.176.221
Connecting to download.fedora.redhat.com|66.187.224.20|:21... connected.
Created socket 3.
Releasing 0x09920a10 (new refcount 1).
Logging in as anonymous ... 220 Fedora FTP server ready. All transfers are
logged. [no EPSV]
--> USER anonymous
331 Please specify the password.
--> PASS -wget@
230 Login successful.
Logged in!
==> SYST ...
--> SYST
215 UNIX Type: L8
done. ==> PWD ...
--> PWD
257 "/"
done.
==> TYPE I ...
--> TYPE I
200 Switching to Binary mode.
done. changing working directory
Prepended initial PWD to relative path:
pwd: '/'
old: 'pub/fedora/linux/core/updates/4/i386'
new: '/pub/fedora/linux/core/updates/4/i386'
==> CWD /pub/fedora/linux/core/updates/4/i386 ...
--> CWD /pub/fedora/linux/core/updates/4/i386
250 Directory successfully changed.
done.
conaddr is: 66.187.224.20
==> PASV ...
--> PASV
227 Entering Passive Mode (66,187,224,20,40,183)
trying to connect to 66.187.224.20 port 10423
Created socket 5.
done. ==> LIST ...
--> LIST
150 Here comes the directory listing.
done.
[ <=>
] 74.843
114.35K/s
Closed fd 5
226 Directory send OK.
15:47:08 (114.20 KB/s) - `.listing' saved [74843]
PLAINFILE; perms 644; month: Jun; day: 24; year: 2005 (no tm);
PLAINFILE; perms 644; month: Dec; day: 14; time: 19:13:00 (no yr);
PLAINFILE; perms 644; month: Dec; day: 14; time: 19:13:00 (no yr);
PLAINFILE; perms 644; month: Feb; day: 22; time: 21:12:00 (no yr);
PLAINFILE; perms 644; month: Feb; day: 22; time: 21:12:00 (no yr);
PLAINFILE; perms 644; month: Mar; day: 16; time: 18:46:00 (no yr);
....
PLAINFILE; perms 644; month: Dec; day: 12; time: 18:11:00 (no yr);
PLAINFILE; perms 644; month: Jul; day: 22; year: 2005 (no tm);
PLAINFILE; perms 644; month: Jul; day: 22; year: 2005 (no tm);
Removed `.listing'.
--15:47:12--
ftp://download.fedora.redhat.com/pub/fedora/linux/core/updates/4/i386/bind-9.3.1-18.FC4.i386.rpm
=> `bind-9.3.1-18.FC4.i386.rpm'
changing working directory
Prepended initial PWD to relative path:
pwd: '/'
old: 'pub/fedora/linux/core/updates/4/i386'
new: '/pub/fedora/linux/core/updates/4/i386'
==> CWD /pub/fedora/linux/core/updates/4/i386 ...
--> CWD /pub/fedora/linux/core/updates/4/i386
250 Directory successfully changed.
done.
conaddr is: 66.187.224.20
==> PASV ...
--> PASV
227 Entering Passive Mode (66,187,224,20,58,13)
trying to connect to 66.187.224.20 port 14861
Created socket 5.
done. ==> RETR bind-9.3.1-18.FC4.i386.rpm ...
--> RETR bind-9.3.1-18.FC4.i386.rpm
150 Opening BINARY mode data connection for bind-9.3.1-18.FC4.i386.rpm (547356
bytes).
done.
Length: 547.356 (535K)
100%[=========================================================================================================================================>]
547.356 311.53K/s
Closed fd 5
...
This is easy to reproduce, just start the wget command a few times and kill it
when the login succeeded. When there
are enough connections from your site, the first login will fail and you can
reproduce the problem.
Karsten
--
Learn. Network. Experience open source.
Red Hat Summit Nashville | May 30 - June 2, 2006
Learn more: http://www.redhat.com/promo/summit/
|
