twilio / video-quickstart-ios

Twilio Video Quickstart for iOS
https://www.twilio.com/docs/api/video
MIT License
465 stars 178 forks source link

Audio is not working after waiting for the participant for more then 15 minutes #484

Closed mialex closed 4 years ago

mialex commented 4 years ago

Description

Hello, as far as I'm not an expert in iOS development, that's why I can't identify if this issue is related to some missed logic in the quickstart-ios. I was using a MultiPart example. Seems like it's been removed, as I can't see this project right now. I expect that MultiPart video was moved to twilio-video-app-ios repository.

Anyway, I have an issue with the audio and I'm not sure that it's related to the MiltyParty. In our flow, it's possible that one of the participants can just stop the call for some time and then get back. If the video stopped for more then 15+ minutes and then the participant gets back (join to the room again), then a video is present, but audio does not work for both participants. Unsubscribing the audio and subscribing to it back when the remote participant did connect to the room does not help. Only if the page closes (dismissed) and then open again fresh page, it's possible to join the room with working audio.

As additional info, we use Pear-to-Pear connection. The second participant can use the iOS app or can be connected form the Web with the Angular SDK

NOTE: I also spot that audio stops working after this notification. Why that rise and why I don't see AVAudioSessionInterruptionTypeEnd.

EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Default audio device received AVAudioSessionInterruptionTypeBegan.

Steps to Reproduce

  1. Create the room
  2. Join with one participant (UserOne)
  3. Join with the second participant (UserTwo)
  4. Disconnect UserOne from the room
  5. Wait for 15+ minutes
  6. Join the Room

Code

The code is almost the same as it was in MultiParty example, with only some minor changes regarding view part

Expected Behavior

The expected result is if even after 15+ minutes somebody gets back to the call, both video and audio should work.

Actual Behavior

Actually, in 15+ minutes audio stops working, but video works fine.

Reproduces How Often

Almost every time I do that

Versions

All relevant version information for the issue.

Video iOS SDK

TwilioVideo 3.2.5 via CocoaPods

Xcode

11.3.1

iOS Version

13.3.1

iOS Device

iPad Pro

Logs

2020-04-30 12:27:24.066903+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:27:25.154593+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}
2020-04-30 12:27:28.502795+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Default audio device received AVAudioSessionInterruptionTypeBegan.
2020-04-30 12:27:28.674576+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:27:29.958849+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}

............

2020-04-30 12:35:06.346492+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}
2020-04-30 12:35:10.181021+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:35:10.337715+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"body":{"version":2,"type":"update","peer_connections":[{"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f","description":{"type":"offer","sdp":"v=0\r\no=- 5741560157422638176 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=msid-semantic: WMS *\r\na=group:BUNDLE audio video\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 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-options:trickle\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:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\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: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=setup:actpass\r\na=mid:audio\r\na=sendrecv\r\na=ice-ufrag:6Jzg\r\na=ice-pwd:9+2QAv62Ksk6fuxtsiupMefW\r\na=fingerprint:sha-256 E1:84:96:FE:7E:82:AC:45:B4:2E:08:65:3D:E4:1E:8D:4B:03:44:A8:0A:6C:30:92:92:B8:87:18:16:4F:6F:C0\r\na=ssrc:4232778098 msid:- 5801223c-ae01-463a-82ee-12237c416e44\r\na=ssrc:4232778098 cname:05J19+cG4P5Tidnc\r\na=ssrc:4232778098 mslabel:-\r\na=ssrc:4232778098 label:5801223c-ae01-463a-82ee-12237c416e44\r\na=rtcp-mux\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 99 101 122 121 107 109 120 119 115 98 100 102 127 125 108 124 123 114 116\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-options:trickle\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:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 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://tools.ietf.org/html/draft-ietf-avtext-framemarking-07\r\na=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\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:102 H264/90000\r\na=rtcp-fb:102 goog-remb\r\na=rtcp-fb:102 transport-cc\r\na=rtcp-fb:102 ccm fir\r\na=rtcp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\r\na=rtpmap:122 rtx/90000\r\na=fmtp:122 apt=102\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=0;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=1;profile-level-id=42e01f\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\na=rtcp-fb:108 nack\r\na=rtcp-fb:108 nack pli\r\na=fmtp:108 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\r\na=rtpmap:109 rtx/90000\r\na=fmtp:109 apt=108\r\na=rtpmap:124 H264/90000\r\na=rtcp-fb:124 goog-remb\r\na=rtcp-fb:124 transport-cc\r\na=rtcp-fb:124 ccm fir\r\na=rtcp-fb:124 nack\r\na=rtcp-fb:124 nack pli\r\na=fmtp:124 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0032\r\na=rtpmap:120 rtx/90000\r\na=fmtp:120 apt=124\r\na=rtpmap:123 H264/90000\r\na=rtcp-fb:123 goog-remb\r\na=rtcp-fb:123 transport-cc\r\na=rtcp-fb:123 ccm fir\r\na=rtcp-fb:123 nack\r\na=rtcp-fb:123 nack pli\r\na=fmtp:123 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640032\r\na=rtpmap:119 rtx/90000\r\na=fmtp:119 apt=123\r\na=rtpmap:114 red/90000\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\r\na=rtpmap:116 ulpfec/90000\r\na=setup:actpass\r\na=mid:video\r\na=sendrecv\r\na=ice-ufrag:6Jzg\r\na=ice-pwd:9+2QAv62Ksk6fuxtsiupMefW\r\na=fingerprint:sha-256 E1:84:96:FE:7E:82:AC:45:B4:2E:08:65:3D:E4:1E:8D:4B:03:44:A8:0A:6C:30:92:92:B8:87:18:16:4F:6F:C0\r\na=ssrc-group:FID 2555901402 1100794705\r\na=ssrc:2555901402 msid:- b6931bf8-e7b9-424b-b105-ef9407a4f440\r\na=ssrc:2555901402 cname:05J19+cG4P5Tidnc\r\na=ssrc:2555901402 mslabel:-\r\na=ssrc:2555901402 label:b6931bf8-e7b9-424b-b105-ef9407a4f440\r\na=ssrc:1100794705 msid:- b6931bf8-e7b9-424b-b105-ef9407a4f440\r\na=ssrc:1100794705 cname:05J19+cG4P5Tidnc\r\na=ssrc:1100794705 mslabel:-\r\na=ssrc:1100794705 label:b6931bf8-e7b9-424b-b105-ef9407a4f440\r\na=rtcp-mux\r\n","revision":1}}],"sid":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","name":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","participant":{"sid":"PAc42a6b7043d1a50875175a3f2692a2cd","identity":"participant-2","tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA490d43189626af28c2cfe945c4df9101","identity":"participant-1","tracks":[{"kind":"audio","priority":"standard","id":"5801223c-ae01-463a-82ee-12237c416e44","enabled":true,"sid":"MTe017775f5c2e2534747e0531b36bbdf5","name":"68a77164-5b91-443e-814a-bc171b0c6e5e","state":"ready"},{"kind":"video","priority":"standard","id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","enabled":true,"sid":"MT3ff837a1ed676d2c896b69036f08f6a0","name":"64050041-1187-4ea0-a13a-e69835581202","state":"ready"}],"revision":3,"state":"connected"}],"recording":{"enabled":false,"revision":1},"subscribe":{"revision":1,"rules":[{"type":"include","all":true}]},"subscribed":{"revision":27,"tracks":[{"id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","sid":"MT3ff837a1ed676d2c896b69036f08f6a0"},{"id":"5801223c-ae01-463a-82ee-12237c416e44","sid":"MTe017775f5c2e2534747e0531b36bbdf5"}]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}]}},"type":"msg"}
2020-04-30 12:35:10.350343+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): RemoteParticipantImpl::RemoteParticipantImpl: participant-1, sid: PA490d43189626af28c2cfe945c4df9101
2020-04-30 12:35:10.351283+0300 EmbeddedMultiVideo[4586:3457012] INFO:Twilio:[Core](0x102625800): Remote participant participant-1 added an audio track with sid: MTe017775f5c2e2534747e0531b36bbdf5, name: 68a77164-5b91-443e-814a-bc171b0c6e5e, enabled: 1
2020-04-30 12:35:10.352150+0300 EmbeddedMultiVideo[4586:3457012] INFO:Twilio:[Core](0x102625800): Remote participant participant-1 added a video track with sid: MT3ff837a1ed676d2c896b69036f08f6a0, name: 64050041-1187-4ea0-a13a-e69835581202, enabled: 1
2020-04-30 12:35:10.352480+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:10.352794+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setObserver
2020-04-30 12:35:10.352979+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12020-04-30 12:35:10.353009+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteAudioTracks
2020-04-30 12:35:10.353344+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteVideoTracks
2020-04-30 12:35:10.353650+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteDataTracks
2b000): API Call getSignalingThread
2020-04-30 12:35:10.354485+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"body":{"version":2,"type":"update","sid":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","name":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","participant":{"sid":"PAc42a6b7043d1a50875175a3f2692a2cd","identity":"participant-2","tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA490d43189626af28c2cfe945c4df9101","identity":"participant-1","tracks":[{"kind":"audio","priority":"standard","id":"5801223c-ae01-463a-82ee-12237c416e44","enabled":true,"sid":"MTe017775f5c2e2534747e0531b36bbdf5","name":"68a77164-5b91-443e-814a-bc171b0c6e5e","state":"ready"},{"kind":"video","priority":"standard","id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","enabled":true,"sid":"MT3ff837a1ed676d2c896b69036f08f6a0","name":"64050041-1187-4ea0-a13a-e69835581202","state":"ready"}],"revision":3,"state":"connected"}],"recording":{"enabled":false,"revision":1},"subscribe":{"revision":1,"rules":[{"type":"include","all":true}]},"subscribed":{"revision":27,"tracks":[{"id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","sid":"MT3ff837a1ed676d2c896b69036f08f6a0"},{"id":"5801223c-ae01-463a-82ee-12237c416e44","sid":"MTe017775f5c2e2534747e0531b36bbdf5"}]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}]}},"type":"msg"}
2020-04-30 12:35:10.356692+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): API Call getSignalingThread
2020-04-30 12:35:10.370666+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): API Call getNetworkingThread
2020-04-30 12:35:10.370925+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Starting the Network Manager
2020-04-30 12:35:10.371353+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): API Call RTCIceServers
2020-04-30 12:35:10.372197+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): API Call RTCIceServer
2020-04-30 12:35:10.372348+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): API Call RTCIceServer
2020-04-30 12:35:10.372847+0300 EmbeddedMultiVideo[4586:3457046] INFO:Twilio:[Core](MediaFactoryImpl::signaling): Creating peer connection ...
2020-04-30 12:35:10.375046+0300 EmbeddedMultiVideo[4586:3457046] INFO:Twilio:[Core](MediaFactoryImpl::signaling): Adding local stream to peer connection ...
2020-04-30 12:35:10.377023+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Open -> Updating. Process an event
2020-04-30 12:35:10.377214+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Process remote offer.
2020-04-30 12:35:10.377597+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Process remote sdp for: 4ca9c8b3-c2de-41df-998b-292464e02c4f revision is: 1.
2020-04-30 12:35:10.381957+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Applying remote description to: 4ca9c8b3-c2de-41df-998b-292464e02c4f rev: 1
2020-04-30 12:35:10.387629+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): onSetSessionRemoteDescription: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.389684+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Create local answer: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.391462+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Including track id: FeE145883AE838EcEa0daE56446D32d8 for simulcast.
2020-04-30 12:35:10.391687+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): onCreateSessionLocalDescription 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.392114+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): SDP Utils: New SSRC group 3455373520 2243541197 --- Original SSRC group 3455373520 2243541197
2020-04-30 12:35:10.393135+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Applying local description to: 4ca9c8b3-c2de-41df-998b-292464e02c4f rev: 1
2020-04-30 12:35:10.427420+0300 EmbeddedMultiVideo[4586:3457048] DEBUG:Twilio:[Core](MediaFactoryImpl::networking): void twilio::media::NetworkMonitor::onNetworksChanged()
2020-04-30 12:35:10.427489+0300 EmbeddedMultiVideo[4586:3457048] DEBUG:Twilio:[Core](MediaFactoryImpl::networking): Network Name: en0, Cost: 10, Type : Wifi, Preference : 127, Active : 1, id: 1, prefix : 192.168.1.0 and key : en0%192.168.1.0/24
2020-04-30 12:35:10.427527+0300 EmbeddedMultiVideo[4586:3457048] DEBUG:Twilio:[Core](MediaFactoryImpl::networking): Network Name: en2, Cost: 10, Type : Wifi, Preference : 126, Active : 1, id: 2, prefix : 169.254.0.0 and key : en2%169.254.0.0/16
2020-04-30 12:35:10.427560+0300 EmbeddedMultiVideo[4586:3457048] DEBUG:Twilio:[Core](MediaFactoryImpl::networking): Network Name: lo0, Cost: 0, Type : Loopback, Preference : 125, Active : 1, id: 4, prefix : ::1 and key : lo0%::1/128
2020-04-30 12:35:10.427595+0300 EmbeddedMultiVideo[4586:3457048] DEBUG:Twilio:[Core](MediaFactoryImpl::networking): Network Name: lo0, Cost: 0, Type : Loopback, Preference : 124, Active : 1, id: 3, prefix : 127.0.0.0 and key : lo0%127.0.0.0/8
2020-04-30 12:35:10.427644+0300 EmbeddedMultiVideo[4586:3457048] DEBUG:Twilio:[Core](MediaFactoryImpl::networking): New preferred network reported by manager: key: en0%192.168.1.0/24, type: Wifi, cost: 10, id: 1
2020-04-30 12:35:10.428278+0300 EmbeddedMultiVideo[4586:3457044] INFO:Twilio:[Core](0x16e12b000): Local answer is ready for 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.428329+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Queue Description: 1 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.428493+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): onSetSessionLocalDescription: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.428818+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (4097 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"description":{"revision":1,"sdp":"v=0\r\no=- 153312047071811399 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video\r\na=msid-semantic: WMS c062E3Ad49f91a25c0Aa944111EDCBCe\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 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:1uMr\r\na=ice-pwd:FSPTSQKg+VteahwnYfE1ddSr\r\na=ice-options:trickle\r\na=fingerprint:sha-256 24:52:17:BC:80:95:55:09:48:1F:FC:7C:D2:84:37:30:54:FC:F8:52:89:C7:83:AE:50:68:43:40:35:68:13:7A\r\na=setup:active\r\na=mid:audio\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=sendrecv\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: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:3780599619 cname:N15I+4DlIu7pVfp2\r\na=ssrc:3780599619 msid:c062E3Ad49f91a25c0Aa944111EDCBCe 1Cb3810516C44fF9e2Cf8faEA05B9cc9\r\na=ssrc:3780599619 mslabel:c062E3Ad49f91a25c0Aa944111EDCBCe\r\na=ssrc:3780599619 label:1Cb3810516C44fF9e2Cf8faEA05B9cc9\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 99 107 115 98 125 114 116\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:1uMr\r\na=ice-pwd:FSPTSQKg+VteahwnYfE1ddSr\r\na=ice-options:trickle\r\na=fingerprint:sha-256 24:52:17:BC:80:95:55:09:48:1F:FC:7C:D2:84:37:30:54:FC:F8:52:89:C7:83:AE:50:68:43:40:35:68:13:7A\r\na=setup:active\r\na=mid:video\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:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 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=sendrecv\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:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:107 rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\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=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=1;profile-level-id=42e01f\r\na=rtpmap:114 red/90000\r\na=rtpmap:116 ulpfec/90000\r\na=ssrc-group:FID 3455373520 2243541197\r\na=ssrc:3455373520 cname:N15I+4DlIu7pVfp2\r\na=ssrc:3455373520 msid:c062E3Ad49f91a25c0Aa944111EDCBCe FeE145883AE838EcEa0daE56446D32d8\r\na=ssrc:3455373520 mslabel:c062E3Ad49f91a25c0Aa944111EDCBCe\r\na=ssrc:3455373520 label:FeE145883AE838EcEa0daE56446D32d8\r\na=ssrc:2243541197 cname:N15I+4DlIu7pVfp2\r\na=ssrc:2243541197 msid:c062E3Ad49f91a25c0Aa944111EDCBCe FeE145883AE838EcEa0daE56446D32d8\r\na=ssrc:2243541197 mslabel:c062E3Ad49f91a25c0Aa944111EDCBCe\r\na=ssrc:2243541197 label:FeE145883AE838EcEa0daE56446D32d8\r\n","type":"answer"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.431760+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Starting ICE Gathering timer...
2020-04-30 12:35:10.431829+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Updating -> Open
2020-04-30 12:35:10.431893+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Done processing onSetSessionLocalDescription: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.431930+0300 EmbeddedMultiVideo[4586:3457044] INFO:Twilio:[Core](0x16e12b000): Ice Gathering for 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.432056+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Gathered a candidate. candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 ufrag 1uMr network-id 1 network-cost 10
2020-04-30 12:35:10.432803+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Queue ICE candidate revision: 1 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.432853+0300 EmbeddedMultiVideo[4586:3457044] INFO:Twilio:[Core](0x16e12b000): Publish ICE candidate revision: 1 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.433067+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Gathered a candidate. candidate:2229118887 1 udp 2122194687 169.254.190.11 64710 typ host generation 0 ufrag 1uMr network-id 2 network-cost 10
2020-04-30 12:35:10.433563+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Queue ICE candidate revision: 2 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.433635+0300 EmbeddedMultiVideo[4586:3457044] INFO:Twilio:[Core](0x16e12b000): Publish ICE candidate revision: 2 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.433887+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (762 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"ice":{"candidates":[{"candidate":"candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"}],"complete":false,"revision":1,"ufrag":"1uMr"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.434559+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (934 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"ice":{"candidates":[{"candidate":"candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:2229118887 1 udp 2122194687 169.254.190.11 64710 typ host generation 0 ufrag 1uMr network-id 2 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"}],"complete":false,"revision":2,"ufrag":"1uMr"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.495090+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Gathered a candidate. candidate:489935783 1 udp 1686052607 46.118.136.55 58350 typ srflx raddr 192.168.1.62 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10
2020-04-30 12:35:10.495186+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Queue ICE candidate revision: 3 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.495242+0300 EmbeddedMultiVideo[4586:3457044] INFO:Twilio:[Core](0x16e12b000): Publish ICE candidate revision: 3 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.495652+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (1136 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"ice":{"candidates":[{"candidate":"candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:2229118887 1 udp 2122194687 169.254.190.11 64710 typ host generation 0 ufrag 1uMr network-id 2 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:489935783 1 udp 1686052607 46.118.136.55 58350 typ srflx raddr 192.168.1.62 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"}],"complete":false,"revision":3,"ufrag":"1uMr"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.573001+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"body":{"version":2,"type":"update","peer_connections":[{"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f","description":{"type":"create-offer","revision":2}}],"sid":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","name":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","participant":{"sid":"PAc42a6b7043d1a50875175a3f2692a2cd","identity":"participant-2","tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[],"subscribe":{"revision":1,"rules":[{"type":"include","all":true}]},"subscribed":{"revision":27,"tracks":[{"id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","sid":"MT3ff837a1ed676d2c896b69036f08f6a0"},{"id":"5801223c-ae01-463a-82ee-12237c416e44","sid":"MTe017775f5c2e2534747e0531b36bbdf5"}]}},"type":"msg"}
2020-04-30 12:35:10.574292+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): Open -> Updating. Process an event
2020-04-30 12:35:10.574469+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Create local offer: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.575366+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Including track id: FeE145883AE838EcEa0daE56446D32d8 for simulcast.
2020-04-30 12:35:10.575544+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): onCreateSessionLocalDescription 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.576090+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): SDP Utils: New SSRC 3780599619 replaced with Old SSRC 3780599619
2020-04-30 12:35:10.576408+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): SDP Utils: New SSRC 3455373520 replaced with Old SSRC 3455373520
2020-04-30 12:35:10.576754+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): SDP Utils: New SSRC 2243541197 replaced with Old SSRC 2243541197
2020-04-30 12:35:10.577017+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): SDP Utils: New SSRC group 3455373520 2243541197 --- Original SSRC group 3455373520 2243541197
2020-04-30 12:35:10.578103+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): Updating -> Open
2020-04-30 12:35:10.578198+0300 EmbeddedMultiVideo[4586:3457309] INFO:Twilio:[Core](0x16dde3000): Local offer is ready for 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.578285+0300 EmbeddedMultiVideo[4586:3457309] DEBUG:Twilio:[Core](0x16dde3000): Queue Description: 3 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.578861+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (4481 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"description":{"revision":3,"sdp":"v=0\r\no=- 153312047071811399 3 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video\r\na=msid-semantic: WMS c062E3Ad49f91a25c0Aa944111EDCBCe\r\nm=audio 58350 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 46.118.136.55\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 network-id 1 network-cost 10\r\na=candidate:2229118887 1 udp 2122194687 169.254.190.11 64710 typ host generation 0 network-id 2 network-cost 10\r\na=candidate:489935783 1 udp 1686052607 46.118.136.55 58350 typ srflx raddr 192.168.1.62 rport 58350 generation 0 network-id 1 network-cost 10\r\na=ice-ufrag:1uMr\r\na=ice-pwd:FSPTSQKg+VteahwnYfE1ddSr\r\na=ice-options:trickle\r\na=fingerprint:sha-256 24:52:17:BC:80:95:55:09:48:1F:FC:7C:D2:84:37:30:54:FC:F8:52:89:C7:83:AE:50:68:43:40:35:68:13:7A\r\na=setup:actpass\r\na=mid:audio\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=sendrecv\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: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:3780599619 cname:N15I+4DlIu7pVfp2\r\na=ssrc:3780599619 msid:c062E3Ad49f91a25c0Aa944111EDCBCe 1Cb3810516C44fF9e2Cf8faEA05B9cc9\r\na=ssrc:3780599619 mslabel:c062E3Ad49f91a25c0Aa944111EDCBCe\r\na=ssrc:3780599619 label:1Cb3810516C44fF9e2Cf8faEA05B9cc9\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 99 107 115 98 125 114 116\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:1uMr\r\na=ice-pwd:FSPTSQKg+VteahwnYfE1ddSr\r\na=ice-options:trickle\r\na=fingerprint:sha-256 24:52:17:BC:80:95:55:09:48:1F:FC:7C:D2:84:37:30:54:FC:F8:52:89:C7:83:AE:50:68:43:40:35:68:13:7A\r\na=setup:actpass\r\na=mid:video\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:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 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=sendrecv\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:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:107 rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\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=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=1;profile-level-id=42e01f\r\na=rtpmap:114 red/90000\r\na=rtpmap:116 ulpfec/90000\r\na=ssrc-group:FID 3455373520 2243541197\r\na=ssrc:3455373520 cname:N15I+4DlIu7pVfp2\r\na=ssrc:3455373520 msid:c062E3Ad49f91a25c0Aa944111EDCBCe FeE145883AE838EcEa0daE56446D32d8\r\na=ssrc:3455373520 mslabel:c062E3Ad49f91a25c0Aa944111EDCBCe\r\na=ssrc:3455373520 label:FeE145883AE838EcEa0daE56446D32d8\r\na=ssrc:2243541197 cname:N15I+4DlIu7pVfp2\r\na=ssrc:2243541197 msid:c062E3Ad49f91a25c0Aa944111EDCBCe FeE145883AE838EcEa0daE56446D32d8\r\na=ssrc:2243541197 mslabel:c062E3Ad49f91a25c0Aa944111EDCBCe\r\na=ssrc:2243541197 label:FeE145883AE838EcEa0daE56446D32d8\r\n","type":"offer"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.609081+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:10.609336+0300 EmbeddedMultiVideo[4586:3457012] Participant participant-1 connected with 1 audio and 1 video tracks
2020-04-30 12:35:10.614503+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:10.615327+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Did move to window with size: {834, 1112}.
Metal content scale factor is now: 2.000
2020-04-30 12:35:10.618368+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrackSubscribed
2020-04-30 12:35:10.618439+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call isTrackEnabled
2020-04-30 12:35:10.618472+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackName
2020-04-30 12:35:10.618504+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrack
2020-04-30 12:35:10.618540+0300 EmbeddedMultiVideo[4586:3457012] INFO:Twilio:[Core](0x102625800): Subscribed to Participant's participant-1 audio track with sid MTe017775f5c2e2534747e0531b36bbdf5
2020-04-30 12:35:10.618572+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:10.618774+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:10.618895+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:10.619013+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:10.619131+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getWebRtcTrack
2020-04-30 12:35:10.619301+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackName
2020-04-30 12:35:10.619431+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:10.619542+0300 EmbeddedMultiVideo[4586:3457012] Subscribed to 68a77164-5b91-443e-814a-bc171b0c6e5e audio track for Participant participant-1
2020-04-30 12:35:10.619647+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:10.619797+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrackSubscribed
2020-04-30 12:35:10.619858+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call isTrackEnabled
2020-04-30 12:35:10.619942+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackName
2020-04-30 12:35:10.620020+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrack
2020-04-30 12:35:10.620054+0300 EmbeddedMultiVideo[4586:3457012] INFO:Twilio:[Core](0x102625800): Subscribed to Participant's participant-1 video track with sid MT3ff837a1ed676d2c896b69036f08f6a0
2020-04-30 12:35:10.620087+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:10.620165+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:10.620206+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:10.620295+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:10.620384+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getWebRtcTrack
2020-04-30 12:35:10.620472+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackName
2020-04-30 12:35:10.620566+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:10.620658+0300 EmbeddedMultiVideo[4586:3457012] Subscribed to 64050041-1187-4ea0-a13a-e69835581202 video track for Participant participant-1
2020-04-30 12:35:10.620737+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:10.620869+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getWebRtcTrack
2020-04-30 12:35:10.620961+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getWebRtcTrack
2020-04-30 12:35:10.713214+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"body":{"version":2,"type":"update","peer_connections":[{"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f","ice":{"ufrag":"6Jzg","revision":1,"candidates":[{"candidate":"candidate:705695061 1 udp 2122260223 192.168.33.254 63876 typ host generation 0 ufrag 6Jzg network-id 4 network-cost 50","sdpMid":"audio","sdpMLineIndex":0}]}}],"sid":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","name":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","participant":{"sid":"PAc42a6b7043d1a50875175a3f2692a2cd","identity":"participant-2","tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA490d43189626af28c2cfe945c4df9101","identity":"participant-1","tracks":[{"kind":"audio","priority":"standard","id":"5801223c-ae01-463a-82ee-12237c416e44","enabled":true,"sid":"MTe017775f5c2e2534747e0531b36bbdf5","name":"68a77164-5b91-443e-814a-bc171b0c6e5e","state":"ready"},{"kind":"video","priority":"standard","id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","enabled":true,"sid":"MT3ff837a1ed676d2c896b69036f08f6a0","name":"64050041-1187-4ea0-a13a-e69835581202","state":"ready"}],"revision":3,"state":"connected"}],"recording":{"enabled":false,"revision":1},"subscribe":{"revision":1,"rules":[{"type":"include","all":true}]},"subscribed":{"revision":27,"tracks":[{"id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","sid":"MT3ff837a1ed676d2c896b69036f08f6a0"},{"id":"5801223c-ae01-463a-82ee-12237c416e44","sid":"MTe017775f5c2e2534747e0531b36bbdf5"}]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}]}},"type":"msg"}
2020-04-30 12:35:10.716367+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Adding 1 ICE candidate(s).
2020-04-30 12:35:10.716882+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): ICE connection state transitioned from New -> Checking
2020-04-30 12:35:10.716948+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f Ice connection state transitioned from New -> Checking
2020-04-30 12:35:10.717015+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Room Media state changed to Checking
2020-04-30 12:35:10.717101+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Ice Connection state checking. Stopping Ice gathering timer.
2020-04-30 12:35:10.751071+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Gathered a candidate. candidate:3287297824 1 udp 41885695 18.195.48.241 56969 typ relay raddr 46.118.136.55 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10
2020-04-30 12:35:10.751383+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Queue ICE candidate revision: 4 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.751561+0300 EmbeddedMultiVideo[4586:3457044] INFO:Twilio:[Core](0x16e12b000): Publish ICE candidate revision: 4 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.753128+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (1338 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"ice":{"candidates":[{"candidate":"candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:2229118887 1 udp 2122194687 169.254.190.11 64710 typ host generation 0 ufrag 1uMr network-id 2 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:489935783 1 udp 1686052607 46.118.136.55 58350 typ srflx raddr 192.168.1.62 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:3287297824 1 udp 41885695 18.195.48.241 56969 typ relay raddr 46.118.136.55 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"}],"complete":false,"revision":4,"ufrag":"1uMr"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.785876+0300 EmbeddedMultiVideo[4586:3457035] INFO:Twilio:[Core](0x16dd57000): Ice Gathering Complete for 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.786242+0300 EmbeddedMultiVideo[4586:3457035] DEBUG:Twilio:[Core](0x16dd57000): Queue ICE candidate revision: 5 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.786620+0300 EmbeddedMultiVideo[4586:3457035] INFO:Twilio:[Core](0x16dd57000): Publish ICE candidate revision: 5 for PeerConnection: 4ca9c8b3-c2de-41df-998b-292464e02c4f.
2020-04-30 12:35:10.788416+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (1337 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","kind":"audio","name":"Microphone","priority":"standard"},{"enabled":true,"id":"FeE145883AE838EcEa0daE56446D32d8","kind":"video","name":"Camera","priority":"standard"}]},"peer_connections":[{"ice":{"candidates":[{"candidate":"candidate:3944983155 1 udp 2122260223 192.168.1.62 58350 typ host generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:2229118887 1 udp 2122194687 169.254.190.11 64710 typ host generation 0 ufrag 1uMr network-id 2 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:489935783 1 udp 1686052607 46.118.136.55 58350 typ srflx raddr 192.168.1.62 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"},{"candidate":"candidate:3287297824 1 udp 41885695 18.195.48.241 56969 typ relay raddr 46.118.136.55 rport 58350 generation 0 ufrag 1uMr network-id 1 network-cost 10","sdpMLineIndex":0,"sdpMid":"audio"}],"complete":true,"revision":5,"ufrag":"1uMr"},"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f"}],"session":"b979b2f58511eba462ea4c336ee6e1aa6dcc3e5dd1a848e4a24f36c9deb3f098c42a6b7043d1a50875175a3f2692a2cd1377c378c2f2a6a2955f310e4476472e","type":"update","version":2},"type":"msg"}
2020-04-30 12:35:10.850888+0300 EmbeddedMultiVideo[4586:3457035] DEBUG:Twilio:[Core](0x16dd57000): ICE connection state transitioned from Checking -> Connected
2020-04-30 12:35:10.852111+0300 EmbeddedMultiVideo[4586:3457035] DEBUG:Twilio:[Core](0x16dd57000): PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f Ice connection state transitioned from Checking -> Connected
2020-04-30 12:35:10.852973+0300 EmbeddedMultiVideo[4586:3457035] DEBUG:Twilio:[Core](0x16dd57000): Room Media state changed to Connected
2020-04-30 12:35:10.853270+0300 EmbeddedMultiVideo[4586:3457035] INFO:Twilio:[Core](0x16dd57000): Media is connected
2020-04-30 12:35:10.853936+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Starting the media monitor - call getPeerConnectionStats
2020-04-30 12:35:10.857637+0300 EmbeddedMultiVideo[4586:3457035] DEBUG:Twilio:[Core](0x16dd57000): Media for PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f transitioned from MediaInactive -> MediaActive
2020-04-30 12:35:10.857967+0300 EmbeddedMultiVideo[4586:3457035] DEBUG:Twilio:[Core](0x16dd57000): PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f Media activity state transitioned from MediaInactive -> MediaActive
2020-04-30 12:35:10.881706+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Preparing renderer for frame size: {640, 480}, view bounds: {{0, 233}, {834, 626}}
2020-04-30 12:35:10.882089+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Detected a pixel format change. Preparing the rendering pipeline. Old = none, New = f420
2020-04-30 12:35:10.883005+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Texture caching failed with code: -6660, fallback to copy and upload path.
2020-04-30 12:35:10.896945+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"body":{"version":2,"type":"update","peer_connections":[{"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f","description":{"type":"answer","sdp":"v=0\r\no=- 5741560157422638176 3 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=msid-semantic: WMS *\r\na=group:BUNDLE audio video\r\nm=audio 52145 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 46.118.136.55\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:705695061 1 udp 2122260223 192.168.33.254 63876 typ host generation 0 network-id 4 network-cost 50\r\na=candidate:2146205724 1 udp 2122194687 169.254.64.221 61696 typ host generation 0 network-id 2\r\na=candidate:918459911 1 udp 2122129151 192.168.1.18 52145 typ host generation 0 network-id 1 network-cost 10\r\na=candidate:2543089907 1 udp 2122063615 172.27.224.17 64666 typ host generation 0 network-id 3 network-cost 50\r\na=candidate:3232690131 1 udp 1685921535 46.118.136.55 52145 typ srflx raddr 192.168.1.18 rport 52145 generation 0 network-id 1 network-cost 10\r\na=candidate:1687417253 1 tcp 1518280447 192.168.33.254 9 typ host tcptype active generation 0 network-id 4 network-cost 50\r\na=candidate:829390060 1 tcp 1518214911 169.254.64.221 9 typ host tcptype active generation 0 network-id 2\r\na=candidate:2017290999 1 tcp 1518149375 192.168.1.18 9 typ host tcptype active generation 0 network-id 1 network-cost 10\r\na=candidate:3642196995 1 tcp 1518083839 172.27.224.17 9 typ host tcptype active generation 0 network-id 3 network-cost 50\r\na=ice-options:trickle\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\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: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=setup:passive\r\na=mid:audio\r\na=sendrecv\r\na=ice-ufrag:6Jzg\r\na=ice-pwd:9+2QAv62Ksk6fuxtsiupMefW\r\na=fingerprint:sha-256 E1:84:96:FE:7E:82:AC:45:B4:2E:08:65:3D:E4:1E:8D:4B:03:44:A8:0A:6C:30:92:92:B8:87:18:16:4F:6F:C0\r\na=ssrc:4232778098 msid:- 5801223c-ae01-463a-82ee-12237c416e44\r\na=ssrc:4232778098 cname:05J19+cG4P5Tidnc\r\na=rtcp-mux\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 99 107 115 98 125 114 116\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-options:trickle\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:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11 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=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:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:107 rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:115 rtx/90000\r\na=fmtp:115 apt=114\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: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=1;profile-level-id=42e01f\r\na=rtpmap:114 red/90000\r\na=rtpmap:116 ulpfec/90000\r\na=setup:passive\r\na=mid:video\r\na=sendrecv\r\na=ice-ufrag:6Jzg\r\na=ice-pwd:9+2QAv62Ksk6fuxtsiupMefW\r\na=fingerprint:sha-256 E1:84:96:FE:7E:82:AC:45:B4:2E:08:65:3D:E4:1E:8D:4B:03:44:A8:0A:6C:30:92:92:B8:87:18:16:4F:6F:C0\r\na=ssrc-group:FID 2555901402 1100794705\r\na=ssrc:2555901402 msid:- b6931bf8-e7b9-424b-b105-ef9407a4f440\r\na=ssrc:2555901402 cname:05J19+cG4P5Tidnc\r\na=ssrc:1100794705 msid:- b6931bf8-e7b9-424b-b105-ef9407a4f440\r\na=ssrc:1100794705 cname:05J19+cG4P5Tidnc\r\na=rtcp-mux\r\n","revision":3},"ice":{"ufrag":"6Jzg","revision":10,"candidates":[{"candidate":"candidate:705695061 1 udp 2122260223 192.168.33.254 63876 typ host generation 0 ufrag 6Jzg network-id 4 network-cost 50","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:2146205724 1 udp 2122194687 169.254.64.221 61696 typ host generation 0 ufrag 6Jzg network-id 2","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:918459911 1 udp 2122129151 192.168.1.18 52145 typ host generation 0 ufrag 6Jzg network-id 1 network-cost 10","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:2543089907 1 udp 2122063615 172.27.224.17 64666 typ host generation 0 ufrag 6Jzg network-id 3 network-cost 50","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:3232690131 1 udp 1685921535 46.118.136.55 52145 typ srflx raddr 192.168.1.18 rport 52145 generation 0 ufrag 6Jzg network-id 1 network-cost 10","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:1687417253 1 tcp 1518280447 192.168.33.254 9 typ host tcptype active generation 0 ufrag 6Jzg network-id 4 network-cost 50","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:829390060 1 tcp 1518214911 169.254.64.221 9 typ host tcptype active generation 0 ufrag 6Jzg network-id 2","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:2017290999 1 tcp 1518149375 192.168.1.18 9 typ host tcptype active generation 0 ufrag 6Jzg network-id 1 network-cost 10","sdpMid":"audio","sdpMLineIndex":0},{"candidate":"candidate:3642196995 1 tcp 1518083839 172.27.224.17 9 typ host tcptype active generation 0 ufrag 6Jzg network-id 3 network-cost 50","sdpMid":"audio","sdpMLineIndex":0}],"complete":true}}],"sid":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","name":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","participant":{"sid":"PAc42a6b7043d1a50875175a3f2692a2cd","identity":"participant-2","tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA490d43189626af28c2cfe945c4df9101","identity":"participant-1","tracks":[{"kind":"audio","priority":"standard","id":"5801223c-ae01-463a-82ee-12237c416e44","enabled":true,"sid":"MTe017775f5c2e2534747e0531b36bbdf5","name":"68a77164-5b91-443e-814a-bc171b0c6e5e","state":"ready"},{"kind":"video","priority":"standard","id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","enabled":true,"sid":"MT3ff837a1ed676d2c896b69036f08f6a0","name":"64050041-1187-4ea0-a13a-e69835581202","state":"ready"}],"revision":3,"state":"connected"}],"recording":{"enabled":false,"revision":1},"subscribe":{"revision":1,"rules":[{"type":"include","all":true}]},"subscribed":{"revision":27,"tracks":[{"id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","sid":"MT3ff837a1ed676d2c896b69036f08f6a0"},{"id":"5801223c-ae01-463a-82ee-12237c416e44","sid":"MTe017775f5c2e2534747e0531b36bbdf5"}]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}]}},"type":"msg"}
2020-04-30 12:35:10.907689+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Open -> Updating. Process an event
2020-04-30 12:35:10.907857+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Process remote answer at revision 3.
2020-04-30 12:35:10.907964+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Process remote sdp for: 4ca9c8b3-c2de-41df-998b-292464e02c4f revision is: 3.
2020-04-30 12:35:10.910058+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Applying local description to: 4ca9c8b3-c2de-41df-998b-292464e02c4f rev: 3
2020-04-30 12:35:10.912467+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Adding 8 ICE candidate(s).
2020-04-30 12:35:10.915002+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): onSetSessionLocalDescription: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.915404+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Applying remote description to: 4ca9c8b3-c2de-41df-998b-292464e02c4f rev: 3
2020-04-30 12:35:10.918059+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Done processing onSetSessionLocalDescription: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.918183+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): onSetSessionRemoteDescription: 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:10.919426+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Updating -> Open
2020-04-30 12:35:14.739505+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:35:15.382072+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): ICE connection state transitioned from Connected -> Disconnected
2020-04-30 12:35:15.382251+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f Ice connection state transitioned from Connected -> Disconnected
2020-04-30 12:35:15.382353+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): Room Media state changed to Disconnected
2020-04-30 12:35:15.382586+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): bool twilio::media::IceConnectionActivityMonitor::isRunning()
2020-04-30 12:35:15.382684+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): void twilio::media::IceConnectionActivityMonitor::getStats()
2020-04-30 12:35:15.589733+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}
2020-04-30 12:35:15.598508+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"body":{"version":2,"type":"update","peer_connections":[{"id":"4ca9c8b3-c2de-41df-998b-292464e02c4f","description":{"type":"close","revision":4}}],"sid":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","name":"RM6dcc3e5dd1a848e4a24f36c9deb3f098","participant":{"sid":"PAc42a6b7043d1a50875175a3f2692a2cd","identity":"participant-2","tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA490d43189626af28c2cfe945c4df9101","identity":"participant-1","tracks":[{"kind":"audio","priority":"standard","id":"5801223c-ae01-463a-82ee-12237c416e44","enabled":true,"sid":"MTe017775f5c2e2534747e0531b36bbdf5","name":"68a77164-5b91-443e-814a-bc171b0c6e5e","state":"ready"},{"kind":"video","priority":"standard","id":"b6931bf8-e7b9-424b-b105-ef9407a4f440","enabled":true,"sid":"MT3ff837a1ed676d2c896b69036f08f6a0","name":"64050041-1187-4ea0-a13a-e69835581202","state":"ready"}],"revision":4,"state":"disconnected"}],"recording":{"enabled":false,"revision":1},"subscribe":{"revision":1,"rules":[{"type":"include","all":true}]},"subscribed":{"revision":28,"tracks":[]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"FeE145883AE838EcEa0daE56446D32d8","enabled":true,"sid":"MT23b5193997e918a5743e9ef5242c3516","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"1Cb3810516C44fF9e2Cf8faEA05B9cc9","enabled":true,"sid":"MT85aac3713213f09b26dd4ea24e20d064","name":"Microphone","state":"ready"}]}},"type":"msg"}
2020-04-30 12:35:15.611911+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): Open -> Updating. Process an event
2020-04-30 12:35:15.611911+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.612482+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrackSubscribed
2020-04-30 12:35:15.612789+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): Current Ice connection state: Disconnected
2020-04-30 12:35:15.612899+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.613242+0300 EmbeddedMultiVideo[4586:3457039] INFO:Twilio:[Core](0x16df87000): Closing 4ca9c8b3-c2de-41df-998b-292464e02c4f due to signaling channel instruction to close
2020-04-30 12:35:15.613309+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:15.614078+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:15.615474+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackName
2020-04-30 12:35:15.616465+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:15.617510+0300 EmbeddedMultiVideo[4586:3457012] Unsubscribed from 68a77164-5b91-443e-814a-bc171b0c6e5e audio track for Participant participant-1
2020-04-30 12:35:15.618808+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:15.620115+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): -[TVIAudioTrack dealloc]
2020-04-30 12:35:15.621389+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrack
2020-04-30 12:35:15.622160+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.622522+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrackSubscribed
2020-04-30 12:35:15.623411+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.623685+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:15.624208+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackSid
2020-04-30 12:35:15.624453+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getTrackName
2020-04-30 12:35:15.624871+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:15.625644+0300 EmbeddedMultiVideo[4586:3457012] Unsubscribed from 64050041-1187-4ea0-a13a-e69835581202 video track for Participant participant-1
2020-04-30 12:35:15.626358+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:15.626828+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getWebRtcTrack
2020-04-30 12:35:15.627326+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getWebRtcTrack
2020-04-30 12:35:15.631407+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): -[TVIVideoTrack dealloc]
2020-04-30 12:35:15.631587+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call setTrack
2020-04-30 12:35:15.631760+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): RemoteParticipantSignaling::~RemoteParticipantSignaling(SID = PA490d43189626af28c2cfe945c4df9101)
2020-04-30 12:35:15.631937+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:15.632072+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:15.632215+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:15.632535+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getName
2020-04-30 12:35:15.633398+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:15.633560+0300 EmbeddedMultiVideo[4586:3457012] Room room-123, Participant participant-1 disconnected
2020-04-30 12:35:15.633767+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getSid
2020-04-30 12:35:15.634752+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): Did move to window with size: {0, 0}.
Metal content scale factor is now: 0.000
2020-04-30 12:35:15.635339+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): -[TVIRemoteParticipant dealloc]
2020-04-30 12:35:15.635514+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:15.635669+0300 EmbeddedMultiVideo[4586:3457012] INFO:Twilio:[Core](0x102625800): Invalidating remote media of participant-1
2020-04-30 12:35:15.635964+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.636260+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.636592+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): RemoteParticipantImpl::~RemoteParticipantImpl
2020-04-30 12:35:15.636931+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getIdentity
2020-04-30 12:35:15.637251+0300 EmbeddedMultiVideo[4586:3457012] INFO:Twilio:[Core](0x102625800): Invalidating remote media of participant-1
2020-04-30 12:35:15.637626+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.638001+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Core](0x102625800): API Call getRemoteTrack
2020-04-30 12:35:15.638773+0300 EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:[Platform](0x102625800): -[TVIMetalRenderer dealloc]
2020-04-30 12:35:15.650008+0300 EmbeddedMultiVideo[4586:3457046] INFO:Twilio:[Core](MediaFactoryImpl::signaling): Closed Webrtc PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f
2020-04-30 12:35:15.650216+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): void twilio::media::IceConnectionActivityMonitor::stop()
2020-04-30 12:35:15.650384+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): virtual twilio::media::IceConnectionActivityMonitor::~IceConnectionActivityMonitor()
2020-04-30 12:35:15.650544+0300 EmbeddedMultiVideo[4586:3457046] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling): Stopping the Network Manager
2020-04-30 12:35:15.650904+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): PeerConnection 4ca9c8b3-c2de-41df-998b-292464e02c4f closed. Ice connection state set from Disconnected -> Closed
2020-04-30 12:35:15.650991+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): Room Media state changed to Closed
2020-04-30 12:35:15.651080+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): All Peer Connections closed without media failure.
2020-04-30 12:35:15.651229+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): ICE connection state transitioned from Disconnected -> Closed
2020-04-30 12:35:15.651367+0300 EmbeddedMultiVideo[4586:3457039] DEBUG:Twilio:[Core](0x16df87000): Discarding ice connection state update because our state is closed
2020-04-30 12:35:19.394547+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:35:20.390328+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}
2020-04-30 12:35:23.995994+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:35:25.194640+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}
2020-04-30 12:35:25.531439+0300 EmbeddedMultiVideo[4586:3457044] DEBUG:Twilio:[Core](0x16e12b000): Invoking cancelled closure.
2020-04-30 12:35:28.607984+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}
2020-04-30 12:35:29.994804+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Sending message (21 bytes):
{"type":"heartbeat"}
2020-04-30 12:35:33.109365+0300 EmbeddedMultiVideo[4586:3457059] DEBUG:Twilio:[Core](0x16e3e7000): Received message:
{"type":"heartbeat"}

