Aruba IAP 277 startet ständig neu

[DerErny]

Guten Tag liebe Community,

Ich habe folgendes Problem:
Ich habe zwei IAPs 277 für den outdoor Einsatz. Diese wollte ich in einem Mesh Link miteinander verbinden. Jedoch tut sich einer der beiden APs sich nach den factory reset andauernd neu starten. 

Er gibt an, dass eine Default IP gewählt wird, obwohl er an einen erreichbarer DHCP Server angeschlossen ist, und startet sich dann direkt nach dem booten neu, da die Default IP nicht in das Netzwerk passen tut. 

Hier das Log:

APBoot 1.5.3.14 (build 46206)
Built: 2014-09-26 at 18:50:05

Model: AP-27x
CPU0:  P1020E, Version: 1.1, (0x80ec0011)
Core:  E500, Version: 5.1, (0x80212051)
Clock:
       CPU0: 800 MHz
       CPU1: 800 MHz
       CCB:  400 MHz
       DDR:  333.333 MHz (666.667 MT/s data rate) (Asynchronous)
       LBC:   25 MHz
L1:    D-cache 32KB enabled
       I-cache 32KB enabled
I2C:   ready
DRAM:  Configuring DDR for 666.667 MT/s data rate
DDR:   512 MB (DDR3, 32-bit, CL=5, ECC off)
POST1: memory passed
Flash: 32 MB
L2:    256 KB enabled
Power: 802.3at POE
PCIe1: RC, link up, x1
       dev fn venID devID class  rev    MBAR0    MBAR1    MBAR2    MBAR3
       00  00  14e4  4360 00002   03 80000004 00000000 00000000 00000000
PCIe2: RC, link up, x1
       dev fn venID devID class  rev    MBAR0    MBAR1    MBAR2    MBAR3
       00  00  14e4  4360 00002   03 a0000004 00000000 00000000 00000000
Net:   eth0, eth1
Radio: bcm43460#0, bcm43460#1

Hit <Enter> to stop autoboot:  0
apboot>
apboot>
apboot>
apboot> factory_reset
Clearing state... Checking OS image and flags

Image is signed; verifying checksum... passed
Preserving image partition 0
Erasing flash sector @ 0xefe80000.... done
Erased 1 sectors

Erasing flash sector @ 0xefea0000.... done
Erased 1 sectors

Erasing flash sector @ 0xefee0000.... done
Erased 1 sectors

Erasing flash sector @ 0xeff00000.... done
Erased 1 sectors

Erasing flash sector @ 0xeff20000.... done
Erased 1 sectors

done
Purging environment... preserving os_partition (0)
Un-Protected 1 sectors
. done
Erased 1 sectors
Writing 9....8....7....6....5....4....3....2....1....
Un-Protected 1 sectors
. done
Erased 1 sectors
Writing 9....8....7....6....5....4....3....2....1....
done
apboot> saveenv
Saving Environment to Flash...
Un-Protected 1 sectors
. done
Erased 1 sectors
Writing 9....8....7....6....5....4....3....2....1....
apboot> bo
Booting OS partition 0
Checking image @ 0xee000000
Copying image from 0xee000000

Hat jemand von euch eine Idee wieso er nicht mehr booten tut? 

Ich würde auf einen Software fehler tippen.

Zur information- Im selben Netz hängt auch der zweite IAP und der Funktioniert. Es kann also nich an dem DCHP Server liegen.

Mit freundlichen Grüßen 

Erny

[DerErny]

Hier der Rest vom Log:

