Ticket #827: dtlogm20.txt

File dtlogm20.txt, 152.0 KB (added by downie, 11 years ago)

0.2.1.13-alpha (r18828) on OSX10.3.9 IP problem

Line 
1Mar 20 05:23:39.800 [notice] Tor 0.2.1.13-alpha (r18828) opening new log file.
2Mar 20 05:23:39.805 [info] tor_lockfile_lock(): Locking "~/.tor//lock"
3Mar 20 05:23:39.822 [info] or_state_load(): Loaded state from "~/.tor//state"
4Mar 20 05:23:39.823 [info] read_file_to_str(): Could not open "~/.tor//router-stability": No such file or directory
5Mar 20 05:23:39.829 [notice] Parsing GEOIP file.
6Mar 20 05:23:41.006 [info] crypto_seed_rng(): Seeding RNG from "/dev/urandom"
7Mar 20 05:23:41.008 [info] configure_nameservers(): Parsing resolver configuration in '/etc/resolv.conf'
8Mar 20 05:23:41.008 [info] eventdns: Parsing resolv.conf file /etc/resolv.conf
9Mar 20 05:23:41.010 [info] eventdns: Trying to add nameserver <62.24.218.222>
10Mar 20 05:23:41.010 [info] eventdns: Added nameserver 62.24.218.222
11Mar 20 05:23:41.010 [info] eventdns: Trying to add nameserver <62.24.218.223>
12Mar 20 05:23:41.010 [info] eventdns: Added nameserver 62.24.218.223
13Mar 20 05:23:41.010 [info] eventdns: Trying to add nameserver <192.168.1.1>
14Mar 20 05:23:41.010 [info] eventdns: Added nameserver 192.168.1.1
15Mar 20 05:23:41.011 [info] eventdns: Setting maximum allowed timeouts to 3
16Mar 20 05:23:41.011 [info] eventdns: Setting timeout to 5
17Mar 20 05:23:41.016 [info] init_keys(): Reading/making identity key "~/.tor//keys/secret_id_key"...
18Mar 20 05:23:41.205 [info] init_keys(): Reading/making onion key "~/.tor//keys/secret_onion_key"...
19Mar 20 05:23:43.462 [info] init_keys(): Dumping fingerprint to "~/.tor//fingerprint"...
20Mar 20 05:23:43.463 [notice] Your Tor server's identity key fingerprint is '<myrelay> <my fingerprint>'
21Mar 20 05:23:43.463 [info] Bootstrapped 0%: Starting.
22Mar 20 05:23:43.479 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority ides with signing key 287C96AFE88795B42A116E659BE58B608739F590
23Mar 20 05:23:43.495 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority dannenberg with signing key 589EB055C643EFBBC69D2209FC95EE81CD811FEB
24Mar 20 05:23:43.517 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority dizum with signing key 44A4408F03768A55AAE0E9D3D41E6E1A37FDD2AA
25Mar 20 05:23:43.532 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority moria1 with signing key C600C8BA94224C51D35361D5399F8B33A77FF191
26Mar 20 05:23:43.546 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority gabelmoo with signing key B0C17B8D3AD626AEBBED67E2FF208E223310526C
27Mar 20 05:23:43.563 [info] trusted_dirs_load_certs_from_string(): Adding cached certificate for directory authority tor26 with signing key D6D2325E1511B23A825DBE1CFD3DF9285AAE4DEB
28Mar 20 05:23:43.706 [info] 0 unknown, 0 missing key, 6 good, 0 bad, 0 no signature, 4 required
29Mar 20 05:23:43.706 [info] update_consensus_networkstatus_fetch_time(): Live consensus was the most recent until 2009-03-20 04:00:00 and will expire at 2009-03-20 06:00:00; fetching the next one at 2009-03-20 05:02:48.
30Mar 20 05:23:43.712 [info] read_file_to_str(): Could not open "~/.tor//unverified-consensus": No such file or directory
31Mar 20 05:23:43.716 [info] routers_update_all_from_networkstatus(): The directory authorities say my version is ok.
32Mar 20 05:23:47.926 [info] router_load_routers_from_string(): 1188 elements to add
33Mar 20 05:23:47.952 [info] router_load_routers_from_string(): 0 elements to add
34Mar 20 05:23:47.958 [info] routerlist_remove_old_routers(): We have 1188 live routers and 0 old router descriptors.
35Mar 20 05:23:47.958 [info] tor_mmap_file(): Could not open "~/.tor//cached-extrainfo" for mmap(): No such file or directory
36Mar 20 05:23:47.960 [notice] We now have enough directory information to build circuits.
37Mar 20 05:23:47.960 [notice] Bootstrapped 80%: Connecting to the Tor network.
38Mar 20 05:23:47.967 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1188 present (0 of those were in old_routers); 0 would_reject; 2 wouldnt_use; 0 in progress.
39Mar 20 05:23:47.970 [info] launch_router_descriptor_downloads(): There are not many downloadable routerdescs, but we haven't tried downloading descriptors recently. Downloading.
40Mar 20 05:23:47.970 [info] launch_router_descriptor_downloads(): Launching 1 request for 1 router, 4 at a time
41Mar 20 05:23:47.973 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
42Mar 20 05:23:47.974 [info] onion_pick_cpath_exit(): Using requested exit node 'UBIT2'
43Mar 20 05:23:47.974 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Router not connected (nothing is).  Connecting.
44Mar 20 05:23:47.974 [info] connection_ap_make_link(): ... application connection created and linked.
45Mar 20 05:23:47.977 [info] routerlist_remove_old_routers(): We have 1188 live routers and 0 old router descriptors.
46Mar 20 05:23:47.978 [info] update_consensus_networkstatus_downloads(): Launching networkstatus consensus download.
47Mar 20 05:23:47.980 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:80 ...
48Mar 20 05:23:47.980 [info] onion_pick_cpath_exit(): Using requested exit node 'CyberSex'
49Mar 20 05:23:47.980 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
50Mar 20 05:23:47.981 [info] connection_ap_make_link(): ... application connection created and linked.
51Mar 20 05:23:47.981 [info] directory_send_command(): Downloading consensus from 85.214.146.160 using /tor/status-vote/current/consensus.z
52Mar 20 05:23:47.983 [info] circuit_predict_and_launch_new(): Have 0 clean circs (0 internal), need another exit circ.
53Mar 20 05:23:47.985 [info] choose_good_exit_server_general(): Found 557 servers that might support 0/0 pending connections.
54Mar 20 05:23:47.991 [info] choose_good_exit_server_general(): Chose exit server 'Wachbian'
55Mar 20 05:23:47.994 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
56Mar 20 05:23:48.000 [info] or_state_save(): Saved state to "~/.tor//state"
57Mar 20 05:23:48.001 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
58Mar 20 05:23:48.001 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
59Mar 20 05:23:48.001 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
60Mar 20 05:23:48.001 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
61Mar 20 05:23:48.039 [notice] Bootstrapped 85%: Finishing handshake with first hop.
62Mar 20 05:23:49.005 [info] circuit_predict_and_launch_new(): Have 1 clean circs (0 internal), need another exit circ.
63Mar 20 05:23:49.007 [info] choose_good_exit_server_general(): Found 557 servers that might support 0/0 pending connections.
64Mar 20 05:23:49.011 [info] choose_good_exit_server_general(): Chose exit server 'torxmission'
65Mar 20 05:23:49.014 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
66Mar 20 05:23:49.360 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
67Mar 20 05:23:49.397 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'UBIT2'
68Mar 20 05:23:49.397 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
69Mar 20 05:23:49.767 [info] circuit_finish_handshake(): Finished building circuit hop:
70Mar 20 05:23:49.767 [info] exit circ (length 1, exit UBIT2): $7DDDEBC5867AF9659D164FA85391122AF79569D5(open)
71Mar 20 05:23:49.767 [info] circuit_send_next_onion_skin(): circuit built!
72Mar 20 05:23:49.767 [info] exit circ (length 1): $7DDDEBC5867AF9659D164FA85391122AF79569D5(open)
73Mar 20 05:23:49.767 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 47381
74Mar 20 05:23:49.768 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
75Mar 20 05:23:49.769 [notice] Bootstrapped 90%: Establishing a Tor circuit.
76Mar 20 05:23:49.807 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'atlgonyovLi'
77Mar 20 05:23:49.807 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
78Mar 20 05:23:49.881 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
79Mar 20 05:23:49.881 [info] exit circ (length 1): $7DDDEBC5867AF9659D164FA85391122AF79569D5(open)
80Mar 20 05:23:50.392 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 2926. Removing stream.
81Mar 20 05:23:50.392 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
82Mar 20 05:23:50.428 [info] circuit_finish_handshake(): Finished building circuit hop:
83Mar 20 05:23:50.429 [info] exit circ (length 3, exit Wachbian): atlgonyovLi(open) PolynaTor(closed) $65870E806830DD226E9BAFDDBC1CD0BFB18F45E6(closed)
84Mar 20 05:23:50.466 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
85Mar 20 05:23:50.468 [info] circuit_predict_and_launch_new(): Have 2 clean circs (0 uptime-internal, 0 internal), need another hidserv circ.
86Mar 20 05:23:50.518 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'atlgonyovLi'
87Mar 20 05:23:50.520 [info] connection_dir_client_reached_eof(): Received server info (size 0) from server '78.142.140.194:9001'
88Mar 20 05:23:50.520 [info] connection_dir_client_reached_eof(): Received http status code 404 ("Not found") from server '78.142.140.194:9001' while fetching "/tor/server/d/1C61A9AB4F827E97F5BB988E9E1BBDAEEB4DD677.z". I'll try again soon.
89Mar 20 05:23:50.520 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
90Mar 20 05:23:50.637 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
91Mar 20 05:23:50.676 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'xanadu'
92Mar 20 05:23:50.676 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
93Mar 20 05:23:50.776 [info] circuit_finish_handshake(): Finished building circuit hop:
94Mar 20 05:23:50.777 [info] exit circ (length 3, exit Wachbian): atlgonyovLi(open) PolynaTor(open) $65870E806830DD226E9BAFDDBC1CD0BFB18F45E6(closed)
95Mar 20 05:23:50.814 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
96Mar 20 05:23:50.964 [info] circuit_finish_handshake(): Finished building circuit hop:
97Mar 20 05:23:50.965 [info] internal (high-uptime) circ (length 3, exit threeletteragency): atlgonyovLi(open) gashmish(closed) threeletteragency(closed)
98Mar 20 05:23:51.004 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
99Mar 20 05:23:51.043 [info] circuit_finish_handshake(): Finished building circuit hop:
100Mar 20 05:23:51.043 [info] exit circ (length 3, exit torxmission): xanadu(open) doncella(closed) torxmission(closed)
101Mar 20 05:23:51.079 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
102Mar 20 05:23:51.164 [info] circuit_finish_handshake(): Finished building circuit hop:
103Mar 20 05:23:51.164 [info] exit circ (length 3, exit Wachbian): atlgonyovLi(open) PolynaTor(open) $65870E806830DD226E9BAFDDBC1CD0BFB18F45E6(open)
104Mar 20 05:23:51.164 [info] circuit_send_next_onion_skin(): circuit built!
105Mar 20 05:23:51.164 [notice] Tor has successfully opened a circuit. Looks like client functionality is working.
106Mar 20 05:23:51.164 [notice] Bootstrapped 100%: Done.
107Mar 20 05:23:51.165 [notice] Now checking whether ORPort xxx.xxx.161.59:9001 is reachable... (this may take up to 20 minutes -- look for log messages indicating success)
108Mar 20 05:23:51.165 [info] consider_testing_reachability(): Testing reachability of my ORPort: xxx.xxx.161.59:9001.
109Mar 20 05:23:51.167 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
110Mar 20 05:23:51.176 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
111Mar 20 05:23:51.577 [info] circuit_finish_handshake(): Finished building circuit hop:
112Mar 20 05:23:51.578 [info] internal (high-uptime) circ (length 3, exit threeletteragency): atlgonyovLi(open) gashmish(open) threeletteragency(closed)
113Mar 20 05:23:51.615 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
114Mar 20 05:23:51.654 [info] circuit_finish_handshake(): Finished building circuit hop:
115Mar 20 05:23:51.654 [info] exit circ (length 3, exit torxmission): xanadu(open) doncella(open) torxmission(closed)
116Mar 20 05:23:51.692 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
117Mar 20 05:23:51.693 [info] circuit_predict_and_launch_new(): Have 3 clean circs (1 uptime-internal, 1 internal), need another hidserv circ.
118Mar 20 05:23:51.703 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
119Mar 20 05:23:52.336 [info] circuit_finish_handshake(): Finished building circuit hop:
120Mar 20 05:23:52.336 [info] internal (high-uptime) circ (length 3, exit threeletteragency): atlgonyovLi(open) gashmish(open) threeletteragency(open)
121Mar 20 05:23:52.336 [info] circuit_send_next_onion_skin(): circuit built!
122Mar 20 05:23:52.432 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
123Mar 20 05:23:52.475 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'tornodeviennasil'
124Mar 20 05:23:52.475 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
125Mar 20 05:23:52.738 [info] circuit_finish_handshake(): Finished building circuit hop:
126Mar 20 05:23:52.739 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) tortestrejectall2(closed) $<my fingerprint>(closed)
127Mar 20 05:23:52.777 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
128Mar 20 05:23:53.294 [info] circuit_finish_handshake(): Finished building circuit hop:
129Mar 20 05:23:53.294 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) tortestrejectall2(open) $<my fingerprint>(closed)
130Mar 20 05:23:53.333 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
131Mar 20 05:23:53.546 [info] circuit_predict_and_launch_new(): Have 3 clean circs (2 internal), need another exit circ.
132Mar 20 05:23:53.548 [info] choose_good_exit_server_general(): Found 557 servers that might support 0/0 pending connections.
133Mar 20 05:23:53.551 [info] choose_good_exit_server_general(): Chose exit server 'FoeBuD3'
134Mar 20 05:23:53.593 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'atlgonyovLi'
135Mar 20 05:23:53.768 [info] circuit_finish_handshake(): Finished building circuit hop:
136Mar 20 05:23:53.769 [info] exit circ (length 3, exit FoeBuD3): atlgonyovLi(open) $8BF67FC634630673AE0BAD2BC4A2399C665B166A(closed) FoeBuD3(closed)
137Mar 20 05:23:53.807 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
138Mar 20 05:23:54.135 [info] circuit_finish_handshake(): Finished building circuit hop:
139Mar 20 05:23:54.135 [info] exit circ (length 3, exit FoeBuD3): atlgonyovLi(open) $8BF67FC634630673AE0BAD2BC4A2399C665B166A(open) FoeBuD3(closed)
140Mar 20 05:23:54.173 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
141Mar 20 05:23:54.568 [info] circuit_finish_handshake(): Finished building circuit hop:
142Mar 20 05:23:54.568 [info] exit circ (length 3, exit FoeBuD3): atlgonyovLi(open) $8BF67FC634630673AE0BAD2BC4A2399C665B166A(open) FoeBuD3(open)
143Mar 20 05:23:54.568 [info] circuit_send_next_onion_skin(): circuit built!
144Mar 20 05:23:55.001 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
145Mar 20 05:23:55.041 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'gunther'
146Mar 20 05:23:55.041 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
147Mar 20 05:23:56.220 [info] circuit_finish_handshake(): Finished building circuit hop:
148Mar 20 05:23:56.220 [info] internal (high-uptime) circ (length 3, exit tortestrejectall1): gunther(open) SmenTrick(closed) tortestrejectall1(closed)
149Mar 20 05:23:56.256 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
150Mar 20 05:23:59.084 [info] circuit_finish_handshake(): Finished building circuit hop:
151Mar 20 05:23:59.084 [info] internal (high-uptime) circ (length 3, exit tortestrejectall1): gunther(open) SmenTrick(open) tortestrejectall1(closed)
152Mar 20 05:23:59.122 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
153Mar 20 05:24:01.086 [info] circuit_finish_handshake(): Finished building circuit hop:
154Mar 20 05:24:01.086 [info] internal (high-uptime) circ (length 3, exit tortestrejectall1): gunther(open) SmenTrick(open) tortestrejectall1(open)
155Mar 20 05:24:01.086 [info] circuit_send_next_onion_skin(): circuit built!
156Mar 20 05:24:17.789 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 5)
157Mar 20 05:24:17.789 [info] exit circ (length 1, exit CyberSex): CyberSex(closed)
158Mar 20 05:24:17.789 [info] connection_ap_fail_onehop(): Closing onehop stream to '$909A8BC31A7B4F3BF39DEDCC528A2F031B9BBE57/85.214.146.160' because the OR conn just failed.
159Mar 20 05:24:17.790 [info] _connection_free(): Freeing linked Socks connection [waiting for circuit] with 125 bytes on inbuf, 0 on outbuf.
160Mar 20 05:24:17.791 [info] connection_dir_client_reached_eof(): 'fetch' response not all here, but we're at eof. Closing.
161Mar 20 05:24:17.791 [info] update_consensus_networkstatus_downloads(): Launching networkstatus consensus download.
162Mar 20 05:24:17.991 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
163Mar 20 05:24:17.991 [info] onion_pick_cpath_exit(): Using requested exit node 'croeso'
164Mar 20 05:24:17.991 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
165Mar 20 05:24:17.991 [info] connection_ap_make_link(): ... application connection created and linked.
166Mar 20 05:24:17.992 [info] directory_send_command(): Downloading consensus from 149.9.0.108:9001 using /tor/status-vote/current/consensus.z
167Mar 20 05:24:17.992 [info] _connection_free(): Freeing linked Directory connection [client reading] with 0 bytes on inbuf, 0 on outbuf.
168Mar 20 05:24:17.992 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
169Mar 20 05:24:17.992 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
170Mar 20 05:24:19.364 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
171Mar 20 05:24:19.403 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'croeso'
172Mar 20 05:24:19.403 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
173Mar 20 05:24:19.793 [info] circuit_finish_handshake(): Finished building circuit hop:
174Mar 20 05:24:19.794 [info] exit circ (length 1, exit croeso): croeso(open)
175Mar 20 05:24:19.794 [info] circuit_send_next_onion_skin(): circuit built!
176Mar 20 05:24:19.794 [info] exit circ (length 1): croeso(open)
177Mar 20 05:24:19.794 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 19076
178Mar 20 05:24:19.932 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
179Mar 20 05:24:19.932 [info] exit circ (length 1): croeso(open)
180Mar 20 05:24:22.218 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 43671. Removing stream.
181Mar 20 05:24:22.218 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
182Mar 20 05:24:22.234 [info] connection_dir_client_reached_eof(): Received consensus directory (size 273825) from server '149.9.0.108:9001'
183Mar 20 05:24:22.368 [info] 0 unknown, 0 missing key, 6 good, 0 bad, 0 no signature, 4 required
184Mar 20 05:24:22.374 [info] update_consensus_networkstatus_fetch_time(): Live consensus will be the most recent until 2009-03-20 06:00:00 and will expire at 2009-03-20 08:00:00; fetching the next one at 2009-03-20 07:14:57.
185Mar 20 05:24:22.405 [info] routers_update_all_from_networkstatus(): The directory authorities say my version is ok.
186Mar 20 05:24:22.406 [info] consider_testing_reachability(): Testing reachability of my ORPort: xxx.xxx.161.59:9001.
187Mar 20 05:24:22.407 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
188Mar 20 05:24:22.452 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'tornodeviennasil'
189Mar 20 05:24:22.452 [info] connection_dir_client_reached_eof(): Successfully loaded consensus.
190Mar 20 05:24:22.453 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
191Mar 20 05:24:22.591 [info] circuit_finish_handshake(): Finished building circuit hop:
192Mar 20 05:24:22.591 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) $7DDDEBC5867AF9659D164FA85391122AF79569D5(closed) $<my fingerprint>(closed)
193Mar 20 05:24:22.629 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
194Mar 20 05:24:22.631 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
195Mar 20 05:24:22.631 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
196Mar 20 05:24:22.761 [info] circuit_finish_handshake(): Finished building circuit hop:
197Mar 20 05:24:22.761 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) $7DDDEBC5867AF9659D164FA85391122AF79569D5(open) $<my fingerprint>(closed)
198Mar 20 05:24:22.801 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
199Mar 20 05:24:23.044 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
200Mar 20 05:24:23.044 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
201Mar 20 05:24:23.173 [info] circuit_finish_handshake(): Finished building circuit hop:
202Mar 20 05:24:23.174 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) $7DDDEBC5867AF9659D164FA85391122AF79569D5(open) $<my fingerprint>(open)
203Mar 20 05:24:23.174 [info] circuit_send_next_onion_skin(): circuit built!
204Mar 20 05:24:31.776 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
205Mar 20 05:24:31.778 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:1496; sending NETINFO.
206Mar 20 05:24:32.081 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:1496; OR connection is now open, using protocol version 2
207Mar 20 05:24:33.834 [notice] Self-testing indicates your ORPort is reachable from the outside. Excellent. Publishing server descriptor.
208Mar 20 05:24:34.999 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
209Mar 20 05:24:35.278 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
210Mar 20 05:24:49.133 [info] update_consensus_router_descriptor_downloads(): 257 router descriptors downloadable. 0 delayed; 941 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
211Mar 20 05:24:49.133 [info] launch_router_descriptor_downloads(): Launching 3 requests for 257 routers, 86 at a time
212Mar 20 05:24:49.136 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
213Mar 20 05:24:49.137 [info] onion_pick_cpath_exit(): Using requested exit node 'jalopy'
214Mar 20 05:24:49.137 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
215Mar 20 05:24:49.138 [info] connection_ap_make_link(): ... application connection created and linked.
216Mar 20 05:24:49.143 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
217Mar 20 05:24:49.143 [info] onion_pick_cpath_exit(): Using requested exit node 'JenesisComputers'
218Mar 20 05:24:49.143 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
219Mar 20 05:24:49.145 [info] connection_ap_make_link(): ... application connection created and linked.
220Mar 20 05:24:49.147 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
221Mar 20 05:24:49.148 [info] onion_pick_cpath_exit(): Using requested exit node 'gothnet'
222Mar 20 05:24:49.148 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
223Mar 20 05:24:49.148 [info] connection_ap_make_link(): ... application connection created and linked.
224Mar 20 05:24:49.149 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
225Mar 20 05:24:49.149 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
226Mar 20 05:24:49.149 [info] onion_pick_cpath_exit(): Using requested exit node 'moria1'
227Mar 20 05:24:49.150 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
228Mar 20 05:24:49.150 [info] connection_ap_make_link(): ... application connection created and linked.
229Mar 20 05:24:49.151 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
230Mar 20 05:24:49.151 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9002 ...
231Mar 20 05:24:49.151 [info] onion_pick_cpath_exit(): Using requested exit node 'moria2'
232Mar 20 05:24:49.151 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
233Mar 20 05:24:49.152 [info] connection_ap_make_link(): ... application connection created and linked.
234Mar 20 05:24:49.152 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
235Mar 20 05:24:49.152 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
236Mar 20 05:24:49.152 [info] onion_pick_cpath_exit(): Using requested exit node 'tor26'
237Mar 20 05:24:49.152 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
238Mar 20 05:24:49.153 [info] connection_ap_make_link(): ... application connection created and linked.
239Mar 20 05:24:49.153 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
240Mar 20 05:24:49.153 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
241Mar 20 05:24:49.153 [info] onion_pick_cpath_exit(): Using requested exit node 'dizum'
242Mar 20 05:24:49.153 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
243Mar 20 05:24:49.153 [info] connection_ap_make_link(): ... application connection created and linked.
244Mar 20 05:24:49.155 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
245Mar 20 05:24:49.155 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9090 ...
246Mar 20 05:24:49.156 [info] onion_pick_cpath_exit(): Using requested exit node 'ides'
247Mar 20 05:24:49.156 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
248Mar 20 05:24:49.156 [info] connection_ap_make_link(): ... application connection created and linked.
249Mar 20 05:24:49.156 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
250Mar 20 05:24:49.157 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
251Mar 20 05:24:49.157 [info] onion_pick_cpath_exit(): Using requested exit node 'gabelmoo'
252Mar 20 05:24:49.157 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
253Mar 20 05:24:49.157 [info] connection_ap_make_link(): ... application connection created and linked.
254Mar 20 05:24:49.158 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 462)
255Mar 20 05:24:49.158 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
256Mar 20 05:24:49.158 [info] onion_pick_cpath_exit(): Using requested exit node 'dannenberg'
257Mar 20 05:24:49.158 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
258Mar 20 05:24:49.159 [info] connection_ap_make_link(): ... application connection created and linked.
259Mar 20 05:24:49.159 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
260Mar 20 05:24:49.160 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
261Mar 20 05:24:49.168 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
262Mar 20 05:24:49.170 [info] routerlist_remove_old_routers(): We have 1188 live routers and 0 old router descriptors.
263Mar 20 05:24:49.171 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
264Mar 20 05:24:49.171 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
265Mar 20 05:24:49.171 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
266Mar 20 05:24:49.171 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
267Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
268Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
269Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
270Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
271Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
272Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
273Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
274Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
275Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
276Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
277Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
278Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
279Mar 20 05:24:49.172 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
280Mar 20 05:24:49.173 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
281Mar 20 05:24:49.173 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
282Mar 20 05:24:49.173 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
283Mar 20 05:24:51.582 [info] circuit_expire_building(): Abandoning circ 86.59.32.35:443:18244 (state 0:doing handshakes, purpose 17)
284Mar 20 05:24:51.583 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) tortestrejectall2(open) $<my fingerprint>(waiting for keys)
285Mar 20 05:24:54.526 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
286Mar 20 05:24:54.567 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'jalopy'
287Mar 20 05:24:54.569 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
288Mar 20 05:24:54.787 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
289Mar 20 05:24:54.828 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'moria1'
290Mar 20 05:24:54.829 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
291Mar 20 05:24:54.829 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9002; sending NETINFO.
292Mar 20 05:24:54.867 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'moria2'
293Mar 20 05:24:54.867 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9002; OR connection is now open, using protocol version 2
294Mar 20 05:24:54.868 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
295Mar 20 05:24:54.906 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'tor26'
296Mar 20 05:24:54.907 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
297Mar 20 05:24:54.919 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:80; sending NETINFO.
298Mar 20 05:24:54.920 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:80; OR connection is now open, using protocol version 2
299Mar 20 05:24:54.967 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
300Mar 20 05:24:55.006 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'dizum'
301Mar 20 05:24:55.006 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
302Mar 20 05:24:55.013 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
303Mar 20 05:24:55.053 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'gabelmoo'
304Mar 20 05:24:55.053 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
305Mar 20 05:24:55.054 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
306Mar 20 05:24:55.096 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'dannenberg'
307Mar 20 05:24:55.096 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
308Mar 20 05:24:55.175 [info] circuit_finish_handshake(): Finished building circuit hop:
309Mar 20 05:24:55.176 [info] exit circ (length 1, exit tor26): tor26(open)
310Mar 20 05:24:55.176 [info] circuit_send_next_onion_skin(): circuit built!
311Mar 20 05:24:55.176 [info] exit circ (length 1): tor26(open)
312Mar 20 05:24:55.176 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 14718
313Mar 20 05:24:55.180 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9090; sending NETINFO.
314Mar 20 05:24:55.218 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'ides'
315Mar 20 05:24:55.218 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9090; OR connection is now open, using protocol version 2
316Mar 20 05:24:55.254 [info] circuit_finish_handshake(): Finished building circuit hop:
317Mar 20 05:24:55.255 [info] exit circ (length 1, exit moria1): moria1(open)
318Mar 20 05:24:55.255 [info] circuit_send_next_onion_skin(): circuit built!
319Mar 20 05:24:55.257 [info] exit circ (length 1): moria1(open)
320Mar 20 05:24:55.258 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 5716
321Mar 20 05:24:55.292 [info] circuit_finish_handshake(): Finished building circuit hop:
322Mar 20 05:24:55.294 [info] exit circ (length 1, exit dizum): dizum(open)
323Mar 20 05:24:55.294 [info] circuit_send_next_onion_skin(): circuit built!
324Mar 20 05:24:55.295 [info] exit circ (length 1): dizum(open)
325Mar 20 05:24:55.296 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 1845
326Mar 20 05:24:55.335 [info] circuit_finish_handshake(): Finished building circuit hop:
327Mar 20 05:24:55.335 [info] exit circ (length 1, exit jalopy): jalopy(open)
328Mar 20 05:24:55.335 [info] circuit_send_next_onion_skin(): circuit built!
329Mar 20 05:24:55.335 [info] exit circ (length 1): jalopy(open)
330Mar 20 05:24:55.335 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 62162
331Mar 20 05:24:55.371 [info] circuit_finish_handshake(): Finished building circuit hop:
332Mar 20 05:24:55.373 [info] exit circ (length 1, exit moria2): moria2(open)
333Mar 20 05:24:55.373 [info] circuit_send_next_onion_skin(): circuit built!
334Mar 20 05:24:55.374 [info] exit circ (length 1): moria2(open)
335Mar 20 05:24:55.374 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 11072
336Mar 20 05:24:55.375 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
337Mar 20 05:24:55.375 [info] exit circ (length 1): tor26(open)
338Mar 20 05:24:55.413 [info] circuit_finish_handshake(): Finished building circuit hop:
339Mar 20 05:24:55.413 [info] exit circ (length 1, exit gabelmoo): gabelmoo(open)
340Mar 20 05:24:55.413 [info] circuit_send_next_onion_skin(): circuit built!
341Mar 20 05:24:55.414 [info] exit circ (length 1): gabelmoo(open)
342Mar 20 05:24:55.414 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 6388
343Mar 20 05:24:55.453 [info] circuit_finish_handshake(): Finished building circuit hop:
344Mar 20 05:24:55.453 [info] exit circ (length 1, exit dannenberg): dannenberg(open)
345Mar 20 05:24:55.453 [info] circuit_send_next_onion_skin(): circuit built!
346Mar 20 05:24:55.453 [info] exit circ (length 1): dannenberg(open)
347Mar 20 05:24:55.454 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 40547
348Mar 20 05:24:55.455 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
349Mar 20 05:24:55.455 [info] exit circ (length 1): moria1(open)
350Mar 20 05:24:55.456 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
351Mar 20 05:24:55.457 [info] exit circ (length 1): dizum(open)
352Mar 20 05:24:55.503 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
353Mar 20 05:24:55.503 [info] exit circ (length 1): gabelmoo(open)
354Mar 20 05:24:55.541 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
355Mar 20 05:24:55.542 [info] exit circ (length 1): moria2(open)
356Mar 20 05:24:55.548 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
357Mar 20 05:24:55.548 [info] exit circ (length 1): dannenberg(open)
358Mar 20 05:24:55.562 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
359Mar 20 05:24:55.562 [info] exit circ (length 1): jalopy(open)
360Mar 20 05:24:55.806 [info] circuit_finish_handshake(): Finished building circuit hop:
361Mar 20 05:24:55.806 [info] exit circ (length 1, exit ides): ides(open)
362Mar 20 05:24:55.806 [info] circuit_send_next_onion_skin(): circuit built!
363Mar 20 05:24:55.807 [info] exit circ (length 1): ides(open)
364Mar 20 05:24:55.807 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 44581
365Mar 20 05:24:55.866 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
366Mar 20 05:24:55.904 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'gothnet'
367Mar 20 05:24:55.904 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
368Mar 20 05:24:55.906 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 61892. Removing stream.
369Mar 20 05:24:55.907 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
370Mar 20 05:24:55.908 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 11330. Removing stream.
371Mar 20 05:24:55.908 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
372Mar 20 05:24:55.908 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 37632. Removing stream.
373Mar 20 05:24:55.908 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
374Mar 20 05:24:55.909 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 36314. Removing stream.
375Mar 20 05:24:55.909 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
376Mar 20 05:24:55.910 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
377Mar 20 05:24:55.910 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
378Mar 20 05:24:55.910 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
379Mar 20 05:24:55.913 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
380Mar 20 05:24:55.914 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
381Mar 20 05:24:55.914 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
382Mar 20 05:24:55.914 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
383Mar 20 05:24:55.914 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
384Mar 20 05:24:55.943 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 51981. Removing stream.
385Mar 20 05:24:55.943 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
386Mar 20 05:24:55.944 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
387Mar 20 05:24:55.944 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
388Mar 20 05:24:55.945 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 22596. Removing stream.
389Mar 20 05:24:55.945 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
390Mar 20 05:24:55.945 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
391Mar 20 05:24:55.945 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
392Mar 20 05:24:56.004 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
393Mar 20 05:24:56.005 [info] exit circ (length 1): ides(open)
394Mar 20 05:24:56.625 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 47233. Removing stream.
395Mar 20 05:24:56.626 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
396Mar 20 05:24:56.627 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
397Mar 20 05:24:56.628 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
398Mar 20 05:24:56.917 [info] circuit_finish_handshake(): Finished building circuit hop:
399Mar 20 05:24:56.917 [info] exit circ (length 1, exit gothnet): gothnet(open)
400Mar 20 05:24:56.918 [info] circuit_send_next_onion_skin(): circuit built!
401Mar 20 05:24:56.918 [info] exit circ (length 1): gothnet(open)
402Mar 20 05:24:56.918 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 5054
403Mar 20 05:24:57.311 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 29440. Removing stream.
404Mar 20 05:24:57.311 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
405Mar 20 05:24:57.324 [info] connection_dir_client_reached_eof(): Received server info (size 117559) from server '149.9.0.57:9001'
406Mar 20 05:24:57.596 [info] router_load_routers_from_string(): 82 elements to add
407Mar 20 05:24:57.711 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
408Mar 20 05:24:57.712 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
409Mar 20 05:24:57.719 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
410Mar 20 05:24:57.721 [info] connection_dir_client_reached_eof(): Received 82/86 router descriptors requested from 149.9.0.57:9001
411Mar 20 05:24:57.722 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
412Mar 20 05:24:58.022 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 2 seconds.
413Mar 20 05:24:58.023 [info] exit circ (length 1): gothnet(open)
414Mar 20 05:24:58.625 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
415Mar 20 05:24:58.663 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'atacama'
416Mar 20 05:24:58.664 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
417Mar 20 05:24:58.834 [info] circuit_finish_handshake(): Finished building circuit hop:
418Mar 20 05:24:58.834 [info] internal circ (length 3, exit <myrelay>): atacama(open) $EDA31B0429A7A649FA305895F8C6155E14BC3436(closed) $<my fingerprint>(closed)
419Mar 20 05:24:58.872 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
420Mar 20 05:24:59.133 [info] circuit_finish_handshake(): Finished building circuit hop:
421Mar 20 05:24:59.134 [info] internal circ (length 3, exit <myrelay>): atacama(open) $EDA31B0429A7A649FA305895F8C6155E14BC3436(open) $<my fingerprint>(closed)
422Mar 20 05:24:59.172 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
423Mar 20 05:25:00.293 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 2781. Removing stream.
424Mar 20 05:25:00.293 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
425Mar 20 05:25:00.489 [info] connection_dir_client_reached_eof(): Received server info (size 134245) from server '64.27.17.141:9001'
426Mar 20 05:25:00.770 [info] router_load_routers_from_string(): 85 elements to add
427Mar 20 05:25:01.153 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
428Mar 20 05:25:01.155 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
429Mar 20 05:25:01.161 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
430Mar 20 05:25:01.163 [info] connection_dir_client_reached_eof(): Received 85/85 router descriptors requested from 64.27.17.141:9001
431Mar 20 05:25:01.163 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
432Mar 20 05:25:01.885 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
433Mar 20 05:25:01.923 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'JenesisComputers'
434Mar 20 05:25:01.924 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
435Mar 20 05:25:02.013 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
436Mar 20 05:25:02.053 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Bellum'
437Mar 20 05:25:02.054 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
438Mar 20 05:25:02.257 [info] circuit_finish_handshake(): Finished building circuit hop:
439Mar 20 05:25:02.257 [info] internal circ (length 3, exit <myrelay>): Bellum(open) Butterfly(closed) $<my fingerprint>(closed)
440Mar 20 05:25:02.294 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
441Mar 20 05:25:02.613 [info] circuit_finish_handshake(): Finished building circuit hop:
442Mar 20 05:25:02.613 [info] internal circ (length 3, exit <myrelay>): Bellum(open) Butterfly(open) $<my fingerprint>(closed)
443Mar 20 05:25:02.650 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
444Mar 20 05:25:05.410 [info] circuit_finish_handshake(): Finished building circuit hop:
445Mar 20 05:25:05.410 [info] exit circ (length 1, exit JenesisComputers): JenesisComputers(open)
446Mar 20 05:25:05.410 [info] circuit_send_next_onion_skin(): circuit built!
447Mar 20 05:25:05.410 [info] exit circ (length 1): JenesisComputers(open)
448Mar 20 05:25:05.419 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 4412
449Mar 20 05:25:07.838 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 2 seconds.
450Mar 20 05:25:07.838 [info] exit circ (length 1): JenesisComputers(open)
451Mar 20 05:25:23.283 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 26432. Removing stream.
452Mar 20 05:25:23.284 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
453Mar 20 05:25:23.527 [info] connection_dir_client_reached_eof(): Received server info (size 111228) from server '75.144.197.249:9001'
454Mar 20 05:25:23.770 [info] router_load_routers_from_string(): 70 elements to add
455Mar 20 05:25:23.872 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
456Mar 20 05:25:23.873 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
457Mar 20 05:25:23.882 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
458Mar 20 05:25:23.884 [info] connection_dir_client_reached_eof(): Received 70/86 router descriptors requested from 75.144.197.249:9001
459Mar 20 05:25:23.885 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
460Mar 20 05:25:24.688 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:11375; sending NETINFO.
461Mar 20 05:25:24.725 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'SURFnetTor1'
462Mar 20 05:25:24.725 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:11375; OR connection is now open, using protocol version 2
463Mar 20 05:25:24.913 [info] circuit_finish_handshake(): Finished building circuit hop:
464Mar 20 05:25:24.914 [info] internal circ (length 3, exit <myrelay>): SURFnetTor1(open) $EDA31B0429A7A649FA305895F8C6155E14BC3436(closed) $<my fingerprint>(closed)
465Mar 20 05:25:24.951 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
466Mar 20 05:25:25.232 [info] circuit_finish_handshake(): Finished building circuit hop:
467Mar 20 05:25:25.234 [info] internal circ (length 3, exit <myrelay>): SURFnetTor1(open) $EDA31B0429A7A649FA305895F8C6155E14BC3436(open) $<my fingerprint>(closed)
468Mar 20 05:25:25.270 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
469Mar 20 05:25:49.487 [info] update_consensus_router_descriptor_downloads(): 20 router descriptors downloadable. 0 delayed; 1178 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
470Mar 20 05:25:49.487 [info] launch_router_descriptor_downloads(): Launching 3 requests for 20 routers, 7 at a time
471Mar 20 05:25:49.490 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
472Mar 20 05:25:49.491 [info] onion_pick_cpath_exit(): Using requested exit node 'doncella'
473Mar 20 05:25:49.491 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
474Mar 20 05:25:49.491 [info] connection_ap_make_link(): ... application connection created and linked.
475Mar 20 05:25:49.494 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
476Mar 20 05:25:49.494 [info] onion_pick_cpath_exit(): Using requested exit node 'GuyMontag'
477Mar 20 05:25:49.494 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
478Mar 20 05:25:49.495 [info] connection_ap_make_link(): ... application connection created and linked.
479Mar 20 05:25:49.498 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
480Mar 20 05:25:49.498 [info] onion_pick_cpath_exit(): Using requested exit node 'oophikeejee'
481Mar 20 05:25:49.498 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
482Mar 20 05:25:49.499 [info] connection_ap_make_link(): ... application connection created and linked.
483Mar 20 05:25:49.501 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
484Mar 20 05:25:49.501 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
485Mar 20 05:25:49.510 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
486Mar 20 05:25:49.512 [info] routerlist_remove_old_routers(): We have 1270 live routers and 0 old router descriptors.
487Mar 20 05:25:49.513 [info] circuit_expire_building(): Abandoning circ 0 (state 2:connecting to server, purpose 17)
488Mar 20 05:25:49.513 [info] internal circ (length 3, exit <myrelay>): lanroamer(closed) SEC(closed) $<my fingerprint>(closed)
489Mar 20 05:25:49.514 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
490Mar 20 05:25:49.514 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
491Mar 20 05:25:49.514 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
492Mar 20 05:25:49.514 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
493Mar 20 05:25:49.514 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
494Mar 20 05:25:49.514 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
495Mar 20 05:25:51.931 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
496Mar 20 05:25:51.971 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'GuyMontag'
497Mar 20 05:25:51.971 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
498Mar 20 05:25:51.972 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
499Mar 20 05:25:52.009 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'doncella'
500Mar 20 05:25:52.009 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
501Mar 20 05:25:52.010 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
502Mar 20 05:25:52.048 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'oophikeejee'
503Mar 20 05:25:52.048 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
504Mar 20 05:25:52.052 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9050; sending NETINFO.
505Mar 20 05:25:52.092 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'gpfTOR1'
506Mar 20 05:25:52.093 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9050; OR connection is now open, using protocol version 2
507Mar 20 05:25:52.235 [info] circuit_finish_handshake(): Finished building circuit hop:
508Mar 20 05:25:52.236 [info] exit circ (length 1, exit GuyMontag): GuyMontag(open)
509Mar 20 05:25:52.236 [info] circuit_send_next_onion_skin(): circuit built!
510Mar 20 05:25:52.236 [info] exit circ (length 1): GuyMontag(open)
511Mar 20 05:25:52.236 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 17016
512Mar 20 05:25:52.308 [info] circuit_finish_handshake(): Finished building circuit hop:
513Mar 20 05:25:52.309 [info] internal circ (length 3, exit <myrelay>): gpfTOR1(open) Fluestertuete(closed) $<my fingerprint>(closed)
514Mar 20 05:25:52.347 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
515Mar 20 05:25:52.398 [info] circuit_finish_handshake(): Finished building circuit hop:
516Mar 20 05:25:52.398 [info] exit circ (length 1, exit doncella): doncella(open)
517Mar 20 05:25:52.398 [info] circuit_send_next_onion_skin(): circuit built!
518Mar 20 05:25:52.398 [info] exit circ (length 1): doncella(open)
519Mar 20 05:25:52.398 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 49577
520Mar 20 05:25:52.399 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
521Mar 20 05:25:52.399 [info] exit circ (length 1): GuyMontag(open)
522Mar 20 05:25:52.437 [info] circuit_finish_handshake(): Finished building circuit hop:
523Mar 20 05:25:52.438 [info] exit circ (length 1, exit oophikeejee): oophikeejee(open)
524Mar 20 05:25:52.438 [info] circuit_send_next_onion_skin(): circuit built!
525Mar 20 05:25:52.438 [info] exit circ (length 1): oophikeejee(open)
526Mar 20 05:25:52.438 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 23052
527Mar 20 05:25:52.537 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
528Mar 20 05:25:52.537 [info] exit circ (length 1): oophikeejee(open)
529Mar 20 05:25:52.544 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
530Mar 20 05:25:52.544 [info] exit circ (length 1): doncella(open)
531Mar 20 05:25:52.599 [info] circuit_finish_handshake(): Finished building circuit hop:
532Mar 20 05:25:52.600 [info] internal circ (length 3, exit <myrelay>): gpfTOR1(open) Fluestertuete(open) $<my fingerprint>(closed)
533Mar 20 05:25:52.639 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
534Mar 20 05:25:52.640 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 56884. Removing stream.
535Mar 20 05:25:52.641 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
536Mar 20 05:25:52.644 [info] connection_dir_client_reached_eof(): Received server info (size 11401) from server '81.88.14.185:9001'
537Mar 20 05:25:52.670 [info] router_load_routers_from_string(): 7 elements to add
538Mar 20 05:25:52.690 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
539Mar 20 05:25:52.691 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
540Mar 20 05:25:52.699 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
541Mar 20 05:25:52.720 [info] connection_dir_client_reached_eof(): Received 7/7 router descriptors requested from 81.88.14.185:9001
542Mar 20 05:25:52.720 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
543Mar 20 05:25:52.724 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 38083. Removing stream.
544Mar 20 05:25:52.724 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
545Mar 20 05:25:52.731 [info] connection_dir_client_reached_eof(): Received server info (size 8206) from server '212.75.37.82:9001'
546Mar 20 05:25:52.773 [info] router_load_routers_from_string(): 6 elements to add
547Mar 20 05:25:52.802 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
548Mar 20 05:25:52.803 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
549Mar 20 05:25:52.814 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
550Mar 20 05:25:52.815 [info] connection_dir_client_reached_eof(): Received 6/6 router descriptors requested from 212.75.37.82:9001
551Mar 20 05:25:52.815 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
552Mar 20 05:25:52.817 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 36551. Removing stream.
553Mar 20 05:25:52.817 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
554Mar 20 05:25:52.825 [info] connection_dir_client_reached_eof(): Received server info (size 4191) from server '87.106.79.223:9001'
555Mar 20 05:25:53.177 [info] router_load_routers_from_string(): 3 elements to add
556Mar 20 05:25:53.289 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
557Mar 20 05:25:53.290 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
558Mar 20 05:25:53.300 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
559Mar 20 05:25:53.301 [info] connection_dir_client_reached_eof(): Received 3/7 router descriptors requested from 87.106.79.223:9001
560Mar 20 05:25:53.301 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
561Mar 20 05:25:54.799 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
562Mar 20 05:25:54.837 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'trusted'
563Mar 20 05:25:54.837 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
564Mar 20 05:25:55.151 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
565Mar 20 05:25:55.306 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'UBIT1'
566Mar 20 05:25:55.306 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
567Mar 20 05:25:56.061 [info] circuit_finish_handshake(): Finished building circuit hop:
568Mar 20 05:25:56.061 [info] internal circ (length 3, exit <myrelay>): trusted(open) nineukyomismo(closed) $<my fingerprint>(closed)
569Mar 20 05:25:56.098 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
570Mar 20 05:25:56.327 [info] circuit_finish_handshake(): Finished building circuit hop:
571Mar 20 05:25:56.327 [info] internal circ (length 3, exit <myrelay>): UBIT1(open) hendi(closed) $<my fingerprint>(closed)
572Mar 20 05:25:56.367 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
573Mar 20 05:25:56.370 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
574Mar 20 05:25:56.429 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Butterfly'
575Mar 20 05:25:56.429 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
576Mar 20 05:25:56.537 [info] circuit_finish_handshake(): Finished building circuit hop:
577Mar 20 05:25:56.537 [info] internal circ (length 3, exit <myrelay>): UBIT1(open) hendi(open) $<my fingerprint>(closed)
578Mar 20 05:25:56.616 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
579Mar 20 05:25:56.814 [info] circuit_finish_handshake(): Finished building circuit hop:
580Mar 20 05:25:56.814 [info] internal circ (length 3, exit <myrelay>): Butterfly(open) SEC(closed) $<my fingerprint>(closed)
581Mar 20 05:25:56.851 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
582Mar 20 05:25:57.038 [info] circuit_expire_building(): Abandoning circ 212.13.194.142:443:32765 (state 0:doing handshakes, purpose 17)
583Mar 20 05:25:57.039 [info] internal circ (length 3, exit <myrelay>): atacama(open) $EDA31B0429A7A649FA305895F8C6155E14BC3436(open) $<my fingerprint>(waiting for keys)
584Mar 20 05:25:57.113 [info] circuit_finish_handshake(): Finished building circuit hop:
585Mar 20 05:25:57.113 [info] internal circ (length 3, exit <myrelay>): Bellum(open) Butterfly(open) $<my fingerprint>(open)
586Mar 20 05:25:57.119 [info] circuit_send_next_onion_skin(): circuit built!
587Mar 20 05:25:57.119 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
588Mar 20 05:25:57.120 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
589Mar 20 05:25:57.137 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
590Mar 20 05:25:57.459 [info] circuit_finish_handshake(): Finished building circuit hop:
591Mar 20 05:25:57.460 [info] internal circ (length 3, exit <myrelay>): trusted(open) nineukyomismo(open) $<my fingerprint>(closed)
592Mar 20 05:25:57.566 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
593Mar 20 05:25:57.674 [info] circuit_finish_handshake(): Finished building circuit hop:
594Mar 20 05:25:57.675 [info] internal circ (length 3, exit <myrelay>): Butterfly(open) SEC(open) $<my fingerprint>(closed)
595Mar 20 05:25:57.792 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
596Mar 20 05:25:59.248 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
597Mar 20 05:25:59.293 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Lifuka'
598Mar 20 05:25:59.293 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
599Mar 20 05:25:59.680 [info] circuit_finish_handshake(): Finished building circuit hop:
600Mar 20 05:25:59.680 [info] internal circ (length 3, exit <myrelay>): Lifuka(open) PolynaTor(closed) $<my fingerprint>(closed)
601Mar 20 05:25:59.736 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
602Mar 20 05:26:00.192 [info] circuit_finish_handshake(): Finished building circuit hop:
603Mar 20 05:26:00.193 [info] internal circ (length 3, exit <myrelay>): Lifuka(open) PolynaTor(open) $<my fingerprint>(closed)
604Mar 20 05:26:00.235 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
605Mar 20 05:26:23.337 [info] circuit_expire_building(): Abandoning circ 194.171.167.98:11375:50082 (state 0:doing handshakes, purpose 17)
606Mar 20 05:26:23.338 [info] internal circ (length 3, exit <myrelay>): SURFnetTor1(open) $EDA31B0429A7A649FA305895F8C6155E14BC3436(open) $<my fingerprint>(waiting for keys)
607Mar 20 05:26:41.350 [info] dns_launch_wildcard_checks(): Launching checks to see whether our nameservers like to hijack DNS failures.
608Mar 20 05:26:41.351 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "erjf25yw.invalid"
609Mar 20 05:26:41.352 [info] eventdns: Resolve requested.
610Mar 20 05:26:41.352 [info] eventdns: Setting timeout for request 1507e20
611Mar 20 05:26:41.352 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "nydf762cs3.test"
612Mar 20 05:26:41.352 [info] eventdns: Resolve requested.
613Mar 20 05:26:41.352 [info] eventdns: Setting timeout for request 11cd990
614Mar 20 05:26:41.352 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "26xvzp7j67eo"
615Mar 20 05:26:41.353 [info] eventdns: Resolve requested.
616Mar 20 05:26:41.353 [info] eventdns: Setting timeout for request 11c6990
617Mar 20 05:26:41.353 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "emf7krbif.com"
618Mar 20 05:26:41.353 [info] eventdns: Resolve requested.
619Mar 20 05:26:41.353 [info] eventdns: Setting timeout for request 1532200
620Mar 20 05:26:41.353 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "ofxrogpccivtgl5.org"
621Mar 20 05:26:41.354 [info] eventdns: Resolve requested.
622Mar 20 05:26:41.354 [info] eventdns: Setting timeout for request 13d4f90
623Mar 20 05:26:41.354 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "u3atkparobpy.net"
624Mar 20 05:26:41.354 [info] eventdns: Resolve requested.
625Mar 20 05:26:41.354 [info] eventdns: Setting timeout for request 11d20e0
626Mar 20 05:26:41.354 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "cyw22jz3i3h.invalid"
627Mar 20 05:26:41.354 [info] eventdns: Resolve requested.
628Mar 20 05:26:41.354 [info] eventdns: Setting timeout for request 11fd880
629Mar 20 05:26:41.354 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "g7xsgn2a2eucso6.test"
630Mar 20 05:26:41.355 [info] eventdns: Resolve requested.
631Mar 20 05:26:41.355 [info] eventdns: Setting timeout for request 1517bd0
632Mar 20 05:26:41.355 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "e3pksvaskksj2d3"
633Mar 20 05:26:41.355 [info] eventdns: Resolve requested.
634Mar 20 05:26:41.355 [info] eventdns: Setting timeout for request 11c4c70
635Mar 20 05:26:41.355 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "kbnn2344.com"
636Mar 20 05:26:41.355 [info] eventdns: Resolve requested.
637Mar 20 05:26:41.355 [info] eventdns: Setting timeout for request 11bfca0
638Mar 20 05:26:41.355 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "tg2yacftoxgjfjg.org"
639Mar 20 05:26:41.355 [info] eventdns: Resolve requested.
640Mar 20 05:26:41.356 [info] eventdns: Setting timeout for request 11db860
641Mar 20 05:26:41.356 [info] launch_wildcard_check(): Testing whether our DNS server is hijacking nonexistent domains with request for bogus hostname "okewyacjvl2b.net"
642Mar 20 05:26:41.356 [info] eventdns: Resolve requested.
643Mar 20 05:26:41.356 [info] eventdns: Setting timeout for request 13dad10
644Mar 20 05:26:41.406 [info] eventdns: Removing timeout for request 1507e20
645Mar 20 05:26:41.407 [info] eventdns: Removing timeout for request 11c6990
646Mar 20 05:26:41.409 [info] eventdns: Removing timeout for request 11d20e0
647Mar 20 05:26:41.409 [info] eventdns: Removing timeout for request 11c4c70
648Mar 20 05:26:41.410 [info] eventdns: Removing timeout for request 11fd880
649Mar 20 05:26:41.416 [info] eventdns: Removing timeout for request 13dad10
650Mar 20 05:26:41.488 [info] eventdns: Removing timeout for request 1532200
651Mar 20 05:26:41.493 [info] eventdns: Removing timeout for request 11bfca0
652Mar 20 05:26:46.351 [info] eventdns: Request 11db860 timed out
653Mar 20 05:26:46.351 [info] eventdns: Setting timeout for request 11db860
654Mar 20 05:26:46.351 [info] eventdns: Request 11cd990 timed out
655Mar 20 05:26:46.351 [info] eventdns: Setting timeout for request 11cd990
656Mar 20 05:26:46.351 [info] eventdns: Request 13d4f90 timed out
657Mar 20 05:26:46.351 [info] eventdns: Setting timeout for request 13d4f90
658Mar 20 05:26:46.352 [info] eventdns: Request 1517bd0 timed out
659Mar 20 05:26:46.352 [info] eventdns: Nameserver 192.168.1.1 has failed: request timed out.
660Mar 20 05:26:46.352 [info] eventdns: Setting timeout for request 1517bd0
661Mar 20 05:26:50.554 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 4 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
662Mar 20 05:26:50.554 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
663Mar 20 05:26:50.556 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
664Mar 20 05:26:50.564 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
665Mar 20 05:26:50.566 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
666Mar 20 05:26:50.566 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 14, dropping 10.
667Mar 20 05:26:51.420 [info] eventdns: Request 1517bd0 timed out
668Mar 20 05:26:51.422 [info] eventdns: Setting timeout for request 1517bd0
669Mar 20 05:26:51.422 [info] eventdns: Request 11db860 timed out
670Mar 20 05:26:51.422 [info] eventdns: Setting timeout for request 11db860
671Mar 20 05:26:51.422 [info] eventdns: Request 11cd990 timed out
672Mar 20 05:26:51.423 [info] eventdns: Setting timeout for request 11cd990
673Mar 20 05:26:51.423 [info] eventdns: Request 13d4f90 timed out
674Mar 20 05:26:51.423 [info] eventdns: Setting timeout for request 13d4f90
675Mar 20 05:26:51.493 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
676Mar 20 05:26:51.535 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'DomecekNaMolotovovi'
677Mar 20 05:26:51.536 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
678Mar 20 05:26:51.762 [info] circuit_finish_handshake(): Finished building circuit hop:
679Mar 20 05:26:51.763 [info] internal circ (length 3, exit <myrelay>): DomecekNaMolotovovi(open) SURFnetTor1(closed) $<my fingerprint>(closed)
680Mar 20 05:26:51.798 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
681Mar 20 05:26:51.936 [info] circuit_finish_handshake(): Finished building circuit hop:
682Mar 20 05:26:51.936 [info] internal circ (length 3, exit <myrelay>): DomecekNaMolotovovi(open) SURFnetTor1(open) $<my fingerprint>(closed)
683Mar 20 05:26:51.974 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
684Mar 20 05:26:52.274 [info] circuit_finish_handshake(): Finished building circuit hop:
685Mar 20 05:26:52.274 [info] internal circ (length 3, exit <myrelay>): DomecekNaMolotovovi(open) SURFnetTor1(open) $<my fingerprint>(open)
686Mar 20 05:26:52.274 [info] circuit_send_next_onion_skin(): circuit built!
687Mar 20 05:26:52.274 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
688Mar 20 05:26:52.278 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
689Mar 20 05:26:52.285 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
690Mar 20 05:26:52.465 [info] circuit_expire_building(): Abandoning circ 94.136.16.242:9001:58091 (state 0:doing handshakes, purpose 17)
691Mar 20 05:26:52.465 [info] internal circ (length 3, exit <myrelay>): UBIT1(open) hendi(open) $<my fingerprint>(waiting for keys)
692Mar 20 05:26:52.465 [info] circuit_expire_building(): Abandoning circ 91.208.34.1:443:57456 (state 0:doing handshakes, purpose 17)
693Mar 20 05:26:52.465 [info] internal circ (length 3, exit <myrelay>): trusted(open) nineukyomismo(open) $<my fingerprint>(waiting for keys)
694Mar 20 05:26:53.423 [info] eventdns: Got a SERVERFAILED from nameserver 192.168.1.1; will allow the request to time out.
695Mar 20 05:26:53.424 [info] eventdns: Removing timeout for request 11db860
696Mar 20 05:26:53.424 [info] eventdns: Got a SERVERFAILED from nameserver 192.168.1.1; will allow the request to time out.
697Mar 20 05:26:53.424 [info] eventdns: Removing timeout for request 1517bd0
698Mar 20 05:26:53.424 [info] eventdns: Got a SERVERFAILED from nameserver 192.168.1.1; will allow the request to time out.
699Mar 20 05:26:53.424 [info] eventdns: Removing timeout for request 13d4f90
700Mar 20 05:26:53.425 [info] eventdns: Got a SERVERFAILED from nameserver 192.168.1.1; will allow the request to time out.
701Mar 20 05:26:53.425 [info] eventdns: Removing timeout for request 11cd990
702Mar 20 05:26:53.465 [info] circuit_expire_building(): Abandoning circ 156.56.103.103:9001:30419 (state 0:doing handshakes, purpose 17)
703Mar 20 05:26:53.466 [info] internal circ (length 3, exit <myrelay>): Butterfly(open) SEC(open) $<my fingerprint>(waiting for keys)
704Mar 20 05:26:56.352 [info] eventdns: Sending probe to 192.168.1.1
705Mar 20 05:26:56.353 [info] eventdns: Setting timeout for request 11cd990
706Mar 20 05:26:56.398 [info] eventdns: Nameserver 192.168.1.1 is back up
707Mar 20 05:26:56.399 [info] eventdns: Removing timeout for request 11cd990
708Mar 20 05:26:57.683 [info] circuit_expire_building(): Abandoning circ 82.94.251.204:443:28255 (state 0:doing handshakes, purpose 17)
709Mar 20 05:26:57.683 [info] internal circ (length 3, exit <myrelay>): Lifuka(open) PolynaTor(open) $<my fingerprint>(waiting for keys)
710Mar 20 05:27:09.930 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
711Mar 20 05:27:09.969 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'VSvTZGO7UPj4yh8'
712Mar 20 05:27:09.971 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
713Mar 20 05:27:11.351 [info] launch_test_addresses(): Launching checks to see whether our nameservers like to hijack *everything*.
714Mar 20 05:27:11.352 [info] eventdns: Resolve requested.
715Mar 20 05:27:11.353 [info] eventdns: Setting timeout for request 11d3580
716Mar 20 05:27:11.353 [info] eventdns: Resolve requested.
717Mar 20 05:27:11.353 [info] eventdns: Setting timeout for request 11e2df0
718Mar 20 05:27:11.353 [info] eventdns: Resolve requested.
719Mar 20 05:27:11.353 [info] eventdns: Setting timeout for request 1177700
720Mar 20 05:27:11.353 [info] eventdns: Resolve requested.
721Mar 20 05:27:11.353 [info] eventdns: Setting timeout for request 213c070
722Mar 20 05:27:11.355 [info] eventdns: Removing timeout for request 11d3580
723Mar 20 05:27:11.398 [info] eventdns: Removing timeout for request 1177700
724Mar 20 05:27:11.401 [info] eventdns: Removing timeout for request 213c070
725Mar 20 05:27:11.480 [info] eventdns: Removing timeout for request 11e2df0
726Mar 20 05:27:15.228 [info] circuit_finish_handshake(): Finished building circuit hop:
727Mar 20 05:27:15.228 [info] internal circ (length 3, exit <myrelay>): VSvTZGO7UPj4yh8(open) wuschelpuschel(closed) $<my fingerprint>(closed)
728Mar 20 05:27:15.269 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
729Mar 20 05:27:51.192 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
730Mar 20 05:27:51.193 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
731Mar 20 05:27:51.193 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
732Mar 20 05:27:51.199 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
733Mar 20 05:27:51.201 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
734Mar 20 05:27:51.201 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 10, dropping 4.
735Mar 20 05:27:52.028 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
736Mar 20 05:27:52.065 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'MopperSmurf'
737Mar 20 05:27:52.065 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
738Mar 20 05:27:52.318 [info] circuit_finish_handshake(): Finished building circuit hop:
739Mar 20 05:27:52.319 [info] internal circ (length 3, exit <myrelay>): MopperSmurf(open) bellerophontes(closed) $<my fingerprint>(closed)
740Mar 20 05:27:52.358 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
741Mar 20 05:27:52.546 [info] circuit_finish_handshake(): Finished building circuit hop:
742Mar 20 05:27:52.547 [info] internal circ (length 3, exit <myrelay>): MopperSmurf(open) bellerophontes(open) $<my fingerprint>(closed)
743Mar 20 05:27:52.588 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
744Mar 20 05:28:51.054 [info] circuit_expire_building(): Abandoning circ 192.150.94.83:9001:1119 (state 0:doing handshakes, purpose 17)
745Mar 20 05:28:51.055 [info] internal circ (length 3, exit <myrelay>): MopperSmurf(open) bellerophontes(open) $<my fingerprint>(waiting for keys)
746Mar 20 05:28:52.239 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
747Mar 20 05:28:52.240 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
748Mar 20 05:28:52.240 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
749Mar 20 05:28:52.246 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
750Mar 20 05:28:52.248 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
751Mar 20 05:28:52.249 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 8, dropping 1.
752Mar 20 05:28:53.872 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:59999; sending NETINFO.
753Mar 20 05:28:53.909 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'tortestrejectall3'
754Mar 20 05:28:53.909 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:59999; OR connection is now open, using protocol version 2
755Mar 20 05:28:54.364 [info] circuit_finish_handshake(): Finished building circuit hop:
756Mar 20 05:28:54.364 [info] internal circ (length 3, exit <myrelay>): tortestrejectall3(open) SURFnetTor1(closed) $<my fingerprint>(closed)
757Mar 20 05:28:54.403 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
758Mar 20 05:28:54.854 [info] circuit_finish_handshake(): Finished building circuit hop:
759Mar 20 05:28:54.854 [info] internal circ (length 3, exit <myrelay>): tortestrejectall3(open) SURFnetTor1(open) $<my fingerprint>(closed)
760Mar 20 05:28:54.892 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
761Mar 20 05:28:55.452 [info] circuit_finish_handshake(): Finished building circuit hop:
762Mar 20 05:28:55.452 [info] internal circ (length 3, exit <myrelay>): tortestrejectall3(open) SURFnetTor1(open) $<my fingerprint>(open)
763Mar 20 05:28:55.452 [info] circuit_send_next_onion_skin(): circuit built!
764Mar 20 05:28:55.452 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
765Mar 20 05:28:55.453 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
766Mar 20 05:28:55.462 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
767Mar 20 05:28:59.550 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:8192; sending NETINFO.
768Mar 20 05:28:59.599 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'juliusagrippa'
769Mar 20 05:28:59.599 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:8192; OR connection is now open, using protocol version 2
770Mar 20 05:28:59.951 [info] circuit_finish_handshake(): Finished building circuit hop:
771Mar 20 05:28:59.952 [info] internal circ (length 3, exit <myrelay>): juliusagrippa(open) devastator(closed) $<my fingerprint>(closed)
772Mar 20 05:28:59.990 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
773Mar 20 05:29:00.642 [info] circuit_finish_handshake(): Finished building circuit hop:
774Mar 20 05:29:00.644 [info] internal circ (length 3, exit <myrelay>): juliusagrippa(open) devastator(open) $<my fingerprint>(closed)
775Mar 20 05:29:00.679 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
776Mar 20 05:29:53.695 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
777Mar 20 05:29:53.697 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
778Mar 20 05:29:53.697 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
779Mar 20 05:29:53.742 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'tornodeviennasil'
780Mar 20 05:29:53.743 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
781Mar 20 05:29:53.886 [info] circuit_finish_handshake(): Finished building circuit hop:
782Mar 20 05:29:53.887 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) SEC(closed) $<my fingerprint>(closed)
783Mar 20 05:29:53.925 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
784Mar 20 05:29:54.118 [info] circuit_finish_handshake(): Finished building circuit hop:
785Mar 20 05:29:54.118 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) SEC(open) $<my fingerprint>(closed)
786Mar 20 05:29:54.159 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
787Mar 20 05:29:55.513 [info] circuit_expire_building(): Abandoning circ 193.137.211.90:8192:12277 (state 0:doing handshakes, purpose 17)
788Mar 20 05:29:55.513 [info] internal circ (length 3, exit <myrelay>): juliusagrippa(open) devastator(open) $<my fingerprint>(waiting for keys)
789Mar 20 05:30:31.373 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'RC4-SHA'
790Mar 20 05:30:31.373 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA:EDH-RSA-DES-CBC3-SHA:RC4-SHA'
791Mar 20 05:30:31.739 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'RC4-SHA'
792Mar 20 05:30:31.739 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA:EDH-RSA-DES-CBC3-SHA:RC4-SHA'
793Mar 20 05:30:32.421 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
794Mar 20 05:30:32.423 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
795Mar 20 05:30:32.572 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
796Mar 20 05:30:34.968 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
797Mar 20 05:30:34.970 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
798Mar 20 05:30:53.799 [info] circuit_expire_building(): Abandoning circ 86.59.32.35:443:18246 (state 0:doing handshakes, purpose 17)
799Mar 20 05:30:53.799 [info] internal circ (length 3, exit <myrelay>): tornodeviennasil(open) SEC(open) $<my fingerprint>(waiting for keys)
800Mar 20 05:30:54.999 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
801Mar 20 05:30:54.999 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
802Mar 20 05:30:55.000 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
803Mar 20 05:30:55.006 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
804Mar 20 05:30:55.007 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
805Mar 20 05:30:56.003 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
806Mar 20 05:30:56.047 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'cthuluzarborg'
807Mar 20 05:30:56.047 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
808Mar 20 05:30:56.290 [info] circuit_finish_handshake(): Finished building circuit hop:
809Mar 20 05:30:56.292 [info] internal circ (length 3, exit <myrelay>): cthuluzarborg(open) jceaovh(closed) $<my fingerprint>(closed)
810Mar 20 05:30:56.329 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
811Mar 20 05:30:56.459 [info] circuit_finish_handshake(): Finished building circuit hop:
812Mar 20 05:30:56.460 [info] internal circ (length 3, exit <myrelay>): cthuluzarborg(open) jceaovh(open) $<my fingerprint>(closed)
813Mar 20 05:30:56.500 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
814Mar 20 05:31:54.222 [info] circuit_expire_building(): Abandoning circ 212.85.158.24:9001:20657 (state 0:doing handshakes, purpose 17)
815Mar 20 05:31:54.222 [info] internal circ (length 3, exit <myrelay>): cthuluzarborg(open) jceaovh(open) $<my fingerprint>(waiting for keys)
816Mar 20 05:31:55.409 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
817Mar 20 05:31:55.410 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
818Mar 20 05:31:55.410 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
819Mar 20 05:31:55.416 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
820Mar 20 05:31:55.419 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
821Mar 20 05:31:56.206 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'c03d9ebf'
822Mar 20 05:31:57.070 [info] circuit_finish_handshake(): Finished building circuit hop:
823Mar 20 05:31:57.070 [info] internal circ (length 3, exit <myrelay>): c03d9ebf(open) devastator(closed) $<my fingerprint>(closed)
824Mar 20 05:31:57.106 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
825Mar 20 05:32:00.200 [info] circuit_finish_handshake(): Finished building circuit hop:
826Mar 20 05:32:00.200 [info] internal circ (length 3, exit <myrelay>): c03d9ebf(open) devastator(open) $<my fingerprint>(closed)
827Mar 20 05:32:00.240 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
828Mar 20 05:32:56.686 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
829Mar 20 05:32:56.690 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
830Mar 20 05:32:56.691 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
831Mar 20 05:32:56.696 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
832Mar 20 05:32:56.698 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
833Mar 20 05:32:57.581 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
834Mar 20 05:32:57.618 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'mytornodefig'
835Mar 20 05:32:57.618 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
836Mar 20 05:32:57.819 [info] circuit_finish_handshake(): Finished building circuit hop:
837Mar 20 05:32:57.819 [info] internal circ (length 3, exit <myrelay>): $D7A0A92D0EAEE459D9955136C363EB439AEF0D3F(open) devastator(closed) $<my fingerprint>(closed)
838Mar 20 05:32:57.857 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
839Mar 20 05:33:56.651 [info] circuit_expire_building(): Abandoning circ 85.25.61.5:9001:27602 (state 0:doing handshakes, purpose 17)
840Mar 20 05:33:56.652 [info] internal circ (length 3, exit <myrelay>): $D7A0A92D0EAEE459D9955136C363EB439AEF0D3F(open) devastator(waiting for keys) $<my fingerprint>(closed)
841Mar 20 05:33:57.851 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
842Mar 20 05:33:57.854 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
843Mar 20 05:33:57.856 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
844Mar 20 05:33:57.900 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Bellum'
845Mar 20 05:33:57.901 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
846Mar 20 05:33:58.044 [info] circuit_finish_handshake(): Finished building circuit hop:
847Mar 20 05:33:58.044 [info] internal circ (length 3, exit <myrelay>): Bellum(open) CyberKrawall(closed) $<my fingerprint>(closed)
848Mar 20 05:33:58.084 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
849Mar 20 05:33:58.207 [info] circuit_finish_handshake(): Finished building circuit hop:
850Mar 20 05:33:58.207 [info] internal circ (length 3, exit <myrelay>): Bellum(open) CyberKrawall(open) $<my fingerprint>(closed)
851Mar 20 05:33:58.244 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
852Mar 20 05:34:04.856 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
853Mar 20 05:34:04.856 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
854Mar 20 05:34:05.214 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
855Mar 20 05:34:05.215 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
856Mar 20 05:34:05.963 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
857Mar 20 05:34:05.965 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
858Mar 20 05:34:06.166 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
859Mar 20 05:34:13.312 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
860Mar 20 05:34:13.313 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
861Mar 20 05:34:57.200 [info] circuit_expire_building(): Abandoning circ 62.75.223.163:9001:3216 (state 0:doing handshakes, purpose 17)
862Mar 20 05:34:57.201 [info] internal circ (length 3, exit <myrelay>): Bellum(open) CyberKrawall(open) $<my fingerprint>(waiting for keys)
863Mar 20 05:34:58.391 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
864Mar 20 05:34:58.392 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
865Mar 20 05:34:58.392 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
866Mar 20 05:34:58.440 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Lifuka'
867Mar 20 05:34:58.441 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
868Mar 20 05:34:58.573 [info] circuit_finish_handshake(): Finished building circuit hop:
869Mar 20 05:34:58.574 [info] internal circ (length 3, exit <myrelay>): Lifuka(open) jceaovh(closed) $<my fingerprint>(closed)
870Mar 20 05:34:58.613 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
871Mar 20 05:34:58.774 [info] circuit_finish_handshake(): Finished building circuit hop:
872Mar 20 05:34:58.774 [info] internal circ (length 3, exit <myrelay>): Lifuka(open) jceaovh(open) $<my fingerprint>(closed)
873Mar 20 05:34:58.813 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
874Mar 20 05:35:58.396 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
875Mar 20 05:35:58.396 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
876Mar 20 05:35:58.594 [info] circuit_expire_building(): Abandoning circ 82.94.251.204:443:28256 (state 0:doing handshakes, purpose 17)
877Mar 20 05:35:58.594 [info] internal circ (length 3, exit <myrelay>): Lifuka(open) jceaovh(open) $<my fingerprint>(waiting for keys)
878Mar 20 05:35:58.753 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
879Mar 20 05:35:58.753 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
880Mar 20 05:35:59.546 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
881Mar 20 05:35:59.551 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
882Mar 20 05:35:59.790 [info] update_consensus_router_descriptor_downloads(): 4 router descriptors downloadable. 0 delayed; 1194 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
883Mar 20 05:35:59.791 [info] launch_router_descriptor_downloads(): There are not many downloadable routerdescs, but we've been waiting long enough (610 seconds). Downloading.
884Mar 20 05:35:59.791 [info] launch_router_descriptor_downloads(): Launching 1 request for 4 routers, 4 at a time
885Mar 20 05:35:59.796 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
886Mar 20 05:35:59.796 [info] onion_pick_cpath_exit(): Using requested exit node 'doncella'
887Mar 20 05:35:59.837 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'doncella'
888Mar 20 05:35:59.837 [info] connection_ap_make_link(): ... application connection created and linked.
889Mar 20 05:35:59.837 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
890Mar 20 05:35:59.838 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
891Mar 20 05:35:59.844 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
892Mar 20 05:35:59.846 [info] routerlist_remove_old_routers(): We have 1275 live routers and 0 old router descriptors.
893Mar 20 05:35:59.847 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
894Mar 20 05:35:59.847 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
895Mar 20 05:35:59.964 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
896Mar 20 05:36:00.024 [info] circuit_finish_handshake(): Finished building circuit hop:
897Mar 20 05:36:00.024 [info] exit circ (length 1, exit doncella): doncella(open)
898Mar 20 05:36:00.024 [info] circuit_send_next_onion_skin(): circuit built!
899Mar 20 05:36:00.025 [info] exit circ (length 1): doncella(open)
900Mar 20 05:36:00.025 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 49578
901Mar 20 05:36:00.263 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
902Mar 20 05:36:00.263 [info] exit circ (length 1): doncella(open)
903Mar 20 05:36:00.722 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 12228. Removing stream.
904Mar 20 05:36:00.723 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
905Mar 20 05:36:00.727 [info] connection_dir_client_reached_eof(): Received server info (size 5590) from server '87.106.79.223:9001'
906Mar 20 05:36:00.747 [info] router_load_routers_from_string(): 4 elements to add
907Mar 20 05:36:00.786 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
908Mar 20 05:36:00.787 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
909Mar 20 05:36:00.793 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Connections all too old, or too non-canonical.  Launching a new one.
910Mar 20 05:36:00.794 [info] connection_dir_client_reached_eof(): Received 4/4 router descriptors requested from 87.106.79.223:9001
911Mar 20 05:36:00.796 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
912Mar 20 05:36:00.892 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
913Mar 20 05:36:00.939 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'TolFuin'
914Mar 20 05:36:00.939 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
915Mar 20 05:36:01.235 [info] circuit_finish_handshake(): Finished building circuit hop:
916Mar 20 05:36:01.237 [info] internal circ (length 3, exit <myrelay>): TolFuin(open) SEC(closed) $<my fingerprint>(closed)
917Mar 20 05:36:01.354 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
918Mar 20 05:36:01.929 [info] circuit_finish_handshake(): Finished building circuit hop:
919Mar 20 05:36:01.929 [info] internal circ (length 3, exit <myrelay>): TolFuin(open) SEC(open) $<my fingerprint>(closed)
920Mar 20 05:36:01.967 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
921Mar 20 05:36:02.969 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
922Mar 20 05:36:03.007 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'anon1984n2'
923Mar 20 05:36:03.007 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
924Mar 20 05:36:03.287 [info] circuit_finish_handshake(): Finished building circuit hop:
925Mar 20 05:36:03.287 [info] internal circ (length 3, exit <myrelay>): anon1984n2(open) ExcessionOCP(closed) $<my fingerprint>(closed)
926Mar 20 05:36:03.325 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
927Mar 20 05:36:04.045 [info] circuit_finish_handshake(): Finished building circuit hop:
928Mar 20 05:36:04.046 [info] internal circ (length 3, exit <myrelay>): anon1984n2(open) ExcessionOCP(open) $<my fingerprint>(closed)
929Mar 20 05:36:04.084 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
930Mar 20 05:36:04.090 [info] connection_or_group_set_badness(): Marking OR conn to 91.143.91.111:443 as too old for new circuits: (fd 59, 6 secs old).  It is not canonical, and we have another connection to that OR that is.
931Mar 20 05:36:59.481 [info] circuit_expire_building(): Abandoning circ 87.118.92.238:9001:16461 (state 0:doing handshakes, purpose 17)
932Mar 20 05:36:59.482 [info] internal circ (length 3, exit <myrelay>): TolFuin(open) SEC(open) $<my fingerprint>(waiting for keys)
933Mar 20 05:37:00.671 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
934Mar 20 05:37:00.671 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
935Mar 20 05:37:00.672 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
936Mar 20 05:37:00.677 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
937Mar 20 05:37:00.680 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
938Mar 20 05:37:00.680 [info] circuit_expire_building(): Abandoning circ 91.143.91.111:443:27403 (state 0:doing handshakes, purpose 17)
939Mar 20 05:37:00.681 [info] internal circ (length 3, exit <myrelay>): anon1984n2(open) ExcessionOCP(open) $<my fingerprint>(waiting for keys)
940Mar 20 05:37:02.603 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
941Mar 20 05:37:02.645 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'notwithoutincident'
942Mar 20 05:37:02.645 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
943Mar 20 05:37:05.602 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 59 (91.143.91.111:443) [Too old].
944Mar 20 05:38:00.096 [info] circuit_expire_building(): Abandoning circ 89.160.32.161:9001:50690 (state 0:doing handshakes, purpose 17)
945Mar 20 05:38:00.097 [info] internal circ (length 3, exit <myrelay>): notwithoutincident(waiting for keys) threeletteragency(closed) $<my fingerprint>(closed)
946Mar 20 05:38:00.097 [info] circuit_build_failed(): Our circuit failed to get a response from the first hop (89.160.32.161:9001). I'm going to try to rotate to a better connection.
947Mar 20 05:38:01.297 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
948Mar 20 05:38:01.298 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
949Mar 20 05:38:01.299 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
950Mar 20 05:38:01.306 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
951Mar 20 05:38:01.310 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
952Mar 20 05:38:01.311 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 65 (89.160.32.161:9001) [Too old].
953Mar 20 05:38:01.311 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 9, dropping 1.
954Mar 20 05:38:03.762 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
955Mar 20 05:38:03.800 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Tonga'
956Mar 20 05:38:03.800 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
957Mar 20 05:38:04.051 [info] circuit_finish_handshake(): Finished building circuit hop:
958Mar 20 05:38:04.052 [info] internal circ (length 3, exit <myrelay>): Tonga(open) $D7EF14045DEDAE9E9E61D8CEF0F84F87703AD55D(closed) $<my fingerprint>(closed)
959Mar 20 05:38:04.310 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
960Mar 20 05:38:05.338 [info] circuit_finish_handshake(): Finished building circuit hop:
961Mar 20 05:38:05.338 [info] internal circ (length 3, exit <myrelay>): Tonga(open) $D7EF14045DEDAE9E9E61D8CEF0F84F87703AD55D(open) $<my fingerprint>(closed)
962Mar 20 05:38:05.716 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
963Mar 20 05:38:52.780 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 19 (192.108.114.19:9001) [Not in clique mode].
964Mar 20 05:39:01.793 [info] circuit_expire_building(): Abandoning circ 82.94.251.206:443:26814 (state 0:doing handshakes, purpose 17)
965Mar 20 05:39:01.794 [info] internal circ (length 3, exit <myrelay>): Tonga(open) $D7EF14045DEDAE9E9E61D8CEF0F84F87703AD55D(open) $<my fingerprint>(waiting for keys)
966Mar 20 05:39:02.982 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
967Mar 20 05:39:02.983 [info] check_descriptor_bandwidth_changed(): Measured bandwidth has changed; rebuilding descriptor.
968Mar 20 05:39:03.077 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
969Mar 20 05:39:03.077 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
970Mar 20 05:39:03.077 [info] onion_pick_cpath_exit(): Using requested exit node 'moria1'
971Mar 20 05:39:03.114 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'moria1'
972Mar 20 05:39:03.114 [info] connection_ap_make_link(): ... application connection created and linked.
973Mar 20 05:39:03.114 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
974Mar 20 05:39:03.114 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9002 ...
975Mar 20 05:39:03.114 [info] onion_pick_cpath_exit(): Using requested exit node 'moria2'
976Mar 20 05:39:03.151 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'moria2'
977Mar 20 05:39:03.151 [info] connection_ap_make_link(): ... application connection created and linked.
978Mar 20 05:39:03.151 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
979Mar 20 05:39:03.151 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
980Mar 20 05:39:03.152 [info] onion_pick_cpath_exit(): Using requested exit node 'tor26'
981Mar 20 05:39:03.191 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'tor26'
982Mar 20 05:39:03.191 [info] connection_ap_make_link(): ... application connection created and linked.
983Mar 20 05:39:03.191 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
984Mar 20 05:39:03.191 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
985Mar 20 05:39:03.191 [info] onion_pick_cpath_exit(): Using requested exit node 'dizum'
986Mar 20 05:39:03.228 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'dizum'
987Mar 20 05:39:03.228 [info] connection_ap_make_link(): ... application connection created and linked.
988Mar 20 05:39:03.228 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
989Mar 20 05:39:03.229 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9090 ...
990Mar 20 05:39:03.229 [info] onion_pick_cpath_exit(): Using requested exit node 'ides'
991Mar 20 05:39:03.269 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'ides'
992Mar 20 05:39:03.269 [info] connection_ap_make_link(): ... application connection created and linked.
993Mar 20 05:39:03.269 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
994Mar 20 05:39:03.269 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
995Mar 20 05:39:03.269 [info] onion_pick_cpath_exit(): Using requested exit node 'gabelmoo'
996Mar 20 05:39:03.306 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'gabelmoo'
997Mar 20 05:39:03.306 [info] connection_ap_make_link(): ... application connection created and linked.
998Mar 20 05:39:03.306 [info] directory_post_to_dirservers(): Uploading an extrainfo (length 476)
999Mar 20 05:39:03.307 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:443 ...
1000Mar 20 05:39:03.307 [info] onion_pick_cpath_exit(): Using requested exit node 'dannenberg'
1001Mar 20 05:39:03.307 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
1002Mar 20 05:39:03.307 [info] connection_ap_make_link(): ... application connection created and linked.
1003Mar 20 05:39:03.308 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
1004Mar 20 05:39:03.308 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
1005Mar 20 05:39:03.318 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
1006Mar 20 05:39:03.320 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1007Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1008Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1009Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1010Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1011Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1012Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1013Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1014Mar 20 05:39:03.324 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1015Mar 20 05:39:03.325 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1016Mar 20 05:39:03.325 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1017Mar 20 05:39:03.325 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1018Mar 20 05:39:03.325 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1019Mar 20 05:39:03.325 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1020Mar 20 05:39:03.325 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1021Mar 20 05:39:03.454 [info] circuit_finish_handshake(): Finished building circuit hop:
1022Mar 20 05:39:03.454 [info] exit circ (length 1, exit tor26): tor26(open)
1023Mar 20 05:39:03.454 [info] circuit_send_next_onion_skin(): circuit built!
1024Mar 20 05:39:03.455 [info] exit circ (length 1): tor26(open)
1025Mar 20 05:39:03.455 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 14719
1026Mar 20 05:39:03.490 [info] circuit_finish_handshake(): Finished building circuit hop:
1027Mar 20 05:39:03.491 [info] exit circ (length 1, exit moria1): moria1(open)
1028Mar 20 05:39:03.491 [info] circuit_send_next_onion_skin(): circuit built!
1029Mar 20 05:39:03.491 [info] exit circ (length 1): moria1(open)
1030Mar 20 05:39:03.492 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 5717
1031Mar 20 05:39:03.531 [info] circuit_finish_handshake(): Finished building circuit hop:
1032Mar 20 05:39:03.531 [info] exit circ (length 1, exit moria2): moria2(open)
1033Mar 20 05:39:03.531 [info] circuit_send_next_onion_skin(): circuit built!
1034Mar 20 05:39:03.532 [info] exit circ (length 1): moria2(open)
1035Mar 20 05:39:03.532 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 11073
1036Mar 20 05:39:03.570 [info] circuit_finish_handshake(): Finished building circuit hop:
1037Mar 20 05:39:03.570 [info] exit circ (length 1, exit dizum): dizum(open)
1038Mar 20 05:39:03.570 [info] circuit_send_next_onion_skin(): circuit built!
1039Mar 20 05:39:03.570 [info] exit circ (length 1): dizum(open)
1040Mar 20 05:39:03.570 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 1846
1041Mar 20 05:39:03.608 [info] circuit_finish_handshake(): Finished building circuit hop:
1042Mar 20 05:39:03.609 [info] exit circ (length 1, exit gabelmoo): gabelmoo(open)
1043Mar 20 05:39:03.609 [info] circuit_send_next_onion_skin(): circuit built!
1044Mar 20 05:39:03.609 [info] exit circ (length 1): gabelmoo(open)
1045Mar 20 05:39:03.609 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 6389
1046Mar 20 05:39:04.050 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
1047Mar 20 05:39:04.050 [info] exit circ (length 1): tor26(open)
1048Mar 20 05:39:04.086 [info] circuit_finish_handshake(): Finished building circuit hop:
1049Mar 20 05:39:04.087 [info] exit circ (length 1, exit ides): ides(open)
1050Mar 20 05:39:04.087 [info] circuit_send_next_onion_skin(): circuit built!
1051Mar 20 05:39:04.087 [info] exit circ (length 1): ides(open)
1052Mar 20 05:39:04.088 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 44582
1053Mar 20 05:39:04.135 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
1054Mar 20 05:39:04.136 [info] exit circ (length 1): dizum(open)
1055Mar 20 05:39:04.151 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
1056Mar 20 05:39:04.152 [info] exit circ (length 1): gabelmoo(open)
1057Mar 20 05:39:04.168 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
1058Mar 20 05:39:04.168 [info] exit circ (length 1): moria1(open)
1059Mar 20 05:39:04.443 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
1060Mar 20 05:39:04.444 [info] exit circ (length 1): moria2(open)
1061Mar 20 05:39:04.446 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
1062Mar 20 05:39:04.446 [info] exit circ (length 1): ides(open)
1063Mar 20 05:39:04.715 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 42857. Removing stream.
1064Mar 20 05:39:04.716 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1065Mar 20 05:39:04.717 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 56606. Removing stream.
1066Mar 20 05:39:04.717 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1067Mar 20 05:39:04.719 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 50461. Removing stream.
1068Mar 20 05:39:04.719 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1069Mar 20 05:39:04.720 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 26032. Removing stream.
1070Mar 20 05:39:04.720 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1071Mar 20 05:39:04.726 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1072Mar 20 05:39:04.726 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1073Mar 20 05:39:04.726 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1074Mar 20 05:39:04.726 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1075Mar 20 05:39:04.726 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1076Mar 20 05:39:04.727 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1077Mar 20 05:39:04.727 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1078Mar 20 05:39:04.727 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1079Mar 20 05:39:04.853 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1080Mar 20 05:39:04.893 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'vallenator'
1081Mar 20 05:39:04.893 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1082Mar 20 05:39:04.894 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1083Mar 20 05:39:04.933 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'dannenberg'
1084Mar 20 05:39:04.933 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1085Mar 20 05:39:05.070 [info] circuit_finish_handshake(): Finished building circuit hop:
1086Mar 20 05:39:05.070 [info] internal circ (length 3, exit <myrelay>): vallenator(open) wuschelpuschel(closed) $<my fingerprint>(closed)
1087Mar 20 05:39:05.107 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1088Mar 20 05:39:05.239 [info] circuit_finish_handshake(): Finished building circuit hop:
1089Mar 20 05:39:05.240 [info] exit circ (length 1, exit dannenberg): dannenberg(open)
1090Mar 20 05:39:05.240 [info] circuit_send_next_onion_skin(): circuit built!
1091Mar 20 05:39:05.240 [info] exit circ (length 1): dannenberg(open)
1092Mar 20 05:39:05.240 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 37528
1093Mar 20 05:39:05.241 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 20319. Removing stream.
1094Mar 20 05:39:05.241 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1095Mar 20 05:39:05.242 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1096Mar 20 05:39:05.242 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1097Mar 20 05:39:05.315 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
1098Mar 20 05:39:05.315 [info] exit circ (length 1): dannenberg(open)
1099Mar 20 05:39:05.502 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 19062. Removing stream.
1100Mar 20 05:39:05.502 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1101Mar 20 05:39:05.503 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1102Mar 20 05:39:05.503 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1103Mar 20 05:39:05.577 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 8693. Removing stream.
1104Mar 20 05:39:05.577 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1105Mar 20 05:39:05.577 [info] connection_dir_client_reached_eof(): eof (status 200) after uploading server descriptor: finished.
1106Mar 20 05:39:05.578 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1107Mar 20 05:39:51.168 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1108Mar 20 05:39:51.168 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1109Mar 20 05:39:51.393 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1110Mar 20 05:39:51.395 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1111Mar 20 05:39:51.736 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1112Mar 20 05:39:51.738 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1113Mar 20 05:39:51.811 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1114Mar 20 05:39:53.859 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1115Mar 20 05:39:53.860 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1116Mar 20 05:39:54.158 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 17 (85.214.146.160:80) [Not in clique mode].
1117Mar 20 05:40:01.068 [info] exit circ (length 3): atlgonyovLi(open) $8BF67FC634630673AE0BAD2BC4A2399C665B166A(open) FoeBuD3(open)
1118Mar 20 05:40:01.069 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket 17, n_circ_id 27742
1119Mar 20 05:40:01.069 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for connect response' state. Leaving it on buffer.
1120Mar 20 05:40:02.602 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 1 seconds.
1121Mar 20 05:40:02.603 [info] addressmap_register(): Addressmap: (re)mapped '[scrubbed]' to '[scrubbed]'
1122Mar 20 05:40:02.604 [info] exit circ (length 3): atlgonyovLi(open) $8BF67FC634630673AE0BAD2BC4A2399C665B166A(open) FoeBuD3(open)
1123Mar 20 05:40:03.677 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
1124Mar 20 05:40:03.678 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
1125Mar 20 05:40:03.678 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
1126Mar 20 05:40:03.685 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
1127Mar 20 05:40:03.688 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1128Mar 20 05:40:04.737 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1129Mar 20 05:40:04.775 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'mailus'
1130Mar 20 05:40:04.775 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1131Mar 20 05:40:04.981 [info] circuit_finish_handshake(): Finished building circuit hop:
1132Mar 20 05:40:04.981 [info] internal circ (length 3, exit <myrelay>): $100A15645E2B057220D0C53CACD3EDBBABC6E9EA(open) TOTSCHLAGARGUMENT(closed) $<my fingerprint>(closed)
1133Mar 20 05:40:05.019 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1134Mar 20 05:40:05.133 [info] circuit_finish_handshake(): Finished building circuit hop:
1135Mar 20 05:40:05.133 [info] internal circ (length 3, exit <myrelay>): $100A15645E2B057220D0C53CACD3EDBBABC6E9EA(open) TOTSCHLAGARGUMENT(open) $<my fingerprint>(closed)
1136Mar 20 05:40:05.169 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1137Mar 20 05:40:07.875 [info] connection_edge_process_relay_cell(): 17: end cell (closed normally) for stream 60028. Removing stream.
1138Mar 20 05:41:03.642 [info] circuit_expire_building(): Abandoning circ 85.25.144.94:9001:57381 (state 0:doing handshakes, purpose 17)
1139Mar 20 05:41:03.642 [info] internal circ (length 3, exit <myrelay>): $100A15645E2B057220D0C53CACD3EDBBABC6E9EA(open) TOTSCHLAGARGUMENT(open) $<my fingerprint>(waiting for keys)
1140Mar 20 05:41:04.853 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
1141Mar 20 05:41:04.853 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
1142Mar 20 05:41:04.854 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
1143Mar 20 05:41:04.925 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Bellum'
1144Mar 20 05:41:04.926 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1145Mar 20 05:41:04.927 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 9, dropping 3.
1146Mar 20 05:41:05.076 [info] circuit_finish_handshake(): Finished building circuit hop:
1147Mar 20 05:41:05.076 [info] internal circ (length 3, exit <myrelay>): Bellum(open) FSF(closed) $<my fingerprint>(closed)
1148Mar 20 05:41:05.141 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1149Mar 20 05:41:05.879 [info] circuit_finish_handshake(): Finished building circuit hop:
1150Mar 20 05:41:05.880 [info] internal circ (length 3, exit <myrelay>): Bellum(open) FSF(open) $<my fingerprint>(closed)
1151Mar 20 05:41:06.023 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1152Mar 20 05:41:21.129 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1153Mar 20 05:41:21.130 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1154Mar 20 05:41:21.608 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1155Mar 20 05:41:21.608 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1156Mar 20 05:41:22.832 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1157Mar 20 05:41:22.834 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1158Mar 20 05:41:23.238 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1159Mar 20 05:41:26.353 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1160Mar 20 05:41:26.353 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1161Mar 20 05:42:04.470 [info] circuit_expire_building(): Abandoning circ 62.75.223.163:9001:3217 (state 0:doing handshakes, purpose 17)
1162Mar 20 05:42:04.471 [info] internal circ (length 3, exit <myrelay>): Bellum(open) FSF(open) $<my fingerprint>(waiting for keys)
1163Mar 20 05:42:05.660 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
1164Mar 20 05:42:05.661 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
1165Mar 20 05:42:05.661 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
1166Mar 20 05:42:05.705 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'SURFnetTor1'
1167Mar 20 05:42:05.706 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1168Mar 20 05:42:05.809 [info] circuit_finish_handshake(): Finished building circuit hop:
1169Mar 20 05:42:05.809 [info] internal circ (length 3, exit <myrelay>): SURFnetTor1(open) berlinlawl(closed) $<my fingerprint>(closed)
1170Mar 20 05:42:05.845 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1171Mar 20 05:42:16.502 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 47 (128.12.191.32:9001) [Not in clique mode].
1172Mar 20 05:42:46.815 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1173Mar 20 05:42:46.815 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1174Mar 20 05:43:07.074 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
1175Mar 20 05:43:07.074 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
1176Mar 20 05:43:07.075 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
1177Mar 20 05:43:07.145 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'Bellum'
1178Mar 20 05:43:07.146 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1179Mar 20 05:43:07.268 [info] circuit_finish_handshake(): Finished building circuit hop:
1180Mar 20 05:43:07.268 [info] internal circ (length 3, exit <myrelay>): Bellum(open) trusted(closed) $<my fingerprint>(closed)
1181Mar 20 05:43:07.323 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1182Mar 20 05:43:07.621 [info] circuit_finish_handshake(): Finished building circuit hop:
1183Mar 20 05:43:07.621 [info] internal circ (length 3, exit <myrelay>): Bellum(open) trusted(open) $<my fingerprint>(closed)
1184Mar 20 05:43:07.663 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1185Mar 20 05:43:21.548 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1186Mar 20 05:43:21.549 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1187Mar 20 05:43:21.773 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1188Mar 20 05:43:21.774 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1189Mar 20 05:43:22.269 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1190Mar 20 05:43:22.271 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1191Mar 20 05:43:22.357 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1192Mar 20 05:43:23.644 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1193Mar 20 05:43:23.644 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1194Mar 20 05:44:07.437 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 5 wouldnt_use; 0 in progress.
1195Mar 20 05:44:07.439 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1196Mar 20 05:44:07.439 [info] circuit_expire_building(): Abandoning circ 62.75.223.163:9001:3218 (state 0:doing handshakes, purpose 17)
1197Mar 20 05:44:07.440 [info] internal circ (length 3, exit <myrelay>): Bellum(open) trusted(open) $<my fingerprint>(waiting for keys)
1198Mar 20 05:45:08.645 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 0 in progress.
1199Mar 20 05:45:08.646 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1200Mar 20 05:45:08.647 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 9, dropping 1.
1201Mar 20 05:45:34.752 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 50 (149.9.0.58:9001) [Not in clique mode].
1202Mar 20 05:46:10.007 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1198 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 0 in progress.
1203Mar 20 05:46:10.008 [info] launch_router_descriptor_downloads(): There are not many downloadable routerdescs, but we've been waiting long enough (610 seconds). Downloading.
1204Mar 20 05:46:10.008 [info] launch_router_descriptor_downloads(): Launching 1 request for 1 router, 4 at a time
1205Mar 20 05:46:10.010 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
1206Mar 20 05:46:10.010 [info] onion_pick_cpath_exit(): Using requested exit node 'info4all'
1207Mar 20 05:46:10.010 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
1208Mar 20 05:46:10.011 [info] connection_ap_make_link(): ... application connection created and linked.
1209Mar 20 05:46:10.013 [info] routerlist_remove_old_routers(): We have 1276 live routers and 0 old router descriptors.
1210Mar 20 05:46:10.014 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1211Mar 20 05:46:10.014 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1212Mar 20 05:46:10.927 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1213Mar 20 05:46:10.965 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'info4all'
1214Mar 20 05:46:10.965 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1215Mar 20 05:46:11.195 [info] circuit_finish_handshake(): Finished building circuit hop:
1216Mar 20 05:46:11.195 [info] exit circ (length 1, exit info4all): info4all(open)
1217Mar 20 05:46:11.195 [info] circuit_send_next_onion_skin(): circuit built!
1218Mar 20 05:46:11.196 [info] exit circ (length 1): info4all(open)
1219Mar 20 05:46:11.196 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 33828
1220Mar 20 05:46:11.269 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
1221Mar 20 05:46:11.269 [info] exit circ (length 1): info4all(open)
1222Mar 20 05:46:11.539 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 23612. Removing stream.
1223Mar 20 05:46:11.539 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1224Mar 20 05:46:11.541 [info] connection_dir_client_reached_eof(): Received server info (size 1179) from server '81.169.136.161:9001'
1225Mar 20 05:46:11.547 [info] router_load_routers_from_string(): 1 elements to add
1226Mar 20 05:46:11.556 [info] consider_testing_reachability(): Testing bandwidth of my ORPort: xxx.xxx.161.59:9001.
1227Mar 20 05:46:11.557 [info] onion_pick_cpath_exit(): Using requested exit node '<myrelay>'
1228Mar 20 05:46:11.568 [info] circuit_handle_first_hop(): Next router is [scrubbed]: Not connected. Connecting.
1229Mar 20 05:46:11.569 [info] connection_dir_client_reached_eof(): Received 1/1 router descriptors requested from 81.169.136.161:9001
1230Mar 20 05:46:11.569 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1231Mar 20 05:46:12.472 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:8463; sending NETINFO.
1232Mar 20 05:46:12.512 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'bellerophontes'
1233Mar 20 05:46:12.513 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:8463; OR connection is now open, using protocol version 2
1234Mar 20 05:46:12.734 [info] circuit_finish_handshake(): Finished building circuit hop:
1235Mar 20 05:46:12.734 [info] internal circ (length 3, exit <myrelay>): bellerophontes(open) SURFnetTor1(closed) $<my fingerprint>(closed)
1236Mar 20 05:46:12.770 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1237Mar 20 05:46:12.907 [info] circuit_finish_handshake(): Finished building circuit hop:
1238Mar 20 05:46:12.907 [info] internal circ (length 3, exit <myrelay>): bellerophontes(open) SURFnetTor1(open) $<my fingerprint>(closed)
1239Mar 20 05:46:12.944 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1240Mar 20 05:46:13.246 [info] circuit_finish_handshake(): Finished building circuit hop:
1241Mar 20 05:46:13.246 [info] internal circ (length 3, exit <myrelay>): bellerophontes(open) SURFnetTor1(open) $<my fingerprint>(open)
1242Mar 20 05:46:13.246 [info] circuit_send_next_onion_skin(): circuit built!
1243Mar 20 05:46:13.246 [notice] Performing bandwidth self-test...done.
1244Mar 20 05:47:09.330 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1245Mar 20 05:47:09.330 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1246Mar 20 05:47:09.560 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1247Mar 20 05:47:09.561 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1248Mar 20 05:47:09.916 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1249Mar 20 05:47:09.922 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1250Mar 20 05:47:10.436 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 0 in progress.
1251Mar 20 05:47:10.437 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1252Mar 20 05:47:10.438 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1253Mar 20 05:47:13.771 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1254Mar 20 05:47:13.771 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1255Mar 20 05:48:11.743 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 0 in progress.
1256Mar 20 05:48:11.745 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1257Mar 20 05:48:11.746 [info] buf_shrink_freelists(): Cleaning freelist for 4096-byte chunks: keeping 9, dropping 27.
1258Mar 20 05:49:12.621 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 4 wouldnt_use; 0 in progress.
1259Mar 20 05:49:12.624 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1260Mar 20 05:49:24.349 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1261Mar 20 05:49:24.349 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1262Mar 20 05:49:25.044 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1263Mar 20 05:49:25.044 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1264Mar 20 05:49:26.287 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1265Mar 20 05:49:26.292 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1266Mar 20 05:49:27.411 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1267Mar 20 05:49:33.415 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1268Mar 20 05:49:33.416 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1269Mar 20 05:49:34.836 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 57 (173.67.101.107:443) [Not in clique mode].
1270Mar 20 05:50:01.927 [info] circuit_predict_and_launch_new(): Have 3 clean circs (2 internal), need another exit circ.
1271Mar 20 05:50:01.931 [info] choose_good_exit_server_general(): Found 557 servers that might support 0/0 pending connections.
1272Mar 20 05:50:01.935 [info] choose_good_exit_server_general(): Chose exit server 'desync'
1273Mar 20 05:50:01.976 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'atlgonyovLi'
1274Mar 20 05:50:02.332 [info] circuit_finish_handshake(): Finished building circuit hop:
1275Mar 20 05:50:02.332 [info] exit circ (length 3, exit desync): atlgonyovLi(open) $AC89E1B0E61BC990E585EF8A8FD68FDFDCBE4AFA(closed) desync(closed)
1276Mar 20 05:50:02.370 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1277Mar 20 05:50:04.340 [info] circuit_finish_handshake(): Finished building circuit hop:
1278Mar 20 05:50:04.340 [info] exit circ (length 3, exit desync): atlgonyovLi(open) $AC89E1B0E61BC990E585EF8A8FD68FDFDCBE4AFA(open) desync(closed)
1279Mar 20 05:50:04.383 [info] circuit_send_next_onion_skin(): Sending extend relay cell.
1280Mar 20 05:50:06.390 [info] circuit_finish_handshake(): Finished building circuit hop:
1281Mar 20 05:50:06.390 [info] exit circ (length 3, exit desync): atlgonyovLi(open) $AC89E1B0E61BC990E585EF8A8FD68FDFDCBE4AFA(open) desync(open)
1282Mar 20 05:50:06.390 [info] circuit_send_next_onion_skin(): circuit built!
1283Mar 20 05:50:13.760 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1284Mar 20 05:50:13.761 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1285Mar 20 05:50:59.088 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 46 (82.94.251.204:443) [Not in clique mode].
1286Mar 20 05:51:14.376 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1287Mar 20 05:51:14.377 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1288Mar 20 05:51:50.096 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1289Mar 20 05:51:50.096 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1290Mar 20 05:51:50.335 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1291Mar 20 05:51:50.335 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1292Mar 20 05:51:50.794 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1293Mar 20 05:51:50.796 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:8192; sending NETINFO.
1294Mar 20 05:51:50.905 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:8192; OR connection is now open, using protocol version 2
1295Mar 20 05:51:52.953 [info] connection_close_immediate(): fd 46, type OR, state open, 512 bytes on outbuf.
1296Mar 20 05:52:15.735 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1297Mar 20 05:52:15.736 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1298Mar 20 05:53:16.834 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1299Mar 20 05:53:16.837 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1300Mar 20 05:54:17.438 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1301Mar 20 05:54:17.440 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1302Mar 20 05:55:18.657 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1303Mar 20 05:55:18.658 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1304Mar 20 05:55:48.994 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1305Mar 20 05:55:48.995 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1306Mar 20 05:55:49.344 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1307Mar 20 05:55:49.344 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1308Mar 20 05:55:50.291 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1309Mar 20 05:55:50.294 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:443; sending NETINFO.
1310Mar 20 05:55:50.497 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:443; OR connection is now open, using protocol version 2
1311Mar 20 05:56:20.097 [info] update_consensus_router_descriptor_downloads(): 1 router descriptors downloadable. 0 delayed; 1199 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1312Mar 20 05:56:20.098 [info] launch_router_descriptor_downloads(): There are not many downloadable routerdescs, but we've been waiting long enough (610 seconds). Downloading.
1313Mar 20 05:56:20.098 [info] launch_router_descriptor_downloads(): Launching 1 request for 1 router, 4 at a time
1314Mar 20 05:56:20.100 [info] connection_ap_make_link(): Making internal direct tunnel to [scrubbed]:9001 ...
1315Mar 20 05:56:20.100 [info] onion_pick_cpath_exit(): Using requested exit node 'MopperSmurf'
1316Mar 20 05:56:20.139 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'MopperSmurf'
1317Mar 20 05:56:20.139 [info] connection_ap_make_link(): ... application connection created and linked.
1318Mar 20 05:56:20.140 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1319Mar 20 05:56:20.142 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1320Mar 20 05:56:20.142 [info] connection_edge_process_inbuf(): data from edge while in 'waiting for circuit' state. Leaving it on buffer.
1321Mar 20 05:56:20.266 [info] circuit_finish_handshake(): Finished building circuit hop:
1322Mar 20 05:56:20.267 [info] exit circ (length 1, exit MopperSmurf): MopperSmurf(open)
1323Mar 20 05:56:20.267 [info] circuit_send_next_onion_skin(): circuit built!
1324Mar 20 05:56:20.267 [info] exit circ (length 1): MopperSmurf(open)
1325Mar 20 05:56:20.267 [info] connection_ap_handshake_send_begin(): Address/port sent, ap socket -1, n_circ_id 1120
1326Mar 20 05:56:20.320 [info] connection_edge_process_relay_cell_not_open(): 'connected' received after 0 seconds.
1327Mar 20 05:56:20.321 [info] exit circ (length 1): MopperSmurf(open)
1328Mar 20 05:56:20.586 [info] connection_edge_process_relay_cell(): -1: end cell (closed normally) for stream 4048. Removing stream.
1329Mar 20 05:56:20.587 [info] _connection_free(): Freeing linked Socks connection [open] with 0 bytes on inbuf, 0 on outbuf.
1330Mar 20 05:56:20.588 [info] connection_dir_client_reached_eof(): Received server info (size 1156) from server '192.150.94.83:9001'
1331Mar 20 05:56:20.591 [info] router_load_routers_from_string(): 1 elements to add
1332Mar 20 05:56:20.605 [info] connection_dir_client_reached_eof(): Received 1/1 router descriptors requested from 192.150.94.83:9001
1333Mar 20 05:56:20.605 [info] _connection_free(): Freeing linked Directory connection [client finished] with 0 bytes on inbuf, 0 on outbuf.
1334Mar 20 05:56:30.922 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 17 (85.214.58.87:443) [Not in clique mode].
1335Mar 20 05:56:53.205 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 45 (156.56.103.103:9001) [Not in clique mode].
1336Mar 20 05:57:19.594 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1337Mar 20 05:57:19.594 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1338Mar 20 05:57:19.803 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher called 'DHE-DSS-AES256-SHA'
1339Mar 20 05:57:19.804 [info] tor_tls_client_is_using_v2_ciphers(): Got a non-version-1 cipher list from [scrubbed].  It is: 'DHE-RSA-AES256-SHA:DHE-DSS-AES256-SHA:AES256-SHA:DHE-RSA-AES128-SHA:DHE-DSS-AES128-SHA:RC4-MD5:RC4-SHA:AES128-SHA:EDH-RSA-DES-CBC3-SHA:EDH-DSS-DES-CBC3-SHA:DES-CBC3-SHA'
1340Mar 20 05:57:20.160 [info] tor_tls_read(): Got a TLS renegotiation from [scrubbed]
1341Mar 20 05:57:20.164 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1342Mar 20 05:57:20.231 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1343Mar 20 05:57:20.741 [info] update_consensus_router_descriptor_downloads(): 0 router descriptors downloadable. 0 delayed; 1200 present (0 of those were in old_routers); 0 would_reject; 3 wouldnt_use; 0 in progress.
1344Mar 20 05:57:20.742 [info] routerlist_remove_old_routers(): We have 1277 live routers and 0 old router descriptors.
1345Mar 20 05:57:22.637 [info] command_process_versions_cell(): Negotiated version 2 with [scrubbed]:9001; sending NETINFO.
1346Mar 20 05:57:22.637 [info] command_process_netinfo_cell(): Got good NETINFO cell from [scrubbed]:9001; OR connection is now open, using protocol version 2
1347Mar 20 05:57:45.630 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 26 (212.117.165.80:9001) [Not in clique mode].
1348Mar 20 05:57:55.709 [info] run_connection_housekeeping(): Expiring non-used OR connection to fd 61 (91.143.91.111:443) [Not in clique mode].