cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
1342
Views
0
Helpful
6
Replies

E20 won't register to VCS demo

robb.ritchey
Level 1
Level 1

I've installed VCS using the  'Single VCS Control Deployment Guide' for 7.2.2.  After following the  directions, I'm unable to register an E20 to VCS.  Below are the network  logs from VCS.

2013-07-01T18:39:23-04:00    tvcs: UTCTime="2013-07-01 22:39:23,056" Module="network.sip" Level="INFO": Dst-ip="10.10.1.56" Dst-port="57531" Detail="Sending Response Code=404, Method=SUBSCRIBE, To=sip:provisioning@mydomain.com, Call-ID=0f11da9ae013fe17@10.10.1.56"
2013-07-01T18:39:23-04:00    tvcs: UTCTime="2013-07-01 22:39:23,055" Module="network.search" Level="INFO": Detail="Considering search rule 'Local zone – full URI' towards target 'LocalZone' at priority '50' with alias 'cisco@mydomain.com'"
2013-07-01T18:39:23-04:00    tvcs: UTCTime="2013-07-01 22:39:23,054" Module="network.search" Level="INFO": Detail="Considering search rule 'LocalZoneMatch' towards target 'LocalZone' at priority '50' with alias 'cisco@mydomain.com'"
2013-07-01T18:39:23-04:00    tvcs: UTCTime="2013-07-01 22:39:23,053" Module="network.search" Level="INFO": Detail="Considering search rule 'Local zone – no domain' towards target 'LocalZone' at priority '48' with alias 'cisco'"
2013-07-01T18:39:23-04:00    tvcs: UTCTime="2013-07-01 22:39:23,050" Module="network.ldap" Level="INFO": Detail="Authentication credential found in directory for identity: cisco"
2013-07-01T18:39:23-04:00    tvcs: UTCTime="2013-07-01 22:39:23,046" Module="network.sip" Level="INFO": Src-ip="10.10.1.56" Src-port="57531" Detail="Receive Request Method=SUBSCRIBE, Request-URI=sip:cisco@mydomain.com, Call-ID=0f11da9ae013fe17@10.10.1.56"

I haven't been able to determine the meaning of response code 404.

Thanks,

Robb R.

6 Replies 6

Alok Jaiswal
Cisco Employee
Cisco Employee

Hi Robb,

the initial subscribe message sent by E-20 is not matching to any of the search rule on the VCS and hence it send 404 not found which means server can't find the requested destination.

check the search rules, transforms you created.

Rgds

Alok

Alok,

Any suggestions as to what search rules I may need to configure?  I've configured the ones beginning on page 12 of the deployment guide below.

http://www.cisco.com/en/US/docs/telepresence/infrastructure/vcs/config_guide/Cisco_VCS_Basic_Configuration_Single_VCS_Control_Deployment_Guide_X7-2.pdf

Thanks!

Robb R.

Hi Robb,

can you paste the whole log, i mean to say the snippet you posted above starts with VCS sending 404 message.

i want to see what is happening when the VCS is receives the first subscribe message. does it goes in some search then it sends 404 message.

Please post the whole set of logs and let me know what search rules you have configured on the VCS?

Rgds

Alok

Alok, below are the only logs recorded by VCS when I attempt to connect.  The top entry is the most recent.  Below are screenshots of my Transform and Search rules.

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,889" Module="network.sip" Level="INFO": Dst-ip="10.254.0.5" Dst-port="59373" Detail="Sending Response Code=404, Method=SUBSCRIBE, To=sip:provisioning@mydomain.com, Call-ID=a0df36ba0e5130cc@127.0.0.1"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,887" Module="network.search" Level="INFO": Detail="Considering search rule 'Local zone – full URI' towards target 'LocalZone' at priority '49' with alias 'cisco@mydomain.com'"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,886" Module="network.search" Level="INFO": Detail="Considering search rule 'Local zone – no domain' towards target 'LocalZone' at priority '48' with alias 'cisco'"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,883" Module="network.ldap" Level="INFO": Detail="Authentication credential found in directory for identity: cisco"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,879" Module="network.sip" Level="INFO": Src-ip="10.254.0.5" Src-port="59373" Detail="Receive Request Method=SUBSCRIBE, Request-URI=sip:cisco@mydomain.com, Call-ID=a0df36ba0e5130cc@127.0.0.1"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,827" Module="network.sip" Level="INFO": Dst-ip="10.254.0.5" Dst-port="59373" Detail="Sending Response Code=407, Method=SUBSCRIBE, To=sip:provisioning@mydomain.com, Call-ID=a0df36ba0e5130cc@127.0.0.1"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,827" Module="network.sip" Level="INFO": Src-ip="10.254.0.5" Src-port="59373" Detail="Receive Request Method=SUBSCRIBE, Request-URI=sip:cisco@mydomain.com, Call-ID=a0df36ba0e5130cc@127.0.0.1"

