[tor-bugs] #28639 [Core Tor/sbws]: After several days, most of the circuits timeout

[Tor Bug Tracker & Wiki]

#28639: After several days, most of the circuits timeout
------------------------------------------+--------------------------------
 Reporter:  juga                          |          Owner:  (none)
     Type:  defect                        |         Status:  new
 Priority:  Medium                        |      Milestone:  sbws:
                                          |  1.0.x-final
Component:  Core Tor/sbws                 |        Version:
 Severity:  Normal                        |     Resolution:
 Keywords:  sbws-1.0-must-moved-20181128  |  Actual Points:
Parent ID:  #25925                        |         Points:
 Reviewer:                                |        Sponsor:
------------------------------------------+--------------------------------

Comment (by teor):

 Replying to [comment:6 juga]:
 > Replying to [comment:1 teor]:
 > > What does tor say in its logs?
 >
 > The main repeated part:
 >
 > {{{
 > Oct 28 05:43:00.000 [notice] Heartbeat: Tor's uptime is 2 days 17:59
 hours, with 7 circuits open. I've sent 15.08 GB and received 482.17 GB.
 > Oct 28 05:43:00.000 [notice] Average packaged cell fullness: 43.617%.
 TLS write overhead: 4%
 > Oct 28 05:50:28.000 [notice] Have tried resolving or connecting to
 address '[scrubbed]' at 3 different places. Giving up.
 > Oct 28 05:57:49.000 [notice] No circuits are opened. Relaxed timeout for
 circuit 40835 (a General-purpose client 2-hop circuit in state doing
 handshakes with channel state open) to 10000ms. However, it appears the
 circuit has timed out anyway. 0 guards are live. [53 similar message(s)
 suppressed in last 3600 seconds]
 > }}}

 The key parts of this message are:
 {{{
 No circuits are opened. Relaxed timeout for circuit
 }}}

 I think we can fix this bug by disabling adaptive timeouts in tor. See
 #28646.

 {{{
 0 guards are live.
 }}}

 > I can't figure out reasons with that, but maybe you do.

 sbws sets `UseEntryGuards 0`, so it should never have any guards:
 https://github.com/torproject/sbws/blob/master/sbws/globals.py#L19

 I need better logs to debug this issue, please implement #28645.

 > There are also some of the type:
 > {{{
 > Oct 26 23:33:59.000 [warn] Tried connecting to router at REDACTED, but
 identity key was not as expected: wanted REDACTED but got REDACTED.
 > }}}

 It is safe to paste these logs without redacting them. sbws just contacts
 relays at random, so there is no need to protect anyone's privacy.

 Once you've done #28645 and #28646, please paste the un-redacted logs in
 this ticket.

--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/28639#comment:7>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online