Solved: Re: Trouble getting 3502I to register to a 4402 - Page 2

Jeff Bull · ‎01-13-2012

I have 2 3502I WAP's in my London office that i'm trying to register to our Amsterdam 4402 WLC. They were able to successfully pull DHCP from a local switch, including option 43, and did register with my controller yesterday. As per the normal process, the controller pushed an updated image to each, and the WAP's reboot. After the reboot, they are stuck in an endless loop of trying to call the ap-manager interface, not the Management interface, so are failing to register.

As of now, i'm at a loss as to how to correct this. Is there a compatibility issue with the image that was pushed? Is there a way to push a different image, with the correct IP?

Please see the attachment for the repeating logs on the CLI of one of the WAP's.

Any ideas/help would be greatly appreciated.

Jeff Bull

Scott Fella · ‎01-13-2012

Also... are these ap's local to where the wlc is at or you trying to do this over the WAN?

-Scott
*** Please rate helpful posts ***

Jeff Bull · ‎01-13-2012

Over the WAN. The AP's are in London, controller is in Amsterdam.

Jeff Bull · ‎01-13-2012

Yes, both ap-manager & management interfaces are in the same IP subnet. I currently have 9 access points in Amsterdam (same location as the controller) registered to the controller successfully.

Scott Fella · ‎01-13-2012

Okay... well if you are doing option 43 and it is working they should find the wlc. Can you post the whole output of the ap join process if you can? I want to make sure it does see the option and is pointing to the WLC.

-Scott
*** Please rate helpful posts ***

Jeff Bull · ‎01-13-2012

Sure thing Scott...

I've included the logs from the start of the last reboot (after issues the clear capwap private command)

r WRDTR,CLKTR: 0x84000800 0x00000000

r RQDC ,RFDC : 0x80000032 0x00000256

using eeprom values

WRDTR,CLKTR: 0x84000800 0x00000000

RQDC ,RFDC : 0x80000032 0x00000256

ddr init done

Running Normal Memtest...

Passed.

IOS Bootloader - Starting system.

FLASH CHIP: Numonyx P33

Checking for Over Erased blocks

......................................................................................................................................................................................................................................................

Xmodem file system is available.

DDR values used from system serial eeprom.

WRDTR,CLKTR: 0x84000800, 0x00000000

RQDC, RFDC : 0x80000032, 0x00000256

PCIE0: link is up.

PCIE0: VC0 is active

PCIE1: link is up.

PCIE1: VC0 is active

64bit PCIE devices

PCIEx: initialization done

flashfs[0]: 36 files, 8 directories

flashfs[0]: 0 orphaned files, 0 orphaned directories

flashfs[0]: Total bytes: 31739904

flashfs[0]: Bytes used: 8303104

flashfs[0]: Bytes available: 23436800

flashfs[0]: flashfs fsck took 13 seconds.

Reading cookie from system serial eeprom...Done

Base Ethernet MAC address: 28:94:0f:c1:17:e3

Ethernet speed is 100 Mb - FULL duplex

Loading "flash:/ap3g1-k9w8-mx.124-23c.JA2/ap3g1-k9w8-mx.124-23c.JA2"...################################################################################################################################################################################################################################################################################################################################################################################################################################################################################

File "flash:/ap3g1-k9w8-mx.124-23c.JA2/ap3g1-k9w8-mx.124-23c.JA2" uncompressed and installed, entry point: 0x4000

executing...

enet halted

Restricted Rights Legend

Use, duplication, or disclosure by the Government is

subject to restrictions as set forth in subparagraph

(c) of the Commercial Computer Software - Restricted

Rights clause at FAR sec. 52.227-19 and subparagraph

(c) (1) (ii) of the Rights in Technical Data and Computer

Software clause at DFARS sec. 252.227-7013.

cisco Systems, Inc.

170 West Tasman Drive

San Jose, California 95134-1706

Cisco IOS Software, C3500 Software (AP3G1-K9W8-M), Version 12.4(23c)JA2, RELEASE SOFTWARE (fc3)

Technical Support: http://www.cisco.com/techsupport

Compiled Wed 13-Apr-11 12:20 by prod_rel_team

Proceeding with system init

Proceeding to unmask interrupts

Initializing flashfs...

FLASH CHIP: Numonyx P33

Checking for Over Erased blocks

......................................................................................................................................................................................................................................................