Transform Rule:

Search Rule 1:

Search Rule 2:

Search Rule 3:

Hi Robb,

i am getting confused with the below two lines

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,889" Module="network.sip" Level="INFO": Dst-ip="10.254.0.5" Dst-port="59373" Detail="Sending Response Code=404, Method=SUBSCRIBE, To=sip:

provisioning@mydomain.com

,

Call-ID=a0df36ba0e5130cc@127.0.0.1

"

2013-07-02T09:21:50-04:00    tvcs: UTCTime="2013-07-02 13:21:50,827" Module="network.sip" Level="INFO": Dst-ip="10.254.0.5" Dst-port="59373" Detail="Sending Response Code=407, Method=SUBSCRIBE, To=sip:

provisioning@mydomain.com

,

Call-ID=a0df36ba0e5130cc@127.0.0.1

"

one time the reply is 404 i.e. not found and one time it is 407 which basically is asking for authentication.

anyways one more thing why you have search rules 49 & 48 with ".+" and why not ".*". can you change it to ".*@mydomain.com.*" and check again.

Also can you pull the diagnostic logs from the VCS in debug mode and see what happens after the first subscribe message.

Rgds

Alok

Thanks Alok.  The authentication (407) request is generated before the 404.  Here's the debug output.  I had to run this test with the Jabber Video (Movi) client as I don't currently have access to the E20.  I also changed the .+ to .* with the same result.

2013-07-02T14:08:52-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:52,355" Module="network.tcp" Level="DEBUG":  Src-ip="10.254.0.7" Src-port="62338" Dst-ip="10.10.2.100" Dst-port="5061" Detail="TCP Connecting"

2013-07-02T14:08:52-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:52,356" Module="network.tcp" Level="DEBUG":  Src-ip="10.254.0.7" Src-port="62338" Dst-ip="10.10.2.100" Dst-port="5061" Detail="TCP Connection Established"

2013-07-02T14:08:52-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:52,784" Module="network.sip" Level="INFO":  Src-ip="10.254.0.7"  Src-port="62338"   Detail="Receive Request Method=SUBSCRIBE, Request-URI=sip:cisco@mydomain.com, Call-ID=6af0c6f351e86ac8@127.0.0.1"

2013-07-02T14:08:52-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:52,784" Module="network.sip" Level="DEBUG":  Src-ip="10.254.0.7"  Src-port="62338"

SIPMSG:

|SUBSCRIBE sip:cisco@mydomain.com SIP/2.0

Via: SIP/2.0/TLS 10.254.0.7:62338;branch=z9hG4bK41804a1eee2152f9366168960169b367.1;received=10.254.0.7;rport=62338

Call-ID: 6af0c6f351e86ac8@127.0.0.1

CSeq: 201 SUBSCRIBE

Contact:

From: <>cisco@mydomain.com>;tag=fa9d28431f16d75c

To: <>provisioning@mydomain.com>

Max-Forwards: 70

Route: <10.10.2.100:5061>

User-Agent: TANDBERG/774 (MCX 4.6.3.17194) - Windows

Expires: 300

Event: ua-profile;model=movi;vendor=tandberg.com;profile-type=user;version=4.6.3.17194;clientid="S-1-5-21-3537420569-697092696-2587007096";connectivity=0

Accept: application/pidf+xml

Content-Length: 0

|

2013-07-02T14:08:52-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:52,785" Module="network.sip" Level="INFO":  Dst-ip="10.254.0.7"  Dst-port="62338"   Detail="Sending Response Code=407, Method=SUBSCRIBE, To=sip:provisioning@mydomain.com, Call-ID=6af0c6f351e86ac8@127.0.0.1"

2013-07-02T14:08:52-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:52,785" Module="network.sip" Level="DEBUG":  Dst-ip="10.254.0.7"  Dst-port="62338"

SIPMSG:

|SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/TLS 10.254.0.7:62338;branch=z9hG4bK41804a1eee2152f9366168960169b367.1;received=10.254.0.7;rport=62338

Call-ID: 6af0c6f351e86ac8@127.0.0.1

CSeq: 201 SUBSCRIBE

From: <>cisco@mydomain.com>;tag=fa9d28431f16d75c

To: <>provisioning@mydomain.com>;tag=97504018f194617b

Server: TANDBERG/4120 (X7.2.2)

Proxy-Authenticate: Digest realm="vcs.mydomain.com", nonce="734622e4a24a70910f7e67b2080ef8bdb56021e396546aa2be572fd76084", opaque="AQAAAHKD1uSTaXVf0u3a4/LkCmjR1phx", stale=FALSE, algorithm=MD5, qop="auth"

Content-Length: 0

