Buy or Renew
Buy or Renew
Cisco + Splunk: It’s a new day for your data. Learn more.
 
cancel
Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
Showing results for 
Search instead for 
Did you mean: 
cancel
Start a conversation
1347
Views
0
Helpful
8
Replies

inbound 8710 dialing issues

Go to solution
watkins.david
Level 1
Level 1

‎09-04-2012 07:13 PM - edited ‎03-17-2019 11:43 PM

I have a 8710 that is registered to vcs (x7.1) with a sip trunk to CUCM(8.6) where my CTS rooms are registered.

Calling from the 8710 to the CTS rooms work fine, but dialing a conference room on the 8710 from the CTS endpoint does not work.

SIP packet sniff from TS endpoint shows a 'internal server error"

The 8710 reports the endpoint connecting, and then immediately disconnected.

I have the DN numbers used fro the call-in match paramenters'

I seem to get random errors from VCS; ie, call leg does not exist, request termination, etc.

ANyone have any idea what this might be?                  

Labels:
0 Helpful
1 Accepted Solution

Accepted Solutions

Go to solution
Paul Anholt
Cisco Employee
Cisco Employee
In response to watkins.david

‎09-05-2012 04:59 PM

Hi David,

You're hitting the bug CSCty07061 which is resolved in CUCM 9.0 and some engineering specials on the 8.6.2 train.

As a workaround you can create a bogus A Record so the resolution will work.

-Paul

Sent from Cisco Technical Support iPad App

View solution in original post

0 Helpful
8 Replies 8

Go to solution
Patrick Pettit
Cisco Employee
Cisco Employee

‎09-05-2012 04:19 AM

HI David.  Would be curious to know the versions on the CTS.  From 1.7.4 or higher, you don't need to add the CTS's as endpoints in the TS. 

Also, its important, if multiple screen CTS's are being used, its important to keep the call SIP to SIP without any interworking being involved here as some information is passed in the SIP headers to define the system as 3 screen system, single screen etc. 

If the call is SIP to SIP, and its still failing, would be interested in seeing network log debug from VCS, and SIP log from TS to see what may be going on here. 

If you can provide it, would be nice to see. 

VR

Patrick

0 Helpful

Go to solution
watkins.david
Level 1
Level 1
In response to Patrick Pettit

‎09-05-2012 08:54 AM

                   1.8.2 is the code rev for th CTS endpoints

attached are the TS SIP logs

and here are the VCS network logs for anything coming from the cucm

