[libnice] ICE success in browser side, fails in libnice

Sun Mar 29 17:19:37 UTC 2020

I upgraded server libnice from Mint oficial one (10.7.0) to github version
(10.9.0) and problem seems solved.
My habit of do not upgrade until an error cause is well-know, this time
caused me loss a week.

On Sun, Mar 29, 2020 at 3:08 PM Bizarre Days <daysbizarre at gmail.com> wrote:

> Correction of last trace, the original one belongs to another call. The
> correct data is:
>
> Mar 29 12:07:38 ip-172-31-37-14 java[803]: Agent 0x7f3648735600 : new pair
> 0x7f35f80ab630 state DISCOVERED
> Mar 29 12:07:38 ip-172-31-37-14 java[803]: Agent 0x7f3648735600 : new pair
> 0x7f35f80ab630 : [35.159.24.246]:34396 --> [88.6.179.119]:53212
> Mar 29 12:07:38 ip-172-31-37-14 java[803]: Agent 0x7f3648735600 :
> conncheck 0x555955870e00 FAILED, 0x7f35f80ab630 DISCOVERED.
>
> On Sun, Mar 29, 2020 at 3:00 PM Bizarre Days <daysbizarre at gmail.com>
> wrote:
>
>> Please, could you help me in this issue ? After a week reading traces, no
>> progress.
>>
>> My test environment is a Firefox browser (NAT, public IP is 88.6.179.119)
>> that offers a webrtc connection to a peer (AWS virtual server with public
>> IP 35.159.24.246) implemented with gstreamer/libnice.
>>
>> According to Firefox, connection is established and stable, but no data
>> is transferred. However, according to server libnice, it fails.
>>
>> In* browser side* Firefox shows:
>>
>> succeededtruetrue88.6.179.119:53212/udp(srflx) [non-proxied]
>>
>>
>>
>> 35.159.24.246:34396/udp(srflx) 1 7205761601893188000 0 0
>>
>> and trace shows:
>>
>> CE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/CAND-PAIR(/3la):
>> setting pair to state FROZEN: /3la|IP4:
>> 88.6.179.119:53212/UDP|IP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP|stun.freeswitch.org:3478)|candidate:7
>> <http://88.6.179.119:53212/UDP%7CIP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP%7Cstun.freeswitch.org:3478)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)
>>
>> ICE(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation))/CAND-PAIR(/3la): Pairing
>> candidate IP4:88.6.179.119:53212/UDP (647f1fff):IP4:
>> 35.159.24.246:34396/UDP (640001ff) priority=7205761601893187583
>> (640001ffc8fe3fff)
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/CAND-PAIR(6RMJ):
>> setting pair to state FAILED: 6RMJ|IP4:
>> 192.168.1.10:53212/UDP|IP4:35.159.24.246:34396/UDP(host(IP4:192.168.1.10:53212/UDP)|candidate:7
>> <http://192.168.1.10:53212/UDP%7CIP4:35.159.24.246:34396/UDP(host(IP4:192.168.1.10:53212/UDP)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/CAND-PAIR(/3la): *setting
>> pair to state SUCCEEDED*: /3la|IP4:
>> 88.6.179.119:53212/UDP|IP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP|stun.freeswitch.org:3478)|candidate:7
>> <http://88.6.179.119:53212/UDP%7CIP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP%7Cstun.freeswitch.org:3478)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/STREAM(PC:1585483657323328
>> (id=2147483652 url=https://35.159.24.246/llocer/login_invitation)
>> transport-id=transport_0 -
>> cda3051b:00889374f6e86175ef9f120144a5333b)/COMP(1)/CAND-PAIR(/3la): *nominated
>> pair* is /3la|IP4:
>> 88.6.179.119:53212/UDP|IP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP|stun.freeswitch.org:3478)|candidate:7
>> <http://88.6.179.119:53212/UDP%7CIP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP%7Cstun.freeswitch.org:3478)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/STREAM(PC:1585483657323328
>> (id=2147483652 url=https://35.159.24.246/llocer/login_invitation)
>> transport-id=transport_0 -
>> cda3051b:00889374f6e86175ef9f120144a5333b)/COMP(1)/CAND-PAIR(/3la):
>> cancelling all pairs but /3la|IP4:
>> 88.6.179.119:53212/UDP|IP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP|stun.freeswitch.org:3478)|candidate:7
>> <http://88.6.179.119:53212/UDP%7CIP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP%7Cstun.freeswitch.org:3478)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/STREAM(PC:1585483657323328
>> (id=2147483652 url=https://35.159.24.246/llocer/login_invitation)
>> transport-id=transport_0 -
>> cda3051b:00889374f6e86175ef9f120144a5333b)/COMP(1)/CAND-PAIR(5AS7):
>> cancelling FROZEN/WAITING pair 5AS7|IP4:
>> 192.168.1.10:49607/TCP|IP4:35.159.24.246:43727/TCP(host(IP4:192.168.1.10:49607/TCP)
>> <http://192.168.1.10:49607/TCP%7CIP4:35.159.24.246:43727/TCP(host(IP4:192.168.1.10:49607/TCP)>
>> active|candidate:9 1 TCP 843055615 35.159.24.246 43727 typ srflx raddr
>> 172.31.37.14 rport 43727 tcptype passive) because CAND-PAIR(/3la) was
>> nominated.
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/CAND-PAIR(5AS7):
>> setting pair to state CANCELLED: 5AS7|IP4:
>> 192.168.1.10:49607/TCP|IP4:35.159.24.246:43727/TCP(host(IP4:192.168.1.10:49607/TCP)
>> <http://192.168.1.10:49607/TCP%7CIP4:35.159.24.246:43727/TCP(host(IP4:192.168.1.10:49607/TCP)>
>> active|candidate:9 1 TCP 843055615 35.159.24.246 43727 typ srflx raddr
>> 172.31.37.14 rport 43727 tcptype passive)
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/ICE-STREAM(PC:1585483657323328
>> (id=2147483652 url=https://35.159.24.246/llocer/login_invitation)
>> transport-id=transport_0 - cda3051b:00889374f6e86175ef9f120144a5333b): all
>> active components have nominated candidate pairs
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default): all checks
>> completed success=1 fail=0
>> Unrecognized attribute: 0x802b
>>
>> Unrecognized attribute: 0x802c
>>
>> Unrecognized attribute: 0x802b
>>
>> Unrecognized attribute: 0x802c
>>
>> STUN-CLIENT(6RMJ|IP4:
>> 192.168.1.10:53212/UDP|IP4:35.159.24.246:34396/UDP(host(IP4:192.168.1.10:53212/UDP)|candidate:7
>> <http://192.168.1.10:53212/UDP%7CIP4:35.159.24.246:34396/UDP(host(IP4:192.168.1.10:53212/UDP)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)): Received response; processing
>>
>> ICE-PEER(PC:1585483657323328 (id=2147483652 url=
>> https://35.159.24.246/llocer/login_invitation):default)/CAND-PAIR(/3la):
>> setting pair to state SUCCEEDED: /3la|IP4:
>> 88.6.179.119:53212/UDP|IP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP|stun.freeswitch.org:3478)|candidate:7
>> <http://88.6.179.119:53212/UDP%7CIP4:35.159.24.246:34396/UDP(srflx(IP4:192.168.1.10:53212/UDP%7Cstun.freeswitch.org:3478)%7Ccandidate:7>
>> 1 UDP 1677722111 35.159.24.246 34396 typ srflx raddr 172.31.37.14 rport
>> 34396)
>>
>>
>>
>> However, *in the server side*, libnice trace, what I see about the
>> correct pair is only:
>>
>> Mar 29 11:54:41 ip-172-31-37-14 java[803]: Agent 0x7f36244fc9d0 : new
>> pair 0x7f35fc028da0 state DISCOVERED
>> Mar 29 11:54:41 ip-172-31-37-14 java[803]: Agent 0x7f36244fc9d0 : new
>> pair 0x7f35fc028da0 : [35.159.24.246]:33384 --> [88.6.179.119]:38189
>> Mar 29 11:54:41 ip-172-31-37-14 java[803]: Agent 0x7f36244fc9d0 : added a
>> new peer-discovered pair with foundation of '7:1'.
>> Mar 29 11:54:41 ip-172-31-37-14 java[803]: Agent 0x7f36244fc9d0 :
>> conncheck 0x7f36487d8a80 FAILED, 0x7f35fc028da0 DISCOVERED.
>>
>>
>> Please, any hint ?
>>
>>
>> Thanks a lot
>>
>>
>>
>>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/nice/attachments/20200329/1661cee0/attachment.htm>