[tor-bugs] #12184 [Tor]: Circuit on detached list which I had no reason to mark

Tor Bug Tracker & Wiki blackhole at torproject.org
Sun Aug 10 10:05:48 UTC 2014


#12184: Circuit on detached list which I had no reason to mark
-----------------------------+--------------------------------------
     Reporter:  cypherpunks  |      Owner:
         Type:  defect       |     Status:  needs_information
     Priority:  major        |  Milestone:  Tor: 0.2.5.x-final
    Component:  Tor          |    Version:  Tor: 0.2.5.4-alpha
   Resolution:               |   Keywords:  024-backport 025-triaged
Actual Points:               |  Parent ID:
       Points:               |
-----------------------------+--------------------------------------

Comment (by reezer):

 Getting more of these. Posting the whole log since startup. Hope that's
 okay.

 {{{
 Aug 07 18:53:53.000 [notice] Tor 0.2.5.6-alpha (git-390728d85644a6c0)
 opening log file.
 Aug 07 18:53:53.000 [notice] Parsing GEOIP IPv4 file
 /usr/local/share/tor/geoip.
 Aug 07 18:53:53.000 [notice] Parsing GEOIP IPv6 file
 /usr/local/share/tor/geoip6.
 Aug 07 18:53:53.000 [notice] Configured to measure statistics. Look for
 the *-stats files that will first be written to the data directory in 24
 hours from now.
 Aug 07 18:53:53.000 [notice] Default OpenSSL engine for RSA is BSD
 cryptodev engine [cryptodev]
 Aug 07 18:53:53.000 [notice] Default OpenSSL engine for DH is BSD
 cryptodev engine [cryptodev]
 Aug 07 18:53:53.000 [notice] Default OpenSSL engine for AES-128-CBC is BSD
 cryptodev engine [cryptodev]
 Aug 07 18:53:53.000 [notice] Default OpenSSL engine for AES-256-CBC is BSD
 cryptodev engine [cryptodev]
 Aug 07 18:53:53.000 [notice] Caching new entry _tor for _tor
 Aug 07 18:53:53.000 [notice] Caching new entry _tor for _tor
 Aug 07 18:53:53.000 [notice] Your Tor server's identity key fingerprint is
 'pixelminer CE75BF0972ADD52AF8807602374E495C815DB304'
 Aug 07 18:53:53.000 [notice] Bootstrapped 0%: Starting
 Aug 07 18:53:58.000 [notice] We now have enough directory information to
 build circuits.
 Aug 07 18:53:58.000 [notice] Bootstrapped 80%: Connecting to the Tor
 network
 Aug 07 18:53:58.000 [notice] Self-testing indicates your ORPort is
 reachable from the outside. Excellent. Publishing server descriptor.
 Aug 07 18:53:58.000 [notice] Bootstrapped 85%: Finishing handshake with
 first hop
 Aug 07 18:53:59.000 [notice] Bootstrapped 90%: Establishing a Tor circuit
 Aug 07 18:54:00.000 [notice] Tor has successfully opened a circuit. Looks
 like client functionality is working.
 Aug 07 18:54:00.000 [notice] Bootstrapped 100%: Done
 Aug 07 18:55:00.000 [notice] Self-testing indicates your DirPort is
 reachable from the outside. Excellent.
 Aug 07 18:55:01.000 [notice] Performing bandwidth self-test...done.
 Aug 08 00:53:59.000 [notice] Heartbeat: Tor's uptime is 6:00 hours, with
 12407 circuits open. I've sent 251.20 GB and received 240.97 GB.
 Aug 08 00:53:59.000 [notice] Average packaged cell fullness: 99.222%
 Aug 08 00:53:59.000 [notice] TLS write overhead: 3%
 Aug 08 00:53:59.000 [notice] Circuit handshake stats since last time:
 589649/589649 TAP, 107361/107361 NTor.
 Aug 08 01:49:44.000 [warn] Unexpected onionskin length after decryption:
 58
 Aug 08 06:53:59.000 [notice] Heartbeat: Tor's uptime is 12:00 hours, with
 14661 circuits open. I've sent 453.43 GB and received 435.17 GB.
 Aug 08 06:53:59.000 [notice] Average packaged cell fullness: 99.228%
 Aug 08 06:53:59.000 [notice] TLS write overhead: 3%
 Aug 08 06:53:59.000 [notice] Circuit handshake stats since last time:
 440176/440176 TAP, 89561/89561 NTor.
 Aug 08 10:52:27.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 12191 seconds and a maximum of 26305 seconds.
 This channel is 36597 seconds old. Failing a circuit.
 Aug 08 10:52:27.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 29899 destroy cells queued.
 Aug 08 10:52:27.000 [warn] Channel 168983 (at 0x808874c80) with transport
 TLS channel (connection 387334) is in state open (2)
 Aug 08 10:52:27.000 [warn]  * Channel 168983 was created at 1407458550
 (36597 seconds ago) and last active at 1407495115 (32 seconds ago)
 Aug 08 10:52:27.000 [warn]  * Channel 168983 says it is connected to an OR
 with digest 4C733BAC82CC609ACC58AD95BFBFF04D5D06188C and no known nickname
 Aug 08 10:52:27.000 [warn]  * Channel 168983 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 08 10:52:27.000 [warn]  * Channel 168983 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 08 10:52:27.000 [warn]  * Channel 168983 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 08 10:52:27.000 [warn]  * Channel 168983 has 0 active circuits out of
 0 in total
 Aug 08 10:52:27.000 [warn]  * Channel 168983 was last used by a client at
 0 (1407495147 seconds ago)
 Aug 08 10:52:27.000 [warn]  * Channel 168983 was last drained at
 1407495064 (83 seconds ago)
 Aug 08 10:52:27.000 [warn]  * Channel 168983 last received a cell at
 1407495115 (32 seconds ago)
 Aug 08 10:52:27.000 [warn]  * Channel 168983 last transmitted a cell at
 1407495064 (83 seconds ago)
 Aug 08 10:52:27.000 [warn]  * Channel 168983 has received 351 cells and
 transmitted 8517
 Aug 08 10:52:27.000 [warn]  * Channel 168983 has averaged 104.264957
 seconds between received cells
 Aug 08 10:52:27.000 [warn]  * Channel 168983 has averaged 4.296936 seconds
 between transmitted cells
 Aug 08 10:52:27.000 [warn] failed to get unique circID.
 Aug 08 12:53:59.000 [notice] Heartbeat: Tor's uptime is 18:00 hours, with
 16917 circuits open. I've sent 685.60 GB and received 656.94 GB.
 Aug 08 12:53:59.000 [notice] Average packaged cell fullness: 99.219%
 Aug 08 12:53:59.000 [notice] TLS write overhead: 3%
 Aug 08 12:53:59.000 [notice] Circuit handshake stats since last time:
 582606/582606 TAP, 89096/89096 NTor.
 Aug 08 18:53:54.000 [notice] Caching new entry _tor for _tor
 Aug 08 18:53:59.000 [notice] Heartbeat: Tor's uptime is 1 day 0:00 hours,
 with 19417 circuits open. I've sent 934.30 GB and received 894.42 GB.
 Aug 08 18:53:59.000 [notice] Average packaged cell fullness: 99.204%
 Aug 08 18:53:59.000 [notice] TLS write overhead: 3%
 Aug 08 18:53:59.000 [notice] Circuit handshake stats since last time:
 747335/747335 TAP, 111457/111457 NTor.
 Aug 08 21:08:56.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4 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 9479 seconds and a maximum of 20277 seconds.
 This channel is 33029 seconds old. Failing a circuit.
 Aug 08 21:08:56.000 [warn]   Circuitmux on this channel has 4 circuits, of
 which 3 are active. It says it has 28810 destroy cells queued.
 Aug 08 21:08:56.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 08 21:08:56.000 [warn]  * Channel 470025 was created at 1407499107
 (33029 seconds ago) and last active at 1407532064 (72 seconds ago)
 Aug 08 21:08:56.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 08 21:08:56.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 08 21:08:56.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 08 21:08:56.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 08 21:08:56.000 [warn]  * Channel 470025 has 3 active circuits out of
 4 in total
 Aug 08 21:08:56.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407532136 seconds ago)
 Aug 08 21:08:56.000 [warn]  * Channel 470025 was last drained at
 1407531711 (425 seconds ago)
 Aug 08 21:08:56.000 [warn]  * Channel 470025 last received a cell at
 1407532064 (72 seconds ago)
 Aug 08 21:08:56.000 [warn]  * Channel 470025 last transmitted a cell at
 1407531711 (425 seconds ago)
 Aug 08 21:08:56.000 [warn]  * Channel 470025 has received 1111 cells and
 transmitted 7739
 Aug 08 21:08:56.000 [warn]  * Channel 470025 has averaged 29.729073
 seconds between received cells
 Aug 08 21:08:56.000 [warn]  * Channel 470025 has averaged 4.267864 seconds
 between transmitted cells
 Aug 08 21:08:56.000 [warn] failed to get unique circID. [173 similar
 message(s) suppressed in last 9600 seconds]
 Aug 08 22:09:03.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294966947 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 9669 seconds and a maximum of 22486
 seconds. This channel is 36636 seconds old. Failing a circuit. [352
 similar message(s) suppressed in last 3600 seconds]
 Aug 08 22:09:03.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=32391. queue_size=32391. manual_total=32391.
 manual_total_in_map=32038.
 Aug 08 22:09:03.000 [warn]   Circuitmux on this channel has 4 circuits, of
 which 3 are active. It says it has 32391 destroy cells queued.
 Aug 08 22:09:03.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 08 22:09:03.000 [warn]  * Channel 470025 was created at 1407499107
 (36636 seconds ago) and last active at 1407535711 (32 seconds ago)
 Aug 08 22:09:03.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 08 22:09:03.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 08 22:09:03.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 08 22:09:03.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 08 22:09:03.000 [warn]  * Channel 470025 has 3 active circuits out of
 4 in total
 Aug 08 22:09:03.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407535743 seconds ago)
 Aug 08 22:09:03.000 [warn]  * Channel 470025 was last drained at
 1407535711 (32 seconds ago)
 Aug 08 22:09:03.000 [warn]  * Channel 470025 last received a cell at
 1407535496 (247 seconds ago)
 Aug 08 22:09:03.000 [warn]  * Channel 470025 last transmitted a cell at
 1407535711 (32 seconds ago)
 Aug 08 22:09:03.000 [warn]  * Channel 470025 has received 1157 cells and
 transmitted 9472
 Aug 08 22:09:03.000 [warn]  * Channel 470025 has averaged 31.664650
 seconds between received cells
 Aug 08 22:09:03.000 [warn]  * Channel 470025 has averaged 3.867821 seconds
 between transmitted cells
 Aug 08 23:09:03.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294963843 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 13802 seconds and a maximum of 24216
 seconds. This channel is 40236 seconds old. Failing a circuit. [3100
 similar message(s) suppressed in last 3600 seconds]
 Aug 08 23:09:03.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=35988. queue_size=35988. manual_total=35988.
 manual_total_in_map=32534.
 Aug 08 23:09:03.000 [warn]   Circuitmux on this channel has 1 circuits, of
 which 1 are active. It says it has 35988 destroy cells queued.
 Aug 08 23:09:03.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 08 23:09:03.000 [warn]  * Channel 470025 was created at 1407499107
 (40236 seconds ago) and last active at 1407539211 (132 seconds ago)
 Aug 08 23:09:03.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 08 23:09:03.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 08 23:09:03.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 08 23:09:03.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 08 23:09:03.000 [warn]  * Channel 470025 has 1 active circuits out of
 1 in total
 Aug 08 23:09:03.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407539343 seconds ago)
 Aug 08 23:09:03.000 [warn]  * Channel 470025 was last drained at
 1407539211 (132 seconds ago)
 Aug 08 23:09:03.000 [warn]  * Channel 470025 last received a cell at
 1407538905 (438 seconds ago)
 Aug 08 23:09:03.000 [warn]  * Channel 470025 last transmitted a cell at
 1407539211 (132 seconds ago)
 Aug 08 23:09:03.000 [warn]  * Channel 470025 has received 1184 cells and
 transmitted 11506
 Aug 08 23:09:03.000 [warn]  * Channel 470025 has averaged 33.983108
 seconds between received cells
 Aug 08 23:09:03.000 [warn]  * Channel 470025 has averaged 3.496958 seconds
 between transmitted cells
 Aug 08 23:48:56.000 [warn] failed to get unique circID. [6268 similar
 message(s) suppressed in last 9600 seconds]
 Aug 09 00:09:03.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294959578 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 12737 seconds and a maximum of 26003
 seconds. This channel is 43836 seconds old. Failing a circuit. [4264
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 00:09:03.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=40192. queue_size=40192. manual_total=40192.
 manual_total_in_map=32473.
 Aug 09 00:09:03.000 [warn]   Circuitmux on this channel has 1 circuits, of
 which 0 are active. It says it has 40192 destroy cells queued.
 Aug 09 00:09:03.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 00:09:03.000 [warn]  * Channel 470025 was created at 1407499107
 (43836 seconds ago) and last active at 1407542941 (2 seconds ago)
 Aug 09 00:09:03.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 00:09:03.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 00:09:03.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 00:09:03.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 00:09:03.000 [warn]  * Channel 470025 has 0 active circuits out of
 1 in total
 Aug 09 00:09:03.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407542943 seconds ago)
 Aug 09 00:09:03.000 [warn]  * Channel 470025 was last drained at
 1407542941 (2 seconds ago)
 Aug 09 00:09:03.000 [warn]  * Channel 470025 last received a cell at
 1407542525 (418 seconds ago)
 Aug 09 00:09:03.000 [warn]  * Channel 470025 last transmitted a cell at
 1407542941 (2 seconds ago)
 Aug 09 00:09:03.000 [warn]  * Channel 470025 has received 1193 cells and
 transmitted 13295
 Aug 09 00:09:03.000 [warn]  * Channel 470025 has averaged 36.744342
 seconds between received cells
 Aug 09 00:09:03.000 [warn]  * Channel 470025 has averaged 3.297179 seconds
 between transmitted cells
 Aug 09 00:53:59.000 [notice] Heartbeat: Tor's uptime is 1 day 6:00 hours,
 with 16366 circuits open. I've sent 1231.13 GB and received 1180.03 GB.
 Aug 09 00:53:59.000 [notice] Average packaged cell fullness: 99.210%
 Aug 09 00:53:59.000 [notice] TLS write overhead: 3%
 Aug 09 00:53:59.000 [notice] Circuit handshake stats since last time:
 876089/876089 TAP, 175127/175127 NTor.
 Aug 09 01:09:03.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294954530 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 17421 seconds and a maximum of 28574
 seconds. This channel is 47436 seconds old. Failing a circuit. [5046
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 01:09:03.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=45357. queue_size=45357. manual_total=45357.
 manual_total_in_map=32591.
 Aug 09 01:09:03.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 45357 destroy cells queued.
 Aug 09 01:09:03.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 01:09:03.000 [warn]  * Channel 470025 was created at 1407499107
 (47436 seconds ago) and last active at 1407546404 (139 seconds ago)
 Aug 09 01:09:03.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 01:09:03.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 01:09:03.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 01:09:03.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 01:09:03.000 [warn]  * Channel 470025 has 0 active circuits out of
 0 in total
 Aug 09 01:09:03.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407546543 seconds ago)
 Aug 09 01:09:03.000 [warn]  * Channel 470025 was last drained at
 1407546384 (159 seconds ago)
 Aug 09 01:09:03.000 [warn]  * Channel 470025 last received a cell at
 1407546104 (439 seconds ago)
 Aug 09 01:09:03.000 [warn]  * Channel 470025 last transmitted a cell at
 1407546384 (159 seconds ago)
 Aug 09 01:09:03.000 [warn]  * Channel 470025 has received 1200 cells and
 transmitted 14782
 Aug 09 01:09:03.000 [warn]  * Channel 470025 has averaged 39.530000
 seconds between received cells
 Aug 09 01:09:03.000 [warn]  * Channel 470025 has averaged 3.209038 seconds
 between transmitted cells
 Aug 09 02:09:04.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294949612 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 17100 seconds and a maximum of 29546
 seconds. This channel is 51037 seconds old. Failing a circuit. [4918
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 02:09:04.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=50306. queue_size=50306. manual_total=50306.
 manual_total_in_map=32621.
 Aug 09 02:09:04.000 [warn]   Circuitmux on this channel has 1 circuits, of
 which 1 are active. It says it has 50306 destroy cells queued.
 Aug 09 02:09:04.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 02:09:04.000 [warn]  * Channel 470025 was created at 1407499107
 (51037 seconds ago) and last active at 1407550073 (71 seconds ago)
 Aug 09 02:09:04.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 02:09:04.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 02:09:04.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 02:09:04.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 02:09:04.000 [warn]  * Channel 470025 has 1 active circuits out of
 1 in total
 Aug 09 02:09:04.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407550144 seconds ago)
 Aug 09 02:09:04.000 [warn]  * Channel 470025 was last drained at
 1407550000 (144 seconds ago)
 Aug 09 02:09:04.000 [warn]  * Channel 470025 last received a cell at
 1407550073 (71 seconds ago)
 Aug 09 02:09:04.000 [warn]  * Channel 470025 last transmitted a cell at
 1407550000 (144 seconds ago)
 Aug 09 02:09:04.000 [warn]  * Channel 470025 has received 1214 cells and
 transmitted 16801
 Aug 09 02:09:04.000 [warn]  * Channel 470025 has averaged 42.040362
 seconds between received cells
 Aug 09 02:09:04.000 [warn]  * Channel 470025 has averaged 3.037736 seconds
 between transmitted cells
 Aug 09 02:28:56.000 [warn] failed to get unique circID. [13352 similar
 message(s) suppressed in last 9600 seconds]
 Aug 09 03:09:04.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294943955 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 18918 seconds and a maximum of 32756
 seconds. This channel is 54637 seconds old. Failing a circuit. [5655
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 03:09:04.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=56046. queue_size=56046. manual_total=56046.
 manual_total_in_map=32705.
 Aug 09 03:09:04.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 56046 destroy cells queued.
 Aug 09 03:09:04.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 03:09:04.000 [warn]  * Channel 470025 was created at 1407499107
 (54637 seconds ago) and last active at 1407553736 (8 seconds ago)
 Aug 09 03:09:04.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 03:09:04.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 03:09:04.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 03:09:04.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 03:09:04.000 [warn]  * Channel 470025 has 0 active circuits out of
 0 in total
 Aug 09 03:09:04.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407553744 seconds ago)
 Aug 09 03:09:04.000 [warn]  * Channel 470025 was last drained at
 1407553390 (354 seconds ago)
 Aug 09 03:09:04.000 [warn]  * Channel 470025 last received a cell at
 1407553736 (8 seconds ago)
 Aug 09 03:09:04.000 [warn]  * Channel 470025 last transmitted a cell at
 1407553390 (354 seconds ago)
 Aug 09 03:09:04.000 [warn]  * Channel 470025 has received 1230 cells and
 transmitted 18581
 Aug 09 03:09:04.000 [warn]  * Channel 470025 has averaged 44.420325
 seconds between received cells
 Aug 09 03:09:04.000 [warn]  * Channel 470025 has averaged 2.940477 seconds
 between transmitted cells
 Aug 09 04:09:04.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294936048 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 21821 seconds and a maximum of 35397
 seconds. This channel is 58237 seconds old. Failing a circuit. [7906
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 04:09:04.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=63986. queue_size=63986. manual_total=63986.
 manual_total_in_map=32738.
 Aug 09 04:09:04.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 63986 destroy cells queued.
 Aug 09 04:09:04.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 04:09:04.000 [warn]  * Channel 470025 was created at 1407499107
 (58237 seconds ago) and last active at 1407557166 (178 seconds ago)
 Aug 09 04:09:04.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 04:09:04.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 04:09:04.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 04:09:04.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 04:09:04.000 [warn]  * Channel 470025 has 0 active circuits out of
 0 in total
 Aug 09 04:09:04.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407557344 seconds ago)
 Aug 09 04:09:04.000 [warn]  * Channel 470025 was last drained at
 1407556906 (438 seconds ago)
 Aug 09 04:09:04.000 [warn]  * Channel 470025 last received a cell at
 1407557166 (178 seconds ago)
 Aug 09 04:09:04.000 [warn]  * Channel 470025 last transmitted a cell at
 1407556906 (438 seconds ago)
 Aug 09 04:09:04.000 [warn]  * Channel 470025 has received 1243 cells and
 transmitted 20101
 Aug 09 04:09:04.000 [warn]  * Channel 470025 has averaged 46.851971
 seconds between received cells
 Aug 09 04:09:04.000 [warn]  * Channel 470025 has averaged 2.897219 seconds
 between transmitted cells
 Aug 09 05:08:56.000 [warn] failed to get unique circID. [18000 similar
 message(s) suppressed in last 9600 seconds]
 Aug 09 05:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294929658 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 24959 seconds and a maximum of 37832
 seconds. This channel is 61838 seconds old. Failing a circuit. [6390
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 05:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=70318. queue_size=70318. manual_total=70318.
 manual_total_in_map=32679.
 Aug 09 05:09:05.000 [warn]   Circuitmux on this channel has 1 circuits, of
 which 1 are active. It says it has 70318 destroy cells queued.
 Aug 09 05:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 05:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (61838 seconds ago) and last active at 1407560931 (14 seconds ago)
 Aug 09 05:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 05:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 05:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 05:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 05:09:05.000 [warn]  * Channel 470025 has 1 active circuits out of
 1 in total
 Aug 09 05:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407560945 seconds ago)
 Aug 09 05:09:05.000 [warn]  * Channel 470025 was last drained at
 1407560931 (14 seconds ago)
 Aug 09 05:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407560123 (822 seconds ago)
 Aug 09 05:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407560931 (14 seconds ago)
 Aug 09 05:09:05.000 [warn]  * Channel 470025 has received 1250 cells and
 transmitted 21929
 Aug 09 05:09:05.000 [warn]  * Channel 470025 has averaged 49.470400
 seconds between received cells
 Aug 09 05:09:05.000 [warn]  * Channel 470025 has averaged 2.819919 seconds
 between transmitted cells
 Aug 09 06:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294922699 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 24854 seconds and a maximum of 40566
 seconds. This channel is 65438 seconds old. Failing a circuit. [6958
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 06:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=77181. queue_size=77181. manual_total=77181.
 manual_total_in_map=32583.
 Aug 09 06:09:05.000 [warn]   Circuitmux on this channel has 1 circuits, of
 which 1 are active. It says it has 77181 destroy cells queued.
 Aug 09 06:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 06:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (65438 seconds ago) and last active at 1407564497 (48 seconds ago)
 Aug 09 06:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 06:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 06:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 06:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 06:09:05.000 [warn]  * Channel 470025 has 1 active circuits out of
 1 in total
 Aug 09 06:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407564545 seconds ago)
 Aug 09 06:09:05.000 [warn]  * Channel 470025 was last drained at
 1407564397 (148 seconds ago)
 Aug 09 06:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407564497 (48 seconds ago)
 Aug 09 06:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407564397 (148 seconds ago)
 Aug 09 06:09:05.000 [warn]  * Channel 470025 has received 1256 cells and
 transmitted 23401
 Aug 09 06:09:05.000 [warn]  * Channel 470025 has averaged 52.100318
 seconds between received cells
 Aug 09 06:09:05.000 [warn]  * Channel 470025 has averaged 2.796376 seconds
 between transmitted cells
 Aug 09 06:53:59.000 [notice] Heartbeat: Tor's uptime is 1 day 12:00 hours,
 with 17472 circuits open. I've sent 1480.49 GB and received 1419.77 GB.
 Aug 09 06:53:59.000 [notice] Average packaged cell fullness: 99.209%
 Aug 09 06:53:59.000 [notice] TLS write overhead: 3%
 Aug 09 06:53:59.000 [notice] Circuit handshake stats since last time:
 648718/648718 TAP, 150890/150890 NTor.
 Aug 09 07:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294916678 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 28298 seconds and a maximum of 43255
 seconds. This channel is 69038 seconds old. Failing a circuit. [6022
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 07:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=83266. queue_size=83266. manual_total=83266.
 manual_total_in_map=32645.
 Aug 09 07:09:05.000 [warn]   Circuitmux on this channel has 3 circuits, of
 which 3 are active. It says it has 83266 destroy cells queued.
 Aug 09 07:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 07:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (69038 seconds ago) and last active at 1407568007 (138 seconds ago)
 Aug 09 07:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 07:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 07:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 07:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 07:09:05.000 [warn]  * Channel 470025 has 3 active circuits out of
 3 in total
 Aug 09 07:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407568145 seconds ago)
 Aug 09 07:09:05.000 [warn]  * Channel 470025 was last drained at
 1407567969 (176 seconds ago)
 Aug 09 07:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407567707 (438 seconds ago)
 Aug 09 07:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407567969 (176 seconds ago)
 Aug 09 07:09:05.000 [warn]  * Channel 470025 has received 1261 cells and
 transmitted 25150
 Aug 09 07:09:05.000 [warn]  * Channel 470025 has averaged 54.748612
 seconds between received cells
 Aug 09 07:09:05.000 [warn]  * Channel 470025 has averaged 2.745050 seconds
 between transmitted cells
 Aug 09 07:48:56.000 [warn] failed to get unique circID. [18328 similar
 message(s) suppressed in last 9600 seconds]
 Aug 09 08:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294908158 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 28696 seconds and a maximum of 45674
 seconds. This channel is 72638 seconds old. Failing a circuit. [8518
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 08:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=91752. queue_size=91752. manual_total=91752.
 manual_total_in_map=32612.
 Aug 09 08:09:05.000 [warn]   Circuitmux on this channel has 2 circuits, of
 which 2 are active. It says it has 91752 destroy cells queued.
 Aug 09 08:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 08:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (72638 seconds ago) and last active at 1407571692 (53 seconds ago)
 Aug 09 08:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 08:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 08:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 08:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 08:09:05.000 [warn]  * Channel 470025 has 2 active circuits out of
 2 in total
 Aug 09 08:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407571745 seconds ago)
 Aug 09 08:09:05.000 [warn]  * Channel 470025 was last drained at
 1407571692 (53 seconds ago)
 Aug 09 08:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407571192 (553 seconds ago)
 Aug 09 08:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407571692 (53 seconds ago)
 Aug 09 08:09:05.000 [warn]  * Channel 470025 has received 1268 cells and
 transmitted 26448
 Aug 09 08:09:05.000 [warn]  * Channel 470025 has averaged 57.285489
 seconds between received cells
 Aug 09 08:09:05.000 [warn]  * Channel 470025 has averaged 2.746446 seconds
 between transmitted cells
 Aug 09 09:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294898090 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 34344 seconds and a maximum of 48618
 seconds. This channel is 76238 seconds old. Failing a circuit. [10067
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 09:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=101730. queue_size=101730. manual_total=101730.
 manual_total_in_map=32522.
 Aug 09 09:09:05.000 [warn]   Circuitmux on this channel has 2 circuits, of
 which 2 are active. It says it has 101730 destroy cells queued.
 Aug 09 09:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 09:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (76238 seconds ago) and last active at 1407575330 (15 seconds ago)
 Aug 09 09:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 09:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 09:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 09:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 09:09:05.000 [warn]  * Channel 470025 has 2 active circuits out of
 2 in total
 Aug 09 09:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407575345 seconds ago)
 Aug 09 09:09:05.000 [warn]  * Channel 470025 was last drained at
 1407575330 (15 seconds ago)
 Aug 09 09:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407574837 (508 seconds ago)
 Aug 09 09:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407575330 (15 seconds ago)
 Aug 09 09:09:05.000 [warn]  * Channel 470025 has received 1271 cells and
 transmitted 27691
 Aug 09 09:09:05.000 [warn]  * Channel 470025 has averaged 59.982691
 seconds between received cells
 Aug 09 09:09:05.000 [warn]  * Channel 470025 has averaged 2.753169 seconds
 between transmitted cells
 Aug 09 10:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294888026 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 35343 seconds and a maximum of 51733
 seconds. This channel is 79838 seconds old. Failing a circuit. [10061
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 10:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=111952. queue_size=111952. manual_total=111952.
 manual_total_in_map=32682.
 Aug 09 10:09:05.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 111952 destroy cells queued.
 Aug 09 10:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 10:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (79838 seconds ago) and last active at 1407578782 (163 seconds ago)
 Aug 09 10:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 10:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 10:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 10:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 10:09:05.000 [warn]  * Channel 470025 has 0 active circuits out of
 0 in total
 Aug 09 10:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407578945 seconds ago)
 Aug 09 10:09:05.000 [warn]  * Channel 470025 was last drained at
 1407578782 (163 seconds ago)
 Aug 09 10:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407578394 (551 seconds ago)
 Aug 09 10:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407578782 (163 seconds ago)
 Aug 09 10:09:05.000 [warn]  * Channel 470025 has received 1277 cells and
 transmitted 28942
 Aug 09 10:09:05.000 [warn]  * Channel 470025 has averaged 62.519969
 seconds between received cells
 Aug 09 10:09:05.000 [warn]  * Channel 470025 has averaged 2.758552 seconds
 between transmitted cells
 Aug 09 10:28:56.000 [warn] failed to get unique circID. [27062 similar
 message(s) suppressed in last 9600 seconds]
 Aug 09 11:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294876844 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 29481 seconds and a maximum of 53876
 seconds. This channel is 83438 seconds old. Failing a circuit. [11181
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 11:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=123159. queue_size=123159. manual_total=123159.
 manual_total_in_map=32707.
 Aug 09 11:09:05.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 123159 destroy cells queued.
 Aug 09 11:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 11:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (83438 seconds ago) and last active at 1407582321 (224 seconds ago)
 Aug 09 11:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 11:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 11:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 11:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 11:09:05.000 [warn]  * Channel 470025 has 0 active circuits out of
 0 in total
 Aug 09 11:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407582545 seconds ago)
 Aug 09 11:09:05.000 [warn]  * Channel 470025 was last drained at
 1407582321 (224 seconds ago)
 Aug 09 11:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407578394 (4151 seconds ago)
 Aug 09 11:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407582321 (224 seconds ago)
 Aug 09 11:09:05.000 [warn]  * Channel 470025 has received 1277 cells and
 transmitted 30207
 Aug 09 11:09:05.000 [warn]  * Channel 470025 has averaged 65.339076
 seconds between received cells
 Aug 09 11:09:05.000 [warn]  * Channel 470025 has averaged 2.762207 seconds
 between transmitted cells
 Aug 09 12:09:05.000 [warn] No unused circIDs found on channel without wide
 circID support, with 0 inbound and 4294864918 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 33466 seconds and a maximum of 57106
 seconds. This channel is 87038 seconds old. Failing a circuit. [11925
 similar message(s) suppressed in last 3600 seconds]
 Aug 09 12:09:05.000 [warn] int64_t
 circuitmux_count_queued_destroy_cells(const channel_t *, const
 circuitmux_t *)(): Bug:   Discrepancy in counts for queued destroy cells
 on circuitmux. n=135125. queue_size=135125. manual_total=135125.
 manual_total_in_map=32747.
 Aug 09 12:09:05.000 [warn]   Circuitmux on this channel has 0 circuits, of
 which 0 are active. It says it has 135125 destroy cells queued.
 Aug 09 12:09:05.000 [warn] Channel 470025 (at 0x80f913400) with transport
 TLS channel (connection 1062759) is in state open (2)
 Aug 09 12:09:05.000 [warn]  * Channel 470025 was created at 1407499107
 (87038 seconds ago) and last active at 1407585865 (280 seconds ago)
 Aug 09 12:09:05.000 [warn]  * Channel 470025 says it is connected to an OR
 with digest 92AA57343957296C7EC89A976609DBB33C56E75F and no known nickname
 Aug 09 12:09:05.000 [warn]  * Channel 470025 says its remote address is
 [scrubbed], and gives a canonical description of "[scrubbed]" and an
 actual description of "[scrubbed]"
 Aug 09 12:09:05.000 [warn]  * Channel 470025 has these marks:
 !bad_for_new_circs canonical is_canonical_is_reliable !client !local
 outgoing
 Aug 09 12:09:05.000 [warn]  * Channel 470025 has 0 queued incoming cells
 and 0 queued outgoing cells
 Aug 09 12:09:05.000 [warn]  * Channel 470025 has 0 active circuits out of
 0 in total
 Aug 09 12:09:05.000 [warn]  * Channel 470025 was last used by a client at
 0 (1407586145 seconds ago)
 Aug 09 12:09:05.000 [warn]  * Channel 470025 was last drained at
 1407585844 (301 seconds ago)
 Aug 09 12:09:05.000 [warn]  * Channel 470025 last received a cell at
 1407585865 (280 seconds ago)
 Aug 09 12:09:05.000 [warn]  * Channel 470025 last transmitted a cell at
 1407585844 (301 seconds ago)
 Aug 09 12:09:05.000 [warn]  * Channel 470025 has received 1281 cells and
 transmitted 31719
 Aug 09 12:09:05.000 [warn]  * Channel 470025 has averaged 67.945355
 seconds between received cells
 Aug 09 12:09:05.000 [warn]  * Channel 470025 has averaged 2.744034 seconds
 between transmitted cells
 }}}

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



More information about the tor-bugs mailing list