|

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,029" Module="network.sip" Level="INFO":  Src-ip="10.254.0.7"  Src-port="62338"   Detail="Receive Request Method=SUBSCRIBE, Request-URI=sip:cisco@mydomain.com, Call-ID=6af0c6f351e86ac8@127.0.0.1"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,029" Module="network.sip" Level="DEBUG":  Src-ip="10.254.0.7"  Src-port="62338"

SIPMSG:

|SUBSCRIBE sip:cisco@mydomain.com SIP/2.0

Via: SIP/2.0/TLS 10.254.0.7:62338;branch=z9hG4bK76c5899d1676671b960ae6cd5e81b29b.1;received=10.254.0.7;rport=62338

Call-ID: 6af0c6f351e86ac8@127.0.0.1

CSeq: 202 SUBSCRIBE

Contact:

From: <>cisco@mydomain.com>;tag=fa9d28431f16d75c

To: <>provisioning@mydomain.com>

Max-Forwards: 70

Route: <10.10.2.100:5061>

User-Agent: TANDBERG/774 (MCX 4.6.3.17194) - Windows

Expires: 300

Proxy-Authorization: Digest nonce="734622e4a24a70910f7e67b2080ef8bdb56021e396546aa2be572fd76084", realm="vcs.mydomain.com", qop=auth, opaque="AQAAAHKD1uSTaXVf0u3a4/LkCmjR1phx", username="cisco", uri="sip:mydomain.com", response="0df0b98314e40203a888b87692999a5c", algorithm=MD5, nc=00000001, cnonce="c724d64a764db4d30ebfa518f9ab5af3"

Event: ua-profile;model=movi;vendor=tandberg.com;profile-type=user;version=4.6.3.17194;clientid="S-1-5-21-3537420569-697092696-2587007096";connectivity=0

Accept: application/pidf+xml

Content-Length: 0

|

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,030" Module="network.http" Level="DEBUG":  Message="Request" Method="POST" URL="http://127.0.0.1:9998/credential/name/cisco" Ref="0x7fd67829a0a0"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,033" Module="network.http" Level="DEBUG":  Message="Response" Src-ip="127.0.0.1" Src-port="9998" Dst-ip="127.0.0.1" Dst-port="43954" Response="200 OK" ResponseTime="0.00339" Ref="0x7fd67829a0a0"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,033" Module="network.ldap" Level="INFO":   Detail="Authentication credential found in directory for identity: cisco"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,036" Module="network.cpl" Level="DEBUG":  Remote-ip="10.254.0.7"  Remote-port="62338"   Detail="CPL: "

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,036" Module="network.cpl" Level="DEBUG":  Remote-ip="10.254.0.7"  Remote-port="62338"   Detail="CPL: "

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,037" Module="network.cpl" Level="DEBUG":  Remote-ip="10.254.0.7"  Remote-port="62338"   Detail="CPL: "

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,037" Module="network.cpl" Level="DEBUG":  Remote-ip="10.254.0.7"  Remote-port="62338"   Detail="CPL: "

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,038" Module="network.search" Level="INFO":   Detail="Search rule 'Local zone – no domain' did not match destination alias 'cisco@mydomain.com'"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,038" Module="network.search" Level="INFO":   Detail="Considering search rule 'Local zone – full URI' towards target 'LocalZone' at priority '49' with alias 'cisco@mydomain.com'"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,041" Module="network.sip" Level="INFO":  Dst-ip="10.254.0.7"  Dst-port="62338"   Detail="Sending Response Code=404, Method=SUBSCRIBE, To=sip:provisioning@mydomain.com, Call-ID=6af0c6f351e86ac8@127.0.0.1"

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,041" Module="network.sip" Level="DEBUG":  Dst-ip="10.254.0.7"  Dst-port="62338"

SIPMSG:

|SIP/2.0 404 Not Found

Via: SIP/2.0/TLS 10.254.0.7:62338;branch=z9hG4bK76c5899d1676671b960ae6cd5e81b29b.1;received=10.254.0.7;rport=62338;ingress-zone=DefaultZone

Call-ID: 6af0c6f351e86ac8@127.0.0.1

CSeq: 202 SUBSCRIBE

From: <>cisco@mydomain.com>;tag=fa9d28431f16d75c

To: <>provisioning@mydomain.com>;tag=f9cb192329b65fef

Server: TANDBERG/4120 (X7.2.2)

Warning: 399 10.10.2.100:5061 "Policy Response"

Content-Length: 0

|

2013-07-02T14:08:53-04:00 vcs tvcs: UTCTime="2013-07-02 18:08:53,251" Module="network.tcp" Level="DEBUG":  Src-ip="10.254.0.7" Src-port="62338" Dst-ip="10.10.2.100" Dst-port="5061" Detail="TCP Connection Closed"

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: