cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
1601
Views
0
Helpful
3
Replies

Phone registers but won't pull a DN

riedmueller
Level 1
Level 1

Hello

I have been trying to troubleshoot this for a while, and can not figure out what I need to do to fix it.

Cisco 2811 running CME 7.1 with two 7960G phones. One is completely operational, the other registers but does not pull a DN.

Some snippets from the Router's configuration:

Telephone Service Parameters

pod12rtr#sho telephony-service
CONFIG (Version=7.1)
=====================
Version 7.1
Cisco Unified Communications Manager Express
For on-line documentation please see:
http://www.cisco.com/en/US/products/sw/voicesw/ps4625/tsd_products_support_series_home.html

ip source-address 192.168.108.193 port 2000
ip qos dscp:
ef (the MS 6 bits, 46, in ToS, 0xB8) for media
cs3 (the MS 6 bits, 24, in ToS, 0x60) for signal
af41 (the MS 6 bits, 34, in ToS, 0x88) for video
default (the MS 6 bits, 0, in ToS, 0x0) for serviceservice directed-pickup
load 7960-7940 P00308000500
load 7961 SCCP41.8-4-2S
load 7971 SCCP41.8-4-2S
max-ephones 5
max-dn 10

TFTP Server Configuration (just the firmware part)

tftp-server flash:P00308000500.loads

tftp-server flash:P00308000500.sb2

tftp-server flash:P00308000500.sbn

tftp-server flash:apps41.8-4-1-23.sbn

tftp-server flash:cnu41.8-4-1-23.sbn

tftp-server flash:cvm41sccp.8-4-1-23.sbn

tftp-server flash:dsp41.8-4-1-23.sbn

tftp-server flash:jar41sccp.8-4-1-23.sbn

tftp-server flash:SCCP41.8-4-2S.loads

tftp-server flash:term41.default.loads

Ephone Configurations

pod12rtr#sho run | b ephone-dn

ephone-dn  1  dual-line

number 1281

name P12Voip1

!

ephone-dn  2  dual-line

number 1280

name P12Voip2

!

ephone  1

device-security-mode none

mac-address 0018.B995.0187

type 7960

button  1:1

!

ephone  2

device-security-mode none

mac-address 0018.B935.BBAA

type 7960

button  1:2

!

Output of DEBUG EPHONE REGISTER (I dropped power and then re-applied)

pod12rtr#
Sep 25 05:40:15.535: New Skinny socket accepted [2] from 0, sub 1 (2 active)
Sep 25 05:40:15.535: sin_family 2, sin_port 49869, in_addr 192.168.108.194
Sep 25 05:40:15.535: skinny_add_socket 2 192.168.108.194 49869
Sep 25 05:40:15.539: %IPPHONE-6-REG_ALARM: 25: Name=SEP0018B9550187 Load=8.0(5.0) Last=Initialized
Sep 25 05:40:15.539:
Skinny StationAlarmMessage on socket [2] 192.168.108.194 SEP0018B9550187
Sep 25 05:40:15.539: severityInformational p1=2304 [0x900] p2=-1033066304 [0xC26CA8C0]
Sep 25 05:40:15.539: 25: Name=SEP0018B9550187 Load=8.0(5.0) Last=Initialized
Sep 25 05:40:15.539: ephone-(3)[2] StationRegisterMessage (2/2/6) from 192.168.108.194
Sep 25 05:40:15.539: ephone-(3)[2] Register StationIdentifier DeviceName SEP0018B9550187
Sep 25 05:40:15.539: ephone-(3)[2] StationIdentifier Instance 1    deviceType 7
Sep 25 05:40:15.539: ephone-3[2/1]:stationIpAddr 192.168.108.194
Sep 25 05:40:15.539: ephone-3[2/1][SEP0018B9550187]:maxStreams 0
Sep 25 05:40:15.539: epho
pod12rtr#ne-3[2/1][SEP0018B9550187]:From Phone raw protocol Ver 0x8560000B
Sep 25 05:40:15.539: ephone-3[2/1][SEP0018B9550187]:protocol Ver 0x8560000B
Sep 25 05:40:15.539: ephone-3[2/1][SEP0018B9550187]:phone-size 23664 dn-size 816
Sep 25 05:40:15.539: ephone-(3) Allow any Skinny Server IP address 192.168.108.193
Sep 25 05:40:15.539: ephone-3[2/1][SEP0018B9550187]:Found entry 2 for 0018B9550187
Sep 25 05:40:15.539: ephone-3[2/1][SEP0018B9550187]:socket change 1 to 2
Sep 25 05:40:15.539: ephone-3[2/1][SEP0018B9550187]:DisAssociate: Closed socket 1 while REGISTERED
Sep 25 05:40:15.543: %IPPHONE-6-UNREGISTER_ABNORMAL: ephone-3:SEP0018B9550187 IP:192.168.108.194 Socket:1 DeviceType:Phone has unregistered abnormally.
Sep 25 05:40:15.543: ephone-3[2/-1][SEP0018B9550187]:FAILED: CLOSED old socket -1
Sep 25 05:40:15.543: ephone-3[2/2][SEP0018B9550187]:***Force device subtype to 0
Sep 25 05:40:15.543: ephone-3[2/2][SEP0018B9550187]:phone SEP0018B9550187 re-associate OK on socket [2]
Sep 25 05:40:15.543: %IPPHONE-6-REGISTER_NEW: ephone-3:SEP0018B9550187 IP:192.168.108.194 Socket:2 DeviceType:Phone has registered.
Sep 25 05:40:15.543: Phone 2 socket 2
Sep 25 05:40:15.543: Skinny Local IP address = 192.168.108.193 on port 2000

