Roger Dingledine <arma@xxxxxxx> wrote: > Changes in version 0.2.1.7-alpha - 2008-11-08 > o Minor bugfixes: > - Minor fix in the warning messages when you're having problems > bootstrapping; also, be more forgiving of bootstrap problems when > we're still making incremental progress on a given bootstrap phase. I'm not sure if it's related to this change, but bootstrapping no longer works for me on FreeBSD 8.0-CURRENT: Nov 23 18:59:08.931 [notice] Tor 0.2.1.7-alpha-dev (r17366) opening log file. Nov 23 18:59:08.945 [notice] Parsing GEOIP file. Nov 23 18:59:10.160 [notice] This version of Tor (0.2.1.7-alpha-dev) is newer than any recommended version, according to the directory authorities. Recommended versions are: 0.1.2.17,0.1.2.18,0.1.2.19,0.2.0.26-rc,0.2.0.27-rc,0.2.0.28-rc,0.2.0.29-rc,0.2.0.30,0.2.0.31,0.2.0.32,0.2.1.1-alpha,0.2.1.2-alpha,0.2.1.4-alpha,0.2.1.5-alpha,0.2.1.6-alpha,0.2.1.7-alpha Nov 23 18:59:11.347 [notice] Bootstrapped 45%: Asking for relay descriptors. Nov 23 18:59:11.347 [notice] I learned some more directory information, but not enough to build a circuit: We have only 0/1259 usable descriptors. Nov 23 18:59:12.163 [notice] Bootstrapped 50%: Loading relay descriptors. Nov 23 18:59:12.741 [notice] I learned some more directory information, but not enough to build a circuit: We have only 0/1259 usable descriptors. [repeated 31 times] Nov 23 18:59:28.774 [warn] Problem bootstrapping. Stuck at 50%: Loading relay descriptors. (Tor gave up on the connection; TIMEOUT; count 10; recommendation warn) Nov 23 18:59:28.805 [warn] Problem bootstrapping. Stuck at 50%: Loading relay descriptors. (Tor gave up on the connection; TIMEOUT; count 11; recommendation warn) Nov 23 18:59:28.810 [warn] Problem bootstrapping. Stuck at 50%: Loading relay descriptors. (DONE; DONE; count 12; recommendation warn) Nov 23 18:59:28.810 [warn] Problem bootstrapping. Stuck at 50%: Loading relay descriptors. (DONE; DONE; count 13; recommendation warn) Nov 23 18:59:28.872 [notice] I learned some more directory information, but not enough to build a circuit: We have only 0/1259 usable descriptors. [Seems to loop endlessly here] I have a complete debug log if any Tor developer is interested. Does the following indicate that Tor is trying to use invalid sockets? Nov 23 15:05:14.034 [debug] relay_lookup_conn(): found conn for stream 17393. Nov 23 15:05:14.035 [debug] circuit_receive_relay_cell(): Sending to origin. Nov 23 15:05:14.035 [debug] connection_edge_process_relay_cell(): Now seen 343 relay cells here. Nov 23 15:05:14.035 [debug] connection_edge_process_relay_cell(): circ deliver_window now 992. Nov 23 15:05:14.035 [debug] connection_or_process_cells_from_inbuf(): 28: starting, inbuf_datalen 496 (0 pending in tls object). Nov 23 15:05:14.035 [debug] conn_write_callback(): socket 19 wants to write. Nov 23 15:05:14.035 [debug] flush_chunk_tls(): flushed 512 bytes, 0 ready to flush, 0 remain. Nov 23 15:05:14.035 [debug] connection_handle_write(): After TLS write of 512: 0 read, 586 written Nov 23 15:05:14.035 [debug] connection_or_flush_from_first_active_circuit(): Made a circuit inactive. Nov 23 15:05:14.035 [debug] conn_read_callback(): socket 28 wants to read. Nov 23 15:05:14.036 [debug] connection_read_to_buf(): 28: starting, inbuf_datalen 496 (0 pending in tls object). at_most 16384. Nov 23 15:05:14.036 [debug] tor_tls_read(): read returned r=-1, err=-2 Nov 23 15:05:14.036 [debug] connection_read_to_buf(): After TLS read of 0: 1440 read, 0 written Nov 23 15:05:14.036 [debug] connection_or_process_cells_from_inbuf(): 28: starting, inbuf_datalen 496 (0 pending in tls object). Nov 23 15:05:14.036 [debug] conn_write_callback(): socket 19 wants to write. Nov 23 15:05:14.036 [debug] flush_chunk_tls(): flushed 512 bytes, 0 ready to flush, 0 remain. Nov 23 15:05:14.036 [debug] connection_handle_write(): After TLS write of 512: 0 read, 586 written Nov 23 15:05:14.036 [debug] conn_read_callback(): socket -1 wants to read. Nov 23 15:05:14.036 [debug] connection_dir_process_inbuf(): Got data, not eof. Leaving on inbuf. Nov 23 15:05:14.045 [debug] conn_read_callback(): socket 21 wants to read. Nov 23 15:05:14.045 [debug] connection_read_to_buf(): 21: starting, inbuf_datalen 0 (0 pending in tls object). at_most 16384. Nov 23 15:05:14.046 [debug] connection_read_to_buf(): After TLS read of 4080: 1258 read, 0 written Nov 23 15:05:14.046 [debug] connection_or_process_cells_from_inbuf(): 21: starting, inbuf_datalen 4080 (0 pending in tls object). According to the debug log, tor_tls_read() returns -1 all the time: fk@TP51 ~ $grep -c "tor_tls_read(): read returned r=-1, err=-2" test/tor/debug.log 757 fk@TP51 ~ $grep "tor_tls_read(): read" test/tor/debug.log | grep -v -c "r=-1" 0 Tor 0.2.1.6-alpha bootstraps without problems: Nov 23 19:38:00.572 [notice] Tor 0.2.1.6-alpha (r17011) opening log file. Nov 23 19:38:00.584 [notice] Parsing GEOIP file. Nov 23 19:38:01.119 [notice] Bootstrapped 45%: Asking for relay descriptors. Nov 23 19:38:01.119 [notice] I learned some more directory information, but not enough to build a circuit: We have only 0/1260 usable descriptors. Nov 23 19:38:02.022 [notice] Bootstrapped 50%: Loading relay descriptors. Nov 23 19:38:02.926 [notice] Bootstrapped 58%: Loading relay descriptors. Nov 23 19:38:02.927 [notice] I learned some more directory information, but not enough to build a circuit: We have only 96/1259 usable descriptors. Nov 23 19:38:03.370 [notice] Bootstrapped 67%: Loading relay descriptors. Nov 23 19:38:03.370 [notice] I learned some more directory information, but not enough to build a circuit: We have only 188/1259 usable descriptors. Nov 23 19:38:05.275 [notice] Bootstrapped 70%: Loading relay descriptors. Nov 23 19:38:05.297 [notice] I learned some more directory information, but not enough to build a circuit: We have only 220/1259 usable descriptors. Nov 23 19:38:11.469 [notice] Bootstrapped 73%: Loading relay descriptors. Nov 23 19:38:11.470 [notice] I learned some more directory information, but not enough to build a circuit: We have only 250/1254 usable descriptors. Nov 23 19:38:12.002 [notice] We now have enough directory information to build circuits. Nov 23 19:38:12.002 [notice] Bootstrapped 80%: Connecting to the Tor network. Nov 23 19:38:12.006 [notice] Bootstrapped 85%: Finishing handshake with first hop. Nov 23 19:38:13.673 [notice] Bootstrapped 90%: Establishing a Tor circuit. Nov 23 19:38:21.262 [notice] Tor has successfully opened a circuit. Looks like client functionality is working. Nov 23 19:38:21.263 [notice] Bootstrapped 100%: Done. Fabian
Attachment:
signature.asc
Description: PGP signature