Skip to content

Instantly share code, notes, and snippets.

@kingdomcoding
Created December 13, 2024 15:42
Show Gist options
  • Save kingdomcoding/84cd007ed27adb6f58bb5f80f833789a to your computer and use it in GitHub Desktop.
Save kingdomcoding/84cd007ed27adb6f58bb5f80f833789a to your computer and use it in GitHub Desktop.
Comparing Failure on Ubuntu and Success on MacOS
@kingdomcoding
Copy link
Author

Failure on Ubuntu

2024-12-13T15:40:41Z app[2871d32f042d98] lhr [info]15:40:41.779 [debug] HANDLE EVENT "start-streaming" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:41Z app[2871d32f042d98] lhr [info]  Parameters: %{"value" => ""}
2024-12-13T15:40:41Z app[2871d32f042d98] lhr [info]15:40:41.779 [debug] Replied in 182µs
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.002 [debug] HANDLE EVENT "offer" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]  Parameters: %{"sdp" => "v=0\r\no=- 2474199741124087950 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0\r\na=extmap-allow-mixed\r\na=msid-semantic: WMS dd80f286-2abd-43bd-b2b3-f9d4067bcbfb\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 9 0 8 13 110 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:1TV9\r\na=ice-pwd:/BQJrUcJ9SI6Zh4WlyPG2lsc\r\na=ice-options:trickle\r\na=fingerprint:sha-256 57:69:36:0C:B5:D8:AB:51:9C:46:EE:8A:22:A7:A0:9E:61:AB:4F:CB:A8:04:F9:2B:EA:A4:83:54:ED:15:B7:73\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=sendrecv\r\na=msid:dd80f286-2abd-43bd-b2b3-f9d4067bcbfb c4919627-817a-4d46-9584-3611bdee7fe1\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:63 red/48000/2\r\na=fmtp:63 111/111\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:4053293191 cname:Ies3yqFtGpPJ5nmq\r\na=ssrc:4053293191 msid:dd80f286-2abd-43bd-b2b3-f9d4067bcbfb c4919627-817a-4d46-9584-3611bdee7fe1\r\n", "type" => "offer"}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.079 [debug] Started DTLSTransport with role active
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.080 [debug] Changing PeerConnection signaling state state: stable -> have_remote_offer
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.080 [debug] Setting remote credentials: "1TV9":"/BQJrUcJ9SI6Zh4WlyPG2lsc"
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {172, 19, 11, 138}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.081 [debug] Changing PeerConnection signaling state state: have_remote_offer -> stable
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.081 [debug] Gathering state change: new -> gathering
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {172, 19, 11, 139}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: true
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {9732, 4992, 33, 32770, 0, 11848, 25930, 1}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {64938, 0, 19320, 2683, 846, 11848, 25930, 2}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {65152, 0, 0, 0, 56493, 22783, 65210, 17274}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.087 [debug] Successfully opened socket for: {172, 19, 11, 139}:32774
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.087 [debug] New candidate: %ExICE.Priv.Candidate.Host{base: #ExICE.Priv.CandidateBase<id: 25009563706076201531666145003, address: {172, 19, 11, 139}, foundation: 1518088250, port: 32774, priority: 2130706431, transport: :udp, transport_module: ExICE.Priv.Transport.UDP, type: :host, base_address: {172, 19, 11, 139}, base_port: 32774, ...>}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.087 [debug] Starting Ta timer
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.088 [debug] Sending binding request to gather srflx candidate for:
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]socket: {172, 19, 11, 139}:32774,
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]stun_server: %{url: %ExSTUN.URI{scheme: :stun, host: "stun.l.google.com", port: 19302, transport: nil}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.090 [debug] Received gathering transaction response from: {{74, 125, 250, 129}, 19302}, on: {{172, 19, 11, 139}, 32774}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.090 [debug] New srflx candidate: %ExICE.Priv.Candidate.Srflx{base: #ExICE.Priv.CandidateBase<id: 67534220454306320567418893123, address: {145, 40, 115, 247}, foundation: 3403588210, port: 32774, priority: 1694498815, transport: :udp, transport_module: ExICE.Priv.Transport.UDP, type: :srflx, base_address: {172, 19, 11, 139}, base_port: 32774, ...>}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.139 [debug] Sending binding request to gather srflx candidate for:
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]socket: {172, 19, 11, 139}:32774,
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]stun_server: %{url: %ExSTUN.URI{scheme: :stun, host: "stun.cloudflare.com", port: 3478, transport: nil}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.143 [debug] Received gathering transaction response from: {{141, 101, 90, 0}, 3478}, on: {{172, 19, 11, 139}, 32774}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.144 [debug] Not adding srflx candidate as we already have a candidate with the same address.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Candidate: %ExICE.Priv.Candidate.Srflx{base: #ExICE.Priv.CandidateBase<id: 67534220454306320567418893123, address: {145, 40, 115, 247}, foundation: 3403588210, port: 32774, priority: 1694498815, transport: :udp, transport_module: ExICE.Priv.Transport.UDP, type: :srflx, base_address: {172, 19, 11, 139}, base_port: 32774, ...>}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.144 [debug] Gathering state change: gathering -> complete
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.144 [debug] Stopping Ta timer
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.144 [debug] Replied in 142ms
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.144 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:1484005343 1 udp 2122260223 192.168.186.202 33512 typ host generation 0 ufrag 1TV9 network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"1TV9\"}"
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.144 [debug] Replied in 291µs
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.145 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:649854279 1 tcp 1518280447 192.168.186.202 9 typ host tcptype active generation 0 ufrag 1TV9 network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"1TV9\"}"
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.145 [debug] Unmarshalling remote candidate: 1484005343 1 udp 2122260223 192.168.186.202 33512 typ host generation 0 ufrag 1TV9 network-id 1 network-cost 10
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.145 [debug] Successfully unmarshaled candidate.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Raw candidate: 1484005343 1 udp 2122260223 192.168.186.202 33512 typ host generation 0 ufrag 1TV9 network-id 1 network-cost 10.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Unmarshaled candidate: %ExICE.Candidate{id: 36503890268387094926299987526, type: :host, address: {192, 168, 186, 202}, port: 33512, foundation: 3927285532, priority: 2122260223, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.145 [debug] New remote candidate: %ExICE.Candidate{id: 36503890268387094926299987526, type: :host, address: {192, 168, 186, 202}, port: 33512, foundation: 3927285532, priority: 2122260223, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.145 [debug] Replied in 367µs
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] New candidate pairs: %{41870881509799981129060567284 => %ExICE.Priv.CandidatePair{id: 41870881509799981129060567284, local_cand_id: 25009563706076201531666145003, remote_cand_id: 36503890268387094926299987526, priority: 9115038255648079870, nominate?: false, nominated?: false, state: :waiting, valid?: false, succeeded_pair_id: nil, discovered_pair_id: nil, keepalive_timer: nil, last_seen: nil}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:3468458246 1 udp 1686052607 197.211.58.96 51097 typ srflx raddr 192.168.186.202 rport 33512 generation 0 ufrag 1TV9 network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"1TV9\"}"
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] Successfully added remote candidate.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] Connection state change: new -> checking
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] Replied in 768µs
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] Changing PeerConnection state: new -> connecting
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.146 [debug] Starting Ta timer
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.147 [debug] Unmarshalling remote candidate: 649854279 1 tcp 1518280447 192.168.186.202 9 typ host tcptype active generation 0 ufrag 1TV9 network-id 1 network-cost 10
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.147 [warning] Couldn't unmarshal candidate, reason: {:unmarshal, :invalid_transport}.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Candidate: 649854279 1 tcp 1518280447 192.168.186.202 9 typ host tcptype active generation 0 ufrag 1TV9 network-id 1 network-cost 10
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.147 [debug] Unmarshalling remote candidate: 3468458246 1 udp 1686052607 197.211.58.96 51097 typ srflx raddr 192.168.186.202 rport 33512 generation 0 ufrag 1TV9 network-id 1 network-cost 10
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.147 [debug] Successfully unmarshaled candidate.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Raw candidate: 3468458246 1 udp 1686052607 197.211.58.96 51097 typ srflx raddr 192.168.186.202 rport 33512 generation 0 ufrag 1TV9 network-id 1 network-cost 10.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Unmarshaled candidate: %ExICE.Candidate{id: 74300605710391538546933277220, type: :srflx, address: {197, 211, 58, 96}, port: 51097, foundation: 1252947498, priority: 1686052607, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.147 [debug] New remote candidate: %ExICE.Candidate{id: 74300605710391538546933277220, type: :srflx, address: {197, 211, 58, 96}, port: 51097, foundation: 1252947498, priority: 1686052607, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.148 [debug] New candidate pairs: %{22231999230431538133495050883 => %ExICE.Priv.CandidatePair{id: 22231999230431538133495050883, local_cand_id: 25009563706076201531666145003, remote_cand_id: 74300605710391538546933277220, priority: 7241540810661953534, nominate?: false, nominated?: false, state: :waiting, valid?: false, succeeded_pair_id: nil, discovered_pair_id: nil, keepalive_timer: nil, last_seen: nil}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.148 [debug] Successfully added remote candidate.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.148 [debug] Sending conn check on pair: 41870881509799981129060567284
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.180 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:3468458246 1 udp 1686052607 197.211.58.96 26196 typ srflx raddr 192.168.186.202 rport 33512 generation 0 ufrag 1TV9 network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"1TV9\"}"
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.180 [debug] Replied in 262µs
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.180 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]  Parameters: "null"
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.180 [debug] Unmarshalling remote candidate: 3468458246 1 udp 1686052607 197.211.58.96 26196 typ srflx raddr 192.168.186.202 rport 33512 generation 0 ufrag 1TV9 network-id 1 network-cost 10
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.181 [debug] Successfully unmarshaled candidate.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Raw candidate: 3468458246 1 udp 1686052607 197.211.58.96 26196 typ srflx raddr 192.168.186.202 rport 33512 generation 0 ufrag 1TV9 network-id 1 network-cost 10.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Unmarshaled candidate: %ExICE.Candidate{id: 15572305962245842627698558637, type: :srflx, address: {197, 211, 58, 96}, port: 26196, foundation: 1252947498, priority: 1686052607, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.181 [debug] New remote candidate: %ExICE.Candidate{id: 15572305962245842627698558637, type: :srflx, address: {197, 211, 58, 96}, port: 26196, foundation: 1252947498, priority: 1686052607, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.181 [debug] Replied in 771µs
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.181 [debug] New candidate pairs: %{19924486017719737458236836759 => %ExICE.Priv.CandidatePair{id: 19924486017719737458236836759, local_cand_id: 25009563706076201531666145003, remote_cand_id: 15572305962245842627698558637, priority: 7241540810661953534, nominate?: false, nominated?: false, state: :frozen, valid?: false, succeeded_pair_id: nil, discovered_pair_id: nil, keepalive_timer: nil, last_seen: nil}}
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.181 [debug] Successfully added remote candidate.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.181 [debug] Setting end-of-candidates flag.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.200 [debug] Sending conn check on pair: 19924486017719737458236836759
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.251 [debug] Sending conn check on pair: 22231999230431538133495050883
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.302 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.353 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.404 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.455 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.506 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.557 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.608 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.649 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Conn check transaction id:  64445172151259843578642309243
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.659 [debug] Retransmitting conn check: 64445172151259843578642309243
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.701 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Conn check transaction id:  58224232879478724750702464908
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.710 [debug] Retransmitting conn check: 58224232879478724750702464908
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.752 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]Conn check transaction id:  30740397416417264108552753880
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.761 [debug] Retransmitting conn check: 30740397416417264108552753880
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.812 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.863 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.914 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:42Z app[2871d32f042d98] lhr [info]15:40:42.965 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.016 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.067 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.118 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.160 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]Conn check transaction id:  64445172151259843578642309243
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.169 [debug] Retransmitting conn check: 64445172151259843578642309243
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.211 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]Conn check transaction id:  58224232879478724750702464908
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.220 [debug] Retransmitting conn check: 58224232879478724750702464908
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.262 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]Conn check transaction id:  30740397416417264108552753880
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.271 [debug] Retransmitting conn check: 30740397416417264108552753880
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.322 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.373 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.424 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.475 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.526 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.577 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.628 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.670 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]Conn check transaction id:  64445172151259843578642309243
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.679 [debug] Retransmitting conn check: 64445172151259843578642309243
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.721 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]Conn check transaction id:  58224232879478724750702464908
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.730 [debug] Retransmitting conn check: 58224232879478724750702464908
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.772 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]Conn check transaction id:  30740397416417264108552753880
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.781 [debug] Retransmitting conn check: 30740397416417264108552753880
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.832 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.883 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.934 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:43Z app[2871d32f042d98] lhr [info]15:40:43.985 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.036 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.087 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.138 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.180 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]Conn check transaction id:  64445172151259843578642309243
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.189 [debug] Connectivity checks timed out: [64445172151259843578642309243]
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.189 [debug] Pairs failed. Reason: timeout. Pairs: [41870881509799981129060567284]
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.189 [debug] Tried to retransmit transaction but it is no longer in-progress. Ignoring.
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]Transaction id: 64445172151259843578642309243
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.231 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]Conn check transaction id:  58224232879478724750702464908
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.240 [debug] Connectivity checks timed out: [58224232879478724750702464908]
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.240 [debug] Pairs failed. Reason: timeout. Pairs: [19924486017719737458236836759]
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.240 [debug] Tried to retransmit transaction but it is no longer in-progress. Ignoring.
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]Transaction id: 58224232879478724750702464908
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.282 [debug] Scheduling conn check for retransmission.
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]Conn check transaction id:  30740397416417264108552753880
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Connectivity checks timed out: [30740397416417264108552753880]
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Pairs failed. Reason: timeout. Pairs: [22231999230431538133495050883]
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Finished all conn checks, there won't be any further local or remote candidates
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]and we don't have any valid or selected pair. Changing connection state to failed.
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Connection state change: checking -> failed
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Changing PeerConnection state: connecting -> failed
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Stopping PeerConnection
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Closing peer connection with reason: {:shutdown, :conn_state_failed}
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Stopping DTLSTransport with reason: :normal
2024-12-13T15:40:44Z app[2871d32f042d98] lhr [info]15:40:44.291 [debug] Stopping ICE agent with reason: :normal
2024-12-13T15:40:57Z app[2871d32f042d98] lhr [info]15:40:57.684 [debug] HANDLE EVENT "stop-streaming" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:40:57Z app[2871d32f042d98] lhr [info]  Parameters: %{"reason" => "failed"}
2024-12-13T15:40:57Z app[2871d32f042d98] lhr [info]15:40:57.684 [debug] Replied in 155µs

