Re: CME question: Cisco ip phone 12SP+ not registering

From: Radioactive Frog (pbhatkoti@gmail.com)
Date: Sat Nov 17 2007 - 03:43:27 ART


Hi Tarun,
Thanks for pointing me in a right direction.
I tested an IP blue client and it works perfectly.

PSTN-WAN#
PSTN-WAN#
*Nov 17 06:42:44.591: New Skinny socket accepted [2] (0 active)
*Nov 17 06:42:44.591: sin_family 2, sin_port 3185, in_addr 10.0.0.2
*Nov 17 06:42:44.591: skinny_add_socket 2 10.0.0.2 3185
*Nov 17 06:42:44.731: New Skinny socket accepted [2] (1 active)
*Nov 17 06:42:44.731: sin_family 2, sin_port 3186, in_addr 10.0.0.2
*Nov 17 06:42:44.731: skinny_add_socket 2 10.0.0.2 3186
*Nov 17 06:42:45.039: Skinny Is Ready
*Nov 17 06:42:45.039: skinny_server_process: Socket error. errno=0
*Nov 17 06:42:45.039: CLOSED Skinny socket 1 at hdr errno=0 (1 active)
error code 0
*Nov 17 06:42:50.079:
Skinny StationAlarmMessage on socket [2] 10.0.0.2 SEP00B06409EA8F
*Nov 17 06:42:50.079: severityInformational p1=0 [0x0] p2=0 [0x0]
*Nov 17 06:42:50.079: IP blue softphone
*Nov 17 06:42:50.331: ephone-(-1)[2] StationRegisterMessage (0/0/10) from
10.0.0.2
*Nov 17 06:42:50.331: ephone-(-1)[2] Register StationIdentifier DeviceName
SEP001125D8A4DD
*Nov 17 06:42:50.331: ephone-(-1)[2] StationIdentifier Instance 1
deviceType 7
*Nov 17 06:42:50.331: ephone-(-1) Allow any Skinny Server IP address
10.0.0.1
*Nov 17 06:42:50.331: ephone-2[2]:***Force device subtype to 0
*Nov 17 06:42:50.331: ephone-2[2]:new phone associate OK on socket [2]
*Nov 17 06:42:50.331: %IPPHONE-6-REGISTER_NEW: ephone-2:SEP001125D8A4DD IP:
10.0.0.2 Socket:2 DeviceType:Phone has registered.
*Nov 17 06:42:50.331: Phone 1 socket 2
*Nov 17 06:42:50.331: Skinny Local IP address = 10.0.0.1 on port 2000

*Nov 17 06:42:50.331: Skinny Phone IP address = 10.0.0.2 3186
*Nov 17 06:42:50.331: ephone-2[2]:RegisterAck msg overrides SCCP v4 deivce
with protocolVer of v3.
*Nov 17 06:42:50.331: ephone-2[2]:Signal protocol ver 5 to phone with ver 4
*Nov 17 06:42:50.331: ephone-2[2]:Date Format M/D/Y
*Nov 17 06:42:50.331: ephone-2[2]:RegisterAck sent to ephone 2: keepalive
period 30 use sccp-version 3
*Nov 17 06:42:50.331: ephone-2[2]:CapabilitiesReq sent
*Nov 17 06:42:50.587: ephone-2[2]:CapabilitiesRes received
*Nov 17 06:42:50.587: ephone-2[2]:Caps list 5
G711Ulaw64k 30 ms
G711Alaw64k 30 ms
G729 40 ms
GSM-FR 40 ms
G726_32K 30 ms

