Code Monkey home page Code Monkey logo

Comments (33)

polhaghverdian avatar polhaghverdian commented on August 31, 2024 2

Thanks!

I had a look, I think the issue is that you create the candidate JSON this way:

nlohmann::json candidate;
candidate["ice"] = ice;
candidate["sdpMid"] = ice.mid();
candidate["type"] = "candidate";

However, you set it this way in the browser, with ice corresponding to the JSON structure:

this.rtc.addIceCandidate({ candidate: ice.candidate, sdpMid: ice.sdpMid });

ice.candidate will be undefined, so the browser will ignore the candidate.

I guess what you wanted is this.rtc.addIceCandidate({ candidate: ice.ice sdpMid: ice.sdpMid }); πŸ˜‰

@paullouisageneau Haha! unbelievable. I am ashamed! Thank you so much and for taking the time, it worked now! πŸ‘ πŸ‘ πŸ‘

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024 1

It should be fixed by paullouisageneau/libjuice@21cf1a3

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024 1

Maybe not related, but the first thing I noticed is this remote candidate:

842163049 1 udp 1677729535 "My public IP" 56337 typ srflx raddr 0.0.0.0 rport 0 generation 0 ufrag hC6d network-cost 999

It doesn't look valid, "My public IP" looks more like a placeholder here. How was it generated?

I didn't want to expose my IP. Thats why I replaced it. Sorry should have mentioned it.

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024 1

Thanks!

I had a look, I think the issue is that you create the candidate JSON this way:

nlohmann::json candidate;
candidate["ice"] = ice;
candidate["sdpMid"] = ice.mid();
candidate["type"] = "candidate";

However, you set it this way in the browser, with ice corresponding to the JSON structure:

this.rtc.addIceCandidate({ candidate: ice.candidate, sdpMid: ice.sdpMid });

ice.candidate will be undefined, so the browser will ignore the candidate.

I guess what you wanted is this.rtc.addIceCandidate({ candidate: ice.ice sdpMid: ice.sdpMid }); πŸ˜‰

from libdatachannel.

jeffRTC avatar jeffRTC commented on August 31, 2024 1

Holy shit. How could I have missed this. It's working now. Thank you!

FYI, I wasn't able to use RapidJSON to send the remote description, had to use nlohmann but it's slow. Maybe there is some unicode issues.

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Thank you for this very detailed issue.
I'm looking into it, I think it comes from a regression in libjuice that prevents the gathering from finishing if it fails to send to the STUN server (here probably IPv6 is not configured):

2020-05-14 15:33:20.192 WARN  [79] [rtc::IceTransport::LogCallback@262] juice: agent.c:920: STUN message send failed, errno=101
2020-05-14 15:33:20.192 VERB  [79] [rtc::IceTransport::LogCallback@262] juice: agent.c:491: STUN entry 1: Failed
2020-05-14 15:33:20.192 VERB  [79] [rtc::IceTransport::LogCallback@262] juice: agent.c:1043: Updating gathering status
2020-05-14 15:33:20.193 VERB  [79] [rtc::IceTransport::LogCallback@262] juice: agent.c:1046: STUN server entry 1 is not finished

from libdatachannel.

slonv23 avatar slonv23 commented on August 31, 2024

@paullouisageneau I have updated libjuice to the latest commit and it indeed helped to resolve this issue. Thank you!

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Great!

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

@paullouisageneau Hi, i almost have the same issue. Works great if run on the same computer. But connection is never established when trying to connect from a different computer on the same network. In my case as well the browser is the offerer. I have also implemented browser to browser (electron app) connection, which works great. Just to confirm that my network connection is not the culprit.



2020-09-19 02:31:41.201 VERB  [8136] [rtc::Candidate::resolve@112] Resolved candidate: 1666101572 1 udp 2113937152 192.168.1.146 60901 typ host generation 0 ufrag AtAe network-cost 999
2020-09-19 02:31:41.204 VERB  [8136] [rtc::IceTransport::LogCallback@268] juice: agent.c:1148: Adding new candidate pair, priority=4227874305
2020-09-19 02:31:41.205 VERB  [8136] [rtc::IceTransport::LogCallback@268] juice: agent.c:1269: Updated ordered candidate pairs
2020-09-19 02:31:41.206 VERB  [8136] [rtc::IceTransport::LogCallback@268] juice: agent.c:1160: Candidate pair has priority
2020-09-19 02:31:41.212 VERB  [8136] [rtc::IceTransport::LogCallback@268] juice: agent.c:1175: Registering STUN entry 2 for candidate pair checking
2020-09-19 02:31:41.216 VERB  [8136] [rtc::IceTransport::LogCallback@268] juice: agent.c:1188: Unfreezing the new candidate pair
2020-09-19 02:31:41.217 VERB  [8136] [rtc::IceTransport::LogCallback@268] juice: agent.c:505: Interrupting agent thread
2020-09-19 02:31:41.219 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:41.221 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 02:31:41.222 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 02:31:41.229 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:31:41.231 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 02:31:41.232 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:41.234 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:41.236 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:41.237 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:41.241 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:41.243 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:41.244 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:41.246 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 485 ms
2020-09-19 02:31:41.733 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:41.737 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:31:41.758 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 02:31:41.761 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:41.762 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:41.763 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:41.765 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:41.767 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:41.768 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:41.775 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:41.777 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 0 ms
2020-09-19 02:31:41.778 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:41.779 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 02:31:41.780 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 02:31:41.781 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:41.782 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:41.783 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:41.789 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:41.792 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:41.794 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:41.796 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:41.799 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 938 ms
2020-09-19 02:31:41.801 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:41.803 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 02:31:41.809 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 02:31:41.812 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 922 ms
2020-09-19 02:31:42.735 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:42.738 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:31:42.739 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 02:31:42.746 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:42.749 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:42.750 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:42.751 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:42.752 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:42.754 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:42.755 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:42.760 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 1016 ms
2020-09-19 02:31:43.779 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:43.780 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 02:31:43.781 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 02:31:43.782 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:43.782 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:43.783 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:43.784 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:43.785 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:43.786 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:43.787 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:43.789 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 02:31:43.795 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:43.796 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 02:31:43.797 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 02:31:43.797 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 02:31:44.751 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:44.753 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:31:44.753 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 02:31:44.754 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:44.754 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:44.756 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:44.756 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:44.757 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:44.758 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:44.758 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:44.759 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 3016 ms
2020-09-19 02:31:47.776 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:47.784 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 02:31:47.785 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 02:31:47.789 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:47.795 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:47.796 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:47.797 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:47.799 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:47.800 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:47.801 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:47.803 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 937 ms
2020-09-19 02:31:47.811 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:47.813 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 02:31:47.814 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 02:31:47.815 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 937 ms
2020-09-19 02:31:48.754 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:48.759 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:31:48.761 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 02:31:48.763 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:48.764 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:48.766 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:48.768 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:48.776 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:48.782 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:48.784 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:48.800 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 6797 ms
2020-09-19 02:31:55.607 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:55.613 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 02:31:55.614 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 02:31:55.616 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding indication
2020-09-19 02:31:55.617 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 02:31:55.618 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:55.620 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 157 ms
2020-09-19 02:31:55.791 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:55.797 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 02:31:55.799 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 02:31:55.800 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:55.802 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:55.803 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:55.804 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:55.806 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:55.813 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:55.814 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:55.816 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 02:31:55.818 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:55.831 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 02:31:55.832 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 02:31:55.834 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 922 ms
2020-09-19 02:31:56.768 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:31:56.774 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:31:56.775 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 02:31:56.776 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding request
2020-09-19 02:31:56.781 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 02:31:56.793 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 02:31:56.806 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 02:31:56.811 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 02:31:56.817 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 02:31:56.824 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:31:56.828 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 9953 ms
2020-09-19 02:32:06.786 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:06.793 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 3828 ms
2020-09-19 02:32:10.622 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:10.644 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 02:32:10.646 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 02:32:10.651 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding indication
2020-09-19 02:32:10.657 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 02:32:10.659 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:32:10.660 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 1125 ms
2020-09-19 02:32:11.786 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:11.801 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 02:32:11.802 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:577: STUN entry 1: Failed
2020-09-19 02:32:11.803 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 969 ms
2020-09-19 02:32:12.773 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:12.780 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 02:32:12.781 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:577: STUN entry 2: Failed
2020-09-19 02:32:12.783 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 10000 ms
2020-09-19 02:32:22.785 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:22.787 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 2875 ms
2020-09-19 02:32:25.663 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:25.665 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 02:32:25.666 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 02:32:25.666 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding indication
2020-09-19 02:32:25.666 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 02:32:25.667 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:32:25.667 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 10000 ms
2020-09-19 02:32:35.668 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:35.691 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 4968 ms
2020-09-19 02:32:40.661 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:40.684 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 02:32:40.686 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 02:32:40.687 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:970: Sending STUN binding indication
2020-09-19 02:32:40.689 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 02:32:40.691 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 02:32:40.692 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 2078 ms
2020-09-19 02:32:42.776 VERB  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 02:32:42.785 INFO  [14056] [rtc::IceTransport::LogCallback@268] juice: agent.c:527: Changing state to failed

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

