Re: Tor 0.1.2.2-alpha eventdns timeouts

2006-12-12 Thread Fabian Keil
Nick Mathewson <[EMAIL PROTECTED]> wrote:

> On Thu, Oct 26, 2006 at 06:49:57PM +0200, Fabian Keil wrote:
>  [...]
> > As a result I see indeed a lot less timeout warnings,
> > and the servers are declared active right away, but it
> > also looks as if the number of timeouts isn't reset
> > correctly:
> 
> My apologies for the delay here.  Your diagnosis turned out to be
> completely correct.  I was looking for far more tricky problems, when
> the root cause turned out to be (I think) that eventdns.c never
> actually reset the timeout count.  Oops! I've checked a patch in to
> subversion as r9054; if you have a chance to see whether it fixes the
> problem for you, I'd be most grateful.

I patched Tor 0.1.2.4-alpha about half an hour ago,
so I can't be sure yet, but it looks as if the patch
causes less timeout warnings, but more "Bad response 2"
messages.

This is a log excerpt from vanilla Tor 0.1.2.4-alpha:

Dec 12 18:55:11.676 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 17:46:01.083 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 17:53:45.157 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 17:53:55.158 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:02:27.201 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 18:02:37.242 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:12:59.581 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 18:13:09.582 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:13:19.784 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 18:13:29.785 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:33:15.708 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 18:33:16.746 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:43:00.952 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 18:43:02.706 [warn] eventdns: Nameserver 81.169.148.34 is back up

This is with your patch applied:

Dec 12 18:47:11.260 [notice] Self-testing indicates your DirPort is reachable 
from the outside. Excellent.
Dec 12 18:48:09.113 [notice] Performing bandwidth self-test.
Dec 12 18:55:11.676 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Dec 12 18:55:21.677 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:55:37.977 [warn] eventdns: Nameserver 81.169.148.34 has failed: Bad 
response 2 (server failed)
Dec 12 18:55:47.978 [warn] eventdns: Nameserver 81.169.148.34 is back up
Dec 12 18:59:26.843 [warn] eventdns: Nameserver 81.169.148.164 has failed: Bad 
response 2 (server failed)
Dec 12 18:59:34.863 [warn] eventdns: Nameserver 81.169.148.34 has failed: Bad 
response 2 (server failed)
Dec 12 18:59:34.864 [warn] eventdns: All nameservers have failed
Dec 12 18:59:36.843 [warn] eventdns: Nameserver 81.169.148.164 is back up
Dec 12 18:59:44.864 [warn] eventdns: Nameserver 81.169.148.34 is back up

I already did get some "Bad response 2" before,
so this could be a coincidence.

As I said, it's not running long enough to be sure,
but it at least looks as if there's still some problem left.

Fabian
-- 
http://www.fabiankeil.de/


signature.asc
Description: PGP signature


Re: Tor 0.1.2.2-alpha eventdns timeouts

2006-12-07 Thread Nick Mathewson
On Thu, Oct 26, 2006 at 06:49:57PM +0200, Fabian Keil wrote:
 [...]
> As a result I see indeed a lot less timeout warnings,
> and the servers are declared active right away, but it
> also looks as if the number of timeouts isn't reset
> correctly:

My apologies for the delay here.  Your diagnosis turned out to be
completely correct.  I was looking for far more tricky problems, when
the root cause turned out to be (I think) that eventdns.c never
actually reset the timeout count.  Oops! I've checked a patch in to
subversion as r9054; if you have a chance to see whether it fixes the
problem for you, I'd be most grateful.

yrs,
-- 
Nick Mathewson


pgptOe8IBfR0T.pgp
Description: PGP signature


Re: Tor 0.1.2.2-alpha eventdns timeouts

2006-10-26 Thread Fabian Keil
Nick Mathewson <[EMAIL PROTECTED]> wrote:

