Ticket #21320: broken_and_working_log.txt

File broken_and_working_log.txt, 37.0 KB (added by anonymous, 2 years ago)
Line 
1================802.11ac BROKEN (r47772) -- see further below for a working system log from r46849================
2
3
4
5Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.584480] ath10k_pci 0000:01:00.0: Falling back to user helper
6Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.676037] firmware ath10k!cal-pci-0000:01:00.0.bin: firmware_loading_store: map pages failed
7Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.684987] ath10k_pci 0000:01:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-5.bin failed with error -2
8Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.695865] ath10k_pci 0000:01:00.0: Falling back to user helper
9Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.770500] firmware ath10k!QCA988X!hw2.0!firmware-5.bin: firmware_loading_store: map pages failed
10Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.779775] ath10k_pci 0000:01:00.0: could not fetch firmware file 'ath10k/QCA988X/hw2.0/firmware-5.bin': -11
11Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.789906] ath10k_pci 0000:01:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-4.bin failed with error -2
12Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.800758] ath10k_pci 0000:01:00.0: Falling back to user helper
13Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.876610] firmware ath10k!QCA988X!hw2.0!firmware-4.bin: firmware_loading_store: map pages failed
14Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.885884] ath10k_pci 0000:01:00.0: could not fetch firmware file 'ath10k/QCA988X/hw2.0/firmware-4.bin': -11
15Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.896011] ath10k_pci 0000:01:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-3.bin failed with error -2
16Sun Dec  6 10:03:13 2015 kern.warn kernel: [   11.906872] ath10k_pci 0000:01:00.0: Falling back to user helper
17Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.982419] firmware ath10k!QCA988X!hw2.0!firmware-3.bin: firmware_loading_store: map pages failed
18Sun Dec  6 10:03:13 2015 kern.err kernel: [   11.991697] ath10k_pci 0000:01:00.0: could not fetch firmware file 'ath10k/QCA988X/hw2.0/firmware-3.bin': -11
19Sun Dec  6 10:03:13 2015 kern.warn kernel: [   12.001822] ath10k_pci 0000:01:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware-2.bin failed with error -2
20Sun Dec  6 10:03:13 2015 kern.warn kernel: [   12.012683] ath10k_pci 0000:01:00.0: Falling back to user helper
21Sun Dec  6 10:03:13 2015 kern.err kernel: [   12.088771] firmware ath10k!QCA988X!hw2.0!firmware-2.bin: firmware_loading_store: map pages failed
22Sun Dec  6 10:03:13 2015 kern.err kernel: [   12.098045] ath10k_pci 0000:01:00.0: could not fetch firmware file 'ath10k/QCA988X/hw2.0/firmware-2.bin': -11
23Sun Dec  6 10:03:13 2015 kern.warn kernel: [   12.108170] ath10k_pci 0000:01:00.0: Direct firmware load for ath10k/QCA988X/hw2.0/firmware.bin failed with error -2
24Sun Dec  6 10:03:13 2015 kern.warn kernel: [   12.118855] ath10k_pci 0000:01:00.0: Falling back to user helper
25Sun Dec  6 10:03:13 2015 kern.err kernel: [   12.206983] firmware ath10k!QCA988X!hw2.0!firmware.bin: firmware_loading_store: map pages failed
26Sun Dec  6 10:03:13 2015 kern.err kernel: [   12.216066] ath10k_pci 0000:01:00.0: could not fetch firmware (-11)
27Sun Dec  6 10:03:13 2015 kern.err kernel: [   12.222463] ath10k_pci 0000:01:00.0: could not fetch firmware files (-11)
28Sun Dec  6 10:03:13 2015 kern.err kernel: [   12.229353] ath10k_pci 0000:01:00.0: could not probe fw (-11)
29Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.254611] ip_tables: (C) 2000-2006 Netfilter Core Team
30Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.268650] nf_conntrack version 0.5.0 (1962 buckets, 7848 max)
31Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.301475] xt_time: kernel timezone is -0000
32Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.318363] PPP generic driver version 2.4.2
33Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.324839] NET: Registered protocol family 24
34Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.343072] ath: EEPROM regdomain: 0x0
35Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.343087] ath: EEPROM indicates default country code should be used
36Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.343095] ath: doing EEPROM country->regdmn map search
37Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.343111] ath: country maps to regdmn code: 0x3a
38Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.343119] ath: Country alpha2 being used: US
39Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.343126] ath: Regpair used: 0x3a
40Sun Dec  6 10:03:13 2015 kern.debug kernel: [   12.356818] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
41Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.359187] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=47
42Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.368011] cfg80211: Regulatory domain changed to country: US
43Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.373968] cfg80211:  DFS Master region: FCC
44Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.378209] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
45Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.388100] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
46Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.396226] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (N/A)
47Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.405844] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s)
48Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.415461] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s)
49Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.423675] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
50Sun Dec  6 10:03:13 2015 kern.info kernel: [   12.431794] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
51Sun Dec  6 10:03:16 2015 kern.info kernel: [   18.139342] eth1: link up (1000Mbps/Full duplex)
52Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'lan' is enabled
53Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'lan' is setting up now
54Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'lan' is now up
55Sun Dec  6 10:03:16 2015 kern.info kernel: [   18.151853] device eth1 entered promiscuous mode
56Sun Dec  6 10:03:16 2015 kern.info kernel: [   18.152673] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
57Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'wan' is enabled
58Sun Dec  6 10:03:16 2015 kern.info kernel: [   18.173452] device eth0 entered promiscuous mode
59Sun Dec  6 10:03:16 2015 kern.info kernel: [   18.175349] br-wan: port 1(eth0) entered forwarding state
60Sun Dec  6 10:03:16 2015 kern.info kernel: [   18.175392] br-wan: port 1(eth0) entered forwarding state
61Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'loopback' is enabled
62Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'loopback' is setting up now
63Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'loopback' is now up
64Sun Dec  6 10:03:16 2015 daemon.notice netifd: Network device 'eth1' link is up
65Sun Dec  6 10:03:16 2015 daemon.notice netifd: Bridge 'br-wan' link is up
66Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'wan' has link connectivity
67Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'wan' is setting up now
68Sun Dec  6 10:03:16 2015 daemon.notice netifd: Network device 'lo' link is up
69Sun Dec  6 10:03:16 2015 daemon.notice netifd: Interface 'loopback' has link connectivity
70Sun Dec  6 10:03:16 2015 daemon.notice netifd: radio1 (1014): Could not find PHY for device 'radio1'
71Sun Dec  6 10:03:16 2015 daemon.notice netifd: wan (1061): udhcpc (v1.24.1) started
72Sun Dec  6 10:03:17 2015 daemon.notice netifd: wan (1061): Sending discover...
73Sun Dec  6 10:03:17 2015 user.notice firewall: Reloading firewall due to ifup of lan (br-lan)
74Sun Dec  6 10:03:17 2015 daemon.notice netifd: wan (1061): Performing a DHCP renew
75Sun Dec  6 10:03:17 2015 daemon.notice netifd: wan (1061): Sending discover...
76Sun Dec  6 10:03:17 2015 authpriv.warn dropbear[1091]: Failed listening on '22': Error listening: Address not available
77Sun Dec  6 10:03:17 2015 authpriv.info dropbear[1091]: Not backgrounding
78Sun Dec  6 10:03:17 2015 kern.info kernel: [   19.361780] br-lan: port 1(eth1) entered forwarding state
79Sun Dec  6 10:03:17 2015 kern.info kernel: [   19.361828] br-lan: port 1(eth1) entered forwarding state
80Sun Dec  6 10:03:17 2015 kern.info kernel: [   19.362721] br-wan: port 1(eth0) entered disabled state
81Sun Dec  6 10:03:17 2015 daemon.notice netifd: radio1 (1069): WARNING: Variable 'data' does not exist or is not an array/object
82Sun Dec  6 10:03:17 2015 daemon.notice netifd: Bridge 'br-lan' link is up
83Sun Dec  6 10:03:17 2015 daemon.notice netifd: Interface 'lan' has link connectivity
84Sun Dec  6 10:03:17 2015 kern.info kernel: [   19.425219] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
85Sun Dec  6 10:03:18 2015 daemon.notice netifd: Network device 'eth0' link is up
86Sun Dec  6 10:03:18 2015 kern.info kernel: [   19.842397] eth0: link up (1000Mbps/Full duplex)
87Sun Dec  6 10:03:18 2015 kern.info kernel: [   19.842561] br-wan: port 1(eth0) entered forwarding state
88Sun Dec  6 10:03:18 2015 kern.info kernel: [   19.842600] br-wan: port 1(eth0) entered forwarding state
89Sun Dec  6 10:03:19 2015 daemon.notice netifd: radio0 (1013): Configuration file: /var/run/hostapd-phy1.conf
90Sun Dec  6 10:03:19 2015 kern.info kernel: [   20.843375] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
91Sun Dec  6 10:03:19 2015 kern.info kernel: [   20.947827] device wlan1 entered promiscuous mode
92Sun Dec  6 10:03:19 2015 kern.info kernel: [   20.947909] br-lan: port 2(wlan1) entered forwarding state
93Sun Dec  6 10:03:19 2015 kern.info kernel: [   20.947935] br-lan: port 2(wlan1) entered forwarding state
94Sun Dec  6 10:03:19 2015 daemon.notice netifd: radio0 (1013): wlan1: interface state UNINITIALIZED->COUNTRY_UPDATE
95Sun Dec  6 10:03:19 2015 daemon.notice netifd: radio0 (1013): Using interface wlan1 with hwaddr e8:94:f6:91:2c:9f and ssid "mynetwork"
96Sun Dec  6 10:03:19 2015 user.notice : setting up led USB1
97Sun Dec  6 10:03:19 2015 user.notice : setting up led USB2
98Sun Dec  6 10:03:19 2015 user.notice : setting up led WLAN2G
99Sun Dec  6 10:03:19 2015 user.notice : setting up led WLAN5G
100Sun Dec  6 10:03:19 2015 kern.info kernel: [   21.360940] br-lan: port 1(eth1) entered forwarding state
101Sun Dec  6 10:03:19 2015 kern.info kernel: [   21.631203] br-lan: port 2(wlan1) entered disabled state
102Sun Dec  6 10:03:19 2015 daemon.info procd: - init complete -
103Sun Dec  6 10:03:19 2015 daemon.notice netifd: radio0 (1013): wlan1: interface state COUNTRY_UPDATE->ENABLED
104Sun Dec  6 10:03:19 2015 daemon.notice netifd: radio0 (1013): wlan1: AP-ENABLED
105Sun Dec  6 10:03:20 2015 kern.info kernel: [   21.782586] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
106Sun Dec  6 10:03:20 2015 kern.info kernel: [   21.782700] br-lan: port 2(wlan1) entered forwarding state
107Sun Dec  6 10:03:20 2015 kern.info kernel: [   21.782734] br-lan: port 2(wlan1) entered forwarding state
108Sun Dec  6 10:03:20 2015 kern.info kernel: [   21.840956] br-wan: port 1(eth0) entered forwarding state
109Sun Dec  6 10:03:20 2015 kern.info kernel: [   21.842010] Atheros AR8216/AR8236/AR8316 ag71xx-mdio.0:00: Port 1 is up
110Sun Dec  6 10:03:20 2015 kern.info kernel: [   21.842364] Atheros AR8216/AR8236/AR8316 ag71xx-mdio.0:00: Port 2 is up
111Sun Dec  6 10:03:20 2015 daemon.notice netifd: Network device 'wlan1' link is up
112Sun Dec  6 10:03:20 2015 daemon.notice netifd: wan (1061): Sending discover...
113Sun Dec  6 10:03:20 2015 daemon.notice netifd: wan (1061): Sending select for xx.xxx.xxx.xxx...
114Sun Dec  6 10:03:21 2015 daemon.notice netifd: wan (1061): Lease of xx.xxx.xxx.xxx obtained, lease time 86400
115Sun Dec  6 10:03:21 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx IEEE 802.11: authenticated
116Sun Dec  6 10:03:21 2015 daemon.notice netifd: Interface 'wan6' is enabled
117Sun Dec  6 10:03:21 2015 daemon.notice netifd: Network alias 'br-wan' link is up
118Sun Dec  6 10:03:21 2015 daemon.notice netifd: Interface 'wan6' has link connectivity
119Sun Dec  6 10:03:21 2015 daemon.notice netifd: Interface 'wan6' is setting up now
120Sun Dec  6 10:03:21 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx IEEE 802.11: associated (aid 1)
121Sun Dec  6 10:03:21 2015 daemon.notice netifd: Interface 'wan' is now up
122Sun Dec  6 10:03:21 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
123Sun Dec  6 10:03:22 2015 kern.info kernel: [   23.780924] br-lan: port 2(wlan1) entered forwarding state
124Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: started, version 2.75 cachesize 150
125Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC loop-detect inotify
126Sun Dec  6 10:03:22 2015 daemon.info dnsmasq-dhcp[1296]: DHCP, IP range xxx.xxx.x.xxx -- xxx.xxx.x.xxx, lease time 365d4h
127Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: using local addresses only for domain lan
128Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: reading /tmp/resolv.conf.auto
129Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: using local addresses only for domain lan
130Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: using nameserver xxx.xx.x.xx#53
131Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: using nameserver xxx.xx.x.xx#53
132Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: using nameserver x.x.x.x#53
133Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: read /etc/hosts - 1 addresses
134Sun Dec  6 10:03:22 2015 daemon.info dnsmasq[1296]: read /tmp/hosts/dhcp - 1 addresses
135Sun Dec  6 10:03:22 2015 daemon.info dnsmasq-dhcp[1296]: read /etc/ethers - 0 addresses
136Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1296]: exiting on receipt of SIGTERM
137Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: started, version 2.75 cachesize 150
138Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC loop-detect inotify
139Sun Dec  6 10:03:23 2015 daemon.info dnsmasq-dhcp[1367]: DHCP, IP range xxx.xxx.x.xxx -- xxx.xxx.x.xxx, lease time 365d4h
140Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: using local addresses only for domain lan
141Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: reading /tmp/resolv.conf.auto
142Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: using local addresses only for domain lan
143Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
144Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
145Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: using nameserver x.x.x.x#53
146Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: read /etc/hosts - 1 addresses
147Sun Dec  6 10:03:23 2015 daemon.info dnsmasq[1367]: read /tmp/hosts/dhcp - 1 addresses
148Sun Dec  6 10:03:23 2015 daemon.info dnsmasq-dhcp[1367]: read /etc/ethers - 0 addresses
149Sun Dec  6 10:03:23 2015 user.notice firewall: Reloading firewall due to ifup of wan (br-wan)
150Sun Dec  6 10:03:24 2015 user.notice ddns-scripts[1454]: script1: PID '1454' started at 2015-12-06 10:03
151Sun Dec  6 10:03:24 2015 user.notice ddns-scripts[1453]: script2: PID '1453' started at 2015-12-06 10:03
152Sun Dec  6 10:03:54 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx IEEE 802.11: authenticated
153Sun Dec  6 10:03:54 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx IEEE 802.11: associated (aid 2)
154Sun Dec  6 10:03:54 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
155Sun Dec  6 10:03:54 2015 daemon.info dnsmasq-dhcp[1367]: DHCPREQUEST(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx:xx
156Sun Dec  6 10:03:54 2015 daemon.info dnsmasq-dhcp[1367]: DHCPACK(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx:xx Client2
157Sun Dec  6 10:03:56 2015 user.warn ddns-scripts[1453]: script2: NO valid IP found
158Sun Dec  6 10:03:59 2015 daemon.notice netifd: Interface 'wan6' is now up
159Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: reading /tmp/resolv.conf.auto
160Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: using local addresses only for domain lan
161Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
162Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
163Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: using nameserver x.x.x.x#53
164Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: using nameserver 2001:578:3f::30#53
165Sun Dec  6 10:03:59 2015 daemon.info dnsmasq[1367]: using nameserver 2001:578:3f:1::30#53
166Sun Dec  6 10:03:59 2015 user.notice firewall: Reloading firewall due to ifup of wan6 (br-wan)
167Sun Dec  6 10:04:09 2015 kern.notice kernel: [   43.366401] random: nonblocking pool is initialized
168Sun Dec  6 10:04:24 2015 daemon.notice netifd: Interface 'wan6' has lost the connection
169Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: reading /tmp/resolv.conf.auto
170Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using local addresses only for domain lan
171Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
172Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
173Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver x.x.x.x#53
174Sun Dec  6 10:04:24 2015 daemon.notice netifd: Interface 'wan6' is now up
175Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: reading /tmp/resolv.conf.auto
176Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using local addresses only for domain lan
177Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
178Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver xxx.xx.x.xx#53
179Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver x.x.x.x#53
180Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver 2001:578:3f::30#53
181Sun Dec  6 10:04:24 2015 daemon.info dnsmasq[1367]: using nameserver 2001:578:3f:1::30#53
182Sun Dec  6 10:04:25 2015 user.notice firewall: Reloading firewall due to ifup of wan6 (br-wan)
183Sun Dec  6 10:04:29 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx IEEE 802.11: authenticated
184Sun Dec  6 10:04:29 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx IEEE 802.11: associated (aid 3)
185Sun Dec  6 10:04:29 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
186Sun Dec  6 10:04:29 2015 daemon.info dnsmasq-dhcp[1367]: DHCPREQUEST(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx:xx
187Sun Dec  6 10:04:29 2015 daemon.info dnsmasq-dhcp[1367]: DHCPACK(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx:xx Client3
188
189
190
191
192
193================802.11ac working r46849================
194
195Sun Dec  6 09:24:59 2015 kern.info kernel: [   14.090000] PPP generic driver version 2.4.2
196Sun Dec  6 09:24:59 2015 kern.info kernel: [   14.090000] NET: Registered protocol family 24
197Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.110000] ath: EEPROM regdomain: 0x0
198Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.110000] ath: EEPROM indicates default country code should be used
199Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.110000] ath: doing EEPROM country->regdmn map search
200Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.110000] ath: country maps to regdmn code: 0x3a
201Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.110000] ath: Country alpha2 being used: US
202Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.110000] ath: Regpair used: 0x3a
203Sun Dec  6 09:24:59 2015 kern.debug kernel: [   14.120000] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
204Sun Dec  6 09:24:59 2015 kern.info kernel: [   14.130000] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=47
205Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'lan' is enabled
206Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'lan' is setting up now
207Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'lan' is now up
208Sun Dec  6 09:25:03 2015 kern.info kernel: [   20.380000] eth1: link up (1000Mbps/Full duplex)
209Sun Dec  6 09:25:03 2015 kern.info kernel: [   20.380000] device eth1 entered promiscuous mode
210Sun Dec  6 09:25:03 2015 kern.info kernel: [   20.380000] IPv6: ADDRCONF(NETDEV_UP): br-lan: link is not ready
211Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'wan' is enabled
212Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'loopback' is enabled
213Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'loopback' is setting up now
214Sun Dec  6 09:25:03 2015 kern.info kernel: [   20.390000] device eth0 entered promiscuous mode
215Sun Dec  6 09:25:03 2015 kern.info kernel: [   20.390000] br-wan: port 1(eth0) entered forwarding state
216Sun Dec  6 09:25:03 2015 kern.info kernel: [   20.390000] br-wan: port 1(eth0) entered forwarding state
217Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'loopback' is now up
218Sun Dec  6 09:25:03 2015 daemon.notice netifd: Network device 'eth1' link is up
219Sun Dec  6 09:25:03 2015 daemon.notice netifd: Bridge 'br-wan' link is up
220Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'wan' has link connectivity
221Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'wan' is setting up now
222Sun Dec  6 09:25:03 2015 daemon.notice netifd: Network device 'lo' link is up
223Sun Dec  6 09:25:03 2015 daemon.notice netifd: Interface 'loopback' has link connectivity
224Sun Dec  6 09:25:04 2015 daemon.notice netifd: wan (950): udhcpc (v1.23.2) started
225Sun Dec  6 09:25:04 2015 daemon.notice netifd: wan (950): Sending discover...
226Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.410000] br-lan: port 1(eth1) entered forwarding state
227Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.410000] br-lan: port 1(eth1) entered forwarding state
228Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.410000] br-wan: port 1(eth0) entered disabled state
229Sun Dec  6 09:25:04 2015 daemon.notice netifd: Bridge 'br-lan' link is up
230Sun Dec  6 09:25:04 2015 daemon.notice netifd: Interface 'lan' has link connectivity
231Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.420000] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
232Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211: Calling CRDA for country: SG
233Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211: Regulatory domain changed to country: SG
234Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:  DFS Master region: FCC
235Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
236Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
237Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A)
238Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2400 mBm), (0 s)
239Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2400 mBm), (0 s)
240Sun Dec  6 09:25:04 2015 kern.info kernel: [   21.510000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
241Sun Dec  6 09:25:04 2015 daemon.notice netifd: wan (950): Performing a DHCP renew
242Sun Dec  6 09:25:04 2015 daemon.notice netifd: wan (950): Sending discover...
243Sun Dec  6 09:25:05 2015 user.notice firewall: Reloading firewall due to ifup of lan (br-lan)
244Sun Dec  6 09:25:05 2015 daemon.notice netifd: Network device 'eth0' link is up
245Sun Dec  6 09:25:05 2015 kern.info kernel: [   22.060000] eth0: link up (1000Mbps/Full duplex)
246Sun Dec  6 09:25:05 2015 kern.info kernel: [   22.060000] br-wan: port 1(eth0) entered forwarding state
247Sun Dec  6 09:25:05 2015 kern.info kernel: [   22.060000] br-wan: port 1(eth0) entered forwarding state
248Sun Dec  6 09:25:05 2015 authpriv.warn dropbear[1012]: Failed loading /etc/dropbear/dropbear_ecdsa_host_key
249Sun Dec  6 09:25:05 2015 authpriv.warn dropbear[1012]: Failed listening on '22': Error listening: Cannot assign requested address
250Sun Dec  6 09:25:05 2015 authpriv.info dropbear[1012]: Not backgrounding
251Sun Dec  6 09:25:06 2015 kern.info kernel: [   23.410000] br-lan: port 1(eth1) entered forwarding state
252Sun Dec  6 09:25:06 2015 daemon.notice netifd: radio1 (917): Configuration file: /var/run/hostapd-phy0.conf
253Sun Dec  6 09:25:06 2015 daemon.notice netifd: radio0 (916): Configuration file: /var/run/hostapd-phy1.conf
254Sun Dec  6 09:25:07 2015 kern.warn kernel: [   23.920000] ath10k_pci 0000:01:00.0: otp stream is empty, using board.bin contents
255Sun Dec  6 09:25:07 2015 kern.info kernel: [   24.060000] br-wan: port 1(eth0) entered forwarding state
256Sun Dec  6 09:25:07 2015 kern.info kernel: [   24.110000] Atheros AR8216/AR8236/AR8316 ag71xx-mdio.0:00: Port 1 is up
257Sun Dec  6 09:25:07 2015 kern.info kernel: [   24.110000] Atheros AR8216/AR8236/AR8316 ag71xx-mdio.0:00: Port 2 is up
258Sun Dec  6 09:25:07 2015 daemon.notice netifd: wan (950): Sending discover...
259Sun Dec  6 09:25:07 2015 daemon.notice netifd: wan (950): Sending select for xx.xxx.xxx.xxx...
260Sun Dec  6 09:25:07 2015 daemon.notice netifd: wan (950): Lease of xx.xxx.xxx.xxx obtained, lease time 86400
261Sun Dec  6 09:25:08 2015 user.emerg syslog: setting up led USB1
262Sun Dec  6 09:25:08 2015 user.emerg syslog: setting up led USB2
263Sun Dec  6 09:25:08 2015 user.emerg syslog: setting up led WLAN2G
264Sun Dec  6 09:25:08 2015 user.emerg syslog: setting up led WLAN5G
265Sun Dec  6 09:25:08 2015 daemon.info procd: - init complete -
266Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.040000] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
267Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.060000] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
268Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.070000] device wlan0 entered promiscuous mode
269Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] device wlan1 entered promiscuous mode
270Sun Dec  6 09:25:09 2015 daemon.notice netifd: Interface 'wan6' is enabled
271Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211: Calling CRDA for country: US
272Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211: Regulatory domain changed to country: US
273Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:  DFS Master region: FCC
274Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
275Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
276Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A)
277Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s)
278Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
279Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.080000] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
280Sun Dec  6 09:25:09 2015 daemon.notice netifd: Network alias 'br-wan' link is up
281Sun Dec  6 09:25:09 2015 daemon.notice netifd: Interface 'wan6' has link connectivity
282Sun Dec  6 09:25:09 2015 daemon.notice netifd: Interface 'wan6' is setting up now
283Sun Dec  6 09:25:09 2015 daemon.notice netifd: Interface 'wan' is now up
284Sun Dec  6 09:25:09 2015 daemon.notice netifd: radio1 (917): wlan0: interface state UNINITIALIZED->COUNTRY_UPDATE
285Sun Dec  6 09:25:09 2015 daemon.notice netifd: radio1 (917): wlan0: interface state COUNTRY_UPDATE->HT_SCAN
286Sun Dec  6 09:25:09 2015 daemon.notice netifd: radio0 (916): wlan1: interface state UNINITIALIZED->COUNTRY_UPDATE
287Sun Dec  6 09:25:09 2015 daemon.notice netifd: radio0 (916): Using interface wlan1 with hwaddr xx:xx:xx:xx:xx:xx and ssid "mynetwork"
288Sun Dec  6 09:25:09 2015 daemon.notice netifd: radio0 (916): wlan1: interface state COUNTRY_UPDATE->ENABLED
289Sun Dec  6 09:25:09 2015 daemon.notice netifd: radio0 (916): wlan1: AP-ENABLED
290Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.720000] br-lan: port 3(wlan1) entered forwarding state
291Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.720000] br-lan: port 3(wlan1) entered forwarding state
292Sun Dec  6 09:25:09 2015 kern.info kernel: [   26.720000] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
293Sun Dec  6 09:25:09 2015 daemon.notice netifd: Network device 'wlan1' link is up
294Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: started, version 2.73 cachesize 150
295Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC loop-detect inotify
296Sun Dec  6 09:25:10 2015 daemon.info dnsmasq-dhcp[1273]: DHCP, IP range xxx.xxx.x.xxx -- xxx.xxx.x.xxx, lease time 365d4h
297Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: using local addresses only for domain lan
298Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: reading /tmp/resolv.conf.auto
299Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: using local addresses only for domain lan
300Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: using nameserver xxx.xx.x.xx#53
301Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: using nameserver xxx.xx.x.xx#53
302Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: using nameserver x.x.x.x#53
303Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: read /etc/hosts - 1 addresses
304Sun Dec  6 09:25:10 2015 daemon.info dnsmasq[1273]: read /tmp/hosts/dhcp - 1 addresses
305Sun Dec  6 09:25:10 2015 daemon.info dnsmasq-dhcp[1273]: read /etc/ethers - 0 addresses
306Sun Dec  6 09:25:10 2015 daemon.notice netifd: radio1 (917): Using interface wlan0 with hwaddr xx:xx:xx:xx:xx:xx and ssid "mynetwork-AC"
307Sun Dec  6 09:25:11 2015 daemon.info dnsmasq[1273]: exiting on receipt of SIGTERM
308Sun Dec  6 09:25:11 2015 user.notice firewall: Reloading firewall due to ifup of wan (br-wan)
309Sun Dec  6 09:25:11 2015 kern.info kernel: [   28.720000] br-lan: port 3(wlan1) entered forwarding state
310Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: started, version 2.73 cachesize 150
311Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC loop-detect inotify
312Sun Dec  6 09:25:12 2015 daemon.info dnsmasq-dhcp[1343]: DHCP, IP range xxx.xxx.x.xxx -- xxx.xxx.x.xxx, lease time 365d4h
313Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using local addresses only for domain lan
314Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: reading /tmp/resolv.conf.auto
315Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using local addresses only for domain lan
316Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver xxx.xx.x.xx#53
317Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using using nameserver xxx.xx.x.xx#53
318Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver x.x.x.x#53
319Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: read /etc/hosts - 1 addresses
320Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: read /tmp/hosts/dhcp - 1 addresses
321Sun Dec  6 09:25:12 2015 daemon.notice hostapd: wlan1: STA xx:xx:xx:xx:xx:64 IEEE 802.11: did not acknowledge authentication response
322Sun Dec  6 09:25:12 2015 daemon.notice hostapd: wlan1: STA xx:xx:xx:xx:xx:64 IEEE 802.11: did not acknowledge authentication response
323Sun Dec  6 09:25:12 2015 daemon.info dnsmasq-dhcp[1343]: read /etc/ethers - 0 addresses
324Sun Dec  6 09:25:12 2015 daemon.notice hostapd: wlan1: STA xx:xx:xx:xx:xx:64 IEEE 802.11: did not acknowledge authentication response
325Sun Dec  6 09:25:12 2015 kern.info kernel: [   29.130000] br-lan: port 2(wlan0) entered forwarding state
326Sun Dec  6 09:25:12 2015 kern.info kernel: [   29.130000] br-lan: port 2(wlan0) entered forwarding state
327Sun Dec  6 09:25:12 2015 kern.info kernel: [   29.130000] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
328Sun Dec  6 09:25:12 2015 daemon.notice netifd: Interface 'wan6' is now up
329Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: reading /tmp/resolv.conf.auto
330Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using local addresses only for domain lan
331Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver xxx.xx.x.xx#53
332Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver xxx.xx.x.xx#53
333Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver x.x.x.x#53
334Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver 2001:578:3f::30#53
335Sun Dec  6 09:25:12 2015 daemon.info dnsmasq[1343]: using nameserver 2001:578:3f:1::30#53
336Sun Dec  6 09:25:12 2015 daemon.notice netifd: radio1 (917): wlan0: interface state HT_SCAN->ENABLED
337Sun Dec  6 09:25:12 2015 daemon.notice netifd: radio1 (917): wlan0: AP-ENABLED
338Sun Dec  6 09:25:12 2015 daemon.notice netifd: Network device 'wlan0' link is up
339Sun Dec  6 09:25:13 2015 user.notice ddns-scripts[1453]: script1: PID '1453' started at 2015-12-06 09:25
340Sun Dec  6 09:25:13 2015 user.notice ddns-scripts[1452]: script2: PID '1452' started at 2015-12-06 09:25
341Sun Dec  6 09:25:13 2015 user.notice firewall: Reloading firewall due to ifup of wan6 (br-wan)
342Sun Dec  6 09:25:14 2015 kern.info kernel: [   31.130000] br-lan: port 2(wlan0) entered forwarding state
343Sun Dec  6 09:25:14 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:64 IEEE 802.11: authenticated
344Sun Dec  6 09:25:14 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:64 IEEE 802.11: associated (aid 1)
345Sun Dec  6 09:25:15 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:64 RADIUS: starting accounting session 56644545-00000000
346Sun Dec  6 09:25:15 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:64 WPA: pairwise key handshake completed (RSN)
347Sun Dec  6 09:25:18 2015 user.warn ddns-scripts[1452]: script2: NO valid IP found
348Sun Dec  6 09:25:19 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx IEEE 802.11: authenticated
349Sun Dec  6 09:25:19 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx IEEE 802.11: associated (aid 2)
350Sun Dec  6 09:25:19 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx RADIUS: starting accounting session 56644545-00000001
351Sun Dec  6 09:25:19 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
352Sun Dec  6 09:25:19 2015 daemon.info dnsmasq-dhcp[1343]: DHCPREQUEST(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx
353Sun Dec  6 09:25:19 2015 daemon.info dnsmasq-dhcp[1343]: DHCPACK(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx Client4
354Sun Dec  6 09:26:01 2015 kern.notice kernel: [   44.170000] random: nonblocking pool is initialized
355Sun Dec  6 09:26:07 2015 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx IEEE 802.11: authenticated
356Sun Dec  6 09:26:07 2015 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx IEEE 802.11: associated (aid 1)
357Sun Dec  6 09:26:07 2015 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx RADIUS: starting accounting session 56644547-00000000
358Sun Dec  6 09:26:07 2015 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
359Sun Dec  6 09:26:07 2015 daemon.info dnsmasq-dhcp[1343]: DHCPREQUEST(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx
360Sun Dec  6 09:26:07 2015 daemon.info dnsmasq-dhcp[1343]: DHCPACK(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx Client1
361Sun Dec  6 09:26:17 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx IEEE 802.11: authenticated
362Sun Dec  6 09:26:17 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx IEEE 802.11: associated (aid 3)
363Sun Dec  6 09:26:17 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx RADIUS: starting accounting session 56644545-00000002
364Sun Dec  6 09:26:17 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
365Sun Dec  6 09:26:17 2015 daemon.info dnsmasq-dhcp[1343]: DHCPREQUEST(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx
366Sun Dec  6 09:26:17 2015 daemon.info dnsmasq-dhcp[1343]: DHCPACK(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx Client3
367Sun Dec  6 09:27:09 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx IEEE 802.11: authenticated
368Sun Dec  6 09:27:09 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx IEEE 802.11: associated (aid 4)
369Sun Dec  6 09:27:09 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx RADIUS: starting accounting session 56644545-00000003
370Sun Dec  6 09:27:09 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
371Sun Dec  6 09:27:09 2015 daemon.info dnsmasq-dhcp[1343]: DHCPREQUEST(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx
372Sun Dec  6 09:27:09 2015 daemon.info dnsmasq-dhcp[1343]: DHCPACK(br-lan) xxx.xxx.x.xxx xx:xx:xx:xx:xx Client2
373Sun Dec  6 09:35:43 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx WPA: group key handshake completed (RSN)
374Sun Dec  6 09:35:43 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx:64 WPA: group key handshake completed (RSN)
375Sun Dec  6 09:35:44 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx WPA: group key handshake completed (RSN)
376Sun Dec  6 09:35:44 2015 daemon.info hostapd: wlan1: STA xx:xx:xx:xx:xx WPA: group key handshake completed (RSN)
377Sun Dec  6 09:35:45 2015 daemon.info hostapd: wlan0: STA xx:xx:xx:xx:xx WPA: group key handshake completed (RSN)