@kingdomcoding
Copy link
Author

Success on MacOS

2024-12-13T15:43:05Z app[2871d32f042d98] lhr [info]15:43:05.782 [debug] HANDLE EVENT "start-streaming" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:05Z app[2871d32f042d98] lhr [info]  Parameters: %{"value" => ""}
2024-12-13T15:43:05Z app[2871d32f042d98] lhr [info]15:43:05.783 [debug] Replied in 188µs
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:05.982 [debug] HANDLE EVENT "offer" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  Parameters: %{"sdp" => "v=0\r\no=- 4889677355042993845 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0\r\na=extmap-allow-mixed\r\na=msid-semantic: WMS a31b9432-5f39-49e9-a733-206dcc574bb4\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 9 0 8 13 110 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:w+Hi\r\na=ice-pwd:pm7YHspqOkmazoap2YPJbLuU\r\na=ice-options:trickle\r\na=fingerprint:sha-256 F1:08:05:C2:19:D6:C8:67:FA:7A:EC:79:04:A8:78:24:00:34:5A:71:DE:41:58:D9:3E:A6:66:71:DE:9A:96:45\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=sendrecv\r\na=msid:a31b9432-5f39-49e9-a733-206dcc574bb4 b5faa931-9ce5-41c9-aefd-c41012a2fcb0\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:63 red/48000/2\r\na=fmtp:63 111/111\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:76042512 cname:0YvCgnikqOw2Kvk+\r\na=ssrc:76042512 msid:a31b9432-5f39-49e9-a733-206dcc574bb4 b5faa931-9ce5-41c9-aefd-c41012a2fcb0\r\n", "type" => "offer"}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.066 [debug] Started DTLSTransport with role active
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.067 [debug] Changing PeerConnection signaling state state: stable -> have_remote_offer
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.067 [debug] Setting remote credentials: "w+Hi":"pm7YHspqOkmazoap2YPJbLuU"
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {172, 19, 11, 138}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.068 [debug] Changing PeerConnection signaling state state: have_remote_offer -> stable
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.068 [debug] Gathering state change: new -> gathering
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {172, 19, 11, 139}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: true
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {9732, 4992, 33, 32770, 0, 11848, 25930, 1}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {64938, 0, 19320, 2683, 846, 11848, 25930, 2}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter ip_address: {65152, 0, 0, 0, 56493, 22783, 65210, 17274}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter :inet.gethostbyname(fly-global-services): {:ok, {:hostent, ~c"fly-global-services", [], :inet, 4, [{172, 19, 11, 139}]}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]ExWebRTC.ICE.FlyIpFilter equal?: false
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.073 [debug] Successfully opened socket for: {172, 19, 11, 139}:52503
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.074 [debug] New candidate: %ExICE.Priv.Candidate.Host{base: #ExICE.Priv.CandidateBase<id: 78189651245189292764305152645, address: {172, 19, 11, 139}, foundation: 1518088250, port: 52503, priority: 2130706431, transport: :udp, transport_module: ExICE.Priv.Transport.UDP, type: :host, base_address: {172, 19, 11, 139}, base_port: 52503, ...>}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.074 [debug] Starting Ta timer
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.074 [debug] Sending binding request to gather srflx candidate for:
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]socket: {172, 19, 11, 139}:52503,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]stun_server: %{url: %ExSTUN.URI{scheme: :stun, host: "stun.l.google.com", port: 19302, transport: nil}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.076 [debug] Received gathering transaction response from: {{74, 125, 250, 129}, 19302}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.076 [debug] New srflx candidate: %ExICE.Priv.Candidate.Srflx{base: #ExICE.Priv.CandidateBase<id: 2893976835644583881548436277, address: {145, 40, 115, 247}, foundation: 3403588210, port: 52503, priority: 1694498815, transport: :udp, transport_module: ExICE.Priv.Transport.UDP, type: :srflx, base_address: {172, 19, 11, 139}, base_port: 52503, ...>}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.125 [debug] Sending binding request to gather srflx candidate for:
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]socket: {172, 19, 11, 139}:52503,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]stun_server: %{url: %ExSTUN.URI{scheme: :stun, host: "stun.cloudflare.com", port: 3478, transport: nil}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.130 [debug] Received gathering transaction response from: {{141, 101, 90, 0}, 3478}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.130 [debug] Not adding srflx candidate as we already have a candidate with the same address.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Candidate: %ExICE.Priv.Candidate.Srflx{base: #ExICE.Priv.CandidateBase<id: 2893976835644583881548436277, address: {145, 40, 115, 247}, foundation: 3403588210, port: 52503, priority: 1694498815, transport: :udp, transport_module: ExICE.Priv.Transport.UDP, type: :srflx, base_address: {172, 19, 11, 139}, base_port: 52503, ...>}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.130 [debug] Gathering state change: gathering -> complete
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.130 [debug] Stopping Ta timer
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.131 [debug] Replied in 148ms
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.131 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:2906543209 1 udp 2122260223 192.168.0.153 62951 typ host generation 0 ufrag w+Hi network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"w+Hi\"}"
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.131 [debug] Replied in 250µs
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.131 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:1402241277 1 tcp 1518280447 192.168.0.153 9 typ host tcptype active generation 0 ufrag w+Hi network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"w+Hi\"}"
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.131 [debug] Unmarshalling remote candidate: 2906543209 1 udp 2122260223 192.168.0.153 62951 typ host generation 0 ufrag w+Hi network-id 1 network-cost 10
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.131 [debug] Successfully unmarshaled candidate.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Raw candidate: 2906543209 1 udp 2122260223 192.168.0.153 62951 typ host generation 0 ufrag w+Hi network-id 1 network-cost 10.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Unmarshaled candidate: %ExICE.Candidate{id: 35430373998515385429015145870, type: :host, address: {192, 168, 0, 153}, port: 62951, foundation: 1153222602, priority: 2122260223, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] New remote candidate: %ExICE.Candidate{id: 35430373998515385429015145870, type: :host, address: {192, 168, 0, 153}, port: 62951, foundation: 1153222602, priority: 2122260223, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Replied in 342µs
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] New candidate pairs: %{35957693016541852371376704849 => %ExICE.Priv.CandidatePair{id: 35957693016541852371376704849, local_cand_id: 78189651245189292764305152645, remote_cand_id: 35430373998515385429015145870, priority: 9115038255648079870, nominate?: false, nominated?: false, state: :waiting, valid?: false, succeeded_pair_id: nil, discovered_pair_id: nil, keepalive_timer: nil, last_seen: nil}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  Parameters: "{\"candidate\":\"candidate:1827668771 1 udp 1686052607 102.91.93.14 52550 typ srflx raddr 192.168.0.153 rport 62951 generation 0 ufrag w+Hi network-id 1 network-cost 10\",\"sdpMid\":\"0\",\"sdpMLineIndex\":0,\"usernameFragment\":\"w+Hi\"}"
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Successfully added remote candidate.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Connection state change: new -> checking
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Replied in 217µs
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Changing PeerConnection state: new -> connecting
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Starting Ta timer
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Unmarshalling remote candidate: 1402241277 1 tcp 1518280447 192.168.0.153 9 typ host tcptype active generation 0 ufrag w+Hi network-id 1 network-cost 10
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [warning] Couldn't unmarshal candidate, reason: {:unmarshal, :invalid_transport}.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Candidate: 1402241277 1 tcp 1518280447 192.168.0.153 9 typ host tcptype active generation 0 ufrag w+Hi network-id 1 network-cost 10
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Unmarshalling remote candidate: 1827668771 1 udp 1686052607 102.91.93.14 52550 typ srflx raddr 192.168.0.153 rport 62951 generation 0 ufrag w+Hi network-id 1 network-cost 10
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Successfully unmarshaled candidate.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Raw candidate: 1827668771 1 udp 1686052607 102.91.93.14 52550 typ srflx raddr 192.168.0.153 rport 62951 generation 0 ufrag w+Hi network-id 1 network-cost 10.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Unmarshaled candidate: %ExICE.Candidate{id: 39970813382154653906692890363, type: :srflx, address: {102, 91, 93, 14}, port: 52550, foundation: 3747844305, priority: 1686052607, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] New remote candidate: %ExICE.Candidate{id: 39970813382154653906692890363, type: :srflx, address: {102, 91, 93, 14}, port: 52550, foundation: 3747844305, priority: 1686052607, transport: :udp, base_address: nil, base_port: nil}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] New candidate pairs: %{54522832466332266618384203071 => %ExICE.Priv.CandidatePair{id: 54522832466332266618384203071, local_cand_id: 78189651245189292764305152645, remote_cand_id: 39970813382154653906692890363, priority: 7241540810661953534, nominate?: false, nominated?: false, state: :waiting, valid?: false, succeeded_pair_id: nil, discovered_pair_id: nil, keepalive_timer: nil, last_seen: nil}}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Successfully added remote candidate.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.132 [debug] Sending conn check on pair: 35957693016541852371376704849
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.172 [debug] HANDLE EVENT "ice" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  Parameters: "null"
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.173 [debug] Setting end-of-candidates flag.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.173 [debug] Replied in 210µs
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.183 [debug] Sending conn check on pair: 54522832466332266618384203071
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.234 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.285 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.336 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.352 [debug] Received binding request from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.352 [debug] Nomination request on pair that hasn't been verified yet.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]We will nominate pair once conn check passes.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Pair: 54522832466332266618384203071
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.387 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.438 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.474 [debug] Received binding request from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.474 [debug] Nomination request on pair that hasn't been verified yet.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]We will nominate pair once conn check passes.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Pair: 54522832466332266618384203071
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.489 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.531 [debug] Received binding request from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.531 [debug] Nomination request on pair that hasn't been verified yet.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]We will nominate pair once conn check passes.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Pair: 54522832466332266618384203071
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.540 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.591 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.633 [debug] Scheduling conn check for retransmission.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Conn check transaction id:  21558352223628567438701142281
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.642 [debug] Retransmitting conn check: 21558352223628567438701142281
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.684 [debug] Scheduling conn check for retransmission.
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]Conn check transaction id:  30173080209620820387631552719
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.693 [debug] Retransmitting conn check: 30173080209620820387631552719
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.744 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.795 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]handle_conn_check_success_response CandidatePair.new: %ExICE.Priv.CandidatePair{
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  id: 35531503906009288243999708138,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  local_cand_id: 2893976835644583881548436277,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  remote_cand_id: 39970813382154653906692890363,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  priority: 7241540809789538302,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  nominate?: false,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  nominated?: false,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  state: :succeeded,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  valid?: true,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  succeeded_pair_id: nil,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  discovered_pair_id: nil,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  keepalive_timer: nil,
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]  last_seen: nil
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] Received conn check response from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] Adding new candidate pair resulted from conn check on pair: 54522832466332266618384203071. Pair: %ExICE.Priv.CandidatePair{id: 35531503906009288243999708138, local_cand_id: 2893976835644583881548436277, remote_cand_id: 39970813382154653906692890363, priority: 7241540809789538302, nominate?: false, nominated?: false, state: :succeeded, valid?: true, succeeded_pair_id: nil, discovered_pair_id: nil, keepalive_timer: nil, last_seen: nil}
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] New valid pair: 35531503906009288243999708138
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] Nomination succeeded, pair: 35531503906009288243999708138
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] Selecting pair: 35531503906009288243999708138
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] Found a valid pair. Changing connection state to connected
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.831 [debug] Connection state change: checking -> connected
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.832 [debug] Changing DTLS state: new -> connecting
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.832 [debug] Started DTLS handshake
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.846 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.897 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:06Z app[2871d32f042d98] lhr [info]15:43:06.948 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:06.999 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.050 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.101 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.122 [debug] DTLS handshake finished
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.122 [debug] Changing DTLS state: connecting -> connected
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.123 [debug] Changing PeerConnection state: connecting -> connected
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.143 [debug] Scheduling conn check for retransmission.
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]Conn check transaction id:  21558352223628567438701142281
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.152 [debug] Retransmitting conn check: 21558352223628567438701142281
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.194 [debug] Transaction timeout timer fired but there is no such transaction in progress. Ignoring.
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]Transaction id: 30173080209620820387631552719
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.203 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.254 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.305 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.356 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.407 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.458 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.509 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.560 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.611 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.653 [debug] Scheduling conn check for retransmission.
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]Conn check transaction id:  21558352223628567438701142281
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.662 [debug] Retransmitting conn check: 21558352223628567438701142281
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.713 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.726 [debug] Received binding request from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.765 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.815 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.866 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.917 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:07Z app[2871d32f042d98] lhr [info]15:43:07.968 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.019 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.070 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.121 [debug] No transaction to execute. Did Ta timer fired without the need?
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.163 [debug] Scheduling conn check for retransmission.
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]Conn check transaction id:  21558352223628567438701142281
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.172 [debug] Connectivity checks timed out: [21558352223628567438701142281]
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.172 [debug] Pairs failed. Reason: timeout. Pairs: [35957693016541852371376704849]
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.172 [debug] Finished all conn checks, there won't be any further local or remote candidates
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]and we have selected pair. Changing connection state to completed.
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.173 [debug] Connection state change: connected -> completed
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.173 [debug] Stopping Ta timer
2024-12-13T15:43:08Z app[2871d32f042d98] lhr [info]15:43:08.779 [debug] Received binding request from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:11Z app[2871d32f042d98] lhr [info]15:43:11.437 [debug] Received binding request from: {{102, 91, 93, 14}, 52550}, on: {{172, 19, 11, 139}, 52503}
2024-12-13T15:43:11Z app[2871d32f042d98] lhr [info]15:43:11.832 [debug] Sending keepalive on 35531503906009288243999708138 l: 145.40.115.247:52503 r: 102.91.93.14:52550
2024-12-13T15:43:11Z app[2871d32f042d98] lhr [info]15:43:11.970 [debug] Received keepalive success response on: 35531503906009288243999708138 l: 145.40.115.247:52503 r: 102.91.93.14:52550
2024-12-13T15:43:12Z app[2871d32f042d98] lhr [info]15:43:12.483 [debug] HANDLE EVENT "stop-streaming" in SolvingMediaWeb.LiveExWebRTC.AudioPublisher
2024-12-13T15:43:12Z app[2871d32f042d98] lhr [info]  Parameters: %{"value" => ""}
2024-12-13T15:43:12Z app[2871d32f042d98] lhr [info]15:43:12.483 [debug] Replied in 128µs
2024-12-13T15:43:12Z app[2871d32f042d98] lhr [info]15:43:12.628 [debug] DTLS error: peer_closed_for_writing
2024-12-13T15:43:12Z app[2871d32f042d98] lhr [info]15:43:12.628 [debug] Stopping DTLSTransport with reason: {:shutdown, :peer_closed_for_writing}

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