It seems like a slightly different issue even if the symptom looks the same. In your case there is no answer from the other client.

It's on Windows, right? Do you use a STUN server? If so it can't be reached also, which would indicate libjuice is actually unable to either send or receive traffic in your case.

I recently made the ICE process more aggressive on both sides, but it should have been done only on the offerer side. Could you retry with the last master just to be sure it's not causing the issue?

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

@paullouisageneau Yes its on windows 10. I am using googles stun server, and tried many different ones, just to confirm the stun servers are not the problem. but you are saying no connection are done to the stun server? I might have removed stun server, during my attempts to troubleshoot. I now tried with the latest master, and re-included stunserver. But its the same issue. I will paste the log below. I can also confirm that answer are recieved by the browser.

these are the ice-candidates produced by the answerer.

a=candidate:1 1 UDP 2122317823 192.168.1.178 63768 typ host
a=candidate:0 1 UDP 1686110207 "Removed my public-IP" 63768 typ srflx raddr 0.0.0.0 rport 0

I really dont know how to troubleshoot this issue :(

2020-09-19 14:44:55.227 VERB  [9120] [rtc::Candidate::resolve@112] Resolved candidate: 1666101572 1 udp 2113937152 192.168.1.146 60228 typ host generation 0 ufrag RBGA network-cost 999
2020-09-19 14:44:55.231 VERB  [9120] [rtc::IceTransport::LogCallback@268] juice: agent.c:1149: Adding new candidate pair, priority=4227874305
2020-09-19 14:44:55.232 VERB  [9120] [rtc::IceTransport::LogCallback@268] juice: agent.c:1272: Updated ordered candidate pairs
2020-09-19 14:44:55.233 VERB  [9120] [rtc::IceTransport::LogCallback@268] juice: agent.c:1161: Candidate pair has priority
2020-09-19 14:44:55.235 VERB  [9120] [rtc::IceTransport::LogCallback@268] juice: agent.c:1176: Registering STUN entry 2 for candidate pair checking
2020-09-19 14:44:55.237 VERB  [9120] [rtc::IceTransport::LogCallback@268] juice: agent.c:1189: Unfreezing the new candidate pair
2020-09-19 14:44:55.241 VERB  [9120] [rtc::IceTransport::LogCallback@268] juice: agent.c:505: Interrupting agent thread
2020-09-19 14:44:55.245 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:55.246 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 14:44:55.248 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 14:44:55.252 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:44:55.254 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 14:44:55.255 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:44:55.257 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:44:55.259 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:44:55.260 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:44:55.264 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:44:55.265 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:44:55.267 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:44:55.268 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 484 ms
2020-09-19 14:44:55.755 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:55.759 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 14:44:55.760 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 14:44:55.761 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:44:55.763 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:44:55.764 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:44:55.765 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:44:55.766 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:44:55.771 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:44:55.772 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:44:55.777 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:44:55.779 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 14:44:55.786 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:44:55.788 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:44:55.789 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:44:55.793 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:44:55.796 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:44:55.797 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:44:55.798 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:44:55.799 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 14:44:55.800 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:55.806 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 14:44:55.807 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 14:44:55.808 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 14:44:56.765 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:56.768 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:44:56.770 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 14:44:56.771 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:44:56.775 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:44:56.776 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:44:56.777 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:44:56.782 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:44:56.786 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:44:56.787 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:44:56.789 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 969 ms
2020-09-19 14:44:57.762 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:57.790 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 14:44:57.794 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 14:44:57.794 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:44:57.795 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:44:57.881 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:44:57.885 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:44:57.888 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:44:57.980 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:44:57.985 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:44:58.067 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 703 ms
2020-09-19 14:44:58.086 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:58.089 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 14:44:58.187 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 14:44:58.191 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 578 ms
2020-09-19 14:44:58.772 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:44:58.776 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:44:58.778 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 14:44:58.779 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:44:58.781 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:44:58.782 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:44:58.788 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:44:58.793 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:44:58.794 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:44:58.795 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:44:58.797 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 3000 ms
2020-09-19 14:45:01.798 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:01.803 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 14:45:01.804 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 14:45:01.805 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:45:01.811 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:45:01.812 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:45:01.817 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:45:01.818 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:45:01.819 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:45:01.820 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:01.821 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 14:45:01.827 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:01.831 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 14:45:01.832 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 14:45:01.833 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 938 ms
2020-09-19 14:45:02.773 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:02.778 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:45:02.779 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 14:45:02.781 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:45:02.782 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:45:02.783 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:45:02.786 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:45:02.791 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:45:02.792 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:45:02.794 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:02.796 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 6782 ms
2020-09-19 14:45:09.580 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:09.585 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 14:45:09.589 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 14:45:09.590 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 14:45:09.592 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 14:45:09.593 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:09.598 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 203 ms
2020-09-19 14:45:09.802 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:09.806 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 14:45:09.807 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 14:45:09.808 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:45:09.810 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:45:09.811 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:45:09.813 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:45:09.820 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:45:09.821 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:45:09.822 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:09.823 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 14:45:09.828 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:09.834 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 14:45:09.835 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 14:45:09.836 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 938 ms
2020-09-19 14:45:10.775 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:10.779 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:45:10.781 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 14:45:10.785 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 14:45:10.787 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 14:45:10.793 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 14:45:10.794 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 14:45:10.795 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 14:45:10.796 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 14:45:10.797 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:10.800 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 9969 ms
2020-09-19 14:45:20.775 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:20.781 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 3828 ms
2020-09-19 14:45:24.618 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:24.620 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 14:45:24.620 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 14:45:24.621 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 14:45:24.621 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 14:45:24.622 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:24.622 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 1188 ms
2020-09-19 14:45:25.813 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:25.817 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 14:45:25.819 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:577: STUN entry 1: Failed
2020-09-19 14:45:25.820 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 14:45:26.775 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:26.776 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 14:45:26.777 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:577: STUN entry 2: Failed
2020-09-19 14:45:26.777 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 10000 ms
2020-09-19 14:45:36.778 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:36.779 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 2843 ms
2020-09-19 14:45:39.623 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:39.629 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 14:45:39.630 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 14:45:39.631 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 14:45:39.633 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 14:45:39.634 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:39.639 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 10000 ms
2020-09-19 14:45:49.640 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:49.656 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 4984 ms
2020-09-19 14:45:54.642 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:54.657 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 14:45:54.658 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 14:45:54.660 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 14:45:54.661 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 14:45:54.662 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 14:45:54.670 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 2110 ms
2020-09-19 14:45:56.781 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:56.790 INFO  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:527: Changing state to failed

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

but you are saying no connection are done to the stun server?

Yes it seems it's not reached by libjuice.

Could you link the entire verbose log please?

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024
2020-09-19 14:45:09.823 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 14:45:09.828 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 14:45:09.834 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 14:45:09.835 VERB  [9128] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive

This might show the origin of the issue. select() returns after 6 ms with new datagrams to read. However, there seems to be nothing read. My fix for errno ECONNRESET on Windows you reported earlier might be incomplete. I'm looking into it.

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

@paullouisageneau
Below is entire verbose log

2020-09-19 15:21:13.026 VERB  [904] [rtc::PeerConnection::setRemoteDescription@102] Setting remote description: v=0
o=- 1696281930 0 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=msid-semantic:WMS *
a=setup:actpass
a=ice-ufrag:hC6d
a=ice-pwd:8klPJspnbRcaMKxo2FvMa2Lu
a=ice-options:trickle
a=fingerprint:sha-256 28:BA:44:A9:E4:59:5B:80:EF:81:A1:08:22:C9:8A:94:77:7A:38:D5:8E:7A:68:3B:2B:9D:64:6D:D1:A8:7C:50
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=bundle-only
a=mid:0
a=sendrecv
a=ice-options:trickle
a=sctp-port:5000
a=max-message-size:262144

2020-09-19 15:21:13.029 DEBUG [904] [rtc::IceTransport::IceTransport@57] Initializing ICE transport (libjuice)
2020-09-19 15:21:13.030 DEBUG [904] [rtc::IceTransport::IceTransport@81] Using STUN server "stun4.l.google.com:19302"
2020-09-19 15:21:13.031 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:55: Creating agent
2020-09-19 15:21:13.056 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: ice.c:191: Created local description: ufrag="LkkM", pwd="yiTfFApW6RnI7m2f4PqTKA"
2020-09-19 15:21:13.060 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:231: Setting remote SDP description: v=0
o=- 1696281930 0 IN IP4 127.0.0.1
s=-
t=0 0
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=bundle-only
a=mid:0
a=sendrecv
a=ice-options:trickle
a=sctp-port:5000
a=max-message-size:262144
a=msid-semantic:WMS *
a=setup:actpass
a=ice-ufrag:hC6d
a=ice-pwd:8klPJspnbRcaMKxo2FvMa2Lu
a=ice-options:trickle
a=fingerprint:sha-256 28:BA:44:A9:E4:59:5B:80:EF:81:A1:08:22:C9:8A:94:77:7A:38:D5:8E:7A:68:3B:2B:9D:64:6D:D1:A8:7C:50

2020-09-19 15:21:13.062 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: ice.c:167: Parsed remote description: ufrag="hC6d", pwd="8klPJspnbRcaMKxo2FvMa2Lu", candidates=0
2020-09-19 15:21:13.063 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:251: Unfreezing 0 existing candidate pairs
2020-09-19 15:21:13.065 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:255: Adding 0 candidates from remote description
2020-09-19 15:21:13.066 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:261: Assuming controlled mode
2020-09-19 15:21:13.069 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:505: Interrupting agent thread
2020-09-19 15:21:13.078 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:219: Generated local SDP description: a=ice-ufrag:LkkM
a=ice-pwd:yiTfFApW6RnI7m2f4PqTKA
a=ice-options:trickle

2020-09-19 15:21:13.095 DEBUG [904] [rtc::PeerConnection::processLocalDescription::<lambda_a4204312ed7e6028ecad7f0c748ae8b7>::operator ()@713] Reciprocating application in local description, mid="0"
2020-09-19 15:21:31.833 INFO  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:527: Changing state to gathering2020-09-19 15:21:31.835 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:163: Adding 1 local host candidates
2020-09-19 15:21:31.837 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:192: Gathered host candidate: a=candidate:1 1 UDP 2122317823 192.168.1.178 58321 typ host

Got: ICE-candidate


candidate:1666101572 1 udp 2113937152 9824673e-fc79-4854-b384-5f16106919d0.local 56337 typ host generation 0 ufrag hC6d network-cost 999

2020-09-19 15:21:31.838 INFO  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:527: Changing state to connecting
2020-09-19 15:21:31.841 VERB  [904] [rtc::PeerConnection::addRemoteCandidate@167] Adding remote candidate: a=candidate:1666101572 1 udp 2113937152 9824673e-fc79-4854-b384-5f16106919d0.local 56337 typ host generation 0 ufrag hC6d network-cost 999
2020-09-19 15:21:31.847 VERB  [904] [rtc::Candidate::resolve@64] Resolving candidate (mode=simple): 1666101572 1 udp 2113937152 9824673e-fc79-4854-b384-5f16106919d0.local 56337 typ host generation 0 ufrag hC6d network-cost 999

Got: ICE-candidate


2020-09-19 15:21:31.849 VERB  [488] [rtc::Candidate::resolve@64] Resolving candidate (mode=lookup): 1666101572 1 udp 2113937152 9824673e-fc79-4854-b384-5f16106919d0.local 56337 typ host generation 0 ufrag hC6d network-cost 999
candidate:842163049 1 udp 1677729535 "MY public-IP" 56337 typ srflx raddr 0.0.0.0 rport 0 generation 0 ufrag hC6d network-cost 999

2020-09-19 15:21:31.855 VERB  [904] [rtc::PeerConnection::addRemoteCandidate@167] Adding remote candidate: a=candidate:842163049 1 udp 1677729535 "Public IP" 56337 typ srflx raddr 0.0.0.0 rport 0 generation 0 ufrag hC6d network-cost 999
2020-09-19 15:21:31.865 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:377: Sending STUN binding request to 1 server addresses
2020-09-19 15:21:31.866 VERB  [904] [rtc::Candidate::resolve@64] Resolving candidate (mode=simple): 842163049 1 udp 1677729535 "My public IP" 56337 typ srflx raddr 0.0.0.0 rport 0 generation 0 ufrag hC6d network-cost 999
2020-09-19 15:21:31.868 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:381: Registering STUN entry 0 for server request
2020-09-19 15:21:31.869 VERB  [904] [rtc::Candidate::resolve@112] Resolved candidate: 842163049 1 udp 1677729535 "My public IP" 56337 typ srflx raddr 0.0.0.0 rport 0 generation 0 ufrag hC6d network-cost 999
2020-09-19 15:21:31.871 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:1244: Updating gathering status
2020-09-19 15:21:31.884 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:1250: STUN server entry 0 is still pending
2020-09-19 15:21:31.885 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 15:21:31.887 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 0: Sending request
2020-09-19 15:21:31.888 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:31.889 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:31.890 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:31.896 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 484 ms
2020-09-19 15:21:31.901 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:1149: Adding new candidate pair, priority=3355459071
2020-09-19 15:21:31.902 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:1272: Updated ordered candidate pairs
2020-09-19 15:21:31.903 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:1161: Candidate pair has priority
2020-09-19 15:21:31.905 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:1176: Registering STUN entry 1 for candidate pair checking
2020-09-19 15:21:31.906 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:1189: Unfreezing the new candidate pair
2020-09-19 15:21:31.907 VERB  [904] [rtc::IceTransport::LogCallback@268] juice: agent.c:505: Interrupting agent thread
2020-09-19 15:21:31.915 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:31.916 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:31.917 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:31.919 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:21:31.920 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 15:21:31.921 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:31.933 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:31.934 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:31.937 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:31.938 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:31.939 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:31.941 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:31.944 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 437 ms
2020-09-19 15:21:31.953 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:31.958 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:31.962 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:31.965 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 422 ms
2020-09-19 15:21:32.205 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:32.208 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:32.209 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:471: Received a datagram, size=32
2020-09-19 15:21:32.210 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:475: Received a STUN datagram
2020-09-19 15:21:32.211 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:289: Reading STUN message, class=100, method=1
2020-09-19 15:21:32.212 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:324: Reading attribute 20, length=8
2020-09-19 15:21:32.214 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:349: Reading XOR mapped address
2020-09-19 15:21:32.215 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:467: Reading IPv4 address
2020-09-19 15:21:32.220 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:304: Finished reading STUN attributes
2020-09-19 15:21:32.221 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:767: STUN message has no integrity
2020-09-19 15:21:32.223 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:771: STUN message is a response, looking for transaction ID
2020-09-19 15:21:32.224 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:775: STUN entry 0 matching incoming transaction ID
2020-09-19 15:21:32.230 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:891: Received STUN binding success response from server
2020-09-19 15:21:32.233 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:896: Response has mapped address
2020-09-19 15:21:32.240 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:1079: Gathered reflexive candidate: a=candidate:0 1 UDP 1686110207 "My public IP" 58321 typ srflx raddr 0.0.0.0 rport 0
2020-09-19 15:21:32.241 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:1244: Updating gathering status
2020-09-19 15:21:32.244 INFO  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:1255: Candidate gathering done
2020-09-19 15:21:32.246 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:32.247 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 172 ms
2020-09-19 15:21:32.421 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:32.430 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:21:32.432 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 15:21:32.434 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:32.436 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:32.437 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:32.438 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:32.439 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:32.441 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:32.446 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:32.450 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 984 ms
2020-09-19 15:21:32.453 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:32.454 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:32.459 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:32.460 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 969 ms
2020-09-19 15:21:32.872 VERB  [488] [rtc::Candidate::resolve@112] Resolved candidate: 1666101572 1 udp 2113937152 192.168.1.146 56337 typ host generation 0 ufrag hC6d network-cost 999
2020-09-19 15:21:32.875 VERB  [488] [rtc::IceTransport::LogCallback@268] juice: agent.c:1149: Adding new candidate pair, priority=4227874305
2020-09-19 15:21:32.876 VERB  [488] [rtc::IceTransport::LogCallback@268] juice: agent.c:1272: Updated ordered candidate pairs
2020-09-19 15:21:32.877 VERB  [488] [rtc::IceTransport::LogCallback@268] juice: agent.c:1161: Candidate pair has priority
2020-09-19 15:21:32.879 VERB  [488] [rtc::IceTransport::LogCallback@268] juice: agent.c:1176: Registering STUN entry 2 for candidate pair checking
2020-09-19 15:21:32.881 VERB  [488] [rtc::IceTransport::LogCallback@268] juice: agent.c:1189: Unfreezing the new candidate pair
2020-09-19 15:21:32.882 VERB  [488] [rtc::IceTransport::LogCallback@268] juice: agent.c:505: Interrupting agent thread
2020-09-19 15:21:32.891 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:32.892 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:32.901 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:32.903 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:21:32.904 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 15:21:32.905 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:32.907 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:32.908 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:32.909 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:32.917 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:32.918 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:32.920 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:32.921 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 485 ms
2020-09-19 15:21:33.407 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:33.410 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:21:33.411 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 15:21:33.412 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:33.418 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:33.421 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:33.426 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:33.428 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:33.433 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:33.435 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:33.436 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 0 ms
2020-09-19 15:21:33.438 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:33.439 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:21:33.440 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 15:21:33.444 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:33.445 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:33.447 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:33.449 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:33.450 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:33.452 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:33.459 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:33.460 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 953 ms
2020-09-19 15:21:33.468 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:33.471 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:33.474 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:33.476 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 937 ms
2020-09-19 15:21:34.414 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:34.415 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:21:34.417 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 15:21:34.419 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:34.420 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:34.421 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:34.430 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:34.433 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:34.435 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:34.436 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:34.437 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 1016 ms
2020-09-19 15:21:35.454 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:35.457 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:21:35.459 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 15:21:35.461 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:35.462 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:35.463 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:35.465 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:35.466 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:35.471 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:35.472 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:35.474 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 937 ms
2020-09-19 15:21:35.479 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:35.483 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:35.484 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:35.486 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 922 ms
2020-09-19 15:21:36.417 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:36.418 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:21:36.424 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 15:21:36.428 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:36.429 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:36.432 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:36.434 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:36.435 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:36.438 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:36.439 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:36.446 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 3015 ms
2020-09-19 15:21:39.463 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:39.465 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:21:39.465 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 15:21:39.466 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:39.467 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:39.468 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:39.468 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:39.469 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:39.470 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:39.471 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:39.472 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 937 ms
2020-09-19 15:21:39.475 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:39.478 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:39.479 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:39.480 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 937 ms
2020-09-19 15:21:40.420 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:40.421 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:21:40.422 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 15:21:40.423 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:40.423 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:40.424 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:40.425 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:40.426 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:40.426 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:40.427 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:40.428 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 6797 ms
2020-09-19 15:21:47.226 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:51.963 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 15:21:51.964 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 15:21:51.966 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 15:21:51.967 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 15:21:51.969 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:51.970 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:21:51.972 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 1: Sending request
2020-09-19 15:21:51.996 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:51.998 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:52.000 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:52.001 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:52.003 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:52.004 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:52.014 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:52.016 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:21:52.017 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:567: STUN entry 2: Sending request
2020-09-19 15:21:52.022 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding request
2020-09-19 15:21:52.034 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=0, method=1
2020-09-19 15:21:52.036 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 24, length=4
2020-09-19 15:21:52.037 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8029, length=8
2020-09-19 15:21:52.039 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 6, length=9
2020-09-19 15:21:52.053 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8, length=20
2020-09-19 15:21:52.055 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:21:52.062 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 9906 ms
2020-09-19 15:21:52.070 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:21:52.071 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:445: Receiving datagrams
2020-09-19 15:21:52.073 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:460: No more datagrams to receive
2020-09-19 15:21:52.089 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 10000 ms
2020-09-19 15:22:02.096 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:22:02.097 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 4875 ms
2020-09-19 15:22:06.972 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:22:06.974 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 15:22:06.974 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 15:22:06.975 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 15:22:06.976 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 15:22:06.977 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:22:06.978 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 984 ms
2020-09-19 15:22:07.963 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:22:07.965 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 1: Transmission time reached
2020-09-19 15:22:07.965 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:577: STUN entry 1: Failed
2020-09-19 15:22:07.966 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 2: Transmission time reached
2020-09-19 15:22:07.967 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:577: STUN entry 2: Failed
2020-09-19 15:22:07.967 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 10000 ms
2020-09-19 15:22:17.969 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:22:17.995 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 3985 ms
2020-09-19 15:22:21.981 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:22:22.005 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 15:22:22.007 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 15:22:22.008 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 15:22:22.012 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 15:22:22.019 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:22:22.020 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 9984 ms
2020-09-19 15:22:32.009 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:22:32.035 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:405: Setting select timeout to 4985 ms
2020-09-19 15:22:37.021 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:418: Leaving select
2020-09-19 15:23:25.620 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:555: STUN entry 0: Transmission time reached
2020-09-19 15:23:25.621 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:558: STUN entry 0: Sending keepalive
2020-09-19 15:23:25.621 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:971: Sending STUN binding indication
2020-09-19 15:23:25.622 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:55: Writing STUN message, class=10, method=1
2020-09-19 15:23:25.623 VERB  [4816] [rtc::IceTransport::LogCallback@268] juice: stun.c:178: Writing STUN attribute type 8028, length=4
2020-09-19 15:23:25.624 INFO  [4816] [rtc::IceTransport::LogCallback@268] juice: agent.c:527: Changing state to failed

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Maybe not related, but the first thing I noticed is this remote candidate:

842163049 1 udp 1677729535 "My public IP" 56337 typ srflx raddr 0.0.0.0 rport 0 generation 0 ufrag hC6d network-cost 999

It doesn't look valid, "My public IP" looks more like a placeholder here. How was it generated?

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

OK so the STUN server can actually be reached fine, only the other peer can't be. The problem seems to be that the response when checking the host candidate 192.168.1.146 56337 is always ECONNRESET, meaning the port is unreachable on the remote side.

For now I've no idea why. Do you confirm 192.168.1.146 is actually the answerer address?

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

OK so the STUN server can actually be reached fine, only the other peer can't be. The problem seems to be that the response when checking the host candidate 192.168.1.146 56337 is always ECONNRESET, meaning the port is unreachable on the remote side.

For now I've no idea why. Do you confirm 192.168.1.146 is actually the answerer address?

Yes 192.168.1.146 is the offerer, which is suppose to receive the answer. The answer is also received. i can confirm the address is correct.

below is the answer received by the browser:

o=- 3428854902 0 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=msid-semantic:WMS *
a=setup:active
a=ice-ufrag:LkkM
a=ice-pwd:yiTfFApW6RnI7m2f4PqTKA
a=ice-options:trickle
a=fingerprint:sha-256 2B:8B:36:51:DC:D1:EE:6A:7D:48:13:31:44:AC:B8:96:A4:A5:5A:A9:7E:D1:E2:5C:77:C2:04:6B:B9:7D:CC:9F
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=bundle-only
a=mid:0
a=sendrecv
a=ice-options:trickle
a=sctp-port:5000
a=max-message-size:262144

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

@paullouisageneau
I also checked with netstat on the offerer machine, to see if the port is actually open:

C:\Users\Pol>netstat -an | find "56337"
  UDP    0.0.0.0:56337          *:*

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Yes sorry I meant offerer (so the browser).

If the offerer machine is listening on the port I guess the only possibility is a firewall blocking it, but it shouldn't if the browser is actually connecting at the same time.

Do you correctly get the answerer candidates to the browser ? Here, they should be:

a=candidate:1 1 UDP 2122317823 192.168.1.178 58321 typ host
a=candidate:0 1 UDP 1686110207 "My public IP" 58321 typ srflx raddr 0.0.0.0 rport 0

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

Yes sorry I meant offerer (so the browser).

If the offerer machine is listening on the port I guess the only possibility is a firewall blocking it, but it shouldn't if the browser is actually connecting at the same time.

Are you correctly getting the answerer candidates to the browser ? Here, they should be:

a=candidate:1 1 UDP 2122317823 192.168.1.178 58321 typ host
a=candidate:0 1 UDP 1686110207 "My public IP" 58321 typ srflx raddr 0.0.0.0 rport 0

Yes, they look exactly the same.

a=candidate:1 1 UDP 2122317823 192.168.1.178 58321 typ host
a=candidate:0 1 UDP 1686110207 "My public IP" 58321 typ srflx raddr 0.0.0.0 rport 0

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

This is puzzling. Everything looks fine yet the peer appears unreachable.

Is the browser Chrome or Firefox? Could you please try with Firefox and open a tab on about:webrtc to see how it looks like on the browser side? (The page layout on Firefox makes it way more visual to find connectivity issues)

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

below is the firefox connection log:

(registry/INFO) insert 'ice' (registry) succeeded: ice

(registry/INFO) insert 'ice.pref' (registry) succeeded: ice.pref

(registry/INFO) insert 'ice.pref.type' (registry) succeeded: ice.pref.type

(registry/INFO) insert 'ice.pref.type.srv_rflx' (UCHAR) succeeded: 0x64

(registry/INFO) insert 'ice.pref.type.peer_rflx' (UCHAR) succeeded: 0x6e

(registry/INFO) insert 'ice.pref.type.host' (UCHAR) succeeded: 0x7e

(registry/INFO) insert 'ice.pref.type.relayed' (UCHAR) succeeded: 0x05

(registry/INFO) insert 'ice.pref.type.srv_rflx_tcp' (UCHAR) succeeded: 0x63

(registry/INFO) insert 'ice.pref.type.peer_rflx_tcp' (UCHAR) succeeded: 0x6d

(registry/INFO) insert 'ice.pref.type.host_tcp' (UCHAR) succeeded: 0x7d

(registry/INFO) insert 'ice.pref.type.relayed_tcp' (UCHAR) succeeded: 0x00

(registry/INFO) insert 'stun' (registry) succeeded: stun

(registry/INFO) insert 'stun.client' (registry) succeeded: stun.client

(registry/INFO) insert 'stun.client.maximum_transmits' (UINT4) succeeded: 7

(registry/INFO) insert 'ice.trickle_grace_period' (UINT4) succeeded: 5000

(registry/INFO) insert 'ice.tcp' (registry) succeeded: ice.tcp

(registry/INFO) insert 'ice.tcp.so_sock_count' (INT4) succeeded: 0

(registry/INFO) insert 'ice.tcp.listen_backlog' (INT4) succeeded: 10

(registry/INFO) insert 'ice.tcp.disable' (char) succeeded: \000

(registry/INFO) insert 'ice.forced_interface_name' (string) succeeded:

(generic/EMERG) Exit UDP socket connected

(ice/INFO) /builds/worker/checkouts/gecko/media/mtransport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:173 function nr_socket_multi_tcp_create_stun_server_socket skipping UDP STUN server(addr:)

(ice/WARNING) /builds/worker/checkouts/gecko/media/mtransport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:617 function nr_socket_multi_tcp_listen failed with error 3

(ice/WARNING) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): failed to create passive TCP host candidate: 3

