<!DOCTYPE html PUBLIC "-//W3C//DTD HTML 4.01 Transitional//EN">
<html>
<head>
  <meta content="text/html;charset=ISO-8859-7" http-equiv="Content-Type">
</head>
<body bgcolor="#ffffff" text="#000066">
<font size="-1"><font face="Trebuchet MS">Hi Ryan,<br>
what is the possibility that both phones have the same problem?<br>
I just bought only 2 of these for the remote site so i can't really
tell if another one has the same problems?<br>
What is this error that i have enboldened and mark with red?<br>
<br>
</font></font>Thanks<br>
Akoul<br>
<br>
Ryan Ratliff wrote:
<blockquote cite="mid:49E78B99-664D-4188-89B2-F8F82888D6AA@cisco.com"
 type="cite">May 18 17:17:41: %IPPHONE-6-REG_ALARM: 25:
Name=SEP001FCAE9332E Load= SCCP11.8-3-3S Last=Initialized
  <br>
  <br>
This means the phone either crashed or lost power.   You may need to
get some eyes on these phones or try and get logs from the phone itself
to get more details.
  <br>
  <br>
-Ryan
  <br>
  <br>
On May 18, 2009, at 11:00 AM, Anthony Kouloglou wrote:
  <br>
  <br>
Hi Ryan,
  <br>
i have also opened a TAC for this but from my experience, cisco-voip
list is much more quicker!!
  <br>
Here is a debugging that they have told me to do.
  <br>
  <br>
  <font color="#cc0000"><b>May 18 17:17:38: socket 10 fatal error 254!
can't read msg header with size -1, fd 10 phone tag 20 device name
SEP001FCAE9332E state 1 keepalive 74
  <br>
  </b></font>May 18 17:17:41: New Skinny socket accepted [1] from 0,
sub 1 (23 active)
  <br>
May 18 17:17:41: sin_family 2, sin_port 50219, in_addr 10.43.3.17
  <br>
May 18 17:17:41: skinny_add_socket 1 10.43.3.17 50219
  <br>
May 18 17:17:41: %IPPHONE-6-REG_ALARM: 25: Name=SEP001FCAE9332E Load=
SCCP11.8-3-3S Last=Initialized
  <br>
May 18 17:17:41:
  <br>
Skinny StationAlarmMessage on socket [20] 10.43.3.17 SEP001FCAE9332E
  <br>
May 18 17:17:41: severityInformational p1=0 [0x0] p2=0 [0x0]
  <br>
May 18 17:17:41: 25: Name=SEP001FCAE9332E Load= SCCP11.8-3-3S
Last=Initialized
  <br>
May 18 17:17:41: ephone-(20)[20] StationRegisterMessage (19/21/37) from
10.43.3.17
  <br>
May 18 17:17:41: ephone-(20)[20] Register StationIdentifier DeviceName
SEP001FCAE9332E
  <br>
May 18 17:17:41: ephone-(20)[20] StationIdentifier Instance 0   
deviceType 307
  <br>
May 18 17:17:41: ephone-20[19/10]:stationIpAddr 10.43.3.17
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:maxStreams 5
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:From Phone raw
protocol Ver 0x8570000C
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:protocol Ver
0x8570000C
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:phone-size 13216
dn-size 784
  <br>
May 18 17:17:41: ephone-(20) Allow any Skinny Server IP address
192.168.101.1
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:Found entry 19 for
001FCAE9332E
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:socket change 10 to
20
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]:DisAssociate: Closed
socket 10 while REGISTERED
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]: DN out-of-service
for DN 20 chan 1
  <br>
May 18 17:17:41: ephone-20[19/10][SEP001FCAE9332E]: DN out-of-service
for DN 20 chan 2
  <br>
May 18 17:17:41: Bring down DN 20 chan 1 (14332) with the following
traceback -Traceback= 0x40CB2104 0x40CB26FC 0x40CB51CC 0x40CE63A0
0x40CE6DA0 0x40CE9074 0x40CA0FCC
  <br>