Image is signed; verifying checksum... passed
Signer Cert OK
Policy Cert OK
RSA signature verified.
[ 0.000000] Flash variant: default
[ 0.000000]
[ 0.000000] Aruba Networks
[ 0.000000] ArubaOS Version 6.5.3.2-6.5.3.2 (build 60886 / label #60886)
[ 0.000000] Built by p4build@pr-hpn-build09 on 2017-08-08 at 06:38:37 UTC (gcc version 4.5.1)
[ 0.000000]
[ 0.000000] Memory: 504068k/524288k available (14528k kernel code, 20220k reserved, 616k data, 376k bss, 10992k init)
[ 0.003004] Processor 1 found.
[ 0.112646] Brought up 2 CPUs
[ 0.189871] PCI: Probing PCI hardware
[ 0.233021] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
[ 0.296024] pci 0001:02:00.0: PCI bridge to [bus 03-ff]
[ 0.358248] pci 0000:00:00.0: enabling device (0106 -> 0107)
[ 0.425333] pci 0001:02:00.0: enabling device (0106 -> 0107)
[ 8.216489] ee000000.nor: Found 1 x16 devices at 0x0 in 16-bit bank
[ 8.291527] Amd/Fujitsu Extended Query Table at 0x0040
[ 8.353045] number of CFI chips: 1
[ 8.398285] fsl-gianfar ethernet.2: enabled errata workarounds, flags: 0x4
[ 8.481809] /proc/gfar_eth0_stats created
[ 8.532110] fsl-gianfar ethernet.3: enabled errata workarounds, flags: 0x4
[ 8.615627] /proc/gfar_eth1_stats created
[ 8.687121] Enabling watchdog on CPU 0
[ 8.687131] Enabling watchdog on CPU 1
[ 8.776997] Masking ICV Error interrupt
[ 9.078774]
[ 9.078779] Starting Kernel SHA1 KAT ...Completed Kernel SHA1 KAT
[ 9.144065] Starting Kernel HMAC SHA1 FIPS KAT ...Completed Kernel HMAC SHA1 FIPS KAT
[ 9.146328] Starting Kernel HMAC SHA256 FIPS KAT ...Completed Kernel HMAC SHA256 FIPS KAT
[ 9.147385] Starting Kernel HMAC SHA384 FIPS KAT ...Completed Kernel HMAC SHA384 FIPS KAT
[ 9.147865] Starting Kernel HMAC SHA512 FIPS KAT ...Completed Kernel HMAC SHA512 FIPS KAT
[ 9.148357] Starting Kernel AES-CBC FIPS KAT ...Starting Kernel HMAC-SHA1 KAT ...Completed Kernel AES-CBC FIPS KAT
[ 9.687963] Starting Kernel AES-CCM FIPS KAT ...Completed Kernel AES-CCM FIPS KAT
[ 9.779278] Starting Kernel 3DES-CBC FIPS KAT ...Completed Kernel HMAC-SHA1 KAT
[ 9.815645] Starting Kernel DES KAT ...Completed Kernel DES KAT
[ 9.815714] Starting Kernel AES KAT ...Completed Kernel AES KAT
[ 9.815747]
[ 10.033155] Completed Kernel 3DES-CBC FIPS KAT
Thu Jan 1 00:00:00 PST 1970
Domain Name: SetMeUp.arubanetworks.com
Current OEM Name : Aruba Networks
Disabling ipv6 for devices by default
IPv6 capability is supported for devices
No panic info available
apfcutil: sector CACHE: Cache uninitialized
apfcutil: sector RAP: Cache uninitialized
apfcutil: sector FAT: Cache uninitialized
apfcutil: sector SCRATCH: Cache uninitialized
Backup ENV.
apfcutil: sector MESH Prov: Cache uninitialized
[ 20.127573] p1020_soc: P1020 Misc Utils Driver version 1
Enter non-FIPS mode
Cfg len is 0
Configuration file is empty, turning on default services...
extended ssid activate due to no AP config ...
Ethernet port 1 mode: active-standby
[ 24.060754] init_phy: PHY interface is SGMII
[ 24.117848] ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 24.183621] ADDRCONF(NETDEV_UP): bond0: link is not ready
[ 24.262596] init_phy: PHY interface is SGMII
[ 24.315294] bonding: bond0: enslaving eth0 as a backup interface with a down link.
Info: use bondin[ 24.423716] init_phy: PHY interface is SGMII
g and enslave et[ 24.489134] ADDRCONF(NETDEV_UP): eth1: link is not ready
h1
[ 24.588509] init_phy: PHY interface is SGMII
[ 24.641217] bonding: bond0: enslaving eth1 as a backup interface with a down link.
Starting watchdog process...
touching file /tmp/ip_mode_0
touching file /tmp/ip_mode_1
Enabling DHCPv6 ... IP mode is v4-prefer ...
[ 25.064387] PHY: eth0 (mdio@ffe24000:00) - Link is Up - 1000/Full
[ 25.382180] bonding: bond0: link status definitely up for interface eth0.
[ 25.463459] bonding: bond0: making interface eth0 the new active one.
[ 25.540607] bonding: bond0: first active interface up!
[ 25.602191] ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready
Checking country code.
Ethernet uplink active. Becoming Mesh Portal
Mesh is DISABLED on this device.
extended ssid is activated on the platform ...
copying bootuplog ...
[ 29.195953] AP xml model 85, num_radios 2 (jiffies 14395)
[ 29.260606] apType 85 hw_opmode 0
[ 29.300213] radio 0: band 1 ant 0 max_ssid 16
[ 29.352315] radio 1: band 0 ant 0 max_ssid 16
[ 29.405988] init_asap_mod: installation:0
[ 29.453975] election init: rand=1c HZ=500
[ 29.501918] IAP client match init
[ 29.542115] ethernet_device_event: dev eth0 is up
[ 29.598403] ethernet_device_event: dev eth1 is up
allow PAPI
set device anul0 mtu to 2000
notify asap_mod 3g no present...
Enabling ipv6 on br0
Enabling ipv6 on loopback
apdot1x authentication is not enabled
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
LLDP not sent yet, DHCP is waiting
Starting DHCP
Getting an IP ad[ 37.996761] bonding: bond0: eth0 is already the current active slave.
dress...
Jan 1 00:00:27 udhcpc[2496]: udhcpc (v0.9.9-pre) started
Jan 1 00:00:28 udhcpc[2496]: send_discover: pkt num 0, secs 0
Jan 1 00:00:28 udhcpc[2496]: Sending discover...
Jan 1 00:00:30 udhcpc[2496]: send_discover: pkt num 1, secs 2
Jan 1 00:00:30 udhcpc[2496]: Sending discover...
Jan 1 00:00:32 udhcpc[2496]: send_discover: pkt num 2, secs 4
Jan 1 00:00:32 udhcpc[2496]: Sending discover...
Jan 1 00:00:34 udhcpc[2496]: No lease, forking to background.
Jan 1 00:00:54 udhcpc[2648]: send_discover: pkt num 0, secs 26
Jan 1 00:00:54 udhcpc[2648]: Sending discover...
Jan 1 00:00:56 udhcpc[2648]: send_discover: pkt num 1, secs 28
Jan 1 00:00:56 udhcpc[2648]: Sending discover...
Jan 1 00:00:58 udhcpc[2648]: send_discover: pkt num 2, secs 30
Jan 1 00:00:58 udhcpc[2648]: Sending discover...
Jan 1 00:01:19 udhcpc[2648]: send_discover: pkt num 0, secs 52
Jan 1 00:01:19 udhcpc[2648]: Sending discover...
Jan 1 00:01:21 udhcpc[2648]: send_discover: pkt num 1, secs 54
Jan 1 00:01:21 udhcpc[2648]: Sending discover...
Jan 1 00:01:23 udhcpc[2648]: send_discover: pkt num 2, secs 56
Jan 1 00:01:23 udhcpc[2648]: Sending discover...
Jan 1 00:01:45 udhcpc[2648]: send_discover: pkt num 0, secs 78
Jan 1 00:01:45 udhcpc[2648]: Sending discover...
Jan 1 00:01:47 udhcpc[2648]: send_discover: pkt num 1, secs 80
Jan 1 00:01:47 udhcpc[2648]: Sending discover...
[ 119.688173] Picked up default IP a9feee45, rand ee45
Jan 1 00:01:49 udhcpc[2648]: send_discover: pkt num 2, secs 82
Jan 1 00:01:49 udhcpc[2648]: Sending discover...
[ 125.700169] Default IP is ready
Jan 1 00:02:12 udhcpc[2648]: send_discover: pkt num 0, secs 104
Jan 1 00:02:12 udhcpc[2648]: Sending discover...
Jan 1 00:02:14 udhcpc[2648]: send_discover: pkt num 1, secs 106
Jan 1 00:02:14 udhcpc[2648]: Sending discover...
Jan 1 00:02:16 udhcpc[2648]: send_discover: pkt num 2, secs 108
Jan 1 00:02:16 udhcpc[2648]: Sending discover...
DHCP timed out.
Installing default ip.
Default IP comes up.
[ 166.782186] ip_time_handler: Got ip and packets on bond0 Started master election 148-0, rand 21
[ 167.213563] (08:02:37) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 167.213570]
DHCP timed out.
DHCP got ip address.
[ 167.980185] notify cli0 to reboot system
[ 168.213574] (08:02:38) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 168.213580]
Jan 1 00:02:38 udhcpc[2648]: send_discover: pkt num 0, secs 130
Jan 1 00:02:38 udhcpc[2648]: Sending discover...
[ 169.213093] (08:02:39) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 169.213100]
[ 170.213602] (08:02:40) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 170.213608]
Jan 1 00:02:40 udhcpc[2648]: send_discover: pkt num 1, secs 132
Jan 1 00:02:40 udhcpc[2648]: Sending discover...
[ 171.213611] (08:02:41) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 171.213618]
[ 172.213633] (08:02:42) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 172.213640]
Jan 1 00:02:42 udhcpc[2648]: send_discover: pkt num 2, secs 134
Jan 1 00:02:42 udhcpc[2648]: Sending discover...
[ 173.213126] (08:02:43) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 173.213133]
[ 174.213149] (08:02:44) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 174.213156]
[ 175.213655] (08:02:45) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 175.213662]
[ 176.213165] (08:02:46) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 176.213171]
[ 177.213168] (08:02:47) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 177.213174]
[ 178.046183] notify cli0 to reboot system
[ 178.213177] (08:02:48) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 178.213183]
[ 179.213696] (08:02:49) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 179.213702]
[ 180.213200] (08:02:50) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 180.213206]
[ 181.213212] (08:02:51) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 181.213218]
[ 182.213731] (08:02:52) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 182.213738]
[ 183.213738] (08:02:53) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 183.213744]
[ 184.213247] (08:02:54) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 184.213254]
[ 185.213750] (08:02:55) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 185.213757]
[ 186.213316] (08:02:56) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 186.213323]
[ 187.213770] (08:02:57) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 187.213776]
[ 188.112180] notify cli0 to reboot system
[ 188.213256] (08:02:58) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 188.213262]
x.x.x.x 255.255.0.0
Adpc could not be triggered.
No v6 controller found, roll back to v4-only
touching file /tmp/ip_mode_0
Disabling ipv6 on br0
Disabling ipv6 on loopback
Compressing all files in the /etc/httpd directory...
[ 189.213320] (08:02:59) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 189.213327]
[ 190.213329] (08:03:00) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 190.213336]
[ 191.213336] (08:03:01) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 191.213343]
[ 192.213835] (08:03:02) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 192.213842]
Done.
Starting Webserver
bind: Transport endpoint is not connected
bind: Transport endpoint is not connected
bind: Transport endpoint is not connected
bind: Transport endpoint is not connected
Launching NTP Client on pool.ntp.org
[ 193.213834] (08:03:03) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 193.213841]
[ 193.364697] wifi0: AP type AP-277, radio 0, max_bssids 16
[ 193.992621] aruba_usb_power_control:1136 en:1 status:0
[ 194.054204] aruba_enable_usb_block:556 Enabled USB
[ 194.111526] aruba_usb_power_control:1144 Enable USB power control for 224/225
[ 194.197002] ardmore_usb_power_control:1055 enabled the USB interface
[ 194.213320] (08:03:04) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 194.213326]
[ 194.412663] Enabling eth1 due to power change [power profile 1]
Jan 1 08:03:04 udhcpc[2648]: send_discover: pkt num 0, secs 157
Jan 1 08:03:04 udhcpc[2648]: Sending discover...
[ 194.633868] wifi1: AP type AP-277, radio 1, max_bssids 16
Clearing P1020 P[ 195.213369] (08:03:05) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 195.213375]
CIe Error Status
shutting down watchdog process (nanny will restart it)...
[ 196.213354] (08:03:06) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 196.213361]
Jan 1 08:03:06 udhcpc[2648]: send_discover: pkt num 1, secs 159
Jan 1 08:03:06 udhcpc[2648]: Sending discover...

Completed SW FIPS KAT test
 <<<<< Welcome to the Access Point >>>>>

User: [ 197.213870] (08:03:07) Rebooting AP due to default-ip is denied in this network (b4:5d:50:c8:b2:98 x.x.x.x)
[ 197.213877]

[DerErny · Accepted solution]

Habs gelöst bekommen.

Einfach den Autoboot vorgang abbrechen und dann über dhcp eine IP ziehen. Dann den Ap normal weiter booten.

LG Erny