[cisco-voip] Virtual Telepresence Server droping conference voice calls

Thu May 4 13:28:01 EDT 2017

Hello All,

We are using Virtual Telepresence Server to make either conference and
video conference calls. We are facing problems when we have a external call
comming from PSTN and when we try to joinn this call to a conference this
call drops.

We have the following scenário

IOS voice Gateway IOS 12.24T
CUCM 11.0
vTS 4.2(4.23)
Conductor XC4.0

Our PSTN connection is a R2 digital and so:

PSTN ---R2D---> Gateway ----SIP----> CUCM ----SIP/TLS---->
Conductor-------> vTS

On the telepresence serve I can see the following logs

529 2017/05/04 12:24:15.734 APP                      Info      conference
"0010360100040x6c5eab929a5f3aa2" created
      530 2017/05/04 12:24:16.161 SIP                      Info
 Incoming call from 138.132.130.200:58111
      531 2017/05/04 12:24:16.162 APP                      Info      call
59: new incoming SIP call from "8633 at 138.132.129.147"
      532 2017/05/04 12:24:16.852 APP                      Info      call
59: "Phone Teste" now joined conference "0010360100040x6c5eab929a5f3aa2"
      533 2017/05/04 12:24:16.948 SIP                      Info
 Incoming call from 138.132.130.200:58111
      534 2017/05/04 12:24:16.949 APP                      Info      call
60: new incoming SIP call from "0985590026 at 138.132.129.147"
      535 2017/05/04 12:24:17.104 APP                      Info      call
60: "0985590026" now joined conference "0010360100040x6c5eab929a5f3aa2"
      536 2017/05/04 12:24:18.054 SIP                      Info
 Incoming call from 138.132.130.200:58111
      537 2017/05/04 12:24:18.055 APP                      Info      call
61: new incoming SIP call from "8691 at 138.132.129.147"
      538 2017/05/04 12:24:18.236 APP                      Info      call
61: "Nilson Costa" now joined conference "0010360100040x6c5eab929a5f3aa2"
      539 2017/05/04 12:24:20.096 SIP                      Error     call
60: Closing call due to failed reINVITE
      540 2017/05/04 12:24:20.096 CMGR                     Info      call
60: disconnecting, "0985590026 at 138.132.129.147" - capset error
      541 2017/05/04 12:24:20.096 APP                      Info      call
60: tearing down call from "0985590026" - destroy at far end request;
capabilityNegotiationError
      542 2017/05/04 12:24:20.420 CMGR                     Info      call
59: disconnecting, "8633 at 138.132.129.147"
      543 2017/05/04 12:24:20.420 APP                      Info      call
59: tearing down call from "Phone Teste" - destroy at far end request;
remoteTeardown
      544 2017/05/04 12:24:21.545 CMGR                     Info      call
61: disconnecting, "8691 at 138.132.129.147"
      545 2017/05/04 12:24:21.545 APP                      Info      call
61: tearing down call from "Nilson Costa" - destroy at far end request;
remoteTeardown
      546 2017/05/04 12:24:22.531 APP                      Info
 conference "0010360100040x6c5eab929a5f3aa2":  deleted via API (no
participants)

On conductor I see