May 18 17:17:41: Skinny DN 20 chan 1 state change to DOWN
  <br>
May 18 17:17:41: Bring down DN 20 chan 2 (14332) with the following
traceback -Traceback= 0x40CB2104 0x40CB26FC 0x40CB51CC 0x40CE63A0
0x40CE6DA0 0x40CE9074 0x40CA0FCC
  <br>
May 18 17:17:41: Skinny DN 20 chan 2 state change to DOWN
  <br>
May 18 17:17:41: %IPPHONE-6-UNREGISTER_ABNORMAL:
ephone-20:SEP001FCAE9332E IP:10.43.3.17 Socket:10 DeviceType:Phone has
unregistered abnormally.
  <br>
May 18 17:17:41: ephone-20[19/-1][SEP001FCAE9332E]:FAILED: CLOSED old
socket -1
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:phone
SEP001FCAE9332E re-associate OK on socket [20]
  <br>
May 18 17:17:41: %IPPHONE-6-REGISTER: ephone-20:SEP001FCAE9332E
IP:10.43.3.17 Socket:20 DeviceType:Phone has registered.
  <br>
May 18 17:17:41: Phone 19 socket 20
  <br>
May 18 17:17:41: Skinny Local IP address = 192.168.101.1 on port 2000
  <br>
  <br>
May 18 17:17:41: Skinny Phone IP address = 10.43.3.17 50219
  <br>
May 18 17:17:41: ephone-20 If FastEthernet0/0 ETHERNET 10.43.3.17 via
192.168.101.254
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Signal protocol ver
9 to phone with ver 12
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Date Format D/M/Y
  <br>
May 18 17:17:41: ephone-20[19/20]:RegisterAck sent to sockettype ephone
socket 20: keepalive period 60 use sccp-version 9
  <br>
May 18 17:17:41: ephone-20[19/20]:CapabilitiesReq sent
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Skinny IP port 3500
set for socket [20]
  <br>
May 18 17:17:41: ephone-20[19/20]:ButtonTemplateReqMessage
  <br>
May 18 17:17:41: ephone-20[19/20]:ButtonTemplateReqMessage waiting for
Caps
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSoftKeyTemplateReqMessage
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSoftKeyTemplateResMessage
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSoftKeySetReqMessage
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSoftKeySetResMessage
  <br>
May 18 17:17:41: ephone-20[19/20]:StationConfigStatReqMessage
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationConfigStatMessage sent for
device SEP001FCAE9332E (40/280)
  <br>
May 18 17:17:41: ephone-20[19/20]:CapabilitiesRes received
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Caps list 9
  <br>
WideBand_256K  40 ms, is_mtp 0
  <br>
G711Ulaw64k  40 ms, is_mtp 0
  <br>
G711Alaw64k  40 ms, is_mtp 0
  <br>
ILBC  60 ms, is_mtp 0
  <br>
G729AnnexB  60 ms, is_mtp 0
  <br>
G729AnnexAwAnnexB  60 ms, is_mtp 0
  <br>
G729  60 ms, is_mtp 0
  <br>
G729AnnexA  60 ms, is_mtp 0
  <br>
Unrecognized Media Type 257  1 ms, is_mtp 0
  <br>
  <br>
May 18 17:17:41: ephone-20[19/20]:Process pending button template
  <br>
May 18 17:17:41: ephone-20[19/20]:ButtonTemplateReqMessage
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationButtonTemplateReqMessage set
max presentation to 2
  <br>
May 18 17:17:41: ephone-20[19/20]:CheckAutoReg
  <br>
May 18 17:17:41: ephone-20[19/20]:AutoReg is disabled
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Setting 1 lines 4
speed-dials on phone (max_line 1)
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:First Speed Dial
Button location is 3 (0)
  <br>
May 18 17:17:41: ephone-20[19/20]:ButtonTemplate lines=1 speed=4
buttons=6 offset=0
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:ButtonTemplate
buttonCount=6 totalButtonCount=6 buttonOffset=0
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Configured 4 speed
dial buttons
  <br>
