search

twilio / video-quickstart-ios

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

Unable to see video sent from iOS device on other platforms #623

Closed zcjhnsn closed 2 years ago

zcjhnsn commented 2 years ago

Description

It appears the local video track is not being sent to the room. Users on web applications are unable to see video from a user on the iPad.

Steps to Reproduce

  1. Create room from a web user
  2. Join room from an iPad
  3. Share video from iPad

Code

Expected Behavior

Actual Behavior

Reproduces How Often

100%

Logs

scene(_:willConnectTo:options:)
sceneWillEnterForeground(_:)
sceneDidBecomeActive(_:)
2021-08-13 16:23:53.045862-0400 VideoQuickStart[772:205852] Metal API Validation Enabled
2021-08-13 16:23:53.132257-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](0x104a73880): API Call create
2021-08-13 16:23:53.133651-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](0x104a73880): API Call create
2021-08-13 16:23:53.133732-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](0x104a73880): API Call create
2021-08-13 16:23:53.133776-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](0x104a73880): Creating peer connection signaling thread ...
2021-08-13 16:23:53.133840-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](0x104a73880): Creating peer connection worker thread ...
2021-08-13 16:23:53.133893-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](0x104a73880): Creating peer connection networking thread ...
2021-08-13 16:23:53.134020-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](0x104a73880): Creating peer connection factory ...
2021-08-13 16:23:53.134057-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](0x104a73880): Creating task queue factory.
2021-08-13 16:23:53.139738-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](0x104a73880): Done creating peer connection factory.
2021-08-13 16:23:53.139815-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](0x104a73880): Done creating AudioMediaFactoryImpl.
2021-08-13 16:23:53.139956-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getSignalingThread
2021-08-13 16:23:53.139994-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getSignalingThread
2021-08-13 16:23:53.140028-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWorkerThread
2021-08-13 16:23:53.140080-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWorkerThread
2021-08-13 16:23:53.140153-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call createVideoTrack
2021-08-13 16:23:53.140276-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Creating a video track ...
2021-08-13 16:23:53.141281-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:23:53.141340-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:23:53.142234-0400 VideoQuickStart[772:205852] Video track created
2021-08-13 16:23:53.144627-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Start capturing with device: <AVCaptureFigVideoDevice: 0x109922a50 [Front Camera][com.apple.avfoundation.avcapturedevice.built-in_video:1]> format: <<TVIVideoFormat: 0x283bfd400> size: {640, 480}, fps: 30, format: 420f>.
2021-08-13 16:23:53.145856-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Prepare for capturing.
2021-08-13 16:23:53.146026-0400 VideoQuickStart[772:205852] INFO:Twilio:[Platform](Thread 0x0x109923b70): Starting capture pipeline ...
2021-08-13 16:23:53.149891-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Platform](0x16b753000): Adding device input: <AVCaptureDeviceInput: 0x283bff3c0 [Front Camera]>
2021-08-13 16:23:53.152139-0400 VideoQuickStart[772:206066] INFO:Twilio:[Platform](0x16b753000): Best device format was: <AVCaptureDeviceFormat: 0x2839d5dc0 'vide'/'420f'  640x 480, { 2- 30 fps}, HRSI:3088x2320, fov:54.201, max zoom:145.00 (upscales @4.82), ISO:23.0-2208.0, SS:0.000013-0.500000, supports wide color>
2021-08-13 16:23:53.152773-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
(
    "<NSLayoutConstraint:0x2818f2da0 UITextField:0x109910db0.lastBaseline == UILabel:0x10991a2f0.lastBaseline   (active)>",
    "<NSLayoutConstraint:0x2818f2ee0 V:[UILabel:0x10991a2f0]-(21)-[UIButton:0x1099108b0'Connect']   (active)>",
    "<NSLayoutConstraint:0x2818f2f30 V:[UITextField:0x109910db0]-(16)-[UIButton:0x1099108b0'Connect']   (active)>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x2818f2ee0 V:[UILabel:0x10991a2f0]-(21)-[UIButton:0x1099108b0'Connect']   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:23:53.154117-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Did move to window with size: {834, 1112}.
Metal content scale factor is now: 2.000
2021-08-13 16:23:53.584500-0400 VideoQuickStart[772:206066] INFO:Twilio:[Platform](0x16b753000): ... Finished starting capture.
2021-08-13 16:23:53.584776-0400 VideoQuickStart[772:206066] INFO:Twilio:[Platform](0x16b753000): AVCaptureSession started running
2021-08-13 16:23:53.601953-0400 VideoQuickStart[772:206064] DEBUG:Twilio:[Platform](0x16b63b000): Video device will start running: <AVCaptureFigVideoDevice: 0x109922a50 [Front Camera][com.apple.avfoundation.avcapturedevice.built-in_video:1]>.
2021-08-13 16:23:53.607626-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Preparing renderer for frame size: {640, 480}, view bounds: {{0, 0}, {120, 160}}
2021-08-13 16:23:53.607898-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Detected a pixel format change. Preparing the rendering pipeline. Old = none, New = 420f
2021-08-13 16:23:57.915047-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
    (Note: If you're seeing NSAutoresizingMaskLayoutConstraints that you don't understand, refer to the documentation for the UIView property translatesAutoresizingMaskIntoConstraints) 
(
    "<NSAutoresizingMaskLayoutConstraint:0x2818d0140 h=--& v=--& _UIButtonBarButton:0x1099619c0.height == 0   (active)>",
    "<NSLayoutConstraint:0x281893480 _UIUCBKBSelectionBackground:0x1099622e0.bottom == _UIButtonBarButton:0x1099619c0.bottom - 6   (active)>",
    "<NSLayoutConstraint:0x2818933e0 V:|-(6)-[_UIUCBKBSelectionBackground:0x1099622e0]   (active, names: '|':_UIButtonBarButton:0x1099619c0 )>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x281893480 _UIUCBKBSelectionBackground:0x1099622e0.bottom == _UIButtonBarButton:0x1099619c0.bottom - 6   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:23:57.915514-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
    (Note: If you're seeing NSAutoresizingMaskLayoutConstraints that you don't understand, refer to the documentation for the UIView property translatesAutoresizingMaskIntoConstraints) 
(
    "<NSAutoresizingMaskLayoutConstraint:0x2818fbc50 h=--& v=--& _UIButtonBarButton:0x10995feb0.height == 0   (active)>",
    "<NSLayoutConstraint:0x281892e40 V:|-(6)-[_UIUCBKBSelectionBackground:0x109960cc0]   (active, names: '|':_UIButtonBarButton:0x10995feb0 )>",
    "<NSLayoutConstraint:0x281892ee0 _UIUCBKBSelectionBackground:0x109960cc0.bottom == _UIButtonBarButton:0x10995feb0.bottom - 6   (active)>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x281892ee0 _UIUCBKBSelectionBackground:0x109960cc0.bottom == _UIButtonBarButton:0x10995feb0.bottom - 6   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:23:57.915920-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
    (Note: If you're seeing NSAutoresizingMaskLayoutConstraints that you don't understand, refer to the documentation for the UIView property translatesAutoresizingMaskIntoConstraints) 
(
    "<NSAutoresizingMaskLayoutConstraint:0x2818fbf70 h=--& v=--& _UIButtonBarButton:0x109961040.height == 0   (active)>",
    "<NSLayoutConstraint:0x281893110 V:|-(6)-[_UIUCBKBSelectionBackground:0x109961840]   (active, names: '|':_UIButtonBarButton:0x109961040 )>",
    "<NSLayoutConstraint:0x2818931b0 _UIUCBKBSelectionBackground:0x109961840.bottom == _UIButtonBarButton:0x109961040.bottom - 6   (active)>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x2818931b0 _UIUCBKBSelectionBackground:0x109961840.bottom == _UIButtonBarButton:0x109961040.bottom - 6   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:23:57.918677-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
    (Note: If you're seeing NSAutoresizingMaskLayoutConstraints that you don't understand, refer to the documentation for the UIView property translatesAutoresizingMaskIntoConstraints) 
(
    "<NSAutoresizingMaskLayoutConstraint:0x281898dc0 h=--& v=--& _UIButtonBarButton:0x109b406f0.height == 0   (active)>",
    "<NSLayoutConstraint:0x2818955e0 _UIUCBKBSelectionBackground:0x109b41400.bottom == _UIButtonBarButton:0x109b406f0.bottom - 6   (active)>",
    "<NSLayoutConstraint:0x281895540 V:|-(6)-[_UIUCBKBSelectionBackground:0x109b41400]   (active, names: '|':_UIButtonBarButton:0x109b406f0 )>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x2818955e0 _UIUCBKBSelectionBackground:0x109b41400.bottom == _UIButtonBarButton:0x109b406f0.bottom - 6   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:23:57.919064-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
    (Note: If you're seeing NSAutoresizingMaskLayoutConstraints that you don't understand, refer to the documentation for the UIView property translatesAutoresizingMaskIntoConstraints) 
(
    "<NSAutoresizingMaskLayoutConstraint:0x281898780 h=--& v=--& _UIButtonBarButton:0x109a4bb90.height == 0   (active)>",
    "<NSLayoutConstraint:0x281894fa0 V:|-(6)-[_UIUCBKBSelectionBackground:0x109b3f800]   (active, names: '|':_UIButtonBarButton:0x109a4bb90 )>",
    "<NSLayoutConstraint:0x281895040 _UIUCBKBSelectionBackground:0x109b3f800.bottom == _UIButtonBarButton:0x109a4bb90.bottom - 6   (active)>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x281895040 _UIUCBKBSelectionBackground:0x109b3f800.bottom == _UIButtonBarButton:0x109a4bb90.bottom - 6   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:23:57.919381-0400 VideoQuickStart[772:205852] [LayoutConstraints] Unable to simultaneously satisfy constraints.
    Probably at least one of the constraints in the following list is one you don't want. 
    Try this: 
        (1) look at each constraint and try to figure out which you don't expect; 
        (2) find the code that added the unwanted constraint or constraints and fix it. 
    (Note: If you're seeing NSAutoresizingMaskLayoutConstraints that you don't understand, refer to the documentation for the UIView property translatesAutoresizingMaskIntoConstraints) 
(
    "<NSAutoresizingMaskLayoutConstraint:0x281898aa0 h=--& v=--& _UIButtonBarButton:0x109b3f980.height == 0   (active)>",
    "<NSLayoutConstraint:0x281895270 V:|-(6)-[_UIUCBKBSelectionBackground:0x109b40570]   (active, names: '|':_UIButtonBarButton:0x109b3f980 )>",
    "<NSLayoutConstraint:0x281895310 _UIUCBKBSelectionBackground:0x109b40570.bottom == _UIButtonBarButton:0x109b3f980.bottom - 6   (active)>"
)

Will attempt to recover by breaking constraint 
<NSLayoutConstraint:0x281895310 _UIUCBKBSelectionBackground:0x109b40570.bottom == _UIButtonBarButton:0x109b3f980.bottom - 6   (active)>

Make a symbolic breakpoint at UIViewAlertForUnsatisfiableConstraints to catch this in the debugger.
The methods in the UIConstraintBasedLayoutDebugging category on UIView listed in <UIKitCore/UIView.h> may also be helpful.
2021-08-13 16:24:00.318982-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call createAudioSource
2021-08-13 16:24:00.319102-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call createAudioSource
2021-08-13 16:24:00.319301-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call createAudioTrack
2021-08-13 16:24:00.319385-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call createAudioTrack
2021-08-13 16:24:00.319444-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Adding audio track ...
2021-08-13 16:24:00.534588-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call connect
2021-08-13 16:24:00.534667-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): Creating dedicated notifier queue ...
2021-08-13 16:24:00.536085-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RoomSignalingImpl::RoomSignalingImpl()
2021-08-13 16:24:00.536291-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): Opening connection 2370c536-721f-4885-9b1d-52e58d04cd24 to wss://global.vss.twilio.com/signaling.
2021-08-13 16:24:00.536502-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackId
2021-08-13 16:24:00.536564-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackId
2021-08-13 16:24:00.536752-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Initialize connection 2370c536-721f-4885-9b1d-52e58d04cd24.
2021-08-13 16:24:00.536913-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call getTrackId
2021-08-13 16:24:00.537053-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call getTrackId
2021-08-13 16:24:00.537181-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:00.537185-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call getName
2021-08-13 16:24:00.537290-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call isEnabled
2021-08-13 16:24:00.537444-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:00.537472-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call getTrackId
2021-08-13 16:24:00.537585-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call getTrackId
2021-08-13 16:24:00.537624-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call getName
2021-08-13 16:24:00.537681-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RoomSignalingImpl: State transition successful: kInit -> kConnecting
2021-08-13 16:24:00.537733-0400 VideoQuickStart[772:206069] DEBUG:Twilio:[Core](0x16b8f7000): API Call isEnabled
2021-08-13 16:24:00.537996-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Building a SSL Context
2021-08-13 16:24:00.538229-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Loading a custom certificate bundle
2021-08-13 16:24:00.538669-0400 VideoQuickStart[772:205852] Attempting to connect to room Optional("de41e8d5-90f4-4519-b594-7a61513791d4")
2021-08-13 16:24:00.540063-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Adding a cipher list: ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:AES128-GCM-SHA256:AES256-GCM-SHA384:
2021-08-13 16:24:00.540823-0400 VideoQuickStart[772:206185] INFO:Twilio:[Core](0x16b6c7000): Will connect to host global.vss.twilio.com.
2021-08-13 16:24:00.601861-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Resolved host global.vss.twilio.com to the following IPs:
 - 52.205.240.193
 - 54.164.142.37
 - 3.224.109.42
2021-08-13 16:24:00.601973-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Connecting to 52.205.240.193...
2021-08-13 16:24:00.621518-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Connected to 52.205.240.193.
2021-08-13 16:24:00.621715-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Established a TCP connection with 52.205.240.193.
2021-08-13 16:24:00.663947-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Completed a TLS handshake with 52.205.240.193.
2021-08-13 16:24:00.664323-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending WebSocket handshake:
GET /signaling HTTP/1.1

Host: global.vss.twilio.com

Upgrade: websocket

Connection: upgrade

Sec-WebSocket-Key: tIRFPPs80CrKLY8tQk9mZw==

Sec-WebSocket-Version: 13

Sec-WebSocket-Extensions: permessage-deflate; server_max_window_bits=15; client_max_window_bits=15

User-Agent: Boost.Beast/290 twilio-video-cpp/6.1.0
2021-08-13 16:24:00.687042-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received WebSocket response:
HTTP/1.1 101 Switching Protocols

Date: Fri, 13 Aug 2021 20:24:00 GMT

Connection: upgrade

Sec-WebSocket-Extensions: permessage-deflate

Sec-WebSocket-Accept: LYLpE03+Z51kWYfDYElJjupA1Uk=

Upgrade: WebSocket
2021-08-13 16:24:00.687169-0400 VideoQuickStart[772:206185] INFO:Twilio:[Core](0x16b6c7000): Completed WebSocket handshake with 52.205.240.193.
2021-08-13 16:24:00.688134-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): AppleReachability::AppleReachability()
2021-08-13 16:24:00.688203-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Creating zeroAddrReachability
2021-08-13 16:24:00.688232-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (644 bytes):
{"body":{"edge":"roaming","token":"eyJhbGciOiJIUzI1NiIsImN0eSI6InR3aWxpby1mcGE7dj0xIiwidHdyIjpudWxsLCJ0eXAiOiJKV1QifQ.eyJqdGkiOiJTSzZhOGYxYmY5OWZmNGQ0ODJiNmU0MWExNmVjMjM3ZTNhLTE2Mjg4ODYxMzgiLCJncmFudHMiOnsiaWRlbnRpdHkiOiJCbHVlLCBCZXR0eSg5MSkiLCJ2aWRlbyI6eyJyb29tIjoiZGU0MWU4ZDUtOTBmNC00NTE5LWI1OTQtN2E2MTUxMzc5MWQ0In19LCJpc3MiOiJTSzZhOGYxYmY5OWZmNGQ0ODJiNmU0MWExNmVjMjM3ZTNhIiwibmJmIjoxNjI4ODg2MTM4LCJleHAiOjE2Mjg4ODk3MzgsInN1YiI6IkFDYWM0YTExODUyNDkyYzNjY2FlMmU0Y2MxNTAxZjY1MWUifQ.PEy9SiLg8MbzAd-_B52GeZHPOZSE67KapuTu2JNhGQs","type":"ice","version":2},"id":"2370c536-721f-4885-9b1d-52e58d04cd24\u0000","timeout":5000,"type":"hello","version":2}
2021-08-13 16:24:00.716573-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"negotiatedTimeout":5000,"type":"welcome"}
2021-08-13 16:24:00.716773-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Connection 2370c536-721f-4885-9b1d-52e58d04cd24 is ready.
2021-08-13 16:24:00.717216-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): AppleReachability::onConnectionEstablished, socket_fd = 19
2021-08-13 16:24:00.750889-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"body":{"version":1,"type":"iced","participants":[],"ice_servers":[{"urls":"turn:ashburn.turn.twilio.com:3478?transport=udp","username":"f9e511fd77b90588c92fc70db62aad9883994aef5201f93aca66a8bae9bc3983","credential":"kcfq7de4+pvnoo9dg0Rh8dvxzwS7moi3gEDVvU9WAn8="},{"urls":"turns:ashburn.turn.twilio.com:443?transport=tcp","username":"f9e511fd77b90588c92fc70db62aad9883994aef5201f93aca66a8bae9bc3983","credential":"kcfq7de4+pvnoo9dg0Rh8dvxzwS7moi3gEDVvU9WAn8="}]},"type":"msg"}
2021-08-13 16:24:00.751977-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): AppleReachability started listening on address pair on 19 socket
2021-08-13 16:24:00.752301-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): API Call getSignalingThread
2021-08-13 16:24:00.752388-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): API Call getSignalingThread
2021-08-13 16:24:00.752449-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): API Call getNetworkingThread
2021-08-13 16:24:00.752522-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Starting the Network Manager
2021-08-13 16:24:00.752681-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): API Call RTCIceServers
2021-08-13 16:24:00.752771-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): API Call RTCIceServer
2021-08-13 16:24:00.752840-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): API Call RTCIceServer
2021-08-13 16:24:00.752914-0400 VideoQuickStart[772:206078] INFO:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Creating peer connection ...
2021-08-13 16:24:00.757548-0400 VideoQuickStart[772:206078] INFO:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Adding local stream to peer connection ...
2021-08-13 16:24:00.757855-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Open -> Updating. Process an event
2021-08-13 16:24:00.758085-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Create local offer: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:00.758745-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onCreateSessionLocalDescription A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:00.769875-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): SDP Utils: New SSRC group 1307798570 2038800402 --- Original SSRC group 1307798570 2038800402
2021-08-13 16:24:00.770431-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Setting use dtx
2021-08-13 16:24:00.771002-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection state: Updating -> Waiting
2021-08-13 16:24:00.771533-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Removing use dtx from fmtp tine
2021-08-13 16:24:00.771640-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Local offer is ready for A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:00.771746-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Queue Description: 1 for PeerConnection: A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:00.772182-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (5387 bytes):
{"body":{"format":"planb","ice_servers":"success","media_signaling":null,"name":"de41e8d5-90f4-4519-b594-7a61513791d4","participant":{"revision":1,"tracks":[{"enabled":true,"id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","kind":"video","name":"Camera","priority":"standard"},{"enabled":true,"id":"f7942AB22dEdd1916a6cfA3eE66a28d1","kind":"audio","name":"Microphone","priority":"standard"}]},"peer_connections":[{"description":{"revision":1,"sdp":"v=0\r\no=- 1373546820972388550 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video\r\na=msid-semantic: WMS 5c958e6F3be12Ed57F1D5F147aBbF1Dd\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:RTKW\r\na=ice-pwd:xDK9uQSe7c4mLbM+UNT7ZrYH\r\na=ice-options:trickle\r\na=fingerprint:sha-256 6D:38:E7:67:2C:F7:38:3E:22:A3:5B:EC:29:17:34:53:74:D6:6D:D6:0F:3A:11:7B:90:A1:B7:90:69:FE:94:1C\r\na=setup:actpass\r\na=mid:audio\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=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:218106820 cname:dojbjAmJlvTYvzlu\r\na=ssrc:218106820 msid:5c958e6F3be12Ed57F1D5F147aBbF1Dd f7942AB22dEdd1916a6cfA3eE66a28d1\r\na=ssrc:218106820 mslabel:5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\na=ssrc:218106820 label:f7942AB22dEdd1916a6cfA3eE66a28d1\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 124 127 123 125\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:RTKW\r\na=ice-pwd:xDK9uQSe7c4mLbM+UNT7ZrYH\r\na=ice-options:trickle\r\na=fingerprint:sha-256 6D:38:E7:67:2C:F7:38:3E:22:A3:5B:EC:29:17:34:53:74:D6:6D:D6:0F:3A:11:7B:90:A1:B7:90:69:FE:94:1C\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:5 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07\r\na=extmap:9 http://www.webrtc.org/experiments/rtp-hdrext/color-space\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=fmtp:98 profile-id=0\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=640c2a\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=42e01f\r\na=rtpmap:124 rtx/90000\r\na=fmtp:124 apt=102\r\na=rtpmap:127 red/90000\r\na=rtpmap:123 rtx/90000\r\na=fmtp:123 apt=127\r\na=rtpmap:125 ulpfec/90000\r\na=ssrc-group:FID 1307798570 2038800402\r\na=ssrc:1307798570 cname:dojbjAmJlvTYvzlu\r\na=ssrc:1307798570 msid:5c958e6F3be12Ed57F1D5F147aBbF1Dd AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\na=ssrc:1307798570 mslabel:5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\na=ssrc:1307798570 label:AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\na=ssrc:2038800402 cname:dojbjAmJlvTYvzlu\r\na=ssrc:2038800402 msid:5c958e6F3be12Ed57F1D5F147aBbF1Dd AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\na=ssrc:2038800402 mslabel:5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\na=ssrc:2038800402 label:AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\n","type":"offer"},"id":"A09Bf0FEe8CB0C16c89ad0C195dbcEF6"}],"publisher":{"hw_device_arch":"arm64","hw_device_manufacturer":"Apple","hw_device_model":"iPad7,3","name":"twilio-video-ios","platform_name":"iOS","platform_version":"14.7.1","sdk_version":"4.4.0"},"token":"eyJhbGciOiJIUzI1NiIsImN0eSI6InR3aWxpby1mcGE7dj0xIiwidHdyIjpudWxsLCJ0eXAiOiJKV1QifQ.eyJqdGkiOiJTSzZhOGYxYmY5OWZmNGQ0ODJiNmU0MWExNmVjMjM3ZTNhLTE2Mjg4ODYxMzgiLCJncmFudHMiOnsiaWRlbnRpdHkiOiJCbHVlLCBCZXR0eSg5MSkiLCJ2aWRlbyI6eyJyb29tIjoiZGU0MWU4ZDUtOTBmNC00NTE5LWI1OTQtN2E2MTUxMzc5MWQ0In19LCJpc3MiOiJTSzZhOGYxYmY5OWZmNGQ0ODJiNmU0MWExNmVjMjM3ZTNhIiwibmJmIjoxNjI4ODg2MTM4LCJleHAiOjE2Mjg4ODk3MzgsInN1YiI6IkFDYWM0YTExODUyNDkyYzNjY2FlMmU0Y2MxNTAxZjY1MWUifQ.PEy9SiLg8MbzAd-_B52GeZHPOZSE67KapuTu2JNhGQs","type":"connect","version":2},"type":"msg"}
2021-08-13 16:24:00.836011-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"body":{"version":2,"type":"connected","peer_connections":[{"id":"A09Bf0FEe8CB0C16c89ad0C195dbcEF6","description":{"type":"answer","sdp":"v=0\r\no=- 3837875040 3837875040 IN IP4 0.0.0.0\r\ns=VMc7c12cd31688ca5090116dd00bc2a733\r\nt=0 0\r\na=ice-lite\r\na=msid-semantic: WMS *\r\na=group:BUNDLE audio video\r\nm=audio 17138 UDP/TLS/RTP/SAVPF 111 0\r\nc=IN IP4 3.235.111.239\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=rtcp:17138 IN IP4 3.235.111.239\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 3.235.111.239 17138 typ host\r\na=candidate:2 2 UDP 2013266429 3.235.111.239 16134 typ host\r\na=rtcp-mux\r\na=setup:active\r\na=mid:audio\r\na=recvonly\r\na=ice-ufrag:4s//\r\na=ice-pwd:g9rfbG5VpiPHTLGpk6cU4S\r\na=fingerprint:sha-256 2B:C2:3D:CF:8A:90:1A:77:6E:43:8E:DC:1A:BA:20:73:88:7D:39:AC:9B:40:99:5E:A6:40:D7:77:9A:09:E0:02\r\nm=video 17138 UDP/TLS/RTP/SAVPF 96 102 127 125\r\nc=IN IP4 3.235.111.239\r\na=rtcp-rsize\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=rtcp:17138 IN IP4 3.235.111.239\r\na=rtpmap:96 VP8/90000\r\na=rtpmap:102 H264/90000\r\na=rtpmap:127 red/90000\r\na=rtpmap:125 ulpfec/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:102 goog-remb\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=42e01f\r\na=candidate:2 1 UDP 2013266430 3.235.111.239 17138 typ host\r\na=candidate:2 2 UDP 2013266429 3.235.111.239 16134 typ host\r\na=rtcp-mux\r\na=setup:active\r\na=mid:video\r\na=recvonly\r\na=ice-ufrag:4s//\r\na=ice-pwd:g9rfbG5VpiPHTLGpk6cU4S\r\na=fingerprint:sha-256 2B:C2:3D:CF:8A:90:1A:77:6E:43:8E:DC:1A:BA:20:73:88:7D:39:AC:9B:40:99:5E:A6:40:D7:77:9A:09:E0:02\r\n","revision":1}}],"sid":"RM619ce18ebc3d626795f3ebc68cec2c02","name":"de41e8d5-90f4-4519-b594-7a61513791d4","participant":{"sid":"PAf3d8bae30e826c8ce0e062dbe8349317","identity":"Blue, Betty(91)","tracks":[{"kind":"video","priority":"standard","id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","enabled":true,"sid":"MTaeafe6cd12d99ad1307fa2b7cdf62c81","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"f7942AB22dEdd1916a6cfA3eE66a28d1","enabled":true,"sid":"MTf7fabe026afc17bd380181a7dd557b33","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA152afd6fa1391599eb5d1fd85011d613","identity":"Alia Okuneva","tracks":[{"kind":"video","priority":"low","id":"84cffbcf-ed1d-4eb1-999f-3235139dfd24","enabled":true,"sid":"MTa07a74a0dba384e88c38c216e037417b","name":"camera-1628885877402","state":"ready"},{"kind":"audio","priority":"standard","id":"e0d6d43a-de25-420e-8f91-7a1dd5833a74","enabled":true,"sid":"MT27594c681297a611a88738b21fc0ae6e","name":"42d55ed9-f44d-4faa-8fc3-10be48c31d12","state":"ready"}],"revision":2,"state":"connected"}],"recording":{"enabled":false,"revision":1,"is_recording":false},"subscribed":{"revision":0,"tracks":[]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","enabled":true,"sid":"MTaeafe6cd12d99ad1307fa2b7cdf62c81","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"f7942AB22dEdd1916a6cfA3eE66a28d1","enabled":true,"sid":"MTf7fabe026afc17bd380181a7dd557b33","name":"Microphone","state":"ready"}]},"session":"ac4a11852492c3ccae2e4cc1501f651e619ce18ebc3d626795f3ebc68cec2c02f3d8bae30e826c8ce0e062dbe8349317b9dabab7d4d73eac40d215b0349e6cb1","options":{"media_region":"us1","signaling_region":"us1","session_timeout":30,"signaling_edge":"ashburn"}},"type":"msg"}
2021-08-13 16:24:00.837217-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onConnectedOrSynced
2021-08-13 16:24:00.837275-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): RoomSignalingImpl: State transition successful: kConnecting -> kConnected
2021-08-13 16:24:00.837276-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"body":{"version":2,"type":"update","peer_connections":[{"id":"A09Bf0FEe8CB0C16c89ad0C195dbcEF6","description":{"type":"offer","sdp":"v=0\r\no=- 3837875040 3837875041 IN IP4 0.0.0.0\r\ns=VMc7c12cd31688ca5090116dd00bc2a733\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\r\nm=audio 1 UDP/TLS/RTP/SAVPF 111 0\r\nc=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=rtcp:9 IN IP4 0.0.0.0\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=candidate:2 1 UDP 2013266430 3.235.111.239 17138 typ host\r\na=c2021-08-13 16:24:00.837437-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setTracks
andidate:2 2 UDP 2013266429 3.235.111.239 16134 typ host\r\na=rtcp-mux\r\na=setup:actpass\r\na=mid:audio\r\na=sendrecv\r\na=ice-ufrag:4s//\r\na=ice-pwd:g9rfbG5VpiPHTLGpk6cU4S\r\na=fingerprint:sha-256 2B:C2:3D:CF:8A:90:1A:77:6E:43:8E:DC:1A:BA:20:73:88:7D:39:AC:9B:40:99:5E:A6:40:D7:77:9A:09:E0:02\r\na=ssrc:3351589422 cname:user1019030805@host-af404df5\r\na=ssrc:3351589422 msid:default 3c49b79a-77d1-4fd9-913f-d2d7a5e07e3f\r\nm=video 1 UDP/TLS/RTP/SAVPF 96 102 127 125\r\nc=IN IP4 0.0.0.0\r\na=rtpmap:96 VP8/90000\r\na=rtpmap:102 H264/90000\r\na=rtpmap:127 red/90000\r\na=rtpmap:125 ulpfec/90000\r\na=fmtp:102 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=rtcp-rsize\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 ccm fir\r\na=rt2021-08-13 16:24:00.837448-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection state: Waiting -> Updating
2021-08-13 16:24:00.837529-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RemoteParticipantImpl::RemoteParticipantImpl: Alia Okuneva, sid: PA152afd6fa1391599eb5d1fd85011d613
2021-08-13 16:24:00.837534-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Process remote answer at revision 1.
2021-08-13 16:24:00.837580-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Process remote sdp for: A09Bf0FEe8CB0C16c89ad0C195dbcEF6 revision is: 1.
2021-08-13 16:24:00.837585-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Remote participant Alia Okuneva added a video track with sid: MTa07a74a0dba384e88c38c216e037417b, name: camera-1628885877402, enabled: 1, priority: 0
2021-08-13 16:24:00.837645-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Remote participant Alia Okuneva added an audio track with sid: MT27594c681297a611a88738b21fc0ae6e, name: 42d55ed9-f44d-4faa-8fc3-10be48c31d12, enabled: 1, priority: 1
cp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=rtcp-fb:102 goog-remb\r\na=rtcp-fb:102 ccm fir\r\na=candidate:2 1 UDP 2013266430 3.235.111.239 17138 typ host\r\na=candidate:2 2 UDP 2013266429 3.235.111.239 16134 typ host\r\na=rtcp-mux\r\na=setup:actpass\r\na=mid:video\r\na=sendrecv\r\na=ice-ufrag:4s//\r\na=ice-pwd:g9rfbG5VpiPHTLGpk6cU4S\r\na=fingerprint:sha-256 2B:C2:3D:CF:8A:90:1A:77:6E:43:8E:DC:1A:BA:20:73:88:7D:39:AC:9B:40:99:5E:A6:40:D7:77:9A:09:E0:02\r\na=ssrc:1900366348 cname:user1019030805@host-af404df5\r\na=ssrc:1900366348 msid:default 9f0eda90-dded-4a3f-926d-5c7b33131379\r\n","revision":2}}],"sid":"RM619ce18ebc3d626795f3ebc68cec2c02","name":"de41e8d5-90f4-4519-b594-7a61513791d4","participant":{"sid":"PAf3d8bae30e826c8ce0e062dbe8349317","identity":"Blue, Betty(91)","tracks":[{"kind":"video","priority":"standard","id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","enabled":tru2021-08-13 16:24:00.837761-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteParticipants
e,"sid":"MTaeafe6cd12d99ad1307fa2b7cdf62c81","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"f7942AB22dEdd1916a6cfA3eE66a28d1","enabled":true,"sid":"MTf7fabe026afc17bd380181a7dd557b33","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA152afd6fa1391599eb5d1fd85011d613","identity":"Alia Okuneva","tracks":[{"kind":"video","priority":"low","id":"84cffbcf-ed1d-4eb1-999f-3235139dfd24","enabled":true,"sid":"MTa07a74a0dba384e88c38c216e037417b","name":"camera-1628885877402","state":"ready"},{"kind":"audio","priority":"standard","id":"e0d6d43a-de25-420e-8f91-7a1dd5833a74","enabled":true,"sid":"MT27594c681297a611a88738b21fc0ae6e","name":"42d55ed9-f44d-4faa-8fc3-10be48c31d12","state":"ready"}],"revision":2,"state":"connected"}],"recording":{"enabled":false,"revision":1,"is_recording":false},"subscribed":{"revisi2021-08-13 16:24:00.838053-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setObserver
on":1,"tracks":[{"id":"3c49b79a-77d1-4fd9-913f-d2d7a5e07e3f","sid":"MT27594c681297a611a88738b21fc0ae6e"},{"id":"9f0eda90-dded-4a3f-926d-5c7b33131379","sid":"MTa07a74a0dba384e88c38c216e037417b"}]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","enabled":true,"sid":"MTaeafe6cd12d99ad1307fa2b7cdf62c81","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"f7942AB22dEdd1916a6cfA3eE66a28d1","enabled":true,"sid":"MTf7fabe026afc17bd380181a7dd557b33","name":"Microphone","state":"ready"}]}},"type":"msg"}
2021-08-13 16:24:00.838218-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteAudioTracks
2021-08-13 16:24:00.838154-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Setting use dtx
2021-08-13 16:24:00.838280-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteVideoTracks
2021-08-13 16:24:00.838619-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteDataTracks
2021-08-13 16:24:00.838707-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getLocalParticipant
2021-08-13 16:24:00.838807-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setObserver
2021-08-13 16:24:00.838891-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getLocalAudioTracks
2021-08-13 16:24:00.838861-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Preferred video codec is VP8
2021-08-13 16:24:00.838942-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getLocalTrack
2021-08-13 16:24:00.838998-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getLocalDataTracks
2021-08-13 16:24:00.839033-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getLocalVideoTracks
2021-08-13 16:24:00.839166-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getLocalTrack
2021-08-13 16:24:00.839292-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getName
2021-08-13 16:24:00.839347-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Applying local description to: A09Bf0FEe8CB0C16c89ad0C195dbcEF6 rev: 1
2021-08-13 16:24:00.839370-0400 VideoQuickStart[772:205852] Connected to room de41e8d5-90f4-4519-b594-7a61513791d4 as Blue, Betty(91)
2021-08-13 16:24:00.844040-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): void twilio::media::NetworkMonitor::onNetworksChanged()
2021-08-13 16:24:00.844038-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onSetSessionLocalDescription: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:00.844134-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Starting ICE Gathering timer...
2021-08-13 16:24:00.844162-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): Network Name: en0, Cost: 10, Type : Wifi, Preference : 127, Active : 1, id: 1, prefix : 192.168.1.x and key : en0%192.168.1.x/24
2021-08-13 16:24:00.844255-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Applying remote description to: A09Bf0FEe8CB0C16c89ad0C195dbcEF6 rev: 1
2021-08-13 16:24:00.844277-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): Network Name: en2, Cost: 10, Type : Wifi, Preference : 126, Active : 1, id: 2, prefix : 169.254.0.x and key : en2%169.254.0.x/16
2021-08-13 16:24:00.844348-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): Network Name: ipsec0, Cost: 50, Type : VPN, Preference : 125, Active : 1, id: 3, prefix : 2607:fb90:13c2:718d:: and key : ipsec0%2607:fb90:13c2:718d::/64
2021-08-13 16:24:00.844671-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): Network Name: lo0, Cost: 0, Type : Loopback, Preference : 124, Active : 1, id: 5, prefix : ::1 and key : lo0%::1/128
2021-08-13 16:24:00.844725-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): Network Name: lo0, Cost: 0, Type : Loopback, Preference : 123, Active : 1, id: 4, prefix : 127.0.0.x and key : lo0%127.0.0.x/8
2021-08-13 16:24:00.844771-0400 VideoQuickStart[772:206080] DEBUG:Twilio:[Core](MediaFactoryImpl::networking 0x0x2810dc8c0): New preferred network reported by manager: key: en0%192.168.1.x/24, type: Wifi, cost: 10, id: 1
2021-08-13 16:24:00.847463-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Done processing onSetSessionLocalDescription: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:00.847552-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Ice Gathering for A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:00.847597-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): ICE connection state transitioned from New -> Checking
2021-08-13 16:24:00.847638-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6 Ice connection state transitioned from New -> Checking
2021-08-13 16:24:00.847674-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Room Media state changed to Checking
2021-08-13 16:24:00.847715-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Gathered a candidate = udp 2607:fb90:13c2:718d:500:4982:d6db:45d5 55238 typ local generation 0 network-id 3
2021-08-13 16:24:00.847751-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onSetSessionRemoteDescription: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:00.847937-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Queue ICE candidate revision: 1 for PeerConnection: A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:00.848017-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Publish ICE candidate revision: 1 for PeerConnection: A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:00.848163-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Process remote offer.
2021-08-13 16:24:00.848214-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Process remote sdp for: A09Bf0FEe8CB0C16c89ad0C195dbcEF6 revision is: 2.
2021-08-13 16:24:00.848395-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Setting use dtx
2021-08-13 16:24:00.848500-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (587 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","kind":"video","name":"Camera","priority":"standard"},{"enabled":true,"id":"f7942AB22dEdd1916a6cfA3eE66a28d1","kind":"audio","name":"Microphone","priority":"standard"}]},"peer_connections":[{"ice":{"candidates":[],"complete":true,"revision":1,"ufrag":"RTKW"},"id":"A09Bf0FEe8CB0C16c89ad0C195dbcEF6"}],"session":"ac4a11852492c3ccae2e4cc1501f651e619ce18ebc3d626795f3ebc68cec2c02f3d8bae30e826c8ce0e062dbe8349317b9dabab7d4d73eac40d215b0349e6cb1","type":"update","version":2},"type":"msg"}
2021-08-13 16:24:00.848835-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Applying remote description to: A09Bf0FEe8CB0C16c89ad0C195dbcEF6 rev: 2
2021-08-13 16:24:00.879435-0400 VideoQuickStart[772:206067] DEBUG:Twilio:[Core](0x16b7df000): Creating a builtin video encoder for VP8
2021-08-13 16:24:00.879766-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"body":{"version":2,"type":"update","sid":"RM619ce18ebc3d626795f3ebc68cec2c02","name":"de41e8d5-90f4-4519-b594-7a61513791d4","participant":{"sid":"PAf3d8bae30e826c8ce0e062dbe8349317","identity":"Blue, Betty(91)","tracks":[{"kind":"video","priority":"standard","id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","enabled":true,"sid":"MTaeafe6cd12d99ad1307fa2b7cdf62c81","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"f7942AB22dEdd1916a6cfA3eE66a28d1","enabled":true,"sid":"MTf7fabe026afc17bd380181a7dd557b33","name":"Microphone","state":"ready"}],"revision":1,"state":"connected"},"participants":[{"sid":"PA152afd6fa1391599eb5d1fd85011d613","identity":"Alia Okuneva","tracks":[{"kind":"video","priority":"low","id":"84cffbcf-ed1d-4eb1-999f-3235139dfd24","enabled":true,"sid":"MTa07a74a0dba384e88c38c216e037417b","name":"camera-1628885877402","state":"ready"},{"kind":"audio","priority":"standard","id":"e0d6d43a-de25-420e-8f91-7a1dd5833a74","enabled":true,"sid":"MT27594c681297a611a88738b21fc0ae6e","name":"42d55ed9-f44d-4faa-8fc3-10be48c31d12","state":"ready"}],"revision":2,"state":"connected"}],"recording":{"enabled":false,"revision":1,"is_recording":false},"subscribed":{"revision":1,"tracks":[{"id":"3c49b79a-77d1-4fd9-913f-d2d7a5e07e3f","sid":"MT27594c681297a611a88738b21fc0ae6e"},{"id":"9f0eda90-dded-4a3f-926d-5c7b33131379","sid":"MTa07a74a0dba384e88c38c216e037417b"}]},"published":{"revision":1,"tracks":[{"kind":"video","priority":"standard","id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","enabled":true,"sid":"MTaeafe6cd12d99ad1307fa2b7cdf62c81","name":"Camera","state":"ready"},{"kind":"audio","priority":"standard","id":"f7942AB22dEdd1916a6cfA3eE66a28d1","enabled":true,"sid":"MTf7fabe026afc17bd380181a7dd557b33","name":"Microphone","state":"ready"}]}},"type":"msg"}
2021-08-13 16:24:01.241681-0400 VideoQuickStart[772:206079] DEBUG:Twilio:[Core](MediaFactoryImpl::worker 0x0x2810dc8c0): Creating a builtin video decoder for VP8
2021-08-13 16:24:01.241774-0400 VideoQuickStart[772:206079] DEBUG:Twilio:[Core](MediaFactoryImpl::worker 0x0x2810dc8c0): Creating a builtin video decoder for VP9
2021-08-13 16:24:01.241819-0400 VideoQuickStart[772:206079] DEBUG:Twilio:[Core](MediaFactoryImpl::worker 0x0x2810dc8c0): Creating an external video decoder for H264
2021-08-13 16:24:01.242018-0400 VideoQuickStart[772:206079] DEBUG:Twilio:[Core](MediaFactoryImpl::worker 0x0x2810dc8c0): Creating an external video decoder for H264
2021-08-13 16:24:01.243082-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call isTrackEnabled
2021-08-13 16:24:01.243102-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Ice Gathering Complete for A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:01.243137-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackName
2021-08-13 16:24:01.243156-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): ICE connection state transitioned from Checking -> Connected
2021-08-13 16:24:01.243175-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Subscribed to Participant's Alia Okuneva audio track with sid MT27594c681297a611a88738b21fc0ae6e
2021-08-13 16:24:01.243196-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6 Ice connection state transitioned from Checking -> Connected
2021-08-13 16:24:01.243210-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:01.243296-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:01.243358-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:01.243774-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:01.243847-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:01.244281-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Room Media state changed to Connected
2021-08-13 16:24:01.244324-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Media is connected
2021-08-13 16:24:01.244427-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackName
2021-08-13 16:24:01.244471-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:01.244531-0400 VideoQuickStart[772:205852] Subscribed to 42d55ed9-f44d-4faa-8fc3-10be48c31d12 audio track for Participant Alia Okuneva
2021-08-13 16:24:01.244556-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): start: Launching background thread to start the WebSocket.
2021-08-13 16:24:01.245656-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): Building a SSL Context
2021-08-13 16:24:01.245845-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setTrackSubscribed
2021-08-13 16:24:01.245924-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call isTrackEnabled
2021-08-13 16:24:01.246042-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackName
2021-08-13 16:24:01.246188-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setTrack
2021-08-13 16:24:01.246243-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Subscribed to Participant's Alia Okuneva video track with sid MTa07a74a0dba384e88c38c216e037417b
2021-08-13 16:24:01.246384-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:01.246452-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:01.246491-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:01.246578-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:01.246626-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:01.246665-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackName
2021-08-13 16:24:01.246703-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:01.247022-0400 VideoQuickStart[772:205852] Subscribed to camera-1628885877402 video track for Participant Alia Okuneva
2021-08-13 16:24:01.247287-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call isTrackSubscribed
2021-08-13 16:24:01.248791-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Did move to window with size: {834, 1112}.
Metal content scale factor is now: 2.000
2021-08-13 16:24:01.248875-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Starting the media monitor - call getPeerConnectionStats
2021-08-13 16:24:01.249108-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:01.249175-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:01.249465-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): Loading a custom certificate bundle
2021-08-13 16:24:01.250628-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): Using default cipher list.
2021-08-13 16:24:01.252320-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): ICE connection state transitioned from Connected -> Completed
2021-08-13 16:24:01.252412-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6 Ice connection state transitioned from Connected -> Completed
2021-08-13 16:24:01.252494-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Room Media state changed to Completed
2021-08-13 16:24:01.252647-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onSetSessionRemoteDescription: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:01.252990-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): connect: url=wss://sdkgw.us1.twilio.com/v1/VideoEvents
2021-08-13 16:24:01.254498-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Create local answer: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:01.254999-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): WebSocket connection timeout set to 15000 milliseconds.
2021-08-13 16:24:01.255017-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): Creating a builtin video encoder for VP8
2021-08-13 16:24:01.255638-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Media for PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6 transitioned from MediaInactive -> MediaActive
2021-08-13 16:24:01.255881-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6 Media activity state transitioned from MediaInactive -> MediaActive
2021-08-13 16:24:01.255943-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Media Activity state changed to MediaActive
2021-08-13 16:24:01.256136-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): At least one media Track is active in Room.
2021-08-13 16:24:01.256312-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onCreateSessionLocalDescription A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:01.265246-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): SDP Utils: New SSRC 1307798570 replaced with Old SSRC 1307798570
2021-08-13 16:24:01.267687-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): SDP Utils: New SSRC 2038800402 replaced with Old SSRC 2038800402
2021-08-13 16:24:01.269996-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): SDP Utils: New SSRC 218106820 replaced with Old SSRC 218106820
2021-08-13 16:24:01.271864-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): SDP Utils: New SSRC group 1307798570 2038800402 --- Original SSRC group 1307798570 2038800402
2021-08-13 16:24:01.272510-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): DTX is already set
2021-08-13 16:24:01.272896-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Applying local description to: A09Bf0FEe8CB0C16c89ad0C195dbcEF6 rev: 2
2021-08-13 16:24:01.273959-0400 VideoQuickStart[772:206079] DEBUG:Twilio:[Core](MediaFactoryImpl::worker 0x0x2810dc8c0): Creating a builtin video decoder for VP8
2021-08-13 16:24:01.274222-0400 VideoQuickStart[772:206079] DEBUG:Twilio:[Core](MediaFactoryImpl::worker 0x0x2810dc8c0): Creating an external video decoder for H264
2021-08-13 16:24:01.274981-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Replaced a private non-loopback connection address with any address. Address = 192.168.1.x:52192.
2021-08-13 16:24:01.275136-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Removing use dtx from fmtp tine
2021-08-13 16:24:01.275204-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Local answer is ready for A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:01.275245-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Queue Description: 2 for PeerConnection: A09Bf0FEe8CB0C16c89ad0C195dbcEF6.
2021-08-13 16:24:01.275412-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): onSetSessionLocalDescription: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:01.275504-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Updating -> Open
2021-08-13 16:24:01.275592-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Done processing onSetSessionLocalDescription: A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:01.275740-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (3022 bytes):
{"body":{"participant":{"revision":1,"tracks":[{"enabled":true,"id":"AeB9fC0ba7A5B88D0f4fEc5eee3C96dA","kind":"video","name":"Camera","priority":"standard"},{"enabled":true,"id":"f7942AB22dEdd1916a6cfA3eE66a28d1","kind":"audio","name":"Microphone","priority":"standard"}]},"peer_connections":[{"description":{"revision":2,"sdp":"v=0\r\no=- 1373546820972388550 3 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video\r\na=msid-semantic: WMS 5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\nm=audio 52192 UDP/TLS/RTP/SAVPF 111 0\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:3334460576 1 udp 2122131711 2607:fb90:13c2:718d:500:4982:d6db:45d5 55238 typ host generation 0 network-id 3 network-cost 50\r\na=ice-ufrag:RTKW\r\na=ice-pwd:xDK9uQSe7c4mLbM+UNT7ZrYH\r\na=ice-options:trickle\r\na=fingerprint:sha-256 6D:38:E7:67:2C:F7:38:3E:22:A3:5B:EC:29:17:34:53:74:D6:6D:D6:0F:3A:11:7B:90:A1:B7:90:69:FE:94:1C\r\na=setup:passive\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=fmtp:111 minptime=10;useinbandfec=1\r\na=rtpmap:0 PCMU/8000\r\na=ssrc:218106820 cname:dojbjAmJlvTYvzlu\r\na=ssrc:218106820 msid:5c958e6F3be12Ed57F1D5F147aBbF1Dd f7942AB22dEdd1916a6cfA3eE66a28d1\r\na=ssrc:218106820 mslabel:5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\na=ssrc:218106820 label:f7942AB22dEdd1916a6cfA3eE66a28d1\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 102 127 125\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=ice-ufrag:RTKW\r\na=ice-pwd:xDK9uQSe7c4mLbM+UNT7ZrYH\r\na=ice-options:trickle\r\na=fingerprint:sha-256 6D:38:E7:67:2C:F7:38:3E:22:A3:5B:EC:29:17:34:53:74:D6:6D:D6:0F:3A:11:7B:90:A1:B7:90:69:FE:94:1C\r\na=setup:passive\r\na=mid:video\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\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 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtpmap:102 H264/90000\r\na=rtcp-fb:102 goog-remb\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=42e01f\r\na=rtpmap:127 red/90000\r\na=rtpmap:125 ulpfec/90000\r\na=ssrc-group:FID 1307798570 2038800402\r\na=ssrc:1307798570 cname:dojbjAmJlvTYvzlu\r\na=ssrc:1307798570 msid:5c958e6F3be12Ed57F1D5F147aBbF1Dd AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\na=ssrc:1307798570 mslabel:5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\na=ssrc:1307798570 label:AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\na=ssrc:2038800402 cname:dojbjAmJlvTYvzlu\r\na=ssrc:2038800402 msid:5c958e6F3be12Ed57F1D5F147aBbF1Dd AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\na=ssrc:2038800402 mslabel:5c958e6F3be12Ed57F1D5F147aBbF1Dd\r\na=ssrc:2038800402 label:AeB9fC0ba7A5B88D0f4fEc5eee3C96dA\r\n","type":"answer"},"id":"A09Bf0FEe8CB0C16c89ad0C195dbcEF6"}],"session":"ac4a11852492c3ccae2e4cc1501f651e619ce18ebc3d626795f3ebc68cec2c02f3d8bae30e826c8ce0e062dbe8349317b9dabab7d4d73eac40d215b0349e6cb1","type":"update","version":2},"type":"msg"}
2021-08-13 16:24:01.278165-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): The DNS resolution completed for sdkgw.us1.twilio.com.
2021-08-13 16:24:01.278279-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): Trying to connect to 54.164.142.37.
2021-08-13 16:24:01.338989-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): Connected to 54.164.142.37.
2021-08-13 16:24:01.339191-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): The TCP handshake completed for sdkgw.us1.twilio.com.
2021-08-13 16:24:01.339328-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): MultiConnect timer was aborted.
2021-08-13 16:24:01.395470-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): The TLS handshake completed for sdkgw.us1.twilio.com.
2021-08-13 16:24:01.532822-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Preparing renderer for frame size: {1280, 720}, view bounds: {{0, 321}, {834, 470}}
2021-08-13 16:24:01.532957-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Detected a pixel format change. Preparing the rendering pipeline. Old = none, New = f420
2021-08-13 16:24:01.533340-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Texture caching failed with code: -6660, fallback to copy and upload path.
2021-08-13 16:24:01.760577-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): open: Continue waiting for connection attempt.
2021-08-13 16:24:02.261583-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): open: Continue waiting for connection attempt.
2021-08-13 16:24:02.539963-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): The WebSocket protocol upgrade completed for sdkgw.us1.twilio.com. Reading indefinitely.
2021-08-13 16:24:02.540121-0400 VideoQuickStart[772:206201] DEBUG:Twilio:[Core](0x16c087000): open: Connection successed.
2021-08-13 16:24:02.540491-0400 VideoQuickStart[772:206200] DEBUG:Twilio:[Core](0x16bffb000): The WebSocket connection timer was aborted.
2021-08-13 16:24:04.944065-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"type":"heartbeat"}
2021-08-13 16:24:06.078930-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (20 bytes):
{"type":"heartbeat"}
2021-08-13 16:24:08.887027-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"type":"heartbeat"}
2021-08-13 16:24:10.878987-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (20 bytes):
{"type":"heartbeat"}
2021-08-13 16:24:12.881520-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"type":"heartbeat"}
2021-08-13 16:24:13.885375-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call disconnect
2021-08-13 16:24:13.885464-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RoomSignalingImpl: State transition successful: kConnected -> kDisconnecting
2021-08-13 16:24:13.885519-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getName
2021-08-13 16:24:13.885562-0400 VideoQuickStart[772:205852] Attempting to disconnect from room de41e8d5-90f4-4519-b594-7a61513791d4
2021-08-13 16:24:13.885608-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Disconnecting from RM619ce18ebc3d626795f3ebc68cec2c02.
2021-08-13 16:24:13.885679-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): virtual void twilio::insights::InsightsPublisher::stop()
2021-08-13 16:24:13.885950-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): stopSocketStartThread: no thread to stop
2021-08-13 16:24:13.886209-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:13.886624-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:13.886668-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:13.886712-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:13.886330-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): virtual twilio::net::WebSocket::Session::~Session()
2021-08-13 16:24:13.886766-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackName
2021-08-13 16:24:13.886886-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:13.886994-0400 VideoQuickStart[772:205852] Unsubscribed from 42d55ed9-f44d-4faa-8fc3-10be48c31d12 audio track for Participant Alia Okuneva
2021-08-13 16:24:13.887014-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Websocket still connected, closing it.
2021-08-13 16:24:13.887544-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Closing A09Bf0FEe8CB0C16c89ad0C195dbcEF6 due to Local Participant initiating disconnect
2021-08-13 16:24:13.887582-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): -[TVIAudioTrack dealloc]
2021-08-13 16:24:13.887634-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:13.887672-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setTrackSubscribed
2021-08-13 16:24:13.887716-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:13.887815-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:13.887868-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackSid
2021-08-13 16:24:13.887965-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getTrackName
2021-08-13 16:24:13.888006-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:13.888098-0400 VideoQuickStart[772:205852] Unsubscribed from camera-1628885877402 video track for Participant Alia Okuneva
2021-08-13 16:24:13.888386-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getSid
2021-08-13 16:24:13.888439-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getSid
2021-08-13 16:24:13.888784-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): Did move to window with size: {0, 0}.
Metal content scale factor is now: 0.000
2021-08-13 16:24:13.889038-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getSid
2021-08-13 16:24:13.889136-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getSid
2021-08-13 16:24:13.889244-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:13.889287-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getWebRtcTrack
2021-08-13 16:24:13.890534-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): -[TVIVideoTrack dealloc]
2021-08-13 16:24:13.890635-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call setTrack
2021-08-13 16:24:13.890773-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RemoteParticipantSignaling::~RemoteParticipantSignaling(SID = PA152afd6fa1391599eb5d1fd85011d613)
2021-08-13 16:24:13.890904-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): -[TVIMetalRenderer dealloc]
2021-08-13 16:24:14.037199-0400 VideoQuickStart[772:206078] INFO:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Closed Webrtc PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6
2021-08-13 16:24:14.037305-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): void twilio::media::IceConnectionActivityMonitor::stop()
2021-08-13 16:24:14.037348-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): ~IceConnectionActivityMonitor
2021-08-13 16:24:14.037563-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Waiting for any in-progress calls in async_invoker to complete.
2021-08-13 16:24:14.037660-0400 VideoQuickStart[772:206078] DEBUG:Twilio:[Core](MediaFactoryImpl::signaling 0x0x2810dc8c0): Stopping the Network Manager
2021-08-13 16:24:14.037811-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): PeerConnection A09Bf0FEe8CB0C16c89ad0C195dbcEF6 closed. Ice connection state set from Completed -> Closed
2021-08-13 16:24:14.037877-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Room Media state changed to Closed
2021-08-13 16:24:14.037961-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Discarding media state changes because we are no longer connected.
2021-08-13 16:24:14.038136-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Media connections closed:
2021-08-13 16:24:14.038176-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): Closing A09Bf0FEe8CB0C16c89ad0C195dbcEF6 due to Local Participant initiating disconnect
2021-08-13 16:24:14.038212-0400 VideoQuickStart[772:206066] INFO:Twilio:[Core](0x16b753000): PeerConnectionSignaling with id A09Bf0FEe8CB0C16c89ad0C195dbcEF6 destroyed
2021-08-13 16:24:14.038333-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): ~NetworkMonitor
2021-08-13 16:24:14.038805-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Closed all Peer Connections
2021-08-13 16:24:14.038928-0400 VideoQuickStart[772:206066] DEBUG:Twilio:[Core](0x16b753000): Invoking cancelled closure. reason=~SafePoster
2021-08-13 16:24:14.039291-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Sending message (196 bytes):
{"body":{"session":"ac4a11852492c3ccae2e4cc1501f651e619ce18ebc3d626795f3ebc68cec2c02f3d8bae30e826c8ce0e062dbe8349317b9dabab7d4d73eac40d215b0349e6cb1","type":"disconnect","version":2},"type":"msg"}
2021-08-13 16:24:14.200737-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"body":{"version":1,"type":"disconnected","sid":"RM619ce18ebc3d626795f3ebc68cec2c02","name":"de41e8d5-90f4-4519-b594-7a61513791d4","participants":[],"status":"in-progress"},"type":"msg"}
2021-08-13 16:24:14.201200-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Received message:
{"type":"bye"}
2021-08-13 16:24:14.201203-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): onDisconnected
2021-08-13 16:24:14.201262-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): Canceling disconnect timer.
2021-08-13 16:24:14.201328-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): AppleReachability::~AppleReachability()
2021-08-13 16:24:14.201463-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): wss::Connection::~Connection
2021-08-13 16:24:14.201503-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): wss::Connection::close
2021-08-13 16:24:14.201670-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Closing the WebSocket by request.
2021-08-13 16:24:14.201837-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Queuing a close request.
2021-08-13 16:24:14.202551-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Receive aborted with code: 2
2021-08-13 16:24:14.202643-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): wss::Connection::closeIfConnected: Closing connection 2370c536-721f-4885-9b1d-52e58d04cd24.
2021-08-13 16:24:14.202757-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): Unable to close the WebSocket stream.
2021-08-13 16:24:14.202824-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): ConnectionFSM::on_transport_failed_while_closing: Received the final 'transport failed', transitioning to closed.
2021-08-13 16:24:14.203005-0400 VideoQuickStart[772:206185] DEBUG:Twilio:[Core](0x16b6c7000): ConnectionFSM::on_closed: Calling onClosed()
2021-08-13 16:24:14.203133-0400 VideoQuickStart[772:206185] INFO:Twilio:[Core](0x16b6c7000): Connection 2370c536-721f-4885-9b1d-52e58d04cd24 was closed with reason: REMOTE category: asio.misc message: End of file.
2021-08-13 16:24:14.203658-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): void twilio::insights::InsightsPublisher::willDestroy()
2021-08-13 16:24:14.203725-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): virtual void twilio::insights::InsightsPublisher::stop()
2021-08-13 16:24:14.203780-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): stopSocketStartThread: no thread to stop
2021-08-13 16:24:14.203818-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): close - websocket not open, ignoring.
2021-08-13 16:24:14.203890-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): willDestroy: Already on task queue, setting cancel flags.
2021-08-13 16:24:14.203956-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): ~InsightsPublisher
2021-08-13 16:24:14.204433-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): RoomSignalingImpl: State transition successful: kDisconnecting -> kDisconnected
2021-08-13 16:24:14.204550-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getName
2021-08-13 16:24:14.204667-0400 VideoQuickStart[772:205852] Disconnected from room de41e8d5-90f4-4519-b594-7a61513791d4, error = nil
2021-08-13 16:24:14.204664-0400 VideoQuickStart[772:206071] DEBUG:Twilio:[Core](0x16b983000): Invoking cancelled closure. reason=~SafePoster
2021-08-13 16:24:14.208412-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Platform](Thread 0x0x109923b70): -[TVIRemoteParticipant dealloc]
2021-08-13 16:24:14.208515-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:14.208555-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Invalidating remote media of Alia Okuneva
2021-08-13 16:24:14.208591-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:14.208629-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:14.208663-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): ~RoomImpl
2021-08-13 16:24:14.208696-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RoomSignalingImpl::~RoomSignalingImpl()
2021-08-13 16:24:14.208754-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RoomSignalingImpl: State Transition Failure: kDisconnected -> kDisconnecting
2021-08-13 16:24:14.209255-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:14.209384-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Invalidating remote media of Alia Okuneva
2021-08-13 16:24:14.209494-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:14.209600-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:14.209673-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): RemoteParticipantImpl::~RemoteParticipantImpl
2021-08-13 16:24:14.209772-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getIdentity
2021-08-13 16:24:14.209858-0400 VideoQuickStart[772:205852] INFO:Twilio:[Core](Thread 0x0x109923b70): Invalidating remote media of Alia Okuneva
2021-08-13 16:24:14.209926-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack
2021-08-13 16:24:14.210018-0400 VideoQuickStart[772:205852] DEBUG:Twilio:[Core](Thread 0x0x109923b70): API Call getRemoteTrack

