[tor-talk] Ongoing client problem

[Geoff Down]

Hello all,
my current experience of Tor is very frustrating in that it generally
won't work for any length of time without changing identity, sending a
SIGHUP or completely restarting. Since I've tried various versions
(built from source), I assume the problem is with some other OS
component or dependency. The following unedited log extract typifies the
problem: identical curl requests to the Socks port which timed out
'Failed to receive SOCKS5 connect request ack' when the URL is fine over
clearnet. Using Vidalia to look at circuits, I often see many in the
'Building' state permanently, or even just 'Path empty', but completed
circuits will often not work either.
Using 'new identity' usually produces a complete working circuit after a
few attempts.
More logs available if anyone wants them - but since this probably isn't
a Tor bug, I won't open a Trac ticket.
Regards,
Geoff

Oct 29 11:50:02.000 [info] connection_handle_listener_read(): New SOCKS
connection opened from 127.0.0.1.
Oct 29 11:50:02.000 [info] connection_edge_process_inbuf(): data from
edge while in 'waiting for circuit' state. Leaving it on buffer.
Oct 29 11:50:02.000 [info] choose_good_exit_server_general(): Found 631
servers that might support 1/1 pending connections.
Oct 29 11:50:02.000 [info] choose_good_exit_server_general(): Chose exit
server '$78E2BE744A53631B4AAB781468E94C52AB73968B~bynumlawtor at
104.200.20.46'
Oct 29 11:50:03.000 [info] circuit_send_next_onion_skin(): First hop:
finished sending CREATE cell to '$yyyyyyy~xxxxxxx at 51.15.61.46'
Oct 29 11:50:03.000 [info] circuit_finish_handshake(): Finished building
circuit hop:
Oct 29 11:50:03.000 [info] exit circ (length 3, last hop bynumlawtor):
$yyyyyyy(open) $2D5FE8689855F9F36B414B908B807981F18F2683(closed)
$78E2BE744A53631B4AAB781468E94C52AB73968B(closed)
Oct 29 11:50:03.000 [info] circuit_send_next_onion_skin(): Sending
extend relay cell.
Oct 29 11:50:12.000 [info] connection_edge_process_inbuf(): data from
edge while in 'waiting for circuit' state. Leaving it on buffer.
Oct 29 11:50:12.000 [info] connection_edge_reached_eof(): conn (fd 13)
reached eof. Closing.
Oct 29 12:50:03.000 [info] connection_handle_listener_read(): New SOCKS
connection opened from 127.0.0.1.
Oct 29 12:50:03.000 [info] connection_edge_process_inbuf(): data from
edge while in 'waiting for circuit' state. Leaving it on buffer.
Oct 29 12:50:05.000 [info] choose_good_exit_server_general(): Found 631
servers that might support 1/1 pending connections.
Oct 29 12:50:05.000 [info] choose_good_exit_server_general(): Chose exit
server '$A571351082A9E04F14A0A3DF27E0637231D57B84~torfa at
79.172.193.32'
Oct 29 12:50:05.000 [info] circuit_send_next_onion_skin(): First hop:
finished sending CREATE cell to '$yyyyyyy~xxxxxxx at 51.15.61.46'
Oct 29 12:50:05.000 [info] circuit_finish_handshake(): Finished building
circuit hop:
Oct 29 12:50:05.000 [info] exit circ (length 3, last hop torfa):
$yyyyyyy(open) $823701D5C4C5D72C3FF533113F25A1922DED6303(closed)
$A571351082A9E04F14A0A3DF27E0637231D57B84(closed)
Oct 29 12:50:05.000 [info] circuit_send_next_onion_skin(): Sending
extend relay cell.
Oct 29 12:50:06.000 [info] entry_guard_inc_circ_attempt_count(): Got
success count 230.375000/279.125000 for guard xxxxxxx ($yyyyyyy)
Oct 29 12:50:06.000 [info] circuit_finish_handshake(): Finished building
circuit hop:
Oct 29 12:50:06.000 [info] exit circ (length 3, last hop torfa):
$yyyyyyy(open) $823701D5C4C5D72C3FF533113F25A1922DED6303(open)
$A571351082A9E04F14A0A3DF27E0637231D57B84(closed)
Oct 29 12:50:06.000 [info] circuit_send_next_onion_skin(): Sending
extend relay cell.
Oct 29 12:50:06.000 [info] onion_skin_ntor_client_handshake(): Invalid
result from curve25519 handshake: 4
Oct 29 12:50:12.000 [info] connection_edge_process_inbuf(): data from
edge while in 'waiting for circuit' state. Leaving it on buffer.
Oct 29 12:50:12.000 [info] connection_edge_reached_eof(): conn (fd 13)
reached eof. Closing.