(stun/INFO) STUN-CLIENT(srflx(IP4:192.168.1.153:55605/UDP|stun4.l.google.com:19302)): Received response; processing

(ice/INFO) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): All candidates initialized

(ice/WARNING) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): peer (PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/):default) has no stream matching stream PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/) transport-id=transport_0 - d4e26b98:a0ab144e99b37c3b1e72e361fe1a5d46

(ice/NOTICE) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): peer (PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/):default) no streams with non-empty check lists

(ice/NOTICE) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): peer (PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/):default) no streams with pre-answer requests

(ice/NOTICE) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): peer (PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/):default) no checks to start

(ice/WARNING) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): Error parsing attribute:

(ice/WARNING) ICE(PC:1600527068783000 (id=6442450946 url=https://192.168.1.178:8080/)): Error parsing attribute:

+++++++ END ++++++++

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

What about the candidates matrix in the ICE stats? Are there selected candidate pairs?

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

What about the candidates matrix in the ICE stats? Are there selected candidate pairs?

RΓ₯ lokal kandidat (Raw local candidates)

host(IP4:192.168.1.153:52085/TCP) active
host(IP4:192.168.1.153:55605/UDP)
srflx(IP4:192.168.1.153:55605/UDP|stun4.l.google.com:19302)

The ip is not the same because i tried with another computer using firefox.

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

What about the candidates matrix in the ICE stats? Are there selected candidate pairs?

@paullouisageneau Aha. the ice statistics is empty!

bild

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

What about the candidates matrix in the ICE stats? Are there selected candidate pairs?

@paullouisageneau Aha. the ice statistics is empty!

OK that's a very good clue, I guess we are progressing. It means the browser is either not receiving the remote candidates or ignoring them. This might be due to a missing or invalid sdpMid field in candidate object passed to addIceCandidate. Could you double check it's set to the value of candidate.mid() on libdatachannel side? (It should be 0 here)

from libdatachannel.

polhaghverdian avatar polhaghverdian commented on August 31, 2024

@paullouisageneau I have my repo private, but will make it public as soon as i have a working project. I made you a collaborator to my repos. Will be helpful if you could check, did't understand what you meant by "field in candidate object passed to addIceCandidate. Could you double check it's set to the value of candidate.mid() on libdatachannel side? (It should be 0 here)"

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

Glad that it eventually works! Good luck on your project, WebRTC remote desktop looks cool!

Still, I think this mistake is the reason you triggered the libjuice bug with ECONNRESET in the first place, so there was some good in it I guess πŸ˜„

from libdatachannel.

jeffRTC avatar jeffRTC commented on August 31, 2024

I'm facing same issue. In my case, the connection state is stuck at connecting also the verbose log runs into endless loop that output following,

2020-11-18 06:24:43.419 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:24:43.419 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:24:43.419 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.

Here is the full verbose log output,

2020-11-18 06:11:39.039 DEBUG [4135228] [rtc::InitLogger@40] Logger initialized
2020-11-18 06:11:39.041 DEBUG [4135228] [rtc::{anonymous}::doInit@46] Global initialization
2020-11-18 06:11:39.043 VERB  [4135228] [rtc::PeerConnection::PeerConnection@48] Creating PeerConnection
Server listening on port 8081
2020-11-18 06:11:49.840 VERB  [4135239] [rtc::PeerConnection::PeerConnection@48] Creating PeerConnection
2020-11-18 06:11:49.840 VERB  [4135239] [rtc::PeerConnection::setRemoteDescription@118] Setting remote description: v=0
o=- 4384332781104372742 0 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=msid-semantic:WMS *
a=setup:actpass
a=ice-ufrag:D+hg
a=ice-pwd:No92LPnYLqPSvHW55V6i1lS2
a=ice-options:trickle
a=fingerprint:sha-256 B5:4B:D0:D6:FA:56:6D:FD:0A:82:FD:5A:7F:22:B4:77:B1:39:FE:DC:9F:78:10:A5:1F:BE:84:AB:62:43:AB:D3
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=bundle-only
a=mid:0
a=sendrecv
a=ice-options:trickle
a=sctp-port:5000
a=max-message-size:262144

2020-11-18 06:11:49.840 DEBUG [4135239] [rtc::IceTransport::IceTransport@327] Initializing ICE transport (libnice)
2020-11-18 06:11:49.841 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Created NiceStream (1 created, 0 destroyed)
2020-11-18 06:11:49.841 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Created NiceComponent (1 created, 0 destroyed)
2020-11-18 06:11:49.841 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : allocating stream id 1 (0x7efef0014fd0)
2020-11-18 06:11:49.841 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Property set, role is already "controlling".
2020-11-18 06:11:49.849 DEBUG [4135239] [rtc::IceTransport::IceTransport@415] Using STUN server "stun.services.mozilla.com:3478"
2020-11-18 06:11:49.849 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Property set, changing role to "controlled".
2020-11-18 06:11:49.850 DEBUG [4135239] [rtc::PeerConnection::processLocalDescription@749] Reciprocating application in local description, mid="0"
2020-11-18 06:11:49.850 INFO  [4135239] [rtc::PeerConnection::changeGatheringState@888] Changed gathering state to in_progress
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : In ICE-FULL mode, starting candidate gathering.
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : UPnP property Disabled
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Failed to convert address to string for interface β€˜lo’.
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Failed to convert address to string for interface β€˜eth0’.
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Interface:  lo
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: IP Address: 127.0.0.1
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Ignoring loopback interface
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Interface:  eth0
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: IP Address: MY_SERVER_IPv4_IP
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Interface:  lo
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: IP Address: ::1
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Ignoring loopback interface
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Interface:  eth0
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: IP Address: MY_SERVER_IPv6_IP
2020-11-18 06:11:49.850 VERB  [4135230] [rtc::PeerConnection::processLocalDescription@828] Issuing local description: v=0
o=rtc 1868659730 0 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=msid-semantic:WMS *
a=setup:active
a=ice-ufrag:uiC9
a=ice-pwd:1FIhGLFsyOMyDOCvNlqRPI
a=ice-options:trickle
a=fingerprint:sha-256 C4:B1:A5:50:25:93:9A:A9:AF:85:DF:2A:81:41:49:A1:16:38:50:71:2A:65:45:9D:F2:34:BF:2F:C6:F5:E5:0F
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=bundle-only
a=mid:0
a=sendrecv
a=ice-options:trickle
a=sctp-port:5000
a=max-message-size:262144

2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Interface:  eth0
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: IP Address: fe80::f03c:92ff:fe64:cdfd%eth0
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: Trying to create host candidate on port 56155
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Component 0x7efef00157a0: Attach source (stream 1).
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Attaching source 0x7efef0020670 (socket 0x7efef000e2e0, FD 21) to context 0x7efef000af90
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: Trying to create host candidate on port 36168
Gathering State: in_progress
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Component 0x7efef00157a0: Attach source (stream 1).
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Attaching source 0x7efef001e100 (socket 0x7efef001f480, FD 22) to context 0x7efef000af90
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: Trying to create host candidate on port 31666
2020-11-18 06:11:49.850 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: Could not set IPV6 socket ToS: Protocol not available
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Component 0x7efef00157a0: Attach source (stream 1).
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Attaching source 0x7efef001e260 (socket 0x7efef001f4f0, FD 23) to context 0x7efef000af90
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Adding new srv-rflx candidate discovery 0x7efef00217f0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : discovery tick #1 with list 0x7efef000a7c0 (1)
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : discovery - scheduling cand type 1 addr 54.172.47.69.
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : stream 1 component 1 STATE-CHANGE disconnected -> gathering.
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 1 1 UDP 2013266431 fe80::f03c:92ff:fe64:cdfd 56155 typ host
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@161] Resolved candidate: 1 1 UDP 2013266431 fe80::f03c:92ff:fe64:cdfd 56155 typ host
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 2 1 UDP 2013266430 MY_SERVER_IPv6_IP 36168 typ host
2020-11-18 06:11:49.851 VERB  [4135232] [rtc::PeerConnection::processLocalCandidate@842] Issuing local candidate: a=candidate:1 1 UDP 2013266431 fe80::f03c:92ff:fe64:cdfd 56155 typ host
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@161] Resolved candidate: 2 1 UDP 2013266430 MY_SERVER_IPv6_IP 36168 typ host
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 3 1 UDP 2013266429 MY_SERVER_IPv4_IP 31666 typ host
2020-11-18 06:11:49.851 VERB  [4135232] [rtc::PeerConnection::processLocalCandidate@842] Issuing local candidate: a=candidate:2 1 UDP 2013266430 MY_SERVER_IPv6_IP 36168 typ host
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@161] Resolved candidate: 3 1 UDP 2013266429 MY_SERVER_IPv4_IP 31666 typ host
2020-11-18 06:11:49.851 VERB  [4135230] [rtc::PeerConnection::processLocalCandidate@842] Issuing local candidate: a=candidate:3 1 UDP 2013266429 MY_SERVER_IPv4_IP 31666 typ host
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.851 VERB  [4135259] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.851 VERB  [4135260] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.851 VERB  [4135261] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.851 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.852 VERB  [4135262] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : No matching remote candidate for incoming check -> peer-reflexive candidate.
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 :  1:1 Adding valid source candidate: MY_CLIENT_IPv6_IP:56511 trans: 0
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Adding a triggered check to conn.check list (local=0x7efef0010b00).
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : creating a new pair
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 state WAITING (priv_add_new_check_pair)
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : new pair 0x7efecc009020 : [MY_SERVER_IPv6_IP]:36168 --> [MY_CLIENT_IPv6_IP]:56511
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : added a new pair 0x7efecc009020 with foundation '2:remote1' to stream 1 component 1.
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : stream 1 component 1 STATE-CHANGE gathering -> connecting.
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 state IN_PROGRESS (priv_add_pair_to_triggered_check_queue)
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:49.935 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:49.935 INFO  [4135257] [rtc::PeerConnection::changeState@873] Changed state to connecting
State: connecting
2020-11-18 06:11:49.943 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.943 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.943 VERB  [4135263] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.943 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.943 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.943 VERB  [4135264] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.944 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.944 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.944 VERB  [4135265] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.944 VERB  [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0
2020-11-18 06:11:49.944 VERB  [4135239] [rtc::Candidate::resolve@85] Resolving candidate (mode=simple): 0
2020-11-18 06:11:49.944 VERB  [4135266] [rtc::Candidate::resolve@85] Resolving candidate (mode=lookup): 0
2020-11-18 06:11:49.983 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:49.983 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:49.984 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:49.984 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:49.984 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:50.033 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:50.033 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:50.033 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:50.033 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:50.033 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv4_IP]:56514 (96 octets) :
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : No matching remote candidate for incoming check -> peer-reflexive candidate.
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 :  1:1 Adding valid source candidate: MY_CLIENT_IPv4_IP:56514 trans: 0
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv4_IP:56514', socket=23, len=80, cand=0x7efecc006150 (c-id:1), use-cand=0.
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Adding a triggered check to conn.check list (local=0x7efef0010b90).
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : creating a new pair
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc0090d0 state WAITING (priv_add_new_check_pair)
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : new pair 0x7efecc0090d0 : [MY_SERVER_IPv4_IP]:31666 --> [MY_CLIENT_IPv4_IP]:56514
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : added a new pair 0x7efecc0090d0 with foundation '3:remote2' to stream 1 component 1.
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc0090d0 state IN_PROGRESS (priv_add_pair_to_triggered_check_queue)
2020-11-18 06:11:50.165 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:50.962 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:50.963 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:50.963 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:50.963 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:50.963 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:51.110 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : discovery tick #51 with list 0x7efef000a7c0 (1)
2020-11-18 06:11:51.862 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : bind discovery timed out, aborting discovery item.
2020-11-18 06:11:51.862 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Candidate gathering FINISHED, stopping discovery timer.
2020-11-18 06:11:51.862 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: gathered UDP local candidate : [fe80::f03c:92ff:fe64:cdfd]:56155 for s1/c1. U/P '(null)'/'(null)'
2020-11-18 06:11:51.862 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : creating a new pair
2020-11-18 06:11:51.862 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009180 state FROZEN (priv_add_new_check_pair)
2020-11-18 06:11:51.862 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : new pair 0x7efecc009180 : [fe80::f03c:92ff:fe64:cdfd]:56155 --> [MY_CLIENT_IPv6_IP]:56511
2020-11-18 06:11:51.863 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : added a new pair 0x7efecc009180 with foundation '1:remote1' to stream 1 component 1.
2020-11-18 06:11:51.863 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: gathered UDP local candidate : [MY_SERVER_IPv6_IP]:36168 for s1/c1. U/P '(null)'/'(null)'
2020-11-18 06:11:51.863 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: gathered UDP local candidate : [MY_SERVER_IPv4_IP]:31666 for s1/c1. U/P '(null)'/'(null)'
2020-11-18 06:11:51.863 INFO  [4135257] [rtc::PeerConnection::changeGatheringState@888] Changed gathering state to complete
Gathering State: complete
2020-11-18 06:11:51.893 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:51.893 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:51.893 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:51.893 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:51.893 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:54.440 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:54.440 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:54.440 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:54.440 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:54.440 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:56.986 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:56.986 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:56.986 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:56.987 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:56.987 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:11:59.533 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:11:59.533 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:11:59.533 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:11:59.534 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:11:59.534 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:02.080 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:02.081 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:02.081 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:02.081 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:02.081 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:04.628 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:04.628 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:04.629 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:04.629 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:04.629 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:07.174 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:07.174 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:07.174 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:07.174 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:07.174 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:09.720 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:09.720 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:09.720 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:09.720 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:09.720 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:12.266 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:12.266 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:12.266 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:12.266 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:12.266 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:14.812 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:14.812 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:14.812 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:14.812 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:14.812 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:15.238 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv4_IP]:56514 (96 octets) :
2020-11-18 06:12:15.238 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv4_IP:56514', socket=23, len=80, cand=0x7efecc006150 (c-id:1), use-cand=0.
2020-11-18 06:12:15.238 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc0090d0 (3:remote2) (IN_PROGRESS) ...
2020-11-18 06:12:15.238 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:17.358 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:17.358 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:17.358 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:17.358 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:17.358 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:19.904 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:19.904 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:19.904 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:19.904 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:19.904 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:22.450 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:22.450 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:22.451 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:22.451 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:22.451 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:24.997 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:24.997 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:24.997 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:24.997 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:24.997 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:27.543 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:27.543 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:27.543 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:27.543 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:27.543 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.
2020-11-18 06:12:30.089 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000: inbound STUN packet for 1/1 (stream/component) from [MY_CLIENT_IPv6_IP]:56511 (100 octets) :
2020-11-18 06:12:30.089 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : STUN-CC RESP to 'MY_CLIENT_IPv6_IP:56511', socket=22, len=92, cand=0x7efef0010e60 (c-id:1), use-cand=1.
2020-11-18 06:12:30.089 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : Found a matching pair 0x7efecc009020 (2:remote1) (IN_PROGRESS) ...
2020-11-18 06:12:30.089 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: Agent 0x7efef0012000 : pair 0x7efecc009020 (2:remote1) is in-progress, will be nominated on response receipt.
2020-11-18 06:12:30.089 VERB  [4135257] [rtc::IceTransport::LogCallback@734] nice: agent_recv_message_unlocked: Valid STUN packet received.

