kaloz / mwlwifi

mac80211 driver for the Marvell 88W8864 802.11ac chip
395 stars 119 forks source link

Connection regularly interrupted with 802.11g only devices and mwlwifi >= 10.3.4.0-20170606 #192

Closed haribert closed 7 years ago

haribert commented 7 years ago

I summarise what I described in thread #170:

I have a Squeezbox Radio which lose the connection to the WRT3200acm with LEDE 17.01.02 regularly. Normally a song plays for around 10 minutes, then the connection is gone and 10 minutes later the Squeezebox Radio is able to connect again. But the connection is not stable for more than around 10 minutes.

The device has 802.11g only.

This issue was not present with LEDE 17.01.01.

Updated LEDE to the version of @yuhhaurlin from following post. It is still present. The following information (system and log) is from the LEDE image in this post.

Connections from my notebook are stable.

WLAN Settings: 2017-07-13 09 33 53 pm

root@lede:~# uname -a
Linux lede 4.9.20 #0 SMP Thu May 11 20:43:01 2017 armv7l GNU/Linux
root@lede:~# opkg info kmod-mwlwifi
Package: kmod-mwlwifi
Version: 4.9.34+10.3.4.0.git-2017-06-06-1
Depends: kernel (= 4.9.34-1-3f04ebeb2838192b4ae77cada9d460d2), kmod-mac80211
Status: unknown ok not-installed
Section: kernel
Architecture: arm_cortex-a9_vfpv3
Size: 711019
Filename: kmod-mwlwifi_4.9.34+10.3.4.0.git-2017-06-06-1_arm_cortex-a9_vfpv3.ipk
Description: Marvell 88W8864 wireless driver

Package: kmod-mwlwifi
Version: 4.9.20+10.3.2.0-20170110-1
Depends: kernel (= 4.9.20-1-4f05d0359e98317d9b1483015bd88598), kmod-mac80211
Status: install user installed
Architecture: arm_cortex-a9_vfpv3
Installed-Time: 1494535381

root@lede:~# cat /sys/kernel/debug/ieee80211/phy0/mwlwifi/info

driver name: mwlwifi
chip type: 88W8964
hw version: 7
driver version: 10.3.4.0-20170713
firmware version: 0x09030007
power table loaded from dts: no
firmware region code: 0x30
mac address: 60:38:e0:b6:70:da
2g: disable
5g: enable
antenna: 4 4
irq number: 45
ap macid support: 0000ffff
sta macid support: 00010000
macid used: 00000001
radio: enable
iobase0: e0e00000
iobase1: e1080000
tx limit: 1024
rx limit: 16384

root@lede:~# cat /etc/banner
     _________
    /        /\      _    ___ ___  ___
   /  LE    /  \    | |  | __|   \| __|
  /    DE  /    \   | |__| _|| |) | _|
 /________/  LE  \  |____|___|___/|___|                      lede-project.org
 \        \   DE /
  \    LE  \    /  -----------------------------------------------------------
   \  DE    \  /    Reboot (SNAPSHOT, r4114-6704410)
    \________\/    -----------------------------------------------------------

Corresponding Log:

root@lede:~# dmesg
[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 4.9.20 (dlin@mtl-wifi-apsw) (gcc version 5.4.0 (LEDE GCC 5.4.0 r4114-6704410) ) #0 SMP Thu May 11 20:43:01 2017
[    0.000000] CPU: ARMv7 Processor [414fc091] revision 1 (ARMv7), cr=10c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] OF: fdt:Machine model: Linksys WRT3200ACM
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] On node 0 totalpages: 131072
[    0.000000] free_area_init_node: node 0, pgdat c061ef80, node_mem_map dfbf9000
[    0.000000]   Normal zone: 1024 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 131072 pages, LIFO batch:31
[    0.000000] percpu: Embedded 13 pages/cpu @dfbce000 s22732 r8192 d22324 u53248
[    0.000000] pcpu-alloc: s22732 r8192 d22324 u53248 alloc=13*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 130048
[    0.000000] Kernel command line: console=ttyS0,115200 root=/dev/mtdblock8 ro rootdelay=1 rootfstype=jffs2 earlyprintk mtdparts=armada-nand:2048K(uboot)ro,128K(u_env),256K(s_env),256K@8064K(devinfo),1920K@8320K(sysdiag),80m@10m(kernel),74m@16m(rootfs),80m@90m(alt_kernel),74m@96m(alt_rootfs),160m@10m(ubifs),-@170m(syscfg)
[    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Memory: 513012K/524288K available (4434K kernel code, 174K rwdata, 1220K rodata, 268K init, 304K bss, 11276K reserved, 0K cma-reserved, 0K highmem)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xe0800000 - 0xff800000   ( 496 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
[    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[    0.000000]       .text : 0xc0008000 - 0xc045cc28   (4436 kB)
[    0.000000]       .init : 0xc05b1000 - 0xc05f4000   ( 268 kB)
[    0.000000]       .data : 0xc05f4000 - 0xc061f880   ( 175 kB)
[    0.000000]        .bss : 0xc061f880 - 0xc066baa0   ( 305 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000]  RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] mvebu_mbus: [Firmware Warn]: deprecated mbus-mvebu Device Tree, suspend/resume will not work
[    0.000000] L2C-310 enabling early BRESP for Cortex-A9
[    0.000000] L2C-310 full line of zeros enabled for Cortex-A9
[    0.000000] L2C-310 D prefetch enabled, offset 1 lines
[    0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[    0.000000] L2C-310 Coherent cache controller enabled, 16 ways, 1024 kB
[    0.000000] L2C-310 Coherent: CACHE_ID 0x410054c9, AUX_CTRL 0x56070001
[    0.000000] Selected CPU frequency (16) unsupported
[    0.000000] Switching to timer-based delay loop, resolution 40ns
[    0.000003] sched_clock: 32 bits at 25MHz, resolution 40ns, wraps every 85899345900ns
[    0.000008] clocksource: armada_370_xp_clocksource: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 76450417870 ns
[    0.000113] Calibrating local timer... 933.21MHz.
[    0.060032] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=250000)
[    0.060038] pid_max: default: 32768 minimum: 301
[    0.060075] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.060079] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.060271] CPU: Testing write buffer coherency: ok
[    0.060361] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[    0.060371] Setting up static identity map for 0x8280 - 0x82d8
[    0.060430] mvebu-soc-id: MVEBU SoC ID=0x6820, Rev=0x4
[    0.060489] mvebu-pmsu: Initializing Power Management Service Unit
[    0.060897] Booting CPU 1
[    0.061035] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[    0.061064] Brought up 2 CPUs
[    0.061069] SMP: Total of 2 processors activated (100.00 BogoMIPS).
[    0.061072] CPU: All CPU(s) started in SVC mode.
[    0.062730] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[    0.062780] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.062787] futex hash table entries: 512 (order: 3, 32768 bytes)
[    0.062820] pinctrl core: initialized pinctrl subsystem
[    0.063075] NET: Registered protocol family 16
[    0.063508] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.090055] cpuidle: using governor ladder
[    0.090185] mvebu-pmsu: CPU hotplug support is currently broken on Armada 38x: disabling
[    0.090190] mvebu-pmsu: CPU idle is currently broken on Armada 38x: disabling
[    0.120458] reg-fixed-voltage xhci0-vbus: could not find pctldev for node /soc/internal-regs/pinctrl@18000/xhci0-vbus-pins, deferring probe
[    0.120588] SCSI subsystem initialized
[    0.120726] libata version 3.00 loaded.
[    0.120827] usbcore: registered new interface driver usbfs
[    0.120852] usbcore: registered new interface driver hub
[    0.120872] usbcore: registered new device driver usb
[    0.121365] clocksource: Switched to clocksource armada_370_xp_clocksource
[    0.121664] NET: Registered protocol family 2
[    0.121861] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[    0.121883] TCP bind hash table entries: 4096 (order: 3, 32768 bytes)
[    0.121913] TCP: Hash tables configured (established 4096 bind 4096)
[    0.121931] UDP hash table entries: 256 (order: 1, 8192 bytes)
[    0.121942] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[    0.121996] NET: Registered protocol family 1
[    0.122007] PCI: CLS 0 bytes, default 64
[    0.122878] Crashlog allocated RAM at address 0x3f00000
[    0.123049] workingset: timestamp_bits=30 max_order=17 bucket_order=0
[    0.125066] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.125071] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    0.125815] io scheduler noop registered
[    0.125820] io scheduler deadline registered (default)
[    0.126195] armada-38x-pinctrl f1018000.pinctrl: registered pinctrl driver
[    0.126790] mvebu-pcie soc:pcie-controller: PCI host bridge to bus 0000:00
[    0.126798] pci_bus 0000:00: root bus resource [io  0x1000-0xfffff]
[    0.126803] pci_bus 0000:00: root bus resource [mem 0xe0000000-0xe7ffffff]
[    0.126807] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.126820] pci 0000:00:01.0: [11ab:6820] type 01 class 0x060400
[    0.126902] pci 0000:00:02.0: [11ab:6820] type 01 class 0x060400
[    0.126979] PCI: bus0: Fast back to back transfers disabled
[    0.126984] pci 0000:00:01.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    0.126990] pci 0000:00:02.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    0.127038] pci 0000:01:00.0: [11ab:2b40] type 00 class 0x020000
[    0.127054] pci 0000:01:00.0: reg 0x10: [mem 0x40000000-0x401fffff 64bit pref]
[    0.127063] pci 0000:01:00.0: reg 0x18: [mem 0x40200000-0x402fffff 64bit pref]
[    0.127123] pci 0000:01:00.0: supports D1 D2
[    0.127126] pci 0000:01:00.0: PME# supported from D0 D1 D3hot D3cold
[    0.127191] PCI: bus1: Fast back to back transfers disabled
[    0.127197] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[    0.127248] pci 0000:02:00.0: [11ab:2b40] type 00 class 0x020000
[    0.127267] pci 0000:02:00.0: reg 0x10: [mem 0x42000000-0x421fffff 64bit pref]
[    0.127278] pci 0000:02:00.0: reg 0x18: [mem 0x42200000-0x422fffff 64bit pref]
[    0.127358] pci 0000:02:00.0: supports D1 D2
[    0.127361] pci 0000:02:00.0: PME# supported from D0 D1 D3hot D3cold
[    0.127423] PCI: bus2: Fast back to back transfers disabled
[    0.127428] pci_bus 0000:02: busn_res: [bus 02-ff] end is updated to 02
[    0.127498] pci 0000:00:01.0: BAR 8: assigned [mem 0xe0000000-0xe02fffff]
[    0.127504] pci 0000:00:02.0: BAR 8: assigned [mem 0xe0400000-0xe06fffff]
[    0.127509] pci 0000:01:00.0: BAR 0: assigned [mem 0xe0000000-0xe01fffff 64bit pref]
[    0.127518] pci 0000:01:00.0: BAR 2: assigned [mem 0xe0200000-0xe02fffff 64bit pref]
[    0.127526] pci 0000:00:01.0: PCI bridge to [bus 01]
[    0.127531] pci 0000:00:01.0:   bridge window [mem 0xe0000000-0xe02fffff]
[    0.127538] pci 0000:02:00.0: BAR 0: assigned [mem 0xe0400000-0xe05fffff 64bit pref]
[    0.127547] pci 0000:02:00.0: BAR 2: assigned [mem 0xe0600000-0xe06fffff 64bit pref]
[    0.127556] pci 0000:00:02.0: PCI bridge to [bus 02]
[    0.127560] pci 0000:00:02.0:   bridge window [mem 0xe0400000-0xe06fffff]
[    0.127760] mv_xor f1060800.xor: Marvell shared XOR driver
[    0.181779] mv_xor f1060800.xor: Marvell XOR (Descriptor Mode): ( xor cpy intr )
[    0.181864] mv_xor f1060900.xor: Marvell shared XOR driver
[    0.241743] mv_xor f1060900.xor: Marvell XOR (Descriptor Mode): ( xor cpy intr )
[    0.241882] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[    0.242140] console [ttyS0] disabled
[    0.262199] f1012000.serial: ttyS0 at MMIO 0xf1012000 (irq = 21, base_baud = 12500000) is a 16550A
[    0.983142] console [ttyS0] enabled
[    0.988509] loop: module loaded
[    0.991903] ahci-mvebu f10a8000.sata: AHCI 0001.0000 32 slots 2 ports 6 Gbps 0x3 impl platform mode
[    1.000988] ahci-mvebu f10a8000.sata: flags: 64bit ncq sntf led only pmp fbs pio slum part sxs
[    1.010100] scsi host0: ahci-mvebu
[    1.013661] scsi host1: ahci-mvebu
[    1.017148] ata1: SATA max UDMA/133 mmio [mem 0xf10a8000-0xf10a9fff] port 0x100 irq 41
[    1.025106] ata2: SATA max UDMA/133 mmio [mem 0xf10a8000-0xf10a9fff] port 0x180 irq 41
[    1.033388] pxa3xx-nand f10d0000.flash: This platform can't do DMA on this device
[    1.041146] nand: device found, Manufacturer ID: 0x01, Chip ID: 0xda
[    1.047534] nand: AMD/Spansion S34ML02G2
[    1.051476] nand: 256 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 128
[    1.059166] pxa3xx-nand f10d0000.flash: ECC strength 16, ECC step size 2048
[    1.066343] Bad block table found at page 131008, version 0x01
[    1.072539] Bad block table found at page 130944, version 0x01
[    1.078649] 11 ofpart partitions found on MTD device pxa3xx_nand-0
[    1.084862] Creating 11 MTD partitions on "pxa3xx_nand-0":
[    1.090369] 0x000000000000-0x000000200000 : "u-boot"
[    1.095646] 0x000000200000-0x000000220000 : "u_env"
[    1.100785] 0x000000220000-0x000000260000 : "s_env"
[    1.105935] 0x0000007e0000-0x000000820000 : "devinfo"
[    1.111239] 0x000000820000-0x000000a00000 : "sysdiag"
[    1.116562] 0x000000a00000-0x000005a00000 : "kernel1"
[    1.122048] 0x000001000000-0x000005a00000 : "rootfs1"
[    1.127495] 0x000005a00000-0x00000aa00000 : "kernel2"
[    1.132959] 0x000006000000-0x00000aa00000 : "ubi"
[    1.138058] 0x00000aa00000-0x000010000000 : "syscfg"
[    1.143443] 0x000000260000-0x000000820000 : "unused_area"
[    1.149366] libphy: Fixed MDIO Bus: probed
[    1.153737] libphy: orion_mdio_bus: probed
[    1.157972] mvneta_bm f10c8000.bm: Buffer Manager for network controller enabled
[    1.166668] mvneta f1070000.ethernet eth0: Using hardware mac address 60:38:e0:b6:70:d8
[    1.175685] mvneta f1034000.ethernet eth1: Using random mac address 46:1f:34:dd:95:b4
[    1.183607] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.190161] ehci-pci: EHCI PCI platform driver
[    1.194652] ehci-platform: EHCI generic platform driver
[    1.199968] ehci-orion: EHCI orion driver
[    1.204059] orion-ehci f1058000.usb: EHCI Host Controller
[    1.209487] orion-ehci f1058000.usb: new USB bus registered, assigned bus number 1
[    1.217132] orion-ehci f1058000.usb: irq 37, io mem 0xf1058000
[    1.251353] orion-ehci f1058000.usb: USB 2.0 started, EHCI 1.00
[    1.257495] hub 1-0:1.0: USB hub found
[    1.261269] hub 1-0:1.0: 1 port detected
[    1.265563] usbcore: registered new interface driver usb-storage
[    1.271721] armada38x-rtc f10a3800.rtc: rtc core: registered f10a3800.rtc as rtc0
[    1.279334] i2c /dev entries driver
[    1.294227] orion_wdt: Initial timeout 171 sec
[    1.298906] sdhci: Secure Digital Host Controller Interface driver
[    1.305117] sdhci: Copyright(c) Pierre Ossman
[    1.362573] ata1: SATA link down (SStatus 0 SControl 300)
[    1.368019] ata2: SATA link down (SStatus 0 SControl 300)
[    1.371373] mmc0: SDHCI controller on f10d8000.sdhci [f10d8000.sdhci] using ADMA
[    1.371446] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.377168] marvell-cesa f1090000.crypto: CESA device successfully registered
[    1.377557] NET: Registered protocol family 10
[    1.391619] NET: Registered protocol family 17
[    1.391632] 8021q: 802.1Q VLAN Support v1.8
[    1.391686] Registering SWP/SWPB emulation handler
[    1.392844] xhci-hcd f10f8000.usb3: xHCI Host Controller
[    1.392856] xhci-hcd f10f8000.usb3: new USB bus registered, assigned bus number 2
[    1.392913] xhci-hcd f10f8000.usb3: hcc params 0x0a000990 hci version 0x100 quirks 0x00010010
[    1.392932] xhci-hcd f10f8000.usb3: irq 44, io mem 0xf10f8000
[    1.393197] hub 2-0:1.0: USB hub found
[    1.393223] hub 2-0:1.0: 1 port detected
[    1.393313] xhci-hcd f10f8000.usb3: xHCI Host Controller
[    1.393319] xhci-hcd f10f8000.usb3: new USB bus registered, assigned bus number 3
[    1.393360] usb usb3: We don't know the algorithms for LPM for this host, disabling LPM.
[    1.393553] hub 3-0:1.0: USB hub found
[    1.393576] hub 3-0:1.0: 1 port detected
[    1.393899] UBI: auto-attach mtd8
[    1.393902] ubi0: attaching mtd8
[    1.398007] random: fast init done
[    1.401561] mmc0: new high speed SDIO card at address 0001
[    1.593503] ubi0: scanning is finished
[    1.601733] ubi0: attached mtd8 (name "ubi", size 74 MiB)
[    1.607154] ubi0: PEB size: 131072 bytes (128 KiB), LEB size: 126976 bytes
[    1.614069] ubi0: min./max. I/O unit sizes: 2048/2048, sub-page size 2048
[    1.620884] ubi0: VID header offset: 2048 (aligned 2048), data offset: 4096
[    1.627878] ubi0: good PEBs: 592, bad PEBs: 0, corrupted PEBs: 0
[    1.633912] ubi0: user volume: 2, internal volumes: 1, max. volumes count: 128
[    1.641163] ubi0: max/mean erase counter: 6/3, WL threshold: 4096, image sequence number: 2096932972
[    1.650336] ubi0: available PEBs: 0, total reserved PEBs: 592, PEBs reserved for bad PEB handling: 40
[    1.659601] ubi0: background thread "ubi_bgt0d" started, PID 646
[    1.660041] block ubiblock0_0: created from ubi0:0(rootfs)
[    1.660042] ubiblock: device ubiblock0_0 (rootfs) set to be root filesystem
[    1.660227] mvsw61xx 10.mvsw61xx: Found MV88E6352 at f1072004.mdio-mi:10
[    1.660230] mvsw61xx 10.mvsw61xx: Using direct addressing
[    1.671148] armada38x-rtc f10a3800.rtc: setting system clock to 2096-12-05 15:38:39 UTC (4005560319)
[    1.699508] Waiting 1 sec before mounting root device...
[    2.011381] usb 3-1: new SuperSpeed USB device number 2 using xhci-hcd
[    2.042289] usb-storage 3-1:1.0: USB Mass Storage device detected
[    2.048492] scsi host2: usb-storage 3-1:1.0
[    2.722800] VFS: Mounted root (squashfs filesystem) readonly on device 254:0.
[    2.730082] Freeing unused kernel memory: 268K (c05b1000 - c05f4000)
[    2.736480] This architecture does not have kernel memory protection.
[    2.882311] init: Console is alive
[    2.885789] init: - watchdog -
[    3.039957] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[    3.071391] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[    3.082590] init: - preinit -
[    3.122249] scsi 2:0:0:0: Direct-Access     SanDisk  Ultra Fit        1.00 PQ: 0 ANSI: 6
[    3.213769] mvneta f1070000.ethernet tmp0: renamed from eth0
[    3.252595] mvneta f1034000.ethernet eth0: renamed from eth1
[    3.292538] mvneta f1070000.ethernet eth1: renamed from tmp0
[    3.577772] mvneta f1034000.ethernet eth0: configuring for fixed link mode
[    3.585062] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    3.591069] mvneta f1034000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[    3.599301] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    5.679260] UBIFS (ubi0:1): background thread "ubifs_bgt0_1" started, PID 767
[    5.707767] UBIFS (ubi0:1): recovery needed
[    5.780033] UBIFS (ubi0:1): recovery completed
[    5.784529] UBIFS (ubi0:1): UBIFS: mounted UBI device 0, volume 1, name "rootfs_data"
[    5.792396] UBIFS (ubi0:1): LEB size: 126976 bytes (124 KiB), min./max. I/O unit sizes: 2048 bytes/2048 bytes
[    5.802354] UBIFS (ubi0:1): FS size: 65265664 bytes (62 MiB, 514 LEBs), journal size 3301376 bytes (3 MiB, 26 LEBs)
[    5.812834] UBIFS (ubi0:1): reserved for root: 3082658 bytes (3010 KiB)
[    5.819475] UBIFS (ubi0:1): media format: w4/r0 (latest is w4/r0), UUID 8FD45C54-2DF5-47E9-8554-B80C7D595142, small LPT model
[    5.834001] mount_root: switching to ubifs overlay
[    5.877290] ubi1: attaching mtd9
[    5.986949] random: crng init done
[    6.112420] ubi1: scanning is finished
[    6.120602] ubi1: attached mtd9 (name "syscfg", size 86 MiB)
[    6.126297] ubi1: PEB size: 131072 bytes (128 KiB), LEB size: 126976 bytes
[    6.133205] ubi1: min./max. I/O unit sizes: 2048/2048, sub-page size 2048
[    6.140020] ubi1: VID header offset: 2048 (aligned 2048), data offset: 4096
[    6.147012] ubi1: good PEBs: 680, bad PEBs: 8, corrupted PEBs: 0
[    6.153045] ubi1: user volume: 1, internal volumes: 1, max. volumes count: 128
[    6.160296] ubi1: max/mean erase counter: 8/4, WL threshold: 4096, image sequence number: 1127247692
[    6.169469] ubi1: available PEBs: 0, total reserved PEBs: 680, PEBs reserved for bad PEB handling: 32
[    6.178734] ubi1: background thread "ubi_bgt1d" started, PID 779
[    6.190524] UBIFS (ubi1:0): background thread "ubifs_bgt1_0" started, PID 783
[    6.229973] UBIFS (ubi1:0): UBIFS: mounted UBI device 1, volume 0, name "syscfg"
[    6.237420] UBIFS (ubi1:0): LEB size: 126976 bytes (124 KiB), min./max. I/O unit sizes: 2048 bytes/2048 bytes
[    6.247380] UBIFS (ubi1:0): FS size: 80375808 bytes (76 MiB, 633 LEBs), journal size 4063232 bytes (3 MiB, 32 LEBs)
[    6.257861] UBIFS (ubi1:0): reserved for root: 3796347 bytes (3707 KiB)
[    6.264505] UBIFS (ubi1:0): media format: w4/r0 (latest is w4/r0), UUID A50E3F52-EFAB-4508-9BD3-9F365ACD75B6, small LPT model
[    6.277320] urandom-seed: Seeding with /etc/urandom.seed
[    6.363215] procd: - early -
[    6.366129] procd: - watchdog -
[    6.977762] procd: - ubus -
[    7.033138] procd: - init -
[    7.137576] kmodloader: loading kernel modules from /etc/modules.d/*
[    7.144965] ip6_tables: (C) 2000-2006 Netfilter Core Team
[    7.151756] Loading modules backported from Linux version wt-2017-01-31-0-ge882dff19e7f
[    7.159793] Backport generated by backports.git backports-20160324-13-g24da7d3c
[    7.173785] <<Marvell Mac80211 Wireless PCIE Network Driver version 10.3.4.0-20170713>>
[    7.181897] pci 0000:00:01.0: enabling device (0140 -> 0142)
[    7.187679] ieee80211 phy0: priv->pcmd_buf = ddcf4000  priv->pphys_cmd_buf = 1dcf4000
[    7.241375] ieee80211 phy0: fw download start
[    7.241380] ieee80211 phy0: ddr init: download start
[    7.241758] ieee80211 phy0: ddr init: download complete
[    7.378616] ieee80211 phy0: FwSize = 447620 downloaded Size = 447620 curr_iteration 65522
[   10.247350] ieee80211 phy0: fw download complete
[   10.257404] ieee80211 phy0: pcmd = ddcf4000
[   10.275376] ieee80211 phy0: firmware version: 0x9030007
[   10.583374] ieee80211 phy0: firmware region code: 30
[   10.612025] ieee80211 phy0: 2G disabled, 5G enabled
[   10.616924] ieee80211 phy0: 4 TX antennas, 4 RX antennas
[   10.622331] pci 0000:00:02.0: enabling device (0140 -> 0142)
[   10.628148] ieee80211 phy1: priv->pcmd_buf = d9814000  priv->pphys_cmd_buf = 19814000
[   10.641376] ieee80211 phy1: fw download start
[   10.641381] ieee80211 phy1: ddr init: download start
[   10.641762] ieee80211 phy1: ddr init: download complete
[   10.781774] ieee80211 phy1: FwSize = 447620 downloaded Size = 447620 curr_iteration 65527
[   11.977349] ieee80211 phy1: fw download complete
[   11.987344] ieee80211 phy1: pcmd = d9814000
[   12.005371] ieee80211 phy1: firmware version: 0x9030007
[   12.313374] ieee80211 phy1: firmware region code: 30
[   12.337259] ieee80211 phy1: 2G enabled, 5G disabled
[   12.342193] ieee80211 phy1: 4 TX antennas, 4 RX antennas
[   12.348744] ip_tables: (C) 2000-2006 Netfilter Core Team
[   12.355554] nf_conntrack version 0.5.0 (8192 buckets, 32768 max)
[   12.369244] xt_time: kernel timezone is -0000
[   12.375638] PPP generic driver version 2.4.2
[   12.380346] NET: Registered protocol family 24
[   12.385643] kmodloader: done loading kernel modules from /etc/modules.d/*
[   13.269567] mvneta f1070000.ethernet eth1: configuring for fixed link mode
[   13.276989] mvneta f1070000.ethernet eth1: Link is Up - 1Gbps/Full - flow control off
[   13.284981] br-xxx1: port 1(eth1) entered blocking state
[   13.290752] br-xxx1: port 1(eth1) entered disabled state
[   13.296653] device eth1 entered promiscuous mode
[   13.302371] br-xxx1: port 1(eth1) entered blocking state
[   13.308143] br-xxx1: port 1(eth1) entered forwarding state
[   13.321580] mvneta f1034000.ethernet eth0: configuring for fixed link mode
[   13.328551] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   13.334516] mvneta f1034000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[   13.342809] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   13.352541] IPv6: ADDRCONF(NETDEV_UP): br-xxx2: link is not ready
[   13.361268] IPv6: ADDRCONF(NETDEV_UP): br-xxx3: link is not ready
[   15.208357] ieee80211 phy1: change: 0xffffffff
[   15.298554] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
[   15.479375] ieee80211 phy0: change: 0xffffffff
[   15.604015] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   15.610026] br-xxx1: port 2(wlan1) entered blocking state
[   15.615895] br-xxx1: port 2(wlan1) entered disabled state
[   15.621881] device wlan1 entered promiscuous mode
[   15.626629] br-xxx1: port 2(wlan1) entered blocking state
[   15.632492] br-xxx1: port 2(wlan1) entered forwarding state
[   15.638766] br-xxx1: port 2(wlan1) entered disabled state
[   15.644802] br-xxx1: port 3(wlan0) entered blocking state
[   15.650669] br-xxx1: port 3(wlan0) entered disabled state
[   15.656663] device wlan0 entered promiscuous mode
[   20.661638] ieee80211 phy1: change: 0x100
[   20.674711] ieee80211 phy1: change: 0x40
[   20.678874] ieee80211 phy0: change: 0x100
[   20.691243] ieee80211 phy0: change: 0x40
[   20.881220] ieee80211 phy1: change: 0x40
[   20.901228] ieee80211 phy0: change: 0x40
[   21.071217] ieee80211 phy1: change: 0x40
[   21.121216] ieee80211 phy0: change: 0x40
[   21.219229] ieee80211 phy0: change: 0x100
[   21.231220] ieee80211 phy0: change: 0x100
[   21.244257] ieee80211 phy0: change: 0x42
[   21.261206] ieee80211 phy1: change: 0x40
[   21.345220] ieee80211 phy0: change: 0x40
[   21.451209] ieee80211 phy1: change: 0x40
[   21.641198] ieee80211 phy1: change: 0x40
[   21.831191] ieee80211 phy1: change: 0x40
[   22.031186] ieee80211 phy1: change: 0x40
[   22.231179] ieee80211 phy1: change: 0x40
[   22.421178] ieee80211 phy1: change: 0x40
[   22.611170] ieee80211 phy1: change: 0x40
[   22.811171] ieee80211 phy1: change: 0x40
[   23.001155] ieee80211 phy1: change: 0x40
[   23.191152] ieee80211 phy1: change: 0x40
[   23.270159] ieee80211 phy1: change: 0x100
[   23.283210] ieee80211 phy1: change: 0x100
[   23.296183] ieee80211 phy1: change: 0x40
[   23.491151] ieee80211 phy1: change: 0x40
[   23.691137] ieee80211 phy1: change: 0x40
[   23.881133] ieee80211 phy1: change: 0x40
[   24.071125] ieee80211 phy1: change: 0x40
[   24.261125] ieee80211 phy1: change: 0x40
[   24.451115] ieee80211 phy1: change: 0x40
[   24.641112] ieee80211 phy1: change: 0x40
[   24.831104] ieee80211 phy1: change: 0x40
[   25.021099] ieee80211 phy1: change: 0x40
[   25.221100] ieee80211 phy1: change: 0x40
[   25.411092] ieee80211 phy1: change: 0x40
[   25.601080] ieee80211 phy1: change: 0x40
[   25.791076] ieee80211 phy1: change: 0x40
[   25.870092] ieee80211 phy1: change: 0x100
[   25.883146] ieee80211 phy1: change: 0x100
[   25.896243] ieee80211 phy1: change: 0x40
[   26.091071] ieee80211 phy1: change: 0x40
[   26.281068] ieee80211 phy1: change: 0x40
[   26.471056] ieee80211 phy1: change: 0x40
[   26.661052] ieee80211 phy1: change: 0x40
[   26.851049] ieee80211 phy1: change: 0x40
[   27.041044] ieee80211 phy1: change: 0x40
[   27.231033] ieee80211 phy1: change: 0x40
[   27.421033] ieee80211 phy1: change: 0x40
[   27.611024] ieee80211 phy1: change: 0x40
[   27.801020] ieee80211 phy1: change: 0x40
[   27.991016] ieee80211 phy1: change: 0x40
[   28.181005] ieee80211 phy1: change: 0x40
[   28.371001] ieee80211 phy1: change: 0x40
[   28.450017] ieee80211 phy1: change: 0x100
[   28.463071] ieee80211 phy1: change: 0x100
[   28.476149] ieee80211 phy1: change: 0x40
[   28.670996] ieee80211 phy1: change: 0x40
[   28.860996] ieee80211 phy1: change: 0x40
[   29.050982] ieee80211 phy1: change: 0x40
[   29.240979] ieee80211 phy1: change: 0x40
[   29.430977] ieee80211 phy1: change: 0x40
[   29.620971] ieee80211 phy1: change: 0x40
[   29.810962] ieee80211 phy1: change: 0x40
[   30.001025] ieee80211 phy1: change: 0x40
[   30.200951] ieee80211 phy1: change: 0x40
[   30.390943] ieee80211 phy1: change: 0x40
[   30.580940] ieee80211 phy1: change: 0x40
[   30.770934] ieee80211 phy1: change: 0x40
[   30.960931] ieee80211 phy1: change: 0x40
[   31.039938] ieee80211 phy1: change: 0x100
[   31.052999] ieee80211 phy1: change: 0x100
[   31.066045] ieee80211 phy1: change: 0x40
[   31.260925] ieee80211 phy1: change: 0x40
[   31.450919] ieee80211 phy1: change: 0x40
[   31.640911] ieee80211 phy1: change: 0x40
[   31.830905] ieee80211 phy1: change: 0x40
[   32.020903] ieee80211 phy1: change: 0x40
[   32.210895] ieee80211 phy1: change: 0x40
[   32.400898] ieee80211 phy1: change: 0x40
[   32.590883] ieee80211 phy1: change: 0x40
[   32.790876] ieee80211 phy1: change: 0x40
[   32.980871] ieee80211 phy1: change: 0x40
[   33.170868] ieee80211 phy1: change: 0x40
[   33.360864] ieee80211 phy1: change: 0x40
[   33.550857] ieee80211 phy1: change: 0x40
[   33.629873] ieee80211 phy1: change: 0x100
[   33.689771] ieee80211 phy1: change: 0x100
[   33.700875] ieee80211 phy1: change: 0x42
[   33.848889] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
[   33.855325] br-xxx1: port 2(wlan1) entered blocking state
[   33.861197] br-xxx1: port 2(wlan1) entered forwarding state
[   33.904470] br-xxx2: port 1(wlan1-1) entered blocking state
[   33.910425] br-xxx2: port 1(wlan1-1) entered disabled state
[   33.916554] device wlan1-1 entered promiscuous mode
[   33.993088] IPv6: ADDRCONF(NETDEV_UP): wlan1-1: link is not ready
[   33.999212] br-xxx2: port 1(wlan1-1) entered blocking state
[   34.005166] br-xxx2: port 1(wlan1-1) entered forwarding state
[   34.011333] IPv6: ADDRCONF(NETDEV_CHANGE): br-xxx2: link becomes ready
[   34.136877] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1-1: link becomes ready
[   34.178724] br-xxx3: port 1(wlan1-2) entered blocking state
[   34.185056] br-xxx3: port 1(wlan1-2) entered disabled state
[   34.191516] device wlan1-2 entered promiscuous mode
[   34.267044] IPv6: ADDRCONF(NETDEV_UP): wlan1-2: link is not ready
[   34.273177] br-xxx3: port 1(wlan1-2) entered blocking state
[   34.279474] br-xxx3: port 1(wlan1-2) entered forwarding state
[   34.286020] IPv6: ADDRCONF(NETDEV_CHANGE): br-xxx3: link becomes ready
[   34.410849] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1-2: link becomes ready
[   43.510778] ieee80211 phy1: staid 1 deleted
[   84.960303] ieee80211 phy0: change: 0x40
[   85.058302] ieee80211 phy0: change: 0x100
[   85.116697] ieee80211 phy0: change: 0x100
[   85.129748] ieee80211 phy0: change: 0x42
[   85.230306] ieee80211 phy0: change: 0x40
[   85.409316] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   85.415775] br-xxx1: port 3(wlan0) entered blocking state
[   85.421645] br-xxx1: port 3(wlan0) entered forwarding state
[  637.211791] ieee80211 phy1: staid 2 deleted
[  637.235928] ieee80211 phy1: staid 2 deleted
[  641.647342] ieee80211 phy1: staid 2 deleted

and more...

root@lede:~# iw wlan1 station dump | grep 00:04:20:29:87:37
root@lede:~# logread | grep hostapd | grep 00:04:20:29:87:37
Thu Jul 13 22:21:13 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 2)
Thu Jul 13 22:21:13 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 00:04:20:29:87:37
Thu Jul 13 22:21:13 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 WPA: pairwise key handshake completed (RSN)
Thu Jul 13 22:21:13 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authenticated
Thu Jul 13 22:31:05 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED 00:04:20:29:87:37
Thu Jul 13 22:31:05 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 2)
Thu Jul 13 22:31:09 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 2)
Thu Jul 13 22:31:09 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 00:04:20:29:87:37
Thu Jul 13 22:31:09 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 WPA: pairwise key handshake completed (RSN)
Thu Jul 13 22:31:10 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authenticated
Thu Jul 13 22:31:10 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authenticated

Is any additional log needed? Is there anything suspicious?

yuhhaurlin commented 7 years ago

Can you make sure open mode (without security) is all right? If yes, I will update hostapd to you to dump more debug information.

yuhhaurlin commented 7 years ago

Can you let me know version of mwlwifi for LEDE.17.01.01?

haribert commented 7 years ago

I will check later today with the open mode and let you know about the outcome.

Looks like LEDE 17.01.1 had mwlwifi version 10.3.2.0-20170110-1.

haribert commented 7 years ago

There is no interruption In open mode without encryption. Connection is great.

There is something else I do not understand. If I flash your LEDE sysupgrade and do a restart (may be combined with opkg update/install packages), the system is back to the previous one from davidc502sis. Is your sysupgrade somehow marked as non-permanent?

yuhhaurlin commented 7 years ago

No. These images are got from directory "bin". I will try to build hostapd with more debug information for you to do test. But you should make sure you can run the LEDE image I sent out.

haribert commented 7 years ago

I can run your LEDE images.

The opkg update/upgrade/install has probably overwritten my packages. So I will test without opkg update.

Thanks!

yuhhaurlin commented 7 years ago

Please use following ways to get more debug information for me:

# grep _level /var/run/hostapd-phy1.conf logger_syslog_level=2 logger_stdout_level=2 # uci set wireless.radio1.log_level=1 # uci commit wireless # wifi up # grep _level /var/run/hostapd-phy1.conf logger_syslog_level=1 logger_stdout_level=1

yuhhaurlin commented 7 years ago

Or You can get LEDE image with 612df7c from:

factory: https://drive.google.com/open?id=0B3qLWtcWB9EdbklyWUowRkJuT1U upgrade: https://drive.google.com/open?id=0B3qLWtcWB9EdTUlnU0hsYjlCd00

root@LEDE:/# cat /sys/kernel/debug/ieee80211/phy0/mwlwifi/info

driver name: mwlwifi chip type: 88W8964 hw version: 7 driver version: 10.3.4.0-20170713-debug firmware version: 0x09030007 power table loaded from dts: no firmware region code: 0x10 mac address: 00:50:43:22:88:8a 2g: disable 5g: enable antenna: 4 4 irq number: 44 ap macid support: 0000ffff sta macid support: 00010000 macid used: 00000001 radio: enable iobase0: f0e00000 iobase1: f1080000 tx limit: 1024 rx limit: 16384

yuhhaurlin commented 7 years ago

No reply for this issue. If needed, you can request to reopen it or create another issue. Thanks.

haribert commented 7 years ago

I had no time to test this in the last week. I will do ASAP.

haribert commented 7 years ago

Here is the result with the sysupgrade and debug level = 1

root@lede:~# uname -a
Linux lede 4.9.20 #0 SMP Thu May 11 20:43:01 2017 armv7l GNU/Linux
root@lede:~# cat /etc/banner
     _________
    /        /\      _    ___ ___  ___
   /  LE    /  \    | |  | __|   \| __|
  /    DE  /    \   | |__| _|| |) | _|
 /________/  LE  \  |____|___|___/|___|                      lede-project.org
 \        \   DE /
  \    LE  \    /  -----------------------------------------------------------
   \  DE    \  /    Reboot (SNAPSHOT, r4114-6704410)
    \________\/    -----------------------------------------------------------

root@lede:~# grep _level /var/run/hostapd-phy1.conf
logger_syslog_level=1
logger_stdout_level=1
root@lede:~# cat /sys/kernel/debug/ieee80211/phy0/mwlwifi/info

driver name: mwlwifi
chip type: 88W8964
hw version: 7
driver version: 10.3.4.0-20170713-debug
firmware version: 0x09030007
power table loaded from dts: no
firmware region code: 0x30
mac address: 60:38:e0:b6:70:da
2g: disable
5g: enable
antenna: 4 4
irq number: 45
ap macid support: 0000ffff
sta macid support: 00010000
macid used: 00000001
radio: enable
iobase0: e0e00000
iobase1: e1080000
tx limit: 1024
rx limit: 16384

root@lede:~#

Connection interrupted at 20:42

root@lede:~# dmesg
[...]
[   84.961240] ieee80211 phy0: change: 0x40
[   85.060216] ieee80211 phy0: change: 0x100
[   85.119566] ieee80211 phy0: change: 0x100
[   85.131203] ieee80211 phy0: change: 0x42
[   85.227214] ieee80211 phy0: change: 0x40
[   85.408219] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   85.414665] br-xxx: port 3(wlan0) entered blocking state
[   85.420522] br-xxx: port 3(wlan0) entered forwarding state
[  128.032508] ieee80211 phy1: staid 1 deleted
[  141.378063] Rx EAPOL
[  141.387353] Rx EAPOL
[  634.811932] Rx EAPOL
[  635.542546] Rx EAPOL
[  638.303622] ieee80211 phy1: staid 1 deleted
[  638.329089] ieee80211 phy1: staid 1 deleted
[  639.380059] ieee80211 phy1: staid 5 deleted
[  642.459230] ieee80211 phy1: staid 1 deleted
[  643.285871] Rx EAPOL
[  643.310284] Rx EAPOL

root@lede:~# logread | grep hostapd | grep 00:04:20:29:87:37
Tue Jul 25 20:32:35 2017 daemon.info hostapd: wlan1-3: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 1)
Tue Jul 25 20:32:35 2017 daemon.notice hostapd: wlan1-3: AP-STA-CONNECTED 00:04:20:29:87:37
Tue Jul 25 20:32:35 2017 daemon.info hostapd: wlan1-3: STA 00:04:20:29:87:37 IEEE 802.11: authenticated
Tue Jul 25 20:34:02 2017 daemon.notice hostapd: wlan1-3: AP-STA-DISCONNECTED 00:04:20:29:87:37
Tue Jul 25 20:34:02 2017 daemon.info hostapd: wlan1-3: STA 00:04:20:29:87:37 IEEE 802.11: disassociated
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authentication OK (open system)
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-AUTHENTICATE.indication(00:04:20:29:87:37, OPEN_SYSTEM)
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: association OK (aid 2)
Tue Jul 25 20:34:07 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 2)
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-ASSOCIATE.indication(00:04:20:29:87:37)
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: binding station to interface 'wlan1'
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 1 notification
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: start authentication
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.1X: unauthorizing port
Tue Jul 25 20:34:07 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:34:08 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:34:08 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:34:08 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: received EAPOL-Key frame (2/4 Pairwise)
Tue Jul 25 20:34:08 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 3/4 msg of 4-Way Handshake
Tue Jul 25 20:34:08 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: received EAPOL-Key frame (4/4 Pairwise)
Tue Jul 25 20:34:08 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 00:04:20:29:87:37
Tue Jul 25 20:34:08 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.1X: authorizing port
Tue Jul 25 20:34:08 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 WPA: pairwise key handshake completed (RSN)
Tue Jul 25 20:34:09 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authenticated
Tue Jul 25 20:42:28 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/2 msg of Group Key Handshake
Tue Jul 25 20:42:29 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:29 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/2 msg of Group Key Handshake
Tue Jul 25 20:42:30 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:30 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/2 msg of Group Key Handshake
Tue Jul 25 20:42:31 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:31 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/2 msg of Group Key Handshake
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: WPA_PTK: sm->Disconnect
Tue Jul 25 20:42:32 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED 00:04:20:29:87:37
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 3 notification
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.1X: unauthorizing port
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authentication OK (open system)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 0 notification
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-AUTHENTICATE.indication(00:04:20:29:87:37, OPEN_SYSTEM)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: association OK (aid 2)
Tue Jul 25 20:42:32 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 2)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-REASSOCIATE.indication(00:04:20:29:87:37)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: binding station to interface 'wlan1'
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 1 notification
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DEAUTHENTICATE.indication(00:04:20:29:87:37, 2)
Tue Jul 25 20:42:32 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:42:33 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:33 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:42:33 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authenticated
Tue Jul 25 20:42:34 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:34 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:42:35 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:35 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: EAPOL-Key timeout
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: PTKSTART: Retry limit 4 reached
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 3 notification
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.1X: unauthorizing port
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authentication OK (open system)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 0 notification
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-AUTHENTICATE.indication(00:04:20:29:87:37, OPEN_SYSTEM)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: association OK (aid 2)
Tue Jul 25 20:42:36 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: associated (aid 2)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-REASSOCIATE.indication(00:04:20:29:87:37)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: binding station to interface 'wlan1'
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: event 1 notification
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 1/4 msg of 4-Way Handshake
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: received EAPOL-Key frame (2/4 Pairwise)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: sending 3/4 msg of 4-Way Handshake
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 WPA: received EAPOL-Key frame (4/4 Pairwise)
Tue Jul 25 20:42:36 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 00:04:20:29:87:37
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.1X: authorizing port
Tue Jul 25 20:42:36 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 WPA: pairwise key handshake completed (RSN)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DEAUTHENTICATE.indication(00:04:20:29:87:37, 2)
Tue Jul 25 20:42:36 2017 daemon.debug hostapd: wlan1: STA 00:04:20:29:87:37 MLME: MLME-DELETEKEYS.request(00:04:20:29:87:37)
Tue Jul 25 20:42:36 2017 daemon.info hostapd: wlan1: STA 00:04:20:29:87:37 IEEE 802.11: authenticated
root@lede:~#

Any additional information needed?

Can you please reopen the issue. Thanks.

yuhhaurlin commented 7 years ago

Thanks. I will prepare another debug image.

yuhhaurlin commented 7 years ago

It looks like your problem is related to group rekey. I will update image to dump EAPOL packets received by driver later. You can add "option wpa_group_rekey '0'" to /etc/config/wireless to disable group rekey to work around this problem first.

yuhhaurlin commented 7 years ago

Since 11g only client hard to find now. If disable group rekey can resolve your problem, I won't take time to check it. I close this one. Thanks.

haribert commented 7 years ago

I am a little bit confused and disappointed. Is this really how open and confirmed issues are handled?

I did not yet test if wpa_group_rekey works (because I thought you will solve this issue the clean way), therefore it is not clear if there is a running workaround. Furthermore, with the previous version of mwlwifi the connection was functional. So you removed functionality from the driver and argue that there are too less devices which are affected?

I thought the opensource version of WRT3200acm should have the same functionality as the original firmware. At least this is always your argument. If you close issues without a proper solution this is not given.

yuhhaurlin commented 7 years ago

All right. This issue will be low priority.

haribert commented 7 years ago

For your information, the option option wpa_group_rekey '0' is not a working workaround. I still have the same issue.

I have currently a wlan without encryption and mac filter to use this device.

yuhhaurlin commented 7 years ago

Can you give me the log you got?

haribert commented 7 years ago

@yuhhaurlin I can give you the logs next week. I am currently off site.

yuhhaurlin commented 7 years ago

11g only device is pretty rare now. I close this one.

thagabe commented 7 years ago

AFAIK I do not have any 11g devices. Yet my logs seem to imply that I do. Here are my kernel logs:

[   23.098366] device wlan0 entered promiscuous mode
[   23.103137] br-lan: port 2(wlan0) entered blocking state
[   23.108470] br-lan: port 2(wlan0) entered forwarding state
[   23.114102] br-lan: port 2(wlan0) entered disabled state
[   23.120240] ieee80211 phy0: change: 0x100
[   23.133331] ieee80211 phy0: change: 0x40
[   23.133619] br-lan: port 3(wlan1) entered blocking state
[   23.133620] br-lan: port 3(wlan1) entered disabled state
[   23.133755] device wlan1 entered promiscuous mode
[   23.182084] ieee80211 phy1: change: 0x100
[   23.195189] ieee80211 phy1: change: 0x42
[   23.381326] ieee80211 phy0: change: 0x40
[   23.384894] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
[   23.384946] br-lan: port 3(wlan1) entered blocking state
[   23.384948] br-lan: port 3(wlan1) entered forwarding state
[   23.681353] ieee80211 phy0: change: 0x40
[   23.808361] ieee80211 phy0: change: 0x100
[   23.869374] ieee80211 phy0: change: 0x100
[   23.881307] ieee80211 phy0: change: 0x42
[   24.093639] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   24.100074] br-lan: port 2(wlan0) entered blocking state
[   24.105418] br-lan: port 2(wlan0) entered forwarding state
[  386.366823] ieee80211 phy1: staid 2 deleted
[11605.476027] ieee80211 phy1: staid 1 deleted
[21562.009382] ieee80211 phy1: staid 2 deleted
[28127.002658] ieee80211 phy1: staid 4 deleted
[32034.570034] ieee80211 phy1: staid 4 deleted
[32736.438754] ieee80211 phy1: staid 5 deleted
[33573.286541] ieee80211 phy1: staid 5 deleted
[39191.974842] ieee80211 phy1: staid 3 deleted
[41761.287955] ieee80211 phy1: staid 2 deleted
[42003.089047] ieee80211 phy1: staid 6 deleted
[42174.726982] ieee80211 phy1: staid 3 deleted
[44717.633854] ieee80211 phy1: staid 5 deleted
[49551.832932] ieee80211 phy1: staid 5 deleted
[51516.761526] ieee80211 phy1: staid 4 deleted
[56307.680597] ieee80211 phy1: staid 3 deleted
[56623.337071] ieee80211 phy0: staid 1 deleted
[56632.094139] ieee80211 phy0: staid 2 deleted
[59253.149762] ieee80211 phy1: staid 4 deleted
[68749.858864] ieee80211 phy1: staid 2 deleted
[69879.678936] ieee80211 phy1: staid 2 deleted
[70585.555910] ieee80211 phy1: staid 5 deleted
[73794.034001] ieee80211 phy1: staid 2 deleted
[74221.957404] ieee80211 phy0: staid 3 deleted
[74889.059512] ieee80211 phy0: staid 3 deleted
[75726.923669] ieee80211 phy1: staid 4 deleted

Here is a more comprehensive system log:

Tue Oct 31 16:43:18 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 16:43:18 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 0 addresses
Tue Oct 31 16:43:18 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 16:43:18 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 16:43:19 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 16:43:19 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 16:43:19 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 2 addresses
Tue Oct 31 16:43:19 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 16:43:19 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 16:44:39 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 16:45:09 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 16:49:42 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 16:50:12 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 16:54:45 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 16:55:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 16:59:48 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:00:18 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:04:51 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:05:21 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:09:54 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:10:24 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:14:57 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:15:27 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:15:58 2017 kern.info kernel: [51516.761526] ieee80211 phy1: staid 4 deleted
Tue Oct 31 17:15:58 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 IEEE 802.11: associated (aid 4)
Tue Oct 31 17:15:58 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 68:db:ca:8f:11:91
Tue Oct 31 17:15:58 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 17:15:58 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.173 68:db:ca:8f:11:91 
Tue Oct 31 17:15:58 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.173 68:db:ca:8f:11:91 Magalys-iPhone
Tue Oct 31 17:15:59 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100011efca59b68dbca8f1191 on br-lan: ok 2601:646:c200:74d4::ef7/128 fd7c:8024:9135::ef7/128 
Tue Oct 31 17:16:00 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 IEEE 802.11: authenticated
Tue Oct 31 17:16:00 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011efca59b68dbca8f1191 on br-lan: ok 2601:646:c200:74d4::ef7/128 fd7c:8024:9135::ef7/128 
Tue Oct 31 17:20:00 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:20:30 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:25:03 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:25:33 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:30:06 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:30:36 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:35:09 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:35:39 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:40:12 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:40:42 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:42:38 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 17:43:50 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.208 30:10:e4:5f:45:da 
Tue Oct 31 17:43:50 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.208 30:10:e4:5f:45:da Daycares-iPad
Tue Oct 31 17:45:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:45:45 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:47:41 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 17:48:09 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 17:50:18 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:50:48 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:52:44 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 17:53:12 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 17:55:21 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 17:55:51 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 17:57:47 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 17:58:15 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:00:24 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:00:54 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:02:50 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:03:18 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:05:27 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:05:57 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:07:53 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:08:21 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:10:30 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:11:00 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:12:56 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:13:24 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:15:33 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:16:03 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:17:59 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:18:27 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:20:36 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:21:06 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:23:02 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:23:30 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:25:39 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:26:09 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:28:05 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:28:33 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:30:42 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:31:12 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:33:08 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:33:36 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:35:45 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:35:49 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED c8:a8:23:32:54:75
Tue Oct 31 18:35:49 2017 kern.info kernel: [56307.680597] ieee80211 phy1: staid 3 deleted
Tue Oct 31 18:36:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 18:36:30 2017 daemon.info hostapd: wlan1: STA c8:a8:23:32:54:75 IEEE 802.11: associated (aid 3)
Tue Oct 31 18:36:30 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED c8:a8:23:32:54:75
Tue Oct 31 18:36:30 2017 daemon.info hostapd: wlan1: STA c8:a8:23:32:54:75 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 18:36:30 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.174 c8:a8:23:32:54:75 
Tue Oct 31 18:36:30 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.174 c8:a8:23:32:54:75 android-59e932e6bf69935a
Tue Oct 31 18:36:34 2017 daemon.info hostapd: wlan1: STA c8:a8:23:32:54:75 IEEE 802.11: authenticated
Tue Oct 31 18:38:11 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:38:39 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:40:48 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:41:03 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) 78:ab:bb:57:17:13 
Tue Oct 31 18:41:03 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.239 78:ab:bb:57:17:13 
Tue Oct 31 18:41:03 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.239 78:ab:bb:57:17:13 
Tue Oct 31 18:41:03 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.239 78:ab:bb:57:17:13 
Tue Oct 31 18:41:05 2017 kern.info kernel: [56623.337071] ieee80211 phy0: staid 1 deleted
Tue Oct 31 18:41:05 2017 daemon.info hostapd: wlan0: STA 5c:a3:9d:68:bd:53 IEEE 802.11: associated (aid 1)
Tue Oct 31 18:41:05 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 5c:a3:9d:68:bd:53
Tue Oct 31 18:41:05 2017 daemon.info hostapd: wlan0: STA 5c:a3:9d:68:bd:53 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 18:41:12 2017 daemon.info hostapd: wlan0: STA 5c:a3:9d:68:bd:53 IEEE 802.11: authenticated
Tue Oct 31 18:41:14 2017 kern.info kernel: [56632.094139] ieee80211 phy0: staid 2 deleted
Tue Oct 31 18:41:14 2017 daemon.info hostapd: wlan0: STA 54:60:09:05:2c:16 IEEE 802.11: associated (aid 2)
Tue Oct 31 18:41:14 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 54:60:09:05:2c:16
Tue Oct 31 18:41:14 2017 daemon.info hostapd: wlan0: STA 54:60:09:05:2c:16 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 18:41:14 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) 54:60:09:05:2c:16 
Tue Oct 31 18:41:14 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.228 54:60:09:05:2c:16 
Tue Oct 31 18:41:14 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.228 54:60:09:05:2c:16 
Tue Oct 31 18:41:14 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.228 54:60:09:05:2c:16 Chromecast
Tue Oct 31 18:41:17 2017 daemon.info hostapd: wlan0: STA 54:60:09:05:2c:16 IEEE 802.11: authenticated
Tue Oct 31 18:41:51 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) cc:b1:1a:fc:01:a5 
Tue Oct 31 18:41:51 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.101 cc:b1:1a:fc:01:a5 
Tue Oct 31 18:41:51 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) cc:b1:1a:fc:01:a5 
Tue Oct 31 18:41:51 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.101 cc:b1:1a:fc:01:a5 
Tue Oct 31 18:41:51 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.101 cc:b1:1a:fc:01:a5 
Tue Oct 31 18:41:51 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.101 cc:b1:1a:fc:01:a5 
Tue Oct 31 18:43:14 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:43:42 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:47:14 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:48:17 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:48:45 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:52:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:53:20 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:53:48 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 18:57:18 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 18:58:23 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 18:58:51 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:02:21 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:03:26 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:03:54 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:07:24 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:08:29 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:08:57 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:12:27 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:13:32 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:14:00 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:17:30 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:18:35 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:19:03 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:22:33 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:23:38 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:24:06 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:24:55 2017 kern.info kernel: [59253.149762] ieee80211 phy1: staid 4 deleted
Tue Oct 31 19:24:55 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 IEEE 802.11: associated (aid 4)
Tue Oct 31 19:24:55 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 68:db:ca:8f:11:91
Tue Oct 31 19:24:55 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 19:24:55 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.173 68:db:ca:8f:11:91 
Tue Oct 31 19:24:55 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.173 68:db:ca:8f:11:91 Magalys-iPhone
Tue Oct 31 19:24:55 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 IEEE 802.11: authenticated
Tue Oct 31 19:24:55 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100011efca59b68dbca8f1191 on br-lan: ok 2601:646:c200:74d4::ef7/128 fd7c:8024:9135::ef7/128 
Tue Oct 31 19:24:56 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011efca59b68dbca8f1191 on br-lan: ok 2601:646:c200:74d4::ef7/128 fd7c:8024:9135::ef7/128 
Tue Oct 31 19:27:36 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:28:41 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:29:09 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:32:39 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:33:44 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:34:12 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:37:42 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:38:47 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:39:15 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:42:45 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:43:50 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:44:18 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:47:48 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:48:53 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:49:21 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:52:51 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:53:56 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:54:24 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 19:57:54 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 19:58:59 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 19:59:27 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:02:57 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:03:07 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.208 30:10:e4:5f:45:da 
Tue Oct 31 20:03:07 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.208 30:10:e4:5f:45:da Daycares-iPad
Tue Oct 31 20:04:02 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:04:30 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:08:00 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:09:05 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:09:33 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:13:03 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:14:08 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:14:36 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:18:06 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:19:11 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:19:39 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:23:09 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:24:14 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:24:42 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:28:12 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:29:17 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:29:45 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:33:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:34:20 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:34:48 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:38:18 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:39:23 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:39:51 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:43:21 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:44:26 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:44:54 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:48:24 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:49:29 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:49:57 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:51:34 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.139 00:db:70:c0:51:db 
Tue Oct 31 20:51:34 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.139 00:db:70:c0:51:db Hugo-As-iPhone
Tue Oct 31 20:53:27 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:54:32 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 20:55:00 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 20:58:30 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 20:59:35 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:00:03 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:03:33 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:04:38 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:05:06 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:08:36 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:09:41 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:10:09 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:13:39 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:14:44 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:15:12 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:18:42 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:19:47 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:20:15 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:23:45 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:24:50 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:25:18 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:28:48 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:29:53 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:30:21 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:33:51 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:34:56 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:35:24 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:38:54 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:39:59 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:40:27 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:43:57 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:45:02 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:45:30 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:49:00 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:50:05 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:50:33 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:52:38 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 21:54:03 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 21:55:08 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 21:55:36 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 21:57:41 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 21:58:04 2017 daemon.info hostapd: wlan1: STA 40:4e:36:21:6a:f7 IEEE 802.11: associated (aid 7)
Tue Oct 31 21:58:04 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 40:4e:36:21:6a:f7
Tue Oct 31 21:58:04 2017 daemon.info hostapd: wlan1: STA 40:4e:36:21:6a:f7 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 21:58:06 2017 daemon.info hostapd: wlan1: STA 40:4e:36:21:6a:f7 IEEE 802.11: authenticated
Tue Oct 31 21:58:08 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) 40:4e:36:21:6a:f7 
Tue Oct 31 21:58:08 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.172 40:4e:36:21:6a:f7 
Tue Oct 31 21:58:08 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) 40:4e:36:21:6a:f7 
Tue Oct 31 21:58:08 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.172 40:4e:36:21:6a:f7 
Tue Oct 31 21:58:08 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.172 40:4e:36:21:6a:f7 
Tue Oct 31 21:58:08 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.172 40:4e:36:21:6a:f7 
Tue Oct 31 21:59:06 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:00:11 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:00:39 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK ec:9b:f3:81:d3:53
Tue Oct 31 22:02:44 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:03:12 2017 kern.info kernel: [68749.858864] ieee80211 phy1: staid 2 deleted
Tue Oct 31 22:03:12 2017 daemon.info hostapd: wlan1: STA ec:9b:f3:81:d3:53 IEEE 802.11: associated (aid 2)
Tue Oct 31 22:03:12 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED ec:9b:f3:81:d3:53
Tue Oct 31 22:03:12 2017 daemon.info hostapd: wlan1: STA ec:9b:f3:81:d3:53 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 22:03:12 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) ec:9b:f3:81:d3:53 
Tue Oct 31 22:03:12 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.105 ec:9b:f3:81:d3:53 
Tue Oct 31 22:03:12 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.105 ec:9b:f3:81:d3:53 
Tue Oct 31 22:03:12 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.105 ec:9b:f3:81:d3:53 SAMSUNG-SM-N920A
Tue Oct 31 22:03:12 2017 daemon.info hostapd: wlan1: STA ec:9b:f3:81:d3:53 IEEE 802.11: authenticated
Tue Oct 31 22:04:09 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:05:14 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:07:47 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:09:12 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:10:17 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:12:50 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:14:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:15:20 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:17:53 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:19:18 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:20:23 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:22:01 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED ec:9b:f3:81:d3:53
Tue Oct 31 22:22:01 2017 daemon.info hostapd: wlan1: STA ec:9b:f3:81:d3:53 IEEE 802.11: disassociated
Tue Oct 31 22:22:01 2017 kern.info kernel: [69879.678936] ieee80211 phy1: staid 2 deleted
Tue Oct 31 22:22:03 2017 daemon.info hostapd: wlan1: STA ec:9b:f3:81:d3:53 IEEE 802.11: deauthenticated due to inactivity (timer DEAUTH/REMOVE)
Tue Oct 31 22:22:56 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:24:21 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:25:26 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:27:59 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:29:24 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:30:29 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK b8:86:87:de:57:83
Tue Oct 31 22:33:02 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:33:47 2017 kern.info kernel: [70585.555910] ieee80211 phy1: staid 5 deleted
Tue Oct 31 22:33:47 2017 daemon.info hostapd: wlan1: STA b8:86:87:de:57:83 IEEE 802.11: associated (aid 5)
Tue Oct 31 22:33:47 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED b8:86:87:de:57:83
Tue Oct 31 22:33:47 2017 daemon.info hostapd: wlan1: STA b8:86:87:de:57:83 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 22:33:48 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.153 b8:86:87:de:57:83 
Tue Oct 31 22:33:48 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.153 b8:86:87:de:57:83 Hugo-PC
Tue Oct 31 22:33:48 2017 daemon.info hostapd: wlan1: STA b8:86:87:de:57:83 IEEE 802.11: authenticated
Tue Oct 31 22:33:49 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 22:33:49 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 22:33:49 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 0 addresses
Tue Oct 31 22:33:49 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 22:33:49 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 22:33:50 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 22:33:50 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 22:33:50 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 2 addresses
Tue Oct 31 22:33:50 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 22:33:50 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 22:34:27 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:38:05 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:39:30 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:43:08 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:44:33 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:48:11 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:49:36 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:53:14 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:54:39 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 22:58:17 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 22:59:42 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:03:20 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:04:45 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:08:23 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:09:48 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:12:02 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 IEEE 802.11: associated (aid 3)
Tue Oct 31 23:12:02 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 IEEE 802.11: authenticated
Tue Oct 31 23:12:02 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 48:51:b7:a3:12:f9
Tue Oct 31 23:12:02 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 23:12:02 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:12:03 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:12:04 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:12:04 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:12:04 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 4 addresses
Tue Oct 31 23:12:04 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:12:04 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:12:11 2017 daemon.info dnsmasq-dhcp[1914]: DHCPDISCOVER(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 
Tue Oct 31 23:12:11 2017 daemon.info dnsmasq-dhcp[1914]: DHCPOFFER(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 
Tue Oct 31 23:12:11 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 
Tue Oct 31 23:12:11 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 Bonobo-PC
Tue Oct 31 23:13:26 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:14:51 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:18:29 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:19:54 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:23:32 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:24:57 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:27:16 2017 kern.info kernel: [73794.034001] ieee80211 phy1: staid 2 deleted
Tue Oct 31 23:27:16 2017 daemon.info hostapd: wlan1: STA b8:86:87:de:57:83 IEEE 802.11: associated (aid 5)
Tue Oct 31 23:27:16 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED b8:86:87:de:57:83
Tue Oct 31 23:27:16 2017 daemon.info hostapd: wlan1: STA b8:86:87:de:57:83 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 23:27:16 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.153 b8:86:87:de:57:83 
Tue Oct 31 23:27:16 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.153 b8:86:87:de:57:83 Hugo-PC
Tue Oct 31 23:27:16 2017 daemon.info hostapd: wlan1: STA b8:86:87:de:57:83 IEEE 802.11: authenticated
Tue Oct 31 23:27:17 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 23:27:17 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:27:17 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 2 addresses
Tue Oct 31 23:27:17 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:27:17 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:27:18 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 23:27:18 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:27:18 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 4 addresses
Tue Oct 31 23:27:18 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:27:18 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:27:20 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.153 b8:86:87:de:57:83 
Tue Oct 31 23:27:20 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.153 b8:86:87:de:57:83 Hugo-PC
Tue Oct 31 23:27:21 2017 daemon.warn odhcpd[1246]: DHCPV6 CONFIRM IA_NA from 000100011f8307a6f832e42b489b on br-lan: not on-link 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 23:27:21 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 23:27:21 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:27:21 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 2 addresses
Tue Oct 31 23:27:21 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:27:21 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:27:22 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011f8307a6f832e42b489b on br-lan: ok 2601:646:c200:74d4::f89/128 fd7c:8024:9135::f89/128 
Tue Oct 31 23:27:22 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:27:22 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 4 addresses
Tue Oct 31 23:27:22 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:27:22 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:28:35 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:30:00 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:33:38 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:34:24 2017 daemon.notice hostapd: wlan0: AP-STA-DISCONNECTED 48:51:b7:a3:12:f9
Tue Oct 31 23:34:24 2017 kern.info kernel: [74221.957404] ieee80211 phy0: staid 3 deleted
Tue Oct 31 23:35:03 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:35:52 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 IEEE 802.11: associated (aid 3)
Tue Oct 31 23:35:52 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 48:51:b7:a3:12:f9
Tue Oct 31 23:35:52 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 23:35:53 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 IEEE 802.11: authenticated
Tue Oct 31 23:35:57 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:35:57 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 
Tue Oct 31 23:35:57 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 Bonobo-PC
Tue Oct 31 23:35:57 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:35:57 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 2 addresses
Tue Oct 31 23:35:57 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:35:57 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:35:58 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:35:58 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:35:58 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 4 addresses
Tue Oct 31 23:35:58 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:35:58 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:37:41 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 68:db:ca:8f:11:91
Tue Oct 31 23:38:41 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:40:06 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:42:44 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 68:db:ca:8f:11:91
Tue Oct 31 23:43:44 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:45:09 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:45:31 2017 daemon.notice hostapd: wlan0: AP-STA-DISCONNECTED 48:51:b7:a3:12:f9
Tue Oct 31 23:45:31 2017 kern.info kernel: [74889.059512] ieee80211 phy0: staid 3 deleted
Tue Oct 31 23:45:56 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 IEEE 802.11: associated (aid 3)
Tue Oct 31 23:45:56 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 48:51:b7:a3:12:f9
Tue Oct 31 23:45:56 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 23:45:57 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:45:57 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:45:57 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 2 addresses
Tue Oct 31 23:45:57 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:45:57 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:45:57 2017 daemon.info hostapd: wlan0: STA 48:51:b7:a3:12:f9 IEEE 802.11: authenticated
Tue Oct 31 23:45:58 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100012180a95980fa5b142d88 on br-lan: ok 2601:646:c200:74d4::629/128 fd7c:8024:9135::629/128 
Tue Oct 31 23:45:58 2017 daemon.info dnsmasq[1914]: read /etc/hosts - 4 addresses
Tue Oct 31 23:45:58 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/odhcpd - 4 addresses
Tue Oct 31 23:45:58 2017 daemon.info dnsmasq[1914]: read /tmp/hosts/dhcp.cfg02411c - 2 addresses
Tue Oct 31 23:45:58 2017 daemon.info dnsmasq-dhcp[1914]: read /etc/ethers - 0 addresses
Tue Oct 31 23:46:01 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 
Tue Oct 31 23:46:01 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.198 48:51:b7:a3:12:f9 Bonobo-PC
Tue Oct 31 23:47:36 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 40:4e:36:21:6a:f7
Tue Oct 31 23:47:47 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 68:db:ca:8f:11:91
Tue Oct 31 23:48:47 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:50:12 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:52:50 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 68:db:ca:8f:11:91
Tue Oct 31 23:53:50 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:55:15 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Tue Oct 31 23:57:53 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 68:db:ca:8f:11:91
Tue Oct 31 23:58:53 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Tue Oct 31 23:59:29 2017 kern.info kernel: [75726.923669] ieee80211 phy1: staid 4 deleted
Tue Oct 31 23:59:29 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 IEEE 802.11: associated (aid 4)
Tue Oct 31 23:59:29 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 68:db:ca:8f:11:91
Tue Oct 31 23:59:29 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 WPA: pairwise key handshake completed (RSN)
Tue Oct 31 23:59:29 2017 daemon.info dnsmasq-dhcp[1914]: DHCPREQUEST(br-lan) 192.168.1.173 68:db:ca:8f:11:91 
Tue Oct 31 23:59:29 2017 daemon.info dnsmasq-dhcp[1914]: DHCPACK(br-lan) 192.168.1.173 68:db:ca:8f:11:91 Magalys-iPhone
Tue Oct 31 23:59:30 2017 daemon.info hostapd: wlan1: STA 68:db:ca:8f:11:91 IEEE 802.11: authenticated
Tue Oct 31 23:59:34 2017 daemon.warn odhcpd[1246]: DHCPV6 SOLICIT IA_NA from 000100011efca59b68dbca8f1191 on br-lan: ok 2601:646:c200:74d4::ef7/128 fd7c:8024:9135::ef7/128 
Tue Oct 31 23:59:35 2017 daemon.warn odhcpd[1246]: DHCPV6 REQUEST IA_NA from 000100011efca59b68dbca8f1191 on br-lan: ok 2601:646:c200:74d4::ef7/128 fd7c:8024:9135::ef7/128 
Wed Nov  1 00:00:18 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Wed Nov  1 00:03:56 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Wed Nov  1 00:05:21 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53
Wed Nov  1 00:08:59 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 54:60:09:05:2c:16
Wed Nov  1 00:10:24 2017 daemon.notice hostapd: wlan0: AP-STA-POLL-OK 5c:a3:9d:68:bd:53

Mind you I am running LEDE master branch with the latest commit from mwlwifi.

haribert commented 7 years ago

I know it does not bother you, because you are the developer and should not concern about marketing stuff. But perhaps you can forward this to your marketing department.

I decided to sell my WRT3200acm router and buy something which I call stable and take the open issues serious. I am a little bit disappointed about the phrase "open source ready", because the documentation of the driver is not open source. And without any information, it is not possible to develop anything for this device. Therefore @yuhhaurlin is the only person who has the documentation and is able to implement anything. I own this device now since about a year and still have some serious workarounds in place and have to reboot the device every week. I spent to much time debugging my environment and device without any improvements in the last months. I would not recommend to use this device in a production environment.

So Long, and Thanks for All the Fish

yuhhaurlin commented 7 years ago

You did not offer log to me for a long period of time. I think maybe you do not use 11g only device now. That is the reason I close it.

yuhhaurlin commented 7 years ago

The remaining severe one is host command timeout, we will fix it.

mtkunkel commented 7 years ago

Wait.. What the actual fuck? There are a whole pile of closed issues on this very topic and you continue to close them without providing a fix? Obviously people are still using 11g and this needs to be fixed, disabling group rekey isn't a real fix. Either open source the docs to go with the "opensource" driver or actually fix something for once. screenshot_2017-11-09_21-17-21

yuhhaurlin commented 7 years ago

Can you help me to check this problem?

yuhhaurlin commented 7 years ago

Please follow the description above and give me log with group key disable. Thanks.

mtkunkel commented 7 years ago

I thought root cause was found above when you said it would be fixed with low priority? Do I need a debug build of hostapd? Additional debug logging turned on?

I can get logs, however I'm now relying on the router to be stable (with the rekey off hack). I decommissioned my backup router due to KRACK.

yuhhaurlin commented 7 years ago

Did you encounter problem?

mtkunkel commented 6 years ago
[58224.386900] ieee80211 phy0: staid 1 deleted
[58836.254648] ieee80211 phy1: staid 2 deleted
[60024.336897] ieee80211 phy0: staid 1 deleted
[61823.047731] ieee80211 phy1: staid 1 deleted
[61824.338455] ieee80211 phy1: staid 1 deleted
[69267.112682] ieee80211 phy1: create ba result error 1
[69267.126694] ieee80211 phy1: ampdu operation error code: -22
[69303.582344] ieee80211 phy1: create ba result error 1
[69303.595442] ieee80211 phy1: ampdu operation error code: -22
[69314.676467] ieee80211 phy0: staid 1 deleted
[69320.922204] ieee80211 phy1: create ba result error 1
[69320.936206] ieee80211 phy1: ampdu operation error code: -22
[69354.171877] ieee80211 phy0: staid 1 deleted
[69367.471527] ieee80211 phy1: create ba result error 1
[69367.485553] ieee80211 phy1: ampdu operation error code: -22
[69393.755328] ieee80211 phy0: staid 1 deleted
[69399.980546] ieee80211 phy1: create ba result error 1
[69399.994559] ieee80211 phy1: ampdu operation error code: -22
[69433.223132] ieee80211 phy0: staid 1 deleted
[69469.417148] ieee80211 phy0: staid 1 deleted
[70025.268952] ieee80211 phy1: create ba result error 1
[70025.281938] ieee80211 phy1: ampdu operation error code: -22
[70146.375311] ieee80211 phy0: staid 1 deleted
[70152.580084] ieee80211 phy1: create ba result error 1
[70152.594089] ieee80211 phy1: ampdu operation error code: -22
[70224.589150] ieee80211 phy0: staid 1 deleted
[70521.954096] ieee80211 phy1: create ba result error 1
[70521.968102] ieee80211 phy1: ampdu operation error code: -22
[70595.511792] ieee80211 phy0: staid 1 deleted
[70695.281071] ieee80211 phy1: create ba result error 1
[70695.294189] ieee80211 phy1: ampdu operation error code: -22
[70737.099726] ieee80211 phy0: staid 1 deleted
[70774.289988] ieee80211 phy1: create ba result error 1
[70774.304000] ieee80211 phy1: ampdu operation error code: -22
[70797.410683] ieee80211 phy1: create ba result error 1
[70797.424685] ieee80211 phy1: ampdu operation error code: -22
[70816.417558] ieee80211 phy0: staid 1 deleted
[70920.654908] ieee80211 phy1: create ba result error 1
[70920.668908] ieee80211 phy1: ampdu operation error code: -22
[70962.993428] ieee80211 phy0: staid 1 deleted
[71044.386234] ieee80211 phy0: staid 1 deleted
[71051.596661] ieee80211 phy1: create ba result error 1
[71051.610744] ieee80211 phy1: ampdu operation error code: -22
[71083.770675] ieee80211 phy0: staid 1 deleted
root@ROOter:~# ```

```Tue Nov 14 18:37:04 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: WPA rekeying GTK
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:f5:da:df:e3:da WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA e8:50:8b:47:94:a3 WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 38:b1:db:15:08:b0 WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 88:de:a9:df:ba:cd WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:c7:bf:05:8d:56 WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA c4:6e:1f:34:6f:38 WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 88:de:a9:df:ba:cd WPA: received EAPOL-Key frame (2/2 Group)
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1: STA 88:de:a9:df:ba:cd WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:c7:bf:05:8d:56 WPA: received EAPOL-Key frame (2/2 Group)
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1: STA 50:c7:bf:05:8d:56 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 38:b1:db:15:08:b0 WPA: received EAPOL-Key frame (2/2 Group)
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1: STA 38:b1:db:15:08:b0 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA c4:6e:1f:34:6f:38 WPA: received EAPOL-Key frame (2/2 Group)
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1: STA c4:6e:1f:34:6f:38 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA e8:50:8b:47:94:a3 WPA: received EAPOL-Key frame (2/2 Group)
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1: STA e8:50:8b:47:94:a3 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:f5:da:df:e3:da WPA: EAPOL-Key timeout
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:f5:da:df:e3:da WPA: sending 1/2 msg of Group Key Handshake
Tue Nov 14 18:37:05 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:05 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:f5:da:df:e3:da WPA: received EAPOL-Key frame (2/2 Group)
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1: STA 50:f5:da:df:e3:da WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:05 2017 daemon.debug hostapd: wlan1: STA 50:f5:da:df:e3:da WPA: received EAPOL-Key 2/2 Group with unexpected replay counter
Tue Nov 14 18:37:05 2017 daemon.info hostapd: wlan1-1: STA f4:5c:89:a3:cc:27 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:06 2017 daemon.info hostapd: wlan1-1: STA f8:e0:79:da:f3:35 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:06 2017 daemon.info hostapd: wlan1-1: STA 18:b4:30:12:ce:08 WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:06 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe WPA: group key handshake completed (RSN)
Tue Nov 14 18:37:08 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:37:09 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:09 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:12 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:37:17 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:17 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:17 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:37:34 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:34 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:36 2017 daemon.info dnsmasq-dhcp[2082]: DHCPREQUEST(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:37:36 2017 daemon.info dnsmasq-dhcp[2082]: DHCPACK(br-lan) 192.168.1.154 84:10:0d:63:dc:fe android-2cba48716354bcce
Tue Nov 14 18:37:36 2017 daemon.warn dnsmasq-dhcp[2082]: not giving name Ooma.lan to the DHCP lease of 192.168.1.245 because the name exists in /tmp/hosts/dhcp.cfg02411c with address 192.168.1.244
Tue Nov 14 18:38:41 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authentication OK (open system)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-AUTHENTICATE.indication(84:10:0d:63:dc:fe, OPEN_SYSTEM)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: association OK (aid 7)
Tue Nov 14 18:38:47 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 7)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-REASSOCIATE.indication(84:10:0d:63:dc:fe)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: binding station to interface 'wlan1'
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 1 notification
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: start authentication
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 1/4 msg of 4-Way Handshake
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (2/4 Pairwise)
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 3/4 msg of 4-Way Handshake
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (4/4 Pairwise)
Tue Nov 14 18:38:47 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:38:47 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: authorizing port
Tue Nov 14 18:38:47 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:38:47 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:38:47 2017 kern.err kernel: [70920.654908] ieee80211 phy1: create ba result error 1
Tue Nov 14 18:38:47 2017 kern.err kernel: [70920.668908] ieee80211 phy1: ampdu operation error code: -22
Tue Nov 14 18:39:26 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:39:26 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 3 notification
Tue Nov 14 18:39:26 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:39:26 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: deauthenticated
Tue Nov 14 18:39:26 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DEAUTHENTICATE.indication(84:10:0d:63:dc:fe, 3)
Tue Nov 14 18:39:26 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:39:30 2017 kern.info kernel: [70962.993428] ieee80211 phy0: staid 1 deleted
Tue Nov 14 18:39:30 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 1)
Tue Nov 14 18:39:30 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:39:30 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:39:30 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:30 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:31 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:39:32 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:32 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:32 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:39:35 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:39:36 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:36 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:39 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:39:44 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:39:44 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:40:00 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:40:00 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:40:00 2017 daemon.info dnsmasq-dhcp[2082]: DHCPREQUEST(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:40:00 2017 daemon.info dnsmasq-dhcp[2082]: DHCPACK(br-lan) 192.168.1.154 84:10:0d:63:dc:fe android-2cba48716354bcce
Tue Nov 14 18:40:00 2017 daemon.warn dnsmasq-dhcp[2082]: not giving name Ooma.lan to the DHCP lease of 192.168.1.245 because the name exists in /tmp/hosts/dhcp.cfg02411c with address 192.168.1.244
Tue Nov 14 18:40:08 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authentication OK (open system)
Tue Nov 14 18:40:08 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-AUTHENTICATE.indication(84:10:0d:63:dc:fe, OPEN_SYSTEM)
Tue Nov 14 18:40:08 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: association OK (aid 7)
Tue Nov 14 18:40:09 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 7)
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-REASSOCIATE.indication(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: binding station to interface 'wlan1'
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 1 notification
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: start authentication
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 1/4 msg of 4-Way Handshake
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (2/4 Pairwise)
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 3/4 msg of 4-Way Handshake
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (4/4 Pairwise)
Tue Nov 14 18:40:09 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:40:09 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: authorizing port
Tue Nov 14 18:40:09 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:40:10 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:40:48 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:40:48 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 3 notification
Tue Nov 14 18:40:48 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:40:48 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: deauthenticated
Tue Nov 14 18:40:48 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DEAUTHENTICATE.indication(84:10:0d:63:dc:fe, 3)
Tue Nov 14 18:40:48 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:51 2017 kern.info kernel: [71044.386234] ieee80211 phy0: staid 1 deleted
Tue Nov 14 18:40:51 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 1)
Tue Nov 14 18:40:51 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:40:51 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:40:52 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:40:53 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:40:53 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:40:56 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:40:57 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authentication OK (open system)
Tue Nov 14 18:40:57 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-AUTHENTICATE.indication(84:10:0d:63:dc:fe, OPEN_SYSTEM)
Tue Nov 14 18:40:57 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: association OK (aid 7)
Tue Nov 14 18:40:58 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 7)
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-REASSOCIATE.indication(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: binding station to interface 'wlan1'
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 1 notification
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: start authentication
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 1/4 msg of 4-Way Handshake
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (2/4 Pairwise)
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 3/4 msg of 4-Way Handshake
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (4/4 Pairwise)
Tue Nov 14 18:40:58 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:40:58 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: authorizing port
Tue Nov 14 18:40:58 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:40:58 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:40:58 2017 kern.err kernel: [71051.596661] ieee80211 phy1: create ba result error 1
Tue Nov 14 18:40:58 2017 kern.err kernel: [71051.610744] ieee80211 phy1: ampdu operation error code: -22
Tue Nov 14 18:41:25 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:41:27 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:41:27 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 3 notification
Tue Nov 14 18:41:27 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:41:27 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: deauthenticated
Tue Nov 14 18:41:27 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DEAUTHENTICATE.indication(84:10:0d:63:dc:fe, 3)
Tue Nov 14 18:41:27 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:41:30 2017 kern.info kernel: [71083.770675] ieee80211 phy0: staid 1 deleted
Tue Nov 14 18:41:30 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 1)
Tue Nov 14 18:41:30 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:41:30 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:41:31 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:31 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:32 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:41:33 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:33 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:35 2017 daemon.info dnsmasq-dhcp[2082]: DHCPREQUEST(wlan1-1) 192.168.2.95 f4:5c:89:a3:cc:27 
Tue Nov 14 18:41:35 2017 daemon.info dnsmasq-dhcp[2082]: DHCPACK(wlan1-1) 192.168.2.95 f4:5c:89:a3:cc:27 m-c02r64p3g8wn
Tue Nov 14 18:41:35 2017 daemon.warn dnsmasq-dhcp[2082]: not giving name Ooma.lan to the DHCP lease of 192.168.1.245 because the name exists in /tmp/hosts/dhcp.cfg02411c with address 192.168.1.244
Tue Nov 14 18:41:36 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:41:36 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:36 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:40 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:41:45 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:45 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:45 2017 daemon.info dnsmasq-dhcp[2082]: DHCPREQUEST(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:41:45 2017 daemon.info dnsmasq-dhcp[2082]: DHCPACK(br-lan) 192.168.1.154 84:10:0d:63:dc:fe android-2cba48716354bcce
Tue Nov 14 18:41:45 2017 daemon.warn dnsmasq-dhcp[2082]: not giving name Ooma.lan to the DHCP lease of 192.168.1.245 because the name exists in /tmp/hosts/dhcp.cfg02411c with address 192.168.1.244
Tue Nov 14 18:41:45 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:42:09 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 50:c7:bf:05:8d:56
Tue Nov 14 18:42:20 2017 daemon.notice hostapd: wlan1: AP-STA-POLL-OK 50:f5:da:df:e3:da
Tue Nov 14 18:42:52 2017 daemon.info hostapd: wlan0: STA 58:00:e3:41:f8:57 IEEE 802.11: associated (aid 2)
Tue Nov 14 18:42:52 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 58:00:e3:41:f8:57
Tue Nov 14 18:42:52 2017 daemon.info hostapd: wlan0: STA 58:00:e3:41:f8:57 WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:42:52 2017 daemon.info dnsmasq-dhcp[2082]: DHCPREQUEST(br-lan) 192.168.1.112 58:00:e3:41:f8:57 
Tue Nov 14 18:42:52 2017 daemon.info dnsmasq-dhcp[2082]: DHCPACK(br-lan) 192.168.1.112 58:00:e3:41:f8:57 arch_klap
Tue Nov 14 18:42:52 2017 daemon.warn dnsmasq-dhcp[2082]: not giving name Ooma.lan to the DHCP lease of 192.168.1.245 because the name exists in /tmp/hosts/dhcp.cfg02411c with address 192.168.1.244
Tue Nov 14 18:42:53 2017 daemon.info hostapd: wlan0: STA 58:00:e3:41:f8:57 IEEE 802.11: authenticated
Tue Nov 14 18:42:53 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:42:57 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:42:57 2017 daemon.notice odhcpd[1283]: Got DHCPv6 request
Tue Nov 14 18:42:57 2017 daemon.warn odhcpd[1283]: DHCPV6 SOLICIT IA_NA from 0004b89b93de93b897fe6197eab637baccb9 on br-lan: ok fd3b:2448:f853::8cd/128 
Tue Nov 14 18:42:58 2017 daemon.notice odhcpd[1283]: Got DHCPv6 request
Tue Nov 14 18:42:58 2017 daemon.warn odhcpd[1283]: DHCPV6 REQUEST IA_NA from 0004b89b93de93b897fe6197eab637baccb9 on br-lan: ok fd3b:2448:f853::8cd/128 
Tue Nov 14 18:42:59 2017 authpriv.info dropbear[7963]: Child connection from 192.168.1.112:39222
Tue Nov 14 18:43:01 2017 authpriv.notice dropbear[7963]: Pubkey auth succeeded for 'root' with key md5 26:30:29:1e:95:40:33:5c:1f:95:21:17:8a:d9:0e:23 from 192.168.1.112:39222
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authentication OK (open system)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-AUTHENTICATE.indication(84:10:0d:63:dc:fe, OPEN_SYSTEM)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: association OK (aid 7)
Tue Nov 14 18:43:44 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 7)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-REASSOCIATE.indication(84:10:0d:63:dc:fe)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: binding station to interface 'wlan1'
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 1 notification
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: start authentication
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 1/4 msg of 4-Way Handshake
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (2/4 Pairwise)
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: sending 3/4 msg of 4-Way Handshake
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: received EAPOL-Key frame (4/4 Pairwise)
Tue Nov 14 18:43:44 2017 daemon.notice hostapd: wlan1: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:43:44 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: authorizing port
Tue Nov 14 18:43:44 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:43:49 2017 kern.err kernel: [71222.676585] ieee80211 phy1: create ba result error 1
Tue Nov 14 18:43:49 2017 kern.err kernel: [71222.690613] ieee80211 phy1: ampdu operation error code: -22
Tue Nov 14 18:43:53 2017 daemon.info hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:44:24 2017 daemon.notice hostapd: wlan1: AP-STA-DISCONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:44:24 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe WPA: event 3 notification
Tue Nov 14 18:44:24 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.1X: unauthorizing port
Tue Nov 14 18:44:24 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe IEEE 802.11: deauthenticated
Tue Nov 14 18:44:24 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DEAUTHENTICATE.indication(84:10:0d:63:dc:fe, 3)
Tue Nov 14 18:44:24 2017 daemon.debug hostapd: wlan1: STA 84:10:0d:63:dc:fe MLME: MLME-DELETEKEYS.request(84:10:0d:63:dc:fe)
Tue Nov 14 18:44:27 2017 kern.info kernel: [71260.321910] ieee80211 phy0: staid 1 deleted
Tue Nov 14 18:44:27 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: associated (aid 1)
Tue Nov 14 18:44:27 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe IEEE 802.11: authenticated
Tue Nov 14 18:44:27 2017 daemon.notice hostapd: wlan0: AP-STA-CONNECTED 84:10:0d:63:dc:fe
Tue Nov 14 18:44:27 2017 daemon.info hostapd: wlan0: STA 84:10:0d:63:dc:fe WPA: pairwise key handshake completed (RSN)
Tue Nov 14 18:44:28 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:44:29 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:44:29 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:44:32 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:44:33 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:44:33 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:44:36 2017 daemon.info odhcpd[1283]: Using a RA lifetime of 1800 seconds on br-lan
Tue Nov 14 18:44:41 2017 daemon.info dnsmasq-dhcp[2082]: DHCPDISCOVER(br-lan) 84:10:0d:63:dc:fe 
Tue Nov 14 18:44:41 2017 daemon.info dnsmasq-dhcp[2082]: DHCPOFFER(br-lan) 192.168.1.154 84:10:0d:63:dc:fe 
Tue Nov 14 18:44:43 2017 daemon.notice hostapd: wlan1-1: AP-STA-POLL-OK f8:e0:79:da:f3:35
root@ROOter:~#  
yuhhaurlin commented 6 years ago

It looks like Block ACK stream can't be established with that client.