May 22 19:47:51.511 [notice] Tor v0.2.2.0-alpha-dev. This is experimental software. Do not rely on it for strong anonymity. (Running on Linux i686) May 22 19:47:51.511 [warn] Tor has been built with the option --enable-highly-insecure-key-debugging. This will dump TLS and circuit keys to Tor's log files. This option is only required for debugging purposes. If you did not configure Tor to do this yourself you should re-install Tor from a trusted source. May 22 19:47:51.512 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:47:51.512 [notice] Initialized libevent version 1.4.9-stable using method epoll. Good. May 22 19:47:51.512 [notice] Opening Socks listener on 127.0.0.1:9050 May 22 19:47:51.512 [notice] Opening Control listener on 127.0.0.1:9051 May 22 19:47:51.512 [info] tor_lockfile_lock(): Locking "/home/robert/.tor/lock" May 22 19:47:51.527 [info] or_state_load(): Loaded state from "/home/robert/.tor/state" May 22 19:47:51.527 [info] remove_obsolete_entry_guards(): Entry guard 'trusted' (8522EB98C91496E80EC238E732594D1509158E77) was selected several months ago. (Version="0.2.1.6-alpha-dev".) Replacing it. May 22 19:47:51.527 [info] log_entry_guards(): nixnix (down made-contact),BlueStar88a (down made-contact),EntitaetNull (down made-contact),SEC (down made-contact),Piper (down made-contact),AMonkeyStoleMyBike (down made-contact),videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'nixnix' (43BE706E24143AB6B3B86DBF7CD4FDE1E0C4CAF1) was selected several months ago. (Version="0.2.1.7-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): BlueStar88a (down made-contact),EntitaetNull (down made-contact),SEC (down made-contact),Piper (down made-contact),AMonkeyStoleMyBike (down made-contact),videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'BlueStar88a' (5C1A263FA240EBE95E991755D67C7C8A82BA4B3B) was selected several months ago. (Version="0.2.1.11-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): EntitaetNull (down made-contact),SEC (down made-contact),Piper (down made-contact),AMonkeyStoleMyBike (down made-contact),videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'EntitaetNull' (8318A0A99B26785C6AB59FB3A290F6A04ADDD42C) was selected several months ago. (Version="0.2.1.11-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): SEC (down made-contact),Piper (down made-contact),AMonkeyStoleMyBike (down made-contact),videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'SEC' (08101AD124C3B10E2F1F18DF2B51F4901E385170) was selected several months ago. (Version="0.2.1.11-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): Piper (down made-contact),AMonkeyStoleMyBike (down made-contact),videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'Piper' (4D91A5B5F995CBF88E5D9378065758D70D24BBBA) was selected several months ago. (Version="0.2.1.12-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): AMonkeyStoleMyBike (down made-contact),videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'AMonkeyStoleMyBike' (3F7C8C80071EC5298E01241EF3B075B3F22A62AB) was selected several months ago. (Version="0.2.1.12-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): videoraptor (down made-contact),gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'videoraptor' (6F01D9573E4838D0AD424A0FCCC4971445058104) was selected several months ago. (Version="0.2.1.12-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): gnomino (down made-contact),Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'gnomino' (70E41A282AB8997682D47D8BEFEC7E569C953C49) was selected several months ago. (Version="0.2.1.12-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): Sivusto9022b (down made-contact),jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'Sivusto9022b' (8EB8F229E93FAFE0F591DC6D0AEAB1CF54554C37) was selected several months ago. (Version="0.2.1.12-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): jceaovh (down made-contact) May 22 19:47:51.528 [info] remove_obsolete_entry_guards(): Entry guard 'jceaovh' (64A0FB9C991FB4AC03594C4949124BD75AEB0A38) was selected several months ago. (Version="0.2.1.12-alpha-dev".) Replacing it. May 22 19:47:51.528 [info] log_entry_guards(): May 22 19:47:51.528 [info] read_file_to_str(): Could not open "/home/robert/.tor/router-stability": No such file or directory May 22 19:47:51.542 [notice] Parsing GEOIP file. May 22 19:47:52.003 [info] crypto_seed_rng(): Seeding RNG from "/dev/urandom" May 22 19:47:52.221 [info] Bootstrapped 0%: Starting. May 22 19:47:52.234 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority moria1 with signing key C600C8BA94224C51D35361D5399F8B33A77FF191 May 22 19:47:52.235 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority gabelmoo with signing key B0C17B8D3AD626AEBBED67E2FF208E223310526C May 22 19:47:52.236 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority dizum with signing key 8C4CA02AA1AA71FCC56F9F4A46E09A4719DD75C3 May 22 19:47:52.237 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority dannenberg with signing key 589EB055C643EFBBC69D2209FC95EE81CD811FEB May 22 19:47:52.237 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority tor26 with signing key D6D2325E1511B23A825DBE1CFD3DF9285AAE4DEB May 22 19:47:52.238 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority ides with signing key 287C96AFE88795B42A116E659BE58B608739F590 May 22 19:47:52.251 [notice] Obsolete file /home/robert/.tor/cached-status/719BE45DE224B607C53707D0E2143E2D423E74CF hasn't been modified since 2009-02-23 21:46:17. Removing it. May 22 19:47:52.264 [notice] Obsolete file /home/robert/.tor/cached-status/FFCB46DB1339DA84674C70D7CB586434C4370441 hasn't been modified since 2009-02-23 21:46:17. Removing it. May 22 19:47:52.282 [notice] Obsolete file /home/robert/.tor/cached-status/847B1F850344D7876491A54892F904934E4EB85D hasn't been modified since 2009-02-23 21:46:17. Removing it. May 22 19:47:52.324 [info] networkstatus_set_current_consensus(): Loaded an obsolete consensus. Discarding. May 22 19:47:52.324 [info] read_file_to_str(): Could not open "/home/robert/.tor/unverified-consensus": No such file or directory May 22 19:47:52.324 [info] read_file_to_str(): Could not open "/usr/local/share/tor/fallback-consensus": No such file or directory May 22 19:47:52.324 [notice] No current certificate known for authority moria1; launching request. May 22 19:47:52.324 [notice] No current certificate known for authority tor26; launching request. May 22 19:47:52.324 [notice] No current certificate known for authority dizum; launching request. May 22 19:47:52.324 [notice] No current certificate known for authority gabelmoo; launching request. May 22 19:47:52.324 [info] router_pick_directory_server(): No reachable router entries for dirservers. Trying them all again. May 22 19:47:52.324 [info] directory_get_from_dirserver(): No router found for authority cert fetch; falling back to dirserver list. May 22 19:47:52.324 [info] connection_ap_make_link(): Making internal direct tunnel to 216.224.124.114:9090 ... May 22 19:47:52.324 [info] onion_pick_cpath_exit(): Using requested exit node 'F397038ADC51336135E7B80BD99CA3844360292B' May 22 19:47:52.324 [info] circuit_handle_first_hop(): Next router is F397038ADC51336135E7B80BD99CA3844360292B: Router not connected (nothing is). Connecting. May 22 19:47:52.324 [notice] Bootstrapped 5%: Connecting to directory server. May 22 19:47:52.324 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:52.539 [info] router_load_routers_from_string(): 925 elements to add May 22 19:47:52.661 [info] router_load_routers_from_string(): 382 elements to add May 22 19:47:52.662 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:52.663 [info] tor_mmap_file(): File "/home/robert/.tor/cached-descriptors" is empty. Ignoring. May 22 19:47:52.663 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:52.717 [info] router_load_extrainfo_from_string(): 773 elements to add May 22 19:47:52.738 [info] router_load_extrainfo_from_string(): 323 elements to add May 22 19:47:52.738 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:47:52.739 [info] tor_mmap_file(): File "/home/robert/.tor/cached-extrainfo" is empty. Ignoring. May 22 19:47:52.739 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:52.739 [notice] I learned some more directory information, but not enough to build a circuit: We have no network-status consensus. May 22 19:47:52.739 [info] update_consensus_networkstatus_downloads(): Launching networkstatus consensus download. May 22 19:47:52.739 [info] router_pick_directory_server(): No reachable router entries for dirservers. Trying them all again. May 22 19:47:52.739 [info] directory_get_from_dirserver(): No router found for consensus network-status fetch; falling back to dirserver list. May 22 19:47:52.739 [info] connection_ap_make_link(): Making internal direct tunnel to 128.31.0.34:9001 ... May 22 19:47:52.739 [info] onion_pick_cpath_exit(): Using requested exit node 'FFCB46DB1339DA84674C70D7CB586434C4370441' May 22 19:47:52.739 [info] circuit_handle_first_hop(): Next router is FFCB46DB1339DA84674C70D7CB586434C4370441: Not connected. Connecting. May 22 19:47:52.739 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:52.739 [info] directory_send_command(): Downloading consensus from 128.31.0.34:9001 using /tor/status-vote/current/consensus.z May 22 19:47:52.739 [info] or_state_save(): Saved state to "/home/robert/.tor/state" May 22 19:47:52.739 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:52.739 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:52.739 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:52.739 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:52.740 [notice] Bootstrapped 10%: Finishing handshake with directory server. May 22 19:47:53.093 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "128.31.0.34",9001,tor,10fd5eb4592e39dddfd1d52c5b3fb4948dd800aa61305c02b0b58e4a98d524a842c024bff55751c0c916c8b75a08b3df May 22 19:47:53.132 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "216.224.124.114",9090,tor,5cd0fe76847a148855a6a115bd5486ee488e17adc0363b298146384d45242772a3c619d75b72be1eca89e6576315a87e May 22 19:47:53.361 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "128.31.0.34",9001,tor,20970f0afad3a2b44e2f11fa90f9eab2c80c41207d1832c4c9af7104061bfc9c16c8517621aeab4f51badfd6f42dbbcc May 22 19:47:53.473 [info] command_process_versions_cell(): Negotiated version 2 with 128.31.0.34:9001; sending NETINFO. May 22 19:47:53.473 [notice] Bootstrapped 15%: Establishing an encrypted directory connection. May 22 19:47:53.473 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:53.473 [info] command_process_netinfo_cell(): Got good NETINFO cell from 128.31.0.34:9001; OR connection is now open, using protocol version 2 May 22 19:47:53.610 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "216.224.124.114",9090,tor,a0736069229d1dda98b9aef863c17e305ef9229b6fb4bd89296415dcf948b83724449f1b3c24fd178f171b992a06bf23 May 22 19:47:53.751 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "128.31.0.34",9001,13411,forward,5065ab9916f4a1c12aaf3e8e246abb5248396b8f,9bc8a485c1ad26a6e8ab830568047574 May 22 19:47:53.751 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "128.31.0.34",9001,13411,reverse,6db37b9f57818a3de2d55a0cf66e9c5ef71f946b,871a9dc82f50f1a0ce821184b9b3361f May 22 19:47:53.751 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:53.751 [info] exit circ (length 1, exit FFCB46DB1339DA84674C70D7CB586434C4370441): $FFCB46DB1339DA84674C70D7CB586434C4370441(open) May 22 19:47:53.751 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:53.751 [notice] Bootstrapped 20%: Asking for networkstatus consensus. May 22 19:47:53.751 [info] exit circ (length 1): $FFCB46DB1339DA84674C70D7CB586434C4370441(open) May 22 19:47:53.751 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 13411 May 22 19:47:53.836 [info] command_process_versions_cell(): Negotiated version 2 with 216.224.124.114:9090; sending NETINFO. May 22 19:47:53.836 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:53.836 [info] command_process_netinfo_cell(): Got good NETINFO cell from 216.224.124.114:9090; OR connection is now open, using protocol version 2 May 22 19:47:53.872 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:47:53.872 [info] exit circ (length 1): $FFCB46DB1339DA84674C70D7CB586434C4370441(open) May 22 19:47:53.872 [notice] Bootstrapped 25%: Loading networkstatus consensus. May 22 19:47:54.307 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "216.224.124.114",9090,62826,forward,7920e441df6827ad0cc9938a3ec1afee33aa145e,1e8f403e7d43f44522d70e5c00f1cc91 May 22 19:47:54.307 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "216.224.124.114",9090,62826,reverse,44a9cdb5f73502c7ebf66a6c48ba2dfe3edde014,e1e750c43cddc4aa6b52d7a1c917dcbf May 22 19:47:54.307 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:54.307 [info] exit circ (length 1, exit F397038ADC51336135E7B80BD99CA3844360292B): $F397038ADC51336135E7B80BD99CA3844360292B(open) May 22 19:47:54.307 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:54.307 [info] exit circ (length 1): $F397038ADC51336135E7B80BD99CA3844360292B(open) May 22 19:47:54.307 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 62826 May 22 19:47:54.534 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:47:54.534 [info] exit circ (length 1): $F397038ADC51336135E7B80BD99CA3844360292B(open) May 22 19:47:54.643 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 11911. Removing stream. May 22 19:47:54.643 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:54.646 [info] connection_dir_client_reached_eof(): Received consensus directory (size 356655) from server '128.31.0.34:9001' May 22 19:47:54.672 [info] networkstatus_check_consensus_signature(): Looks like we need to download a new certificate from authority 'tor26' at 86.59.21.38:80 (contact Peter Palfrader; identity 14C131DFC5C6F93646BE72FA1401C02A8DF2E8B4) May 22 19:47:54.672 [info] networkstatus_check_consensus_signature(): Looks like we need to download a new certificate from authority 'gabelmoo' at 80.190.246.100:80 (contact 1024D/F7C11265 Karsten Loesing ; identity 81349FC1F2DBA2C2C11B45CB9706637D480AB913) May 22 19:47:54.672 [info] networkstatus_check_consensus_signature(): Looks like we need to download a new certificate from authority 'moria1' at 128.31.0.34:9031 (contact 1024D/28988BF5 arma mit edu; identity E2A2AF570166665D738736D0DD58169CC61D8A8B) May 22 19:47:54.672 [info] networkstatus_check_consensus_signature(): Looks like we need to download a new certificate from authority 'dizum' at tor.dizum.com:80 (contact 1024R/8D56913D Alex de Joode ; identity E8A9C45EDE6D711294FADF8E7951F4DE6CA56B58) May 22 19:47:54.672 [warn] 0 unknown, 4 missing key, 2 good, 0 bad, 0 no signature, 4 required May 22 19:47:54.672 [info] networkstatus_set_current_consensus(): Not enough certificates to check networkstatus consensus May 22 19:47:54.673 [notice] I learned some more directory information, but not enough to build a circuit: We have no network-status consensus. May 22 19:47:54.673 [info] connection_dir_client_reached_eof(): Successfully loaded consensus. May 22 19:47:54.673 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:54.980 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 22248. Removing stream. May 22 19:47:54.980 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:54.980 [info] connection_dir_client_reached_eof(): Received authority certificates (size 7532) from server '216.224.124.114:9090' May 22 19:47:54.981 [info] trusted_dirs_load_certs_from_string(): Adding downloaded certificate for directory authority tor26 with signing key 36892827926E3BB068E8F9EDFA463C179162952F May 22 19:47:54.982 [info] trusted_dirs_load_certs_from_string(): Adding downloaded certificate for directory authority gabelmoo with signing key 1FD9845C566C40EC0401B9857C98824CB6D4F747 May 22 19:47:54.983 [info] trusted_dirs_load_certs_from_string(): Adding downloaded certificate for directory authority moria1 with signing key 42CF43879B4F1188CB428564EE1D319CE7C502B9 May 22 19:47:54.984 [info] trusted_dirs_load_certs_from_string(): Adding downloaded certificate for directory authority dizum with signing key 44A4408F03768A55AAE0E9D3D41E6E1A37FDD2AA May 22 19:47:54.984 [info] 0 unknown, 0 missing key, 6 good, 0 bad, 0 no signature, 4 required May 22 19:47:55.007 [info] 0 unknown, 0 missing key, 6 good, 0 bad, 0 no signature, 4 required May 22 19:47:55.007 [info] update_consensus_networkstatus_fetch_time(): Live consensus will be the most recent until 2009-05-22 20:00:00 and will expire at 2009-05-22 22:00:00; fetching the next one at 2009-05-22 20:50:45. May 22 19:47:55.009 [notice] Bootstrapped 45%: Asking for relay descriptors. May 22 19:47:55.009 [notice] I learned some more directory information, but not enough to build a circuit: We have only 0/1535 usable descriptors. May 22 19:47:55.009 [info] update_consensus_router_descriptor_downloads(): 1535 router descriptors downloadable. 0 delayed; 0 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 0 in progress. May 22 19:47:55.009 [info] launch_router_descriptor_downloads(): Launching 16 requests for 1535 routers, 96 at a time May 22 19:47:55.010 [info] connection_ap_make_link(): Making internal direct tunnel to 88.140.187.164:443 ... May 22 19:47:55.010 [info] onion_pick_cpath_exit(): Using requested exit node '3EC3307E0DD88E20B3354BDD8C348515B1C88B36' May 22 19:47:55.010 [info] circuit_handle_first_hop(): Next router is 3EC3307E0DD88E20B3354BDD8C348515B1C88B36: Not connected. Connecting. May 22 19:47:55.010 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.011 [info] connection_ap_make_link(): Making internal direct tunnel to 80.56.34.26:9001 ... May 22 19:47:55.011 [info] onion_pick_cpath_exit(): Using requested exit node 'C7893FC9EA62049BCB512E8486880B361AF45271' May 22 19:47:55.011 [info] circuit_handle_first_hop(): Next router is C7893FC9EA62049BCB512E8486880B361AF45271: Not connected. Connecting. May 22 19:47:55.011 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.011 [info] connection_ap_make_link(): Making internal direct tunnel to 85.196.147.105:443 ... May 22 19:47:55.011 [info] onion_pick_cpath_exit(): Using requested exit node '825326AA9DE096ACBCA4F4B790FD55DA83BDADEE' May 22 19:47:55.011 [info] circuit_handle_first_hop(): Next router is 825326AA9DE096ACBCA4F4B790FD55DA83BDADEE: Not connected. Connecting. May 22 19:47:55.011 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.011 [info] connection_ap_make_link(): Making internal direct tunnel to 77.204.2.159:443 ... May 22 19:47:55.011 [info] onion_pick_cpath_exit(): Using requested exit node '6585E356D3E655423A4DD2A5A581F951D214CEFE' May 22 19:47:55.011 [info] circuit_handle_first_hop(): Next router is 6585E356D3E655423A4DD2A5A581F951D214CEFE: Not connected. Connecting. May 22 19:47:55.011 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.012 [info] connection_ap_make_link(): Making internal direct tunnel to 213.112.198.243:443 ... May 22 19:47:55.012 [info] onion_pick_cpath_exit(): Using requested exit node '647486E22ECF2A71CE4771B2FB5B121039B5C09A' May 22 19:47:55.012 [info] circuit_handle_first_hop(): Next router is 647486E22ECF2A71CE4771B2FB5B121039B5C09A: Not connected. Connecting. May 22 19:47:55.012 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.012 [info] connection_ap_make_link(): Making internal direct tunnel to 77.198.246.8:443 ... May 22 19:47:55.012 [info] onion_pick_cpath_exit(): Using requested exit node '26B42DF07715CE875FB15A4281B037CE875B0C56' May 22 19:47:55.012 [info] circuit_handle_first_hop(): Next router is 26B42DF07715CE875FB15A4281B037CE875B0C56: Not connected. Connecting. May 22 19:47:55.012 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.013 [info] connection_ap_make_link(): Making internal direct tunnel to 90.24.32.9:9001 ... May 22 19:47:55.013 [info] onion_pick_cpath_exit(): Using requested exit node 'EA2CC2FD2CD1DCCB6E988EC843425398E98DA6B2' May 22 19:47:55.013 [info] circuit_handle_first_hop(): Next router is EA2CC2FD2CD1DCCB6E988EC843425398E98DA6B2: Not connected. Connecting. May 22 19:47:55.013 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.013 [info] connection_ap_make_link(): Making internal direct tunnel to 79.111.86.60:9001 ... May 22 19:47:55.013 [info] onion_pick_cpath_exit(): Using requested exit node 'CCF1A0CB3FA11ABA052EAB86DA5830DAB97D41C0' May 22 19:47:55.013 [info] circuit_handle_first_hop(): Next router is CCF1A0CB3FA11ABA052EAB86DA5830DAB97D41C0: Not connected. Connecting. May 22 19:47:55.013 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.013 [info] connection_ap_make_link(): Making internal direct tunnel to 88.200.247.202:443 ... May 22 19:47:55.013 [info] onion_pick_cpath_exit(): Using requested exit node '1F02787580FBC23A19C2F99BAC3DA6A471045248' May 22 19:47:55.013 [info] circuit_handle_first_hop(): Next router is 1F02787580FBC23A19C2F99BAC3DA6A471045248: Not connected. Connecting. May 22 19:47:55.013 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.014 [info] connection_ap_make_link(): Making internal direct tunnel to 75.73.41.14:9001 ... May 22 19:47:55.014 [info] onion_pick_cpath_exit(): Using requested exit node '8FE5206363990D8DB3846A90F582BFB393161060' May 22 19:47:55.014 [info] circuit_handle_first_hop(): Next router is 8FE5206363990D8DB3846A90F582BFB393161060: Not connected. Connecting. May 22 19:47:55.014 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.014 [info] connection_ap_make_link(): Making internal direct tunnel to 147.32.98.63:9001 ... May 22 19:47:55.014 [info] onion_pick_cpath_exit(): Using requested exit node '2B5BE5729FDBC0CB37B0CF557FBAFE3C5E0E684C' May 22 19:47:55.014 [info] circuit_handle_first_hop(): Next router is 2B5BE5729FDBC0CB37B0CF557FBAFE3C5E0E684C: Not connected. Connecting. May 22 19:47:55.014 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.015 [info] connection_ap_make_link(): Making internal direct tunnel to 91.198.227.49:9001 ... May 22 19:47:55.015 [info] onion_pick_cpath_exit(): Using requested exit node 'E69CE28A1F180C1822930F94AC20364FDFC09793' May 22 19:47:55.015 [info] circuit_handle_first_hop(): Next router is E69CE28A1F180C1822930F94AC20364FDFC09793: Not connected. Connecting. May 22 19:47:55.015 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.015 [info] connection_ap_make_link(): Making internal direct tunnel to 79.208.193.36:443 ... May 22 19:47:55.015 [info] onion_pick_cpath_exit(): Using requested exit node '8DAF83555EFAD50CC86D491ED2CEA8FCB17E337B' May 22 19:47:55.015 [info] circuit_handle_first_hop(): Next router is 8DAF83555EFAD50CC86D491ED2CEA8FCB17E337B: Not connected. Connecting. May 22 19:47:55.015 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.015 [info] connection_ap_make_link(): Making internal direct tunnel to 78.43.109.6:4440 ... May 22 19:47:55.016 [info] onion_pick_cpath_exit(): Using requested exit node '89FFA767EC5706C1A0A6BB4CDD7CF1A65B608A97' May 22 19:47:55.016 [info] circuit_handle_first_hop(): Next router is 89FFA767EC5706C1A0A6BB4CDD7CF1A65B608A97: Not connected. Connecting. May 22 19:47:55.016 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.016 [info] connection_ap_make_link(): Making internal direct tunnel to 77.84.113.156:443 ... May 22 19:47:55.016 [info] onion_pick_cpath_exit(): Using requested exit node '265CF8AFE824289C14F1A3DAE22C7F6B794CD9B0' May 22 19:47:55.016 [info] circuit_handle_first_hop(): Next router is 265CF8AFE824289C14F1A3DAE22C7F6B794CD9B0: Not connected. Connecting. May 22 19:47:55.016 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.016 [info] connection_ap_make_link(): Making internal direct tunnel to 93.129.13.124:11100 ... May 22 19:47:55.016 [info] onion_pick_cpath_exit(): Using requested exit node '1297D27A91E37410EEB2EED31B67218E69AFB19D' May 22 19:47:55.016 [info] circuit_handle_first_hop(): Next router is 1297D27A91E37410EEB2EED31B67218E69AFB19D: Not connected. Connecting. May 22 19:47:55.016 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:55.016 [info] connection_dir_client_reached_eof(): Successfully loaded certificates from fetch. May 22 19:47:55.016 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.016 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.017 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:55.246 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "91.198.227.49",9001,tor,63f749a0693d56006eaca09dd4cb1a5e97bcad10574b67dcc573b75d90ad852cdaa9c88b708f320cf54b2d40f9f9727f May 22 19:47:55.249 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "80.56.34.26",9001,tor,b6cf57ca8b92464ced627aa32676e5d6b1a7531ff0a7435ca629ddb00b321999f5a67d78e8c1d8efdd002bb51fab8db5 May 22 19:47:55.278 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "213.112.198.243",443,tor,9c3a7a994952877e03624e793391a5120db3f0b730ccbec2f27b368da4ae6a67aa404ff09671f0244e9644f5e71f2200 May 22 19:47:55.332 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "93.129.13.124",11100,tor,137a27933c159f60117ac3ce77e06434a1ed2dfd99bf73b09a94dba264f48b876ccdc37940a3e178ed1aa4378db137d6 May 22 19:47:55.333 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "147.32.98.63",9001,tor,9dfe2e5636db8a7326d277b10a34f7031a7569feb294ab0b2069d6a5f3b9aea0fc868d48f8848e4564ecc846c4a83d66 May 22 19:47:55.362 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "77.84.113.156",443,tor,fe53e5243d515d134e883228a785d5148c2d0850a659ff7f8be2a738a25d42ae223af9b09385e30b99ee20992c5f80fb May 22 19:47:55.386 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.111.86.60",9001,tor,3cf26503fa67a78a1e3727d6085f797bcf9472ddcb1bb23ee9e94def6b3335db56883c8910ae17f8e853f4d733e6e61c May 22 19:47:55.430 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "88.140.187.164",443,tor,5241c0d4bb2b6e54d70fe432bf8f5c31fe92660dcace43e14e29721924a579df438e1bd3823310fd1c3477d9a8621e28 May 22 19:47:55.491 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "80.56.34.26",9001,tor,2dd507ee90db4dd1f7fb090bb2805e3aaca6eb54cf3a8e2baf1826fb3e1d195be486423a0f94d8c67add55105f8ba1c8 May 22 19:47:55.602 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "93.129.13.124",11100,tor,0c20971082b35b1aca9108abd9b8c76f5fe39e2213f6e924f9844530e0b202d84e1a0fa390bdb324f52d1ef1ecb90d30 May 22 19:47:55.615 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "147.32.98.63",9001,tor,166fc5b7ca0715fddee88205288f8620f4eb033468d14617402475c68b920b12aadcac1ebf50a306b5bcf785dd8bbcaf May 22 19:47:55.656 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "77.84.113.156",443,tor,a7074021b09eaf2f577a1a91a1f6aeb650ae63cd5efc464ceb272b1fa89df80435e274b20255a985317f3aa7d55ae313 May 22 19:47:55.692 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.111.86.60",9001,tor,302505b07929e1b20428dffaa1df10800ef1f38e6c131c29625b8f147cfb40a2a06334c04eb06d60edbc860932fe9711 May 22 19:47:55.712 [info] command_process_versions_cell(): Negotiated version 2 with 147.32.98.63:9001; sending NETINFO. May 22 19:47:55.712 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:55.713 [info] command_process_netinfo_cell(): Got good NETINFO cell from 147.32.98.63:9001; OR connection is now open, using protocol version 2 May 22 19:47:55.715 [info] command_process_versions_cell(): Negotiated version 2 with 93.129.13.124:11100; sending NETINFO. May 22 19:47:55.715 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:55.715 [info] command_process_netinfo_cell(): Got good NETINFO cell from 93.129.13.124:11100; OR connection is now open, using protocol version 2 May 22 19:47:55.751 [info] command_process_versions_cell(): Negotiated version 2 with 77.84.113.156:443; sending NETINFO. May 22 19:47:55.751 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:55.751 [info] command_process_netinfo_cell(): Got good NETINFO cell from 77.84.113.156:443; OR connection is now open, using protocol version 2 May 22 19:47:55.777 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "88.140.187.164",443,tor,e9497aa419f9bd518f9157f0f28369b5d1a7f7189c9a46244b140d21f134ebab3c707dc0128b03b4a1ea3842d2590bc1 May 22 19:47:55.800 [info] command_process_versions_cell(): Negotiated version 2 with 79.111.86.60:9001; sending NETINFO. May 22 19:47:55.800 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:55.800 [info] command_process_netinfo_cell(): Got good NETINFO cell from 79.111.86.60:9001; OR connection is now open, using protocol version 2 May 22 19:47:55.919 [info] command_process_versions_cell(): Negotiated version 2 with 88.140.187.164:443; sending NETINFO. May 22 19:47:55.919 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:55.919 [info] command_process_netinfo_cell(): Got good NETINFO cell from 88.140.187.164:443; OR connection is now open, using protocol version 2 May 22 19:47:55.927 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "147.32.98.63",9001,1335,forward,7be54d64623bd360cd0170be56d58c9aad8e739b,e632178c71d8f7b7a89130f38f3737b0 May 22 19:47:55.927 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "147.32.98.63",9001,1335,reverse,cc7c66cdfd02d9a1aed35d5ec5c86c4e63b24f0b,cbd47be72d4557cce32516d03dfc2788 May 22 19:47:55.927 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:55.927 [info] exit circ (length 1, exit 2B5BE5729FDBC0CB37B0CF557FBAFE3C5E0E684C): $2B5BE5729FDBC0CB37B0CF557FBAFE3C5E0E684C(open) May 22 19:47:55.927 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:55.927 [info] exit circ (length 1): $2B5BE5729FDBC0CB37B0CF557FBAFE3C5E0E684C(open) May 22 19:47:55.927 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 1335 May 22 19:47:55.950 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.129.13.124",11100,19663,forward,c8d8087e448eedfd5ab6567c9f4d5466d12bb55a,ff94682da68a44f661c299f2c9440a9f May 22 19:47:55.950 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.129.13.124",11100,19663,reverse,4087dc5b51325a354d23222e92a4318cfb2dcb37,d496f2793ae48a1325877cbb08c426e5 May 22 19:47:55.950 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:55.950 [info] exit circ (length 1, exit 1297D27A91E37410EEB2EED31B67218E69AFB19D): $1297D27A91E37410EEB2EED31B67218E69AFB19D(open) May 22 19:47:55.950 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:55.950 [info] exit circ (length 1): $1297D27A91E37410EEB2EED31B67218E69AFB19D(open) May 22 19:47:55.950 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 19663 May 22 19:47:56.013 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "75.73.41.14",9001,tor,44ba54a71fd09b81ee0aa90d05e72bf08d3af28856d6d43d8e052e7a0114f8a3c839b73d8f99e271e5ddaac8c4a163ff May 22 19:47:56.022 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:56.022 [info] exit circ (length 1): $2B5BE5729FDBC0CB37B0CF557FBAFE3C5E0E684C(open) May 22 19:47:56.022 [notice] Bootstrapped 50%: Loading relay descriptors. May 22 19:47:56.046 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:56.046 [info] exit circ (length 1): $1297D27A91E37410EEB2EED31B67218E69AFB19D(open) May 22 19:47:56.069 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "91.198.227.49",9001,tor,7e7e26a935951396d4790c9f3322fceb6351687bc06b778fa5b3f97d92bb4fca4eb48a7bc574c95ba05da69e2c816fdd May 22 19:47:56.244 [info] command_process_versions_cell(): Negotiated version 2 with 80.56.34.26:9001; sending NETINFO. May 22 19:47:56.245 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:56.245 [info] command_process_netinfo_cell(): Got good NETINFO cell from 80.56.34.26:9001; OR connection is now open, using protocol version 2 May 22 19:47:56.322 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "77.84.113.156",443,23969,forward,98f679fbb3ab8f996a4416a8ffbcc7ef61b491bc,724726c7681c41ffabff51d7c479402d May 22 19:47:56.322 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "77.84.113.156",443,23969,reverse,310a2c93713fb43ad5a594461897d2a9cd4ffe12,b7ce60d639c94001a12cca2a8bbaea98 May 22 19:47:56.322 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:56.322 [info] exit circ (length 1, exit 265CF8AFE824289C14F1A3DAE22C7F6B794CD9B0): $265CF8AFE824289C14F1A3DAE22C7F6B794CD9B0(open) May 22 19:47:56.322 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:56.323 [info] exit circ (length 1): $265CF8AFE824289C14F1A3DAE22C7F6B794CD9B0(open) May 22 19:47:56.323 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 23969 May 22 19:47:56.360 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "88.140.187.164",443,24245,forward,540aaa9992f04c09cae895ddf2d25e61ec7b0879,dc498298c24ad5ca895eac2a3affa382 May 22 19:47:56.360 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "88.140.187.164",443,24245,reverse,fdaee15c2dfec448408bf36dc02b9ce699913a84,79f19534deceb7c509320905be415b6f May 22 19:47:56.360 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:56.360 [info] exit circ (length 1, exit 3EC3307E0DD88E20B3354BDD8C348515B1C88B36): $3EC3307E0DD88E20B3354BDD8C348515B1C88B36(open) May 22 19:47:56.360 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:56.360 [info] exit circ (length 1): $3EC3307E0DD88E20B3354BDD8C348515B1C88B36(open) May 22 19:47:56.360 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 24245 May 22 19:47:56.363 [info] TLS error: (errno=104: Connection reset by peer) May 22 19:47:56.363 [info] connection_tls_continue_handshake(): tls error [connection reset]. breaking connection. May 22 19:47:56.363 [info] circuit_n_conn_done(): or_conn failed. Closing circ. May 22 19:47:56.363 [info] connection_ap_fail_onehop(): Closing onehop stream to '$825326AA9DE096ACBCA4F4B790FD55DA83BDADEE/85.196.147.105' because the OR conn just failed. May 22 19:47:56.363 [info] control_event_bootstrap_problem(): Problem bootstrapping. Stuck at 50%: Loading relay descriptors. (DONE; DONE; count 1; recommendation ignore) May 22 19:47:56.363 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4044 bytes on inbuf, 0 on outbuf. May 22 19:47:56.363 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:47:56.363 [info] connection_dir_request_failed(): Giving up on directory server at '85.196.147.105'; retrying May 22 19:47:56.363 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:56.416 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "80.56.34.26",9001,38174,forward,a5b6553a9dce06e70928a595bd64b5d075efea53,90f80db97763464b845858c0ae8ba576 May 22 19:47:56.416 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "80.56.34.26",9001,38174,reverse,8854011228a298020e086c918fae6ad64fc4b05f,43a40ee38586e2903f29fc4554c2a55b May 22 19:47:56.416 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:56.416 [info] exit circ (length 1, exit C7893FC9EA62049BCB512E8486880B361AF45271): $C7893FC9EA62049BCB512E8486880B361AF45271(open) May 22 19:47:56.416 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:56.416 [info] exit circ (length 1): $C7893FC9EA62049BCB512E8486880B361AF45271(open) May 22 19:47:56.416 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 38174 May 22 19:47:56.428 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:47:56.428 [info] exit circ (length 1): $265CF8AFE824289C14F1A3DAE22C7F6B794CD9B0(open) May 22 19:47:56.498 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:47:56.498 [info] exit circ (length 1): $3EC3307E0DD88E20B3354BDD8C348515B1C88B36(open) May 22 19:47:56.669 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.111.86.60",9001,55391,forward,f0daf487c62ac64419b4d514d33e96048bfd1390,bead5f0101509ad6c342e50084a1fb2d May 22 19:47:56.669 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.111.86.60",9001,55391,reverse,d11bd56f57745095083496490b8d668177510612,3f7eae4dab39db0a6213896812ff0d00 May 22 19:47:56.669 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:56.669 [info] exit circ (length 1, exit CCF1A0CB3FA11ABA052EAB86DA5830DAB97D41C0): $CCF1A0CB3FA11ABA052EAB86DA5830DAB97D41C0(open) May 22 19:47:56.669 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:56.669 [info] exit circ (length 1): $CCF1A0CB3FA11ABA052EAB86DA5830DAB97D41C0(open) May 22 19:47:56.669 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 55391 May 22 19:47:56.737 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 24489. Removing stream. May 22 19:47:56.737 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:56.739 [info] connection_dir_client_reached_eof(): Received server info (size 137328) from server '147.32.98.63:9001' May 22 19:47:56.760 [info] router_load_routers_from_string(): 96 elements to add May 22 19:47:56.762 [info] routerlist_remove_old_routers(): We have 96 live routers and 0 old router descriptors. May 22 19:47:56.762 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:56.762 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:56.763 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:56.763 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:56.764 [notice] Bootstrapped 57%: Loading relay descriptors. May 22 19:47:56.764 [notice] I learned some more directory information, but not enough to build a circuit: We have only 96/1534 usable descriptors. May 22 19:47:56.765 [info] update_consensus_router_descriptor_downloads(): 96 router descriptors downloadable. 0 delayed; 96 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 1343 in progress. May 22 19:47:56.765 [info] launch_router_descriptor_downloads(): Launching 3 requests for 96 routers, 32 at a time May 22 19:47:56.766 [info] connection_ap_make_link(): Making internal direct tunnel to 83.65.91.108:443 ... May 22 19:47:56.766 [info] onion_pick_cpath_exit(): Using requested exit node '1E46A7BB0E225B6571AB2998E4A1E02BF72B0199' May 22 19:47:56.766 [info] circuit_handle_first_hop(): Next router is 1E46A7BB0E225B6571AB2998E4A1E02BF72B0199: Not connected. Connecting. May 22 19:47:56.766 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:56.766 [info] connection_ap_make_link(): Making internal direct tunnel to 213.253.1.10:9001 ... May 22 19:47:56.766 [info] onion_pick_cpath_exit(): Using requested exit node '72050E1047E16D606EA3D30877ADC85521E2AB28' May 22 19:47:56.766 [info] circuit_handle_first_hop(): Next router is 72050E1047E16D606EA3D30877ADC85521E2AB28: Not connected. Connecting. May 22 19:47:56.766 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:56.767 [info] connection_ap_make_link(): Making internal direct tunnel to 91.67.76.249:443 ... May 22 19:47:56.767 [info] onion_pick_cpath_exit(): Using requested exit node '58B6EEFB4838C900EE2854D5C5C2BFF4B1B40CC3' May 22 19:47:56.767 [info] circuit_handle_first_hop(): Next router is 58B6EEFB4838C900EE2854D5C5C2BFF4B1B40CC3: Not connected. Connecting. May 22 19:47:56.767 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:47:56.767 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 147.32.98.63:9001 May 22 19:47:56.767 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:56.767 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:56.767 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:56.767 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:56.767 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:56.767 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:56.767 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:47:56.782 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "213.112.198.243",443,tor,fca3b2bcfe441b36d1c8c9ae532f64f93c537743bf9fd0d44865fb05820363c289b7548728b4b86f849a4498a75da3eb May 22 19:47:56.783 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:47:56.783 [info] exit circ (length 1): $CCF1A0CB3FA11ABA052EAB86DA5830DAB97D41C0(open) May 22 19:47:56.868 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "75.73.41.14",9001,tor,591a6a14a5dd13286505d24eee0c759e4fe97e5c0abf3eae34533fb2e6f29f0404c12900e39c62dfdd20d82c51137d96 May 22 19:47:56.973 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "213.253.1.10",9001,tor,e97418e0a4fc182599fddf3662e6df562714a61aac4b5d3fcb191135ec627dce254747c76f7ad25b172227aa463f9f75 May 22 19:47:57.075 [info] command_process_versions_cell(): Negotiated version 2 with 91.198.227.49:9001; sending NETINFO. May 22 19:47:57.075 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:57.075 [info] command_process_netinfo_cell(): Got good NETINFO cell from 91.198.227.49:9001; OR connection is now open, using protocol version 2 May 22 19:47:57.123 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "213.253.1.10",9001,tor,e2e19f67a93cf9bbb17c63e8166b36fe4aed6b0e64c68a9ce439c795f701116e72bfe6f1116cf23680c3ef7ddba0118e May 22 19:47:57.176 [info] command_process_versions_cell(): Negotiated version 2 with 75.73.41.14:9001; sending NETINFO. May 22 19:47:57.176 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:57.176 [info] command_process_netinfo_cell(): Got good NETINFO cell from 75.73.41.14:9001; OR connection is now open, using protocol version 2 May 22 19:47:57.192 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 36009. Removing stream. May 22 19:47:57.192 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:57.194 [info] connection_dir_client_reached_eof(): Received server info (size 135535) from server '93.129.13.124:11100' May 22 19:47:57.215 [info] router_load_routers_from_string(): 95 elements to add May 22 19:47:57.217 [info] routerlist_remove_old_routers(): We have 191 live routers and 0 old router descriptors. May 22 19:47:57.217 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:57.218 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:57.218 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:57.219 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:57.220 [notice] Bootstrapped 64%: Loading relay descriptors. May 22 19:47:57.220 [notice] I learned some more directory information, but not enough to build a circuit: We have only 191/1534 usable descriptors. May 22 19:47:57.222 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 191 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 1344 in progress. May 22 19:47:57.222 [info] connection_dir_client_reached_eof(): Received 95/95 router descriptors requested from 93.129.13.124:11100 May 22 19:47:57.222 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:57.222 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "83.65.91.108",443,tor,2ef4596dd282c7da81ea6914bccc54ffe538d76abe4cf08f54a1624f9e0e8caf60913624244496437a1e97abc400c211 May 22 19:47:57.492 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:57.492 [info] exit circ (length 1): $C7893FC9EA62049BCB512E8486880B361AF45271(open) May 22 19:47:57.645 [info] command_process_versions_cell(): Negotiated version 2 with 213.253.1.10:9001; sending NETINFO. May 22 19:47:57.645 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:57.645 [info] command_process_netinfo_cell(): Got good NETINFO cell from 213.253.1.10:9001; OR connection is now open, using protocol version 2 May 22 19:47:57.793 [info] command_process_versions_cell(): Negotiated version 2 with 213.112.198.243:443; sending NETINFO. May 22 19:47:57.793 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:57.793 [info] command_process_netinfo_cell(): Got good NETINFO cell from 213.112.198.243:443; OR connection is now open, using protocol version 2 May 22 19:47:57.979 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "75.73.41.14",9001,12394,forward,9bbae1cc70ec83d3c4e3ff817407e23ee477f100,dbb83ff3cdbdf2f24fd09240601f5040 May 22 19:47:57.979 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "75.73.41.14",9001,12394,reverse,ee338376134c569a6af869de08fd688d1e508ccb,70eed22dc44b414a3863721768be6166 May 22 19:47:57.979 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:57.979 [info] exit circ (length 1, exit 8FE5206363990D8DB3846A90F582BFB393161060): $8FE5206363990D8DB3846A90F582BFB393161060(open) May 22 19:47:57.979 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:57.979 [info] exit circ (length 1): $8FE5206363990D8DB3846A90F582BFB393161060(open) May 22 19:47:57.979 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 12394 May 22 19:47:57.994 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "83.65.91.108",443,tor,b049d31699ea7df2c0f151ea3f9a4e3672bc0348e3488c16173d2f9115d7565be21473ef05a6cef88df31ee937186582 May 22 19:47:58.066 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 40822. Removing stream. May 22 19:47:58.066 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:58.068 [info] connection_dir_client_reached_eof(): Received server info (size 155739) from server '77.84.113.156:443' May 22 19:47:58.091 [info] router_load_routers_from_string(): 95 elements to add May 22 19:47:58.092 [info] routerlist_remove_old_routers(): We have 286 live routers and 0 old router descriptors. May 22 19:47:58.092 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:58.095 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:58.095 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:58.097 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:58.097 [notice] Bootstrapped 71%: Loading relay descriptors. May 22 19:47:58.097 [notice] I learned some more directory information, but not enough to build a circuit: We have only 286/1534 usable descriptors. May 22 19:47:58.099 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 286 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 1249 in progress. May 22 19:47:58.099 [info] connection_dir_client_reached_eof(): Received 95/96 router descriptors requested from 77.84.113.156:443 May 22 19:47:58.099 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:58.100 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "91.198.227.49",9001,895,forward,0d51aee5a55121542852dfc2f26ac5d51c87e553,ae39b8264ace6124acb2c3a659a69207 May 22 19:47:58.100 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "91.198.227.49",9001,895,reverse,e2ece2c5ee5dca671e111590a52211289a45d3db,8e0c8baaaa61774a3c7af93d2daecbec May 22 19:47:58.100 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:58.100 [info] exit circ (length 1, exit E69CE28A1F180C1822930F94AC20364FDFC09793): $E69CE28A1F180C1822930F94AC20364FDFC09793(open) May 22 19:47:58.100 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:58.100 [info] exit circ (length 1): $E69CE28A1F180C1822930F94AC20364FDFC09793(open) May 22 19:47:58.100 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 895 May 22 19:47:58.287 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "90.24.32.9",9001,tor,a8c8669c8b99edbaca328c454ffe8a4cb2b539dec5f1db37959c8b1e1dff38dff3fb93795ee11aa4c98a6e2d7f145154 May 22 19:47:58.467 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:58.467 [info] exit circ (length 1): $8FE5206363990D8DB3846A90F582BFB393161060(open) May 22 19:47:58.666 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "213.253.1.10",9001,58745,forward,b7fc47659906efac85374616708596fc3486fad1,996521dde6a6353316ae359d26a2f79c May 22 19:47:58.666 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "213.253.1.10",9001,58745,reverse,8c4fdcafbdeda9246f94d3e901986ff1c50c853d,5c4eed5a0b9c13d7d02e2e8580c731cb May 22 19:47:58.666 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:58.666 [info] exit circ (length 1, exit 72050E1047E16D606EA3D30877ADC85521E2AB28): $72050E1047E16D606EA3D30877ADC85521E2AB28(open) May 22 19:47:58.666 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:58.666 [info] exit circ (length 1): $72050E1047E16D606EA3D30877ADC85521E2AB28(open) May 22 19:47:58.666 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 58745 May 22 19:47:58.795 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "213.112.198.243",443,24961,forward,7198b901a77989879875df8e79d404d6648925e7,382fc6a3d3be0cfddc37edd24c394150 May 22 19:47:58.795 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "213.112.198.243",443,24961,reverse,afe45bb58e8f6292208539be1c3fac7d84530c2b,695eb0fe7b5bebc3e8ae74fa7fa75302 May 22 19:47:58.795 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:47:58.795 [info] exit circ (length 1, exit 647486E22ECF2A71CE4771B2FB5B121039B5C09A): $647486E22ECF2A71CE4771B2FB5B121039B5C09A(open) May 22 19:47:58.795 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:47:58.795 [info] exit circ (length 1): $647486E22ECF2A71CE4771B2FB5B121039B5C09A(open) May 22 19:47:58.795 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 24961 May 22 19:47:58.841 [info] command_process_versions_cell(): Negotiated version 2 with 83.65.91.108:443; sending NETINFO. May 22 19:47:58.841 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:47:58.841 [info] command_process_netinfo_cell(): Got good NETINFO cell from 83.65.91.108:443; OR connection is now open, using protocol version 2 May 22 19:47:58.892 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.208.193.36",443,tor,23205a65993b9e5ceb3018e4ed06689974a9e9ec77823e2a90892ba6015a450407cfe152b19b4d0cd780b23272a3e615 May 22 19:47:58.913 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 49462. Removing stream. May 22 19:47:58.913 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:58.915 [info] connection_dir_client_reached_eof(): Received server info (size 136360) from server '88.140.187.164:443' May 22 19:47:58.936 [info] router_load_routers_from_string(): 96 elements to add May 22 19:47:58.938 [notice] Bootstrapped 78%: Loading relay descriptors. May 22 19:47:58.938 [notice] I learned some more directory information, but not enough to build a circuit: We have only 382/1534 usable descriptors. May 22 19:47:58.940 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 382 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 1152 in progress. May 22 19:47:58.940 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 88.140.187.164:443 May 22 19:47:58.940 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:59.009 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 39065. Removing stream. May 22 19:47:59.009 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:59.011 [info] connection_dir_client_reached_eof(): Received server info (size 147058) from server '79.111.86.60:9001' May 22 19:47:59.035 [info] router_load_routers_from_string(): 96 elements to add May 22 19:47:59.037 [info] routerlist_remove_old_routers(): We have 478 live routers and 0 old router descriptors. May 22 19:47:59.037 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:59.042 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:59.042 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:47:59.046 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:47:59.046 [notice] We now have enough directory information to build circuits. May 22 19:47:59.046 [notice] Bootstrapped 80%: Connecting to the Tor network. May 22 19:47:59.046 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 79.111.86.60:9001 May 22 19:47:59.046 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:59.077 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:59.077 [info] exit circ (length 1): $E69CE28A1F180C1822930F94AC20364FDFC09793(open) May 22 19:47:59.555 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 42873. Removing stream. May 22 19:47:59.555 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:59.557 [info] connection_dir_client_reached_eof(): Received server info (size 140138) from server '80.56.34.26:9001' May 22 19:47:59.579 [info] router_load_routers_from_string(): 96 elements to add May 22 19:47:59.581 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 80.56.34.26:9001 May 22 19:47:59.581 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:47:59.687 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:59.687 [info] exit circ (length 1): 72050E1047E16D606EA3D30877ADC85521E2AB28(open) May 22 19:47:59.786 [info] circuit_predict_and_launch_new(): Have 0 clean circs (0 internal), need another exit circ. May 22 19:47:59.787 [info] choose_good_exit_server_general(): Found 294 servers that might support 0/0 pending connections. May 22 19:47:59.787 [info] choose_good_exit_server_general(): Chose exit server 'propsy' May 22 19:47:59.787 [info] add_an_entry_guard(): Chose 'enterprise' as new entry guard. May 22 19:47:59.787 [info] log_entry_guards(): enterprise (up never-contacted) May 22 19:47:59.787 [info] add_an_entry_guard(): Chose 'chome' as new entry guard. May 22 19:47:59.787 [info] log_entry_guards(): enterprise (up never-contacted),chome (up never-contacted) May 22 19:47:59.787 [info] add_an_entry_guard(): Chose 'tbreg' as new entry guard. May 22 19:47:59.787 [info] log_entry_guards(): enterprise (up never-contacted),chome (up never-contacted),tbreg (up never-contacted) May 22 19:47:59.787 [info] circuit_handle_first_hop(): Next router is enterprise: Not connected. Connecting. May 22 19:47:59.800 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:47:59.800 [info] exit circ (length 1): $647486E22ECF2A71CE4771B2FB5B121039B5C09A(open) May 22 19:47:59.846 [notice] Bootstrapped 85%: Finishing handshake with first hop. May 22 19:48:00.014 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "193.201.52.133",9001,tor,540760563751c38508840c8715af645589334683c5446f86eb02e9617cdfc48e59916bb7f1c9c7f12016ff74e2be6e94 May 22 19:48:00.113 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "83.65.91.108",443,23397,forward,0bb7c5b79950d95a52eec932ebe0982f06330765,acfea7168ff5ce13d510ed004e4e3fe9 May 22 19:48:00.113 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "83.65.91.108",443,23397,reverse,55c527a2d46dca6b1209ee273d4eba45a52aee9a,a2b1d34251bd58e3fdfd265a5f8b75b8 May 22 19:48:00.113 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:00.113 [info] exit circ (length 1, exit 1E46A7BB0E225B6571AB2998E4A1E02BF72B0199): 1E46A7BB0E225B6571AB2998E4A1E02BF72B0199(open) May 22 19:48:00.113 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:00.114 [info] exit circ (length 1): 1E46A7BB0E225B6571AB2998E4A1E02BF72B0199(open) May 22 19:48:00.114 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 23397 May 22 19:48:00.191 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "193.201.52.133",9001,tor,08e3ec910bf4eda692231e535ead923f32eec771c9dfd387e6927a57aeb2ac1a5ee2fb3ad0bb3445da9eb8654f87cb91 May 22 19:48:00.677 [info] handle_control_authenticate(): Authenticated control connection (30) May 22 19:48:00.685 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:00.686 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:00.794 [info] circuit_predict_and_launch_new(): Have 1 clean circs (0 internal), need another exit circ. May 22 19:48:00.794 [info] choose_good_exit_server_general(): Found 294 servers that might support 0/0 pending connections. May 22 19:48:00.794 [info] choose_good_exit_server_general(): Chose exit server 'Sheepy' May 22 19:48:00.794 [info] circuit_handle_first_hop(): Next router is enterprise: Connection in progress; waiting. May 22 19:48:00.910 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:00.910 [info] exit circ (length 1): 1E46A7BB0E225B6571AB2998E4A1E02BF72B0199(open) May 22 19:48:00.998 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:00.999 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.000 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.001 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.001 [warn] Controller gave us config lines that didn't validate: Must set TunnelDirConns if PreferTunneledDirConns is set. May 22 19:48:01.001 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.002 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.003 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.004 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.004 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.005 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.005 [info] options_act(): Worker-related options changed. Rotating workers. May 22 19:48:01.006 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.006 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.007 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.008 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.008 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.009 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.009 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.010 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.010 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.010 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.010 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.011 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.011 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.012 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.012 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.013 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.013 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.013 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.013 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.014 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.014 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.015 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.015 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.015 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.016 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.016 [warn] Controller gave us config lines that didn't validate: Bad HashedControlPassword: wrong length or bad encoding May 22 19:48:01.017 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.017 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.018 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.018 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.018 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.018 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.019 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.019 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.020 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.020 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.021 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.021 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.021 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.021 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.022 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.022 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.023 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.023 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.131 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.131 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.131 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.131 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.132 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.132 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.133 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.133 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.134 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.134 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.134 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.134 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.135 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.135 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.136 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.136 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.137 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.137 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.137 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.138 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.138 [warn] ControlPort is open, but no authentication method has been configured. This means that any program on your computer can reconfigure your Tor. That's bad! You should upgrade your Tor controller as soon as possible. May 22 19:48:01.138 [warn] Skipping invalid argument 'google.com.unnamed.Exit,hotmail.com hotmail.com.whistlersmother.Exit' to MapAddress May 22 19:48:01.194 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "90.24.32.9",9001,tor,10af81416a86cbbb8677019dd76c7a5cf23b8707df5d2be2ba9643b5d9197273e562dcbdaee023da8810e641b2dc4627 May 22 19:48:01.250 [info] command_process_versions_cell(): Negotiated version 2 with 193.201.52.133:9001; sending NETINFO. May 22 19:48:01.250 [notice] Bootstrapped 90%: Establishing a Tor circuit. May 22 19:48:01.250 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'enterprise' May 22 19:48:01.250 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'enterprise' May 22 19:48:01.250 [info] command_process_netinfo_cell(): Got good NETINFO cell from 193.201.52.133:9001; OR connection is now open, using protocol version 2 May 22 19:48:01.315 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "91.67.76.249",443,tor,4680d5e634eeb1c4af0ee2b0d3797d32318aee7fea28ad64920745108ade1e36871afd70afe775159752f76bbc35366a May 22 19:48:01.544 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.208.193.36",443,tor,fa27e0f94ad02f2a1aa42da502f8bfe04ab8cb26ad00a3b9cad8a3fcafa4d1b41819fb650fe38ed9f98b6f5dc8dd0a82 May 22 19:48:01.794 [info] circuit_predict_and_launch_new(): Have 2 clean circs (0 uptime-internal, 0 internal), need another hidserv circ. May 22 19:48:01.794 [info] add_an_entry_guard(): Chose 'toradactyl' as new entry guard. May 22 19:48:01.794 [info] log_entry_guards(): enterprise (up made-contact),chome (up never-contacted),tbreg (up never-contacted),toradactyl (up never-contacted) May 22 19:48:01.794 [info] add_an_entry_guard(): Chose '42rangnar23' as new entry guard. May 22 19:48:01.794 [info] log_entry_guards(): enterprise (up made-contact),chome (up never-contacted),tbreg (up never-contacted),toradactyl (up never-contacted),42rangnar23 (up never-contacted) May 22 19:48:01.794 [info] circuit_handle_first_hop(): Next router is 42rangnar23: Not connected. Connecting. May 22 19:48:02.237 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "93.209.240.153",9001,tor,cff3e9fda94be5bc207de5a84ef78eb07cc00bfceafedb7ec23c68a5b26cc795b0cb7f84109c115106f8a580295f36ce May 22 19:48:02.249 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6587,forward,c34bb769947b3d6f36b6f27fd9b7137eddacd2df,ab37a62eaee8ff8bf47dc83b1a474813 May 22 19:48:02.249 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6587,reverse,498434b22ae266639120c88cae93449c005df962,d93d5be66c470504d051f26426ec4416 May 22 19:48:02.249 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:02.249 [info] exit circ (length 3, exit propsy): enterprise(open) atacama(closed) propsy(closed) May 22 19:48:02.251 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:02.321 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6588,forward,31a22e23b0dcb7c5aeeff74cf4cc1ea7b4f971a3,4ccd76be670d557a4f453018579fff22 May 22 19:48:02.321 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6588,reverse,e91f9b57d21b74e109856482a35a6fecc10c5129,6805848f11fc91d24f3ebcdf39240f95 May 22 19:48:02.321 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:02.321 [info] exit circ (length 3, exit Sheepy): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(closed) Sheepy(closed) May 22 19:48:02.323 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:02.559 [info] command_process_versions_cell(): Negotiated version 2 with 79.208.193.36:443; sending NETINFO. May 22 19:48:02.559 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:48:02.559 [info] command_process_netinfo_cell(): Got good NETINFO cell from 79.208.193.36:443; OR connection is now open, using protocol version 2 May 22 19:48:02.794 [info] circuit_predict_and_launch_new(): Have 3 clean circs (1 uptime-internal, 1 internal), need another hidserv circ. May 22 19:48:02.794 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'enterprise' May 22 19:48:02.846 [info] command_process_versions_cell(): Negotiated version 2 with 90.24.32.9:9001; sending NETINFO. May 22 19:48:02.846 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:48:02.846 [info] command_process_netinfo_cell(): Got good NETINFO cell from 90.24.32.9:9001; OR connection is now open, using protocol version 2 May 22 19:48:03.261 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6589,forward,aade1f4589462316b7c8e85b009a9965b3d2755d,c22aa64a41a20ec4f57156c85631457e May 22 19:48:03.261 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6589,reverse,07f332fe8cf5634004af8b8e6c701995d233131d,2c7f60a81ad3d457373855e7134cb24e May 22 19:48:03.261 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:03.261 [info] internal (high-uptime) circ (length 3, exit GEO): enterprise(open) corfu(closed) GEO(closed) May 22 19:48:03.263 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:03.733 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.208.193.36",443,42919,forward,2fd5a6aad662d55b2b6de923875585828a0cb6b0,02ee49dfeffedb7e9fc9f49b7c9863f0 May 22 19:48:03.733 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.208.193.36",443,42919,reverse,951628a9b352cb0c090b163e00d01b0282123381,e53acec3a031ee9ce011aa34debadd71 May 22 19:48:03.733 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:03.733 [info] exit circ (length 1, exit 8DAF83555EFAD50CC86D491ED2CEA8FCB17E337B): $8DAF83555EFAD50CC86D491ED2CEA8FCB17E337B(open) May 22 19:48:03.733 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:03.733 [info] exit circ (length 1): $8DAF83555EFAD50CC86D491ED2CEA8FCB17E337B(open) May 22 19:48:03.733 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 42919 May 22 19:48:03.756 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "93.209.240.153",9001,tor,dd3d02d525ff3f4a1dd4e2ee06ba5feba6cd50423a64b99e2ad7dc2dd07773e04f66c87b845ca68bf81084c3214554f5 May 22 19:48:03.795 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 574 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 960 in progress. May 22 19:48:03.796 [info] update_extrainfo_downloads(): Extrainfo download status: 50 router with no ei, 0 with present ei, 0 delaying, 0 pending, 524 downloadable. May 22 19:48:03.797 [info] connection_ap_make_link(): Making internal direct tunnel to 89.113.222.107:9001 ... May 22 19:48:03.797 [info] onion_pick_cpath_exit(): Using requested exit node 'mral' May 22 19:48:03.797 [info] circuit_handle_first_hop(): Next router is mral: Not connected. Connecting. May 22 19:48:03.797 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:03.797 [info] connection_ap_make_link(): Making internal direct tunnel to 79.134.170.65:443 ... May 22 19:48:03.797 [info] onion_pick_cpath_exit(): Using requested exit node 'ivangotoy' May 22 19:48:03.797 [info] circuit_handle_first_hop(): Next router is ivangotoy: Not connected. Connecting. May 22 19:48:03.797 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:03.797 [info] connection_ap_make_link(): Making internal direct tunnel to 79.134.170.65:443 ... May 22 19:48:03.798 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:03.798 [info] connection_ap_make_link(): Making internal direct tunnel to 89.113.222.107:9001 ... May 22 19:48:03.798 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:03.798 [info] connection_ap_make_link(): Making internal direct tunnel to 89.113.222.107:9001 ... May 22 19:48:03.798 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:03.798 [info] connection_ap_make_link(): Making internal direct tunnel to 89.113.222.107:9001 ... May 22 19:48:03.798 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:03.799 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:04.144 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.134.170.65",443,tor,f456ff9f59de3f7901fbc3c742d8912f037daa8278f8888608ede4acbd2090c157314eca0f3dad6ce7b4919cb351efe1 May 22 19:48:04.230 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 19131. Removing stream. May 22 19:48:04.230 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:04.232 [info] connection_dir_client_reached_eof(): Received server info (size 137079) from server '91.198.227.49:9001' May 22 19:48:04.253 [info] router_load_routers_from_string(): 96 elements to add May 22 19:48:04.256 [info] entry_guard_set_status(): Entry guard enterprise (894F36424095060F599657C181EDF62AF0E7F56C) is not recommended as a guard: marking as unusable. May 22 19:48:04.256 [info] entry_guard_set_status(): Entry guard chome (26B42DF07715CE875FB15A4281B037CE875B0C56) is not recommended as a guard: marking as unusable. May 22 19:48:04.256 [info] entry_guard_set_status(): Entry guard tbreg (6CC5928C614B075CD63199EBF58781F3C2D93479) is not recommended as a guard: marking as unusable. May 22 19:48:04.256 [info] entry_guard_set_status(): Entry guard toradactyl (9A29219D217A2781F9F8DC16A1AED8D8D7B3A64D) is not recommended as a guard: marking as unusable. May 22 19:48:04.256 [info] entry_guard_set_status(): Entry guard 42rangnar23 (D281C408176F0DEF40E4256B8EDAFB7037848E16) is not recommended as a guard: marking as unusable. May 22 19:48:04.256 [info] entry_guards_compute_status(): Summary: Entry 'enterprise' is reachable, unusable, not recommended as a guard, and not live. May 22 19:48:04.256 [info] entry_guards_compute_status(): Summary: Entry 'chome' is reachable, unusable, not recommended as a guard, and not live. May 22 19:48:04.256 [info] entry_guards_compute_status(): Summary: Entry 'tbreg' is reachable, unusable, not recommended as a guard, and not live. May 22 19:48:04.256 [info] entry_guards_compute_status(): Summary: Entry 'toradactyl' is reachable, unusable, not recommended as a guard, and not live. May 22 19:48:04.256 [info] entry_guards_compute_status(): Summary: Entry '42rangnar23' is reachable, unusable, not recommended as a guard, and not live. May 22 19:48:04.256 [info] entry_guards_compute_status(): (0/5 entry guards are usable/new) May 22 19:48:04.256 [info] log_entry_guards(): enterprise (down made-contact),chome (down never-contacted),tbreg (down never-contacted),toradactyl (down never-contacted),42rangnar23 (down never-contacted) May 22 19:48:04.256 [info] update_extrainfo_downloads(): Extrainfo download status: 55 router with no ei, 0 with present ei, 0 delaying, 524 pending, 91 downloadable. May 22 19:48:04.257 [info] connection_ap_make_link(): Making internal direct tunnel to 89.113.222.107:9001 ... May 22 19:48:04.257 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:04.257 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 91.198.227.49:9001 May 22 19:48:04.257 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:04.257 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:04.257 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:04.264 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6587,forward,1a411d0a194fcb27ad6420cadb5a484f036a0161,a22062423f921ba8557a14b43afc8482 May 22 19:48:04.264 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6587,reverse,53932bf0140036f7d33aba0de67482ef0a57472a,dac5b7bd950b3acc6ba80934899a1b98 May 22 19:48:04.264 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:04.264 [info] exit circ (length 3, exit propsy): enterprise(open) atacama(open) propsy(closed) May 22 19:48:04.266 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:04.422 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.134.170.65",443,tor,fc92bc435582f9b28153ac16138a8fc90e01683808eec6e910a866a9daa8d0ff8a66ff30ff66d477e53551654b561fe2 May 22 19:48:04.561 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:48:04.561 [info] exit circ (length 1): $8DAF83555EFAD50CC86D491ED2CEA8FCB17E337B(open) May 22 19:48:04.590 [info] command_process_versions_cell(): Negotiated version 2 with 79.134.170.65:443; sending NETINFO. May 22 19:48:04.590 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'ivangotoy' May 22 19:48:04.590 [info] command_process_netinfo_cell(): Got good NETINFO cell from 79.134.170.65:443; OR connection is now open, using protocol version 2 May 22 19:48:04.771 [info] command_process_versions_cell(): Negotiated version 2 with 93.209.240.153:9001; sending NETINFO. May 22 19:48:04.771 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '42rangnar23' May 22 19:48:04.771 [info] command_process_netinfo_cell(): Got good NETINFO cell from 93.209.240.153:9001; OR connection is now open, using protocol version 2 May 22 19:48:04.814 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "91.67.76.249",443,tor,63ef103f3b47c3d14a82cee8e656ae1f583afda093f3a19a12ad06e17ec095fc57d4e4f01ee725188994fe1d61887c36 May 22 19:48:04.887 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 36969. Removing stream. May 22 19:48:04.887 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:04.889 [info] connection_dir_client_reached_eof(): Received server info (size 134741) from server '213.112.198.243:443' May 22 19:48:04.910 [info] router_load_routers_from_string(): 96 elements to add May 22 19:48:04.912 [info] routerlist_remove_old_routers(): We have 766 live routers and 0 old router descriptors. May 22 19:48:04.912 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:48:04.917 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:04.918 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:48:04.924 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:04.925 [info] update_extrainfo_downloads(): Extrainfo download status: 64 router with no ei, 0 with present ei, 0 delaying, 615 pending, 87 downloadable. May 22 19:48:04.926 [info] connection_ap_make_link(): Making internal direct tunnel to 79.134.170.65:443 ... May 22 19:48:04.926 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:04.926 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 213.112.198.243:443 May 22 19:48:04.926 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:04.926 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:04.926 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:04.926 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 19999. Removing stream. May 22 19:48:04.926 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:04.928 [info] connection_dir_client_reached_eof(): Received server info (size 142913) from server '75.73.41.14:9001' May 22 19:48:04.950 [info] router_load_routers_from_string(): 96 elements to add May 22 19:48:04.956 [info] update_extrainfo_downloads(): Extrainfo download status: 74 router with no ei, 0 with present ei, 0 delaying, 702 pending, 86 downloadable. May 22 19:48:04.956 [info] connection_ap_make_link(): Making internal direct tunnel to 93.152.151.31:9001 ... May 22 19:48:04.956 [info] onion_pick_cpath_exit(): Using requested exit node 'TorKServers' May 22 19:48:04.956 [info] circuit_handle_first_hop(): Next router is TorKServers: Not connected. Connecting. May 22 19:48:04.956 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:04.956 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 75.73.41.14:9001 May 22 19:48:04.956 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:04.956 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:04.956 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:05.283 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "93.152.151.31",9001,tor,bc7ba4dcafae6010ec7fcb9b10c33d0399dd72b3fd563790bd804eef23dcee4c2ed1528143925a9fe57a1d2741aaff0f May 22 19:48:05.600 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.134.170.65",443,30616,forward,62917f139e3b27d725da3cdbbc9e84ea61188241,6c9ac80fa50ab4df90f7b8dc16513ed1 May 22 19:48:05.600 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.134.170.65",443,30616,reverse,05340cfe79ce7dc8fdb14f9d2b20b8bc858e94f4,357636c535109aa07a0c4c9372fc0e4b May 22 19:48:05.600 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:05.600 [info] exit circ (length 1, exit ivangotoy): ivangotoy(open) May 22 19:48:05.600 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:05.600 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:05.600 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 30616 May 22 19:48:05.600 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:05.600 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 30616 May 22 19:48:05.600 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:05.600 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 30616 May 22 19:48:05.644 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "93.152.151.31",9001,tor,f0dac1ed4b2e41566373117cde768363fd7fd3efc2fe85b55069dd167e009a690604f98475aa40c85dc3edb05917684a May 22 19:48:05.746 [info] command_process_versions_cell(): Negotiated version 2 with 93.152.151.31:9001; sending NETINFO. May 22 19:48:05.746 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'TorKServers' May 22 19:48:05.746 [info] command_process_netinfo_cell(): Got good NETINFO cell from 93.152.151.31:9001; OR connection is now open, using protocol version 2 May 22 19:48:05.783 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.209.240.153",9001,54483,forward,44dc5f3e5e6bd516135cc18c6009dc633a92fd4c,8945149904bd721fe97cfe8fa8b21ad5 May 22 19:48:05.783 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.209.240.153",9001,54483,reverse,db82eef65d02527054be2ed2aefe1e31d091626e,76e06a238c35b600fb0205e9f2bd7221 May 22 19:48:05.783 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:05.783 [info] internal (high-uptime) circ (length 3, exit mailus): 42rangnar23(open) aLPHAbETAgAMMAdELTA(closed) $100A15645E2B057220D0C53CACD3EDBBABC6E9EA(closed) May 22 19:48:05.785 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:06.004 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.152.151.31",9001,45914,forward,29b204a490287ec63aa4b57b60512023c88daec0,65224758d85fc5944c7b35557be5c12a May 22 19:48:06.004 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.152.151.31",9001,45914,reverse,8789570e91b340be0efe0dccf350382141dcf595,638fbb7d522da1ffb5da452919b90755 May 22 19:48:06.004 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:06.004 [info] exit circ (length 1, exit TorKServers): $4D3CCE5885A99D161B287B5CF12617B51BC69373(open) May 22 19:48:06.004 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:06.004 [info] exit circ (length 1): $4D3CCE5885A99D161B287B5CF12617B51BC69373(open) May 22 19:48:06.004 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 45914 May 22 19:48:06.114 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:06.114 [info] exit circ (length 1): $4D3CCE5885A99D161B287B5CF12617B51BC69373(open) May 22 19:48:06.261 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6587,forward,db6d9538a3b5a7dfb7bfa7d6565bd33a898d171e,4077b4621c76605f24701da9a54e2662 May 22 19:48:06.261 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6587,reverse,fe01e8a5090620025ce32d50ba7b2d8b9a0e2457,4ffbccfd75b9ea531b0138706c10c5a3 May 22 19:48:06.261 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:06.261 [info] exit circ (length 3, exit propsy): enterprise(open) atacama(open) propsy(open) May 22 19:48:06.261 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:06.261 [notice] Tor has successfully opened a circuit. Looks like client functionality is working. May 22 19:48:06.261 [notice] Bootstrapped 100%: Done. May 22 19:48:06.360 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6589,forward,fa586aac23148b53917bc102234513eb2028ee6f,0477a36e2f75d13bb5a8d9c259e8ec6a May 22 19:48:06.360 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6589,reverse,ee22f030e9232a82327c7fb83efdb8d4e23c031d,ae318480c2275f212c5f54392b5cf116 May 22 19:48:06.360 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:06.360 [info] internal (high-uptime) circ (length 3, exit GEO): enterprise(open) corfu(open) GEO(closed) May 22 19:48:06.362 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:06.364 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6588,forward,7bc135f625a7264afd98ea0e4f2e93c332d661af,f11cdb218d8ab8ce53c30c6470914b1b May 22 19:48:06.364 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6588,reverse,943a6cd432ebfe96729caa90d379b14212a5e2a0,1989a1c495dfc3889fe1f445ec0e66d1 May 22 19:48:06.364 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:06.364 [info] exit circ (length 3, exit Sheepy): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(open) Sheepy(closed) May 22 19:48:06.366 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:06.523 [info] command_process_versions_cell(): Negotiated version 2 with 91.67.76.249:443; sending NETINFO. May 22 19:48:06.523 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'rembremerdinger' May 22 19:48:06.523 [info] command_process_netinfo_cell(): Got good NETINFO cell from 91.67.76.249:443; OR connection is now open, using protocol version 2 May 22 19:48:06.605 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:48:06.605 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:06.718 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:48:06.718 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:06.718 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:48:06.718 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:07.295 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 5540. Removing stream. May 22 19:48:07.295 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:07.297 [info] connection_dir_client_reached_eof(): Received server info (size 48387) from server '83.65.91.108:443' May 22 19:48:07.304 [info] router_load_routers_from_string(): 32 elements to add May 22 19:48:07.307 [info] update_extrainfo_downloads(): Extrainfo download status: 77 router with no ei, 0 with present ei, 0 delaying, 788 pending, 29 downloadable. May 22 19:48:07.307 [info] connection_ap_make_link(): Making internal direct tunnel to 93.152.151.31:9001 ... May 22 19:48:07.307 [info] exit circ (length 1): $4D3CCE5885A99D161B287B5CF12617B51BC69373(open) May 22 19:48:07.307 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 45914 May 22 19:48:07.307 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:07.307 [info] connection_dir_client_reached_eof(): Received 32/32 router descriptors requested from 83.65.91.108:443 May 22 19:48:07.307 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:07.307 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:48:07.307 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:48:07.885 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 17096. Removing stream. May 22 19:48:07.885 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:07.886 [info] connection_dir_client_reached_eof(): Received server info (size 46213) from server '213.253.1.10:9001' May 22 19:48:07.893 [info] router_load_routers_from_string(): 32 elements to add May 22 19:48:07.896 [info] update_extrainfo_downloads(): Extrainfo download status: 79 router with no ei, 0 with present ei, 0 delaying, 817 pending, 30 downloadable. May 22 19:48:07.896 [info] connection_ap_make_link(): Making internal direct tunnel to 89.113.222.107:9001 ... May 22 19:48:07.896 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:07.896 [info] connection_dir_client_reached_eof(): Received 32/32 router descriptors requested from 213.253.1.10:9001 May 22 19:48:07.896 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:07.896 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:07.896 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:08.125 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "90.24.32.9",9001,49534,forward,3cb2c521850048e510d0ee2c1d4f7513271a10f9,525cbb73db584c1ce855ab5e01aa2288 May 22 19:48:08.125 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "90.24.32.9",9001,49534,reverse,2a3ca48221d66d3b929e5db0ccece63bd4e6d769,93e91ec0a4729ee2f476203c416d8db0 May 22 19:48:08.125 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:08.125 [info] exit circ (length 1, exit EA2CC2FD2CD1DCCB6E988EC843425398E98DA6B2): $EA2CC2FD2CD1DCCB6E988EC843425398E98DA6B2(open) May 22 19:48:08.125 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:08.125 [info] exit circ (length 1): $EA2CC2FD2CD1DCCB6E988EC843425398E98DA6B2(open) May 22 19:48:08.125 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 49534 May 22 19:48:08.577 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "91.67.76.249",443,8129,forward,8e49ea2dceabf004a2fb1674fc96540944cfe334,18476a1fab975d07260cd5596e7158b5 May 22 19:48:08.577 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "91.67.76.249",443,8129,reverse,490de8fad33aa1956ff435fb5f49b36216132370,8b5532964f7a7e99035bc801def0c5c1 May 22 19:48:08.577 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:08.577 [info] exit circ (length 1, exit 58B6EEFB4838C900EE2854D5C5C2BFF4B1B40CC3): $58B6EEFB4838C900EE2854D5C5C2BFF4B1B40CC3(open) May 22 19:48:08.577 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:08.577 [info] exit circ (length 1): $58B6EEFB4838C900EE2854D5C5C2BFF4B1B40CC3(open) May 22 19:48:08.577 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 8129 May 22 19:48:09.794 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.209.240.153",9001,54483,forward,a9c50c6e20f4dfe6fa8103bf2230fc33cb3282dd,fb722fb2cf4bcf03e99589bdd67eac83 May 22 19:48:09.794 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.209.240.153",9001,54483,reverse,f1abb2f0a0d7b21fc556505018a77ad16b8d2b69,e40651e32f364bad99960093703688a2 May 22 19:48:09.794 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:09.794 [info] internal (high-uptime) circ (length 3, exit mailus): 42rangnar23(open) aLPHAbETAgAMMAdELTA(open) $100A15645E2B057220D0C53CACD3EDBBABC6E9EA(closed) May 22 19:48:09.796 [info] circuit_send_next_onion_skin(): Sending extend relay cell. May 22 19:48:10.261 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6589,forward,fa7bd935b09e0c7be4b3661b0b861da81ea5b3bc,e914ad0b3881f30fae6c405f942b58c4 May 22 19:48:10.261 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6589,reverse,27cd1832aaf8065aa1bfab81ffc2e6249bbe13d2,9fa07025fc671867dc92d1da3f58d05d May 22 19:48:10.261 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:10.261 [info] internal (high-uptime) circ (length 3, exit GEO): enterprise(open) corfu(open) GEO(open) May 22 19:48:10.261 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:10.358 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6588,forward,2a22a990e7f1261e8a6484cb37a0b27a563c6daa,c58b741402bfc49bfb598d7a75cba444 May 22 19:48:10.358 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "193.201.52.133",9001,6588,reverse,14f7e85e203cbffcf6808ac0a44a02aac71b7485,097a720df485fefb1060fef38ef13ee0 May 22 19:48:10.358 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:10.358 [info] exit circ (length 3, exit Sheepy): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(open) Sheepy(open) May 22 19:48:10.358 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:10.424 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 2 seconds. May 22 19:48:10.424 [info] exit circ (length 1): $58B6EEFB4838C900EE2854D5C5C2BFF4B1B40CC3(open) May 22 19:48:11.793 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.209.240.153",9001,54483,forward,a207761c4081e662e8e13336861be362ea7eb50a,135769bda7e2688a3735eaa03a359858 May 22 19:48:11.793 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "93.209.240.153",9001,54483,reverse,a5919dee6040c3bb2bc10dd25516676ccb2aaac7,539964a7f7461ccbaea0603918b7a957 May 22 19:48:11.793 [info] circuit_finish_handshake(): Finished building circuit hop: May 22 19:48:11.793 [info] internal (high-uptime) circ (length 3, exit mailus): 42rangnar23(open) aLPHAbETAgAMMAdELTA(open) $100A15645E2B057220D0C53CACD3EDBBABC6E9EA(open) May 22 19:48:11.793 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:12.644 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 4 seconds. May 22 19:48:12.644 [info] exit circ (length 1): $EA2CC2FD2CD1DCCB6E988EC843425398E98DA6B2(open) May 22 19:48:12.661 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 39900. Removing stream. May 22 19:48:12.661 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:12.665 [info] connection_dir_client_reached_eof(): Received extra server info (size 158922) from server '79.134.170.65:443' May 22 19:48:12.677 [info] router_load_extrainfo_from_string(): 87 elements to add May 22 19:48:12.679 [info] routerlist_remove_old_routers(): We have 926 live routers and 0 old router descriptors. May 22 19:48:12.679 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:12.680 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:12.680 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:12.681 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:12.681 [info] connection_dir_client_reached_eof(): Received 87/87 extra-info documents requested from 79.134.170.65:443 May 22 19:48:12.681 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:14.562 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 18040. Removing stream. May 22 19:48:14.562 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 7 seconds. May 22 19:48:14.562 [info] exit circ (length 1): $4D3CCE5885A99D161B287B5CF12617B51BC69373(open) May 22 19:48:14.562 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:14.566 [info] connection_dir_client_reached_eof(): Received extra server info (size 159455) from server '93.152.151.31:9001' May 22 19:48:14.578 [info] router_load_extrainfo_from_string(): 86 elements to add May 22 19:48:14.580 [info] routerlist_remove_old_routers(): We have 926 live routers and 0 old router descriptors. May 22 19:48:14.580 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:14.582 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:14.582 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:14.583 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:14.584 [info] connection_dir_client_reached_eof(): Received 86/86 extra-info documents requested from 93.152.151.31:9001 May 22 19:48:14.584 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:15.139 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 18391. Removing stream. May 22 19:48:15.139 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:15.141 [info] connection_dir_client_reached_eof(): Received server info (size 43980) from server '91.67.76.249:443' May 22 19:48:15.148 [info] router_load_routers_from_string(): 32 elements to add May 22 19:48:15.150 [info] update_extrainfo_downloads(): Extrainfo download status: 80 router with no ei, 173 with present ei, 0 delaying, 674 pending, 31 downloadable. May 22 19:48:15.151 [info] connection_ap_make_link(): Making internal direct tunnel to 79.134.170.65:443 ... May 22 19:48:15.151 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:15.151 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 30616 May 22 19:48:15.151 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:15.151 [info] connection_dir_client_reached_eof(): Received 32/32 router descriptors requested from 91.67.76.249:443 May 22 19:48:15.151 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:15.151 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:48:15.151 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:48:18.576 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 27143. Removing stream. May 22 19:48:18.576 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:18.579 [info] connection_dir_client_reached_eof(): Received server info (size 148459) from server '79.208.193.36:443' May 22 19:48:18.600 [info] router_load_routers_from_string(): 96 elements to add May 22 19:48:18.604 [info] update_extrainfo_downloads(): Extrainfo download status: 90 router with no ei, 173 with present ei, 0 delaying, 705 pending, 86 downloadable. May 22 19:48:18.605 [info] connection_ap_make_link(): Making internal direct tunnel to 212.42.236.140:443 ... May 22 19:48:18.605 [info] onion_pick_cpath_exit(): Using requested exit node 'bach' May 22 19:48:18.605 [info] circuit_handle_first_hop(): Next router is bach: Not connected. Connecting. May 22 19:48:18.605 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:18.605 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 79.208.193.36:443 May 22 19:48:18.605 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:18.605 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:18.605 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:18.803 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "212.42.236.140",443,tor,8dabb24250c9f685b4b33be822c215085e435d03c39c078839b88738e8f8d94ef9803b4725c1c2189d994e4e3c765dd3 May 22 19:48:18.984 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "212.42.236.140",443,tor,1714a6da4072914bd9749d3acf2b500cda2eabcdcf158c658ffb748c04735c5c80e8504b61e5bd08c2ec322198926e45 May 22 19:48:19.047 [info] command_process_versions_cell(): Negotiated version 2 with 212.42.236.140:443; sending NETINFO. May 22 19:48:19.047 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'bach' May 22 19:48:19.047 [info] command_process_netinfo_cell(): Got good NETINFO cell from 212.42.236.140:443; OR connection is now open, using protocol version 2 May 22 19:48:19.206 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "212.42.236.140",443,31325,forward,e38b8493901f47e4b9806b21f91fd73ac5b0f5fa,91b5163eb0ec45d16636370589183ba8 May 22 19:48:19.206 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "212.42.236.140",443,31325,reverse,323f05899300541256db27c2088e5dc0ec340361,97c393cf0f185a6e06dc375daa2b2a0a May 22 19:48:19.206 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:19.206 [info] exit circ (length 1, exit bach): bach(open) May 22 19:48:19.206 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:19.206 [info] exit circ (length 1): bach(open) May 22 19:48:19.206 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 31325 May 22 19:48:19.268 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:19.268 [info] exit circ (length 1): bach(open) May 22 19:48:20.465 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 18041. Removing stream. May 22 19:48:20.465 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:20.466 [info] connection_dir_client_reached_eof(): Received extra server info (size 57469) from server '93.152.151.31:9001' May 22 19:48:20.470 [info] router_load_extrainfo_from_string(): 29 elements to add May 22 19:48:20.472 [info] connection_dir_client_reached_eof(): Received 29/29 extra-info documents requested from 93.152.151.31:9001 May 22 19:48:20.472 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:20.838 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 44211. Removing stream. May 22 19:48:20.838 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:20.841 [info] connection_dir_client_reached_eof(): Received extra server info (size 157890) from server '212.42.236.140:443' May 22 19:48:20.854 [info] router_load_extrainfo_from_string(): 86 elements to add May 22 19:48:20.856 [info] routerlist_remove_old_routers(): We have 1054 live routers and 0 old router descriptors. May 22 19:48:20.856 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:20.858 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:20.859 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:20.861 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:20.861 [info] connection_dir_client_reached_eof(): Received 86/86 extra-info documents requested from 212.42.236.140:443 May 22 19:48:20.861 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:22.892 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 39902. Removing stream. May 22 19:48:22.892 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 39901. Removing stream. May 22 19:48:22.892 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 7 seconds. May 22 19:48:22.892 [info] exit circ (length 1): ivangotoy(open) May 22 19:48:22.892 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:22.892 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:22.897 [info] connection_dir_client_reached_eof(): Received extra server info (size 167889) from server '79.134.170.65:443' May 22 19:48:22.910 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:22.913 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 79.134.170.65:443 May 22 19:48:22.913 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:22.915 [info] connection_dir_client_reached_eof(): Received extra server info (size 179435) from server '79.134.170.65:443' May 22 19:48:22.929 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:22.932 [info] routerlist_remove_old_routers(): We have 1054 live routers and 0 old router descriptors. May 22 19:48:22.932 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:22.935 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:22.936 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:22.939 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:22.940 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 79.134.170.65:443 May 22 19:48:22.940 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:25.822 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 39903. Removing stream. May 22 19:48:25.822 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:25.823 [info] connection_dir_client_reached_eof(): Received extra server info (size 55440) from server '79.134.170.65:443' May 22 19:48:25.828 [info] router_load_extrainfo_from_string(): 31 elements to add May 22 19:48:25.829 [info] connection_dir_client_reached_eof(): Received 31/31 extra-info documents requested from 79.134.170.65:443 May 22 19:48:25.829 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:25.850 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 5) May 22 19:48:25.850 [info] exit circ (length 1, exit 89FFA767EC5706C1A0A6BB4CDD7CF1A65B608A97): $89FFA767EC5706C1A0A6BB4CDD7CF1A65B608A97(closed) May 22 19:48:25.850 [info] connection_ap_fail_onehop(): Closing onehop stream to '$89FFA767EC5706C1A0A6BB4CDD7CF1A65B608A97/78.43.109.6' because the OR conn just failed. May 22 19:48:25.850 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 5) May 22 19:48:25.850 [info] exit circ (length 1, exit 1F02787580FBC23A19C2F99BAC3DA6A471045248): $1F02787580FBC23A19C2F99BAC3DA6A471045248(closed) May 22 19:48:25.850 [info] connection_ap_fail_onehop(): Closing onehop stream to '$1F02787580FBC23A19C2F99BAC3DA6A471045248/88.200.247.202' because the OR conn just failed. May 22 19:48:25.850 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 5) May 22 19:48:25.850 [info] exit circ (length 1, exit 26B42DF07715CE875FB15A4281B037CE875B0C56): $26B42DF07715CE875FB15A4281B037CE875B0C56(closed) May 22 19:48:25.850 [info] entry_guard_register_connect_status(): Connection to never-contacted entry guard 'chome' (26B42DF07715CE875FB15A4281B037CE875B0C56) failed. Removing from the list. -1/4 entry guards usable/new. May 22 19:48:25.850 [info] log_entry_guards(): enterprise (down made-contact),tbreg (down never-contacted),toradactyl (down never-contacted),42rangnar23 (down made-contact) May 22 19:48:25.850 [info] connection_ap_fail_onehop(): Closing onehop stream to '$26B42DF07715CE875FB15A4281B037CE875B0C56/77.198.246.8' because the OR conn just failed. May 22 19:48:25.850 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 5) May 22 19:48:25.850 [info] exit circ (length 1, exit 6585E356D3E655423A4DD2A5A581F951D214CEFE): $6585E356D3E655423A4DD2A5A581F951D214CEFE(closed) May 22 19:48:25.850 [info] connection_ap_fail_onehop(): Closing onehop stream to '$6585E356D3E655423A4DD2A5A581F951D214CEFE/77.204.2.159' because the OR conn just failed. May 22 19:48:25.851 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4042 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4042 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4042 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4044 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:25.851 [info] connection_dir_request_failed(): Giving up on directory server at '78.43.109.6'; retrying May 22 19:48:25.851 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:25.851 [info] connection_dir_request_failed(): Giving up on directory server at '77.204.2.159'; retrying May 22 19:48:25.851 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:25.851 [info] connection_dir_request_failed(): Giving up on directory server at '77.198.246.8'; retrying May 22 19:48:25.851 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:25.851 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:25.851 [info] connection_dir_request_failed(): Giving up on directory server at '88.200.247.202'; retrying May 22 19:48:25.851 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 5) May 22 19:48:33.878 [info] exit circ (length 1, exit mral): $8FABA50F851C61D37599AC1B8BB52956CC62262C(closed) May 22 19:48:33.878 [info] connection_ap_fail_onehop(): Closing onehop stream to '$8FABA50F851C61D37599AC1B8BB52956CC62262C/89.113.222.107' because the OR conn just failed. May 22 19:48:33.878 [info] connection_ap_fail_onehop(): Closing onehop stream to '$8FABA50F851C61D37599AC1B8BB52956CC62262C/89.113.222.107' because the OR conn just failed. May 22 19:48:33.878 [info] connection_ap_fail_onehop(): Closing onehop stream to '$8FABA50F851C61D37599AC1B8BB52956CC62262C/89.113.222.107' because the OR conn just failed. May 22 19:48:33.878 [info] connection_ap_fail_onehop(): Closing onehop stream to '$8FABA50F851C61D37599AC1B8BB52956CC62262C/89.113.222.107' because the OR conn just failed. May 22 19:48:33.878 [info] connection_ap_fail_onehop(): Closing onehop stream to '$8FABA50F851C61D37599AC1B8BB52956CC62262C/89.113.222.107' because the OR conn just failed. May 22 19:48:33.878 [info] connection_ap_fail_onehop(): Closing onehop stream to '$8FABA50F851C61D37599AC1B8BB52956CC62262C/89.113.222.107' because the OR conn just failed. May 22 19:48:33.878 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4044 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 1338 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4044 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 1912 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 3839 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 4044 bytes on inbuf, 0 on outbuf. May 22 19:48:33.878 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:33.879 [info] connection_dir_request_failed(): Giving up on directory server at '89.113.222.107'; retrying May 22 19:48:33.879 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:33.879 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:33.879 [info] connection_dir_request_failed(): Giving up on directory server at '89.113.222.107'; retrying May 22 19:48:33.879 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:33.879 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:33.879 [info] connection_dir_request_failed(): Giving up on directory server at '89.113.222.107'; retrying May 22 19:48:33.879 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:33.879 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:33.879 [info] connection_dir_request_failed(): Giving up on directory server at '89.113.222.107'; retrying May 22 19:48:33.879 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:33.879 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:33.879 [info] connection_dir_request_failed(): Giving up on directory server at '89.113.222.107'; retrying May 22 19:48:33.879 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:33.879 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing. May 22 19:48:33.879 [info] connection_dir_request_failed(): Giving up on directory server at '89.113.222.107'; retrying May 22 19:48:33.879 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:42.873 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 46083. Removing stream. May 22 19:48:42.873 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:42.875 [info] connection_dir_client_reached_eof(): Received server info (size 137982) from server '90.24.32.9:9001' May 22 19:48:42.896 [info] router_load_routers_from_string(): 96 elements to add May 22 19:48:42.899 [info] routerlist_remove_old_routers(): We have 1150 live routers and 0 old router descriptors. May 22 19:48:42.899 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:48:42.907 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:42.908 [info] router_rebuild_store(): Rebuilding router descriptors cache May 22 19:48:42.916 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:42.917 [info] update_extrainfo_downloads(): Extrainfo download status: 99 router with no ei, 511 with present ei, 0 delaying, 0 pending, 540 downloadable. May 22 19:48:42.919 [info] connection_ap_make_link(): Making internal direct tunnel to 212.42.236.140:443 ... May 22 19:48:42.919 [info] exit circ (length 1): bach(open) May 22 19:48:42.919 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 31325 May 22 19:48:42.919 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:42.919 [info] connection_ap_make_link(): Making internal direct tunnel to 62.141.58.13:443 ... May 22 19:48:42.919 [info] onion_pick_cpath_exit(): Using requested exit node 'gpfTOR3' May 22 19:48:42.919 [info] circuit_handle_first_hop(): Next router is gpfTOR3: Not connected. Connecting. May 22 19:48:42.919 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:42.919 [info] connection_ap_make_link(): Making internal direct tunnel to 62.141.58.13:443 ... May 22 19:48:42.919 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:42.920 [info] connection_ap_make_link(): Making internal direct tunnel to 192.251.226.206:443 ... May 22 19:48:42.920 [info] onion_pick_cpath_exit(): Using requested exit node 'blutmagie' May 22 19:48:42.920 [info] circuit_handle_first_hop(): Next router is blutmagie: Not connected. Connecting. May 22 19:48:42.920 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:42.920 [info] connection_ap_make_link(): Making internal direct tunnel to 62.141.58.13:443 ... May 22 19:48:42.920 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:42.920 [info] connection_ap_make_link(): Making internal direct tunnel to 192.251.226.206:443 ... May 22 19:48:42.920 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:48:42.920 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 90.24.32.9:9001 May 22 19:48:42.920 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.921 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:48:42.987 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:42.987 [info] exit circ (length 1): bach(open) May 22 19:48:43.138 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "62.141.58.13",443,tor,bf7bd92b4d17a90b6372d8dd9a4eed2ed990539ae71ecae0699d6dc4582bb3843334ba8c7dd3b4b20d4776e982ac0dca May 22 19:48:43.153 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "192.251.226.206",443,tor,4c9cc7e5f4da611490aac3dbcb686430b3df8f6546025afaf0daeb0484bc0f8ec39ebf61f22f5cfb2fddf4d84a9d6483 May 22 19:48:43.328 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "62.141.58.13",443,tor,d52728bde4c707c20bc7c6e77101d213b4a40f8f27d2af21d50a8c053665c6d3bc13361a92c6733b1978c91997820e73 May 22 19:48:43.392 [info] command_process_versions_cell(): Negotiated version 2 with 62.141.58.13:443; sending NETINFO. May 22 19:48:43.392 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'gpfTOR3' May 22 19:48:43.392 [info] command_process_netinfo_cell(): Got good NETINFO cell from 62.141.58.13:443; OR connection is now open, using protocol version 2 May 22 19:48:43.603 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "62.141.58.13",443,39185,forward,621c1c957df9f2d81a39587807913c2d76a768e6,e90893bb2298714419df70c1eb3b0fb7 May 22 19:48:43.603 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "62.141.58.13",443,39185,reverse,b5c125936fa4743766d78bc85a36b04b64e97d17,f52be8aeb7e291c66fcb8d8eba0923c5 May 22 19:48:43.603 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:43.603 [info] exit circ (length 1, exit gpfTOR3): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.603 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:43.603 [info] exit circ (length 1): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.603 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 39185 May 22 19:48:43.603 [info] exit circ (length 1): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.603 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 39185 May 22 19:48:43.603 [info] exit circ (length 1): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.603 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 39185 May 22 19:48:43.678 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:43.678 [info] exit circ (length 1): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.760 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:43.760 [info] exit circ (length 1): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.877 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:43.877 [info] exit circ (length 1): $6D3EE5088279027AD8F64FF61A079DC44E29E3DF(open) May 22 19:48:43.883 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "192.251.226.206",443,tor,aeb7c401064517477f32dbe1ec148edd9f75879ee10d080727aef1dd6e75e7b15356b9998886c44fd9e8e70165982903 May 22 19:48:44.058 [info] command_process_versions_cell(): Negotiated version 2 with 192.251.226.206:443; sending NETINFO. May 22 19:48:44.058 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'blutmagie' May 22 19:48:44.058 [info] command_process_netinfo_cell(): Got good NETINFO cell from 192.251.226.206:443; OR connection is now open, using protocol version 2 May 22 19:48:44.799 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "192.251.226.206",443,52615,forward,b9de12308ae7abd2c280932dea8f16d50356a3f2,2c89e9ef227c6992a0930656c4df4cc2 May 22 19:48:44.799 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "192.251.226.206",443,52615,reverse,1fd61ce8eb94d5959931b62f42de3f57217782b1,5ef0d853caf14d29f12901e9e59711a4 May 22 19:48:44.799 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:48:44.799 [info] exit circ (length 1, exit blutmagie): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:48:44.799 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:48:44.799 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:48:44.799 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 52615 May 22 19:48:44.799 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:48:44.799 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 52615 May 22 19:48:44.904 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:44.904 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:48:44.923 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 44212. Removing stream. May 22 19:48:44.923 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:44.926 [info] connection_dir_client_reached_eof(): Received extra server info (size 179088) from server '212.42.236.140:443' May 22 19:48:44.940 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:44.943 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 212.42.236.140:443 May 22 19:48:44.943 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:44.994 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:48:44.994 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:48:45.926 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 11079. Removing stream. May 22 19:48:45.926 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:45.929 [info] connection_dir_client_reached_eof(): Received extra server info (size 171682) from server '62.141.58.13:443' May 22 19:48:45.943 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:45.946 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 62.141.58.13:443 May 22 19:48:45.946 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:46.926 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 3353. Removing stream. May 22 19:48:46.926 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:46.929 [info] connection_dir_client_reached_eof(): Received extra server info (size 169991) from server '192.251.226.206:443' May 22 19:48:46.943 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:46.946 [info] routerlist_remove_old_routers(): We have 1150 live routers and 0 old router descriptors. May 22 19:48:46.946 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:46.952 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:46.953 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:48:46.960 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:48:46.960 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 192.251.226.206:443 May 22 19:48:46.960 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:48.926 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 3354. Removing stream. May 22 19:48:48.926 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:48.928 [info] connection_dir_client_reached_eof(): Received extra server info (size 103388) from server '192.251.226.206:443' May 22 19:48:48.937 [info] router_load_extrainfo_from_string(): 60 elements to add May 22 19:48:48.939 [info] connection_dir_client_reached_eof(): Received 60/60 extra-info documents requested from 192.251.226.206:443 May 22 19:48:48.939 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:48.939 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 11080. Removing stream. May 22 19:48:48.939 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:48.942 [info] connection_dir_client_reached_eof(): Received extra server info (size 167937) from server '62.141.58.13:443' May 22 19:48:48.956 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:48.958 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 62.141.58.13:443 May 22 19:48:48.958 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:51.935 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 11081. Removing stream. May 22 19:48:51.935 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:51.937 [info] connection_dir_client_reached_eof(): Received extra server info (size 172701) from server '62.141.58.13:443' May 22 19:48:51.951 [info] router_load_extrainfo_from_string(): 96 elements to add May 22 19:48:51.954 [info] connection_dir_client_reached_eof(): Received 96/96 extra-info documents requested from 62.141.58.13:443 May 22 19:48:51.954 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:48:53.938 [info] routerlist_remove_old_routers(): We have 1150 live routers and 0 old router descriptors. May 22 19:49:04.958 [info] update_consensus_router_descriptor_downloads(): 383 router descriptors downloadable. 0 delayed; 1150 present (0 of those were in old_routers); 0 would_reject; 6 wouldnt_use; 0 in progress. May 22 19:49:04.958 [info] launch_router_descriptor_downloads(): Launching 4 requests for 383 routers, 96 at a time May 22 19:49:04.959 [info] connection_ap_make_link(): Making internal direct tunnel to 87.106.208.182:443 ... May 22 19:49:04.959 [info] onion_pick_cpath_exit(): Using requested exit node 'Fluestertuete' May 22 19:49:04.959 [info] circuit_handle_first_hop(): Next router is Fluestertuete: Not connected. Connecting. May 22 19:49:04.959 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:04.959 [info] connection_ap_make_link(): Making internal direct tunnel to 91.143.93.213:9002 ... May 22 19:49:04.959 [info] onion_pick_cpath_exit(): Using requested exit node '2F2A729DDCC3EA862F1A9FE743A055BD45882474' May 22 19:49:04.959 [info] circuit_handle_first_hop(): Next router is 2F2A729DDCC3EA862F1A9FE743A055BD45882474: Not connected. Connecting. May 22 19:49:04.959 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:04.960 [info] connection_ap_make_link(): Making internal direct tunnel to 86.59.32.35:443 ... May 22 19:49:04.960 [info] onion_pick_cpath_exit(): Using requested exit node 'tornodeviennasil' May 22 19:49:04.960 [info] circuit_handle_first_hop(): Next router is tornodeviennasil: Not connected. Connecting. May 22 19:49:04.960 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:04.960 [info] connection_ap_make_link(): Making internal direct tunnel to 79.241.206.120:443 ... May 22 19:49:04.960 [info] onion_pick_cpath_exit(): Using requested exit node 'Hirakim' May 22 19:49:04.960 [info] circuit_handle_first_hop(): Next router is Hirakim: Not connected. Connecting. May 22 19:49:04.960 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:04.961 [info] update_extrainfo_downloads(): Extrainfo download status: 99 router with no ei, 1051 with present ei, 0 delaying, 0 pending, 0 downloadable. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:04.961 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer. May 22 19:49:05.167 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "87.106.208.182",443,tor,5162a541476437dc0b7d273d9598bfbf14889c5781163c62684e99ad71abc8ea75ef9f70ed2815a0a92d406fc1819b05 May 22 19:49:05.167 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "91.143.93.213",9002,tor,5764b834bce46f745f0ee5b9f0ca3ab6b42bc220599ef78d1589327144c1c43206affef34128834498bd3704ba392f3a May 22 19:49:05.292 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.241.206.120",443,tor,ee93684ef42a463f9b6db248a30d395bd349431edfef8c350fbbc045dbd47068f0c4da61e26890b024c10e39212b6bd6 May 22 19:49:05.354 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "87.106.208.182",443,tor,2e55a90b76127d0c1e76aabded1ebff6415eb91a125a4756845f939480ba0f94312efa2f1f5e03167d57ec68630389dc May 22 19:49:05.365 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "86.59.32.35",443,tor,01ca2f779757351eafb734d484a30c0cfc160cc41928f5177f533adca3d7d595af44befcafbcb2f35ab470a8c179e368 May 22 19:49:05.443 [info] command_process_versions_cell(): Negotiated version 2 with 87.106.208.182:443; sending NETINFO. May 22 19:49:05.443 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'Fluestertuete' May 22 19:49:05.443 [info] command_process_netinfo_cell(): Got good NETINFO cell from 87.106.208.182:443; OR connection is now open, using protocol version 2 May 22 19:49:05.557 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "79.241.206.120",443,tor,718146ea9668940ff6eda3b3ddc1da82519c6d516fd06da708f1ca31ae1716b17d66bdc1698308c61761cfcbd6cb18c7 May 22 19:49:05.623 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "91.143.93.213",9002,tor,f8126dda8e9eabe4ff6c7d28875b88fe3c58b55d42b7c0de045c83c88b2ffc60380be38fe436db8b4d9a8c4861301da8 May 22 19:49:05.670 [info] command_process_versions_cell(): Negotiated version 2 with 79.241.206.120:443; sending NETINFO. May 22 19:49:05.671 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'Hirakim' May 22 19:49:05.671 [info] command_process_netinfo_cell(): Got good NETINFO cell from 79.241.206.120:443; OR connection is now open, using protocol version 2 May 22 19:49:05.681 [info] command_process_versions_cell(): Negotiated version 2 with 91.143.93.213:9002; sending NETINFO. May 22 19:49:05.681 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to '' May 22 19:49:05.681 [info] command_process_netinfo_cell(): Got good NETINFO cell from 91.143.93.213:9002; OR connection is now open, using protocol version 2 May 22 19:49:05.695 [info] tor_tls_dump_tls_key(): TLS master key (address,port,protocol,key): "86.59.32.35",443,tor,ea9fecabb974b34d48763767c00dadc31e9062bb0839d82b1bb80729ad3655f65a37114c503581f941ed8606f9e46bb0 May 22 19:49:05.813 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "87.106.208.182",443,16861,forward,82daa929f30dedb24ae362b6ccfe51b735cd096b,019157b54c96ed2a3ac58a452b8af204 May 22 19:49:05.813 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "87.106.208.182",443,16861,reverse,00eeae7f92be023dc1a1ed79b365832079e8982b,fc061fe3480603fbbdc46415d28c1531 May 22 19:49:05.813 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:49:05.813 [info] exit circ (length 1, exit Fluestertuete): Fluestertuete(open) May 22 19:49:05.813 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:49:05.813 [info] exit circ (length 1): Fluestertuete(open) May 22 19:49:05.813 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 16861 May 22 19:49:05.856 [info] command_process_versions_cell(): Negotiated version 2 with 86.59.32.35:443; sending NETINFO. May 22 19:49:05.856 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE_FAST cell to 'tornodeviennasil' May 22 19:49:05.856 [info] command_process_netinfo_cell(): Got good NETINFO cell from 86.59.32.35:443; OR connection is now open, using protocol version 2 May 22 19:49:05.861 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "91.143.93.213",9002,62921,forward,c3149de98152f55450fcf66ef9d71b74452df5a3,f2b87b3778492e472455f61c9b07af7a May 22 19:49:05.861 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "91.143.93.213",9002,62921,reverse,f75de365f71aef468ce7ea53dc02c975accfa4ad,966583ee73d95aa69d5c768f4355e6c8 May 22 19:49:05.861 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:49:05.861 [info] exit circ (length 1, exit 2F2A729DDCC3EA862F1A9FE743A055BD45882474): $2F2A729DDCC3EA862F1A9FE743A055BD45882474(open) May 22 19:49:05.861 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:49:05.861 [info] exit circ (length 1): $2F2A729DDCC3EA862F1A9FE743A055BD45882474(open) May 22 19:49:05.861 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 62921 May 22 19:49:05.898 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:05.898 [info] exit circ (length 1): Fluestertuete(open) May 22 19:49:05.943 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:05.943 [info] exit circ (length 1): $2F2A729DDCC3EA862F1A9FE743A055BD45882474(open) May 22 19:49:06.154 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "86.59.32.35",443,60020,forward,87ca0d0f477f93f072f31182197ab1c363363701,c31f567f0c32556af17e0048cbf8bf0a May 22 19:49:06.154 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "86.59.32.35",443,60020,reverse,85706154a7367643732cf885fe29f50e3e23c1b4,7eb41172aac49182ba8730d420e37320 May 22 19:49:06.154 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:49:06.155 [info] exit circ (length 1, exit tornodeviennasil): tornodeviennasil(open) May 22 19:49:06.155 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:49:06.155 [info] exit circ (length 1): tornodeviennasil(open) May 22 19:49:06.155 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 60020 May 22 19:49:06.317 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:06.317 [info] exit circ (length 1): tornodeviennasil(open) May 22 19:49:06.380 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.241.206.120",443,50445,forward,8393beb0aae05bb471feb78a5345fdac5863da5f,46bbe4ffb295b91b35090114d80fef6c May 22 19:49:06.380 [info] tor_tls_dump_circuit_key(): Circuit key (address,port,circid,direction,digest,crypto): "79.241.206.120",443,50445,reverse,7fd4f2f61898d8b79dbc23c644a7816ce20bfb88,032639b9005adf93fd85fe2e0a512867 May 22 19:49:06.380 [info] circuit_finish_handshake(): Finished building fast circuit hop: May 22 19:49:06.380 [info] exit circ (length 1, exit Hirakim): Hirakim(open) May 22 19:49:06.380 [info] circuit_send_next_onion_skin(): circuit built! May 22 19:49:06.380 [info] exit circ (length 1): Hirakim(open) May 22 19:49:06.380 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 50445 May 22 19:49:06.527 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:06.527 [info] exit circ (length 1): Hirakim(open) May 22 19:49:07.462 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 63059. Removing stream. May 22 19:49:07.462 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:07.464 [info] connection_dir_client_reached_eof(): Received server info (size 137863) from server '91.143.93.213:9002' May 22 19:49:07.485 [info] router_load_routers_from_string(): 96 elements to add May 22 19:49:07.488 [info] update_extrainfo_downloads(): Extrainfo download status: 107 router with no ei, 1051 with present ei, 0 delaying, 0 pending, 88 downloadable. May 22 19:49:07.489 [info] connection_ap_make_link(): Making internal direct tunnel to 192.251.226.206:443 ... May 22 19:49:07.489 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:49:07.489 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 52615 May 22 19:49:07.489 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:07.489 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 91.143.93.213:9002 May 22 19:49:07.489 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:07.490 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:07.490 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:07.511 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 6150. Removing stream. May 22 19:49:07.511 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:07.514 [info] connection_dir_client_reached_eof(): Received server info (size 149076) from server '87.106.208.182:443' May 22 19:49:07.536 [info] router_load_routers_from_string(): 96 elements to add May 22 19:49:07.539 [info] update_extrainfo_downloads(): Extrainfo download status: 121 router with no ei, 1051 with present ei, 0 delaying, 88 pending, 82 downloadable. May 22 19:49:07.539 [info] connection_ap_make_link(): Making internal direct tunnel to 212.42.236.140:443 ... May 22 19:49:07.539 [info] exit circ (length 1): bach(open) May 22 19:49:07.540 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 31325 May 22 19:49:07.540 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:07.540 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 87.106.208.182:443 May 22 19:49:07.540 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:07.540 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:07.540 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:07.562 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:07.562 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:49:07.613 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:07.613 [info] exit circ (length 1): bach(open) May 22 19:49:07.971 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 34384. Removing stream. May 22 19:49:07.971 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:07.973 [info] connection_dir_client_reached_eof(): Received server info (size 140957) from server '79.241.206.120:443' May 22 19:49:07.994 [info] router_load_routers_from_string(): 95 elements to add May 22 19:49:07.998 [info] update_extrainfo_downloads(): Extrainfo download status: 131 router with no ei, 1051 with present ei, 0 delaying, 170 pending, 85 downloadable. May 22 19:49:07.998 [info] connection_ap_make_link(): Making internal direct tunnel to 192.251.226.206:443 ... May 22 19:49:07.998 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:49:07.999 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 52615 May 22 19:49:07.999 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:07.999 [info] connection_dir_client_reached_eof(): Received 95/95 router descriptors requested from 79.241.206.120:443 May 22 19:49:07.999 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:08.000 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:08.000 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:08.000 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 55168. Removing stream. May 22 19:49:08.000 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:08.003 [info] connection_dir_client_reached_eof(): Received server info (size 142175) from server '86.59.32.35:443' May 22 19:49:08.024 [info] router_load_routers_from_string(): 96 elements to add May 22 19:49:08.028 [info] update_extrainfo_downloads(): Extrainfo download status: 142 router with no ei, 1051 with present ei, 0 delaying, 255 pending, 85 downloadable. May 22 19:49:08.029 [info] connection_ap_make_link(): Making internal direct tunnel to 212.42.236.140:443 ... May 22 19:49:08.029 [info] exit circ (length 1): bach(open) May 22 19:49:08.029 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 31325 May 22 19:49:08.029 [info] connection_ap_make_link(): ... application connection created and linked. May 22 19:49:08.029 [info] connection_dir_client_reached_eof(): Received 96/96 router descriptors requested from 86.59.32.35:443 May 22 19:49:08.029 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:08.030 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:08.030 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:49:08.277 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds. May 22 19:49:08.277 [info] exit circ (length 1): bach(open) May 22 19:49:08.966 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 3355. Removing stream. May 22 19:49:08.966 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:08.969 [info] connection_dir_client_reached_eof(): Received extra server info (size 161558) from server '192.251.226.206:443' May 22 19:49:08.982 [info] router_load_extrainfo_from_string(): 88 elements to add May 22 19:49:08.985 [info] connection_dir_client_reached_eof(): Received 88/88 extra-info documents requested from 192.251.226.206:443 May 22 19:49:08.985 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:08.985 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds. May 22 19:49:08.985 [info] exit circ (length 1): $7F6A632B86036964B7E364E78453DEF982EAEE4F(open) May 22 19:49:08.987 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 44213. Removing stream. May 22 19:49:08.987 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:08.989 [info] connection_dir_client_reached_eof(): Received extra server info (size 150657) from server '212.42.236.140:443' May 22 19:49:09.001 [info] router_load_extrainfo_from_string(): 82 elements to add May 22 19:49:09.003 [info] routerlist_remove_old_routers(): We have 1533 live routers and 0 old router descriptors. May 22 19:49:09.003 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:49:09.013 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:49:09.014 [info] router_rebuild_store(): Rebuilding extra-info documents cache May 22 19:49:09.023 [info] router_rebuild_store(): Reconstructing pointers into cache May 22 19:49:09.025 [info] connection_dir_client_reached_eof(): Received 82/82 extra-info documents requested from 212.42.236.140:443 May 22 19:49:09.025 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:11.978 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 3356. Removing stream. May 22 19:49:11.978 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:11.981 [info] connection_dir_client_reached_eof(): Received extra server info (size 157904) from server '192.251.226.206:443' May 22 19:49:11.993 [info] router_load_extrainfo_from_string(): 85 elements to add May 22 19:49:11.996 [info] connection_dir_client_reached_eof(): Received 85/85 extra-info documents requested from 192.251.226.206:443 May 22 19:49:11.996 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:11.996 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 44214. Removing stream. May 22 19:49:11.996 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:11.999 [info] connection_dir_client_reached_eof(): Received extra server info (size 146478) from server '212.42.236.140:443' May 22 19:49:12.011 [info] router_load_extrainfo_from_string(): 85 elements to add May 22 19:49:12.014 [info] connection_dir_client_reached_eof(): Received 85/85 extra-info documents requested from 212.42.236.140:443 May 22 19:49:12.014 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf. May 22 19:49:54.094 [info] routerlist_remove_old_routers(): We have 1533 live routers and 0 old router descriptors. May 22 19:49:54.094 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 53, dropping 17. May 22 19:50:05.111 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1533 present (0 of those were in old_routers); 0 would_reject; 6 wouldnt_use; 0 in progress. May 22 19:50:05.111 [info] update_extrainfo_downloads(): Extrainfo download status: 142 router with no ei, 1391 with present ei, 0 delaying, 0 pending, 0 downloadable. May 22 19:50:55.210 [info] routerlist_remove_old_routers(): We have 1533 live routers and 0 old router descriptors. May 22 19:50:55.210 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 8, dropping 45. May 22 19:50:55.210 [info] buf_shrink_freelists(): Cleaning freelist for 32768-byte chunks: keeping 2, dropping 3. May 22 19:51:06.231 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1533 present (0 of those were in old_routers); 0 would_reject; 6 wouldnt_use; 0 in progress. May 22 19:51:06.231 [info] update_extrainfo_downloads(): Extrainfo download status: 142 router with no ei, 1391 with present ei, 0 delaying, 0 pending, 0 downloadable. May 22 19:51:56.374 [info] routerlist_remove_old_routers(): We have 1533 live routers and 0 old router descriptors. May 22 19:52:07.411 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1533 present (0 of those were in old_routers); 0 would_reject; 6 wouldnt_use; 0 in progress. May 22 19:52:07.411 [info] update_extrainfo_downloads(): Extrainfo download status: 142 router with no ei, 1391 with present ei, 0 delaying, 0 pending, 0 downloadable. May 22 19:52:57.526 [info] routerlist_remove_old_routers(): We have 1533 live routers and 0 old router descriptors. May 22 19:53:08.554 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1533 present (0 of those were in old_routers); 0 would_reject; 6 wouldnt_use; 0 in progress. May 22 19:53:08.555 [info] update_extrainfo_downloads(): Extrainfo download status: 142 router with no ei, 1391 with present ei, 0 delaying, 0 pending, 0 downloadable. May 22 19:53:39.976 [info] connection_control_reached_eof(): Control connection reached EOF. Closing. May 22 19:53:41.404 [info] exit circ (length 3): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(open) Sheepy(open) May 22 19:53:41.404 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket 16, n_circ_id 6588 May 22 19:53:41.404 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:53:44.761 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 3 seconds. May 22 19:53:44.762 [info] addressmap_register(): Addressmap: (re)mapped 'check.torproject.org' to '209.237.247.84' May 22 19:53:44.762 [info] exit circ (length 3): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(open) Sheepy(open) May 22 19:53:55.188 [info] handle_control_authenticate(): Authenticated control connection (19) May 22 19:53:58.658 [info] routerlist_remove_old_routers(): We have 1533 live routers and 0 old router descriptors. May 22 19:53:59.473 [info] connection_edge_reached_eof(): conn (fd 16) reached eof. Closing. May 22 19:53:59.511 [info] connection_control_reached_eof(): Control connection reached EOF. Closing. May 22 19:53:59.511 [info] connection_control_reached_eof(): Control connection reached EOF. Closing. May 22 19:54:09.691 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1533 present (0 of those were in old_routers); 0 would_reject; 6 wouldnt_use; 0 in progress. May 22 19:54:09.691 [info] update_extrainfo_downloads(): Extrainfo download status: 142 router with no ei, 1391 with present ei, 0 delaying, 0 pending, 0 downloadable. May 22 19:54:10.961 [info] connection_control_reached_eof(): Control connection reached EOF. Closing. May 22 19:54:11.270 [info] addressmap_rewrite(): Addressmap: rewriting "check.torproject.org" to "209.237.247.84" May 22 19:54:11.270 [info] exit circ (length 3): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(open) Sheepy(open) May 22 19:54:11.270 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket 16, n_circ_id 6588 May 22 19:54:11.270 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer. May 22 19:54:13.821 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 2 seconds. May 22 19:54:13.821 [info] exit circ (length 3): enterprise(open) $676CA3ADD2BC07FD9DFB74B66CA4A7E1C8106F2B(open) Sheepy(open) May 22 19:54:24.127 [info] handle_control_authenticate(): Authenticated control connection (19) May 22 19:54:33.997 [notice] Interrupt: exiting cleanly. May 22 19:54:33.997 [info] or_state_save(): Saved state to "/home/robert/.tor/state" May 22 19:54:34.009 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 0, dropping 9. May 22 19:54:34.009 [info] buf_shrink_freelists(): Cleaning freelist for 8192-byte chunks: keeping 0, dropping 1. May 22 19:54:34.013 [info] buf_shrink_freelists(): Cleaning freelist for 16384-byte chunks: keeping 0, dropping 2. May 22 19:54:34.013 [info] buf_shrink_freelists(): Cleaning freelist for 32768-byte chunks: keeping 0, dropping 2. May 22 19:54:34.013 [info] tor_lockfile_unlock(): Unlocking "/home/robert/.tor/lock"