9951 phone - voice vlan connectivity lost

[Jean-Christophe Majchrzak]

Hello,

I've 9951 phones that sometimes get the error LastOutOfServiceInformation=26 (close TCP due to a reconfiguration on a new voice Vlan).

I've checked the switch port status and modifications but nothing has been done that could lead to this issue. The user says it has no impact on the PC behaviour linked behind the phone. Phone is located on the LAN, close to the Cluster.

CUCM is 8.6.2

Phone firmware is sip9951.9-2-4-19

According to the logs, waht could be the reason ? DHCP renewal ? SIP fw bug ? Catalyst bug ?

Here are a few line console logs from the phone

6318 NOT 09:57:54.726464 CDP-cdpCacheClear(): vlan lost: proto: 1

6319 NOT 09:57:55.731141 CDP-configSelectVLAN(): 3 OP_USE_ADMIN_DFLT:5 oper:4096 cdp:4096 lldp:4096 admin:4096 mac:d4:a0:2a:83:b1:26

6320 NOT 09:57:55.750901 DHCP-dhcpRelease(): activeInterface: WIRED

6321 NOT 09:57:55.751044 DHCP-dhcpSendRel(): sending RELEASE...

6322 NOT 09:57:55.751173 DHCP-createSocket(): cesw0

6323 NOT 09:57:55.753565 CDP-Cfg_Idle_EvlldpDone_XIdle(): VVLAN [LLDP-IDLE] change: DHCP released

6324 NOT 09:57:55.757093 CDP-setVVLanConfig(): tmpVvlanId: 4096 dbgOldVvlan: 11 dscryProcInfo.vvlan: 4096

6325 NOT 09:57:55.760366 CDP-setVLanConfig(): tmpVlanId: 4096 dbgOldVlan: 41 dscryProcInfo.vlan: 4096

6326 NOT 09:57:55.762038 NETSD-netsdSignal(): EV_DHCP

6327 NOT 09:57:55.762169 NETSD-netsdSignal(): EV_VLAN

6328 NOT 09:57:55.762259 NETSD-netsdSignal(): forceDhcp= 1

6329 NOT 09:57:55.762342 PAE: -paeNetsdRcvMsg(1540): VLAN change: status: 0x0 : No such file or directory 6318 NOT 09:57:54.726464 CDP-cdpCacheClear(): vlan lost: proto: 1
6319 NOT 09:57:55.731141 CDP-configSelectVLAN(): 3 OP_USE_ADMIN_DFLT:5 oper:4096 cdp:4096 lldp:4096 admin:4096 mac:d4:a0:2a:83:b1:26
6320 NOT 09:57:55.750901 DHCP-dhcpRelease(): activeInterface: WIRED
6321 NOT 09:57:55.751044 DHCP-dhcpSendRel(): sending RELEASE...
6322 NOT 09:57:55.751173 DHCP-createSocket(): cesw0
6323 NOT 09:57:55.753565 CDP-Cfg_Idle_EvlldpDone_XIdle(): VVLAN [LLDP-IDLE] change: DHCP released
6324 NOT 09:57:55.757093 CDP-setVVLanConfig(): tmpVvlanId: 4096 dbgOldVvlan: 11 dscryProcInfo.vvlan: 4096
6325 NOT 09:57:55.760366 CDP-setVLanConfig(): tmpVlanId: 4096 dbgOldVlan: 41 dscryProcInfo.vlan: 4096
6326 NOT 09:57:55.762038 NETSD-netsdSignal(): EV_DHCP
6327 NOT 09:57:55.762169 NETSD-netsdSignal(): EV_VLAN
6328 NOT 09:57:55.762259 NETSD-netsdSignal(): forceDhcp= 1
6329 NOT 09:57:55.762342 PAE: -paeNetsdRcvMsg(1540): VLAN change: status: 0x0 : No such file or directory

Thanks,

JC

[paolo bevilacqua]

Update phone firmware andh check again.

[Jean-Christophe Majchrzak]

Yes, I've uploaded sip9951.9-3-2SR1-1 and wait for next event...

[Jean-Christophe Majchrzak]

Problem still happen. Sometimes several times a day.

Any idea before a TAC request ?

JC,

[Jean-Christophe Majchrzak]

By the way I regularly see (around 10 times within an hour) this message :

CDP-lldpRcvPktValidation(): pkt dropped: invalid port: -1

Not linked directly to the crash but could be a root cause ?

7894 NOT 09:48:28.022583  CVM-ccsip_messaging: sipSPIAddContactHeader: CFGID_DEVICE_NAME = SEPC40ACBE13AD8

7895 NOT 09:48:37.682380  CVM-ccsip_messaging: sipSPIAddContactHeader: CFGID_DEVICE_NAME = SEPC40ACBE13AD8

7896 WRN 09:50:01.798760  CDP-lldpRcvPktValidation(): pkt dropped: invalid port: -1

7897 WRN 09:50:20.720654  CDP-lldpRcvPktValidation(): pkt dropped: invalid port: -1

7898 NOT 09:50:28.022406  CVM-ccsip_messaging: sipSPIAddContactHeader: CFGID_DEVICE_NAME = SEPC40ACBE13AD8

7899 NOT 09:50:32.683986  CVM-ccsip_messaging: sipSPIAddContactHeader: CFGID_DEVICE_NAME = SEPC40ACBE13AD8

7900 WRN 09:52:20.723040  CDP-lldpRcvPktValidation(): pkt dropped: invalid port: -1

JC,

[Walter Maciola]

Hi JC,

any updates? Got the same Problem. 9951 restarting several times a day with the same error code.

Cheers

Walter

[Jean-Christophe Majchrzak]

Hi,

Unfortunately no news for the moment I've opened a TAC case.

It seems - not 100% sure - that it happens more often when a PC is connected behind.

JC,

[Aman Soi]

Hi Jean,

Could be hitting the bug

CSCuf93609 Bug Details

9951 loses audio on active call when link with pc port is   disconnected
Symptom: When the cable between 9951 and the pc connected to the pc port gets   disconnected during an active call there is no audio anymore, the call stays   active. Conditions: Running firmware version 9.3(2)ES10 or ES12, does not happen with 9.3(2)

regds,

aman

[Jean-Christophe Majchrzak]

Hello,

I've faced this bug also (phone hangs), but as far as the vlan lost issue is concerned I'm already running 9-3-2SR1-1 and I still have the problem.

Thanks anyway.

[Walter Maciola]

Ok, thanks.

I'll try to set the Admin Vlan ID in the phone settings. Maybe this will help, although the CDP Info has the higher priority...

[Walter Maciola]

As a workaround:

Separate the PC from the Phone.

Worked for me, no reboots since then.

Cheers

Walter

[Jean-Christophe Majchrzak]

This is a bug, so waiting for correction. Workaround works as indicated.

CSCuj85339

JC.