from libdatachannel.

jeffRTC avatar jeffRTC commented on August 31, 2024

I have posted this on Stackoverflow too and there you can find client side code etc

https://stackoverflow.com/questions/64887771/stun-allocate-request-timed-out

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024

2020-11-18 06:11:49.943 VERB [4135239] [rtc::PeerConnection::addRemoteCandidate@205] Adding remote candidate: a=candidate:0

Your remote candidates are invalid and therefore ignored, this is probably a signaling problem. Note that the last version of libdatachannel will raise errors on invalid candidates.

from libdatachannel.

jeffRTC avatar jeffRTC commented on August 31, 2024

Here is the part of code I'm using to add candidates on C++ side. Note that I'm using simdjson instead nlohmann.

    simdjson::dom::parser parser;

    WSsocket.on_message = [&](std::shared_ptr<WsServer::Connection> connection, std::shared_ptr<WsServer::InMessage> in_message) {
        auto messageObj = parser.parse(in_message->string());

        std::string id(messageObj["id"]);
        std::string type(messageObj["type"]);

        if (id.empty() || type.empty())
        {
            return;
        }

        std::shared_ptr<rtc::PeerConnection> pc;

        // Check if Connection already exists
        auto record = peerConnectionMap.find(id);

        if (record != peerConnectionMap.end())
        {
            // Set to already existing Peer Connection
            pc = record->second;
        }

        if (type == "offer")
        {
            pc = createPeerConnection(config, connection, id);
        }

        if (type == "offer" || type == "answer")
        {
            std::string sdp(messageObj["description"]);

            pc->setRemoteDescription(rtc::Description(sdp, type));
        }

        if (type == "candidate")
        {
            std::string sdp(messageObj["mid"]);
            std::string mid(messageObj["candidate"]);

            pc->addRemoteCandidate(rtc::Candidate(sdp, mid));
        }

from libdatachannel.

paullouisageneau avatar paullouisageneau commented on August 31, 2024
std::string sdp(messageObj["mid"]);
std::string mid(messageObj["candidate"]);

There is an obvious mix-up here ;)

from libdatachannel.

Related Issues (20)

Recommend Projects

  • React photo React

    A declarative, efficient, and flexible JavaScript library for building user interfaces.

  • Vue.js photo Vue.js

    πŸ–– Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.

  • Typescript photo Typescript

    TypeScript is a superset of JavaScript that compiles to clean JavaScript output.

  • TensorFlow photo TensorFlow

    An Open Source Machine Learning Framework for Everyone

  • Django photo Django

    The Web framework for perfectionists with deadlines.

  • D3 photo D3

    Bring data to life with SVG, Canvas and HTML. πŸ“ŠπŸ“ˆπŸŽ‰

Recommend Topics

  • javascript

    JavaScript (JS) is a lightweight interpreted programming language with first-class functions.

  • web

    Some thing interesting about web. New door for the world.

  • server

    A server is a program made to process requests and deliver data to clients.

  • Machine learning

    Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.

  • Game

    Some thing interesting about game, make everyone happy.

Recommend Org

  • Facebook photo Facebook

    We are working to build community through open source technology. NB: members must have two-factor auth.

  • Microsoft photo Microsoft

    Open source projects and samples from Microsoft.

  • Google photo Google

    Google ❀️ Open Source for everyone.

  • D3 photo D3

    Data-Driven Documents codes.