Sep 5 09:49:13tvcs: UTCTime="2012-09-05 15:49:13,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=69576a185bb9b2c6@10.52.36.14"
Sep 5 09:49:13tvcs: UTCTime="2012-09-05 15:49:13,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=69576a185bb9b2c6@10.52.36.14"
Sep 5 09:48:42tvcs: UTCTime="2012-09-05 15:48:42,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=19810c4b32d41f39@10.52.36.14"
Sep 5 09:48:42tvcs: UTCTime="2012-09-05 15:48:42,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=19810c4b32d41f39@10.52.36.14"
Sep 5 09:48:12tvcs: UTCTime="2012-09-05 15:48:12,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=d726f682248dc0fe@10.52.36.14"
Sep 5 09:48:12tvcs: UTCTime="2012-09-05 15:48:12,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=d726f682248dc0fe@10.52.36.14"
Sep 5 09:47:42tvcs: UTCTime="2012-09-05 15:47:42,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=47c0916ae836f746@10.52.36.14"
Sep 5 09:47:42tvcs: UTCTime="2012-09-05 15:47:42,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=47c0916ae836f746@10.52.36.14"
Sep 5 09:47:11tvcs: UTCTime="2012-09-05 15:47:11,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=2309b4232bb47ac3@10.52.36.14"
Sep 5 09:47:11tvcs: UTCTime="2012-09-05 15:47:11,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=2309b4232bb47ac3@10.52.36.14"
Sep 5 09:46:41tvcs: UTCTime="2012-09-05 15:46:41,270" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=06f96859b7a02237@10.52.36.14"
Sep 5 09:46:41tvcs: UTCTime="2012-09-05 15:46:41,269" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=06f96859b7a02237@10.52.36.14"
Sep 5 09:46:09tvcs: UTCTime="2012-09-05 15:46:09,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=c4568d50b00b8791@10.52.36.14"
Sep 5 09:46:09tvcs: UTCTime="2012-09-05 15:46:09,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=c4568d50b00b8791@10.52.36.14"
Sep 5 09:45:38tvcs: UTCTime="2012-09-05 15:45:38,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=c322adffdcb056e9@10.52.36.14"
Sep 5 09:45:38tvcs: UTCTime="2012-09-05 15:45:38,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=c322adffdcb056e9@10.52.36.14"
Sep 5 09:45:07tvcs: UTCTime="2012-09-05 15:45:07,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=cb180fe914a02584@10.52.36.14"
Sep 5 09:45:07tvcs: UTCTime="2012-09-05 15:45:07,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=cb180fe914a02584@10.52.36.14"
Sep 5 09:44:37tvcs: UTCTime="2012-09-05 15:44:37,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=4ccb3ed42afa2b1e@10.52.36.14"
Sep 5 09:44:37tvcs: UTCTime="2012-09-05 15:44:37,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=4ccb3ed42afa2b1e@10.52.36.14"
Sep 5 09:44:17tvcs: UTCTime="2012-09-05 15:44:17,026" Module="network.sip" Level="INFO": Dst-ip="10.52.36.15" Dst-port="25011" Detail="Sending Response Code=481, Method=BYE, To=sip:3711@10.52.36.12, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:17tvcs: UTCTime="2012-09-05 15:44:17,018" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=481, Method=BYE, To=sip:3711@10.52.36.12, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:17tvcs: UTCTime="2012-09-05 15:44:17,017" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=BYE, Request-URI=sip:3711@10.52.36.12:5060;transport=tcp, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:17tvcs: UTCTime="2012-09-05 15:44:17,016" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="25011" Detail="Receive Request Method=BYE, Request-URI=sip:3711@10.52.36.12:5060;transport=tcp, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:16tvcs: UTCTime="2012-09-05 15:44:16,355" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:16tvcs: UTCTime="2012-09-05 15:44:16,354" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:12tvcs: UTCTime="2012-09-05 15:44:12,354" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:12tvcs: UTCTime="2012-09-05 15:44:12,353" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:08tvcs: UTCTime="2012-09-05 15:44:08,353" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:08tvcs: UTCTime="2012-09-05 15:44:08,352" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:07tvcs: UTCTime="2012-09-05 15:44:07,269" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="5060" Detail="Receive Response Code=200, Method=OPTIONS, To=sip:10.52.36.12:5060, Call-ID=ab14822edbe6470c@10.52.36.14"
Sep 5 09:44:07tvcs: UTCTime="2012-09-05 15:44:07,268" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Request Method=OPTIONS, Request-URI=sip:10.52.36.12:5060;transport=tcp, Call-ID=ab14822edbe6470c@10.52.36.14"
Sep 5 09:44:04tvcs: UTCTime="2012-09-05 15:44:04,352" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:04tvcs: UTCTime="2012-09-05 15:44:04,351" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:02tvcs: UTCTime="2012-09-05 15:44:02,351" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:02tvcs: UTCTime="2012-09-05 15:44:02,350" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:01tvcs: UTCTime="2012-09-05 15:44:01,350" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="5060" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:01tvcs: UTCTime="2012-09-05 15:44:01,349" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,859" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="38810" Detail="Sending Response Code=481, Method=CANCEL, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,859" Module="network.sip" Level="INFO": Src-ip="10.52.36.12" Src-port="38810" Detail="Receive Request Method=CANCEL, Request-URI=sip:511001@VCS-CC.uc.supervalu.com:5060, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,857" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="38810" Detail="Sending Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,850" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=200, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,768" Module="network.sip" Level="INFO": Dst-ip="10.52.36.12" Dst-port="38810" Detail="Sending Response Code=180, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,761" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=180, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,650" Module="network.sip" Level="INFO": Src-ip="10.52.36.15" Src-port="5061" Detail="Receive Response Code=100, Method=INVITE, To=sip:511001@VCS-CC.uc.supervalu.com, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,646" Module="network.sip" Level="INFO": Dst-ip="10.52.36.15" Dst-port="5061" Detail="Sending Request Method=INVITE, Request-URI=sip:511001@uc.supervalu.com:5060;registration-serial-number=c7cb3662-f6f9-11e1-a634-0010f3210632, Call-ID=818a6580-4717340-6f687-c24340a@10.52.36.12"
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,612" Module="network.h323" Level="INFO": Dst-ip="10.52.36.15" Dst-port="1719"
Detail="Sending RAS LRQ SeqNum=57306 DestAlias='511001' SrcAlias='3711@10.52.36.12' Hopcount=1 "
Sep 5 09:44:00tvcs: UTCTime="2012-09-05 15:44:00,611" Module="network.h323" Level="INFO": Dst-ip="10.52.36.15" Dst-port="1719"
Detail="Sending RAS LRQ SeqNum=57305 DestAlias='511001@uc.supervalu.com:5060' SrcAlias='3711@10.52.36.12' Hopcount=1 "
Preview file
148 KB
0 Helpful

Go to solution
Patrick Pettit
Cisco Employee
Cisco Employee
In response to watkins.david