> On Mon, Oct 23, 2006 at 12:48:48PM +0200, Fabian Keil wrote:
>  [...]
> > Oct 23 12:09:06.074 [warn] eventdns: Nameserver 10.0.0.4 is back up
> > 
> > This always seems to happen if there are more than a few (<5)
> > DNS requests per second. Am I the only one seeing this?
> 
> No, this seems to be a (relatively harmless) bug with our eventdns
> code.  I'm hoping to have it fixed soon; please let us know if it
> appears in later versions.
> 
> Also, you can check to see whether bugs are already reported by
> checking our bugtracker at:
> 
>http://bugs.noreply.org/flyspray/index.php?tasks=all&project=4

I'll keep that in mind, thanks.

> This is bug 326:
> 
>http://bugs.noreply.org/flyspray/index.php?do=details&id=326

Is "timeout threshold is set too low, and the threshold for declaring
a server down is set too low" still the current analysis?

I increased global_max_retransmits and global_max_nameserver_timeout
from 3 to 5 and changed global_timeout from {3, 0} to {20, 0}.

As eventdns used to complaint from time to time about
"Bad response 2 (server failed)" and I didn't find a threshold
for these cases, I also added {0, 0} at the beginning of
global_nameserver_timeouts[], to make sure the server wouldn't
be ignored for ten seconds.

As a result I see indeed a lot less timeout warnings,
and the servers are declared active right away, but it
also looks as if the number of timeouts isn't reset
correctly:

Oct 26 18:00:26.467 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Oct 26 18:00:26.469 [warn] eventdns: Nameserver 81.169.148.34 is back up
[ten DNS requests successful]
Oct 26 18:00:35.962 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Oct 26 18:00:36.017 [warn] eventdns: Nameserver 81.169.148.34 is back up
[thirteen DNS requests succesful]
Oct 26 18:00:55.992 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Oct 26 18:00:56.008 [warn] eventdns: Nameserver 81.169.148.34 is back up

I assumed that there should be at least global_timeout seconds
between the last successful DNS requests, and a DNS server being
marked as down because of timeouts?

Fabian
-- 
http://www.fabiankeil.de/


signature.asc
Description: PGP signature


Re: Tor 0.1.2.2-alpha eventdns timeouts

2006-10-23 Thread Nick Mathewson
On Mon, Oct 23, 2006 at 12:48:48PM +0200, Fabian Keil wrote:
 [...]
> Oct 23 12:09:06.074 [warn] eventdns: Nameserver 10.0.0.4 is back up
> 
> This always seems to happen if there are more than a few (<5)
> DNS requests per second. Am I the only one seeing this?

No, this seems to be a (relatively harmless) bug with our eventdns
code.  I'm hoping to have it fixed soon; please let us know if it
appears in later versions.

Also, you can check to see whether bugs are already reported by
checking our bugtracker at:

   http://bugs.noreply.org/flyspray/index.php?tasks=all&project=4


This is bug 326:

   http://bugs.noreply.org/flyspray/index.php?do=details&id=326

yrs,
-- 
Nick Mathewson


pgpSjxLM119Lr.pgp
Description: PGP signature


Re: Tor 0.1.2.2-alpha eventdns timeouts

2006-10-23 Thread Enigma
Hi,

I have the same problem each time I start my home server (Windows XP
SP2), I get those lines a few times (however, it shows my local IP, not
my remote IP) but despite that everything seems to be normal. Usually
the last line ends like yours: .. is back up. So I believe since it ends
with "is back up" everything is okay... I hope?

Sincerely,
Enigma

-- 
German Tor mailing list / surveillance and its risks:
http://www.anti1984.com





