Skip to content

Instantly share code, notes, and snippets.

@mondain

mondain/gist:983892136d64975c9871c6ecedda7a29

Created July 8, 2017 02:45
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save mondain/983892136d64975c9871c6ecedda7a29 to your computer and use it in GitHub Desktop.
Save mondain/983892136d64975c9871c6ecedda7a29 to your computer and use it in GitHub Desktop.
Download ZIP
ConnectivityCheckServer - Failed to send BINDING-RESPONSE(0x101)
Raw
gistfile1.txt
UA: Edge on Win
2017-07-07 19:02:19,248 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Offer: v=0
o=thisisadapterortc 3579037566002956 2 IN IP4 127.0.0.1
s=-
t=0 0
a=msid-semantic:WMS *
a=group:BUNDLE 9wj9mdiaks 0k3vfndwv6
a=ice-options:trickle
m=audio 9 UDP/TLS/RTP/SAVPF 104 102 9 0 8 103 97 13 118 101
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=rtpmap:104 SILK/16000
a=rtcp-fb:104 x-message app send:dsh recv:dsh
a=rtpmap:102 opus/48000/2
a=rtcp-fb:102 x-message app send:dsh recv:dsh
a=rtpmap:9 G722/8000
a=rtcp-fb:9 x-message app send:dsh recv:dsh
a=rtpmap:0 PCMU/8000
a=rtcp-fb:0 x-message app send:dsh recv:dsh
a=rtpmap:8 PCMA/8000
a=rtcp-fb:8 x-message app send:dsh recv:dsh
a=rtpmap:103 SILK/8000
a=rtcp-fb:103 x-message app send:dsh recv:dsh
a=rtpmap:97 RED/8000
a=rtpmap:13 CN/8000
a=rtpmap:118 CN/16000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 events=0-16
a=maxptime:100
a=rtcp-mux
a=extmap:1 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3 http://skype.com/experiments/rtp-hdrext/fast_bandwidth_feedback#version_2
a=ice-ufrag:j7M0
a=ice-pwd:K4IgBQiQVbqxRY5op+CNfYJH
a=setup:actpass
a=fingerprint:sha-256 D2:03:51:B2:F2:CA:BE:B7:15:B8:B9:54:90:EE:0B:AF:77:69:8C:7A:2B:71:70:CE:61:4D:EA:5A:3D:17:B1:07
a=mid:9wj9mdiaks
a=sendrecv
a=msid:6AA6BB6D-3A11-4232-90E1-AD638EC8BC20 812DAC2E-7165-498D-BEBB-C43C0ADEA53A
a=ssrc:1001 msid:6AA6BB6D-3A11-4232-90E1-AD638EC8BC20 812DAC2E-7165-498D-BEBB-C43C0ADEA53A
a=ssrc:1001 cname:d8347prl2j
a=rtcprsize
m=video 9 UDP/TLS/RTP/SAVPF 122 107 100 99 96 123
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=rtpmap:122 X-H264UC/90000
a=fmtp:122 packetization-mode=1;mst-mode=NI-TC
a=rtcp-fb:122 x-message app send:src,x-pli recv:src,x-pli
a=rtpmap:107 H264/90000
a=fmtp:107 profile-level-id=42C02A;packetization-mode=1;level-asymmetry-allowed=1
a=rtcp-fb:107 nack
a=rtcp-fb:107 nack pli
a=rtcp-fb:107 goog-remb
a=rtpmap:100 VP8/90000
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=rtcp-fb:100 goog-remb
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=107;rtx-time=3000
a=rtpmap:96 rtx/90000
a=fmtp:96 apt=100;rtx-time=3000
a=rtpmap:123 x-ulpfecuc/90000
a=rtcp-mux
a=extmap:1 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3 http://skype.com/experiments/rtp-hdrext/fast_bandwidth_feedback#version_2
a=ice-ufrag:Jcst
a=ice-pwd:YUjfTwRExvv9B1oHa3MJjSjT
a=setup:actpass
a=fingerprint:sha-256 40:7B:54:B7:49:0F:29:8A:57:2F:DD:A6:51:A2:A1:C1:86:73:5E:45:90:FC:93:4C:02:07:98:BF:B1:AE:74:AA
a=mid:0k3vfndwv6
a=sendrecv
a=msid:6AA6BB6D-3A11-4232-90E1-AD638EC8BC20 05D60A23-776B-4FAF-8006-B194D80FC7E9
a=ssrc:3003 msid:6AA6BB6D-3A11-4232-90E1-AD638EC8BC20 05D60A23-776B-4FAF-8006-B194D80FC7E9
a=ssrc:3004 msid:6AA6BB6D-3A11-4232-90E1-AD638EC8BC20 05D60A23-776B-4FAF-8006-B194D80FC7E9
a=ssrc-group:FID 3003 3004
a=ssrc:3003 cname:d8347prl2j
a=ssrc:3004 cname:d8347prl2j
a=rtcprsize
2017-07-07 19:02:19,256 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - setupDTLS control: passive
2017-07-07 19:02:20,075 [NioProcessor-18] INFO c.r.webrtc.stream.RTCSourceStream - setupICE - name: stream1 controlling: false
2017-07-07 19:02:20,084 [NioProcessor-18] INFO c.r.webrtc.stream.RTCSourceStream - ICE total harvest time: 0 ms
2017-07-07 19:02:20,084 [NioProcessor-18] INFO c.r.webrtc.stream.RTCSourceStream - org.ice4j.ice.harvest.MappingCandidateHarvester, face=/127.0.1.1, mask=/101.1.144.101: time=0ms harvests=0 candidates=0
2017-07-07 19:02:20,084 [NioProcessor-18] INFO c.r.webrtc.stream.RTCSourceStream - STUN harvester(srvr: 173.194.202.127:19302/udp): time=0ms harvests=0 candidates=0
2017-07-07 19:02:20,091 [NioProcessor-18] INFO org.ice4j.ice.Agent - Gathering candidates for component media-0.RTP. Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:20,095 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Harvesting for rtp via org.ice4j.ice.harvest.MappingCandidateHarvester, face=/127.0.1.1, mask=/101.1.144.101
2017-07-07 19:02:20,095 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Harvesting for rtp via STUN harvester(srvr: 173.194.202.127:19302/udp)
2017-07-07 19:02:20,139 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Harvested candidates: [candidate:2 1 udp 1694498815 101.1.144.101 49152 typ srflx raddr 10.0.0.5 rport 49152]
2017-07-07 19:02:20,139 [NioProcessor-18] INFO c.r.webrtc.stream.RTCSourceStream - Overriding local IP with candidate host address: 10.0.0.5
2017-07-07 19:02:20,139 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - setRemoteProperties: 9wj9mdiaks media-0
2017-07-07 19:02:20,159 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Generated answer: v=0
o=red5pro_stream1 9423616738532 3 IN IP4 0.0.0.0
s=-
t=0 0
a=msid-semantic:WMS *
a=group:BUNDLE 9wj9mdiaks 0k3vfndwv6
a=ice-options:trickle
m=audio 9 UDP/TLS/RTP/SAVPF 102
c=IN IP4 101.1.144.101
b=AS:64
a=rtpmap:102 opus/48000/2
a=ice-ufrag:e1s7k1bkfutt1i
a=ice-pwd:3mm0nd533kvrm99uq218tdc5j4
a=fingerprint:sha-256 04:82:AB:E3:FD:52:AB:AC:68:7B:E9:D6:02:A8:69:2E:67:B1:06:8E:B4:26:8F:61:95:69:4B:00:48:81:ED:6D
a=setup:passive
a=mid:9wj9mdiaks
a=recvonly
a=rtcp-mux
m=video 9 UDP/TLS/RTP/SAVPF 107
c=IN IP4 101.1.144.101
b=AS:256
a=rtpmap:107 H264/90000
a=fmtp:107 profile-level-id=42e01f;level-asymmetry-allowed=1;packetization-mode=1
a=ice-ufrag:e1s7k1bkfutt1i
a=ice-pwd:3mm0nd533kvrm99uq218tdc5j4
a=fingerprint:sha-256 04:82:AB:E3:FD:52:AB:AC:68:7B:E9:D6:02:A8:69:2E:67:B1:06:8E:B4:26:8F:61:95:69:4B:00:48:81:ED:6D
a=setup:passive
a=mid:0k3vfndwv6
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=recvonly
a=rtcp-mux
a=rtcp-fb:107 nack
a=rtcp-fb:107 nack pli
2017-07-07 19:02:20,160 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Local candidate: candidate:1 1 udp 2130706431 10.0.0.5 49152 typ host
2017-07-07 19:02:20,160 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Local candidate: candidate:2 1 udp 1694498815 101.1.144.101 49152 typ srflx raddr 10.0.0.5 rport 49152
2017-07-07 19:02:20,160 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Local candidate: candidate:2 1 udp 1694498815 101.1.144.101 49152 typ srflx raddr 10.0.0.5 rport 49152
2017-07-07 19:02:20,160 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Local candidate results: [media-0@candidate:1 1 udp 2130706431 10.0.0.5 49152 typ host, media-0@candidate:2 1 udp 1694498815 101.1.144.101 49152 typ srflx raddr 10.0.0.5 rport 49152]
2017-07-07 19:02:20,161 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - setRemoteICECandidates mlineIndex: 0 candidate:1 1 UDP 2130706431 192.168.0.171 54672 typ host
2017-07-07 19:02:20,162 [NioProcessor-18] INFO org.ice4j.ice.Component - Add remote candidate for media-0.RTP: 192.168.0.171:54672/udp/host
2017-07-07 19:02:20,162 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Remote candidates at 0: [candidate:1 1 udp 2130706431 192.168.0.171 54672 typ host]
2017-07-07 19:02:20,162 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - setRemoteICECandidates mlineIndex: 1 candidate:1 1 UDP 2130706431 192.168.0.171 51752 typ host
2017-07-07 19:02:20,162 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - No ICE stream for index: 1
2017-07-07 19:02:20,204 [Stun4J Message Processor] INFO o.ice4j.ice.ConnectivityCheckServer - Failed to send BINDING-RESPONSE(0x101)[attrib.count=3 len=60] through 10.0.0.5:49152/udp
org.ice4j.StunException: The transaction specified in the response (tid=0x8FE41855C3FA034AFD3CA95A) has already seen a previous response. Response was:
BINDING-ERROR-RESPONSE(0x111)[attrib.count=4 len=68 tranID=0x8FE41855C3FA034AFD3CA95A]
at org.ice4j.stack.StunStack.sendResponse(StunStack.java:767)
at org.ice4j.ice.ConnectivityCheckServer.processRequest(ConnectivityCheckServer.java:214)
at org.ice4j.stack.EventDispatcher$RequestListenerMessageEventHandler.handleMessageEvent(EventDispatcher.java:511)
at org.ice4j.stack.EventDispatcher.fireMessageEvent(EventDispatcher.java:268)
at org.ice4j.stack.StunStack.handleMessageEvent(StunStack.java:987)
at org.ice4j.stack.MessageProcessor.run(MessageProcessor.java:171)
at java.lang.Thread.run(Thread.java:748)
2017-07-07 19:02:20,205 [Stun4J Message Processor] INFO org.ice4j.stack.StunStack - Received an invalid request.
java.lang.RuntimeException: Failed to send a response
at org.ice4j.ice.ConnectivityCheckServer.processRequest(ConnectivityCheckServer.java:226)
at org.ice4j.stack.EventDispatcher$RequestListenerMessageEventHandler.handleMessageEvent(EventDispatcher.java:511)
at org.ice4j.stack.EventDispatcher.fireMessageEvent(EventDispatcher.java:268)
at org.ice4j.stack.StunStack.handleMessageEvent(StunStack.java:987)
at org.ice4j.stack.MessageProcessor.run(MessageProcessor.java:171)
at java.lang.Thread.run(Thread.java:748)
Caused by: org.ice4j.StunException: The transaction specified in the response (tid=0x8FE41855C3FA034AFD3CA95A) has already seen a previous response. Response was:
BINDING-ERROR-RESPONSE(0x111)[attrib.count=4 len=68 tranID=0x8FE41855C3FA034AFD3CA95A]
at org.ice4j.stack.StunStack.sendResponse(StunStack.java:767)
at org.ice4j.ice.ConnectivityCheckServer.processRequest(ConnectivityCheckServer.java:214)
... 5 common frames omitted
2017-07-07 19:02:20,208 [NioProcessor-18] INFO org.ice4j.ice.Agent - Start ICE connectivity establishment. Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:20,209 [NioProcessor-18] INFO org.ice4j.ice.Agent - Init checklist for stream media-0
2017-07-07 19:02:20,209 [NioProcessor-18] INFO org.ice4j.ice.Agent - ICE state changed from Waiting to Running. Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:20,210 [NioProcessor-18] INFO org.ice4j.ice.Agent - Trigger checks for pairs that were received before running state
2017-07-07 19:02:20,210 [NioProcessor-18] INFO org.ice4j.ice.Agent - Add peer CandidatePair with new reflexive address to checkList: CandidatePair (State=Frozen Priority=7998391838664818686):
LocalCandidate=candidate:1 1 udp 2130706431 10.0.0.5 49152 typ host
RemoteCandidate=candidate:10000 1 udp 1862270719 10.0.0.2 54672 typ prflx
2017-07-07 19:02:20,211 [NioProcessor-18] INFO o.ice4j.ice.ConnectivityCheckClient - Start connectivity checks. Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:20,211 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - Connectivity establishment in process
2017-07-07 19:02:20,255 [Stun4J Message Processor] INFO o.ice4j.ice.ConnectivityCheckClient - Pair succeeded: 10.0.0.5:49152/udp/host -> 10.0.0.2:54672/udp/prflx (media-0.RTP). Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:20,256 [Stun4J Message Processor] INFO o.i.socket.MergingDatagramSocket - Adding allowed address: 10.0.0.2:54672/udp
2017-07-07 19:02:20,256 [Stun4J Message Processor] INFO o.ice4j.ice.ConnectivityCheckClient - Pair validated: 10.0.0.5:49152/udp/host -> 10.0.0.2:54672/udp/prflx (media-0.RTP). Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:20,256 [Stun4J Message Processor] INFO o.ice4j.ice.ConnectivityCheckClient - IsControlling: false USE-CANDIDATE:false. Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:21,356 [StunClientTransaction-pool-24-thread-2] INFO o.ice4j.ice.ConnectivityCheckClient - timeout for pair: 10.0.0.5:49152/udp/host -> 192.168.0.171:54672/udp/host (media-0.RTP), failing.
2017-07-07 19:02:21,376 [StunClientTransaction-pool-24-thread-1] INFO o.ice4j.ice.ConnectivityCheckClient - timeout for pair: 10.0.0.5:49152/udp/host -> 192.168.0.171:54672/udp/host (media-0.RTP), failing.
2017-07-07 19:02:24,211 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - ICE establishment failed for: stream1
2017-07-07 19:02:24,212 [NioProcessor-18] DEBUG c.r.webrtc.stream.RTCSourceStream - stop: stream1
2017-07-07 19:02:24,213 [NioProcessor-18] INFO o.i.socket.MergingDatagramSocket - Closing.
2017-07-07 19:02:24,215 [NioProcessor-18] INFO org.ice4j.ice.Agent - ICE state changed from Running to Terminated. Local ufrag e1s7k1bkfutt1i
2017-07-07 19:02:25,214 [MergingDatagramSocket reader thread for: /10.0.0.5:49152 -> null] INFO o.i.socket.MergingDatagramSocket - Failed to receive: java.net.SocketException: Socket closed
@mondain
Copy link
Author

mondain commented Jul 8, 2017

Failed to send BINDING-RESPONSE(0x101) only happens on Edge; Chrome, Firefox, and Safari Preview do not raise this error.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment