search

twilio / twilio-video-ios

Programmable Video SDK by Twilio
http://twilio.com/video
Other
64 stars 22 forks source link

Troubles using ICE server for connection #48

Closed MilanNosal closed 5 years ago

MilanNosal commented 5 years ago

Description

We are trying to use ICE server when connecting to the room. For some reason it seems that the ICE options on the connection options does not work (based on the dashboard of the ICE server provider).

Steps to Reproduce

Try to connect to the room.

Code


        guard let accessToken = self.accessToken else {
            return
        }

        let connectOptions = TVIConnectOptions.init(token: accessToken) { (builder) in

            builder.audioTracks = self.localAudioTrack != nil ? [self.localAudioTrack!] : [TVILocalAudioTrack]()
            builder.videoTracks = self.localVideoTrack != nil ? [self.localVideoTrack!] : [TVILocalVideoTrack]()

            if let preferredAudioCodec = TwillioSettings.shared.audioCodec {
                builder.preferredAudioCodecs = [preferredAudioCodec]
            }
            if let preferredVideoCodec = TwillioSettings.shared.videoCodec {
                builder.preferredVideoCodecs = [preferredVideoCodec]
            }
            if let encodingParameters = TwillioSettings.shared.getEncodingParameters() {
                builder.encodingParameters = encodingParameters
            }

            builder.roomName = roomId.uuidString

            builder.uuid = uuid

            builder.iceOptions = TVIIceOptions.init(block: { (TVIIceOptionsBuilder) in
                TVIIceOptionsBuilder.transportPolicy = .relay
                TVIIceOptionsBuilder.servers = [
                    TVIIceServer(urlString: "********",
                                 username: "********",
                                 password: "********"),
                    TVIIceServer(urlString: "********",
                                 username: "********",
                                 password: "********"),
                    TVIIceServer(urlString: "********",
                                 username: "********",
                                 password: "********"),
                    TVIIceServer(urlString: "********",
                                 username: "********",
                                 password: "********"),
                    TVIIceServer(urlString: "********",
                                 username: "********",
                                 password: "********"), ]

            })
        }

        room = TwilioVideo.connect(with: connectOptions, delegate: self)

        logMessage(messageText: "Callkit: Attempting to connect to room call \(String(describing: roomId.uuidString))")

        self.callKitCompletionHandler = completionHandler

Expected Behavior

Connection would be made through ICE server.

Actual Behavior

Does not seem to affect connection.

From the logs (see below) I can only see a single mention of the ice server during the connection stating: "ice_servers":"overrode". What does this mean?

Reproduces How Often

100% times

Logs