Sep 25 05:40:15.543: Skinny Phone IP address = 192.168.108.194 49869
Sep 25 05:40:15.543: Update tftp binding for SEP0018B9550187
Sep 25 05:40:15.543: ephone-3[2/2][SEP0018B9550187]:Signal protocol ver 12 to phone with ver 11
Sep 25 05:40:15.543: ephone-3[2/2][SEP0018B9550187]:Date Format M/D/Y
Sep 25 05:40:15.543: ephone-3[2/2]:RegisterAck sent to sockettype ephone socket 2: keepalive period 30 use sccp-version 9
Sep 25 05:40:15.543: ephone-3[2/2]:CapabilitiesReq sent
Sep 25 05:40:15.551: ephone-3[2/2]:HeadsetStatusMessage
Sep 25 05:40:15.587: ephone-3[2/2]:MediaPathCapabilitiesMessage
Sep 25 05:40:15.587: ephone-3[2/2]:MediaPathEventMessage
Sep 25 05:40:15.591: ephone-3[2/2]:MediaPathCapabilitiesMessage
Sep 25 05:40:15.591: ephone-3[2/2]:MediaPathEventMessage
Sep 25 05:40:15.595: ephone-3[2/2]:CapabilitiesRes received
Sep 25 05:40:15.595: ephone-3[2/2][SEP0018B9550187]:Caps list 8
WideBand_256K  120 ms, is_mtp 0
G711Ulaw64k  40 ms, is_mtp 0
G711Alaw64k  40 ms, is_mtp 0
G729AnnexB  60 ms, is_mtp 0
G729AnnexAwAnnexB  60 ms, is_mtp 0
G729  60 ms, is_mtp 0
G729AnnexA  60 ms, is_mtp 0
Unrecognized Media Type 257  4 ms, is_mtp 0