*Nov 17 06:42:50.587: ephone-2[2]:ButtonTemplateReqMessage
*Nov 17 06:42:50.587: ephone-2[2]:CheckAutoReg
*Nov 17 06:42:50.587: ephone-2[2]:AutoReg is disabled
*Nov 17 06:42:50.587: ephone-2[2][SEP001125D8A4DD]:Setting 6 lines 0
speed-dials on phone (max_line 6)
*Nov 17 06:42:50.587: ephone-2[2]:First Speed Dial Button location is 0 (0)
*Nov 17 06:42:50.587: ephone-2[2]:Configured 0 speed dial buttons
*Nov 17 06:42:50.587: ephone-2[2]:ButtonTemplate lines=6 speed=0 buttons=6
offset=0
*Nov 17 06:42:50.839: ephone-2[2]:StationSoftKeyTemplateReqMessage
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 1 tag 1
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 2 tag 2
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 3 tag 3
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 4 tag 4
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 5 tag 5
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 6 tag 6
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 7 tag 7
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 8 tag 8
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 9 tag 9
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 10 tag 10
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 11 tag 11
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 12 tag 12
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 13 tag 13
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 14 tag 14
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 15 tag 15
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 16 tag 16
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 17 tag 17
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 18 tag 18
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 19 tag 57
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 20 tag 65
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 21 tag 67
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 22 tag 63
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 23 tag 71
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 24 tag 72
*Nov 17 06:42:50.839: ephone-2[2]:SoftKeys: International On | 25 tag 73
*Nov 17 06:42:50.839: ephone-2[2]:StationSoftKeyTemplateResMessage
*Nov 17 06:42:50.843: ephone-2[2]:StationConfigStatReqMessage
*Nov 17 06:42:50.843: ephone-2[2]:StationConfigStatMessage sent for device
SEP001125D8A4DD
*Nov 17 06:42:51.095: ephone-2[2]:StationSoftKeySetReqMessage
*Nov 17 06:42:51.095: ephone-2[2]:GetSoftkeysetIdle: Default Template

*Nov 17 06:42:51.095: ephone-2[2]:GetSoftkeysetConnected:Default Template

*Nov 17 06:42:51.095: ephone-2[2]:GetSoftkeysetSeized:Default Template

*Nov 17 06:42:51.095: ephone-2[2]:GetSoftkeysetAlerting:Default Template

