Hi There,
I just bought my first AP50 for my UTM Home and tried to install it. I connected to the UTM successfully and gets marked as active, I can even configure it.
The weird thing is, it does not broadcast its radio. The two LEDs for 2,4GHz and 5GHz are off.
I took a look at the wireless log and found these lines:
2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1130): Could not find PHY for device 'radio1'
2016:12:23-13:56:30 172.20.0.200 netifd: radio0 (1129): Could not find PHY for device 'radio0'
2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1192): WARNING: Variable 'data' does not exist or is not an array/object
2016:12:23-13:56:30 172.20.0.200 netifd: radio0 (1199): WARNING: Variable 'data' does not exist or is not an array/object
If I take of the two antennae, the log shows a Data bus error, so I don't suspect the antennae to be defect.
If I try to configure a Wireless Network with only 5GHz enabled the UTM states, thatthe AP50 does not support operation on the 5 GHz band.
I am kinda lost here, could this be a firmware problem or is it a hardware problem?
I even attached the AP50 to my enterprise network at work, with the same result...
Attached you find the wireless log file.
2017:03:09-19:45:41 utm awed[62772]: [MASTER] new connection from 172.20.0.200:35553 2017:03:09-19:46:10 utm awed[62772]: [MASTER] new connection from 172.20.0.200:35553 2017:03:09-19:46:10 utm awed[44457]: WARN ------------------------------------------------------- 2017:03:09-19:46:10 utm awed[44457]: Use of uninitialized value in concatenation (.) or string at awed_ng.pl line 347. 2017:03:09-19:46:10 utm awed[44457]: 1 main::awed_aphandler 2017:03:09-19:46:10 utm awed[44457]: 1 2017:03:09-19:46:13 utm awed[62772]: [MASTER] new AP with ID A400022BAE70DE3 2017:03:09-19:46:14 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-19:46:14 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-19:46:14 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-19:46:14 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-19:47:26 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-19:47:27 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-19:47:27 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-19:47:27 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-19:47:27 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-19:47:27 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-19:47:37 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-19:47:37 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-19:47:37 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-19:47:37 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-19:47:37 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-19:47:37 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-19:47:37 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-19:48:36 utm awed[62772]: [MASTER] new connection from 172.20.0.200:60077 2017:03:09-19:48:36 utm awed[45094]: [A400022BAE70DE3] AP50 from 172.20.0.200:60077 identified as A400022BAE70DE3 2017:03:09-19:48:36 utm awed[45094]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-19:48:41 utm awed[45094]: [A400022BAE70DE3] sent firmware /etc/wireless/firmware/AP50.uimage to device, releasing connection. 2017:03:09-19:50:29 utm awed[62772]: [MASTER] new connection from 172.20.0.200:38885 2017:03:09-19:50:29 utm awed[45388]: [A400022BAE70DE3] AP50 from 172.20.0.200:38885 identified as A400022BAE70DE3 2017:03:09-19:50:29 utm awed[45388]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-19:50:32 utm awed[62772]: [MASTER] updating confd object for AP A400022BAE70DE3 2016:12:23-13:56:30 172.20.0.200 logread[884]: Logread connected to 172.20.0.250:415 2017:03:09-19:50:32 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-19:50:33 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-19:50:33 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-19:50:33 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-19:50:33 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-19:50:33 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-19:50:33 utm awed[62772]: [MASTER] end processing configuration change 2016:12:23-13:56:31 172.20.0.200 aweclient: Config in flash changed, reboot. 2016:12:23-13:56:31 172.20.0.200 syslog: - shutdown - 2016:12:23-13:56:31 172.20.0.200 syslog: 2017:03:09-19:51:30 utm awed[45388]: [A400022BAE70DE3] ll_read: dead socket: Resource temporarily unavailable 2017:03:09-19:51:30 utm awed[45388]: [A400022BAE70DE3] disconnected. Close socket and kill process. 2017:03:09-19:51:35 utm awed[62772]: [MASTER] new connection from 172.20.0.200:53170 2017:03:09-19:51:36 utm awed[45671]: [A400022BAE70DE3] AP50 from 172.20.0.200:53170 identified as A400022BAE70DE3 2017:03:09-19:51:36 utm awed[45671]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:56:29 172.20.0.200 logread[882]: Logread connected to 172.20.0.250:415 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.530000] device vxlan.100 entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.540000] device vxlan entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.550000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.560000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:56:29 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1133): Could not find PHY for device 'radio1' 2016:12:23-13:56:30 172.20.0.200 netifd: radio0 (1132): Could not find PHY for device 'radio0' 2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1195): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:56:30 172.20.0.200 netifd: radio0 (1200): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:56:31 172.20.0.200 kernel: [ 31.560000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2017:03:09-19:58:29 utm awed[62772]: [MASTER] new connection from 172.20.0.200:34305 2017:03:09-19:58:29 utm awed[46597]: [A400022BAE70DE3] AP50 from 172.20.0.200:34305 identified as A400022BAE70DE3 2017:03:09-19:58:29 utm awed[46597]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:56:29 172.20.0.200 logread[880]: Logread connected to 172.20.0.250:415 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is enabled 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.540000] device vxlan.100 entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.550000] device vxlan entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.570000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.570000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:56:29 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is now up 2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1130): Could not find PHY for device 'radio1' 2016:12:23-13:56:30 172.20.0.200 netifd: radio0 (1129): Could not find PHY for device 'radio0' 2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1192): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:56:30 172.20.0.200 netifd: radio0 (1199): WARNING: Variable 'data' does not exist or is not an array/object 2017:03:09-19:58:32 utm awed[45671]: [A400022BAE70DE3] ll_read: dead socket: Interrupted system call 2017:03:09-19:58:32 utm awed[45671]: [A400022BAE70DE3] disconnected. Close socket and kill process. 2016:12:23-13:56:31 172.20.0.200 kernel: [ 31.570000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2017:03:09-20:01:12 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:01:12 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:01:12 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:01:12 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:01:12 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:01:12 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-20:01:12 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:01:16 utm awed[46597]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-20:01:16 172.20.0.200 aweclient[710]: aweclient.c (2462) Exit from main loop with no error. Get new configuration. 2017:03:09-20:01:17 172.20.0.200 aweclient[710]: Cloudclient not found on ubus. 2017:03:09-20:01:18 172.20.0.200 add_radio_mapping.sh: AP50 detected: Using on-the-fly ACS procedure 2017:03:09-20:01:19 172.20.0.200 netifd: radio1 (1587): Could not find PHY for device 'radio1' 2017:03:09-20:01:19 172.20.0.200 netifd: radio0 (1586): Could not find PHY for device 'radio0' 2017:03:09-20:01:19 172.20.0.200 netifd: radio1 (1612): WARNING: Variable 'data' does not exist or is not an array/object 2017:03:09-20:01:19 172.20.0.200 netifd: radio0 (1618): WARNING: Variable 'data' does not exist or is not an array/object 2017:03:09-20:03:08 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:03:08 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:03:08 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:03:08 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:03:08 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:03:08 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:04:50 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:04:50 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:04:50 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:04:50 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:04:50 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:04:50 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-20:04:50 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:05:02 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:05:02 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:05:02 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:05:02 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:05:02 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:05:02 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:05:04 utm awed[46597]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-20:05:04 172.20.0.200 aweclient[710]: aweclient.c (2462) Exit from main loop with no error. Get new configuration. 2017:03:09-20:05:05 172.20.0.200 aweclient[710]: Cloudclient not found on ubus. 2017:03:09-20:05:06 172.20.0.200 add_radio_mapping.sh: AP50 detected: Using on-the-fly ACS procedure 2017:03:09-20:05:07 172.20.0.200 netifd: lan (769): Sending renew... 2017:03:09-20:05:07 172.20.0.200 netifd: lan (769): Received SIGTERM 2017:03:09-20:07:38 utm awed[46597]: [A400022BAE70DE3] ll_read: dead socket: Resource temporarily unavailable 2017:03:09-20:07:38 utm awed[46597]: [A400022BAE70DE3] disconnected. Close socket and kill process. 2017:03:09-20:24:21 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37533 2017:03:09-20:24:21 utm awed[51194]: [A400022BAE70DE3] AP50 from 172.20.0.200:37533 identified as A400022BAE70DE3 2017:03:09-20:24:21 utm awed[51194]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.020000] cfg80211: DFS Master region: ETSI 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.020000] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.030000] cfg80211: (2400000 KHz - 2483000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.040000] cfg80211: (5150000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.050000] cfg80211: (5250000 KHz - 5350000 KHz @ 80000 KHz), (N/A, 2000 mBm), (0 s) 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.060000] cfg80211: (5470000 KHz - 5725000 KHz @ 80000 KHz), (N/A, 2700 mBm), (0 s) 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.060000] cfg80211: (57240000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.630000] device vxlan.100 entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.640000] device vxlan entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 add_radio_mapping.sh: AP50 detected: Using on-the-fly ACS procedure 2016:12:23-13:56:29 172.20.0.200 logread[882]: Logread connected to 172.20.0.250:415 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is enabled 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.660000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.660000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:56:29 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is now up 2016:12:23-13:56:30 172.20.0.200 netifd: lan (771): Received SIGTERM 2016:12:23-13:56:37 172.20.0.200 logread[882]: Logread connected to 172.20.0.250:415 2017:03:09-20:25:28 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:25:28 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-20:25:28 utm awed[62772]: Use of uninitialized value $sorted_channels[-1] in numeric gt (>) at awed_ng.pl line 1109. 2017:03:09-20:25:28 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:26:18 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:26:18 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:27:06 utm awed[62772]: [MASTER] new connection from 172.20.0.200:43840 2017:03:09-20:27:06 utm awed[51931]: [A400022BAE70DE3] AP50 from 172.20.0.200:43840 identified as A400022BAE70DE3 2017:03:09-20:27:06 utm awed[51931]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.670000] device vxlan.100 entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.670000] device vxlan entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.700000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.700000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 logread[882]: Logread connected to 172.20.0.250:415 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is enabled 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:56:29 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is now up 2016:12:23-13:56:30 172.20.0.200 netifd: lan (782): Received SIGTERM 2016:12:23-13:56:30 172.20.0.200 netifd: Interface 'lan' is now down 2017:03:09-20:27:09 utm awed[51194]: [A400022BAE70DE3] ll_read: dead socket: Interrupted system call 2017:03:09-20:27:09 utm awed[51194]: [A400022BAE70DE3] disconnected. Close socket and kill process. 2016:12:23-13:56:37 172.20.0.200 logread[882]: Logread connected to 172.20.0.250:415 2017:03:09-20:27:27 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-20:27:26 172.20.0.200 aweclient[709]: aweclient.c (2456) Exit from main loop. 2017:03:09-20:27:26 172.20.0.200 aweclient[709]: aweclient.c (2470) Error in getting new configuration. Reconnecting (1) 2017:03:09-20:27:26 172.20.0.200 aweclient[709]: aweclient.c (277) Failed to connect to 0.0.0.0. 2017:03:09-20:27:27 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-20:27:27 utm awed[62772]: [MASTER] new connection from 172.20.0.200:43841 2017:03:09-20:27:27 172.20.0.200 aweclient[709]: json_messages.c (461) Message type is different from expected. 2017:03:09-20:27:28 172.20.0.200 aweclient[709]: aweclient.c (621) Invalid shared key, clear registered flag and retry. 2017:03:09-20:27:28 172.20.0.200 aweclient[709]: aweclient.c (2400) Cannot get a valid configuration, retry later. 2017:03:09-21:14:21 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37533 2017:03:09-21:14:21 utm awed[59961]: WARN ------------------------------------------------------- 2017:03:09-21:14:21 utm awed[59961]: Use of uninitialized value in concatenation (.) or string at awed_ng.pl line 347. 2017:03:09-21:14:21 utm awed[59961]: 1 main::awed_aphandler 2017:03:09-21:14:21 utm awed[59961]: 1 2017:03:09-21:14:24 utm awed[62772]: [MASTER] new AP with ID A400022BAE70DE3 2017:03:09-21:14:24 utm awed[62772]: WARN ------------------------------------------------------- 2017:03:09-21:14:24 utm awed[62772]: Use of uninitialized value in concatenation (.) or string at awed_ng.pl line 1673. 2017:03:09-21:14:24 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-21:14:25 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-21:14:25 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-21:14:25 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-21:14:28 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37534 2017:03:09-21:14:28 utm awed[60057]: [A400022BAE70DE3] AP50 from 172.20.0.200:37534 identified as A400022BAE70DE3 2017:03:09-21:14:28 utm awed[60057]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-21:14:28 utm awed[60057]: [A400022BAE70DE3] device not authorized yet, dropping. 2017:03:09-21:14:43 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37535 2017:03:09-21:14:43 utm awed[60089]: [A400022BAE70DE3] AP50 from 172.20.0.200:37535 identified as A400022BAE70DE3 2017:03:09-21:14:43 utm awed[60089]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-21:14:43 utm awed[60089]: [A400022BAE70DE3] device not authorized yet, dropping. 2017:03:09-21:14:58 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37536 2017:03:09-21:14:58 utm awed[60127]: [A400022BAE70DE3] AP50 from 172.20.0.200:37536 identified as A400022BAE70DE3 2017:03:09-21:14:58 utm awed[60127]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2017:03:09-21:14:58 utm awed[60127]: [A400022BAE70DE3] device not authorized yet, dropping. 2017:03:09-21:15:04 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-21:15:05 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-21:15:05 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-21:15:05 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-21:15:13 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37537 2017:03:09-21:15:13 utm awed[60405]: [A400022BAE70DE3] AP50 from 172.20.0.200:37537 identified as A400022BAE70DE3 2017:03:09-21:15:13 utm awed[60405]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.220000] cfg80211: DFS Master region: ETSI 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.240000] cfg80211: (5150000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.250000] cfg80211: (5250000 KHz - 5350000 KHz @ 80000 KHz), (N/A, 2000 mBm), (0 s) 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.260000] cfg80211: (5470000 KHz - 5725000 KHz @ 80000 KHz), (N/A, 2700 mBm), (0 s) 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.270000] cfg80211: (57240000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.790000] device vxlan.100 entered promiscuous mode 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.800000] device vxlan entered promiscuous mode 2016:12:23-13:57:23 172.20.0.200 add_radio_mapping.sh: AP50 detected: Using on-the-fly ACS procedure 2016:12:23-13:57:23 172.20.0.200 logread[908]: Logread connected to 172.20.0.250:415 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan' is enabled 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.810000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:57:23 172.20.0.200 kernel: [ 83.810000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:57:23 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:57:23 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:57:23 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:57:23 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:57:23 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:57:23 172.20.0.200 netifd: Interface 'vxlan100' is now up 2016:12:23-13:57:24 172.20.0.200 netifd: radio1 (1154): Could not find PHY for device 'radio1' 2016:12:23-13:57:24 172.20.0.200 netifd: radio0 (1153): Could not find PHY for device 'radio0' 2016:12:23-13:57:24 172.20.0.200 netifd: radio1 (1221): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:57:24 172.20.0.200 netifd: radio0 (1226): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:57:25 172.20.0.200 kernel: [ 85.810000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2017:03:09-21:16:46 utm awed[62772]: [MASTER] new connection from 172.20.0.200:37533 2017:03:09-21:16:46 utm awed[60911]: [A400022BAE70DE3] AP50 from 172.20.0.200:37533 identified as A400022BAE70DE3 2017:03:09-21:16:46 utm awed[60911]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:56:29 172.20.0.200 logread[960]: Logread connected to 172.20.0.250:415 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is enabled 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.580000] device vxlan.100 entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.590000] device vxlan entered promiscuous mode 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.600000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 kernel: [ 29.610000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:56:29 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:56:29 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:56:29 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Data bus error, epc == 82802170, ra == 82802164 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Oops[#1]: 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] CPU: 0 PID: 1327 Comm: iw Not tainted 3.10.49 #3 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] task: 838a7aa0 ti: 82b1e000 task.ti: 82b1e000 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $ 0 : 00000000 0050a134 deadc0de 00000080 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $ 4 : 828e8010 0000801c 00000080 00000000 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $ 8 : 00000000 00000000 585d2d0f 0000052f 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $12 : 02000000 82addd24 00000000 00080001 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $16 : 828e8010 828e5cd4 00000010 0000002c 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $20 : 00000004 828e8404 00000004 00000024 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $24 : 00000000 777bc364 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] $28 : 82b1e000 82b1fae8 00000008 82802164 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Hi : 00000027 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Lo : 001797ba 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] epc : 82802170 ath9k_hw_init_global_settings+0x118/0x400 [ath9k_hw] 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Not tainted 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] ra : 82802164 ath9k_hw_init_global_settings+0x10c/0x400 [ath9k_hw] 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Status: 1000d403 KERNEL EXL IE 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Cause : 1080001c 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] PrId : 00019374 (MIPS 24Kc) 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Modules linked in: ath9k ath9k_common ath9k_hw ath ledtrig_netdev mac80211 cfg80211 compat arc4 crypto_blkcipher ledtrig_timer ledtrig_default_on gpio_button_hotplug 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Process iw (pid: 1327, threadinfo=82b1e000, task=838a7aa0, tls=7783f440) 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Stack : 00000004 00000007 00000004 00000024 828e5440 828e5cd4 828e8010 00000000 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] 00000004 00000007 00000004 00000024 00000008 82862e4c 000000d0 80095444 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] 00030002 800817f0 82a99300 828e4120 00000000 00000010 828e4ac0 82f95968 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] 82addd00 00000014 00000000 00000014 828dfa00 828e4000 00000000 ffffffff 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] ffffffff 82ed6ef0 82a99300 82a99300 00000000 8019e564 00000029 82b04630 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] ... 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Call Trace: 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] [<82802170>] ath9k_hw_init_global_settings+0x118/0x400 [ath9k_hw] 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] [<82862e4c>] ath9k_ps_restore+0xf0/0x8f8 [ath9k] 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.380000] Code: 8e1300c0 02002021 3405801c <0053001b> 8e020000 0040f809 00009812 08a00866 7c542dc0 2016:12:23-13:56:30 172.20.0.200 kernel: [ 30.560000] ---[ end trace 5c9108b814015780 ]--- 2016:12:23-13:56:30 172.20.0.200 netifd: radio1 (1226): Segmentation fault 2017:03:09-21:16:49 utm awed[62772]: [MASTER] updating confd object for AP A400022BAE70DE3 2017:03:09-21:16:50 utm awed[60405]: [A400022BAE70DE3] ll_read: dead socket: Interrupted system call 2017:03:09-21:16:50 utm awed[60405]: [A400022BAE70DE3] disconnected. Close socket and kill process. 2016:12:23-13:56:31 172.20.0.200 kernel: [ 31.610000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2017:03:09-21:16:53 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-21:16:53 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-21:16:53 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-21:16:53 utm awed[62772]: [MASTER] end processing configuration change 2017:03:09-21:17:48 utm awed[60911]: [A400022BAE70DE3] ll_read: dead socket: Resource temporarily unavailable 2017:03:09-21:17:48 utm awed[60911]: [A400022BAE70DE3] disconnected. Close socket and kill process. 2017:03:09-21:20:31 utm awed[62772]: [MASTER] new connection from 172.20.0.200:45842 2017:03:09-21:20:31 utm awed[61538]: [A400022BAE70DE3] AP50 from 172.20.0.200:45842 identified as A400022BAE70DE3 2017:03:09-21:20:31 utm awed[61538]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:57:59 172.20.0.200 kernel: [ 119.190000] cfg80211: (5250000 KHz - 5350000 KHz @ 80000 KHz), (N/A, 2000 mBm), (0 s) 2016:12:23-13:57:59 172.20.0.200 kernel: [ 119.210000] cfg80211: (57240000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) 2016:12:23-13:57:59 172.20.0.200 kernel: [ 119.780000] device vxlan.100 entered promiscuous mode 2016:12:23-13:57:59 172.20.0.200 kernel: [ 119.780000] device vxlan entered promiscuous mode 2016:12:23-13:57:59 172.20.0.200 logread[884]: Logread connected to 172.20.0.250:415 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan' is enabled 2016:12:23-13:57:59 172.20.0.200 kernel: [ 119.800000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:57:59 172.20.0.200 kernel: [ 119.800000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan100' is enabled 2016:12:23-13:57:59 172.20.0.200 netifd: Network device 'vxlan' link is up 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan' has link connectivity 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan' is setting up now 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan' is now up 2016:12:23-13:57:59 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:57:59 172.20.0.200 netifd: VLAN 'vxlan.100' link is down 2016:12:23-13:57:59 172.20.0.200 netifd: VLAN 'vxlan.100' link is up 2016:12:23-13:57:59 172.20.0.200 netifd: Bridge 'br-vxlan100' link is up 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan100' has link connectivity 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan100' is setting up now 2016:12:23-13:57:59 172.20.0.200 netifd: Interface 'vxlan100' is now up 2016:12:23-13:58:00 172.20.0.200 netifd: radio1 (1183): Could not find PHY for device 'radio1' 2016:12:23-13:58:00 172.20.0.200 netifd: radio0 (1182): Could not find PHY for device 'radio0' 2016:12:23-13:58:00 172.20.0.200 netifd: radio1 (1238): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:58:00 172.20.0.200 netifd: radio0 (1251): WARNING: Variable 'data' does not exist or is not an array/object 2017:03:09-21:20:34 utm awed[62772]: [MASTER] updating confd object for AP A400022BAE70DE3 2017:03:09-21:20:34 utm awed[62772]: [MASTER] start processing configuration change 2017:03:09-21:20:34 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Local metadata updated 2017:03:09-21:20:34 utm awed[62772]: [MASTER] AP A400022BAE70DE3: Configuration change detected 2017:03:09-21:20:34 utm awed[62772]: [MASTER] end processing configuration change 2016:12:23-13:58:01 172.20.0.200 kernel: [ 121.800000] br-vxlan100: port 1(vxlan.100) entered forwarding state 2017:03:09-21:20:46 utm awed[61538]: [A400022BAE70DE3] (Re-)loaded identity and/or configuration 2016:12:23-13:58:13 172.20.0.200 aweclient[709]: aweclient.c (2462) Exit from main loop with no error. Get new configuration. 2016:12:23-13:58:14 172.20.0.200 aweclient[709]: Cloudclient not found on ubus. 2016:12:23-13:58:15 172.20.0.200 add_radio_mapping.sh: AP50 detected: Using on-the-fly ACS procedure 2016:12:23-13:58:16 172.20.0.200 netifd: radio1 (1515): Could not find PHY for device 'radio1' 2016:12:23-13:58:16 172.20.0.200 netifd: radio0 (1514): Could not find PHY for device 'radio0' 2016:12:23-13:58:16 172.20.0.200 netifd: radio1 (1540): WARNING: Variable 'data' does not exist or is not an array/object 2016:12:23-13:58:16 172.20.0.200 netifd: radio0 (1546): WARNING: Variable 'data' does not exist or is not an array/object 2017:03:09-21:22:34 utm awed[61538]: [A400022BAE70DE3] ll_read: dead socket: Resource temporarily unavailable 2017:03:09-21:22:34 utm awed[61538]: [A400022BAE70DE3] disconnected. Close socket and kill process.
Any ideas?
Kind Regards,
Julian
This thread was automatically locked due to age.