[Author Prev][Author Next][Thread Prev][Thread Next][Author Index][Thread Index]

Re: [tor-bugs] #30628 [Core Tor/Tor]: sendme closes client connections



#30628: sendme closes client connections
-------------------------------------------------+-------------------------
 Reporter:  traumschule                          |          Owner:  dgoulet
     Type:  defect                               |         Status:
                                                 |  assigned
 Priority:  Medium                               |      Milestone:  Tor:
                                                 |  0.4.1.x-final
Component:  Core Tor/Tor                         |        Version:
 Severity:  Normal                               |     Resolution:
 Keywords:  sendme, tor-flowctrl, 041-must       |  Actual Points:
  041-regression regression                      |
Parent ID:                                       |         Points:
 Reviewer:                                       |        Sponsor:
-------------------------------------------------+-------------------------

Comment (by adYpc):

 Here some more lines from info-level logging output:

 {{{
 rend_service_rendezvous_has_opened(): Done building circuit 3070116516 to
 rendezvous with cookie 2B7FE4B3 for service my6v3xxi2vmukctc
 internal (high-uptime) circ (length 4):
 $E86B22596DC9439B6B8DDE9599F23A02E206383B(open)
 $BD2CAAF6CA982D8B0BF73C7EA3E243F30AE9F042(open)
 $49C343884F3DC2E85CB3F847902A8018124371EB(open)
 $2F09BD6D9A2D5A7D6D26C17651CE8ECF0B7BA257(open)
 rep_hist_note_used_internal(): New port prediction added. Will continue
 predictive circ building for 2617 more seconds.
 circuit_predict_and_launch_new(): Have 4 clean circs (2 internal), need
 another internal circ for my hidden service.
 origin_circuit_new(): Circuit 23 chose an idle timeout of 2729 based on
 2617 seconds of predictive building remaining.
 extend_info_from_node(): Including Ed25519 ID for
 $7524D5503DB794914A917F57B91555E62E034E87~Unnamed at 176.9.92.184
 select_primary_guard_for_circuit(): Selected primary guard dvbhorst
 ($E86B22596DC9439B6B8DDE9599F23A02E206383B) for circuit.
 extend_info_from_node(): Including Ed25519 ID for
 $E86B22596DC9439B6B8DDE9599F23A02E206383B~dvbhorst at 195.201.138.156
 extend_info_from_node(): Including Ed25519 ID for
 $66CA5474346F35E375C4D4514C51A540545347EE~ToolspireRelay at 138.201.83.171
 circuit_send_first_onion_skin(): First hop: finished sending CREATE cell
 to '$E86B22596DC9439B6B8DDE9599F23A02E206383B~dvbhorst at 195.201.138.156'
 connection_edge_finished_connecting(): Exit connection to [scrubbed]:7805
 ([scrubbed]) established.
 circuit_finish_handshake(): Finished building circuit hop:
 internal (high-uptime) circ (length 3, last hop Unnamed):
 $E86B22596DC9439B6B8DDE9599F23A02E206383B(open)
 $66CA5474346F35E375C4D4514C51A540545347EE(closed)
 $7524D5503DB794914A917F57B91555E62E034E87(closed)
 circuit_send_intermediate_onion_skin(): Sending extend relay cell.
 entry_guard_inc_circ_attempt_count(): Got success count
 180.000000/182.000000 for guard dvbhorst
 ($E86B22596DC9439B6B8DDE9599F23A02E206383B)
 circuit_finish_handshake(): Finished building circuit hop:
 internal (high-uptime) circ (length 3, last hop Unnamed):
 $E86B22596DC9439B6B8DDE9599F23A02E206383B(open)
 $66CA5474346F35E375C4D4514C51A540545347EE(open)
 $7524D5503DB794914A917F57B91555E62E034E87(closed)
 circuit_send_intermediate_onion_skin(): Sending extend relay cell.
 circuit_finish_handshake(): Finished building circuit hop:
 internal (high-uptime) circ (length 3, last hop Unnamed):
 $E86B22596DC9439B6B8DDE9599F23A02E206383B(open)
 $66CA5474346F35E375C4D4514C51A540545347EE(open)
 $7524D5503DB794914A917F57B91555E62E034E87(open)
 circuit_build_times_get_xm(): Xm mode #0: 475 36
 circuit_build_times_set_timeout(): Set buildtimeout to low value
 935.337593ms. Setting to 1500ms
 circuit_build_times_set_timeout(): Set circuit build timeout to 2s
 (1500.000000ms, 60000.000000ms, Xm: 475, a: 2.375229, r: 0.110092) based
 on 327 circuit times
 entry_guards_note_guard_success(): Recorded success for primary confirmed
 guard dvbhorst ($E86B22596DC9439B6B8DDE9599F23A02E206383B)
 circuit_build_no_more_hops(): circuit built!
 pathbias_count_build_success(): Got success count 181.000000/182.000000
 for guard dvbhorst ($E86B22596DC9439B6B8DDE9599F23A02E206383B)
 connection_handle_listener_read(): New SOCKS connection opened from
 127.0.0.1.
 connection_ap_handle_onion(): Got a hidden service request for ID
 '[scrubbed]'
 rep_hist_note_used_internal(): New port prediction added. Will continue
 predictive circ building for 2617 more seconds.
 connection_ap_handle_onion(): Descriptor is here. Great.
 connection_edge_process_inbuf(): data from edge while in 'waiting for
 circuit' state. Leaving it on buffer.
 connection_ap_handshake_attach_circuit(): rend joined circ 4266353635 (id:
 16) already here. Attaching. (stream 0 sec old)
 pathbias_count_use_attempt(): Used circuit 16 is already in path state use
 succeeded. Circuit is a Hidden service client: Active rendezvous point
 currently open.
 rend_client_note_connection_attempt_ended(): Connection attempt for
 [scrubbed] has ended; cleaning up temporary state.
 link_apconn_to_circ(): Looks like completed circuit to hidden service does
 allow optimistic data for connection to [scrubbed]
 connection_ap_handshake_send_begin(): Sending relay cell 0 on circ
 4266353635 to begin stream 5625.
 connection_ap_handshake_send_begin(): Address/port sent, ap socket 12,
 n_circ_id 4266353635
 connection_edge_process_relay_cell_not_open(): 'connected' received for
 circid 4266353635 streamid 5625 after 0 seconds.
 internal (high-uptime) circ (length 3):
 $E86B22596DC9439B6B8DDE9599F23A02E206383B(open)
 $5AD4E3F36B803500AE5A724ACD4A3BCCE3BEFA14(open)
 $58FC2AAB3792AC37897D34331F4F4E00341DEC0C(open)
 sendme_process_stream_level(): Unexpected stream sendme cell. Closing circ
 (window 500).
 command_process_relay_cell(): circuit_receive_relay_cell (backward)
 failed. Closing.
 circuit_mark_for_close_(): Circuit 3070116516 (id: 20) marked for close at
 src/core/or/command.c:582 (orig reason: 1, new reason: 0)
 connection_edge_destroy(): CircID 0: At an edge. Marking connection for
 close.
 circuit_free_(): Circuit 0 (id: 20) has been freed.
 connection_edge_reached_eof(): conn (fd 12) reached eof. Closing.
 connection_edge_reached_eof(): conn (fd 10) reached eof. Closing.
 }}}

--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/30628#comment:11>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online
_______________________________________________
tor-bugs mailing list
tor-bugs@xxxxxxxxxxxxxxxxxxxx
https://lists.torproject.org/cgi-bin/mailman/listinfo/tor-bugs