#8387: Unbuilt one-hop circuits sometimes hang around forever -------------------------------------------------+------------------------- Reporter: mikeperry | Owner: nickm Type: defect | Status: | needs_information Priority: High | Milestone: Tor: | 0.2.??? Component: Core Tor/Tor | Version: Severity: Normal | Resolution: Keywords: tor-client, 025-triaged, | Actual Points: 027-triaged-1-out 2016-bug-retrospective | Parent ID: | Points: Reviewer: | Sponsor: -------------------------------------------------+-------------------------
Comment (by pastly): I'm getting output related to this ticket every heartbeat it looks like. Running 0294-alpha as a single onion service. The real-time up-to-date log is http://bh2lpa5qyawryvk2.onion/log Tor 0.2.9.4-alpha (git-8b0755c9bb296ae2) running on Linux with Libevent 2.0.10-stable, OpenSSL 1.0.1t and Zlib 1.2.8. Snippit: {{{ Nov 07 07:50:00.000 [notice] Heartbeat: Tor's uptime is 9 days 11:59 hours, with 10 circuits open. I've sent 38.40 MB and received 122.33 MB. Nov 07 07:50:00.000 [notice] Diagnostic for issue 8387: Found 3 one-hop circuits more than 1800 seconds old! Logging 3... Nov 07 07:50:00.000 [notice] #0 created at 2016-11-06 23:49:39. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 07:50:00.000 [notice] #1 created at 2016-11-06 18:23:40. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 07:50:00.000 [notice] #2 created at 2016-11-07 05:29:55. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 07:50:00.000 [notice] It has been 11 seconds since I last called circuit_expire_old_circuits_clientside(). Nov 07 10:07:03.000 [warn] Giving up launching first hop of circuit to rendezvous point [scrubbed] for service bh2lpa5qyawryvk2. Nov 07 10:07:14.000 [warn] Giving up launching first hop of circuit to rendezvous point [scrubbed] for service bh2lpa5qyawryvk2. Nov 07 10:07:44.000 [warn] Giving up launching first hop of circuit to rendezvous point [scrubbed] for service bh2lpa5qyawryvk2. Nov 07 10:08:23.000 [warn] Giving up launching first hop of circuit to rendezvous point [scrubbed] for service bh2lpa5qyawryvk2. Nov 07 13:50:00.000 [notice] Heartbeat: Tor's uptime is 9 days 17:59 hours, with 6 circuits open. I've sent 39.17 MB and received 124.90 MB. Nov 07 13:50:00.000 [notice] Diagnostic for issue 8387: Found 3 one-hop circuits more than 1800 seconds old! Logging 3... Nov 07 13:50:00.000 [notice] #0 created at 2016-11-06 23:49:39. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 13:50:00.000 [notice] #1 created at 2016-11-06 18:23:40. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 13:50:00.000 [notice] #2 created at 2016-11-07 05:29:55. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 13:50:00.000 [notice] It has been 4 seconds since I last called circuit_expire_old_circuits_clientside(). Nov 07 19:01:32.000 [warn] connection_edge_process_relay_cell (at origin) failed. Nov 07 19:50:00.000 [notice] Heartbeat: Tor's uptime is 9 days 23:59 hours, with 6 circuits open. I've sent 40.01 MB and received 128.15 MB. Nov 07 19:50:00.000 [notice] Diagnostic for issue 8387: Found 3 one-hop circuits more than 1800 seconds old! Logging 3... Nov 07 19:50:00.000 [notice] #0 created at 2016-11-06 23:49:39. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 19:50:00.000 [notice] #1 created at 2016-11-07 16:01:03. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 19:50:00.000 [notice] #2 created at 2016-11-07 05:29:55. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 07 19:50:00.000 [notice] It has been 28 seconds since I last called circuit_expire_old_circuits_clientside(). Nov 08 01:50:00.000 [notice] Heartbeat: Tor's uptime is 10 days 5:59 hours, with 7 circuits open. I've sent 40.93 MB and received 131.47 MB. Nov 08 01:50:00.000 [notice] Diagnostic for issue 8387: Found 3 one-hop circuits more than 1800 seconds old! Logging 3... Nov 08 01:50:00.000 [notice] #0 created at 2016-11-07 16:01:03. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 01:50:00.000 [notice] #1 created at 2016-11-07 20:38:25. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 01:50:00.000 [notice] #2 created at 2016-11-07 05:29:55. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 01:50:00.000 [notice] It has been 21 seconds since I last called circuit_expire_old_circuits_clientside(). Nov 08 07:50:00.000 [notice] Heartbeat: Tor's uptime is 10 days 11:59 hours, with 12 circuits open. I've sent 41.66 MB and received 133.95 MB. Nov 08 07:50:00.000 [notice] Diagnostic for issue 8387: Found 3 one-hop circuits more than 1800 seconds old! Logging 3... Nov 08 07:50:00.000 [notice] #0 created at 2016-11-08 04:46:37. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 07:50:00.000 [notice] #1 created at 2016-11-07 16:01:03. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 07:50:00.000 [notice] #2 created at 2016-11-07 20:38:25. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 07:50:00.000 [notice] It has been 14 seconds since I last called circuit_expire_old_circuits_clientside(). Nov 08 13:50:00.000 [notice] Heartbeat: Tor's uptime is 10 days 17:59 hours, with 6 circuits open. I've sent 42.45 MB and received 137.12 MB. Nov 08 13:50:00.000 [notice] Diagnostic for issue 8387: Found 3 one-hop circuits more than 1800 seconds old! Logging 3... Nov 08 13:50:00.000 [notice] #0 created at 2016-11-08 04:46:37. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 13:50:00.000 [notice] #1 created at 2016-11-08 09:17:21. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 13:50:00.000 [notice] #2 created at 2016-11-07 20:38:25. open, Hidden service: Introduction point. Not marked for close. Package window: 1000. usable for new conns. Not marked dirty. Nov 08 13:50:00.000 [notice] It has been 7 seconds since I last called circuit_expire_old_circuits_clientside(). }}} -- Ticket URL: <https://trac.torproject.org/projects/tor/ticket/8387#comment:50> Tor Bug Tracker & Wiki <https://trac.torproject.org/> The Tor Project: anonymity online _______________________________________________ tor-bugs mailing list tor-bugs@lists.torproject.org https://lists.torproject.org/cgi-bin/mailman/listinfo/tor-bugs