May 18 17:17:41: ephone-20[19/20]:MediaPathEventMessage
  <br>
May 18 17:17:41: ephone-20[19/20]:MediaPathEventMessage
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationLineStatReqMessage from ephone
line 1
  <br>
May 18 17:17:41: ephone-20[19/20]:StationLineStatReqMessage ephone line
1 DN 20 = 14332 desc = 14332 label =
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationLineStatResMessage sent to
ephone (1 of 1)
  <br>
May 18 17:17:41: ephone-20[19/20]:SkinnyCompleteRegistration
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]: DN in-service for
DN 20 chan 1
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]: DN in-service for
DN 20 chan 2
  <br>
May 18 17:17:41: Skinny DN 20 chan 1 state change to UP
  <br>
May 18 17:17:41: Skinny DN 20 chan 2 state change to UP
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationForwardStatReqMessage line 1
from ephone
  <br>
May 18 17:17:41: Skinny StationForwardStatMessage line 1 sent on ephone
socket [20] for ephone-20
  <br>
May 18 17:17:41: activeForward 0 AllActive 0 BusyActive 0
NoAnswerActive 0
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationSpeedDialStatReqMessage speed
1
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:No speed-dial set 1
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSpeedDialStatMessage sent
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationSpeedDialStatReqMessage speed
2
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:No speed-dial set 2
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSpeedDialStatMessage sent
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationSpeedDialStatReqMessage speed
3
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:No speed-dial set 3
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSpeedDialStatMessage sent
  <br>
May 18 17:17:41:
ephone-20[19/20][SEP001FCAE9332E]:StationSpeedDialStatReqMessage speed
4
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:No speed-dial set 4
  <br>
May 18 17:17:41: ephone-20[19/20]:StationSpeedDialStatMessage sent
  <br>
May 18 17:17:41: ephone-20[19/20][SEP001FCAE9332E]:Skinny Available
Lines 1 set for socket [20]
  <br>
May 18 17:17:41: ephone-20[19/20]:Already done
SkinnyCompleteRegistration
  <br>
May 18 17:17:41: STANDBY Keepalive socket 26 nonregistered ephone {3}
192.168.101.28 1026
  <br>
  <br>
Ryan Ratliff wrote:
  <br>
  <blockquote type="cite"><br>
When the phone re-registers to CCME I believe the alarm messages gets
printed to the log/console.  It should have a string like "last=" in
it.  This is the reason the phone last unregistered and will be very
useful.
    <br>
    <br>
-Ryan
    <br>
    <br>
On May 18, 2009, at 7:01 AM, Anthony Kouloglou wrote:
    <br>
    <br>
Hi, in a CUCME 7.0(1) running on 2811 with 12.4.22.T1, in the local
site all phones have no problem.
    <br>
But, in a remote site, i registered 2 7911 and i noticed that they
unregister and reregister every 46 minutes!!
    <br>
Not 45 not 47!
    <br>
I upgraded them to SCCP11.8-3-3S and they are doing the same thing.
    <br>
There is no connectivity problem with the remote site. I registered a
7940 at the remote site and it never reseted!!.
    <br>
Also, the phone 7911 reseted even in an active call (it was at th 46th
minute)
    <br>
    <br>
Has anyone faced that before?
    <br>
    <br>
Thanks
    <br>
Anthony
    <br>
_______________________________________________
    <br>
cisco-voip mailing list
    <br>
<a class="moz-txt-link-abbreviated" href="mailto:cisco-voip@puck.nether.net">cisco-voip@puck.nether.net</a>
    <br>
<a class="moz-txt-link-freetext" href="https://puck.nether.net/mailman/listinfo/cisco-voip">https://puck.nether.net/mailman/listinfo/cisco-voip</a>
    <br>
    <br>
  </blockquote>
  <br>
</blockquote>
</body>
</html>