paullouisageneau / libjuice

JUICE is a UDP Interactive Connectivity Establishment library
Mozilla Public License 2.0
426 stars 80 forks source link

STUN errors with libdatachannel #165

Closed unktomi closed 2 years ago

unktomi commented 2 years ago

Hi, with a simple test case creating multiple data channels with libdatachannel connecting from/to the same host I'm seeing a lot of these:

juice: Got STUN error code 400, reason "You cannot use the same channel number with different peer"

Any suggestions?

paullouisageneau commented 2 years ago

What is your setup? It is possible to reproduce your test case?

Additionally, what TURN server do you use?

unktomi commented 2 years ago

The turn server is provided by https://xirsys.com/

paullouisageneau commented 2 years ago

Could you please provide the verbose log of a session showing this error?

unktomi commented 2 years ago
2022-07-31 15:01:46.532 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.532 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:5349"
2022-07-31 15:01:46.532 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.532 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-local-offer
2022-07-31 15:01:46.533 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:46.533 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:46.533 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:46.533 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:46.601 INFO  [8620934] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:5349
2022-07-31 15:01:46.602 INFO  [8620934] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.603 INFO  [8620934] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.629 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.629 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.629 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.629 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-local-offer
2022-07-31 15:01:46.629 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:46.630 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:46.630 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:46.630 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:46.631 INFO  [8620937] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.631 INFO  [8620937] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.632 INFO  [8620937] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-local-offer
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:46.723 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:46.725 INFO  [8620938] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.726 INFO  [8620938] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.726 INFO  [8620938] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.817 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:46.817 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:61833 from server
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-local-offer
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:46.829 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:46.831 INFO  [8620940] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.832 INFO  [8620940] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.832 INFO  [8620940] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.903 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:51444 from TURN server
2022-07-31 15:01:46.903 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:51009
2022-07-31 15:01:46.911 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:46.911 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:52317 from server
2022-07-31 15:01:46.927 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:52317 from TURN server
2022-07-31 15:01:46.927 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:58877
2022-07-31 15:01:46.929 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:61833 from TURN server
2022-07-31 15:01:46.929 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:61753
2022-07-31 15:01:46.929 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN error code 437, reason "Mismatched allocation: wrong transaction ID"
2022-07-31 15:01:46.929 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: TURN allocation failed
2022-07-31 15:01:46.929 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Candidate gathering done
2022-07-31 15:01:46.930 INFO  [8620933] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to complete
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:5349"
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-local-offer
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:46.938 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:46.941 INFO  [8620941] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:5349
2022-07-31 15:01:46.942 INFO  [8620941] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.943 INFO  [8620941] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:46.969 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:51444 from TURN server
2022-07-31 15:01:46.969 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:56141
2022-07-31 15:01:46.972 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN error code 437, reason "Mismatched allocation: wrong transaction ID"
2022-07-31 15:01:46.972 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: TURN allocation failed
2022-07-31 15:01:46.972 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Candidate gathering done
2022-07-31 15:01:46.972 INFO  [8620933] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to complete
2022-07-31 15:01:47.020 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.020 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:49643 from server
2022-07-31 15:01:47.080 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:49643 from TURN server
2022-07-31 15:01:47.080 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:50790
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:5349"
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-remote-offer
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:47.105 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:47.107 INFO  [8620942] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.108 INFO  [8620942] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:5349
2022-07-31 15:01:47.109 INFO  [8620942] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.110 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.111 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.111 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.117 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN error code 437, reason "Mismatched allocation: wrong transaction ID"
2022-07-31 15:01:47.117 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: TURN allocation failed
2022-07-31 15:01:47.117 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Candidate gathering done
2022-07-31 15:01:47.117 INFO  [8620933] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to complete
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:5349"
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-remote-offer
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:47.152 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:47.153 INFO  [8620944] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.154 INFO  [8620944] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:5349
2022-07-31 15:01:47.155 INFO  [8620944] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.157 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.157 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.157 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.216 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.216 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:63953 from server
2022-07-31 15:01:47.259 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.264 INFO  [8620943] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.264 INFO  [8620949] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.264 INFO  [8620918] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.264 INFO  [8620918] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.264 INFO  [8620918] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.264 INFO  [8620918] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.292 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.292 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.292 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.292 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-remote-offer
2022-07-31 15:01:47.292 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.292 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:47.293 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:47.293 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:47.293 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:47.294 INFO  [8620950] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.295 INFO  [8620950] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.295 INFO  [8620950] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.296 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.296 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:51444 from server
2022-07-31 15:01:47.296 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Candidate gathering done
2022-07-31 15:01:47.296 INFO  [8620933] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to complete
2022-07-31 15:01:47.298 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.298 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.298 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.303 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.303 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:64240 from server
2022-07-31 15:01:47.305 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.308 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.310 INFO  [8620945] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.310 INFO  [8620952] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.310 INFO  [8620917] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.310 INFO  [8620917] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.310 INFO  [8620918] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.310 INFO  [8620918] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.341 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.341 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:56429 from server
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:5349"
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-remote-offer
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:47.353 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:47.355 INFO  [8620953] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.356 INFO  [8620953] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:5349
2022-07-31 15:01:47.356 INFO  [8620953] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.357 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.357 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.359 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.359 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.360 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.360 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.447 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.450 INFO  [8620951] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@114] Using STUN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:5349"
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::IceTransport::IceTransport@130] Using TURN server "us-turn4.xirsys.com:3478"
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to have-remote-offer
2022-07-31 15:01:47.450 INFO  [8620956] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to in-progress
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to gathering
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connecting
2022-07-31 15:01:47.450 INFO  [8620905] [rtc::impl::PeerConnection::changeState@1149] Changed state to connecting
2022-07-31 15:01:47.451 INFO  [8620957] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:5349
2022-07-31 15:01:47.452 INFO  [8620957] [rtc::impl::IceTransport::LogCallback@354] juice: Using TURN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.453 INFO  [8620957] [rtc::impl::IceTransport::LogCallback@354] juice: Using STUN server us-turn4.xirsys.com:3478
2022-07-31 15:01:47.453 INFO  [8620918] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.453 INFO  [8620918] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.453 INFO  [8620917] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.453 INFO  [8620917] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.454 INFO  [8620905] [rtc::impl::PeerConnection::changeSignalingState@1180] Changed signaling state to stable
2022-07-31 15:01:47.477 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.478 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:62862 from server
2022-07-31 15:01:47.496 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.545 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.546 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.547 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.547 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:62580 from server
2022-07-31 15:01:47.595 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:64240 from TURN server
2022-07-31 15:01:47.595 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:54028
2022-07-31 15:01:47.604 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to connected
2022-07-31 15:01:47.608 INFO  [8620958] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.609 INFO  [8620959] [rtc::impl::DtlsTransport::runRecvLoop@565] DTLS handshake finished
2022-07-31 15:01:47.609 INFO  [8620917] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.609 INFO  [8620917] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.609 INFO  [8620916] [rtc::impl::SctpTransport::processNotification@829] SCTP connected
2022-07-31 15:01:47.609 INFO  [8620916] [rtc::impl::PeerConnection::changeState@1149] Changed state to connected
2022-07-31 15:01:47.638 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: STUN server binding successful
2022-07-31 15:01:47.638 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:55183 from server
2022-07-31 15:01:47.644 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:56429 from TURN server
2022-07-31 15:01:47.645 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:64292
2022-07-31 15:01:47.653 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Changing state to completed
2022-07-31 15:01:47.685 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:62862 from TURN server
2022-07-31 15:01:47.685 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:58012
2022-07-31 15:01:47.687 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:63953 from TURN server
2022-07-31 15:01:47.687 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:54445
2022-07-31 15:01:47.697 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:56429 from TURN server
2022-07-31 15:01:47.698 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:56111
2022-07-31 15:01:47.698 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Candidate gathering done
2022-07-31 15:01:47.698 INFO  [8620933] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to complete
2022-07-31 15:01:47.710 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got STUN mapped address 172.251.73.173:64240 from TURN server
2022-07-31 15:01:47.710 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Allocated TURN relayed address 45.55.60.16:54621
2022-07-31 15:01:47.710 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Candidate gathering done
2022-07-31 15:01:47.710 INFO  [8620933] [rtc::impl::PeerConnection::changeGatheringState@1167] Changed gathering state to complete
2022-07-31 15:01:47.725 INFO  [8620933] [rtc::impl::IceTransport::LogCallback@354] juice: Got
unktomi commented 2 years ago

btw xirsys has a free tier you could test against iirc

paullouisageneau commented 2 years ago

It seems you specified the same TURN server multiple times. You shouldn't do that as the TURN server will see multiple conflicting clients. Also, you don't need a separate STUN server as TURN servers will act as STUN.

unktomi commented 2 years ago

Ah thanks. That list is returned by xirsys. Perhaps libjuice should deduplicate (and remove stun if that is also causing errors) for compatibility with browsers? Just a thought.

paullouisageneau commented 2 years ago

Perhaps libjuice should deduplicate (and remove stun if that is also causing errors) for compatibility with browsers? Just a thought.

Done in https://github.com/paullouisageneau/libjuice/pull/166