Fabian Keil schrieb:
> With Tor 0.1.2.2-alpha running as exit node on
> FreeBSD 7.0-CURRENT I constantly get warnings
> like:
>
> Oct 23 11:56:02.760 [warn] eventdns: Nameserver 10.0.0.4 is back up
> Oct 23 11:56:21.183 [warn] eventdns: Nameserver 81.169.148.164 has failed: 
> Bad response 2 (server failed)
> Oct 23 11:56:23.770 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
> request timed out.
> Oct 23 11:56:31.185 [warn] eventdns: Nameserver 81.169.148.164 is back up
> Oct 23 11:56:33.776 [warn] eventdns: Nameserver 81.169.148.34 is back up
> Oct 23 11:58:47.232 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
> request timed out.
> Oct 23 11:58:48.867 [warn] eventdns: Nameserver 81.169.148.34 is back up
> Oct 23 11:59:05.767 [warn] eventdns: Nameserver 81.169.148.164 has failed: 
> request timed out.
> Oct 23 11:59:15.802 [warn] eventdns: Nameserver 81.169.148.164 is back up
> Oct 23 12:02:02.180 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
> request timed out.
> Oct 23 12:02:12.182 [warn] eventdns: Nameserver 81.169.148.34 is back up
> Oct 23 12:08:50.727 [warn] eventdns: Nameserver 81.169.148.34 has failed: Bad 
> response 2 (server failed)
> Oct 23 12:08:53.062 [warn] eventdns: Nameserver 81.169.148.164 has failed: 
> request timed out.
> Oct 23 12:08:56.068 [warn] eventdns: Nameserver 10.0.0.4 has failed: request 
> timed out.
> Oct 23 12:08:57.148 [warn] eventdns: Nameserver 81.169.148.34 is back up
> Oct 23 12:09:03.064 [warn] eventdns: Nameserver 81.169.148.164 is back up
> Oct 23 12:09:06.074 [warn] eventdns: Nameserver 10.0.0.4 is back up
>
> This always seems to happen if there are more than a few (<5)
> DNS requests per second. Am I the only one seeing this?
>
> Fabian
>   


Tor 0.1.2.2-alpha eventdns timeouts

2006-10-23 Thread Fabian Keil
With Tor 0.1.2.2-alpha running as exit node on
FreeBSD 7.0-CURRENT I constantly get warnings
like:

Oct 23 11:56:02.760 [warn] eventdns: Nameserver 10.0.0.4 is back up
Oct 23 11:56:21.183 [warn] eventdns: Nameserver 81.169.148.164 has failed: Bad 
response 2 (server failed)
Oct 23 11:56:23.770 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Oct 23 11:56:31.185 [warn] eventdns: Nameserver 81.169.148.164 is back up
Oct 23 11:56:33.776 [warn] eventdns: Nameserver 81.169.148.34 is back up
Oct 23 11:58:47.232 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Oct 23 11:58:48.867 [warn] eventdns: Nameserver 81.169.148.34 is back up
Oct 23 11:59:05.767 [warn] eventdns: Nameserver 81.169.148.164 has failed: 
request timed out.
Oct 23 11:59:15.802 [warn] eventdns: Nameserver 81.169.148.164 is back up
Oct 23 12:02:02.180 [warn] eventdns: Nameserver 81.169.148.34 has failed: 
request timed out.
Oct 23 12:02:12.182 [warn] eventdns: Nameserver 81.169.148.34 is back up
Oct 23 12:08:50.727 [warn] eventdns: Nameserver 81.169.148.34 has failed: Bad 
response 2 (server failed)
Oct 23 12:08:53.062 [warn] eventdns: Nameserver 81.169.148.164 has failed: 
request timed out.
Oct 23 12:08:56.068 [warn] eventdns: Nameserver 10.0.0.4 has failed: request 
timed out.
Oct 23 12:08:57.148 [warn] eventdns: Nameserver 81.169.148.34 is back up
Oct 23 12:09:03.064 [warn] eventdns: Nameserver 81.169.148.164 is back up
Oct 23 12:09:06.074 [warn] eventdns: Nameserver 10.0.0.4 is back up

This always seems to happen if there are more than a few (<5)
DNS requests per second. Am I the only one seeing this?

Fabian
-- 
http://www.fabiankeil.de/


signature.asc
Description: PGP signature