Sep 25 05:40:15.599: ephone-3[2/2]:MediaPathEventMessage
Sep 25 05:40:15.751: ephone-3[2/2]:MediaPathEventMessage
Sep 25 05:40:15.751: ephone-3[2/2]:ButtonTemplateReqMessage
Sep 25 05:40:15.751: ephone-3[2/2][SEP0018B9550187]:StationButtonTemplateReqMessage set max presentation to 6
Sep 25 05:40:15.751: ephone-3[2/2]:CheckAutoReg
Sep 25 05:40:15.751: ephone-3[2/2]:AutoReg is disabled
Sep 25 05:40:15.751: ephone-3[2/2][SEP0018B9550187]:Setting 6 lines 0 speed-dials on phone (max_line 6)
Sep 25 05:40:15.751: ephone-3[2/2][SEP0018B9550187]:First Speed Dial Button location is 0 (0)
Sep 25 05:40:15.751: ephone-3[2/2]:ButtonTemplate lines=6 speed=0 buttons=6 offset=0
Sep 25 05:40:15.751: ephone-3[2/2][SEP0018B9550187]:ButtonTemplate buttonCount=6 totalButtonCount=6 buttonOffset=0
Sep 25 05:40:15.751: ephone-3[2/2][SEP0018B9550187]:Configured 0 speed dial buttons
Sep 25 05:40:15.759: ephone-3[2/2]:StationSoftKeyTemplateReqMessage
Sep 25 05:40:15.759: ephone-3[2/2]:StationSoftKeyTemplateResMessage
Sep 25 05:40:15.767: ephone-3[2/2]:StationSoftKeySetReqMessage
Sep 25 05:40:15.767: ephone-3[2/2]:StationSoftKeySetResMessage
Sep 25 05:40:15.787: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 6
Sep 25 05:40:15.787: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 6 Invalid DN -1
Sep 25 05:40:15.787: ephone-3[2/2][SEP0018B9550187]:StationLineStatResMessage sent to ephone (1 of 6)
Sep 25 05:40:15.791: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 5
Sep 25 05:40:15.791: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 5 Invalid DN -1
Sep 25 05:40:15.791: ephone-3[2/2][SEP0018B9550187]:StationLineStatResMessage sent to ephone (2 of 6)
Sep 25 05:40:15.799: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 4
Sep 25 05:40:15.799: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 4 Invalid DN -1
Sep 25 05:40:15.799: ephone-3[2/2][SEP0018B9550187]:StationLineStatResMessage sent to ephone (3 of 6)
Sep 25 05:40:15.807: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 3
Sep 25 05:40:15.807: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 3 Invalid DN -1
Sep 25 05:40:15.807: ephone-3[2/2][SEP0018B9550187]:StationLineStatResMessage sent to ephone (4 of 6)
Sep 25 05:40:15.815: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 2
Sep 25 05:40:15.815: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 2 Invalid DN -1
Sep 25 05:40:15.815: ephone-3[2/2][SEP0018B9550187]:StationLineStatResMessage sent to ephone (5 of 6)
Sep 25 05:40:15.823: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 1
Sep 25 05:40:15.823: ephone-3[2/2]:CheckAutoReg
Sep 25 05:40:15.823: ephone-3[2/2]:AutoReg is disabled
Sep 25 05:40:15.823: ephone-3[2/2][SEP0018B9550187]:StationLineStatReqMessage from ephone line 1 Invalid DN -1
Sep 25 05:40:15.823: ephone-3[2/2][SEP0018B9550187]:StationLineStatResMessage sent to ephone (6 of 6)
Sep 25 05:40:15.823: ephone-3[2/2]:SkinnyCompleteRegistration
Sep 25 05:40:15.895: ephone-3[2/2][SEP0018B9550187]:Skinny Available Lines 6 set for socket [2]
Sep 25 05:40:15.895: ephone-3[2/2]:Already done SkinnyCompleteRegistration
pod12rtr#

Output of SHOW EPHONE PHONE-LOAD

pod12rtr#sho ephone phone-load

DeviceName        CurrentPhoneload       PreviousPhoneload      LastReset     

=====================================================================

SEP0018B9550187   8.0(5.0)               8.0(5.0)               Initialized   

SEP0018B935BBAA   8.0(5.0)               8.0(5.0)               Reset-Restart 

pod12rtr#


Can anyone help me in the right direction here?

Thanks

1 Accepted Solution

Accepted Solutions

Rob Huffman
Hall of Fame
Hall of Fame

Hi Reid,

It looks to me like the ephone mac address may have been

set incorrectly.

mac-address 0018.B995.0187

But in the traces we see;

SEP0018B9550187

Cheers!

Rob

"Why not help one another on the way" - Bob Marley

View solution in original post

3 Replies 3

Rob Huffman
Hall of Fame
Hall of Fame

Hi Reid,

It looks to me like the ephone mac address may have been

set incorrectly.

mac-address 0018.B995.0187

But in the traces we see;

SEP0018B9550187

Cheers!

Rob

"Why not help one another on the way" - Bob Marley

How embarassing

Thanks for picking up on that. Changed the MAC and reset the phone and it's working fine.

Maybe I need to get my eyes checked

Rob Huffman
Hall of Fame
Hall of Fame

Hey Reid,

Don't be embarassed my friend If I had a nickle

for every time I've missed something like this I'd be

a rich man That's why an extra set of eyes is so

helpful here.

Cheers!

Rob

"Why not help one another on the way" - Bob Marley