[tor-dev] Log output cause for concern?

Steve Snyder swsnyder at snydernet.net
Fri Oct 3 01:18:40 UTC 2014


Over 3 days I've gotten 9 instances of the sequence shown below.

This on Tor v0.2.5.8-rc / x86_64.  I am at 80% CPU utilization with
BandwidthRate set to 90Mbps on this 100Mbps interface.

Should I be concerned about this log output, or is it just verbose
because v0.2.5.x is still in development?

---------------------------------------

Sep 30 15:30:08.000 [warn] No unused circIDs found on channel without wide circID support, with 0 inbound and 0 outbound circuits. Found 0 circuit IDs in use by circuits, and 64 with pending destroy cells. (0 of those were marked bogusly.) The ones with pending destroy cells have been marked unusable for an average of 16204 seconds and a maximum of 32369 seconds. This channel is 61794 seconds old. Failing a circuit. [3827 similar message(s) suppressed in last 3600 seconds]
Sep 30 15:30:08.000 [warn]   Circuitmux on this channel has 0 circuits, of which 0 are active. It says it has 32669 destroy cells queued.
Sep 30 15:30:08.000 [warn] Channel 2454544 (at 0x7f3ca1b12720) with transport TLS channel (connection 5592182) is in state open (2)
Sep 30 15:30:08.000 [warn]  * Channel 2454544 was created at 1412029214 (61794 seconds ago) and last active at 1412090927 (81 seconds ago)
Sep 30 15:30:08.000 [warn]  * Channel 2454544 says it is connected to an OR with digest 7CF62B2A0EA73C3621B79118A40F0A9673FA3146 and no known nickname
Sep 30 15:30:08.000 [warn]  * Channel 2454544 says its remote address is [scrubbed], and gives a canonical description of "[scrubbed]" and an actual description of "[scrubbed]"
Sep 30 15:30:08.000 [warn]  * Channel 2454544 has these marks: !bad_for_new_circs canonical is_canonical_is_reliable !client !local outgoing
Sep 30 15:30:08.000 [warn]  * Channel 2454544 has 0 queued incoming cells and 0 queued outgoing cells
Sep 30 15:30:08.000 [warn]  * Channel 2454544 has 0 active circuits out of 0 in total
Sep 30 15:30:08.000 [warn]  * Channel 2454544 was last used by a client at 0 (1412091008 seconds ago)
Sep 30 15:30:08.000 [warn]  * Channel 2454544 was last drained at 1412090927 (81 seconds ago)
Sep 30 15:30:08.000 [warn]  * Channel 2454544 last received a cell at 1412090006 (1002 seconds ago)
Sep 30 15:30:08.000 [warn]  * Channel 2454544 last transmitted a cell at 1412090927 (81 seconds ago)
Sep 30 15:30:08.000 [warn]  * Channel 2454544 has received 381 cells and transmitted 11081
Sep 30 15:30:08.000 [warn]  * Channel 2454544 has averaged 162.188976 seconds between received cells
Sep 30 15:30:08.000 [warn]  * Channel 2454544 has averaged 5.576573 seconds between transmitted cells

Sep 30 19:43:59.000 [notice] Heartbeat: Tor's uptime is 5 days 18:00 hours, with 10312 circuits open. I've sent 3545.65 GB and received 3417.71 GB.
Sep 30 19:43:59.000 [notice] Average packaged cell fullness: 99.112%
Sep 30 19:43:59.000 [notice] TLS write overhead: 3%
Sep 30 19:43:59.000 [notice] Circuit handshake stats since last time: 352835/352843 TAP, 113291/113292 NTor.


More information about the tor-dev mailing list