‎09-05-2012 09:57 AM

Hi David.

Seems the TS is constantly sending 200 Ok with SDP, but not getting an ACK back to start the call from the CUCM side perhaps.  If you can, would need to confirm that the VCS is sending the 200 OK with SDP to the CUCM side, and would be interested in seeing if the CUCM is receiving it, and sending the ACK back to finish the call. 

If you go to Maintanance>Diagnostics>Diagnostic Logging and set Network Log Level to Debug, and place the same call, this would show us the comms between the TS and the CUCM. 

I'm wondering also if the CCM can't process the large SDP from the TS at the beginning here. 

http://www.cisco.com/en/US/docs/telepresence/infrastructure/vcs/config_guide/Cisco_VCS_and_CUCM_Deployment_Guide_CUCM_6-1_7_8_and_X7-1.pdf

See Page 28 of 53.  Can you verify the SIP MAX Incoming Message Size is increased here?  I'd check here to see if this may be causing you your problem, and if this is set right, and it still fails, would need to see the network log level debug from the VCS. 

VR

Patrick

0 Helpful

Go to solution
watkins.david
Level 1
Level 1
In response to watkins.david

‎09-05-2012 10:16 AM

i did change the SIP max incoming from 5000 to 12000. Calls still dont complete however.

0 Helpful

Go to solution
Patrick Pettit
Cisco Employee
Cisco Employee
In response to watkins.david

‎09-05-2012 10:19 AM

HI David.  Sounds good.  If you can, would you be able to post the log, network log level set to debug on the diagnostics page would be helpful.  Turn it on to debug, place the call, and lets take a look at the log so we can see whats happening. 

Thanks. 

VR

Patrick

0 Helpful

Go to solution
watkins.david
Level 1
Level 1
In response to Patrick Pettit

‎09-05-2012 04:29 PM

            I also tried using the vcs-interop normalization script, to no avail

Looked at this with my call manager expert and it appears that its the CM that is hanging up the call. from the RTMT it looks like a dns query is failing, and then the SIP timer expires:

|2,100,63,1.3508793^10.52.36.15^*

11:20:09.377 |//SIP/SIPDns(2,72,1)/wait_SdlDnsSrvRecordRsp: Received SdlDnsSrvRecordRsp ReqCode is  -1|0,0,0,0.0^*^*

11:20:09.377 |//SIP/SIPDns(2,72,1)/copyRecordRspToRecordReq: Retry SRV query as an 1 query|0,0,0,0.0^*^*

11:20:09.377 |//SIP/SIPDns(2,72,1)/wait_SdlDnsSrvRecordRsp: (DNS A or AAAA query called as SRV query Fail):hostname=uc.supervalu.com

Contact: <sip:511001@uc.supervalu.com;gr=urn:uuid:b716ad28-2312-54db- 825f-4aca99cade58>;isfocus;x-cisco-tip

|2,100,63,1.3508793^10.52.36.15^*

11:20:09.377 |//SIP/SIPDns(2,72,1)/wait_SdlDnsSrvRecordRsp: Received SdlDnsSrvRecordRsp ReqCode is  -1|0,0,0,0.0^*^*

11:20:09.377 |//SIP/SIPDns(2,72,1)/copyRecordRspToRecordReq: Retry SRV query as an 1 query|0,0,0,0.0^*^*

11:20:09.377 |//SIP/SIPDns(2,72,1)/wait_SdlDnsSrvRecordRsp: (DNS A or AAAA query called as SRV query Fail):hostname=uc.supervalu.com

not sure where its trying to get uc.supervalu.com as that is a domain not a hostname.

After a couple more hours of troubleshooting he suggested that its from this:

Contact: <sip:511001@uc.supervalu.com;gr=urn:uuid:b716ad28-2312-54db- 825f-4aca99cade58>;isfocus;x-cisco-tip

in the header, which is not received when dialing a jabber client.

134499-CTS-8710-not-working.txt.zip
0 Helpful

Go to solution
Paul Anholt
Cisco Employee
Cisco Employee
In response to watkins.david

‎09-05-2012 04:59 PM

Hi David,

You're hitting the bug CSCty07061 which is resolved in CUCM 9.0 and some engineering specials on the 8.6.2 train.

As a workaround you can create a bogus A Record so the resolution will work.

-Paul

Sent from Cisco Technical Support iPad App

0 Helpful

Go to solution
watkins.david
Level 1
Level 1
In response to Paul Anholt

‎09-06-2012 01:52 PM

bogus A record pointing at my vcs seems to have done the trick, thanks!

0 Helpful
Getting Started

Find answers to your questions by entering keywords or phrases in the Search bar above. New here? Use these resources to familiarize yourself with the community:

Customers Also Viewed These Support Documents