2017-05-04T11:38:59-03:00 conferencefactory.controller: Level="INFO"
Event="A conference has been deleted."
Conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_unique_identifier="c7936d82e0d556f4250f361f1c0b3965c69da4f1"
Conference_bridge_address="138.132.130.195"
Conference_bridge_conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_bridge_UUID="488623ee-4cc8-4aa7-a3dc-11853bf8c1f1"
UTCTime="2017-05-04 14:38:59,84"
2017-05-04T11:38:58-03:00 conferencefactory.controller: Level="INFO"
Event="A conference has been marked for deletion."
Conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_unique_identifier="c7936d82e0d556f4250f361f1c0b3965c69da4f1"
Conference_bridge_address="138.132.130.195"
Conference_bridge_conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_bridge_UUID="488623ee-4cc8-4aa7-a3dc-11853bf8c1f1"
UTCTime="2017-05-04 14:38:58,845"
2017-05-04T11:38:58-03:00 conferencefactory.switchboard: Level="INFO"
Event="A management request has been received."
Command="conference.destroy" Conference_name="003036010011"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
UTCTime="2017-05-04 14:38:58,823"
2017-05-04T11:38:54-03:00 conferencefactory.controller: Level="INFO"
Event="A request to join a conference was successfully processed."
Conference_alias_description="LC_SPO_Ad-HOC"
Conference_alias_name="LC_SPO_Ad-HOC" Incoming_alias_match="(.*)@.*"
Conference_name_rule="\1" Conference_alias_UUID="adhoc_auto_gen"
Conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_template_name="CUCM Ad-Hoc SP Meeting"
Conference_template_UUID="b78f285a-a1a4-4189-ab5d-26a59a9ee111"
Destination-alias="003036010011 at 138.132.130.199"
Conference_unique_identifier="c7936d82e0d556f4250f361f1c0b3965c69da4f1"
Pre-configured_endpoint="False" Conference_bridge_address="138.132.130.195"
Conference_bridge_conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_bridge_UUID="488623ee-4cc8-4aa7-a3dc-11853bf8c1f1"
Participant_role="participant" Participant_type="Incoming ad-hoc"
Request_unique_identifier="663d6ede-30d7-11e7-b4ee-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
Source_protocol="SIP" Unauthenticated_source_aliases="[8691 at 138.132.129.146]"
UTCTime="2017-05-04 14:38:54,970"
2017-05-04T11:38:54-03:00 conferencefactory.controller: Level="INFO"
Event="A request has been received from a client for a participant to
create or join a conference." Destination-alias="
003036010011 at 138.132.130.199"
Request_unique_identifier="663d6ede-30d7-11e7-b4ee-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
Source_protocol="SIP" Unauthenticated_source_aliases="[8691 at 138.132.129.146]"
UTCTime="2017-05-04 14:38:54,950"
2017-05-04T11:38:53-03:00 conferencefactory.controller: Level="INFO"
Event="A request to join a conference was successfully processed."
Conference_alias_description="LC_SPO_Ad-HOC"
Conference_alias_name="LC_SPO_Ad-HOC" Incoming_alias_match="(.*)@.*"
Conference_name_rule="\1" Conference_alias_UUID="adhoc_auto_gen"
Conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_template_name="CUCM Ad-Hoc SP Meeting"
Conference_template_UUID="b78f285a-a1a4-4189-ab5d-26a59a9ee111"
Destination-alias="003036010011 at 138.132.130.199"
Conference_unique_identifier="c7936d82e0d556f4250f361f1c0b3965c69da4f1"
Pre-configured_endpoint="False" Conference_bridge_address="138.132.130.195"
Conference_bridge_conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_bridge_UUID="488623ee-4cc8-4aa7-a3dc-11853bf8c1f1"
Participant_role="participant" Participant_type="Incoming ad-hoc"
Request_unique_identifier="6589d7c0-30d7-11e7-b7e9-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
Source_protocol="SIP" Unauthenticated_source_aliases="[
0985590026 at 138.132.129.146]" UTCTime="2017-05-04 14:38:53,787"
2017-05-04T11:38:53-03:00 conferencefactory.controller: Level="INFO"
Event="A request has been received from a client for a participant to
create or join a conference." Destination-alias="
003036010011 at 138.132.130.199"
Request_unique_identifier="6589d7c0-30d7-11e7-b7e9-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
Source_protocol="SIP" Unauthenticated_source_aliases="[
0985590026 at 138.132.129.146]" UTCTime="2017-05-04 14:38:53,773"
2017-05-04T11:38:53-03:00 conferencefactory.controller: Level="INFO"
Event="A request to join a conference was successfully processed."
Conference_alias_description="LC_SPO_Ad-HOC"
Conference_alias_name="LC_SPO_Ad-HOC" Incoming_alias_match="(.*)@.*"
Conference_name_rule="\1" Conference_alias_UUID="adhoc_auto_gen"
Conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_template_name="CUCM Ad-Hoc SP Meeting"
Conference_template_UUID="b78f285a-a1a4-4189-ab5d-26a59a9ee111"
Destination-alias="003036010011 at 138.132.130.199"
Conference_unique_identifier="c7936d82e0d556f4250f361f1c0b3965c69da4f1"
Pre-configured_endpoint="False" Conference_bridge_address="138.132.130.195"
Conference_bridge_conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_bridge_UUID="488623ee-4cc8-4aa7-a3dc-11853bf8c1f1"
Participant_role="participant" Participant_type="Incoming ad-hoc"
Request_unique_identifier="65643447-30d7-11e7-9f87-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
Source_protocol="SIP" Unauthenticated_source_aliases="[8633 at 138.132.129.146]"
UTCTime="2017-05-04 14:38:53,542"
2017-05-04T11:38:53-03:00 conferencefactory.controller: Level="INFO"
Event="A request has been received from a client for a participant to
create or join a conference." Destination-alias="
003036010011 at 138.132.130.199"
Request_unique_identifier="65643447-30d7-11e7-9f87-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
Source_protocol="SIP" Unauthenticated_source_aliases="[8633 at 138.132.129.146]"
UTCTime="2017-05-04 14:38:53,527"
2017-05-04T11:38:53-03:00 conferencefactory.controller: Level="INFO"
Event="A conference has been successfully created on the conference bridge
and is ready to receive participants."
Conference_display_name="0030360100110x6c5eab929a5f3aa3"
Conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_template_name="CUCM Ad-Hoc SP Meeting"
Conference_unique_identifier="c7936d82e0d556f4250f361f1c0b3965c69da4f1"
Conference_bridge_address="138.132.130.195"
Conference_bridge_conference_name="0030360100110x6c5eab929a5f3aa3"
Conference_bridge_UUID="488623ee-4cc8-4aa7-a3dc-11853bf8c1f1"
Process_time="0.131369898096"
Request_unique_identifier="65461d1e-30d7-11e7-99dd-55a476ff1b76"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
UTCTime="2017-05-04 14:38:53,461"
2017-05-04T11:38:53-03:00 conferencefactory.controller: Level="WARNING"
Event="An API request was made to create a conference using a non-scheduled
conference template; the factory.conferencecreate request may fail if the
conference has already started." Conference_template_name="CUCM Ad-Hoc SP
Meeting" UTCTime="2017-05-04 14:38:53,333"
2017-05-04T11:38:53-03:00 conferencefactory.switchboard: Level="INFO"
Event="A management request has been received." Command="conference.create"
Conference_name="003036010011"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
UTCTime="2017-05-04 14:38:53,311"
2017-05-04T11:38:37-03:00 conferencefactory.switchboard: Level="INFO"
Event="A management request has been received." Command="device.query"
Requester_(VCS/Unified_CM/client)_address="138.132.129.146"
UTCTime="2017-05-04 14:38:37,917"
2017-05-04T11:38:23-03:00 syslog-ng[1167]: Configuration reload request
received, reloading configuration;
2017-05-04T11:38:23-03:00 syslog-ng[1167]: Syslog connection established;
fd='21', server='AF_INET(138.132.130.190:514)', local='AF_INET(0.0.0.0:0)'

Can someone help me solving this issue?

Regards

-- 
Nilson Lino da Costa Junior
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://puck.nether.net/pipermail/cisco-voip/attachments/20170504/afde1716/attachment.html>