*Nov 17 06:42:51.095: ephone-2[2]:Removed SkPark key
*Nov 17 06:42:51.095: ephone-2[2]:StationSoftKeySetResMessage
*Nov 17 06:42:51.347: ephone-2[2]:StationLineStatReqMessage from ephone line
1
*Nov 17 06:42:51.347: ephone-2[2]:CheckAutoReg
*Nov 17 06:42:51.347: ephone-2[2]:AutoReg is disabled
*Nov 17 06:42:51.347: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 1 Invalid DN -1
*Nov 17 06:42:51.347: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (1 of 6)
*Nov 17 06:42:51.359: ephone-2[2][SEP001125D8A4DD]:CallPrompt line 0 ref 0:
ITS
*Nov 17 06:42:51.611: ephone-2[2]:StationForwardStatReqMessage line 1 from
ephone
*Nov 17 06:42:51.611: Skinny StationForwardStatMessage line 1 sent on ephone
socket [2] for ephone-2
*Nov 17 06:42:51.611: activeForward 0 AllActive 0 BusyActive 0
NoAnswerActive 0
*Nov 17 06:42:51.611: ephone-2[2]:Skinny Available Lines 36 set for socket
[2]
*Nov 17 06:42:51.611: ephone-2[2]:SkinnyCompleteRegistrationForAvailLines
*Nov 17 06:42:51.611: ephone-2[2]:36 lines Completed Registration out of 0
lines
*Nov 17 06:42:51.611: ephone-2[2][SEP001125D8A4DD]:CallPrompt line 0 ref 0:
Cisco CME
*Nov 17 06:42:51.611: ephone-2[2]:SkinnyCheckPendingCallBackPhone scan 6
lines
*Nov 17 06:42:51.867: ephone-2[2]:StationLineStatReqMessage from ephone line
1
*Nov 17 06:42:51.867: ephone-2[2]:CheckAutoReg
*Nov 17 06:42:51.867: ephone-2[2]:AutoReg is disabled
*Nov 17 06:42:51.867: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 1 Invalid DN -1
*Nov 17 06:42:51.867: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (2 of 6)
*Nov 17 06:42:51.879: ephone-2[2][SEP001125D8A4DD]:CallPrompt line 0 ref 0:
ITS
*Nov 17 06:42:51.879: ephone-2[2]:StationLineStatReqMessage from ephone line
2
*Nov 17 06:42:51.879: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 2 Invalid DN -1
*Nov 17 06:42:51.879: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (3 of 6)
*Nov 17 06:42:51.879: ephone-2[2]:StationLineStatReqMessage from ephone line
3
*Nov 17 06:42:51.879: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 3 Invalid DN -1
*Nov 17 06:42:51.879: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (4 of 6)
*Nov 17 06:42:51.883: ephone-2[2]:StationLineStatReqMessage from ephone line
4
*Nov 17 06:42:51.883: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 4 Invalid DN -1
*Nov 17 06:42:51.883: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (5 of 6)
*Nov 17 06:42:51.883: ephone-2[2]:StationLineStatReqMessage from ephone line
5
*Nov 17 06:42:51.883: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 5 Invalid DN -1
*Nov 17 06:42:51.883: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (6 of 6)
*Nov 17 06:42:51.883: ephone-2[2]:SkinnyCompleteRegistration
*Nov 17 06:42:51.883: ephone-2[2]:ClearCallPrompt line 0 ref 0
*Nov 17 06:42:51.887: ephone-2[2]:SelectPhoneSoftKeys set 0 mask FFBE for
line 0 ref 0
*Nov 17 06:42:51.887: ephone-2[2][SEP001125D8A4DD]:CallPrompt line 0 ref 0:
Cisco CME
*Nov 17 06:42:51.887: ephone-2[2]:SkinnyCheckPendingCallBackPhone scan 6
lines
*Nov 17 06:42:51.887: ephone-2[2]:StationLineStatReqMessage from ephone line
6
*Nov 17 06:42:51.887: ephone-2[2][SEP001125D8A4DD]:StationLineStatReqMessage
from ephone line 6 Invalid DN -1
*Nov 17 06:42:51.887: ephone-2[2][SEP001125D8A4DD]:StationLineStatResMessage
sent to ephone (7 of 6)
*Nov 17 06:42:51.891: ephone-2[2]:StationForwardStatReqMessage line 1 from
ephone
*Nov 17 06:42:51.891: Skinny StationForwardStatMessage line 1 sent on ephone
socket [2] for ephone-2
*Nov 17 06:42:51.891: activeForward 0 AllActive 0 BusyActive 0
NoAnswerActive 0
*Nov 17 06:42:51.891: ephone-2[2]:TimeDateReqMessage
*Nov 17 06:42:51.891: year=2007 month=11 day=17
*Nov 17 06:42:51.891: hour=6 minute=42 second=51
*Nov 17 06:42:51.891: day=6 dayofyear=321 tzoffset=0
*Nov 17 06:42:51.891: ephone-2[2]:DefineTimeDate sent
*Nov 17 06:43:01.975: ephone-2[2]:Check Hot-Sync for 6 out of 0 lines
*Nov 17 06:43:01.975: ephone-2[2][SEP001125D8A4DD]:CallPrompt line 0 ref 0:
Cisco CME
*Nov 17 06:43:01.975: ephone-2[2]:SkinnyCheckPendingCallBackPhone scan 6
lines
PSTN-WAN#
PSTN-WAN#
PSTN-WAN#show ephon
PSTN-WAN#show ephone

ephone-1 Mac:00B0.6409.EA8F TCP socket:[-1] activeLine:0 UNREGISTERED
mediaActive:0 offhook:0 ringing:0 reset:0 reset_sent:0 paging 0 debug:1
IP:10.0.0.2 49192 12SP+ keepalive 0 max_line 0

ephone-2 Mac:0011.25D8.A4DD TCP socket:[2] activeLine:0 REGISTERED in SCCP
ver 4
mediaActive:0 offhook:0 ringing:0 reset:0 reset_sent:0 paging 0 debug:1
IP:10.0.0.2 3186 Telecaster 7960 keepalive 0 max_line 6

PSTN-WAN#
PSTN-WAN#



This archive was generated by hypermail 2.1.4 : Sat Dec 01 2007 - 06:37:30 ART