Versions

All relevant version information for the issue.

Video iOS SDK

4.4.0

Xcode

12.5.1

iOS Version

14.7.1

iOS Device

iPad Pro 10"

ceaglest commented 2 years ago

Hi @zcjhnsn,

Create room from a web user

What app is your web user using? If you are using https://github.com/twilio/twilio-video-app-react that app expects tracks to have a specific name ("camera...") or they are not shown to the user.

JS

P1 published video: camera-1628885877402 / MTa07a74a0dba384e88c38c216e037417b revision: 2 priority: low

iOS

P2 published video: Camera / MTaeafe6cd12d99ad1307fa2b7cdf62c81 revision: 1 priority: standard

Expected Behavior

Web users should be able to see video from participant using the iPad

Actual Behavior

No video ever shows

I see video flowing from iOS to JS for 10 seconds in RM619ce18ebc3d626795f3ebc68cec2c02 which you provided.

Let me know, Chris

zcjhnsn commented 2 years ago

@ceaglest Thank you so much for pointing us in that direction. We are using the example react application The default name for the Local Participant's video track is "Camera" but the react app is expecting "camera" lowercased. Perhaps an update to the QuickStart Application in ViewController.swift, line 222 would prevent some confusion in the future. Thanks again.

ceaglest commented 2 years ago

Excellent. This makes sense, and I filed an escalation so the team can evaluate if we are going to update the naming in the iOS example or better document the layout behavior in the JS app.