2019-05-17 14:15:33.434323+0200 Squad[652:128475] [NetworkInfo] Signal strength query returned error: Error Domain=NSPOSIXErrorDomain Code=13 "Permission denied", descriptor: <CTServiceDescriptor 0x2808f3200, domain=1, instance=1>
----------------------- attempt push token registered
2019-05-17 14:15:33.453949+0200 Squad[652:128475] [Crashlytics] Version 3.12.0 (136)
2019-05-17 14:15:33.547479+0200 Squad[652:128475] [Contacts] Contacts TCC acccess preflight was denied
2019-05-17 14:15:33.547560+0200 Squad[652:128475] [Contacts] Contacts TCC acccess preflight was denied
2019-05-17 14:15:33.554140+0200 Squad[652:128475] [MC] System group container for systemgroup.com.apple.configurationprofiles path is /private/var/containers/Shared/SystemGroup/systemgroup.com.apple.configurationprofiles
2019-05-17 14:15:33.554436+0200 Squad[652:128475] [MC] Reading from public effective user settings.
2019-05-17 14:15:33.565176+0200 Squad[652:128475] [Contacts] Contacts TCC acccess preflight was denied
2019-05-17 14:15:33.772543+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating peer connection signaling thread ...
2019-05-17 14:15:33.772810+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating peer connection worker thread ...
2019-05-17 14:15:33.772875+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating peer connection networking thread ...
2019-05-17 14:15:33.772928+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating peer connection factory ...
2019-05-17 14:15:33.776506+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Done creating peer connection factory.
2019-05-17 14:15:33.778335+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Adding audio track ...
2019-05-17 14:15:33.787141+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating a video track ...
2019-05-17 14:15:33.790740+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Start capturing with device: <AVCaptureFigVideoDevice: 0x10e482dd0 [Front Camera][com.apple.avfoundation.avcapturedevice.built-in_video:1]> format: <<TVIVideoFormat: 0x2808a0ce0> size: {640, 480}, fps: 30, format: 420f>.
2019-05-17 14:15:33.790871+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Prepare for capturing.
2019-05-17 14:15:33.791019+0200 Squad[652:128475] INFO:TwilioVideo:[Platform]:Starting capture pipeline ...
Video track created
2019-05-17 14:15:33.791182+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating a data track ...
2019-05-17 14:15:33.804743+0200 Squad[652:128541] DEBUG:TwilioVideo:[Platform]:Adding device input: <AVCaptureDeviceInput: 0x2808a2ac0 [Front Camera]>
2019-05-17 14:15:33.809169+0200 Squad[652:128541] INFO:TwilioVideo:[Platform]:Best device format was: <AVCaptureDeviceFormat: 0x280ac2690 'vide'/'420f'  640x 480, { 1- 30 fps}, fov:55.200, max zoom:60.00 (upscales @2.00), ISO:47.0-1504.0, SS:0.000031-1.000000>
2019-05-17 14:15:34.140254+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140385+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140493+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140605+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140698+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140758+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140816+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.140923+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.141032+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.141329+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.141403+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.141631+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.141742+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.142033+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.142095+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.142424+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.142509+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.142782+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.142863+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.143102+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.143198+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.143437+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.143542+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.143789+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.143852+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Did move to window with size: {320, 568}.
Metal content scale factor is now: 2.000
2019-05-17 14:15:34.175688+0200 Squad[652:128475] [NetworkInfo] Signal strength query returned error: Error Domain=NSPOSIXErrorDomain Code=13 "Permission denied", descriptor: <CTServiceDescriptor 0x28086b3e0, domain=1, instance=1>
----------------------- push token try to registered
Callkit: providerDidBegin
>> device token: 376756FAA2EB5E51671064D29A56AB4089C058F30F28FA33FB37D7ACF22105C4
2019-05-17 14:15:34.397438+0200 Squad[652:128475] [User Defaults] Couldn't read values in CFPrefsPlistSource<0x2826d3e80> (Domain: group.com.molly.squad, User: kCFPreferencesAnyUser, ByHost: Yes, Container: (null), Contents Need Refresh: Yes): Using kCFPreferencesAnyUser with a container is only allowed for System Containers, detaching from cfprefsd
We're up to date
2019-05-17 14:15:34.500927+0200 Squad[652:128541] INFO:TwilioVideo:[Platform]:... Finished starting capture.
2019-05-17 14:15:34.501032+0200 Squad[652:128541] INFO:TwilioVideo:[Platform]:Session started running
2019-05-17 14:15:34.503350+0200 Squad[652:128543] DEBUG:TwilioVideo:[Platform]:Video pipeline will start running.
2019-05-17 14:15:34.503836+0200 Squad[652:128543] DEBUG:TwilioVideo:[Platform]:Video device will start running: <AVCaptureFigVideoDevice: 0x10e482dd0 [Front Camera][com.apple.avfoundation.avcapturedevice.built-in_video:1]>.
2019-05-17 14:15:34.511515+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Preparing renderer for frame size: {640, 480}, view bounds: {{0, 0}, {320, 568}}
2019-05-17 14:15:34.511638+0200 Squad[652:128475] DEBUG:TwilioVideo:[Platform]:Detected a pixel format change. Preparing the rendering pipeline. Old = none, New = 420f
----------------------- device token registered
-------------- SUCCESS: <null>
--------------- 
----------------------- push token registered
Loaded list of products...
2019-05-17 14:16:35.181855+0200 Squad[652:128525] TIC Read Status [5:0x283dfbcc0]: 1:57
2019-05-17 14:16:35.182016+0200 Squad[652:128525] TIC Read Status [5:0x283dfbcc0]: 1:57
2019-05-17 14:16:35.182086+0200 Squad[652:128525] TIC Read Status [5:0x283dfbcc0]: 1:57
2019-05-17 14:16:35.186460+0200 Squad[652:128525] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C5.1:2][0x116ba0120] get output frames failed, state 8196
2019-05-17 14:16:35.186896+0200 Squad[652:128525] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C5.1:2][0x116ba0120] get output frames failed, state 8196
2019-05-17 14:16:35.188464+0200 Squad[652:128525] TIC Read Status [5:0x0]: 1:57
2019-05-17 14:16:35.188539+0200 Squad[652:128525] TIC Read Status [5:0x0]: 1:57
2019-05-17 14:16:35.188644+0200 Squad[652:128525] TIC Read Status [5:0x0]: 1:57
2019-05-17 14:16:35.188800+0200 Squad[652:128525] TIC Read Status [5:0x0]: 1:57
2019-05-17 14:16:35.317181+0200 Squad[652:128525] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C1.1:2][0x10e35a4a0] get output frames failed, state 8196
2019-05-17 14:16:35.318675+0200 Squad[652:128525] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C1.1:2][0x10e35a4a0] get output frames failed, state 8196
2019-05-17 14:16:35.321902+0200 Squad[652:128525] TIC Read Status [1:0x0]: 1:57
2019-05-17 14:16:35.321994+0200 Squad[652:128525] TIC Read Status [1:0x0]: 1:57
2019-05-17 14:17:33.988600+0200 Squad[652:129160] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C4.1:2][0x116b0e7d0] get output frames failed, state 8196
2019-05-17 14:17:33.989173+0200 Squad[652:129160] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C4.1:2][0x116b0e7d0] get output frames failed, state 8196
2019-05-17 14:17:33.992075+0200 Squad[652:129160] TIC Read Status [4:0x0]: 1:57
2019-05-17 14:17:33.992204+0200 Squad[652:129160] TIC Read Status [4:0x0]: 1:57
2019-05-17 14:17:34.275721+0200 Squad[652:128540] Callkit: StartCallAction transaction request successful
Callkit: provider:performStartCallAction:
2019-05-17 14:17:34.616330+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating dedicated notifier queue ...
2019-05-17 14:17:34.618071+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:AppleReachability::AppleReachability()
2019-05-17 14:17:34.618109+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:Creating zeroAddrReachability
2019-05-17 14:17:34.619770+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Creating SIP stack ...
2019-05-17 14:17:34.620182+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Adding IPv4/IPv6 TLS transports ...
2019-05-17 14:17:34.620241+0200 Squad[652:128475] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Connection::Connection: new connection created to who: [ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:34.620271+0200 Squad[652:128475] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Creating TLS transport for domain  interface= port=0
2019-05-17 14:17:34.620408+0200 Squad[652:128475] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Connection::Connection: new connection created to who: [ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:34.623792+0200 Squad[652:128475] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Creating TLS transport for domain  interface= port=0
2019-05-17 14:17:34.624005+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl::RoomSignalingImpl()
2019-05-17 14:17:34.624066+0200 Squad[652:128475] INFO:TwilioVideo:[Core]:Starting SIP signaling stack worker thread ...
2019-05-17 14:17:34.627712+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Starting StackThread runloop.
2019-05-17 14:17:34.627930+0200 Squad[652:129238] INFO:TwilioVideo:[Core]:Querying SIP edge (mobile-endpoint.twilio.com) IP addresses ...
2019-05-17 14:17:34.627960+0200 Squad[652:129238] INFO:TwilioVideo:[Core]:Looking up: mobile-endpoint.twilio.com
Callkit: Attempting to connect to room call 00662AAD-1F9F-4141-8613-DE4C8CDE3DD9
2019-05-17 14:17:34.648810+0200 Squad[652:128550] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl: State transition successful: kInit -> kConnecting
2019-05-17 14:17:34.649619+0200 Squad[652:128554] INFO:TwilioVideo:[Core]:Creating peer connection ...
2019-05-17 14:17:34.659379+0200 Squad[652:128554] INFO:TwilioVideo:[Core]:Adding local stream to peer connection ...
2019-05-17 14:17:34.661707+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Address family: 2: 34.203.250.196
2019-05-17 14:17:34.661747+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Address family: 2: 34.203.250.196
2019-05-17 14:17:34.661799+0200 Squad[652:129238] INFO:TwilioVideo:[Core]:Setting SIP edge (outbound proxy) to: sips:34.203.250.196:443
2019-05-17 14:17:34.661831+0200 Squad[652:129238] INFO:TwilioVideo:[Core]:DNS resolution was successful
2019-05-17 14:17:34.661867+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Sending a ping message ...
2019-05-17 14:17:34.662109+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Socket created in ../resiprocate-1.8/resip/stack/TcpBaseTransport.cxx at line 223, transport: 1, socket: 60
2019-05-17 14:17:34.662307+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Connection::Connection: new connection created to who: [ V4 34.203.250.196:443 TLS target domain=unspecified mFlowKey=60 ]
2019-05-17 14:17:34.662349+0200 Squad[652:129238] INFO2019-05-17 14:17:34.669984+0200 Squad[652:128550] DEBUG:TwilioVideo:[Core]:Open -> Updating. Process an event
:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Creating TLS connection for domain  [ V4 34.203.250.196:443 TLS target domain=unspecified mFlowKey=0 ] on 60
2019-05-17 14:17:34.671527+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Create local offer: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:34.672149+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Including track id: c825Dd591422a0f43aFe5BFf58FCe0b5 for simulcast.
2019-05-17 14:17:34.682062+0200 Squad[652:128550] DEBUG:TwilioVideo:[Core]:onCreateSessionLocalDescription 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:34.682355+0200 Squad[652:128550] DEBUG:TwilioVideo:[Core]:SDP Utils: New SSRC group 1033393581 1680391674 --- Original SSRC group 1033393581 1680391674
2019-05-17 14:17:34.683101+0200 Squad[652:128550] DEBUG:TwilioVideo:[Core]:PeerConnection state: Updating -> Waiting
2019-05-17 14:17:34.683133+0200 Squad[652:128550] INFO:TwilioVideo:[Core]:Local SDP is ready
2019-05-17 14:17:34.683167+0200 Squad[652:128550] INFO:TwilioVideo:[Core]:Queue Description: 1 for PeerConnection: 6CE08380ad3F6FBdDD888aBB1f765D92.
2019-05-17 14:17:34.686238+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Adding X-Twilio-AccessToken header.
2019-05-17 14:17:34.686336+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:DNS is resolved.
2019-05-17 14:17:34.686430+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Sending outgoing SIP message
INVITE sip:mobile-endpoint.twilio.com;transport=tls SIP/2.0

Via: SIP/2.0/TLS 127.0.0.1;branch=z9hG4bK-524287-1---5ad6ec0b79b5aff4;rport

Max-Forwards: 70

Contact: <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@127.0.0.1;transport=tls;ob>

To: <sip:orchestrator@mobile-endpoint.twilio.com>

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 1 INVITE

Session-Expires: 120

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, UPDATE, NOTIFY

Content-Type: application/room-signaling+json

Supported: timer, outbound, path, gruu, room-signaling

User-Agent: TwilioVideo SDK

X-Twilio-AccessToken: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCIsImN0eSI6InR3aWxpby1mcGE7dj0xIn0.eyJqdGkiOiJTSzJiNTgyZDc0ZDVlMDc2OTA0MmUxYzIxZTdiYWE1MWU5LTE1NTgwOTU0NTQiLCJncmFudHMiOnsiaWRlbnRpdHkiOiIxMDc0NzkiLCJ2aWRlbyI6eyJyb29tIjoiMDA2NjJBQUQtMUY5Ri00MTQxLTg2MTMtREU0QzhDREUzREQ5In19LCJpYXQiOjE1NTgwOTU0NTQsImV4cCI6MTU1ODA5OTA1NCwiaXNzIjoiU0syYjU4MmQ3NGQ1ZTA3NjkwNDJlMWMyMWU3YmFhNTFlOSIsInN1YiI6IkFDYmJiZTc2YTg4NTdhNDc2NGZmYWRlMzg1NjA2NTdmY2YifQ.Xn5d9NcvFXdgz6cWmA3zqMwCksRzYCIktneQdRKcR2A

Content-Length: 4257

{"format":"planb","ice_servers":"overrode","media_signaling":null,"name":"00662AAD-1F9F-4141-8613-DE4C8CDE3DD9","participant":{"revision":1,"tracks":[{"enabled":true,"id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","kind":"audio","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","priority":"medium"},{"enabled":true,"id":"c825Dd591422a0f43aFe5BFf58FCe0b5","kind":"video","name":"camera","priority":"medium"}]},"peer_connections":[{"description":{"revision":1,"sdp":"v=0\r\no=- 6686746332114638318 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video\r\na=msid-semantic: WMS aDBf6B06A5e93DCC1ADBFA76E467Fd93\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:Uckh\r\na=ice-pwd:AnDGWi3I0gp8mcnH8mixqKf+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 CF:5D:F7:EF:9A:E1:BB:10:EE:AD:6B:D2:5C:19:62:79:B0:3F:62:48:4F:86:59:20:58:D1:1F:17:4F:60:81:A0\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:4203016772 cname:BJESmOLlPu4a0W92\r\na=ssrc:4203016772 mCallkit: provider:didActivateAudioSession:
sid:aDBf6B06A5e93DCC1ADBFA76E467Fd93 aaE1E3E4ee74639aAA4dA07CAAE8Df13\r\na=ssrc:4203016772 mslabel:aDBf6B06A5e93DCC1ADBFA76E467Fd93\r\na=ssrc:4203016772 label:aaE1E3E4ee74639aAA4dA07CAAE8Df13\r\nm=video 9 UDP/TLS/RTP/SAVPF 100 96 97 98 99 101 102 125 127\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:Uckh\r\na=ice-pwd:AnDGWi3I0gp8mcnH8mixqKf+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 CF:5D:F7:EF:9A:E1:BB:10:EE:AD:6B:D2:5C:19:62:79:B0:3F:62:48:4F:86:59:20:58:D1:1F:17:4F:60:81:A0\r\na=setup:actpass\r\na=mid:video\r\na=extmap:2 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:4 urn:3gpp:video-orientation\r\na=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:8 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: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:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:100 H264/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 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:102 red/90000\r\na=rtpmap:125 rtx/90000\r\na=fmtp:125 apt=102\r\na=rtpmap:127 ulpfec/90000\r\na=ssrc-group:FID 1033393581 1680391674\r\na=ssrc:1033393581 cname:BJESmOLlPu4a0W92\r\na=ssrc:1033393581 msid:aDBf6B06A5e93DCC1ADBFA76E467Fd93 c825Dd591422a0f43aFe5BFf58FCe0b5\r\na=ssrc:1033393581 mslabel:aDBf6B06A5e93DCC1ADBFA76E467Fd93\r\na=ssrc:1033393581 label:c825Dd591422a0f43aFe5BFf58FCe0b5\r\na=ssrc:1680391674 cname:BJESmOLlPu4a0W92\r\na=ssrc:1680391674 msid:aDBf6B06A5e93DCC1ADBFA76E467Fd93 c825Dd591422a0f43aFe5BFf58FCe0b5\r\na=ssrc:1680391674 mslabel:aDBf6B06A5e93DCC1ADBFA76E467Fd93\r\na=ssrc:1680391674 label:c825Dd591422a0f43aFe5BFf58FCe0b5\r\n","type":"offer"},"id":"6CE08380ad3F6FBdDD888aBB1f765D92"}],"publisher":{"hw_device_arch":"arm64","hw_device_manufacturer":"Apple","hw_device_model":"iPhone8,4","name":"twilio-video-ios","platform_name":"iOS","platform_version":"12.3","sdk_version":"2.10.0"},"type":"connect","version":2}
2019-05-17 14:17:34.732035+0200 Squad[652:129238] WARN:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Can't find matching transport [ V4 127.0.0.1:0 TLS target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:34.784921+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: TLS handshake starting (client mode)
2019-05-17 14:17:34.785437+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: TLS connected
2019-05-17 14:17:35.034900+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: TLS connected
2019-05-17 14:17:35.034992+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: TLS sessions set up with TLSv1.2 TLSv1/SSLv3 AES256-GCM-SHA384
2019-05-17 14:17:35.035098+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::SIP: subjectAltName of TLS session cert contains DNS <mobile-endpoint.twilio.com>
2019-05-17 14:17:35.035139+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::SIP: subjectAltName of TLS session cert contains DNS <mobile-endpoint.us1.twilio.com>
2019-05-17 14:17:35.035405+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::TRANSPORT: TLS handshake done for peer mobile-endpoint.twilio.com, mobile-endpoint.us1.twilio.com
2019-05-17 14:17:35.402859+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
SIP/2.0 100 Giving a try

Via: SIP/2.0/TLS 127.0.0.1;received=88.212.40.93;branch=z9hG4bK-524287-1---5ad6ec0b79b5aff4;rport=51601

To: <sip:orchestrator@mobile-endpoint.twilio.com>

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 1 INVITE

Server: Twilio Gateway

Content-Length: 0
2019-05-17 14:17:35.403213+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Process INVITE response with code 100
2019-05-17 14:17:35.578234+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
SIP/2.0 200 OK

Via: SIP/2.0/TLS 127.0.0.1;received=88.212.40.93;branch=z9hG4bK-524287-1---5ad6ec0b79b5aff4;rport=51601

Record-Route: <sip:172.18.3.179:5060;r2=on;transport=udp;ftag=209e23f5;lr>

Record-Route: <sip:34.203.250.196:443;r2=on;transport=tls;ftag=209e23f5;lr>

Require: timer

Contact: <sip:172.18.52.17:5060>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 1 INVITE

Session-Expires: 120;refresher=uac

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE

Content-Type: application/room-signaling+json

Server: Twilio

Supported: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

X-Twilio-EdgeHost: ec2-34-203-250-196.compute-1.amazonaws.com

Content-Length: 3018

{"version":2,"type":"connected","peer_connections":[{"id":"6CE08380ad3F6FBdDD888aBB1f765D92","description":{"type":"answer","sdp":"v=0\r\no=- 3767084255 3767084255 IN IP4 0.0.0.0\r\ns=VM6fbe6c595e7cf6428edb5e88f31b1c44\r\nt=0 0\r\na=ice-lite\r\na=msid-semantic: WMS *\r\na=group:BUNDLE audio video\r\nm=audio 19452 UDP/TLS/RTP/SAVPF 111 0\r\nc=IN IP4 34.203.254.9\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=rtcp:19452 IN IP4 34.203.254.9\r\na=rtpmap:111 opus/48000/2\r\na=rtpmap:0 PCMU/8000\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=candidate:2 1 UDP 2013266430 34.203.254.9 19452 typ host\r\na=candidate:2 2 UDP 2013266429 34.203.254.9 15269 typ host\r\na=rtcp-mux\r\na=setup:active\r\na=mid:audio\r\na=recvonly\r\na=ice-ufrag:N9Cj\r\na=ice-pwd:+d5ChhWamol/bN4OTdIVGK\r\na=fingerprint:sha-256 3F:F8:B5:EC:9A:DA:36:40:4D:28:21:42:44:86:D2:E5:F1:3E:E5:8E:9F:5C:F1:ED:3A:3D:57:C2:E7:2F:5F:14\r\nm=video 19452 UDP/TLS/RTP/SAVPF 100 96\r\nc=IN IP4 34.203.254.9\r\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=rtcp:19452 IN IP4 34.203.254.9\r\na=rtpmap:100 H264/90000\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=candidate:2 1 UDP 2013266430 34.203.254.9 19452 typ host\r\na=candidate:2 2 UDP 2013266429 34.203.254.9 15269 typ host\r\na=rtcp-mux\r\na=setup:active\r\na=mid:video\r\na=recvonly\r\na=ice-ufrag:N9Cj\r\na=ice-pwd:+d5ChhWamol/bN4OTdIVGK\r\na=fingerprint:sha-256 3F:F8:B5:EC:9A:DA:36:40:4D:28:21:42:44:86:D2:E5:F1:3E:E5:8E:9F:5C:F1:ED:3A:3D:57:C2:E7:2F:5F:14\r\n","revision":1}}],"sid":"RM02dd50732488da0845337a6ce5a2ea68","name":"00662AAD-1F9F-4141-8613-DE4C8CDE3DD9","participant":{"sid":"PAf11e9f57ffd811bbe48b5b27982522f6","identity":"107479","tracks":[{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}],"revision":1,"state":"connected"},"participants":[],"recording":{"enabled":false,"revision":1},"subscribed":{"revision":0,"tracks":[]},"published":{"revision":1,"tracks":[{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}]},"session":"bbbe76a8857a4764ffade38560657fcf02dd50732488da0845337a6ce5a2ea68f11e9f57ffd811bbe48b5b27982522f64707683ac934667245dd6934abf07bbf"}
2019-05-17 14:17:35.580018+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Process INVITE response with code 200
2019-05-17 14:17:35.580180+0200 Squad[652:129238] INFO:TwilioVideo:[Core]:SipCall::updateContact set host to ec2-34-203-250-196.compute-1.amazonaws.com
2019-05-17 14:17:35.580421+0200 Squad[652:129238] INFO:TwilioVideo:[Core]:SipSignalingStackImpl::UpdateHost
2019-05-17 14:17:35.580729+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Sending outgoing SIP message
ACK sip:172.18.52.17:5060 SIP/2.0

Via: SIP/2.0/TLS 127.0.0.1;branch=z9hG4bK-524287-1---60d9cb6aac9573c4;rport

Max-Forwards: 70

Route: <sip:34.203.250.196:443;r2=on;transport=tls;ftag=209e23f5;lr>

Route: <sip:172.18.3.179:5060;r2=on;transport=udp;ftag=209e23f5;lr>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 1 ACK

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, UPDATE, NOTIFY

Supported: timer, outbound, path, gruu, room-signaling

User-Agent: TwilioVideo SDK

Content-Length: 0
2019-05-17 14:17:35.581392+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::SIP: SipMessage::getContents: got content type (application/room-signaling+json) that is not known, returning as opaque application/octet-stream
2019-05-17 14:17:35.583408+0200 Squad[652:129238] WARN:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Can't find matching transport [ V4 127.0.0.1:0 TLS target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:35.593483+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:AppleReachability::onConnectionEstablished, socket_ipv6 = -1, socket_ipv4 = 60
2019-05-17 14:17:35.594634+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:AppleReachability started listening on address pair on 60 socket
2019-05-17 14:17:35.594723+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Canceling reconnect retry timer.
2019-05-17 14:17:35.594811+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:onAccepted
2019-05-17 14:17:35.594883+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl: State transition successful: kConnecting -> kConnected
Connected to room 00662AAD-1F9F-4141-8613-DE4C8CDE3DD9 as Optional("107479")
2019-05-17 14:17:35.606046+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:PeerConnection state: Waiting -> Updating
2019-05-17 14:17:35.606129+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Process remote answer at revision 1.
2019-05-17 14:17:35.606178+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Process remote sdp for: 6CE08380ad3F6FBdDD888aBB1f765D92 revision is: 1.
2019-05-17 14:17:35.615064+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Applying local description to: 6CE08380ad3F6FBdDD888aBB1f765D92 rev: 1
2019-05-17 14:17:35.634785+0200 Squad[652:128556] DEBUG:TwilioVideo:[Core]: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
2019-05-17 14:17:35.634851+0200 Squad[652:128556] DEBUG:TwilioVideo:[Core]: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
2019-05-17 14:17:35.634882+0200 Squad[652:128556] DEBUG:TwilioVideo:[Core]:Network Name: lo0, Cost: 0, Type : Loopback, Preference : 125, Active : 1, id: 4, prefix : ::1 and key : lo0%::1/128
2019-05-17 14:17:35.634912+0200 Squad[652:128556] DEBUG:TwilioVideo:[Core]: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
2019-05-17 14:17:35.634939+0200 Squad[652:128556] DEBUG:TwilioVideo:[Core]:New preferred network reported by manager: key: en0%192.168.1.0/24, type: Wifi, cost: 10, id: 1
2019-05-17 14:17:35.640417+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Sent a track update message
2019-05-17 14:17:35.640488+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:onSetSessionLocalDescription: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.640527+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Applying remote description to: 6CE08380ad3F6FBdDD888aBB1f765D92 rev: 1
2019-05-17 14:17:35.640703+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Sending outgoing SIP message
INFO sip:172.18.52.17:5060 SIP/2.0

Via: SIP/2.0/TLS 127.0.0.1;branch=z9hG4bK-524287-1---d481e2e1dce205ef;rport

Max-Forwards: 70

Route: <sip:34.203.250.196:443;r2=on;transport=tls;ftag=209e23f5;lr>

Route: <sip:172.18.3.179:5060;r2=on;transport=udp;ftag=209e23f5;lr>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 2 INFO

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, UPDATE, NOTIFY

Content-Type: application/room-signaling+json

Supported: timer, outbound, path, gruu, room-signaling

User-Agent: TwilioVideo SDK

Event: room-signaling

Info-Package: room-signaling

Content-Length: 422

{"participant":{"revision":2,"tracks":[{"enabled":true,"id":"8EEf30925cbB985EB2cfBFec4D2daFf6","kind":"data","name":"messenger","priority":"medium"},{"enabled":true,"id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","kind":"audio","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","priority":"medium"},{"enabled":true,"id":"c825Dd591422a0f43aFe5BFf58FCe0b5","kind":"video","name":"camera","priority":"medium"}]},"type":"update","version":2}
2019-05-17 14:17:35.643039+0200 Squad[652:129238] WARN:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Can't find matching transport [ V4 127.0.0.1:0 TLS target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:35.645231+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Done processing onSetSessionLocalDescription: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.645323+0200 Squad[652:128540] INFO:TwilioVideo:[Core]:Ice Gathering...
2019-05-17 14:17:35.645357+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:ICE connection state transitioned from New -> Checking
2019-05-17 14:17:35.645408+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:PeerConnection 6CE08380ad3F6FBdDD888aBB1f765D92 Ice connection state transitioned from New -> Checking
2019-05-17 14:17:35.645434+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Room Media state changed to Checking
2019-05-17 14:17:35.645484+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:onSetSessionRemoteDescription: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.645705+0200 Squad[652:128540] INFO:TwilioVideo:[Core]:Queue ICE candidate revision: 1 for PeerConnection: 6CE08380ad3F6FBdDD888aBB1f765D92.
2019-05-17 14:17:35.645739+0200 Squad[652:128540] INFO:TwilioVideo:[Core]:Publish ICE candidate revision: 1 for PeerConnection: 6CE08380ad3F6FBdDD888aBB1f765D92.
2019-05-17 14:17:35.646114+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Sending outgoing SIP message
INFO sip:172.18.52.17:5060 SIP/2.0

Via: SIP/2.0/TLS 127.0.0.1;branch=z9hG4bK-524287-1---15b58fdd9185c213;rport

Max-Forwards: 70

Route: <sip:34.203.250.196:443;r2=on;transport=tls;ftag=209e23f5;lr>

Route: <sip:172.18.3.179:5060;r2=on;transport=udp;ftag=209e23f5;lr>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 3 INFO

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, UPDATE, NOTIFY

Content-Type: application/room-signaling+json

Supported: timer, outbound, path, gruu, room-signaling

User-Agent: TwilioVideo SDK

Event: room-signaling

Info-Package: room-signaling

Content-Length: 553

{"participant":{"revision":2,"tracks":[{"enabled":true,"id":"8EEf30925cbB985EB2cfBFec4D2daFf6","kind":"data","name":"messenger","priority":"medium"},{"enabled":true,"id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","kind":"audio","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","priority":"medium"},{"enabled":true,"id":"c825Dd591422a0f43aFe5BFf58FCe0b5","kind":"video","name":"camera","priority":"medium"}]},"peer_connections":[{"ice":{"candidates":[],"complete":true,"revision":1,"ufrag":"Uckh"},"id":"6CE08380ad3F6FBdDD888aBB1f765D92"}],"type":"update","version":2}
2019-05-17 14:17:35.646190+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Create local offer: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.647146+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Including track id: c825Dd591422a0f43aFe5BFf58FCe0b5 for simulcast.
2019-05-17 14:17:35.647833+0200 Squad[652:129238] WARN:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Can't find matching transport [ V4 127.0.0.1:0 TLS target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:35.648675+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:onCreateSessionLocalDescription 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.649091+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:SDP Utils: New SSRC 4203016772 replaced with Old SSRC 4203016772
2019-05-17 14:17:35.649564+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:SDP Utils: New SSRC 1033393581 replaced with Old SSRC 1033393581
2019-05-17 14:17:35.649715+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:SDP Utils: New SSRC 1680391674 replaced with Old SSRC 1680391674
2019-05-17 14:17:35.649864+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:SDP Utils: New SSRC group 1033393581 1680391674 --- Original SSRC group 1033393581 1680391674
2019-05-17 14:17:35.650816+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Updating -> Open
2019-05-17 14:17:35.650960+0200 Squad[652:128540] INFO:TwilioVideo:[Core]:Local SDP is ready
2019-05-17 14:17:35.651005+0200 Squad[652:128540] INFO:TwilioVideo:[Core]:Queue Description: 2 for PeerConnection: 6CE08380ad3F6FBdDD888aBB1f765D92.
2019-05-17 14:17:35.651787+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Sending outgoing SIP message
INFO sip:172.18.52.17:5060 SIP/2.0

Via: SIP/2.0/TLS 127.0.0.1;branch=z9hG4bK-524287-1---33a100876533baaa;rport

Max-Forwards: 70

Route: <sip:34.203.250.196:443;r2=on;transport=tls;ftag=209e23f5;lr>

Route: <sip:172.18.3.179:5060;r2=on;transport=udp;ftag=209e23f5;lr>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 4 INFO

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, UPDATE, NOTIFY

Content-Type: application/room-signaling+json

Supported: timer, outbound, path, gruu, room-signaling

User-Agent: TwilioVideo SDK

Event: room-signaling

Info-Package: room-signaling

Content-Length: 4394

{"participant":{"revision":2,"tracks":[{"enabled":true,"id":"8EEf30925cbB985EB2cfBFec4D2daFf6","kind":"data","name":"messenger","priority":"medium"},{"enabled":true,"id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","kind":"audio","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","priority":"medium"},{"enabled":true,"id":"c825Dd591422a0f43aFe5BFf58FCe0b5","kind":"video","name":"camera","priority":"medium"}]},"peer_connections":[{"description":{"revision":2,"sdp":"v=0\r\no=- 6686746332114638318 3 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video data\r\na=msid-semantic: WMS aDBf6B06A5e93DCC1ADBFA76E467Fd93\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:Uckh\r\na=ice-pwd:AnDGWi3I0gp8mcnH8mixqKf+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 CF:5D:F7:EF:9A:E1:BB:10:EE:AD:6B:D2:5C:19:62:79:B0:3F:62:48:4F:86:59:20:58:D1:1F:17:4F:60:81:A0\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:4203016772 cname:BJESmOLlPu4a0W92\r\na=ssrc:4203016772 msid:aDBf6B06A5e93DCC1ADBFA76E467Fd93 aaE1E3E4ee74639aAA4dA07CAAE8Df13\r\na=ssrc:4203016772 mslabel:aDBf6B06A5e93DCC1ADBFA76E467Fd93\r\na=ssrc:4203016772 label:aaE1E3E4ee74639aAA4dA07CAAE8Df13\r\nm=video 9 UDP/TLS/RTP/SAVPF 100 96 97 98 99 101 102 125 127\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:Uckh\r\na=ice-pwd:AnDGWi3I0gp8mcnH8mixqKf+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 CF:5D:F7:EF:9A:E1:BB:10:EE:AD:6B:D2:5C:19:62:79:B0:3F:62:48:4F:86:59:20:58:D1:1F:17:4F:60:81:A0\r\na=setup:actpass\r\na=mid:video\r\na=extmap:2 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:4 urn:3gpp:video-orientation\r\na=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=sendrecv\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:100 H264/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 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\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=rtpmap:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:102 red/90000\r\na=rtpmap:125 rtx/90000\r\na=fmtp:125 apt=102\r\na=rtpmap:127 ulpfec/90000\r\na=ssrc-group:FID 1033393581 1680391674\r\na=ssrc:1033393581 cname:BJESmOLlPu4a0W92\r\na=ssrc:1033393581 msid:aDBf6B06A5e93DCC1ADBFA76E467Fd93 c825Dd591422a0f43aFe5BFf58FCe0b5\r\na=ssrc:1033393581 mslabel:aDBf6B06A5e93DCC1ADBFA76E467Fd93\r\na=ssrc:1033393581 label:c825Dd591422a0f43aFe5BFf58FCe0b5\r\na=ssrc:1680391674 cname:BJESmOLlPu4a0W92\r\na=ssrc:1680391674 msid:aDBf6B06A5e93DCC1ADBFA76E467Fd93 c825Dd591422a0f43aFe5BFf58FCe0b5\r\na=ssrc:1680391674 mslabel:aDBf6B06A5e93DCC1ADBFA76E467Fd93\r\na=ssrc:1680391674 label:c825Dd591422a0f43aFe5BFf58FCe0b5\r\nm=application 9 DTLS/SCTP 5000\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:Uckh\r\na=ice-pwd:AnDGWi3I0gp8mcnH8mixqKf+\r\na=ice-options:trickle\r\na=fingerprint:sha-256 CF:5D:F7:EF:9A:E1:BB:10:EE:AD:6B:D2:5C:19:62:79:B0:3F:62:48:4F:86:59:20:58:D1:1F:17:4F:60:81:A0\r\na=setup:actpass\r\na=mid:data\r\na=sctpmap:5000 webrtc-datachannel 1024\r\n","type":"offer"},"id":"6CE08380ad3F6FBdDD888aBB1f765D92"}],"type":"update","version":2}
2019-05-17 14:17:35.659797+0200 Squad[652:129238] WARN:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Can't find matching transport [ V4 127.0.0.1:0 TLS target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:35.772955+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
SIP/2.0 200 OK

Via: SIP/2.0/TLS 127.0.0.1;received=88.212.40.93;branch=z9hG4bK-524287-1---d481e2e1dce205ef;rport=51601

Contact: <sip:172.18.52.17:5060>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 2 INFO

Server: Twilio

Supported: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 0
2019-05-17 14:17:35.773241+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Process INFO response with code 200
2019-05-17 14:17:35.773341+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
SIP/2.0 200 OK

Via: SIP/2.0/TLS 127.0.0.1;received=88.212.40.93;branch=z9hG4bK-524287-1---15b58fdd9185c213;rport=51601

Contact: <sip:172.18.52.17:5060>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 3 INFO

Server: Twilio

Supported: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 0
2019-05-17 14:17:35.774258+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Process INFO response with code 200
2019-05-17 14:17:35.777767+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
INFO sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@88.212.40.93:51601;transport=tls;ob SIP/2.0

Via: SIP/2.0/TLS 34.203.250.196:443;branch=z9hG4bK22e5.e84dcde7.0

Via: SIP/2.0/UDP 172.18.52.17:5060;branch=z9hG4bK2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97_6772d868_265-3365026380927853803

Max-Forwards: 68

To: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

From: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 1 INFO

Content-Type: application/room-signaling+json

Supported: room-signaling

User-Agent: Twilio Gateway

Recv-Info: room-signaling

Info-Package: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 1228

{"version":2,"type":"update","sid":"RM02dd50732488da0845337a6ce5a2ea68","name":"00662AAD-1F9F-4141-8613-DE4C8CDE3DD9","participant":{"sid":"PAf11e9f57ffd811bbe48b5b27982522f6","identity":"107479","tracks":[{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}],"revision":2,"state":"connected"},"participants":[],"recording":{"enabled":false,"revision":1},"subscribed":{"revision":0,"tracks":[]},"published":{"revision":2,"tracks":[{"kind":"data","priority":"medium","id":"8EEf30925cbB985EB2cfBFec4D2daFf6","enabled":true,"name":"messenger","state":"created"},{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}]}}
2019-05-17 14:17:35.778521+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::SIP: SipMessage::getContents: got content type (application/room-signaling+json) that is not known, returning as opaque application/octet-stream
2019-05-17 14:17:35.786544+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
SIP/2.0 200 OK

Via: SIP/2.0/TLS 127.0.0.1;received=88.212.40.93;branch=z9hG4bK-524287-1---33a100876533baaa;rport=51601

Contact: <sip:172.18.52.17:5060>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 4 INFO

Server: Twilio

Supported: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 0
2019-05-17 14:17:35.786625+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Process INFO response with code 200
2019-05-17 14:17:35.796378+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
INFO sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@88.212.40.93:51601;transport=tls;ob SIP/2.0

Via: SIP/2.0/TLS 34.203.250.196:443;branch=z9hG4bKf1e5.31aa0341.0

Via: SIP/2.0/UDP 172.18.52.17:5060;branch=z9hG4bK2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97_6772d868_266-13314689149124506107

Max-Forwards: 68

To: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

From: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 2 INFO

Content-Type: application/room-signaling+json

Supported: room-signaling

User-Agent: Twilio Gateway

Recv-Info: room-signaling

Info-Package: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 3402

{"version":2,"type":"update","peer_connections":[{"id":"6CE08380ad3F6FBdDD888aBB1f765D92","description":{"type":"answer","sdp":"v=0\r\no=- 3767084255 3767084256 IN IP4 0.0.0.0\r\ns=VM6fbe6c595e7cf6428edb5e88f31b1c44\r\nc=IN IP4 0.0.0.0\r\nt=0 0\r\na=ice-lite\r\na=msid-semantic: WMS *\r\na=group:BUNDLE audio video data\r\nm=audio 1 UDP/TLS/RTP/SAVPF 111 0\r\nc=IN IP4 0.0.0.0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=rtpmap:111 opus/48000/2\r\na=rtpmap:0 PCMU/8000\r\na=fmtp:111 minptime=10;useinbandfec=1\r\na=candidate:2 1 UDP 2013266430 34.203.254.9 19452 typ host\r\na=candidate:2 2 UDP 2013266429 34.203.254.9 15269 typ host\r\na=rtcp-mux\r\na=setup:active\r\na=mid:audio\r\na=recvonly\r\na=ice-ufrag:N9Cj\r\na=ice-pwd:+d5ChhWamol/bN4OTdIVGK\r\na=fingerprint:sha-256 3F:F8:B5:EC:9A:DA:36:40:4D:28:21:42:44:86:D2:E5:F1:3E:E5:8E:9F:5C:F1:ED:3A:3D:57:C2:E7:2F:5F:14\r\nm=video 1 UDP/TLS/RTP/SAVPF 100 96\r\nc=IN IP4 0.0.0.0\r\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=rtpmap:100 H264/90000\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=candidate:2 1 UDP 2013266430 34.203.254.9 19452 typ host\r\na=candidate:2 2 UDP 2013266429 34.203.254.9 15269 typ host\r\na=rtcp-mux\r\na=setup:active\r\na=mid:video\r\na=recvonly\r\na=ice-ufrag:N9Cj\r\na=ice-pwd:+d5ChhWamol/bN4OTdIVGK\r\na=fingerprint:sha-256 3F:F8:B5:EC:9A:DA:36:40:4D:28:21:42:44:86:D2:E5:F1:3E:E5:8E:9F:5C:F1:ED:3A:3D:57:C2:E7:2F:5F:14\r\nm=application 1 DTLS/SCTP 5000\r\nc=IN IP4 0.0.0.0\r\na=sctpmap:5000 webrtc-datachannel 1024\r\na=candidate:2 1 UDP 2013266430 34.203.254.9 19452 typ host\r\na=candidate:2 2 UDP 2013266429 34.203.254.9 15269 typ host\r\na=mid:data\r\na=ice-ufrag:N9Cj\r\na=ice-pwd:+d5ChhWamol/bN4OTdIVGK\r\na=fingerprint:sha-256 3F:F8:B5:EC:9A:DA:36:40:4D:28:21:42:44:86:D2:E5:F1:3E:E5:8E:9F:5C:F1:ED:3A:3D:57:C2:E7:2F:5F:14\r\n","revision":2}}],"sid":"RM02dd50732488da0845337a6ce5a2ea68","name":"00662AAD-1F9F-4141-8613-DE4C8CDE3DD9","participant":{"sid":"PAf11e9f57ffd811bbe48b5b27982522f6","identity":"107479","tracks":[{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}],"revision":2,"state":"connected"},"participants":[],"recording":{"enabled":false,"revision":1},"subscribed":{"revision":0,"tracks":[]},"published":{"revision":2,"tracks":[{"kind":"data","priority":"medium","id":"8EEf30925cbB985EB2cfBFec4D2daFf6","enabled":true,"name":"messenger","state":"created"},{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}]}}
2019-05-17 14:17:35.797137+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::SIP: SipMessage::getContents: got content type (application/room-signaling+json) that is not known, returning as opaque application/octet-stream
2019-05-17 14:17:35.797895+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Open -> Updating. Process an event
2019-05-17 14:17:35.798006+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Process remote answer at revision 2.
2019-05-17 14:17:35.798036+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Process remote sdp for: 6CE08380ad3F6FBdDD888aBB1f765D92 revision is: 2.
2019-05-17 14:17:35.799083+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Applying local description to: 6CE08380ad3F6FBdDD888aBB1f765D92 rev: 2
2019-05-17 14:17:35.802189+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:onSetSessionLocalDescription: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.802366+0200 Squad[652:128554] DEBUG:TwilioVideo:[Core]:Applying remote description to: 6CE08380ad3F6FBdDD888aBB1f765D92 rev: 2
2019-05-17 14:17:35.804269+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Done processing onSetSessionLocalDescription: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.804368+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:onSetSessionRemoteDescription: 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:35.804523+0200 Squad[652:128540] DEBUG:TwilioVideo:[Core]:Updating -> Open
2019-05-17 14:17:36.321338+0200 Squad[652:128525] INFO:TwilioVideo:[Core]:Ice Gathering Complete.
2019-05-17 14:17:38.925498+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:ICE connection state transitioned from Checking -> Connected
2019-05-17 14:17:38.925627+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:PeerConnection 6CE08380ad3F6FBdDD888aBB1f765D92 Ice connection state transitioned from Checking -> Connected
2019-05-17 14:17:38.925702+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Room Media state changed to Connected
2019-05-17 14:17:38.925769+0200 Squad[652:128534] INFO:TwilioVideo:[Core]:Media is connected
2019-05-17 14:17:38.926482+0200 Squad[652:129265] INFO:TwilioVideo:[Core]:Connecting to sdkgw.us1.twilio.com:443.
2019-05-17 14:17:38.970149+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:ICE connection state transitioned from Connected -> Completed
2019-05-17 14:17:38.970284+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:PeerConnection 6CE08380ad3F6FBdDD888aBB1f765D92 Ice connection state transitioned from Connected -> Completed
2019-05-17 14:17:38.970425+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Room Media state changed to Completed
2019-05-17 14:17:39.076505+0200 Squad[652:128555] DEBUG:TwilioVideo:[Platform]:TVIRoom received audioSessionActivated.
2019-05-17 14:17:39.376430+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
INFO sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@88.212.40.93:51601;transport=tls;ob SIP/2.0

Via: SIP/2.0/TLS 34.203.250.196:443;branch=z9hG4bK02e5.530d6a21.0

Via: SIP/2.0/UDP 172.18.52.17:5060;branch=z9hG4bK2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97_6772d868_266-13319253741625158733

Max-Forwards: 68

To: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

From: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 3 INFO

Content-Type: application/room-signaling+json

Supported: room-signaling

User-Agent: Twilio Gateway

Recv-Info: room-signaling

Info-Package: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 1438

{"version":2,"type":"update","sid":"RM02dd50732488da0845337a6ce5a2ea68","name":"00662AAD-1F9F-4141-8613-DE4C8CDE3DD9","participant":{"sid":"PAf11e9f57ffd811bbe48b5b27982522f6","identity":"107479","tracks":[{"kind":"data","priority":"medium","id":"8EEf30925cbB985EB2cfBFec4D2daFf6","enabled":true,"sid":"MT59aced925df6ecacccce78a5caee43a2","name":"messenger","state":"ready"},{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}],"revision":2,"state":"connected"},"participants":[],"recording":{"enabled":false,"revision":1},"subscribed":{"revision":0,"tracks":[]},"published":{"revision":3,"tracks":[{"kind":"data","priority":"medium","id":"8EEf30925cbB985EB2cfBFec4D2daFf6","enabled":true,"sid":"MT59aced925df6ecacccce78a5caee43a2","name":"messenger","state":"ready"},{"kind":"audio","priority":"medium","id":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","enabled":true,"sid":"MTc86ac766a45bcc9620c504cfed0bb1f6","name":"aaE1E3E4ee74639aAA4dA07CAAE8Df13","state":"ready"},{"kind":"video","priority":"medium","id":"c825Dd591422a0f43aFe5BFf58FCe0b5","enabled":true,"sid":"MTead35e536320b86355d24d2b3ade4a18","name":"camera","state":"ready"}]}}
2019-05-17 14:17:39.377261+0200 Squad[652:129238] INFO:TwilioVideo:[Signaling]:RESIP::SIP: SipMessage::getContents: got content type (application/room-signaling+json) that is not known, returning as opaque application/octet-stream
2019-05-17 14:17:39.378027+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:Dispatching onDataTrackPublished() for track sid: MT59aced925df6ecacccce78a5caee43a2
2019-05-17 14:17:39.496188+0200 Squad[652:129265] INFO:TwilioVideo:[Core]:Connected to sdkgw.us1.twilio.com:443.
2019-05-17 14:17:39.978014+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Media for PeerConnection 6CE08380ad3F6FBdDD888aBB1f765D92 transitioned from MediaInactive -> MediaActive
2019-05-17 14:17:39.978258+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:PeerConnection 6CE08380ad3F6FBdDD888aBB1f765D92 Media activity state transitioned from MediaInactive -> MediaActive
2019-05-17 14:17:39.978341+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Media Activity state changed to MediaActive
2019-05-17 14:17:39.978455+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:At least one media track is active in Room.
2019-05-17 14:17:41.905360+0200 Squad[652:128525] Callkit: EndCallAction transaction request successful
2019-05-17 14:17:41.945197+0200 Squad[652:128475] -->>>>>>> Callkit: provider:performEndCallAction:
2019-05-17 14:17:42.001297+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl: State transition successful: kConnected -> kDisconnecting
2019-05-17 14:17:42.002012+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Disconnecting from RM02dd50732488da0845337a6ce5a2ea68.
Callkit: provider:didDeactivateAudioSession:
2019-05-17 14:17:42.628246+0200 Squad[652:128555] DEBUG:TwilioVideo:[Platform]:TVIRoom received audioSessionDeactivated.
2019-05-17 14:17:42.731016+0200 Squad[652:128554] INFO:TwilioVideo:[Core]:Closed Webrtc PeerConnection 6CE08380ad3F6FBdDD888aBB1f765D92
2019-05-17 14:17:42.733235+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Closing DataChannels for peerconnection: -2140804752
2019-05-17 14:17:42.733400+0200 Squad[652:128534] INFO:TwilioVideo:[Core]:PeerConnectionSignaling with id 6CE08380ad3F6FBdDD888aBB1f765D92 destroyed
2019-05-17 14:17:42.733472+0200 Squad[652:128534] DEBUG:TwilioVideo:[Core]:Closed all Peer Connections
2019-05-17 14:17:42.733803+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Sending outgoing SIP message
BYE sip:172.18.52.17:5060 SIP/2.0

Via: SIP/2.0/TLS 127.0.0.1;branch=z9hG4bK-524287-1---cbd587dbe81b29b1;rport

Max-Forwards: 70

Route: <sip:34.203.250.196:443;r2=on;transport=tls;ftag=209e23f5;lr>

Route: <sip:172.18.3.179:5060;r2=on;transport=udp;ftag=209e23f5;lr>

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea"<sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 5 BYE

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, UPDATE, NOTIFY

Content-Type: application/room-signaling+json

Supported: timer, outbound, path, gruu, room-signaling

User-Agent: TwilioVideo SDK

Content-Length: 34

{"type":"disconnect","version":2}
2019-05-17 14:17:42.733953+0200 Squad[652:129238] WARN:TwilioVideo:[Signaling]:RESIP::TRANSPORT: Can't find matching transport [ V4 127.0.0.1:0 TLS target domain=unspecified mFlowKey=0 ]
2019-05-17 14:17:42.862607+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:
Receiving incoming SIP message from infra
SIP/2.0 200 OK

Via: SIP/2.0/TLS 127.0.0.1;received=88.212.40.93;branch=z9hG4bK-524287-1---cbd587dbe81b29b1;rport=51601

To: <sip:orchestrator@mobile-endpoint.twilio.com>;tag=62421807_6772d868_2a3ada8a-bd8c-47a0-b72e-d3fbecfa7d97

From: "3d2d50B0cd8E1CbffA14dcd1f6684Bea" <sip:3d2d50B0cd8E1CbffA14dcd1f6684Bea@mobile-endpoint.twilio.com>;tag=209e23f5

Call-ID: fJa-Yab3gnire_teymHuuQ..

CSeq: 5 BYE

Content-Type: application/room-signaling+json

Server: Twilio

Supported: room-signaling

X-Twilio-CallSid: CA4707683ac934667245dd6934abf07bbf

X-Twilio-LegInfo: external

X-Twilio-TlsVerify: true

Content-Length: 165

{"version":1,"type":"disconnected","sid":"RM02dd50732488da0845337a6ce5a2ea68","name":"00662AAD-1F9F-4141-8613-DE4C8CDE3DD9","participants":[],"status":"in-progress"}
2019-05-17 14:17:42.862706+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Process BYE response with code 200
2019-05-17 14:17:42.862777+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Disconnected from Transport.
2019-05-17 14:17:42.862927+0200 Squad[652:129279] DEBUG:TwilioVideo:[Core]:AppleReachability::~AppleReachability()
2019-05-17 14:17:42.863094+0200 Squad[652:129279] DEBUG:TwilioVideo:[Core]:onDisconnected
2019-05-17 14:17:42.863138+0200 Squad[652:129279] DEBUG:TwilioVideo:[Core]:Canceling disconnect timer.
2019-05-17 14:17:42.863515+0200 Squad[652:129279] INFO:TwilioVideo:[Core]:Shutdown and join the signaling stack's thread.
2019-05-17 14:17:42.863608+0200 Squad[652:129238] DEBUG:TwilioVideo:[Core]:Shutting down StackThread runloop.
2019-05-17 14:17:42.863838+0200 Squad[652:129279] WARN:TwilioVideo:[Signaling]:RESIP::TRANSACTION: On shutdown, there are Client TransactionStates remaining!
2019-05-17 14:17:42.864917+0200 Squad[652:129279] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl: State transition successful: kDisconnecting -> kDisconnected
Disconnected from room 00662AAD-1F9F-4141-8613-DE4C8CDE3DD9, error = nil
2019-05-17 14:17:42.874701+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl::~RoomSignalingImpl()
2019-05-17 14:17:42.874770+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:RoomSignalingImpl: State Transition Failure: kDisconnected -> kDisconnecting
2019-05-17 14:17:42.874809+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:virtual twilio::insights::InsightsPublisher::~InsightsPublisher()
2019-05-17 14:17:42.875447+0200 Squad[652:128475] DEBUG:TwilioVideo:[Core]:Closing DataChannels on an unsubscribe
2019-05-17 14:18:34.304829+0200 Squad[652:128525] TIC Read Status [8:0x283dee040]: 1:57
2019-05-17 14:18:34.304984+0200 Squad[652:128525] TIC Read Status [8:0x283dee040]: 1:57
2019-05-17 14:18:34.305234+0200 Squad[652:128525] TIC Read Status [8:0x283dee040]: 1:57
2019-05-17 14:18:34.308176+0200 Squad[652:128525] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C8.1:2][0x116bd3860] get output frames failed, state 8196
2019-05-17 14:18:34.308700+0200 Squad[652:128525] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C8.1:2][0x116bd3860] get output frames failed, state 8196
2019-05-17 14:18:34.311286+0200 Squad[652:128525] TIC Read Status [8:0x0]: 1:57
2019-05-17 14:18:34.311422+0200 Squad[652:128525] TIC Read Status [8:0x0]: 1:57
2019-05-17 14:18:34.311482+0200 Squad[652:128525] TIC Read Status [8:0x0]: 1:57
2019-05-17 14:18:34.311530+0200 Squad[652:128525] TIC Read Status [8:0x0]: 1:57
2019-05-17 14:18:49.735590+0200 Squad[652:128540] TIC Read Status [7:0x283de4d80]: 1:57
2019-05-17 14:18:49.735672+0200 Squad[652:128540] TIC Read Status [7:0x283de4d80]: 1:57
2019-05-17 14:18:49.735697+0200 Squad[652:128540] TIC Read Status [7:0x283de4d80]: 1:57
2019-05-17 14:18:49.737024+0200 Squad[652:128540] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C7.1:2][0x116c9ea50] get output frames failed, state 8196
2019-05-17 14:18:49.737139+0200 Squad[652:128540] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C7.1:2][0x116c9ea50] get output frames failed, state 8196
2019-05-17 14:18:49.737639+0200 Squad[652:128540] TIC Read Status [7:0x0]: 1:57
2019-05-17 14:18:49.737672+0200 Squad[652:128540] TIC Read Status [7:0x0]: 1:57
2019-05-17 14:18:49.737693+0200 Squad[652:128540] TIC Read Status [7:0x0]: 1:57
2019-05-17 14:18:49.737713+0200 Squad[652:128540] TIC Read Status [7:0x0]: 1:57
2019-05-17 14:21:35.176940+0200 Squad[652:128540] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C3.1:2][0x10e45f210] get output frames failed, state 8196
2019-05-17 14:21:35.177434+0200 Squad[652:128540] [BoringSSL] nw_protocol_boringssl_get_output_frames(1301) [C3.1:2][0x10e45f210] get output frames failed, state 8196
2019-05-17 14:21:35.178490+0200 Squad[652:128540] TIC Read Status [3:0x0]: 1:57
2019-05-17 14:21:35.178588+0200 Squad[652:128540] TIC Read Status [3:0x0]: 1:57

Versions

Video iOS SDK

TwilioVideo 2.6.1 via cocoa pods

Xcode

10.2.1

iOS Version

12.3

iOS Device

iPhone SE, iPhone 6S

ceaglest commented 5 years ago

Hi @MilanNosal,

Sorry for the late response to your question.

It looks like the ICE Servers that you provided were used by the SDK ("overrode"). After reviewing RM02dd50732488da0845337a6ce5a2ea68 from your logs, and I can see a couple of items:

  1. It is a Group Room.
  2. From what I can tell, the Client was able to establish a relayed connection with the Media Server (from 104.248.xxx.xxx, a Digital Ocean IP address).

If you'd like to confirm locally you can use Room.getStats() to inspect the active ice candidate pair after providing your own TURN servers.

We are trying to use ICE server when connecting to the room.

Unless UDP traffic on ports 10,000 - 60,000 is blocked it should be pretty easy to connect to our publicly available Media Servers. Also, Twilio provides you STUN/TURN servers at no additional charge by default if you would like to use them.

Best, Chris

ceaglest commented 5 years ago

Hi,

I hope we were able to answer your question. In general, I wouldn't recommend overriding TURN servers unless you have a very specific reason to do so (this was not clear in your original comment). Twilio provides globally deployed TURN Servers, and they are included with both Peer-to-Peer and Group Rooms by default. Please let us know if you have any more questions.

Best, Chris