flashfs[1]: 36 files, 8 directories

flashfs[1]: 0 orphaned files, 0 orphaned directories

flashfs[1]: Total bytes: 31481856

flashfs[1]: Bytes used: 8303104

flashfs[1]: Bytes available: 23178752

flashfs[1]: flashfs fsck took 7 seconds.

flashfs[1]: Initialization complete.

flashfs[2]: 0 files, 1 directories

flashfs[2]: 0 orphaned files, 0 orphaned directories

flashfs[2]: Total bytes: 11999232

flashfs[2]: Bytes used: 1024

flashfs[2]: Bytes available: 11998208

flashfs[2]: flashfs fsck took 1 seconds.

flashfs[2]: Initialization complete....done Initializing flashfs.

Ethernet speed is 100 Mb - FULL duplex

Radio0 present 8364B 8000 B8020000 0 B8030000 10

Radio1 present 8364B 8000 B0020000 0 B0030000 C

This product contains cryptographic features and is subject to United

States and local country laws governing import, export, transfer and

use. Delivery of Cisco cryptographic products does not imply

third-party authority to import, export, distribute or use encryption.

Importers, exporters, distributors and users are responsible for

compliance with U.S. and local country laws. By using this product you

agree to comply with applicable laws and regulations. If you are unable

to comply with U.S. and local laws, return this product immediately.

A summary of U.S. laws governing Cisco cryptographic products may be found at:

http://www.cisco.com/wwl/export/crypto/tool/stqrg.html

If you require further assistance please contact us by sending email to

export@cisco.com.

cisco AIR-CAP3502I-A-K9 (PowerPC460exr) processor (revision A0) with 81910K/49152K bytes of memory.

Processor board ID FGL1551S4ZS

PowerPC460exr CPU at 666Mhz, revision number 0x18A8

Last reset from reload

LWAPP image version 7.0.116.0

1 Gigabit Ethernet interface

2 802.11 Radio(s)

32K bytes of flash-simulated non-volatile configuration memory.

Base ethernet MAC Address: 28:94:0F:C1:17:E3

Part Number : 73-12175-05

PCA Assembly Number : 800-32268-05

PCA Revision Number : A0

PCB Serial Number : FOC1548586P

Top Assembly Part Number : 800-32891-01

Top Assembly Serial Number : FGL1551S4ZS

Top Revision Number : A0

Product/Model Number : AIR-CAP3502I-A-K9

% Please define a domain-name first.

Press RETURN to get started!

*Mar 1 00:00:09.490: %SOAP_FIPS-2-SELF_TEST_IOS_SUCCESS: IOS crypto FIPS self test passed

*Mar 1 00:00:09.500: *** CRASH_LOG = YES

*Mar 1 00:00:09.500: 64bit PCIE devicesSecurity Core found.

Base Ethernet MAC address: 28:94:0F:C1:17:E3

*Mar 1 00:00:12.409: %LINK-3-UPDOWN: Interface GigabitEthernet0, changed state to up

*Mar 1 00:00:13.212: %SOAP_FIPS-2-SELF_TEST_RAD_SUCCESS: RADIO crypto FIPS self test passed on interface Dot11Radio 0

*Mar 1 00:00:13.441: %LINEPROTO-5-UPDOWN: Line protocol on Interface GigabitEthernet0, changed state to up

*Mar 1 00:00:15.911: %SOAP_FIPS-2-SELF_TEST_RAD_SUCCESS: RADIO crypto FIPS self test passed on interface Dot11Radio 1

*Mar 1 00:00:15.964: %LWAPP-3-CLIENTEVENTLOG: Read and initialized AP event log (contains, 1024 messages)

*Mar 1 00:00:15.980: status of voice_diag_test from WLC is false

*Mar 1 00:00:18.081: %SYS-5-RESTART: System restarted --

Cisco IOS Software, C3500 Software (AP3G1-K9W8-M), Version 12.4(23c)JA2, RELEASE SOFTWARE (fc3)

Technical Support: http://www.cisco.com/techsupport

Compiled Wed 13-Apr-11 12:20 by prod_rel_team

*Mar 1 00:00:18.081: %SNMP-5-COLDSTART: SNMP agent on host ap is undergoing a cold start

*Mar 1 00:11:54.034: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Mar 1 00:11:54.047: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to reset

*Mar 1 00:11:54.047: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to reset

*Mar 1 00:11:54.207: %SSH-5-ENABLED: SSH 2.0 has been enabled

*Mar 1 00:11:54.972: %LINEPROTO-5-UPDOWN: Line protocol on Interface GigabitEthernet0, changed state to up

*Mar 1 00:11:55.047: %LINEPROTO-5-UPDOWN: Line protocol on Interface Dot11Radio1, changed state to down

*Mar 1 00:11:55.047: %LINEPROTO-5-UPDOWN: Line protocol on Interface Dot11Radio0, changed state to down

*Mar 1 00:12:04.078: %DHCP-6-ADDRESS_ASSIGN: Interface GigabitEthernet0 assigned DHCP address 192.168.208.237, mask 255.255.255.248, hostname AP2894.0fc1.17e3

*Mar 1 00:12:12.940: status of voice_diag_test from WLC is false

*Mar 1 00:12:12.997: Logging LWAPP message to 255.255.255.255.

*Mar 1 00:12:17.743: %CDP_PD-4-POWER_OK: Full power - NEGOTIATED inline power source

*Mar 1 00:12:17.835: %LINK-3-UPDOWN: Interface Dot11Radio1, changed state to up

*Mar 1 00:12:17.932: %LINK-3-UPDOWN: Interface Dot11Radio0, changed state to up

*Mar 1 00:12:18.753: %LINEPROTO-5-UPDOWN: Line protocol on Interface Dot11Radio1, changed state to up

*Mar 1 00:12:18.753: %SYS-6-LOGGINGHOST_STARTSTOP: Logging to host 255.255.255.255 started - CLI initiated

*Mar 1 00:12:18.851: %LINEPROTO-5-UPDOWN: Line protocol on Interface Dot11Radio0, changed state to up

Translating "CISCO-CAPWAP-CONTROLLER"...domain server (10.170.2.4)

*Mar 1 00:12:24.019: %CAPWAP-5-DHCP_OPTION_43: Controller address 10.170.29.10 obtained through DHCP

*Jan 14 00:19:39.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:19:39.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:19:39.556: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:19:39.556: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:19:39.556: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:19:44.558: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:19:44.750: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:19:44.766: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:19:44.766: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:19:44.766: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:19:44.819: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Jan 14 00:19:44.882: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to administratively down

*Jan 14 00:19:44.882: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to administratively down

*Jan 14 00:19:44.901: status of voice_diag_test from WLC is false

*Jan 14 00:19:55.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:19:55.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:19:55.556: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:19:55.556: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:19:55.556: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:20:00.558: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:20:00.737: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:20:00.756: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:20:00.756: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:20:00.756: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:20:00.813: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Jan 14 00:20:00.879: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to administratively down

*Jan 14 00:20:00.879: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to administratively down

*Jan 14 00:20:00.895: status of voice_diag_test from WLC is false

*Jan 14 00:20:11.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:11.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:20:11.559: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:11.559: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:20:11.559: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:20:11.805: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:20:11.827: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:20:11.827: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:20:11.827: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:20:11.880: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Jan 14 00:20:11.962: status of voice_diag_test from WLC is false

*Jan 14 00:20:22.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:22.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:20:22.556: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:22.556: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:20:22.556: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:20:22.802: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:20:22.824: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:20:22.824: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:20:22.824: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:20:22.877: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Jan 14 00:20:22.959: status of voice_diag_test from WLC is false

*Jan 14 00:20:33.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:33.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:20:33.556: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:33.556: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:20:33.556: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:20:38.558: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:20:38.737: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:20:38.756: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:20:38.756: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:20:38.756: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:20:38.810: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Jan 14 00:20:38.873: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to administratively down

*Jan 14 00:20:38.873: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to administratively down

*Jan 14 00:20:38.882: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to reset

*Jan 14 00:20:38.891: status of voice_diag_test from WLC is false

*Jan 14 00:20:48.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:48.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:20:48.556: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:20:48.556: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:20:48.556: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:20:48.805: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:20:48.827: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:20:48.827: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:20:48.827: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:20:48.880: %CAPWAP-5-CHANGED: CAPWAP changed state to DISCOVERY

*Jan 14 00:20:48.909: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to administratively down

*Jan 14 00:20:48.909: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to administratively down

*Jan 14 00:20:49.862: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to reset

*Jan 14 00:20:49.871: status of voice_diag_test from WLC is false

*Jan 14 00:20:49.871: %LINK-3-UPDOWN: Interface Dot11Radio1, changed state to up

*Jan 14 00:20:49.881: %LINK-3-UPDOWN: Interface Dot11Radio0, changed state to up

*Jan 14 00:20:49.890: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to reset

*Jan 14 00:20:49.906: %LINK-3-UPDOWN: Interface Dot11Radio1, changed state to up

*Jan 14 00:21:00.000: %CAPWAP-5-DTLSREQSEND: DTLS connection request sent peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:21:00.000: %CAPWAP-5-CHANGED: CAPWAP changed state to

*Jan 14 00:21:00.553: %CAPWAP-5-DTLSREQSUCC: DTLS connection created sucessfully peer_ip: 10.170.29.9 peer_port: 5246

*Jan 14 00:21:00.556: %CAPWAP-5-SENDJOIN: sending Join Request to 10.170.29.9

*Jan 14 00:21:00.556: %CAPWAP-5-CHANGED: CAPWAP changed state to JOIN

*Jan 14 00:21:00.742: %CAPWAP-5-CHANGED: CAPWAP changed state to CFG

*Jan 14 00:21:00.764: %DTLS-5-ALERT: Received WARNING : Close notify alert from 10.170.29.9

*Jan 14 00:21:00.764: %DTLS-5-PEER_DISCONNECT: Peer 10.170.29.9 has closed connection.

*Jan 14 00:21:00.767: %DTLS-5-SEND_ALERT: Send FATAL : Close notify Alert to 10.170.29.9:5246

*Jan 14 00:21:00.880: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to administratively down

*Jan 14 00:21:00.880: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to administratively down

*Jan 14 00:21:00.890: %LINK-5-CHANGED: Interface Dot11Radio0, changed state to reset

*Jan 14 00:21:00.899: status of voice_diag_test from WLC is false

*Jan 14 00:21:00.899: %LINK-3-UPDOWN: Interface Dot11Radio1, changed state to up

*Jan 14 00:21:00.909: %LINK-3-UPDOWN: Interface Dot11Radio0, changed state to up

*Jan 14 00:21:00.918: %LINK-5-CHANGED: Interface Dot11Radio1, changed state to reset

*Jan 14 00:21:00.934: %LINK-3-UPDOWN: Interface Dot11Radio1, changed state to up

Scott Fella · ‎01-13-2012

Product/Model Number : AIR-CAP3502I-A-K9

This is a US AP…. Is it the same country code for out there?

-Scott
*** Please rate helpful posts ***

Jeff Bull · ‎01-13-2012

Bought the AP from a UK vendor, but if there's a way to change the country code on it, I can do that

Scott Fella · ‎01-13-2012

You can’t change the country code on the AP, you can just add the country code to the WLC. So is that the wrong part number?

-Scott
*** Please rate helpful posts ***

Leo Laohoo · ‎01-13-2012

Controller is now running 7.0.116.0, and the 3502I's have received the new code, but are right back to where I started;

Hmmmm ... so it can "join" intially. Wierd.

Can you console into the WAP and enter the command "clear capwap private" and reboot again?

Another thing, you have a 4402. So how many WAPs can you 4402 support (25?) and how many are currently joined to this unit?

Jeff Bull · ‎01-13-2012

When the code on the AP's was outdated, and they were at factory settings, they would register and the controller would push out the new code. After the reboot, that's when connectivity no longer worked.

Just issued the "clear capwap private" command.... the AP i'm testing with is rebooting now.

Leo Laohoo · ‎01-13-2012

Hi jeff,

thanks for the quick response.

Another thing, you have a 4402. So how many WAPs can you 4402 support (25?) and how many are currently joined to this unit?

Scott Fella · ‎01-13-2012

Okay… you should see in the log the issue hopefully. Or else you can manually enter the ip address of the wlc.

-Scott
*** Please rate helpful posts ***

Jeff Bull · ‎01-13-2012

It's a 4402, with a 12 AP license. Currently, there are only 9 AP's registered to it.

Leo Laohoo · ‎01-13-2012

Hi Jeff,

Did my recommendation worked???? I'm confused because your thread has been marked as "Answered".

Jeff Bull · ‎01-13-2012

Leolaohoo,

I ran the command, but still the same result.

And no, my issue still exists.