[tor-bugs] #21312 [Obfuscation/Snowflake]: snowflake-client is pegged at 100% cpu

Tor Bug Tracker & Wiki blackhole at torproject.org
Tue Mar 13 18:44:24 UTC 2018


#21312: snowflake-client is pegged at 100% cpu
-----------------------------------+--------------------------------
 Reporter:  arlolra                |          Owner:  arlolra
     Type:  defect                 |         Status:  needs_revision
 Priority:  High                   |      Milestone:
Component:  Obfuscation/Snowflake  |        Version:
 Severity:  Major                  |     Resolution:
 Keywords:                         |  Actual Points:
Parent ID:                         |         Points:
 Reviewer:                         |        Sponsor:
-----------------------------------+--------------------------------
Changes (by dcf):

 * status:  needs_review => needs_revision


Comment:

 Replying to [comment:28 dcf]:
 > So, is the last thing needed for this ticket a patch for server-webrtc?
 Here's a stab at it.

 Stand by. The server-webrtc process stopped running for some reason. I'm
 not sure if it's related to the patch or not. I'll try running it again
 with a debugger attached.

 The last messages in the server-webrtc log:
 {{{
 2018/03/13 03:27:19 sdp offer successfully received.
 2018/03/13 03:27:19 Generating answer...
 2018/03/13 03:27:19 answering HTTP POST
 2018/03/13 03:27:19 OnDataChannel
 2018/03/13 03:27:19 OnOpen channel
 2018/03/13 03:27:25 Write 543 bytes --> WebRTC
 }}}

 The last messages in the client log:
 {{{
 2018/03/13 03:27:19 WebRTC: DataChannel.OnOpen
 2018/03/13 03:27:20 Traffic Bytes (in|out): 1086 | 1086 -- (2 OnMessages,
 2 Sends)
 2018/03/13 03:27:29 WebRTC: At capacity [3/3]  Retrying in 10 seconds...
 2018/03/13 03:27:30 Traffic Bytes (in|out): 0 | 543 -- (0 OnMessages, 1
 Sends)
 2018/03/13 03:27:39 WebRTC: No messages received for 30 seconds -- closing
 stale connection.
 2018/03/13 03:27:39 WebRTC: closing DataChannel
 2018/03/13 03:27:39 WebRTC: DataChannel.OnClose [locally]
 2018/03/13 03:27:39 WebRTC: closing PeerConnection
 2018/03/13 03:27:39 WebRTC: Closing
 2018/03/13 03:27:39 WebRTC: Collecting a new Snowflake. Currently at [2/3]
 2018/03/13 03:27:39 snowflake-6UnoOk512PFjOuaU  connecting...
 2018/03/13 03:27:39 WebRTC: PeerConnection created.
 2018/03/13 03:27:39 WebRTC: OnNegotiationNeeded
 2018/03/13 03:27:39 WebRTC: DataChannel created.
 2018/03/13 03:27:39 candidate:1749024283 1 udp 2122260223 X.X.X.X 57098
 typ host generation 0 ufrag GUHO network-id 1 network-cost 50
 2018/03/13 03:27:39 candidate:649855723 1 tcp 1518280447 X.X.X.X 33197 typ
 host tcptype passive generation 0 ufrag GUHO network-id 1 network-cost 50
 2018/03/13 03:27:39 WebRTC: OnIceComplete
 2018/03/13 03:27:39 Negotiating via BrokerChannel...
 Target URL:
 Front URL:   127.0.0.1:8080
 2018/03/13 03:27:39 http://127.0.0.1:8080/client
 2018/03/13 03:27:39 "http://127.0.0.1:8080/client"
 2018/03/13 03:27:39 BrokerChannel Error: dial tcp 127.0.0.1:8080:
 getsockopt: connection refused
 2018/03/13 03:27:39 Failed to retrieve answer. Retrying in 10 seconds
 2018/03/13 03:27:41 Traffic Bytes (in|out): 0 | 543 -- (0 OnMessages, 1
 Sends)
 2018/03/13 03:27:46 WebRTC: No messages received for 30 seconds -- closing
 stale connection.
 2018/03/13 03:27:46 WebRTC: closing DataChannel
 2018/03/13 03:27:46 WebRTC: DataChannel.OnClose [locally]
 2018/03/13 03:27:46 WebRTC: closing PeerConnection
 2018/03/13 03:27:46 WebRTC: Closing
 2018/03/13 03:27:46 copy loop ended
 2018/03/13 03:27:46 ---- Handler: closed ---
 2018/03/13 03:27:46 SOCKS listening...
 2018/03/13 03:27:46 SOCKS accepted:  {0.0.3.0:1   map[]}
 2018/03/13 03:27:46 ---- Handler: snowflake assigned ----
 2018/03/13 03:27:49 WebRTC: No messages received for 30 seconds -- closing
 stale connection.
 2018/03/13 03:27:49 WebRTC: closing DataChannel
 2018/03/13 03:27:49 WebRTC: DataChannel.OnClose [locally]
 2018/03/13 03:27:49 WebRTC: closing PeerConnection
 2018/03/13 03:27:49 WebRTC: Closing
 2018/03/13 03:27:49 copy loop ended
 2018/03/13 03:27:49 ---- Handler: closed ---
 2018/03/13 03:27:49 SOCKS listening...
 2018/03/13 03:27:49 Negotiating via BrokerChannel...
 Target URL:
 Front URL:   127.0.0.1:8080
 2018/03/13 03:27:49 http://127.0.0.1:8080/client
 2018/03/13 03:27:49 "http://127.0.0.1:8080/client"
 2018/03/13 03:27:49 BrokerChannel Error: dial tcp 127.0.0.1:8080:
 getsockopt: connection refused
 2018/03/13 03:27:49 Failed to retrieve answer. Retrying in 10 seconds
 2018/03/13 03:27:51 Traffic Bytes (in|out): 0 | 190 -- (0 OnMessages, 1
 Sends)
 2018/03/13 03:27:59 Negotiating via BrokerChannel...
 Target URL:
 Front URL:   127.0.0.1:8080
 2018/03/13 03:27:59 http://127.0.0.1:8080/client
 2018/03/13 03:27:59 "http://127.0.0.1:8080/client"
 2018/03/13 03:27:59 BrokerChannel Error: dial tcp 127.0.0.1:8080:
 getsockopt: connection refused
 2018/03/13 03:27:59 Failed to retrieve answer. Retrying in 10 seconds
 }}}
 (Then it repeats with further getsockopt errors.)

--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/21312#comment:29>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online


More information about the tor-bugs mailing list