Skip to content

Instantly share code, notes, and snippets.

@cristaloleg

cristaloleg/gist:3d0fcf209a357c5815c7f0de7e05bd95

Created July 5, 2022 07:35
Show Gist options
  • Save cristaloleg/3d0fcf209a357c5815c7f0de7e05bd95 to your computer and use it in GitHub Desktop.
Save cristaloleg/3d0fcf209a357c5815c7f0de7e05bd95 to your computer and use it in GitHub Desktop.
Download ZIP
Membrane debug log
Raw
gistfile1.txt
olegkovalov@oleg-mbp membrane_videoroom % docker build -t membrane_videoroom_advanced .
olegkovalov@oleg-mbp membrane_videoroom % docker run -p 50000-50050:50000-50050/udp -p 4000:4000/tcp --env-file .env membrane_videoroom_advanced
ck_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "4b8088d9-61c3-4d52-b679-4e02e079a4f3"]}, pid: #PID<0.2420.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240205>, sync: :membrane_no_sync, terminating?: false}
07:31:16.060 [debug] [:endpoint_bin bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.Funnel, name: :ice_funnel, options: %Membrane.Funnel{end_of_stream: :on_last_pad}, pid: #PID<0.2426.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240205>, sync: :membrane_no_sync, terminating?: false}
07:31:16.060 [debug] [:endpoint_bin bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTP.SessionBin, name: :rtp, options: %Membrane.RTP.SessionBin{fmt_mapping: %{}, receiver_srtp_policies: nil, receiver_ssrc_generator: &Membrane.RTP.SessionBin.generate_receiver_ssrc/2, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, secure?: true, srtp_policies: []}, pid: #PID<0.2427.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240205>, sync: :membrane_no_sync, terminating?: false}
07:31:16.060 [debug] [:endpoint_bin bin] Changing playback state from stopped to prepared
07:31:16.061 [debug] [:rtp bin] Changing playback state from stopped to prepared
07:31:16.061 [debug] [:rtp bin] Playback state changed from stopped to prepared
07:31:16.061 [debug] [:endpoint_bin bin] Playback state changed from stopped to prepared
07:31:16.061 [debug] [{:endpoint, "4b8088d9-61c3-4d52-b679-4e02e079a4f3"} bin] Playback state changed from stopped to prepared
07:31:16.061 [debug] [{:endpoint, "4b8088d9-61c3-4d52-b679-4e02e079a4f3"} bin] Changing playback state from prepared to playing
07:31:16.061 [debug] [:endpoint_bin bin] Changing playback state from prepared to playing
07:31:16.062 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 7µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"renegotiateTracks\"}}"}
07:31:16.062 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 0µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"renegotiateTracks\"}}"}
07:31:16.062 [debug] [:rtp bin] Changing playback state from prepared to playing
07:31:16.063 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240202>}] Evaluating playback buffer
07:31:16.063 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240202>}] Evaluating playback buffer
07:31:16.063 [debug] [:ice_funnel] Evaluating playback buffer
07:31:16.064 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240202>}] Sending caps through pad {Membrane.Pad, :rtcp_output, #Reference<0.2131086919.1186463748.240145>}
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.064 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240202>}] Evaluating playback buffer
07:31:16.064 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240202>}] Sending caps through pad :receiver_report_output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.064 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240202>}] Evaluating playback buffer
07:31:16.064 [debug] [:ssrc_router] Evaluating playback buffer
07:31:16.064 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240202>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.064 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240202>}] Sending caps through pad :output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.064 [debug] [:rtp bin] Playback state changed from prepared to playing
07:31:16.065 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240202>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.065 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240202>}] Sending caps through pad :output
Caps: %Membrane.RTCP{}
07:31:16.065 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240202>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.065 [debug] [:ssrc_router] Received caps on pad {Membrane.Pad, :input, {:rtcp, #Reference<0.2131086919.1186463745.240202>}}
Caps: %Membrane.RTCP{}
07:31:16.065 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240202>}] Sending caps through pad :output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.065 [debug] [:ice_funnel] Received caps on pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240238>}
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.065 [debug] [:ice_funnel] Sending caps through pad :output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.070 [debug] [:ice] Starting udp TURN Server at "0.0.0.0":52066
07:31:16.070 [debug] [:ice] Sending caps through pad {Membrane.Pad, :output, 1}
Caps: %Membrane.RemoteStream{content_format: nil, type: :packetized}
07:31:16.070 [debug] [:ice] Evaluating playback buffer
07:31:16.070 [debug] [:ice] Received caps on pad {Membrane.Pad, :input, 1}
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:16.070 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240202>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: nil, type: :packetized}
07:31:16.070 [debug] [:endpoint_bin bin] Playback state changed from prepared to playing
07:31:16.070 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240202>}] Sending caps through pad :output
Caps: %Membrane.RTP{}
07:31:16.070 [debug] [:ssrc_router] Received caps on pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240202>}
Caps: %Membrane.RTP{}
07:31:16.071 [debug] [{:endpoint, "4b8088d9-61c3-4d52-b679-4e02e079a4f3"} bin] Playback state changed from prepared to playing
07:31:16.081 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 18µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 2 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:KRBG\\r\\na=ice-pwd:0LMiOvdop7m3AsXqWoBueFLi\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:KRBG\\r\\na=ice-pwd:0LMiOvdop7m3AsXqWoBueFLi\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\n" <> ...}
07:31:21.071 [debug] [:ice] ICE restart failed due to timeout
07:31:21.107 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 6µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 3 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:Uk1Y\\r\\na=ice-pwd:SiPSwsFRw5x0+GVOotTj2gal\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:Uk1Y\\r\\na=ice-pwd:SiPSwsFRw5x0+GVOotTj2gal\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\n" <> ...}
07:31:26.073 [debug] [:ice] ICE restart failed due to timeout
07:31:26.095 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 50µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 4 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:x3hA\\r\\na=ice-pwd:9gw5bs650EDMfJKg1fEdk9Kl\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:x3hA\\r\\na=ice-pwd:9gw5bs650EDMfJKg1fEdk9Kl\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\n" <> ...}
07:31:31.075 [debug] [:ice] ICE restart failed due to timeout
07:31:31.095 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 10µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 5 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:/ZbA\\r\\na=ice-pwd:Dza3cYgdvUNbn/SaTYtYB6re\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:/ZbA\\r\\na=ice-pwd:Dza3cYgdvUNbn/SaTYtYB6re\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\n" <> ...}
07:31:33.297 [debug] Processing with VideoRoomWeb.RoomController.index/2
Parameters: %{"room_id" => "1"}
Pipelines: [:browser]
07:31:33.315 [debug] Processing with VideoRoomWeb.PageController.index/2
Parameters: %{"room_id" => "1"}
Pipelines: [:browser]
07:31:36.076 [debug] [:ice] ICE restart failed due to timeout
07:31:36.097 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 7µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 6 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:0tWU\\r\\na=ice-pwd:aFz0QEvZhMMPAgGlXmLkYsYw\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:0tWU\\r\\na=ice-pwd:aFz0QEvZhMMPAgGlXmLkYsYw\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir\\r\\n" <> ...}
07:31:38.746 [debug] Processing with VideoRoomWeb.PageController.index/2
Parameters: %{}
Pipelines: [:browser]
07:31:39.805 [debug] Processing with VideoRoomWeb.PageController.enter/2
Parameters: %{"display_name" => "anon", "room_id" => "1", "room_name" => "1"}
Pipelines: [:browser]
07:31:39.831 [debug] Processing with VideoRoomWeb.RoomController.index/2
Parameters: %{"display_name" => "anon", "room_id" => "1"}
Pipelines: [:browser]
07:31:39.871 [info] CONNECTED TO VideoRoomWeb.UserSocket in 29µs
Transport: :websocket
Serializer: Phoenix.Socket.V2.JSONSerializer
Parameters: %{"vsn" => "2.0.0"}
07:31:39.922 [info] JOINED room:1 in 68µs
Parameters: %{}
07:31:39.930 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 6µs
Parameters: %{"data" => "{\"type\":\"join\",\"data\":{\"metadata\":{\"displayName\":\"anon\"}}}"}
07:31:39.930 [info] New peer: %Membrane.RTC.Engine.Peer{id: "3dba8630-950a-4f17-9624-31be46973a2c", metadata: %{"displayName" => "anon"}}. Accepting.
07:31:39.931 [debug] [pipeline@<0.2414.0>] Initializing spec
children: %{{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} => %Membrane.RTC.Engine.Endpoint.WebRTC{direction: :sendrecv, extensions: %{}, filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, ...>>], ice_name: "3dba8630-950a-4f17-9624-31be46973a2c", integrated_turn_domain: "localhost", integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], owner: #PID<0.2412.0>, rtc_engine: #PID<0.2414.0>, rtcp_fir_interval: 1000000000, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast_config: %Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig{default_encoding: &Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig.default_encoding/1, enabled: false}, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, video_tracks_limit: nil, webrtc_extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC]}}
links: []
07:31:39.931 [debug] [pipeline@<0.2414.0>] Starting children: [%Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTC.Engine.Endpoint.WebRTC, name: {:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"}, options: %Membrane.RTC.Engine.Endpoint.WebRTC{direction: :sendrecv, extensions: %{}, filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, ...>>], ice_name: "3dba8630-950a-4f17-9624-31be46973a2c", integrated_turn_domain: "localhost", integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], owner: #PID<0.2412.0>, rtc_engine: #PID<0.2414.0>, rtcp_fir_interval: 1000000000, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast_config: %Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig{default_encoding: &Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig.default_encoding/1, enabled: false}, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, video_tracks_limit: nil, webrtc_extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC]}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240393>, sync: nil, terminating?: false}]
07:31:39.931 [debug] [pipeline@<0.2414.0>] Starting child: name: {:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"}, module: Membrane.RTC.Engine.Endpoint.WebRTC
07:31:39.931 [debug] [pipeline@<0.2414.0>] Bin start: {:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"}
node: ,
module: Membrane.RTC.Engine.Endpoint.WebRTC,
bin options: %Membrane.RTC.Engine.Endpoint.WebRTC{direction: :sendrecv, extensions: %{}, filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, 29, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, 49, ...>>], ice_name: "3dba8630-950a-4f17-9624-31be46973a2c", integrated_turn_domain: "localhost", integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], owner: #PID<0.2412.0>, rtc_engine: #PID<0.2414.0>, rtcp_fir_interval: 1000000000, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast_config: %Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig{default_encoding: &Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig.default_encoding/1, enabled: false}, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, video_tracks_limit: nil, webrtc_extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC]}
07:31:39.932 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Initializing spec
children: %{endpoint_bin: %Membrane.WebRTC.EndpointBin{direction: :sendrecv, extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC], filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, ...>>], inbound_tracks: [], integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], outbound_tracks: [], rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast?: false, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, trace_metadata: [name: "3dba8630-950a-4f17-9624-31be46973a2c"]}}
links: []
07:31:39.932 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Starting children: [%Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.WebRTC.EndpointBin, name: :endpoint_bin, options: %Membrane.WebRTC.EndpointBin{direction: :sendrecv, extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC], filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, ...>>], inbound_tracks: [], integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], outbound_tracks: [], rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast?: false, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, trace_metadata: [name: "3dba8630-950a-4f17-9624-31be46973a2c"]}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240402>, sync: nil, terminating?: false}]
07:31:39.932 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Starting child: name: :endpoint_bin, module: Membrane.WebRTC.EndpointBin
07:31:39.932 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Bin start: :endpoint_bin
node: ,
module: Membrane.WebRTC.EndpointBin,
bin options: %Membrane.WebRTC.EndpointBin{direction: :sendrecv, extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC], filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, 29, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, 49, ...>>], inbound_tracks: [], integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], outbound_tracks: [], rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast?: false, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, trace_metadata: [name: "3dba8630-950a-4f17-9624-31be46973a2c"]}
07:31:39.933 [debug] [:endpoint_bin bin] Initializing spec
children: %{ice: %Membrane.ICE.Endpoint{dtls?: true, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, 29, 62, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, 49, 15, ...>>], ice_lite?: true, integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"]}, ice_funnel: Membrane.Funnel, rtp: %Membrane.RTP.SessionBin{fmt_mapping: %{}, receiver_srtp_policies: nil, receiver_ssrc_generator: &Membrane.RTP.SessionBin.generate_receiver_ssrc/2, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, secure?: true, srtp_policies: []}}
links: [%Membrane.ParentSpec.LinkBuilder{children: [], links: [%{from: :rtp, from_pad: {Membrane.Pad, :rtcp_receiver_output, #Reference<0.2131086919.1186463745.240409>}, from_pad_props: %{options: []}, to: :ice_funnel, to_pad: :input, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}], status: :done}, %Membrane.ParentSpec.LinkBuilder{children: [], links: [%{from: :ice, from_pad: {Membrane.Pad, :output, 1}, from_pad_props: %{options: []}, to: :rtp, to_pad: {Membrane.Pad, :rtp_input, #Reference<0.2131086919.1186463745.240409>}, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}], status: :done}, %Membrane.ParentSpec.LinkBuilder{children: [], links: [%{from: :ice_funnel, from_pad: :output, from_pad_props: %{options: []}, to: :ice, to_pad: {Membrane.Pad, :input, 1}, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}], status: :done}]
07:31:39.933 [debug] [:endpoint_bin bin] Starting children: [%Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.ICE.Endpoint, name: :ice, options: %Membrane.ICE.Endpoint{dtls?: true, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, ...>>], ice_lite?: true, integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"]}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: nil, terminating?: false}, %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.Funnel, name: :ice_funnel, options: %Membrane.Funnel{end_of_stream: :on_last_pad}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: nil, terminating?: false}, %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTP.SessionBin, name: :rtp, options: %Membrane.RTP.SessionBin{fmt_mapping: %{}, receiver_srtp_policies: nil, receiver_ssrc_generator: &Membrane.RTP.SessionBin.generate_receiver_ssrc/2, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, secure?: true, srtp_policies: []}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: nil, terminating?: false}]
07:31:39.933 [debug] [:endpoint_bin bin] Starting child: name: :ice, module: Membrane.ICE.Endpoint
07:31:39.933 [debug] [:endpoint_bin bin] Element start: :ice
node: ,
module: Membrane.ICE.Endpoint,
element options: %Membrane.ICE.Endpoint{dtls?: true, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, 29, 62, 220, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, 49, 15, 48, ...>>], ice_lite?: true, integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"]},
07:31:39.933 [debug] [:ice] Initializing element: Membrane.ICE.Endpoint, options: %Membrane.ICE.Endpoint{dtls?: true, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, 81, 239, 29, 62, 220, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, 80, 76, 49, 15, 48, ...>>], ice_lite?: true, integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"]}
07:31:39.933 [debug] [:ice] Element initialized: Membrane.ICE.Endpoint
07:31:39.933 [debug] [:endpoint_bin bin] Starting child: name: :ice_funnel, module: Membrane.Funnel
07:31:39.933 [debug] [:endpoint_bin bin] Element start: :ice_funnel
node: ,
module: Membrane.Funnel,
element options: %Membrane.Funnel{end_of_stream: :on_last_pad},
07:31:39.933 [debug] [:ice_funnel] Initializing element: Membrane.Funnel, options: %Membrane.Funnel{end_of_stream: :on_last_pad}
07:31:39.933 [debug] [:ice_funnel] Element initialized: Membrane.Funnel
07:31:39.933 [debug] [:endpoint_bin bin] Starting child: name: :rtp, module: Membrane.RTP.SessionBin
07:31:39.933 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 3µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"renegotiateTracks\"}}"}
07:31:39.933 [debug] [:endpoint_bin bin] Bin start: :rtp
node: ,
module: Membrane.RTP.SessionBin,
bin options: %Membrane.RTP.SessionBin{fmt_mapping: %{}, receiver_srtp_policies: nil, receiver_ssrc_generator: &Membrane.RTP.SessionBin.generate_receiver_ssrc/2, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, secure?: true, srtp_policies: []}
07:31:39.933 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 0µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"renegotiateTracks\"}}"}
07:31:39.933 [debug] [:rtp bin] Initializing spec
children: [ssrc_router: Membrane.RTP.SSRCRouter]
links: []
07:31:39.933 [debug] [:rtp bin] Starting children: [%Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.SSRCRouter, name: :ssrc_router, options: nil, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240425>, sync: nil, terminating?: false}]
07:31:39.933 [debug] [:rtp bin] Starting child: name: :ssrc_router, module: Membrane.RTP.SSRCRouter
07:31:39.933 [debug] [:rtp bin] Element start: :ssrc_router
node: ,
module: Membrane.RTP.SSRCRouter,
element options: nil,
07:31:39.933 [debug] [:ssrc_router] Initializing element: Membrane.RTP.SSRCRouter, options: nil
07:31:39.933 [debug] [:ssrc_router] Element initialized: Membrane.RTP.SSRCRouter
07:31:39.933 [debug] [:rtp bin] Spec #Reference<0.2131086919.1186463745.240425> linked internally
07:31:39.933 [debug] [:rtp bin] Linking spec #Reference<0.2131086919.1186463745.240425> externally
07:31:39.933 [debug] [:rtp bin] Spec #Reference<0.2131086919.1186463745.240425> linked externally
07:31:39.933 [debug] [:rtp bin] Spec playback init #Reference<0.2131086919.1186463745.240425> %{ssrc_router: %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.SSRCRouter, name: :ssrc_router, options: nil, pid: #PID<0.2475.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240425>, sync: :membrane_no_sync, terminating?: false}}
07:31:39.933 [debug] [:rtp bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.SSRCRouter, name: :ssrc_router, options: nil, pid: #PID<0.2475.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240425>, sync: :membrane_no_sync, terminating?: false}
07:31:39.934 [debug] [:rtp bin] Received link request on pad {Membrane.Pad, :rtcp_receiver_output, #Reference<0.2131086919.1186463745.240409>}
07:31:39.934 [debug] [:rtp bin] Received link request on pad {Membrane.Pad, :rtp_input, #Reference<0.2131086919.1186463745.240409>}
07:31:39.934 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Spec #Reference<0.2131086919.1186463745.240402> linked internally
07:31:39.934 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Linking spec #Reference<0.2131086919.1186463745.240402> externally
07:31:39.934 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Spec #Reference<0.2131086919.1186463745.240402> linked externally
07:31:39.934 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Spec playback init #Reference<0.2131086919.1186463745.240402> %{endpoint_bin: %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.WebRTC.EndpointBin, name: :endpoint_bin, options: %Membrane.WebRTC.EndpointBin{direction: :sendrecv, extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC], filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, ...>>], inbound_tracks: [], integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], outbound_tracks: [], rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast?: false, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, trace_metadata: [name: "3dba8630-950a-4f17-9624-31be46973a2c"]}, pid: #PID<0.2464.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240402>, sync: :membrane_no_sync, terminating?: false}}
07:31:39.934 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.WebRTC.EndpointBin, name: :endpoint_bin, options: %Membrane.WebRTC.EndpointBin{direction: :sendrecv, extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC], filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, ...>>], inbound_tracks: [], integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], outbound_tracks: [], rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast?: false, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, trace_metadata: [name: "3dba8630-950a-4f17-9624-31be46973a2c"]}, pid: #PID<0.2464.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240402>, sync: :membrane_no_sync, terminating?: false}
07:31:39.934 [debug] [:rtp bin] Initializing spec
children: %{}
links: [%Membrane.ParentSpec.LinkBuilder{children: [{{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, %Membrane.RTP.Parser{secure?: true}}], links: [%{from: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, from_pad: :output, from_pad_props: %{options: []}, to: :ssrc_router, to_pad: {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240409>}, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}, %{from: {Membrane.Bin, :itself}, from_pad: {Membrane.Pad, :rtp_input, #Reference<0.2131086919.1186463745.240409>}, from_pad_props: %{}, to: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, to_pad: :input, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: 500}}], status: :done}, %Membrane.ParentSpec.LinkBuilder{children: [{{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, %Membrane.SRTP.Encryptor{policies: []}}, {{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, Membrane.RTCP.Parser}, {{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, %Membrane.SRTCP.Decryptor{policies: []}}], links: [%{from: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, from_pad: :output, from_pad_props: %{options: []}, to: {Membrane.Bin, :itself}, to_pad: {Membrane.Pad, :rtcp_receiver_output, #Reference<0.2131086919.1186463745.240409>}, to_pad_props: %{}}, %{from: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, from_pad: :receiver_report_output, from_pad_props: %{options: []}, to: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, to_pad: :input, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}, %{from: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, from_pad: :output, from_pad_props: %{options: []}, to: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, to_pad: :input, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}, %{from: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, from_pad: :rtcp_output, from_pad_props: %{options: []}, to: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, to_pad: :input, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}], status: :done}, %Membrane.ParentSpec.LinkBuilder{children: [], links: [%{from: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, from_pad: :output, from_pad_props: %{options: []}, to: :ssrc_router, to_pad: {Membrane.Pad, :input, {:rtcp, #Reference<0.2131086919.1186463745.240409>}}, to_pad_props: %{auto_demand_size: nil, min_demand_factor: nil, options: [], target_queue_size: nil, toilet_capacity: nil}}], status: :done}]
07:31:39.935 [debug] [pipeline@<0.2414.0>] Spec #Reference<0.2131086919.1186463745.240393> linked internally
07:31:39.935 [debug] [:rtp bin] Starting children: [%Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.Parser, name: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.RTP.Parser{secure?: true}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: nil, terminating?: false}, %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.SRTP.Encryptor, name: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.SRTP.Encryptor{policies: []}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: nil, terminating?: false}, %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTCP.Parser, name: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, options: nil, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: nil, terminating?: false}, %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.SRTCP.Decryptor, name: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.SRTCP.Decryptor{policies: []}, pid: nil, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: nil, terminating?: false}]
07:31:39.935 [debug] [:rtp bin] Starting child: name: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, module: Membrane.RTP.Parser
07:31:39.935 [debug] [:rtp bin] Element start: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}
node: ,
module: Membrane.RTP.Parser,
element options: %Membrane.RTP.Parser{secure?: true},
07:31:39.935 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Initializing element: Membrane.RTP.Parser, options: %Membrane.RTP.Parser{secure?: true}
07:31:39.935 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Element initialized: Membrane.RTP.Parser
07:31:39.935 [debug] [:rtp bin] Starting child: name: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, module: Membrane.SRTP.Encryptor
07:31:39.935 [debug] [:rtp bin] Element start: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}
node: ,
module: Membrane.SRTP.Encryptor,
element options: %Membrane.SRTP.Encryptor{policies: []},
07:31:39.935 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Initializing element: Membrane.SRTP.Encryptor, options: %Membrane.SRTP.Encryptor{policies: []}
07:31:39.935 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Element initialized: Membrane.SRTP.Encryptor
07:31:39.935 [debug] [:rtp bin] Starting child: name: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, module: Membrane.RTCP.Parser
07:31:39.935 [debug] [:rtp bin] Element start: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}
node: ,
module: Membrane.RTCP.Parser,
element options: nil,
07:31:39.935 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Initializing element: Membrane.RTCP.Parser, options: nil
07:31:39.935 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Element initialized: Membrane.RTCP.Parser
07:31:39.935 [debug] [:rtp bin] Starting child: name: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, module: Membrane.SRTCP.Decryptor
07:31:39.935 [debug] [:rtp bin] Element start: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}
node: ,
module: Membrane.SRTCP.Decryptor,
element options: %Membrane.SRTCP.Decryptor{policies: []},
07:31:39.935 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Initializing element: Membrane.SRTCP.Decryptor, options: %Membrane.SRTCP.Decryptor{policies: []}
07:31:39.935 [debug] [pipeline@<0.2414.0>] Spec playback init #Reference<0.2131086919.1186463745.240393> %{{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} => %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTC.Engine.Endpoint.WebRTC, name: {:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"}, options: %Membrane.RTC.Engine.Endpoint.WebRTC{direction: :sendrecv, extensions: %{}, filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, ...>>], ice_name: "3dba8630-950a-4f17-9624-31be46973a2c", integrated_turn_domain: "localhost", integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], owner: #PID<0.2412.0>, rtc_engine: #PID<0.2414.0>, rtcp_fir_interval: 1000000000, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast_config: %Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig{default_encoding: &Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig.default_encoding/1, enabled: false}, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, video_tracks_limit: nil, webrtc_extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC]}, pid: #PID<0.2462.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240393>, sync: :membrane_no_sync, terminating?: false}, {:endpoint, "4b8088d9-61c3-4d52-b679-4e02e079a4f3"} => %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTC.Engine.Endpoint.WebRTC, name: {:endpoint, "4b8088d9-61c3-4d52-b679-4e02e079a4f3"}, options: %Membrane.RTC.Engine.Endpoint.WebRTC{direction: :sendrecv, extensions: %{}, filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, ...>>], ice_name: "4b8088d9-61c3-4d52-b679-4e02e079a4f3", integrated_turn_domain: "localhost", integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "4b8088d9-61c3-4d52-b679-4e02e079a4f3"], owner: #PID<0.2412.0>, rtc_engine: #PID<0.2414.0>, rtcp_fir_interval: 1000000000, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast_config: %Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig{default_encoding: &Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig.default_encoding/1, enabled: false}, telemetry_label: [room_id: "1", peer_id: "4b8088d9-61c3-4d52-b679-4e02e079a4f3"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, video_tracks_limit: nil, webrtc_extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC]}, pid: #PID<0.2416.0>, playback_sync: :synced, spec_ref: #Reference<0.2131086919.1186463745.240178>, sync: :membrane_no_sync, terminating?: false}}
07:31:39.935 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Element initialized: Membrane.SRTCP.Decryptor
07:31:39.935 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :output with pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240409>} of child :ssrc_router
07:31:39.935 [debug] [:ssrc_router] Element handle link on pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240409>} with pad :output of child {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}
07:31:39.935 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad {Membrane.Pad, :rtcp_output, #Reference<0.2131086919.1186463747.243041>} with pad :input of child {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}
07:31:39.935 [debug] [pipeline@<0.2414.0>] Initializing playback state :playing %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTC.Engine.Endpoint.WebRTC, name: {:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"}, options: %Membrane.RTC.Engine.Endpoint.WebRTC{direction: :sendrecv, extensions: %{}, filter_codecs: &Membrane.WebRTC.SDP.filter_mappings/1, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, ...>>], ice_name: "3dba8630-950a-4f17-9624-31be46973a2c", integrated_turn_domain: "localhost", integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], log_metadata: [peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], owner: #PID<0.2412.0>, rtc_engine: #PID<0.2414.0>, rtcp_fir_interval: 1000000000, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, simulcast_config: %Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig{default_encoding: &Membrane.RTC.Engine.Endpoint.WebRTC.SimulcastConfig.default_encoding/1, enabled: false}, telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"], trace_context: %{{:otel_tracer, :span_ctx} => {:span_ctx, 229955439798163086271608342599503991130, 3114524061457178896, 1, :undefined, true, :undefined, true, {:otel_span_ets, #Function<1.129312512/1 in :otel_tracer_server.on_end/1>}}}, video_tracks_limit: nil, webrtc_extensions: [Membrane.WebRTC.Extension.Mid, Membrane.WebRTC.Extension.TWCC]}, pid: #PID<0.2462.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240393>, sync: :membrane_no_sync, terminating?: false}
07:31:39.935 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :input with pad {Membrane.Pad, :rtcp_output, #Reference<0.2131086919.1186463747.243041>} of child {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}
07:31:39.935 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :output with pad :input of child {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}
07:31:39.935 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :input with pad :output of child {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}
07:31:39.935 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Changing playback state from stopped to prepared
07:31:39.937 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :receiver_report_output with pad :input of child {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}
07:31:39.937 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :input with pad :receiver_report_output of child {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}
07:31:39.937 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :output with pad {Membrane.Pad, :input, {:rtcp, #Reference<0.2131086919.1186463745.240409>}} of child :ssrc_router
07:31:39.937 [debug] [:ssrc_router] Element handle link on pad {Membrane.Pad, :input, {:rtcp, #Reference<0.2131086919.1186463745.240409>}} with pad :output of child {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}
07:31:39.937 [debug] [:rtp bin] Spec #Reference<0.2131086919.1186463745.240440> linked internally
07:31:39.937 [debug] [:rtp bin] Linking spec #Reference<0.2131086919.1186463745.240440> externally
07:31:39.937 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :output with pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240435>} of child :ice_funnel
07:31:39.937 [debug] [:ice_funnel] Element handle link on pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240435>} with pad :output of child {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}
07:31:39.937 [debug] [:ice] Element handle link on pad {Membrane.Pad, :output, 1} with pad {Membrane.Pad, :rtp_input, #Reference<0.2131086919.1186463745.240409>} of child :rtp
07:31:39.937 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Element handle link on pad :input with pad {Membrane.Pad, :output, 1} of child :ice
07:31:39.937 [debug] [:rtp bin] Spec #Reference<0.2131086919.1186463745.240440> linked externally
07:31:39.937 [debug] [:rtp bin] Spec playback init #Reference<0.2131086919.1186463745.240440> %{:ssrc_router => %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.SSRCRouter, name: :ssrc_router, options: nil, pid: #PID<0.2475.0>, playback_sync: :synced, spec_ref: #Reference<0.2131086919.1186463745.240425>, sync: :membrane_no_sync, terminating?: false}, {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>} => %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTCP.Parser, name: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, options: nil, pid: #PID<0.2478.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}, {:rtp_parser, #Reference<0.2131086919.1186463745.240409>} => %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.Parser, name: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.RTP.Parser{secure?: true}, pid: #PID<0.2476.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}, {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>} => %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.SRTCP.Decryptor, name: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.SRTCP.Decryptor{policies: []}, pid: #PID<0.2479.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}, {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>} => %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.SRTP.Encryptor, name: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.SRTP.Encryptor{policies: []}, pid: #PID<0.2477.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}}
07:31:39.937 [debug] [:rtp bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTCP.Parser, name: {:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}, options: nil, pid: #PID<0.2478.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}
07:31:39.937 [debug] [:rtp bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.RTP.Parser, name: {:rtp_parser, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.RTP.Parser{secure?: true}, pid: #PID<0.2476.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}
07:31:39.937 [debug] [:rtp bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.SRTCP.Decryptor, name: {:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.SRTCP.Decryptor{policies: []}, pid: #PID<0.2479.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}
07:31:39.938 [debug] [:rtp bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.SRTP.Encryptor, name: {:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}, options: %Membrane.SRTP.Encryptor{policies: []}, pid: #PID<0.2477.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240440>, sync: :membrane_no_sync, terminating?: false}
07:31:39.938 [debug] [:ice_funnel] Element handle link on pad :output with pad {Membrane.Pad, :input, 1} of child :ice
07:31:39.938 [debug] [:ice] Element handle link on pad {Membrane.Pad, :input, 1} with pad :output of child :ice_funnel
07:31:39.938 [debug] [:endpoint_bin bin] Spec #Reference<0.2131086919.1186463745.240411> linked internally
07:31:39.938 [debug] [:endpoint_bin bin] Linking spec #Reference<0.2131086919.1186463745.240411> externally
07:31:39.938 [debug] [:endpoint_bin bin] Spec #Reference<0.2131086919.1186463745.240411> linked externally
07:31:39.938 [debug] [:endpoint_bin bin] Spec playback init #Reference<0.2131086919.1186463745.240411> %{ice: %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.ICE.Endpoint, name: :ice, options: %Membrane.ICE.Endpoint{dtls?: true, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, ...>>], ice_lite?: true, integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"]}, pid: #PID<0.2466.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: :membrane_no_sync, terminating?: false}, ice_funnel: %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.Funnel, name: :ice_funnel, options: %Membrane.Funnel{end_of_stream: :on_last_pad}, pid: #PID<0.2472.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: :membrane_no_sync, terminating?: false}, rtp: %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTP.SessionBin, name: :rtp, options: %Membrane.RTP.SessionBin{fmt_mapping: %{}, receiver_srtp_policies: nil, receiver_ssrc_generator: &Membrane.RTP.SessionBin.generate_receiver_ssrc/2, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, secure?: true, srtp_policies: []}, pid: #PID<0.2473.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: :membrane_no_sync, terminating?: false}}
07:31:39.938 [debug] [:endpoint_bin bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.ICE.Endpoint, name: :ice, options: %Membrane.ICE.Endpoint{dtls?: true, handshake_opts: [client_mode: false, dtls_srtp: true, pkey: <<48, 130, 4, 164, 2, 1, 0, 2, 130, 1, 1, 0, 172, 130, 198, 240, 15, 206, 223, 94, 167, 186, 173, 11, 159, 130, 71, 178, 99, 97, 195, 20, 17, 140, 65, 199, 97, 37, 17, 26, ...>>, cert: <<48, 130, 2, 210, 48, 130, 1, 186, 2, 1, 1, 48, 13, 6, 9, 42, 134, 72, 134, 247, 13, 1, 1, 5, 5, 0, 48, 47, 49, 11, 48, 9, 6, 3, 85, 4, 6, 19, 2, ...>>], ice_lite?: true, integrated_turn_options: [ip: {0, 0, 0, 0}, mock_ip: {127, 0, 0, 1}, ports_range: {50000, 59999}, cert_file: nil], telemetry_label: [room_id: "1", peer_id: "3dba8630-950a-4f17-9624-31be46973a2c"]}, pid: #PID<0.2466.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: :membrane_no_sync, terminating?: false}
07:31:39.945 [debug] [:endpoint_bin bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :element, module: Membrane.Funnel, name: :ice_funnel, options: %Membrane.Funnel{end_of_stream: :on_last_pad}, pid: #PID<0.2472.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: :membrane_no_sync, terminating?: false}
07:31:39.945 [debug] [:endpoint_bin bin] Initializing playback state :stopped %Membrane.ChildEntry{clock: nil, component_type: :bin, module: Membrane.RTP.SessionBin, name: :rtp, options: %Membrane.RTP.SessionBin{fmt_mapping: %{}, receiver_srtp_policies: nil, receiver_ssrc_generator: &Membrane.RTP.SessionBin.generate_receiver_ssrc/2, rtcp_receiver_report_interval: nil, rtcp_sender_report_interval: nil, secure?: true, srtp_policies: []}, pid: #PID<0.2473.0>, playback_sync: :not_synced, spec_ref: #Reference<0.2131086919.1186463745.240411>, sync: :membrane_no_sync, terminating?: false}
07:31:39.945 [debug] [:endpoint_bin bin] Changing playback state from stopped to prepared
07:31:39.945 [debug] [:rtp bin] Changing playback state from stopped to prepared
07:31:39.945 [debug] [:rtp bin] Playback state changed from stopped to prepared
07:31:39.945 [debug] [:endpoint_bin bin] Playback state changed from stopped to prepared
07:31:39.945 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Playback state changed from stopped to prepared
07:31:39.945 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Changing playback state from prepared to playing
07:31:39.945 [debug] [:endpoint_bin bin] Changing playback state from prepared to playing
07:31:39.946 [debug] [:ice_funnel] Evaluating playback buffer
07:31:39.946 [debug] [:rtp bin] Changing playback state from prepared to playing
07:31:39.946 [debug] [:ssrc_router] Evaluating playback buffer
07:31:39.946 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Sending caps through pad :receiver_report_output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Evaluating playback buffer
07:31:39.946 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Sending caps through pad {Membrane.Pad, :rtcp_output, #Reference<0.2131086919.1186463747.243041>}
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Evaluating playback buffer
07:31:39.946 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Evaluating playback buffer
07:31:39.946 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [{:srtcp_decryptor, #Reference<0.2131086919.1186463745.240409>}] Sending caps through pad :output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [{:rtcp_parser, #Reference<0.2131086919.1186463745.240409>}] Sending caps through pad :output
Caps: %Membrane.RTCP{}
07:31:39.946 [debug] [:ssrc_router] Received caps on pad {Membrane.Pad, :input, {:rtcp, #Reference<0.2131086919.1186463745.240409>}}
Caps: %Membrane.RTCP{}
07:31:39.946 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Evaluating playback buffer
07:31:39.946 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [{:srtcp_encryptor, #Reference<0.2131086919.1186463745.240409>}] Sending caps through pad :output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [:rtp bin] Playback state changed from prepared to playing
07:31:39.946 [debug] [:ice_funnel] Received caps on pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240435>}
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.946 [debug] [:ice_funnel] Sending caps through pad :output
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.962 [debug] [:ice] Starting udp TURN Server at "0.0.0.0":50585
07:31:39.962 [debug] [:ice] Sending caps through pad {Membrane.Pad, :output, 1}
Caps: %Membrane.RemoteStream{content_format: nil, type: :packetized}
07:31:39.962 [debug] [:ice] Evaluating playback buffer
07:31:39.962 [debug] [:ice] Received caps on pad {Membrane.Pad, :input, 1}
Caps: %Membrane.RemoteStream{content_format: Membrane.RTCP, type: :packetized}
07:31:39.962 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Received caps on pad :input
Caps: %Membrane.RemoteStream{content_format: nil, type: :packetized}
07:31:39.962 [debug] [{:rtp_parser, #Reference<0.2131086919.1186463745.240409>}] Sending caps through pad :output
Caps: %Membrane.RTP{}
07:31:39.963 [debug] [:ssrc_router] Received caps on pad {Membrane.Pad, :input, #Reference<0.2131086919.1186463745.240409>}
Caps: %Membrane.RTP{}
07:31:39.963 [debug] [:endpoint_bin bin] Playback state changed from prepared to playing
07:31:39.963 [debug] [{:endpoint, "3dba8630-950a-4f17-9624-31be46973a2c"} bin] Playback state changed from prepared to playing
07:31:39.975 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 3µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6431179107191689322 2 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2 3\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:lrFG\\r\\na=ice-pwd:haeT4SDEY6GJl7OljXLeLalI\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:6F:F6:52:DC:49:68:02:96:B5:82:3D:B1:AE:B8:73:E4:1D:BA:A9:8B:23:C4:6A:02:3B:D4:AB:C3:ED:8C:98\\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=sendonly\\r\\na=msid:- 701830e9-1770-4676-b454-622cd4212581\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:2915313532 cname:GuYN6mE7MG7TutIb\\r\\na=ssrc:2915313532 msid:- 701830e9-1770-4676-b454-622cd4212581\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:lrFG\\r\\na=ice-pwd:haeT4SDEY6GJl7OljXLeLalI\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:6F:F6:52:DC:49:68:02:96:B5:82:3D:B1:AE:B8:73:E4:1D:BA:A9:8B:23:C4:6A:02:3B:D4:AB:C3:ED:8C:98\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 9d826343-97f2-4985-b2dc-43725de3c74b\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm f" <> ...}
07:31:41.081 [debug] [:ice] ICE restart failed due to timeout
07:31:41.114 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 48µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 7 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2 3\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:kpeS\\r\\na=ice-pwd:HyJUDE0IiacaZSzeTXCPGWgK\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:kpeS\\r\\na=ice-pwd:HyJUDE0IiacaZSzeTXCPGWgK\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir" <> ...}
07:31:44.967 [debug] [:ice] ICE restart failed due to timeout
07:31:44.997 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 9µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6431179107191689322 3 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2 3\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:egbL\\r\\na=ice-pwd:k0PezwcEAlWN7QL6NBJv+LoM\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:6F:F6:52:DC:49:68:02:96:B5:82:3D:B1:AE:B8:73:E4:1D:BA:A9:8B:23:C4:6A:02:3B:D4:AB:C3:ED:8C:98\\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=sendonly\\r\\na=msid:- 701830e9-1770-4676-b454-622cd4212581\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:2915313532 cname:GuYN6mE7MG7TutIb\\r\\na=ssrc:2915313532 msid:- 701830e9-1770-4676-b454-622cd4212581\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:egbL\\r\\na=ice-pwd:k0PezwcEAlWN7QL6NBJv+LoM\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:6F:F6:52:DC:49:68:02:96:B5:82:3D:B1:AE:B8:73:E4:1D:BA:A9:8B:23:C4:6A:02:3B:D4:AB:C3:ED:8C:98\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 9d826343-97f2-4985-b2dc-43725de3c74b\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm f" <> ...}
07:31:46.083 [debug] [:ice] ICE restart failed due to timeout
07:31:46.118 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 9µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 8 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2 3\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:KKJv\\r\\na=ice-pwd:ohAmdvu5z6RNvsAMtwP207ZY\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:KKJv\\r\\na=ice-pwd:ohAmdvu5z6RNvsAMtwP207ZY\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir" <> ...}
07:31:49.971 [debug] [:ice] ICE restart failed due to timeout
07:31:49.999 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 4µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6431179107191689322 4 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2 3\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:MZUo\\r\\na=ice-pwd:D6+/+AZ/cgV274nyqgsnx0tI\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:6F:F6:52:DC:49:68:02:96:B5:82:3D:B1:AE:B8:73:E4:1D:BA:A9:8B:23:C4:6A:02:3B:D4:AB:C3:ED:8C:98\\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=sendonly\\r\\na=msid:- 701830e9-1770-4676-b454-622cd4212581\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:2915313532 cname:GuYN6mE7MG7TutIb\\r\\na=ssrc:2915313532 msid:- 701830e9-1770-4676-b454-622cd4212581\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:MZUo\\r\\na=ice-pwd:D6+/+AZ/cgV274nyqgsnx0tI\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 BF:6F:F6:52:DC:49:68:02:96:B5:82:3D:B1:AE:B8:73:E4:1D:BA:A9:8B:23:C4:6A:02:3B:D4:AB:C3:ED:8C:98\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 9d826343-97f2-4985-b2dc-43725de3c74b\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm f" <> ...}
07:31:51.087 [debug] [:ice] ICE restart failed due to timeout
07:31:51.116 [debug] HANDLED mediaEvent INCOMING ON room:1 (VideoRoomWeb.PeerChannel) in 13µs
Parameters: %{"data" => "{\"type\":\"custom\",\"data\":{\"type\":\"sdpOffer\",\"data\":{\"sdpOffer\":{\"type\":\"offer\",\"sdp\":\"v=0\\r\\no=- 6042406025057165005 9 IN IP4 127.0.0.1\\r\\ns=-\\r\\nt=0 0\\r\\na=group:BUNDLE 0 1 2 3\\r\\na=extmap-allow-mixed\\r\\na=msid-semantic: WMS\\r\\nm=audio 9 UDP/TLS/RTP/SAVPF 111 63 103 104 9 0 8 106 105 13 110 112 113 126\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:9WeM\\r\\na=ice-pwd:ikM98wajhygdpm5G0CzmTuxA\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\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=sendonly\\r\\na=msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\na=rtcp-mux\\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:103 ISAC/16000\\r\\na=rtpmap:104 ISAC/32000\\r\\na=rtpmap:9 G722/8000\\r\\na=rtpmap:0 PCMU/8000\\r\\na=rtpmap:8 PCMA/8000\\r\\na=rtpmap:106 CN/32000\\r\\na=rtpmap:105 CN/16000\\r\\na=rtpmap:13 CN/8000\\r\\na=rtpmap:110 telephone-event/48000\\r\\na=rtpmap:112 telephone-event/32000\\r\\na=rtpmap:113 telephone-event/16000\\r\\na=rtpmap:126 telephone-event/8000\\r\\na=ssrc:155670368 cname:n4Pu0Z2CPZdSalYW\\r\\na=ssrc:155670368 msid:- f937f720-4f02-4ef5-b745-b25c51196107\\r\\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 127 121 125 107 108 109 124 120 123 119 35 36 41 42 114 115 116 117 118\\r\\nc=IN IP4 0.0.0.0\\r\\na=rtcp:9 IN IP4 0.0.0.0\\r\\na=ice-ufrag:9WeM\\r\\na=ice-pwd:ikM98wajhygdpm5G0CzmTuxA\\r\\na=ice-options:trickle\\r\\na=fingerprint:sha-256 7B:D2:DE:C2:5E:FC:E1:D4:8F:9E:B2:86:3B:A6:AB:D9:AF:02:2A:36:9A:5A:6D:1C:22:12:1E:F9:BD:15:BF:54\\r\\na=setup:actpass\\r\\na=mid:1\\r\\na=extmap:14 urn:ietf:params:rtp-hdrext:toffset\\r\\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\\r\\na=extmap:13 urn:3gpp:video-orientation\\r\\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\\r\\na=extmap:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\\r\\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\\r\\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\\r\\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space\\r\\na=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid\\r\\na=extmap:10 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\\r\\na=extmap:11 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\\r\\na=sendonly\\r\\na=msid:- 25ac454f-2b26-4384-a715-101b89881809\\r\\na=rtcp-mux\\r\\na=rtcp-rsize\\r\\na=rtpmap:96 VP8/90000\\r\\na=rtcp-fb:96 goog-remb\\r\\na=rtcp-fb:96 transport-cc\\r\\na=rtcp-fb:96 ccm fir\\r\\na=rtcp-fb:96 nack\\r\\na=rtcp-fb:96 nack pli\\r\\na=rtpmap:97 rtx/90000\\r\\na=fmtp:97 apt=96\\r\\na=rtpmap:98 VP9/90000\\r\\na=rtcp-fb:98 goog-remb\\r\\na=rtcp-fb:98 transport-cc\\r\\na=rtcp-fb:98 ccm fir\\r\\na=rtcp-fb:98 nack\\r\\na=rtcp-fb:98 nack pli\\r\\na=fmtp:98 profile-id=0\\r\\na=rtpmap:99 rtx/90000\\r\\na=fmtp:99 apt=98\\r\\na=rtpmap:100 VP9/90000\\r\\na=rtcp-fb:100 goog-remb\\r\\na=rtcp-fb:100 transport-cc\\r\\na=rtcp-fb:100 ccm fir\\r\\na=rtcp-fb:100 nack\\r\\na=rtcp-fb:100 nack pli\\r\\na=fmtp:100 profile-id=2\\r\\na=rtpmap:101 rtx/90000\\r\\na=fmtp:101 apt=100\\r\\na=rtpmap:127 H264/90000\\r\\na=rtcp-fb:127 goog-remb\\r\\na=rtcp-fb:127 transport-cc\\r\\na=rtcp-fb:127 ccm fir\\r\\na=rtcp-fb:127 nack\\r\\na=rtcp-fb:127 nack pli\\r\\na=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\\r\\na=rtpmap:121 rtx/90000\\r\\na=fmtp:121 apt=127\\r\\na=rtpmap:125 H264/90000\\r\\na=rtcp-fb:125 goog-remb\\r\\na=rtcp-fb:125 transport-cc\\r\\na=rtcp-fb:125 ccm fir\\r\\na=rtcp-fb:125 nack\\r\\na=rtcp-fb:125 nack pli\\r\\na=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\\r\\na=rtpmap:107 rtx/90000\\r\\na=fmtp:107 apt=125\\r\\na=rtpmap:108 H264/90000\\r\\na=rtcp-fb:108 goog-remb\\r\\na=rtcp-fb:108 transport-cc\\r\\na=rtcp-fb:108 ccm fir" <> ...}
^C
BREAK: (a)bort (A)bort with dump (c)ontinue (p)roc info (i)nfo
(l)oaded (v)ersion (k)ill (D)b-tables (d)istribution
olegkovalov@oleg-mbp membrane_videoroom %
olegkovalov@oleg-mbp membrane_videoroom %
olegkovalov@oleg-mbp membrane_videoroom %
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment