[cisco-voip] Phone reset problem

Fri Jul 2 09:33:27 EDT 2010

NOT 13:47:54.756830 CDP-D: vvlan changed --> New:4096 old:159 4096

That's all you need to know.  The phone's voice vlan changed, and so it re-IP'd.

What type of switch are you using, and is it using CDP or LLDP?

-Ryan

On Jul 2, 2010, at 9:21 AM, James Dust wrote:

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/

_______________________________________________
cisco-voip mailing list
cisco-voip at puck.nether.net
https://puck.nether.net/mailman/listinfo/cisco-voip

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