[cisco-voip] Phone reset problem

Fri Jul 2 09:21:43 EDT 2010

We have an issue in a specific building with it's own subnet where the
IP phones keep resetting randomly. Below is an extract from one of the
console logs from the phone.

Can anyone interpret what exactly is causing the restart?

NOT 13:33:05.041067 tftpClient: request server6 1 ---> :: 
NOT 13:33:05.048867 tftpClient: request server 1 ---> 172.30.0.2 
NOT 13:33:05.056302 ESP: server 1 = 172.30.0.2 
NOT 13:33:05.062319 tftpClient: request server6 0 ---> :: 
NOT 13:33:05.063574 ESP: server 2 = :: 
NOT 13:33:05.068524 tftpClient: request server6 1 ---> :: 
NOT 13:33:05.070156 ESP: server 3 = :: 
WRN 13:39:40.597548 JVM: Startup Module Loader|cip.mmgr.dt:? -
[MediaMgrSM]: Unhandled Event, State = StateHandsetOffHook Event =
EventSetSpeakerMode
WRN 13:39:47.421602 JVM: Startup Module Loader|cip.mmgr.dt:? -
[MediaMgrSM]: Unhandled Event, State = StateOnHook Event =
EventSetSpeakerModeOff
WRN 13:39:47.423681 JVM: Startup Module Loader|cip.mmgr.dt:? -
[MediaMgrSM]: Unhandled Event, State = StateOnHook Event = EventEndcall
NOT 13:47:54.744024 CDP-D: cache clear - + : protoType:2
NOT 13:47:54.746317 CDP-D: configSelectVLAN: 3 OP_USE_INIT:0 oper:4096
cdp:4096 lldp:4096 admin:4096 mac:0:1b:c:b1:30:a7
NOT 13:47:54.756830 CDP-D: vvlan changed --> New:4096 old:159 4096
ERR 13:47:54.757714 CDP-D: setVVLANConfig VVLAN CHANGED --> NEW:4096
OLD:159 4096
ERR 13:47:54.759000 CDP-D: setVVLANConfig VVLAN CHANGED --> NEW:4096
OLD:159
ERR 13:47:54.759867 ETH_SET_IPV6 call in6_if_brcm_reset
ERR 13:47:54.759905 enter in6_if_brcm_reset
ERR 13:47:54.759930 exit in6_if_brcm_reset
ERR 13:47:54.759949 ETH_SET_IPV6 call in6_if_brcm_up
ERR 13:47:54.759967 ETH_SET_IPV6 call in6_if_loopback_up
ERR 13:47:54.759989 ETH_SET_IPV6 returned from in6_if_loopback_up
NOT 13:47:54.767017 CDP-D: vlan Configured --> New:4096 old:180 :4096
ERR 13:47:54.767467 CDP-D: calling ETH_SET_IPV6 from VLanConfig
ERR 13:47:54.767792 ETH_SET_IPV6 call in6_if_brcm_reset
ERR 13:47:54.767826 enter in6_if_brcm_reset
ERR 13:47:54.767848 exit in6_if_brcm_reset
ERR 13:47:54.767866 ETH_SET_IPV6 call in6_if_brcm_up
ERR 13:47:54.767885 ETH_SET_IPV6 call in6_if_loopback_up
ERR 13:47:54.767911 ETH_SET_IPV6 returned from in6_if_loopback_up
NOT 13:47:54.775324 PAE: SIGIPCFG received...
NOT 13:47:54.776542 CDP-D: Sent SIGNINFO & SIGIPCFG
NOT 13:47:54.776840 CDP-D: getCdpExtaInfo: OP:0 Cos:0 Trust:1
lldp.idxOfInterest:-1 
WRN 13:47:54.777293 CDP-D: cdpSetCos T:1 C:0 
ERR 13:47:54.785517 RTSOLD: opvvlan:159->4096 advvlan:4096->4096
ERR 13:47:54.788148 RTSOLD: LINK -> LINK
NOT 13:47:54.818189 DHCP6: Enable
NOT 13:47:54.826348 PAE: SIGIPCFG received...
NOT 13:47:54.849317 PAE: SIGIPCFG received...
NOT 13:47:54.851249 DHCP: Enable 
NOT 13:47:54.851528 DHCP: Sending Release... 
NOT 13:47:54.852957 ESP: send ADMIN, logging = 1, shell = 0, ipconfig =
0 
NOT 13:47:54.857265 CDP-D: catchipcfg:getdhcpinfo IP:ac1e9e87
domain:charles-stanley.co.uk chngVal:1 
NOT 13:47:54.860514 CDP-D: catchipcfg:getdhcpinfo IP:ac1e9e87
domain:charles-stanley.co.uk chngVal:1 
WRN 13:47:54.867931 SECD: WARN:getCTLInfo: ** phone has no CTL
WRN 13:47:54.879805 SECD: WARN:getCTLInfo: ** phone has no CTL
NOT 13:47:54.903822 CDP-D: catchipcfg:getdhcpinfo IP:ac1e9e87
domain:charles-stanley.co.uk chngVal:1 
ERR 13:47:54.909865 RTSOLD: opvvlan:4096->4096 advvlan:4096->4096
ERR 13:47:54.914566 RTSOLD: LINK -> LINK
ERR 13:47:54.920021 RTSOLD: opvvlan:4096->4096 advvlan:4096->4096
ERR 13:47:54.921769 RTSOLD: LINK -> LINK
NOT 13:47:55.253940 CDP-D: configSelectVLAN: 3 OP_USE_CDP:2 oper:159
cdp:159 lldp:4096 admin:4096 mac:0:1b:c:b1:30:a7
ERR 13:47:57.960193 ESP: rcv from tftpClient timed out
ERR 13:48:00.960200 ESP: rcv from tftpClient timed out
WRN 13:48:02.021966 JVM: Startup Module Loader|cip.sccp.ck:? - Socket
Timeout exception: cip.io.SocketTimeoutException: Connection timed out:
Connection timed out 
 Close(d) Connection ...
ERR 13:48:02.033469 JVM: 13:48:02|cip.io.SocketTimeoutException:
Connection timed out: Connection timed out
	at cip.io.SecureInputStream.socketRead([BII)I(Native Method)
	at cip.io.SecureInputStream.read([BII)I(Unknown Source)
	at java.io.BufferedInputStream.fill()V(Unknown Source)
	at java.io.BufferedInputStream.read()I(Unknown Source)
	at java.io.DataInputStream.readInt()I(Unknown Source)
	at cip.io.i.readInt()I(Unknown Source)
	at cip.sccp.av.a()Lcip/sccp/br;(Unknown Source)
	at cip.sccp.ck.e()V(Unknown Source)
	at cip.sys.l.run()V(Unknown Source)
	at java.lang.Thread.startup(Z)V(Unknown Source)

Consider the environment - Think before you print

The contents of this email are confidential to the intended recipient and may not be disclosed. Although it is believed that this email and any attachments are virus free, it is the responsibility of the recipient to confirm this. 

You are advised that urgent, time-sensitive communications should not be sent by email. We hereby give you notice that a delivery receipt does not constitute acknowledgement or receipt by the intended recipient(s).

Details of Charles Stanley group companies and their regulators (where applicable), can be found at this URL http://www.charles-stanley.co.uk/contact-us/disclosure/

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://puck.nether.net/pipermail/cisco-voip/attachments/20100702/78d53a92/attachment.html>