......................

Thank you

mialex commented 4 years ago

After doing more research I found out that indeed the issue was caused by the Default audio device received AVAudioSessionInterruptionTypeBegan. Af far as the session was interrupted and never got back I've decided to deactivate the session manually. Luckily that helped.

 func participantDidDisconnect(room: Room, participant: RemoteParticipant) {

        let session = AVAudioSession.sharedInstance()

        do {
            try session.setActive(false )
        } catch let error as NSError {
            print("Unable to activate audio session:  \(error.localizedDescription)")
        }
        ...
}

Maybe you have some better options or suggestions on how to deal with that or if this fix will be included in the next releases?

ceaglest commented 4 years ago

Hi @mialex,

Thanks or writing in. I looked at the Room Sid you provided and I am not sure why the AVAudioSessionInterruptionTypeBegan is not coupled with an AVAudioSessionInterruptionTypeEnded.

EmbeddedMultiVideo[4586:3457012] DEBUG:Twilio:Platform: Default audio device received AVAudioSessionInterruptionTypeBegan.

Do you know what causes this interruption to begin in the first place? It doesn't look like it happens when UserOne disconnects from the Room.

I am also wondering if you have Enabled Background Audio in your application, just in case this is the culprit.

Thanks, Chris

mialex commented 4 years ago

Hi, @ceaglest

Do you know what causes this interruption to begin in the first place?

Not sure, as after I've made a call and the second participant has disconnected I've put my phone aside and did nothing except staying on the page with the video call and waiting for the second participant to get back on the call. In some time 10+ minutes or so, I get AVAudioSessionInterruptionTypeBegan notification. Maybe because of inactivity iOS system put the application to the background even though it's still opened (not sure as I'm not an expert :) )

I am also wondering if you have Enabled Background Audio in your application

I saw that option but was not sure If I have to use that as I don't put the audio to the background. At least I don't do that, in case of the system can do that. So, answering your question, I haven't used that option. Is this mandatory to use that?

mialex commented 4 years ago

Enabled Background Audio has helped me to avoid this issue, thx