MicrosoftDocs / msteams-docs

Source for the Microsoft Teams developer platform documentation.
https://aka.ms/teamsdev
Creative Commons Attribution 4.0 International
288 stars 511 forks source link

Audio Video Bot Teams call join fails "MediaControllerConversationAddParticipantFailed" #1930

Closed harishvadali closed 4 years ago

harishvadali commented 4 years ago

Hello,

Having issues with Audio Video Bot joining the Teams call. Sometimes it goes straight to terminated with "MediaControllerConversationAddParticipantFailed" reason and sometimes shows established and then shows terminated with "IceConnectivityChecksFailed. DiagCode: 500#1004" reason. I double checked ports mapping and certificate. I have the Audio Video Bot running in a docker container on AWS. Any pointers would be helpful. Thanks!

$>2020-07-29T02:34:07.8608214Z Info: CommunicationsClientExtensions.cs:151 LogAndCreateResponse
ScenarioId: e50c9956-978b-4344-bffc-5af8decadf88
AppId: e8459a67-c315-445f-abf4-588c8da4bdb5
AppName: Sample.AudioVideoPlaybackBot.FrontEnd
TransactionDirection: Incoming
TraceType: HttpRequest
request: POST https://dev-signaling.vci.vbrickrev.com:2001/api/calling
headers:
  X-Forwarded-For: (redacted)
  X-Forwarded-Proto: https
  X-Forwarded-Port: (redacted)
  X-Amzn-Trace-Id: (redacted)
  X-Microsoft-Skype-Chain-ID: d9cd0e24-05bf-40ef-9c03-f133485889c0
  Scenario-Id: e50c9956-978b-4344-bffc-5af8decadf88
  X-Microsoft-Skype-Message-ID: 1aad2e9f-bc99-4010-9a2b-afaefc0fb2d7
  Accept: application/json
  Authorization: (redacted)
  Host: dev-signaling.vci.vbrickrev.com:2001
  User-Agent: Microsoft-Skype/3.0,(Calling/1.0)
  Content-Length: 977
  Content-Type: application/json
{
  "@odata.type": "#microsoft.graph.commsNotifications",
  "value": [
    {
      "@odata.type": "#microsoft.graph.commsNotification",
      "changeType": "deleted",
      "resourceUrl": "/communications/calls/b51f0400-401f-4d3d-b282-dfd92ac922a5",
      "resource": "/app/calls/b51f0400-401f-4d3d-b282-dfd92ac922a5",
      "resourceData": {
        "@odata.type": "#microsoft.graph.call",
        "state": "terminated",
        "resultInfo": {
          "@odata.type": "#microsoft.graph.resultInfo",
          "code": 500,
          "subcode": 7112,
          "message": "MediaControllerConversationAddParticipantFailed"
        },
        "chatInfo": {
          "@odata.type": "#microsoft.graph.chatInfo",
          "threadId": "19:meeting_N2QyNDIzNjUtNzhhYS00NmM1LTg4ZDctZThjNmEzMmY4YjRh@thread.v2",
          "messageId": "0"
        },
        "meetingInfo": {
          "@odata.type": "#microsoft.graph.organizerMeetingInfo",
          "organizer": {
            "@odata.type": "#microsoft.graph.identitySet",
            "user": {
              "@odata.type": "#microsoft.graph.identity",
              "id": "4e3601bb-a8bd-488a-ba8d-bbcb89409471",
              "tenantId": "24ed0676-67e2-4293-a8d4-28937fdb3247"
            }
          }
        },
        "tenantId": "24ed0676-67e2-4293-a8d4-28937fdb3247",
        "callChainId": "d9cd0e24-05bf-40ef-9c03-f133485889c0",
        "id": "b51f0400-401f-4d3d-b282-dfd92ac922a5"
      }
    }
  ]
}
$>2020-07-29T02:33:47.5274770Z Info: CommunicationsClientExtensions.cs:151 LogAndCreateResponse
ScenarioId: e50c9956-978b-4344-bffc-5af8decadf88
AppId: e8459a67-c315-445f-abf4-588c8da4bdb5
AppName: Sample.AudioVideoPlaybackBot.FrontEnd
TransactionDirection: Incoming
TraceType: HttpRequest
request: POST https://dev-signaling.vci.vbrickrev.com:2001/api/calling
headers:
  X-Forwarded-For: (redacted)
  X-Forwarded-Proto: https
  X-Forwarded-Port: (redacted)
  X-Amzn-Trace-Id: (redacted)
  X-Microsoft-Skype-Chain-ID: d9cd0e24-05bf-40ef-9c03-f133485889c0
  Scenario-Id: e50c9956-978b-4344-bffc-5af8decadf88
  X-Microsoft-Skype-Message-ID: 19bd0a85-5759-4ea3-9d2f-ab97faf608ca
  Accept: application/json
  Authorization: (redacted)
  Host: dev-signaling.vci.vbrickrev.com:2001
  User-Agent: Microsoft-Skype/3.0,(Calling/1.0)
  Content-Length: 834
  Content-Type: application/json
{
  "@odata.type": "#microsoft.graph.commsNotifications",
  "value": [
    {
      "@odata.type": "#microsoft.graph.commsNotification",
      "changeType": "updated",
      "resourceUrl": "/communications/calls/b51f0400-401f-4d3d-b282-dfd92ac922a5",
      "resource": "/app/calls/b51f0400-401f-4d3d-b282-dfd92ac922a5",
      "resourceData": {
        "@odata.type": "#microsoft.graph.call",
        "state": "establishing",
        "chatInfo": {
          "@odata.type": "#microsoft.graph.chatInfo",
          "threadId": "19:meeting_N2QyNDIzNjUtNzhhYS00NmM1LTg4ZDctZThjNmEzMmY4YjRh@thread.v2",
          "messageId": "0"
        },
        "meetingInfo": {
          "@odata.type": "#microsoft.graph.organizerMeetingInfo",
          "organizer": {
            "@odata.type": "#microsoft.graph.identitySet",
            "user": {
              "@odata.type": "#microsoft.graph.identity",
              "id": "4e3601bb-a8bd-488a-ba8d-bbcb89409471",
              "tenantId": "24ed0676-67e2-4293-a8d4-28937fdb3247"
            }
          }
        },
        "tenantId": "24ed0676-67e2-4293-a8d4-28937fdb3247",
        "callChainId": "d9cd0e24-05bf-40ef-9c03-f133485889c0",
        "id": "b51f0400-401f-4d3d-b282-dfd92ac922a5"
      }
    }
  ]
}
$>2020-07-29T02:33:47.4180962Z Info: GraphAuthClient.cs:153 SendHttpRequestAsync
ScenarioId: e50c9956-978b-4344-bffc-5af8decadf88
AppId: e8459a67-c315-445f-abf4-588c8da4bdb5
AppName: Sample.AudioVideoPlaybackBot.FrontEnd
TransactionDirection: Outgoing
TraceType: HttpResponse
ResponseTime: 275
request: POST https://graph.microsoft.com/v1.0/communications/calls
response: 201 Created
headers:
  request-id: 1609e902-448a-4e6c-8fd2-e548ccf334e3
  client-request-id: 012064cb-317a-4bc9-bf44-c2f7c2ac21b9
  x-ms-ags-diagnostic: {"ServerInfo":{"DataCenter":"East US","Slice":"SliceC","Ring":"5","ScaleUnit":"002","RoleInstance":"AGSFE_IN_14"}}
  scenario-id: e50c9956-978b-4344-bffc-5af8decadf88
  OData-Version: 4.0
  Strict-Transport-Security: max-age=31536000
  Cache-Control: private
  Date: Wed, 29 Jul 2020 02:33:46 GMT
  Location: https://graph.microsoft.com/v1.0/communications/calls/b51f0400-401f-4d3d-b282-dfd92ac922a5
  Content-Length: 3122
  Content-Type: application/json; odata.metadata=minimal; odata.streaming=true; IEEE754Compatible=false; charset=utf-8
{
  "@odata.type": "#microsoft.graph.call",
  "state": "establishing",
  "direction": "outgoing",
  "callbackUri": "https://dev-signaling.vci.vbrickrev.com:2001/api/calling",
  "callRoutes": [],
  "source": {
    "@odata.type": "#microsoft.graph.participantInfo",
    "identity": {
      "@odata.type": "#microsoft.graph.identitySet",
      "application": {
        "@odata.type": "#microsoft.graph.identity",
        "displayName": "(Identity: /BcgPS9D)",
        "id": "e8459a67-c315-445f-abf4-588c8da4bdb5"
      },
      "acsUser": null,
      "spoolUser": null,
      "phone": null,
      "guest": null,
      "encrypted": null,
      "onPremises": null,
      "acsApplicationInstance": null,
      "spoolApplicationInstance": null,
      "applicationInstance": null
    }
  },
  "targets": [],
  "requestedModalities": [
    "audio",
    "video",
    "videoBasedScreenSharing"
  ],
  "mediaConfig": {
    "@odata.type": "#microsoft.graph.appHostedMediaConfig",
    "blob": "{\"mpUri\":\"net.tcp://dev-media.vci.vbrickrev.com:2001/MediaProcessor\",\"audioRenderContexts\":[\"4b8fc7ed-987b-4a97-9dd4-30442f71e244\"],\"videoRenderContexts\":[\"13dbc7ad-7d89-4da7-a6e4-f3d5166b681e\",\"f8616ac7-491a-47a4-8b92-0335f3ec1dd3\",\"8be9fa83-bbd2-4336-ae30-b96d19ab3ab1\",\"aa2b43af-d2ef-43a8-881d-822eeb5eb95d\"],\"vbssRenderContexts\":[\"59f61462-f3da-4beb-b520-0dd413067c34\"],\"audioSourceContexts\":[\"3dc1fafd-93a6-4afc-99c4-5b99ef1fb8e0\"],\"videoSourceContexts\":[\"8859a4fa-375b-45c8-bdf9-717f2dd17ac6\"],\"vbssSourceContexts\":[\"a3dc6d80-8613-4baf-a9b8-1a0472bdafc9\"],\"dataRenderContexts\":null,\"dataSourceContexts\":null,\"supportedAudioFormat\":\"Pcm16K\",\"videoSinkEncodingFormats\":[\"H264\",\"H264\",\"H264\",\"H264\"],\"vbssSinkEncodingFormats\":[\"H264\"],\"initialScreenSharingRole\":\"Viewer\",\"mpMediaSessionId\":\"bb08f0a4-f3d5-40aa-b930-08a67c5b5c8f\",\"regionAffinity\":null,\"skypeMediaBotsVersion\":\"1.17.0.0039\",\"mediaStackVersion\":\"2020.7.1.12\",\"mpVersion\":\"7.2.0.7736\",\"callId\":\"155da172-fe99-4dcb-b548-badcb012e1cf\"}"
  },
  "chatInfo": {
    "@odata.type": "#microsoft.graph.chatInfo",
    "threadId": "19:meeting_N2QyNDIzNjUtNzhhYS00NmM1LTg4ZDctZThjNmEzMmY4YjRh@thread.v2",
    "messageId": "0"
  },
  "callOptions": {
    "@odata.type": "#microsoft.graph.outgoingCallOptions",
    "allowGuestToBypassLobby": null
  },
  "meetingInfo": {
    "@odata.type": "#microsoft.graph.organizerMeetingInfo",
    "organizer": {
      "@odata.type": "#microsoft.graph.identitySet",
      "user": {
        "@odata.type": "#microsoft.graph.identity",
        "id": "4e3601bb-a8bd-488a-ba8d-bbcb89409471",
        "tenantId": "24ed0676-67e2-4293-a8d4-28937fdb3247"
      },
      "acsUser": null,
      "spoolUser": null,
      "phone": null,
      "guest": null,
      "encrypted": null,
      "onPremises": null,
      "acsApplicationInstance": null,
      "spoolApplicationInstance": null,
      "applicationInstance": null
    },
    "allowConversationWithoutHost": null,
    "lobbyBypass": null
  },
  "tenantId": "24ed0676-67e2-4293-a8d4-28937fdb3247",
  "myParticipantId": "7535200b-6e74-48d0-9bd8-cdd38ef456e2",
  "callChainId": "d9cd0e24-05bf-40ef-9c03-f133485889c0",
  "id": "b51f0400-401f-4d3d-b282-dfd92ac922a5",
  "@odata.context": "https://graph.microsoft.com/v1.0/$metadata#communications/calls/$entity",
  "transferState": null,
  "terminationReason": null,
  "ringingTimeoutInSeconds": null,
  "activeModalities": [],
  "routingPolicies": [],
  "answeredBy": null,
  "transcriptionInfo": null,
  "meetingCapability": null,
  "terminationSender": null
}
ghost commented 4 years ago

Hi harishvadali! Thank you for bringing this issue to our attention. We will investigate and if we require further information we will reach out. Best regards, Teams Platform

harishvadali commented 4 years ago

Got it working after opening outbound UDP traffic. Is there any specific port range or configurable range instead of opening for all UDP traffic?